builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-039 starttime: 1471562112.5 results: success (0) buildid: 20160818143003 builduid: 1febe02b051a447da10946125d329dac revision: e7cfd78dee27a013c4e5be92e56d76080ffaf85d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 16:15:12.503588) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 16:15:12.504088) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 16:15:12.504412) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 16:15:12.519476) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 16:15:12.519771) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5bd038846534b2fdfa68eeae000001e2-1471562111.946310-1123868270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-18 16:15:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 10.6M=0.001s 2016-08-18 16:15:12 (10.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164217 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 16:15:12.702313) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 16:15:12.703126) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5bd038846534b2fdfa68eeae000001e2-1471562111.946310-1123868270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018115 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 16:15:12.756595) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-18 16:15:12.757004) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e7cfd78dee27a013c4e5be92e56d76080ffaf85d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev e7cfd78dee27a013c4e5be92e56d76080ffaf85d --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5bd038846534b2fdfa68eeae000001e2-1471562111.946310-1123868270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-18 16:15:13,059 truncating revision to first 12 chars 2016-08-18 16:15:13,059 Setting DEBUG logging. 2016-08-18 16:15:13,059 attempt 1/10 2016-08-18 16:15:13,059 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e7cfd78dee27?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-18 16:15:13,968 unpacking tar archive at: fx-team-e7cfd78dee27/testing/mozharness/ program finished with exit code 0 elapsedTime=1.250322 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-18 16:15:14.027372) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 16:15:14.028270) ========= script_repo_revision: e7cfd78dee27a013c4e5be92e56d76080ffaf85d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 16:15:14.029440) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 16:15:14.030305) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 16:15:14.043988) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-18 16:15:14.044682) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5bd038846534b2fdfa68eeae000001e2-1471562111.946310-1123868270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:15:14 INFO - MultiFileLogger online at 20160818 16:15:14 in /builds/slave/test 16:15:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:15:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:15:14 INFO - {'append_to_log': False, 16:15:14 INFO - 'base_work_dir': '/builds/slave/test', 16:15:14 INFO - 'blob_upload_branch': 'Fx-Team', 16:15:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:15:14 INFO - 'branch': 'Fx-Team', 16:15:14 INFO - 'buildbot_json_path': 'buildprops.json', 16:15:14 INFO - 'config_files': ('talos/linux_config.py',), 16:15:14 INFO - 'default_actions': ('clobber', 16:15:14 INFO - 'read-buildbot-config', 16:15:14 INFO - 'download-and-extract', 16:15:14 INFO - 'populate-webroot', 16:15:14 INFO - 'create-virtualenv', 16:15:14 INFO - 'install', 16:15:14 INFO - 'run-tests'), 16:15:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:15:14 INFO - 'download_minidump_stackwalk': True, 16:15:14 INFO - 'download_symbols': 'ondemand', 16:15:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:15:14 INFO - 'tooltool.py': '/tools/tooltool.py', 16:15:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:15:14 INFO - '/tools/misc-python/virtualenv.py')}, 16:15:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:15:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:15:14 INFO - 'installer_path': 'installer.exe', 16:15:14 INFO - 'log_level': 'info', 16:15:14 INFO - 'log_name': 'talos', 16:15:14 INFO - 'log_to_console': True, 16:15:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:15:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:15:14 INFO - 'opt_config_files': (), 16:15:14 INFO - 'pip_index': False, 16:15:14 INFO - 'sps_profile': False, 16:15:14 INFO - 'sps_profile_interval': 0, 16:15:14 INFO - 'suite': 'dromaeojs', 16:15:14 INFO - 'system_bits': '32', 16:15:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:15:14 INFO - 'title': 'talos-linux64-ix-039', 16:15:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:15:14 INFO - 'use_talos_json': True, 16:15:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:15:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:15:14 INFO - 'work_dir': 'build'} 16:15:14 INFO - [mozharness: 2016-08-18 23:15:14.443207Z] Running clobber step. 16:15:14 INFO - Running pre-action listener: _resource_record_pre_action 16:15:14 INFO - Running main action method: clobber 16:15:14 INFO - rmtree: /builds/slave/test/build 16:15:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:15:14 INFO - Running post-action listener: _resource_record_post_action 16:15:14 INFO - [mozharness: 2016-08-18 23:15:14.918881Z] Finished clobber step (success) 16:15:14 INFO - [mozharness: 2016-08-18 23:15:14.918981Z] Running read-buildbot-config step. 16:15:14 INFO - Running pre-action listener: _resource_record_pre_action 16:15:14 INFO - Running main action method: read_buildbot_config 16:15:14 INFO - Using buildbot properties: 16:15:14 INFO - { 16:15:14 INFO - "project": "", 16:15:14 INFO - "product": "firefox", 16:15:14 INFO - "script_repo_revision": "production", 16:15:14 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:15:14 INFO - "repository": "", 16:15:14 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 16:15:14 INFO - "buildid": "20160818143003", 16:15:14 INFO - "pgo_build": "True", 16:15:14 INFO - "basedir": "/builds/slave/test", 16:15:14 INFO - "buildnumber": 373, 16:15:14 INFO - "slavename": "talos-linux64-ix-039", 16:15:14 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:15:14 INFO - "platform": "ubuntu64_hw", 16:15:14 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 16:15:14 INFO - "branch": "fx-team", 16:15:14 INFO - "repo_path": "integration/fx-team", 16:15:14 INFO - "revision": "e7cfd78dee27a013c4e5be92e56d76080ffaf85d", 16:15:14 INFO - "stage_platform": "linux64-pgo", 16:15:14 INFO - "builduid": "1febe02b051a447da10946125d329dac", 16:15:14 INFO - "slavebuilddir": "test" 16:15:14 INFO - } 16:15:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 16:15:14 INFO - Running post-action listener: _resource_record_post_action 16:15:14 INFO - [mozharness: 2016-08-18 23:15:14.921384Z] Finished read-buildbot-config step (success) 16:15:14 INFO - [mozharness: 2016-08-18 23:15:14.921473Z] Running download-and-extract step. 16:15:14 INFO - Running pre-action listener: _resource_record_pre_action 16:15:14 INFO - Running main action method: download_and_extract 16:15:14 INFO - mkdir: /builds/slave/test/build/tests 16:15:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:14 INFO - trying https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:15:14 INFO - Downloading https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:15:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:15:15 INFO - Downloaded 1361 bytes. 16:15:15 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:15:15 INFO - Using the following test package requirements: 16:15:15 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:15:15 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:15:15 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:15:15 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:15:15 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:15:15 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:15:15 INFO - u'jsshell-linux-x86_64.zip'], 16:15:15 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:15:15 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:15:15 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:15:15 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:15:15 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:15:15 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:15:15 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:15:15 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:15:15 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:15:15 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:15:15 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:15:15 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:15:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:15 INFO - trying https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:15:15 INFO - Downloading https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:15:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:15:16 INFO - Downloaded 21907579 bytes. 16:15:16 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 16:15:20 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:15:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:20 INFO - trying https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:15:20 INFO - Downloading https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:15:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:15:21 INFO - Downloaded 21907579 bytes. 16:15:21 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 16:15:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:26 INFO - trying https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 16:15:26 INFO - Downloading https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 16:15:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:15:26 INFO - Downloaded 14413981 bytes. 16:15:26 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 16:15:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:27 INFO - trying https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:15:27 INFO - Downloading https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:15:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:15:28 INFO - Downloaded 59594219 bytes. 16:15:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:15:28 INFO - mkdir: /builds/slave/test/properties 16:15:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:15:28 INFO - Writing to file /builds/slave/test/properties/build_url 16:15:28 INFO - Contents: 16:15:28 INFO - build_url:https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:15:28 INFO - Running post-action listener: _resource_record_post_action 16:15:28 INFO - Running post-action listener: set_extra_try_arguments 16:15:28 INFO - [mozharness: 2016-08-18 23:15:28.939347Z] Finished download-and-extract step (success) 16:15:28 INFO - [mozharness: 2016-08-18 23:15:28.939571Z] Running populate-webroot step. 16:15:28 INFO - Running pre-action listener: _resource_record_pre_action 16:15:28 INFO - Running main action method: populate_webroot 16:15:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:15:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:15:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:15:28 INFO - '--tppagecycles', 16:15:28 INFO - '7'], 16:15:28 INFO - 'tests': ['tsvgm']}}, 16:15:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:15:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:15:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:15:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:15:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:15:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:15:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:28 INFO - 'talos_options': ['--disable-e10s'], 16:15:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:15:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:15:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:28 INFO - 'talos_options': ['--disable-e10s'], 16:15:28 INFO - 'tests': ['damp', 'tps']}, 16:15:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:28 INFO - 'tests': ['damp', 'tps']}, 16:15:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:15:28 INFO - 'tests': ['dromaeo_dom']}, 16:15:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:15:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:15:28 INFO - 'tests': ['basic_compositor_video']}, 16:15:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:15:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:15:28 INFO - 'tests': ['a11yr', 16:15:28 INFO - 'ts_paint', 16:15:28 INFO - 'tpaint', 16:15:28 INFO - 'sessionrestore', 16:15:28 INFO - 'sessionrestore_no_auto_restore', 16:15:28 INFO - 'tabpaint']}, 16:15:28 INFO - 'other-e10s': {'tests': ['a11yr', 16:15:28 INFO - 'ts_paint', 16:15:28 INFO - 'tpaint', 16:15:28 INFO - 'sessionrestore', 16:15:28 INFO - 'sessionrestore_no_auto_restore', 16:15:28 INFO - 'tabpaint']}, 16:15:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:15:28 INFO - 'ts_paint', 16:15:28 INFO - 'tpaint', 16:15:28 INFO - 'sessionrestore', 16:15:28 INFO - 'sessionrestore_no_auto_restore', 16:15:28 INFO - 'tabpaint']}, 16:15:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:15:28 INFO - 'ts_paint', 16:15:28 INFO - 'tpaint', 16:15:28 INFO - 'sessionrestore', 16:15:28 INFO - 'sessionrestore_no_auto_restore', 16:15:28 INFO - 'tabpaint']}, 16:15:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:15:28 INFO - 'tests': ['a11yr', 16:15:28 INFO - 'ts_paint', 16:15:28 INFO - 'tpaint', 16:15:28 INFO - 'sessionrestore', 16:15:28 INFO - 'sessionrestore_no_auto_restore', 16:15:28 INFO - 'tabpaint']}, 16:15:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:15:28 INFO - 'tests': ['a11yr', 16:15:28 INFO - 'ts_paint', 16:15:28 INFO - 'tpaint', 16:15:28 INFO - 'sessionrestore', 16:15:28 INFO - 'sessionrestore_no_auto_restore', 16:15:28 INFO - 'tabpaint']}, 16:15:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:15:28 INFO - 'tests': ['tsvgx', 16:15:28 INFO - 'tsvgr_opacity', 16:15:28 INFO - 'tart', 16:15:28 INFO - 'tscrollx', 16:15:28 INFO - 'cart']}, 16:15:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:15:28 INFO - 'tsvgr_opacity', 16:15:28 INFO - 'tart', 16:15:28 INFO - 'tscrollx', 16:15:28 INFO - 'cart']}, 16:15:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:28 INFO - 'talos_options': ['--disable-e10s'], 16:15:28 INFO - 'tests': ['tp5o']}, 16:15:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:28 INFO - 'tests': ['tp5o']}, 16:15:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:28 INFO - 'talos_options': ['--disable-e10s', 16:15:28 INFO - '--xperf_path', 16:15:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:15:28 INFO - 'tests': ['tp5n']}, 16:15:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:28 INFO - 'talos_options': ['--xperf_path', 16:15:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:15:28 INFO - 'tests': ['tp5n']}}, 16:15:28 INFO - 'talos.zip': {'path': '', 16:15:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:15:28 INFO - Running post-action listener: _resource_record_post_action 16:15:28 INFO - [mozharness: 2016-08-18 23:15:28.959136Z] Finished populate-webroot step (success) 16:15:28 INFO - [mozharness: 2016-08-18 23:15:28.959223Z] Running create-virtualenv step. 16:15:28 INFO - Running pre-action listener: _resource_record_pre_action 16:15:28 INFO - Running main action method: create_virtualenv 16:15:28 INFO - Creating virtualenv /builds/slave/test/build/venv 16:15:28 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:15:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:15:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:15:29 INFO - Using real prefix '/usr' 16:15:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:15:29 INFO - Installing distribute.............................................................................................................................................................................................done. 16:15:31 INFO - Installing pip.................done. 16:15:31 INFO - Return code: 0 16:15:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0ad30ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f4850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ef370>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f28f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f2d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1471562111.946310-1123868270', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:15:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:15:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:15:31 INFO - Using env: {'DISPLAY': ':0', 16:15:31 INFO - 'HOME': '/home/cltbld', 16:15:31 INFO - 'LANG': 'en_US.UTF-8', 16:15:31 INFO - 'LANGUAGE': 'en_US:en', 16:15:31 INFO - 'LOGNAME': 'cltbld', 16:15:31 INFO - 'MAIL': '/var/mail/cltbld', 16:15:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:31 INFO - 'MOZ_NO_REMOTE': '1', 16:15:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:31 INFO - 'NO_EM_RESTART': '1', 16:15:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:31 INFO - 'PWD': '/builds/slave/test', 16:15:31 INFO - 'SHELL': '/bin/bash', 16:15:31 INFO - 'SHLVL': '1', 16:15:31 INFO - 'TERM': 'linux', 16:15:31 INFO - 'TMOUT': '86400', 16:15:31 INFO - 'USER': 'cltbld', 16:15:31 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1471562111.946310-1123868270', 16:15:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:31 INFO - '_': '/tools/buildbot/bin/python'} 16:15:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:31 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:15:31 INFO - Cleaning up... 16:15:31 INFO - Return code: 0 16:15:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0ad30ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f4850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ef370>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f28f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f2d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1471562111.946310-1123868270', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:15:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:15:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:15:31 INFO - Using env: {'DISPLAY': ':0', 16:15:31 INFO - 'HOME': '/home/cltbld', 16:15:31 INFO - 'LANG': 'en_US.UTF-8', 16:15:31 INFO - 'LANGUAGE': 'en_US:en', 16:15:31 INFO - 'LOGNAME': 'cltbld', 16:15:31 INFO - 'MAIL': '/var/mail/cltbld', 16:15:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:31 INFO - 'MOZ_NO_REMOTE': '1', 16:15:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:31 INFO - 'NO_EM_RESTART': '1', 16:15:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:31 INFO - 'PWD': '/builds/slave/test', 16:15:31 INFO - 'SHELL': '/bin/bash', 16:15:31 INFO - 'SHLVL': '1', 16:15:31 INFO - 'TERM': 'linux', 16:15:31 INFO - 'TMOUT': '86400', 16:15:31 INFO - 'USER': 'cltbld', 16:15:31 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1471562111.946310-1123868270', 16:15:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:31 INFO - '_': '/tools/buildbot/bin/python'} 16:15:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:31 INFO - Downloading/unpacking psutil>=3.1.1 16:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:15:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:15:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:15:33 INFO - Installing collected packages: psutil 16:15:33 INFO - Running setup.py install for psutil 16:15:34 INFO - building 'psutil._psutil_linux' extension 16:15:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:15:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:15:34 INFO - building 'psutil._psutil_posix' extension 16:15:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:15:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:15:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:15:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:15:34 INFO - Successfully installed psutil 16:15:34 INFO - Cleaning up... 16:15:34 INFO - Return code: 0 16:15:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0ad30ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f4850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ef370>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f28f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f2d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1471562111.946310-1123868270', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:15:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:15:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:15:34 INFO - Using env: {'DISPLAY': ':0', 16:15:34 INFO - 'HOME': '/home/cltbld', 16:15:34 INFO - 'LANG': 'en_US.UTF-8', 16:15:34 INFO - 'LANGUAGE': 'en_US:en', 16:15:34 INFO - 'LOGNAME': 'cltbld', 16:15:34 INFO - 'MAIL': '/var/mail/cltbld', 16:15:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:34 INFO - 'MOZ_NO_REMOTE': '1', 16:15:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:34 INFO - 'NO_EM_RESTART': '1', 16:15:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:34 INFO - 'PWD': '/builds/slave/test', 16:15:34 INFO - 'SHELL': '/bin/bash', 16:15:34 INFO - 'SHLVL': '1', 16:15:34 INFO - 'TERM': 'linux', 16:15:34 INFO - 'TMOUT': '86400', 16:15:34 INFO - 'USER': 'cltbld', 16:15:34 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1471562111.946310-1123868270', 16:15:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:34 INFO - '_': '/tools/buildbot/bin/python'} 16:15:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:15:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:15:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:15:36 INFO - Installing collected packages: mozsystemmonitor 16:15:36 INFO - Running setup.py install for mozsystemmonitor 16:15:36 INFO - Successfully installed mozsystemmonitor 16:15:36 INFO - Cleaning up... 16:15:36 INFO - Return code: 0 16:15:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:15:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0ad30ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f4850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ef370>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f28f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f2d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1471562111.946310-1123868270', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:15:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:15:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:15:36 INFO - Using env: {'DISPLAY': ':0', 16:15:36 INFO - 'HOME': '/home/cltbld', 16:15:36 INFO - 'LANG': 'en_US.UTF-8', 16:15:36 INFO - 'LANGUAGE': 'en_US:en', 16:15:36 INFO - 'LOGNAME': 'cltbld', 16:15:36 INFO - 'MAIL': '/var/mail/cltbld', 16:15:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:36 INFO - 'MOZ_NO_REMOTE': '1', 16:15:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:36 INFO - 'NO_EM_RESTART': '1', 16:15:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:36 INFO - 'PWD': '/builds/slave/test', 16:15:36 INFO - 'SHELL': '/bin/bash', 16:15:36 INFO - 'SHLVL': '1', 16:15:36 INFO - 'TERM': 'linux', 16:15:36 INFO - 'TMOUT': '86400', 16:15:36 INFO - 'USER': 'cltbld', 16:15:36 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1471562111.946310-1123868270', 16:15:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:36 INFO - '_': '/tools/buildbot/bin/python'} 16:15:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:37 INFO - Downloading/unpacking jsonschema==2.5.1 16:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:15:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:39 INFO - Downloading functools32-3.2.3-2.tar.gz 16:15:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:15:39 INFO - warning: no files found matching '*.txt' 16:15:39 INFO - no previously-included directories found matching 'build' 16:15:39 INFO - no previously-included directories found matching 'dist' 16:15:39 INFO - no previously-included directories found matching '.git*' 16:15:39 INFO - Installing collected packages: jsonschema, functools32 16:15:39 INFO - Running setup.py install for functools32 16:15:39 INFO - warning: no files found matching '*.txt' 16:15:39 INFO - no previously-included directories found matching 'build' 16:15:39 INFO - no previously-included directories found matching 'dist' 16:15:39 INFO - no previously-included directories found matching '.git*' 16:15:39 INFO - Successfully installed jsonschema functools32 16:15:39 INFO - Cleaning up... 16:15:39 INFO - Return code: 0 16:15:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0ad30ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f4850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ef370>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f28f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f2d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1471562111.946310-1123868270', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:15:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:15:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:15:39 INFO - Using env: {'DISPLAY': ':0', 16:15:39 INFO - 'HOME': '/home/cltbld', 16:15:39 INFO - 'LANG': 'en_US.UTF-8', 16:15:39 INFO - 'LANGUAGE': 'en_US:en', 16:15:39 INFO - 'LOGNAME': 'cltbld', 16:15:39 INFO - 'MAIL': '/var/mail/cltbld', 16:15:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:39 INFO - 'MOZ_NO_REMOTE': '1', 16:15:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:39 INFO - 'NO_EM_RESTART': '1', 16:15:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:39 INFO - 'PWD': '/builds/slave/test', 16:15:39 INFO - 'SHELL': '/bin/bash', 16:15:39 INFO - 'SHLVL': '1', 16:15:39 INFO - 'TERM': 'linux', 16:15:39 INFO - 'TMOUT': '86400', 16:15:39 INFO - 'USER': 'cltbld', 16:15:39 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1471562111.946310-1123868270', 16:15:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:39 INFO - '_': '/tools/buildbot/bin/python'} 16:15:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:15:39 INFO - Cleaning up... 16:15:39 INFO - Return code: 0 16:15:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0ad30ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f4850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ef370>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f28f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f2d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1471562111.946310-1123868270', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:15:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:15:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:15:39 INFO - Using env: {'DISPLAY': ':0', 16:15:39 INFO - 'HOME': '/home/cltbld', 16:15:39 INFO - 'LANG': 'en_US.UTF-8', 16:15:39 INFO - 'LANGUAGE': 'en_US:en', 16:15:39 INFO - 'LOGNAME': 'cltbld', 16:15:39 INFO - 'MAIL': '/var/mail/cltbld', 16:15:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:39 INFO - 'MOZ_NO_REMOTE': '1', 16:15:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:39 INFO - 'NO_EM_RESTART': '1', 16:15:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:39 INFO - 'PWD': '/builds/slave/test', 16:15:39 INFO - 'SHELL': '/bin/bash', 16:15:39 INFO - 'SHLVL': '1', 16:15:39 INFO - 'TERM': 'linux', 16:15:39 INFO - 'TMOUT': '86400', 16:15:39 INFO - 'USER': 'cltbld', 16:15:39 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1471562111.946310-1123868270', 16:15:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:39 INFO - '_': '/tools/buildbot/bin/python'} 16:15:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:39 INFO - Downloading/unpacking blobuploader==1.2.4 16:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:41 INFO - Downloading blobuploader-1.2.4.tar.gz 16:15:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:15:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:15:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:42 INFO - Downloading docopt-0.6.1.tar.gz 16:15:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:15:42 INFO - Installing collected packages: blobuploader, requests, docopt 16:15:42 INFO - Running setup.py install for blobuploader 16:15:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:15:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:15:42 INFO - Running setup.py install for requests 16:15:42 INFO - Running setup.py install for docopt 16:15:42 INFO - Successfully installed blobuploader requests docopt 16:15:42 INFO - Cleaning up... 16:15:43 INFO - Return code: 0 16:15:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0ad30ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f4850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ef370>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f28f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f2d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1471562111.946310-1123868270', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:15:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:15:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:15:43 INFO - Using env: {'DISPLAY': ':0', 16:15:43 INFO - 'HOME': '/home/cltbld', 16:15:43 INFO - 'LANG': 'en_US.UTF-8', 16:15:43 INFO - 'LANGUAGE': 'en_US:en', 16:15:43 INFO - 'LOGNAME': 'cltbld', 16:15:43 INFO - 'MAIL': '/var/mail/cltbld', 16:15:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:43 INFO - 'MOZ_NO_REMOTE': '1', 16:15:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:43 INFO - 'NO_EM_RESTART': '1', 16:15:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:43 INFO - 'PWD': '/builds/slave/test', 16:15:43 INFO - 'SHELL': '/bin/bash', 16:15:43 INFO - 'SHLVL': '1', 16:15:43 INFO - 'TERM': 'linux', 16:15:43 INFO - 'TMOUT': '86400', 16:15:43 INFO - 'USER': 'cltbld', 16:15:43 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1471562111.946310-1123868270', 16:15:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:43 INFO - '_': '/tools/buildbot/bin/python'} 16:15:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:15:43 INFO - Running setup.py (path:/tmp/pip-7ujyDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:15:43 INFO - Running setup.py (path:/tmp/pip-5dOMwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:15:43 INFO - Running setup.py (path:/tmp/pip-UAB08A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:15:43 INFO - Running setup.py (path:/tmp/pip-z3sFS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:15:43 INFO - Running setup.py (path:/tmp/pip-CpFnBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:15:43 INFO - Running setup.py (path:/tmp/pip-LCyjfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:15:43 INFO - Running setup.py (path:/tmp/pip-g2PiG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:15:43 INFO - Running setup.py (path:/tmp/pip-oL9F3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:15:43 INFO - Running setup.py (path:/tmp/pip-zZKmrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:15:43 INFO - Running setup.py (path:/tmp/pip-lzaeRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:15:44 INFO - Running setup.py (path:/tmp/pip-L_IE5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:15:44 INFO - Running setup.py (path:/tmp/pip-l9HF6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:15:44 INFO - Running setup.py (path:/tmp/pip-ltBAX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:15:44 INFO - Running setup.py (path:/tmp/pip-_5G81B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:15:44 INFO - Running setup.py (path:/tmp/pip-1up6YJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:15:44 INFO - Running setup.py (path:/tmp/pip-bBXkwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:15:44 INFO - Running setup.py (path:/tmp/pip-ITlSgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:15:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:15:44 INFO - Running setup.py install for manifestparser 16:15:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:15:44 INFO - Running setup.py install for mozcrash 16:15:44 INFO - Running setup.py install for mozdebug 16:15:44 INFO - Running setup.py install for mozdevice 16:15:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:15:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:15:44 INFO - Running setup.py install for mozfile 16:15:45 INFO - Running setup.py install for mozhttpd 16:15:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:15:45 INFO - Running setup.py install for mozinfo 16:15:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:15:45 INFO - Running setup.py install for mozInstall 16:15:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:15:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:15:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:15:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:15:45 INFO - Running setup.py install for mozleak 16:15:45 INFO - Running setup.py install for mozlog 16:15:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:15:45 INFO - Running setup.py install for moznetwork 16:15:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:15:45 INFO - Running setup.py install for mozprocess 16:15:45 INFO - Running setup.py install for mozprofile 16:15:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:15:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:15:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:15:45 INFO - Running setup.py install for mozrunner 16:15:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:15:46 INFO - Running setup.py install for mozscreenshot 16:15:46 INFO - Running setup.py install for moztest 16:15:46 INFO - Running setup.py install for mozversion 16:15:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:15:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:15:46 INFO - Cleaning up... 16:15:46 INFO - Return code: 0 16:15:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0ad30ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f4850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ef370>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f28f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f2d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1471562111.946310-1123868270', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:15:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:15:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:15:46 INFO - Using env: {'DISPLAY': ':0', 16:15:46 INFO - 'HOME': '/home/cltbld', 16:15:46 INFO - 'LANG': 'en_US.UTF-8', 16:15:46 INFO - 'LANGUAGE': 'en_US:en', 16:15:46 INFO - 'LOGNAME': 'cltbld', 16:15:46 INFO - 'MAIL': '/var/mail/cltbld', 16:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:46 INFO - 'MOZ_NO_REMOTE': '1', 16:15:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:46 INFO - 'NO_EM_RESTART': '1', 16:15:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:46 INFO - 'PWD': '/builds/slave/test', 16:15:46 INFO - 'SHELL': '/bin/bash', 16:15:46 INFO - 'SHLVL': '1', 16:15:46 INFO - 'TERM': 'linux', 16:15:46 INFO - 'TMOUT': '86400', 16:15:46 INFO - 'USER': 'cltbld', 16:15:46 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1471562111.946310-1123868270', 16:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:46 INFO - '_': '/tools/buildbot/bin/python'} 16:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:15:46 INFO - Running setup.py (path:/tmp/pip-YrhZ47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:15:46 INFO - Running setup.py (path:/tmp/pip-fNwewS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:15:46 INFO - Running setup.py (path:/tmp/pip-mARhc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:15:46 INFO - Running setup.py (path:/tmp/pip-ft1Thh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:15:46 INFO - Running setup.py (path:/tmp/pip-VVvfcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:15:46 INFO - Running setup.py (path:/tmp/pip-IqITk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:15:46 INFO - Running setup.py (path:/tmp/pip-3mY_43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:15:47 INFO - Running setup.py (path:/tmp/pip-SQssFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:15:47 INFO - Running setup.py (path:/tmp/pip-8bQtys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:15:47 INFO - Running setup.py (path:/tmp/pip-PPqDCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:15:47 INFO - Running setup.py (path:/tmp/pip-SzBRMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:15:47 INFO - Running setup.py (path:/tmp/pip-G19spo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:15:47 INFO - Running setup.py (path:/tmp/pip-fv1WXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:15:47 INFO - Running setup.py (path:/tmp/pip-Mn07ym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:15:47 INFO - Running setup.py (path:/tmp/pip-uREP08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:15:47 INFO - Running setup.py (path:/tmp/pip-WEvB7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:15:47 INFO - Running setup.py (path:/tmp/pip-cDjkev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:15:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:49 INFO - Downloading blessings-1.6.tar.gz 16:15:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:15:49 INFO - Installing collected packages: blessings 16:15:49 INFO - Running setup.py install for blessings 16:15:49 INFO - Successfully installed blessings 16:15:49 INFO - Cleaning up... 16:15:49 INFO - Return code: 0 16:15:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:15:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:15:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:15:50 INFO - Reading from file tmpfile_stdout 16:15:50 INFO - Current package versions: 16:15:50 INFO - argparse == 1.2.1 16:15:50 INFO - blessings == 1.6 16:15:50 INFO - blobuploader == 1.2.4 16:15:50 INFO - docopt == 0.6.1 16:15:50 INFO - functools32 == 3.2.3-2 16:15:50 INFO - jsonschema == 2.5.1 16:15:50 INFO - manifestparser == 1.1 16:15:50 INFO - mozInstall == 1.12 16:15:50 INFO - mozcrash == 0.17 16:15:50 INFO - mozdebug == 0.1 16:15:50 INFO - mozdevice == 0.48 16:15:50 INFO - mozfile == 1.2 16:15:50 INFO - mozhttpd == 0.7 16:15:50 INFO - mozinfo == 0.9 16:15:50 INFO - mozleak == 0.1 16:15:50 INFO - mozlog == 3.3 16:15:50 INFO - moznetwork == 0.27 16:15:50 INFO - mozprocess == 0.23 16:15:50 INFO - mozprofile == 0.28 16:15:50 INFO - mozrunner == 6.12 16:15:50 INFO - mozscreenshot == 0.1 16:15:50 INFO - mozsystemmonitor == 0.3 16:15:50 INFO - moztest == 0.7 16:15:50 INFO - mozversion == 1.4 16:15:50 INFO - psutil == 3.1.1 16:15:50 INFO - requests == 1.2.3 16:15:50 INFO - wsgiref == 0.1.2 16:15:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0ad30ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f4850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ef370>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f28f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f2d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1471562111.946310-1123868270', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:15:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:15:50 INFO - Using env: {'DISPLAY': ':0', 16:15:50 INFO - 'HOME': '/home/cltbld', 16:15:50 INFO - 'LANG': 'en_US.UTF-8', 16:15:50 INFO - 'LANGUAGE': 'en_US:en', 16:15:50 INFO - 'LOGNAME': 'cltbld', 16:15:50 INFO - 'MAIL': '/var/mail/cltbld', 16:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:50 INFO - 'MOZ_NO_REMOTE': '1', 16:15:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:50 INFO - 'NO_EM_RESTART': '1', 16:15:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:50 INFO - 'PWD': '/builds/slave/test', 16:15:50 INFO - 'SHELL': '/bin/bash', 16:15:50 INFO - 'SHLVL': '1', 16:15:50 INFO - 'TERM': 'linux', 16:15:50 INFO - 'TMOUT': '86400', 16:15:50 INFO - 'USER': 'cltbld', 16:15:50 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1471562111.946310-1123868270', 16:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:50 INFO - '_': '/tools/buildbot/bin/python'} 16:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:15:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:15:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:15:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:15:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:15:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:15:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:15:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:15:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:15:50 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:15:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:15:50 INFO - Cleaning up... 16:15:50 INFO - Return code: 0 16:15:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0ad30ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f4850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ef370>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f28f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f2d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1471562111.946310-1123868270', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:15:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:15:50 INFO - Using env: {'DISPLAY': ':0', 16:15:50 INFO - 'HOME': '/home/cltbld', 16:15:50 INFO - 'LANG': 'en_US.UTF-8', 16:15:50 INFO - 'LANGUAGE': 'en_US:en', 16:15:50 INFO - 'LOGNAME': 'cltbld', 16:15:50 INFO - 'MAIL': '/var/mail/cltbld', 16:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:50 INFO - 'MOZ_NO_REMOTE': '1', 16:15:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:50 INFO - 'NO_EM_RESTART': '1', 16:15:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:50 INFO - 'PWD': '/builds/slave/test', 16:15:50 INFO - 'SHELL': '/bin/bash', 16:15:50 INFO - 'SHLVL': '1', 16:15:50 INFO - 'TERM': 'linux', 16:15:50 INFO - 'TMOUT': '86400', 16:15:50 INFO - 'USER': 'cltbld', 16:15:50 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1471562111.946310-1123868270', 16:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:50 INFO - '_': '/tools/buildbot/bin/python'} 16:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:15:50 INFO - Cleaning up... 16:15:50 INFO - Return code: 0 16:15:50 INFO - Running post-action listener: _resource_record_post_action 16:15:50 INFO - Running post-action listener: _start_resource_monitoring 16:15:50 INFO - Starting resource monitoring. 16:15:50 INFO - [mozharness: 2016-08-18 23:15:50.578303Z] Finished create-virtualenv step (success) 16:15:50 INFO - [mozharness: 2016-08-18 23:15:50.578766Z] Running install step. 16:15:50 INFO - Running pre-action listener: _resource_record_pre_action 16:15:50 INFO - Running main action method: install 16:15:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:15:50 INFO - Reading from file tmpfile_stdout 16:15:50 INFO - Detecting whether we're running mozinstall >=1.0... 16:15:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:15:50 INFO - Reading from file tmpfile_stdout 16:15:50 INFO - Output received: 16:15:50 INFO - Usage: mozinstall [options] installer 16:15:50 INFO - Options: 16:15:50 INFO - -h, --help show this help message and exit 16:15:50 INFO - -d DEST, --destination=DEST 16:15:50 INFO - Directory to install application into. [default: 16:15:50 INFO - "/builds/slave/test"] 16:15:50 INFO - --app=APP Application being installed. [default: firefox] 16:15:50 INFO - mkdir: /builds/slave/test/build/application 16:15:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:16:07 INFO - Reading from file tmpfile_stdout 16:16:07 INFO - Output received: 16:16:07 INFO - /builds/slave/test/build/application/firefox/firefox 16:16:07 INFO - Running post-action listener: _resource_record_post_action 16:16:07 INFO - [mozharness: 2016-08-18 23:16:07.836528Z] Finished install step (success) 16:16:07 INFO - [mozharness: 2016-08-18 23:16:07.836776Z] Running run-tests step. 16:16:07 INFO - Running pre-action listener: _resource_record_pre_action 16:16:07 INFO - Running main action method: run_tests 16:16:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:16:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:16:07 INFO - Python 2.7.3 16:16:07 INFO - Return code: 0 16:16:07 INFO - grabbing minidump binary from tooltool 16:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:07 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ef370>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f28f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f2d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:16:07 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:16:07 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:16:07 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:16:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:16:07 INFO - Return code: 0 16:16:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:16:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:16:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:16:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:16:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:16:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:16:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:16:07 INFO - Using env: {'DISPLAY': ':0', 16:16:07 INFO - 'HOME': '/home/cltbld', 16:16:07 INFO - 'LANG': 'en_US.UTF-8', 16:16:07 INFO - 'LANGUAGE': 'en_US:en', 16:16:07 INFO - 'LOGNAME': 'cltbld', 16:16:07 INFO - 'MAIL': '/var/mail/cltbld', 16:16:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:16:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:07 INFO - 'MOZ_NO_REMOTE': '1', 16:16:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:16:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:07 INFO - 'NO_EM_RESTART': '1', 16:16:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:07 INFO - 'PWD': '/builds/slave/test', 16:16:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:16:07 INFO - 'SHELL': '/bin/bash', 16:16:07 INFO - 'SHLVL': '1', 16:16:07 INFO - 'TERM': 'linux', 16:16:07 INFO - 'TMOUT': '86400', 16:16:07 INFO - 'USER': 'cltbld', 16:16:07 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1471562111.946310-1123868270', 16:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:07 INFO - '_': '/tools/buildbot/bin/python'} 16:16:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:16:08 INFO - mozversion application_buildid: 20160818143003 16:16:08 INFO - mozversion application_changeset: e7cfd78dee27a013c4e5be92e56d76080ffaf85d 16:16:08 INFO - mozversion application_display_name: Nightly 16:16:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:16:08 INFO - mozversion application_name: Firefox 16:16:08 INFO - mozversion application_remotingname: firefox 16:16:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:16:08 INFO - mozversion application_vendor: Mozilla 16:16:08 INFO - mozversion application_version: 51.0a1 16:16:08 INFO - mozversion platform_buildid: 20160818143003 16:16:08 INFO - mozversion platform_changeset: e7cfd78dee27a013c4e5be92e56d76080ffaf85d 16:16:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:16:08 INFO - mozversion platform_version: 51.0a1 16:16:08 INFO - using testdate: 1471562168 16:16:08 INFO - actual date: 1471562168 16:16:08 INFO - starting webserver on 'localhost:46018' 16:16:08 INFO - SUITE-START | Running 2 tests 16:16:08 INFO - TEST-START | dromaeo_css 16:16:08 INFO - operating with platform_type : linux_ 16:16:08 INFO - Initialising browser for dromaeo_css test... 16:16:08 INFO - TEST-INFO | started process 29503 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm_PKoH/profile http://localhost:46018/getInfo.html) 16:16:12 INFO - PROCESS | 29503 | __metrics Screen width/height:1600/1200 16:16:12 INFO - PROCESS | 29503 | colorDepth:24 16:16:12 INFO - PROCESS | 29503 | Browser inner width/height: 1024/697 16:16:12 INFO - PROCESS | 29503 | __metrics 16:16:12 INFO - PROCESS | 29503 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:16:12 INFO - PROCESS | 29503 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:16:13 INFO - PROCESS | 29503 | console.error: PushService: 16:16:13 INFO - PROCESS | 29503 | stateChangeProcessEnqueue: Error transitioning state 16:16:13 INFO - PROCESS | 29503 | UnknownError 16:16:13 INFO - TEST-INFO | 29503: exit 0 16:16:13 INFO - Browser initialized. 16:16:13 INFO - Running cycle 1/1 for dromaeo_css test... 16:16:13 INFO - TEST-INFO | started process 29582 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm_PKoH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:16:25 INFO - PROCESS | 29582 | RSS: Main: 156041216 16:16:25 INFO - PROCESS | 29582 | 16:17:17 INFO - PROCESS | 29582 | 1471562237314 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:19:26 INFO - PROCESS | 29582 | Cycle 1(1): loaded http://localhost:46018/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46018/tests/dromaeo/cssquery-ext.html) 16:19:27 INFO - PROCESS | 29582 | RSS: Main: 230191104 16:19:27 INFO - PROCESS | 29582 | 16:22:30 INFO - PROCESS | 29582 | Cycle 1(1): loaded http://localhost:46018/tests/dromaeo/cssquery-ext.html (next: http://localhost:46018/tests/dromaeo/cssquery-jquery.html) 16:22:31 INFO - PROCESS | 29582 | RSS: Main: 243863552 16:22:31 INFO - PROCESS | 29582 | 16:25:33 INFO - PROCESS | 29582 | Cycle 1(1): loaded http://localhost:46018/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46018/tests/dromaeo/cssquery-mootools.html) 16:25:33 INFO - PROCESS | 29582 | RSS: Main: 185024512 16:25:33 INFO - PROCESS | 29582 | 16:28:35 INFO - PROCESS | 29582 | Cycle 1(1): loaded http://localhost:46018/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46018/tests/dromaeo/cssquery-prototype.html) 16:28:36 INFO - PROCESS | 29582 | RSS: Main: 226164736 16:28:36 INFO - PROCESS | 29582 | 16:31:38 INFO - PROCESS | 29582 | Cycle 1(1): loaded http://localhost:46018/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46018/tests/dromaeo/cssquery-yui.html) 16:31:39 INFO - PROCESS | 29582 | RSS: Main: 186822656 16:31:39 INFO - PROCESS | 29582 | 16:34:42 INFO - PROCESS | 29582 | Cycle 1(1): loaded http://localhost:46018/tests/dromaeo/cssquery-yui.html (next: http://localhost:46018/tests/dromaeo/cssquery-dojo.html) 16:34:42 INFO - PROCESS | 29582 | RSS: Main: 274423808 16:34:42 INFO - PROCESS | 29582 | 16:34:42 INFO - PROCESS | 29582 | __start_tp_report 16:34:42 INFO - PROCESS | 29582 | _x_x_mozilla_page_load 16:34:42 INFO - PROCESS | 29582 | _x_x_mozilla_page_load_details 16:34:42 INFO - PROCESS | 29582 | |i|pagename|runs| 16:34:42 INFO - PROCESS | 29582 | |0;dojo.html;2980.582718419421;3022.1235841605935;3028.424599326128;3036.3320069584684;3057.5413687946807;5186.611004174692;5291.814786482474;5333.839984800453;5425.562593848512;5515.47602977717;5335.653182543132;5343.438938911417;5353.384360798509;5390.460953904608;5394.460553944604;4832.130216561018;4899.583535399477;4916.901661966758;4925.26121081837;5083.983203359325;4976.502349765013;5003.849884503471;5027.29617853499;5043.899122017558;5044;4794.496577859327;4912.533309335608;4946.851594452172;4998.475160108209;5022.799088036474;4827.179379505493;4851.029794041206;4853.174960256765;4951.851444456636;5003.974980125076;4870.099031679115;4907.901841963177;4910.7299098549565;4941.283513890502;4976.900461990776;5120.436751957282;5252.343457067866;5355.303810504648;5398.433164517708;5416;5756.913646295309;5801.24583804107;5809.302883653946;5809.738561764731;5812.651240925516;5810.041343178371;5838.591298609099;5839.591228613998;5853.64878107315;5857.062869940832;5147.176451767699;5262.894742105136;5314.096603577401;5331.920021199685;5426.62013659044;5942.465178133903;5952.375000624958;5952.494038006731;5953.910691339634;5958.910616340759;5662.801801936913;5698.116791897262;5703.62926409782;5706.144078388192;5708.914366284509;5551.805686800943;5669.801556945487;5709.172170035322;5716.57125715573;5788.710564471759;5721.799737009268;5732.369439361667;5736.627119237236;5742.569307301969;5774.585226619505;5676.318841739017;5720.8283751487525;5729.169270455761;5737.741801618854;5747.39652336507;4285.871423857289;4337.783110844445;4340.739555626673;4387.96882732564;4389.473263208435;3921.4117882317883;3951.644352008333;3956.090099277182;3962.128331767007;3964.0288129408477;5363.946360536423;5374.8656283592445;5400.729963501888;5490.862728431821;5493.7802487900835;5775.335836378787;5775.5668324875805;5775.595708300462;5780.450857168562;5783.045797443375;5223.973880130575;5391.514763671288;5436.483534064258;5445.972770136124;5447.673139611636;4883.34074899891;4917;4944.406671199479;4984.102861484967;5021.096202683552;6004.309504406961;6013.879722405527;6016;6018.789342372996;6021.126936594169;5552.305961754781;5725.7137143141845;5783.334916484489;5794.594378393472;5795.188673585617;5924.289085309618;5986.461218490357;6006.819795406145;6077.4226448487325;6086.056661217518;5663;5707.6575405475805;5710.486056254957;5715.942840571541;5718.313802343745;5800.303963524404;5807.738651760766;5810.448007439287;5811.56413269015;5813.534917206698;5423.918641220306;5503.504684578407;5527.198556209247;5566.276384070045;5688.232088667977;5633.295838020247;5640.858978525405;5642.633228840113;5647.181158731879;5647.915281270866;5590.329160500766;5634.605577609528;5647.378788333198;5650.971745141248;5658.971705141448;5510.311211098613;5587.636803607753;5618.494335509824;5630.239917611234;5729.570282228933;5520.751566179451;5548.4174161712435;5557.499825015606;5575.219469274224;5576.358718747396 16:34:42 INFO - PROCESS | 29582 | |1;ext.html;574.2964868036655;586.1764221269117;613.6164896939413;617.3702823120417;636.5162476517845;33561.66438335619;34105.829470852645;36359.63640363592;36536.634633653724;36631.08422289444;45334.55985281763;46420.767896160556;46473.53526464734;50308;50353.49646503543;8994.955025224881;9139.99460059393;9140.588673509708;9144.725658230263;9149.039350868163;9068.637254509844;9152;9171.082891710808;9180;9182.219511341544;9177.311701622371;9209.171174594285;9216.907830921706;9221.585028673691;9243.49160796156;9185.724428267162;9207.861882071775;9213.907860921372;9226.077392260788;9226.800515932953;9034;9117.908820911773;9118.088191180896;9121.863172052424;9130.817383652357;45022.774886125684;45227.773861130816;45524.544754552364;45534.77232613849;45661.54338456606;3353.5975682918206;3412.436947903593;3471.7396195285455;3818;4201.243776120297;33414.33171336584;33684.15789605255;33790.1552461188;34260.31479370398;35540;4243.80902859369;4353.25994580922;4397.340398940152;4515.096980603892;4526.502084770673;346054;347815.08739650383;353739;355288;357923;59842.00789960485;60234.698826505584;60830.3501789894;60860;60895.695521523;54839.177412338846;62890.37109628845;66443.66778166174;68273;68753;16605.0867202305;16921.407750728664;16996.57508562271;16996.575085622957;16996.915015424845;12962.351882405843;13053.086283960221;13062.54281100176;13063.150895191782;13073.084884058215;15478.845211547741;17747;17758.20088096013;18267.255212681368;18287.45137645873;6125.601835880653;6134.846628834225;6213.596116252429;6400.359964003563;6414.422701956753;951.5765484359532;1030.2788048366024;1087.1194332590626;1090.3948308688596;1128.4357821089454;33287.66712332894;33622.49566256508;33829.83085084608;34062.318753624786;34191.31617367639;1067.1036329483272;1142.1319796954374;1142.657202839145;1156.6819124740596;1190.5535424215918;16558;17550.473485795446;17743.73384399235;17781;17809.376671816422;522177;537526;543819;549535;757361;61528.38471615316;61801.381986179564;61871.690641546506;62004.37995620076;62064;1388.6597783543098;1391.9443222270995;1395.4418232706998;1408.0777091005407;1430.7353139669194;31462;34289;34362.31275374528;34548.604197363624;34559.65440345665;52961.20558191553;53176.73411632917;53215.4678453226;53291.46708532865;53317;440489;441060;442250.4511800676;443202;443368;25670.22989310324;28129.296767580974;29218.41563168682;29456.263593410335;29818.70181298159;39097.6090239094;41548;41560.16879662329;50606.2409063857;50894.236586451974;40623;42896.35655465233;43366.56633433751;44746.55253447424;45167.548324516334;41589.81971580412;42128.15743685048;43037.78481107575;43126;44256;42122.57877421186;43147.84260787011;43203.78398107989;43260.35109473424;43364.78317608392;34225.82887085548;37495.25009499849;37536.62463375441;37602;38515;28564.285892852844;29236.561451577818;29418.70581294245;29576.852115739282;29667.258318542208 16:34:42 INFO - PROCESS | 29582 | |2;jquery.html;362.8040857936713;380.24711072077287;390.732348341386;396.1739772574183;412.96902732295086;18030.549236269082;19651.115699793507;19762.505937351572;20024.4993875153;20190.29333973311;19113.808861911377;19324.903375483103;19714.50713732154;19805.108770105344;19933.800661993377;5664;5739.913901291484;5752.539796816265;5763.711814409284;5879.647221166722;4151.667866570667;6267.592606480587;6588.945768677013;6596.60420374779;6606.603603783764;6318.652474113922;6371.776987805428;6519.543631945766;6532.216134063919;6533.15069041024;6360.650164240965;6367.7771278005275;6454.644994525299;6462.838429039265;6470.417662410358;5614.943850561483;5637.408072152447;5643.040683083886;5667.801626943078;5673.8297851064535;24112.276631701076;24196.758032419802;24280.271591852274;24290;24524;2320.3734991552355;2346.4016675747744;2420.3344080378038;2427.1626288930293;2470.542949554338;14102.153870767685;14670.853291467056;14948.775768363483;15025.173615451145;15843.445479408281;1918.2039453626728;1961.4507937777446;1972.7422702884853;1975.9308424205228;2010.6280338137344;85575;85651;85750.57124714399;86110.56944715299;87352.56323718405;10762.56949722018;10808.243422960317;11012.614558490415;11075.280106793032;11161.43739876418;15284.082955022734;15287.770683439758;15291.158986255641;15320.923395383175;15328.310226039855;8388.454750441202;8465.83068338642;8578.360980440702;8619.870701939475;8673.609687564074;8197.34421246299;8321.209485098905;8334.083250842403;8549.273311768446;8592.48445093284;4540.750258735801;4588.632909367309;4717.339572459859;4732.38478997735;4841.3222148899185;1758.9007347850622;1851.0559614596384;1982.4845540159374;1993.9302124425576;2003.1586733571935;883.7348795361365;1018.2007124407453;1050.8633877595864;1062.644014255233;1095.9397233152254;17998.91000544989;18751.90624046871;19092.90453547751;19299.035048247533;21251.46871328229;956.4357029352715;972.1153750087528;978.2663002747939;1002.1181360402799;1033.5865653738565;10588.258821882548;11228.992489018336;11388.487518061707;11395.202335836411;11419.942900285612;470626;470847;471453;476890;481596;99147.50426247966;101488.49255753674;103204.19560141774;105118;106139;982.8623992641036;1016.8830584482731;1052.9157667386437;1059.4861492176287;1062.3201151263197;17519.21163547618;17821.643567128845;18427.355042573447;18438.35465758692;18523.814761852747;42113;42197.578024219365;42828.28888822165;43079.35380969225;43107;54716.72641636767;59959.40040599538;60561.394386057334;60882.69558652178;61339.38660613515;8388.328933685412;8562.315014798676;8574.401250516654;8874.245689116497;8900.77748056278;9796.216302695624;12362.134650574373;12803.487860485477;13016.934915325362;13448.93275533616;11405.543778248777;11562.653120406401;11678.532858685558;11826.82259766087;12218.20581662189;10984.06635435997;11536;11671.941640291745;11743.530258789553;12265;11387.145964052896;11688.415579221175;11841.23032002917;11861.347625880315;12091.637250882488;8497.2777313929;8823.382363234512;9013.233875120426;9049.095090490899;9111.681091161778;10628.41543715103;11319.773604528027;11523.366214858263;11803.468843902217;12105.455254513392 16:34:42 INFO - PROCESS | 29582 | |3;mootools.html;1355.5933220033987;1489.5605796290092;1495.4765831958816;1636.4108920788515;1815.5461134716313;8592.398532102756;8956.462612243253;9039.90960090399;9046.140616641425;9053.185213330798;8856.291496680265;8978.86531702025;8984.326175536844;8994.505302208376;8999.280057595393;2137.9144834206613;2397.0771253067605;2473.6042233242683;2501.062101711858;2502.5370306493264;2421.503591763693;2440.5973014452684;2461.59383701689;2461.8645974471397;2464.4331803685163;2364.243442098529;2379;2379.1078345620394;2393.868337241451;2454.460018795862;2300.861948283108;2304.896279667419;2305.158617104753;2321.616933206019;2403.9399015024587;2360.834741568091;2366.491204391047;2375.6317770745563;2379.0364902214455;2383.1778036577525;9260.120288572642;9317.487538185396;9320.067993200693;9321.207697345733;9336.813263734755;5201.271821944931;5344.118220493614;5464.672119672832;5484.91772623411;5493.313335833021;3535.9646403535894;3612.277544491086;3668.321360548307;3687.7418580699364;3699.038250054978;1135.1259530161728;1178.263585259213;1190.65471013406;1210.7760064388117;1224.3755684600828;12464.626061218178;12521.060920431004;12600.68498287541;12611.684707882285;12624.431900564497;4296.462942132233;4613.40025796651;4627.907441851212;4733.83431579893;4762.52374762521;9744.853827192597;9750.122488976027;9751.31740778153;9751.414915105117;9759.219262458986;5297.841064768063;5307.601929855199;5315.920261196085;5317.175837745156;5318.335208098988;4403.603675669206;4900.632452566072;4982.9252561211615;4985.351904252424;4988.201887698024;3791.2227993261317;3856.6721828644318;3900.434437006675;3916.882493525142;3935.779908228458;1169.187414746743;1192.8389767117035;1202.4228370382266;1203.9759204815855;1214.763121191377;983.5279066048193;996.8853581838036;999.1008092716468;1004.8542961270575;1006.0894890124449;5988;6053.51571874249;6088.238970128734;6110.877782444415;6153.507719382439;959.8320293948531;997.2271489595621;1006.6879267426974;1026.9383836969657;1065.1159537583942;3952.209558088394;4260.510041345285;4326.113146804897;4385.978070109629;4517.593416592523;11024.393658348868;11332.773344533229;11360.318380897008;11367.715807104723;11407.885921140849;11315.660530183943;11333.773324533464;11357.886421135849;11398.886011139783;11433.714157146138;8030.237127472998;8250.339972802161;8387.119352468026;8391.832163356821;8572.142785721378;6186.721597528032;6312.3687631238345;6351.841203969938;6413.8717225656155;6451.7096430766405;10194.898051019394;10241.07830295277;10439.425831579336;10483.842742358718;10556.577736890438;10494.895051049698;10521.368717876952;10526.684199474028;10714.73213169677;10771.946140269562;7924.48490848093;7998.120206777367;8019.318357939641;8134.6171150905675;8153.55155466455;8596.91403085961;8634.697785577475;8652.610632521677;8663.95668021656;8665.82668346617;7695.807604809925;7950.16523265072;7983.92016079855;8039.276465118168;8178.713745018896;7857.960710196412;7863.52818830872;7928.127905930228;7944.682212711658;7950.840983180188;7149.7140114396925;7166.068411106523;7246.746363877239;7255.56466612005;7256.854862902818;5166.3800343958965;5183.663061900965;5250.65870718402;5290.312259406252;5399.335190009839;5287.233351163983;5293.947060529345;5339.626226164131;5384.542313903362;5521.089020311603 16:34:42 INFO - PROCESS | 29582 | |4;prototype.html;323.7264511487792;332.869906666866;335.96808303211185;339.3890996206827;340.8125530957972;5215.305025866594;5263.34208223972;5292.311999440072;5295.126304159814;5313.442088580701;4925.285833554132;4996.800127994885;5121.257417674435;5162.767675454605;5211.5309622134;4088.9182216355657;4089.161721847029;4092.6725861931122;4097.873084901661;4104.8563300284495;4099.405586190001;4124.886280704208;4125.855595054174;4145.7719825409595;4156.044109854735;3898.2203559288114;3911.3741801311794;4053.918921621566;4103.138340948404;4126.46355973723;4066.146109317047;4075.4701888754566;4078.6737061035046;4096.91806163878;4100.938485922714;3662.3336381946415;3662.7252956028137;3663.9633603664156;3668.926621467556;3672.8530858765616;4975;5059.6458247922665;5077.974610126926;5105.132127538327;5105.642605017651;4651.674382793206;4660.930086048712;4698.060387922429;4706.388169537938;4709.952900470986;5399.136138217867;5407.161889907071;5412.485813847678;5462.235287059815;5464.043792336325;3745.1760612665444;3928.8821335359985;4045.939310910339;4055.5336136344404;4059.4925634295714;5599.4120617335;5648.717564121818;5648.802291919763;5651.463111004448;5655.943440565583;4029.435878976946;4052.675785937118;4052.878413647595;4053.412255223035;4068.779366190131;3889.3193691103943;4100.831263090005;4104.363823607346;4104.56902025289;4122.711410201257;4600.2978897808025;4617.930731039037;4621.976890115595;4652.651051171176;4660.86017419478;5450.04624190765;5453.127499600124;5472.781088756485;5478.808476609388;5509.586780991442;1358.4769863602387;1405.220102842932;1415.9646008849654;1417.9078359906573;1421.580633713057;893.097971049245;901.2114399900088;903.6972614174325;916.5005072235648;918.6141820435433;4692.601128904082;4719.740414277179;4720;4745.335653008581;4762.880927976828;4542.772861356985;4948.752562371867;4966.850994470172;4968.627352948543;4972.676776009548;4634.629229661619;4647.55848194421;4653.743489257881;4660.836870709509;4684.906301874012;2603.6745406824148;2617.952818872466;2619.305883940757;2620.371110933362;2636.248669129289;4759.619230461555;5054.620903432184;5071.797128114834;5088.821891233863;5113.948860511422;4971.975140124348;4989.176785830297;4994.3507344045765;5001.32402684027;5026.271190677331;5043.84868453947;5047.646664733434;5068.391792984866;5104.897902042013;5115.7442127893455;4940.258961155855;4941.728204948762;4950.554450099508;4960.677555958851;5204.386640141568;5550.167474878801;5559.583031272751;5577.693226872561;5582.3859375467855;5605.32736071674;5828.59199856006;5842.883142337045;5852.882942341044;5863.237779088691;5875.883582119554;3905.5899130592015;4004.4771793769737;4021.155557332993;4045.130296986162;4073.7759423232005;5290.788368465218;5398.757055932414;5571.247881536103;5602.85992850182;5628.099504079328;5474.698891561003;5504.440435197653;5517.558595312285;5524.364698059614;5530.336359636869;5264.131418315935;5435.918461223164;5477.849651573214;5507.311586051744;5511.696856672921;5431.782728690966;5433.375161856437;5445.128779395278;5446.754896029767;5447.264619276505;5441.29263195782;5457.399686034612;5511.559075273888;5512.586556008396;5519.862003449946;5286.867828304323;5349.144136938071;5380.623356365017;5400.621956463167;5410.161424979135 16:34:42 INFO - PROCESS | 29582 | |5;yui.html;638.3807706524669;676.2763842688322;685.9314068593139;736.0394684936159;811.5739236900627;15330.770038449418;16437.753433698505;16580.419685311015;16594.08732519711;16652.16739163043;14678.853211467882;14945.551633450987;15644.452444164457;15681.372745090212;16343.610793082602;796.6733639207926;819.1890028871434;823.086374124721;829.0548774397192;831.7213733399318;656.7537173559915;785.3285440947993;811.4968719393984;812.2283830361151;815.4291995603072;858.0218550852034;858.8024754306513;859.282499113238;859.3683642522741;859.8151397449548;851.9446235994641;853.5220276645099;853.799357151069;854.5214679779313;854.8290341931638;507.11508417810785;602.28027507129;622.3838399983983;623.0218556865723;626.6616027345228;14565.70868582633;14578.12531248118;14586.416543338253;14599.197044162673;14613.342399592044;13908.374123164482;14284;14702.705945881129;14801.925990370088;14927.328270227867;13145.145565538305;13253.602391928258;13440.932795336059;13550.254735989516;13993;4371.14762621289;4404.559544045602;4457;4459.904651000752;4463.352813842007;83364;84005;84486.57756711177;89287.55356223242;89576.552117239;10906.5092070857;11065.778684426266;11131;11418.257813242113;11496.195266331277;22076.55846883053;22146.22488212937;22170.113195472324;22181.44546386321;22218.66671999921;8358.45670031446;8429.114942931026;8481.194286542892;8549.444286121383;8950.776230594287;4773.331733557305;4794.9280760788615;4795.472498025214;4846.588040016568;4914.066327397854;3475.3396854597545;3589.2462582857893;3592.9281414371567;3597.6042635310096;3599.856005759793;553.8753780399378;559.9888002239933;561.53673219594;568.5934556791914;572.8882867840814;497.1895809829954;592.8646641681132;635.6472157952381;651.8012006338113;656.6388486332498;9011.774705632411;9495.477748723748;9561.61753529851;9765.218782497383;9767.462789546644;630.678354039434;635.920509936258;662.2251965200727;664.6078813500059;688.3495097133261;4322.762248076386;4623.190941585209;4635.513271106485;4653.627709783209;4722.716637001791;128252;129310;130886.34556827345;131759;134883.32558337343;68449;68706;94310.58534121994;114414;116602.41698791621;75965.6201718999;76107.61946190233;98016.50991744996;99149;100492.49753751184;8764.517951512727;8786.25316848075;8836.337274704294;8891.688790892287;8962.462252264884;55093.72453137708;57454;58873.70563147157;59710;59882;48893.755531222116;53944.290027795374;86124.13875861162;86920.56539717515;88471;10900.890991090304;10906.890931090906;11016.614418495314;11052.944735276273;11100.61147859821;12815.935920320338;13816.792748108988;14025.719485610434;14087.577372678836;14818.777718334019;13839.861601383856;13897.16617002983;14060.437582496994;14131.717365652425;14219.431222751387;12944.352782360656;12974.351282435651;13311.46754129824;13637.590872273848;13933.721325573635;13050.804237936249;13465.326733663474;13543.119697220043;13785.379657915217;14003.159810411407;10544.89455105439;10640.680779576625;10677.57289708403;10942.17967980408;10985.450727463434;10197.643082492077;10865.239433239598;11054.170937179582;11114.666560003212;11361.715957101138 16:34:42 INFO - PROCESS | 29582 | __end_tp_report 16:34:42 INFO - PROCESS | 29582 | __start_cc_report 16:34:42 INFO - PROCESS | 29582 | _x_x_mozilla_cycle_collect,1053 16:34:42 INFO - PROCESS | 29582 | __end_cc_report 16:34:42 INFO - PROCESS | 29582 | __startTimestamp1471563282568__endTimestamp 16:34:42 INFO - PROCESS | 29582 | 16:34:42 INFO - PROCESS | 29582 | ------- Summary: start ------- 16:34:42 INFO - PROCESS | 29582 | Number of tests: 6 16:34:42 INFO - PROCESS | 29582 | 16:34:42 INFO - PROCESS | 29582 | [#0] dojo.html Cycles:165 Average:5351.26 Median:5552.31 stddev:621.76 (11.2%) stddev-sans-first:595.21 16:34:42 INFO - PROCESS | 29582 | Values: 2980.6 3022.1 3028.4 3036.3 3057.5 5186.6 5291.8 5333.8 5425.6 5515.5 5335.7 5343.4 5353.4 5390.5 5394.5 4832.1 4899.6 4916.9 4925.3 5084.0 4976.5 5003.8 5027.3 5043.9 5044.0 4794.5 4912.5 4946.9 4998.5 5022.8 4827.2 4851.0 4853.2 4951.9 5004.0 4870.1 4907.9 4910.7 4941.3 4976.9 5120.4 5252.3 5355.3 5398.4 5416.0 5756.9 5801.2 5809.3 5809.7 5812.7 5810.0 5838.6 5839.6 5853.6 5857.1 5147.2 5262.9 5314.1 5331.9 5426.6 5942.5 5952.4 5952.5 5953.9 5958.9 5662.8 5698.1 5703.6 5706.1 5708.9 5551.8 5669.8 5709.2 5716.6 5788.7 5721.8 5732.4 5736.6 5742.6 5774.6 5676.3 5720.8 5729.2 5737.7 5747.4 4285.9 4337.8 4340.7 4388.0 4389.5 3921.4 3951.6 3956.1 3962.1 3964.0 5363.9 5374.9 5400.7 5490.9 5493.8 5775.3 5775.6 5775.6 5780.5 5783.0 5224.0 5391.5 5436.5 5446.0 5447.7 4883.3 4917.0 4944.4 4984.1 5021.1 6004.3 6013.9 6016.0 6018.8 6021.1 5552.3 5725.7 5783.3 5794.6 5795.2 5924.3 5986.5 6006.8 6077.4 6086.1 5663.0 5707.7 5710.5 5715.9 5718.3 5800.3 5807.7 5810.4 5811.6 5813.5 5423.9 5503.5 5527.2 5566.3 5688.2 5633.3 5640.9 5642.6 5647.2 5647.9 5590.3 5634.6 5647.4 5651.0 5659.0 5510.3 5587.6 5618.5 5630.2 5729.6 5520.8 5548.4 5557.5 5575.2 5576.4 16:34:42 INFO - PROCESS | 29582 | 16:34:42 INFO - PROCESS | 29582 | [#1] ext.html Cycles:180 Average:62349.08 Median:43175.81 stddev:125276.33 (290.2%) stddev-sans-first:125541.90 16:34:42 INFO - PROCESS | 29582 | Values: 574.3 586.2 613.6 617.4 636.5 33561.7 34105.8 36359.6 36536.6 36631.1 45334.6 46420.8 46473.5 50308.0 50353.5 8995.0 9140.0 9140.6 9144.7 9149.0 9068.6 9152.0 9171.1 9180.0 9182.2 9177.3 9209.2 9216.9 9221.6 9243.5 9185.7 9207.9 9213.9 9226.1 9226.8 9034.0 9117.9 9118.1 9121.9 9130.8 45022.8 45227.8 45524.5 45534.8 45661.5 3353.6 3412.4 3471.7 3818.0 4201.2 33414.3 33684.2 33790.2 34260.3 35540.0 4243.8 4353.3 4397.3 4515.1 4526.5 346054.0 347815.1 353739.0 355288.0 357923.0 59842.0 60234.7 60830.4 60860.0 60895.7 54839.2 62890.4 66443.7 68273.0 68753.0 16605.1 16921.4 16996.6 16996.6 16996.9 12962.4 13053.1 13062.5 13063.2 13073.1 15478.8 17747.0 17758.2 18267.3 18287.5 6125.6 6134.8 6213.6 6400.4 6414.4 951.6 1030.3 1087.1 1090.4 1128.4 33287.7 33622.5 33829.8 34062.3 34191.3 1067.1 1142.1 1142.7 1156.7 1190.6 16558.0 17550.5 17743.7 17781.0 17809.4 522177.0 537526.0 543819.0 549535.0 757361.0 61528.4 61801.4 61871.7 62004.4 62064.0 1388.7 1391.9 1395.4 1408.1 1430.7 31462.0 34289.0 34362.3 34548.6 34559.7 52961.2 53176.7 53215.5 53291.5 53317.0 440489.0 441060.0 442250.5 443202.0 443368.0 25670.2 28129.3 29218.4 29456.3 29818.7 39097.6 41548.0 41560.2 50606.2 50894.2 40623.0 42896.4 43366.6 44746.6 45167.5 41589.8 42128.2 43037.8 43126.0 44256.0 42122.6 43147.8 43203.8 43260.4 43364.8 34225.8 37495.3 37536.6 37602.0 38515.0 28564.3 29236.6 29418.7 29576.9 29667.3 16:34:42 INFO - PROCESS | 29582 | 16:34:42 INFO - PROCESS | 29582 | [#2] jquery.html Cycles:180 Average:29358.26 Median:24154.52 stddev:78624.56 (325.5%) stddev-sans-first:78814.98 16:34:42 INFO - PROCESS | 29582 | Values: 362.8 380.2 390.7 396.2 413.0 18030.5 19651.1 19762.5 20024.5 20190.3 19113.8 19324.9 19714.5 19805.1 19933.8 5664.0 5739.9 5752.5 5763.7 5879.6 4151.7 6267.6 6588.9 6596.6 6606.6 6318.7 6371.8 6519.5 6532.2 6533.2 6360.7 6367.8 6454.6 6462.8 6470.4 5614.9 5637.4 5643.0 5667.8 5673.8 24112.3 24196.8 24280.3 24290.0 24524.0 2320.4 2346.4 2420.3 2427.2 2470.5 14102.2 14670.9 14948.8 15025.2 15843.4 1918.2 1961.5 1972.7 1975.9 2010.6 85575.0 85651.0 85750.6 86110.6 87352.6 10762.6 10808.2 11012.6 11075.3 11161.4 15284.1 15287.8 15291.2 15320.9 15328.3 8388.5 8465.8 8578.4 8619.9 8673.6 8197.3 8321.2 8334.1 8549.3 8592.5 4540.8 4588.6 4717.3 4732.4 4841.3 1758.9 1851.1 1982.5 1993.9 2003.2 883.7 1018.2 1050.9 1062.6 1095.9 17998.9 18751.9 19092.9 19299.0 21251.5 956.4 972.1 978.3 1002.1 1033.6 10588.3 11229.0 11388.5 11395.2 11419.9 470626.0 470847.0 471453.0 476890.0 481596.0 99147.5 101488.5 103204.2 105118.0 106139.0 982.9 1016.9 1052.9 1059.5 1062.3 17519.2 17821.6 18427.4 18438.4 18523.8 42113.0 42197.6 42828.3 43079.4 43107.0 54716.7 59959.4 60561.4 60882.7 61339.4 8388.3 8562.3 8574.4 8874.2 8900.8 9796.2 12362.1 12803.5 13016.9 13448.9 11405.5 11562.7 11678.5 11826.8 12218.2 10984.1 11536.0 11671.9 11743.5 12265.0 11387.1 11688.4 11841.2 11861.3 12091.6 8497.3 8823.4 9013.2 9049.1 9111.7 10628.4 11319.8 11523.4 11803.5 12105.5 16:34:42 INFO - PROCESS | 29582 | 16:34:42 INFO - PROCESS | 29582 | [#3] mootools.html Cycles:180 Average:5950.38 Median:4831.58 stddev:3375.61 (69.9%) stddev-sans-first:3367.42 16:34:42 INFO - PROCESS | 29582 | Values: 1355.6 1489.6 1495.5 1636.4 1815.5 8592.4 8956.5 9039.9 9046.1 9053.2 8856.3 8978.9 8984.3 8994.5 8999.3 2137.9 2397.1 2473.6 2501.1 2502.5 2421.5 2440.6 2461.6 2461.9 2464.4 2364.2 2379.0 2379.1 2393.9 2454.5 2300.9 2304.9 2305.2 2321.6 2403.9 2360.8 2366.5 2375.6 2379.0 2383.2 9260.1 9317.5 9320.1 9321.2 9336.8 5201.3 5344.1 5464.7 5484.9 5493.3 3536.0 3612.3 3668.3 3687.7 3699.0 1135.1 1178.3 1190.7 1210.8 1224.4 12464.6 12521.1 12600.7 12611.7 12624.4 4296.5 4613.4 4627.9 4733.8 4762.5 9744.9 9750.1 9751.3 9751.4 9759.2 5297.8 5307.6 5315.9 5317.2 5318.3 4403.6 4900.6 4982.9 4985.4 4988.2 3791.2 3856.7 3900.4 3916.9 3935.8 1169.2 1192.8 1202.4 1204.0 1214.8 983.5 996.9 999.1 1004.9 1006.1 5988.0 6053.5 6088.2 6110.9 6153.5 959.8 997.2 1006.7 1026.9 1065.1 3952.2 4260.5 4326.1 4386.0 4517.6 11024.4 11332.8 11360.3 11367.7 11407.9 11315.7 11333.8 11357.9 11398.9 11433.7 8030.2 8250.3 8387.1 8391.8 8572.1 6186.7 6312.4 6351.8 6413.9 6451.7 10194.9 10241.1 10439.4 10483.8 10556.6 10494.9 10521.4 10526.7 10714.7 10771.9 7924.5 7998.1 8019.3 8134.6 8153.6 8596.9 8634.7 8652.6 8664.0 8665.8 7695.8 7950.2 7983.9 8039.3 8178.7 7858.0 7863.5 7928.1 7944.7 7950.8 7149.7 7166.1 7246.7 7255.6 7256.9 5166.4 5183.7 5250.7 5290.3 5399.3 5287.2 5293.9 5339.6 5384.5 5521.1 16:34:42 INFO - PROCESS | 29582 | 16:34:42 INFO - PROCESS | 29582 | [#4] prototype.html Cycles:180 Average:4476.64 Median:4972.33 stddev:1295.27 (26.0%) stddev-sans-first:1260.84 16:34:42 INFO - PROCESS | 29582 | Values: 323.7 332.9 336.0 339.4 340.8 5215.3 5263.3 5292.3 5295.1 5313.4 4925.3 4996.8 5121.3 5162.8 5211.5 4088.9 4089.2 4092.7 4097.9 4104.9 4099.4 4124.9 4125.9 4145.8 4156.0 3898.2 3911.4 4053.9 4103.1 4126.5 4066.1 4075.5 4078.7 4096.9 4100.9 3662.3 3662.7 3664.0 3668.9 3672.9 4975.0 5059.6 5078.0 5105.1 5105.6 4651.7 4660.9 4698.1 4706.4 4710.0 5399.1 5407.2 5412.5 5462.2 5464.0 3745.2 3928.9 4045.9 4055.5 4059.5 5599.4 5648.7 5648.8 5651.5 5655.9 4029.4 4052.7 4052.9 4053.4 4068.8 3889.3 4100.8 4104.4 4104.6 4122.7 4600.3 4617.9 4622.0 4652.7 4660.9 5450.0 5453.1 5472.8 5478.8 5509.6 1358.5 1405.2 1416.0 1417.9 1421.6 893.1 901.2 903.7 916.5 918.6 4692.6 4719.7 4720.0 4745.3 4762.9 4542.8 4948.8 4966.9 4968.6 4972.7 4634.6 4647.6 4653.7 4660.8 4684.9 2603.7 2618.0 2619.3 2620.4 2636.2 4759.6 5054.6 5071.8 5088.8 5113.9 4972.0 4989.2 4994.4 5001.3 5026.3 5043.8 5047.6 5068.4 5104.9 5115.7 4940.3 4941.7 4950.6 4960.7 5204.4 5550.2 5559.6 5577.7 5582.4 5605.3 5828.6 5842.9 5852.9 5863.2 5875.9 3905.6 4004.5 4021.2 4045.1 4073.8 5290.8 5398.8 5571.2 5602.9 5628.1 5474.7 5504.4 5517.6 5524.4 5530.3 5264.1 5435.9 5477.8 5507.3 5511.7 5431.8 5433.4 5445.1 5446.8 5447.3 5441.3 5457.4 5511.6 5512.6 5519.9 5286.9 5349.1 5380.6 5400.6 5410.2 16:34:42 INFO - PROCESS | 29582 | 16:34:42 INFO - PROCESS | 29582 | [#5] yui.html Cycles:180 Average:21575.99 Median:4644.57 stddev:32248.13 (694.3%) stddev-sans-first:32300.28 16:34:42 INFO - PROCESS | 29582 | Values: 638.4 676.3 685.9 736.0 811.6 15330.8 16437.8 16580.4 16594.1 16652.2 14678.9 14945.6 15644.5 15681.4 16343.6 796.7 819.2 823.1 829.1 831.7 656.8 785.3 811.5 812.2 815.4 858.0 858.8 859.3 859.4 859.8 851.9 853.5 853.8 854.5 854.8 507.1 602.3 622.4 623.0 626.7 14565.7 14578.1 14586.4 14599.2 14613.3 13908.4 14284.0 14702.7 14801.9 14927.3 13145.1 13253.6 13440.9 13550.3 13993.0 4371.1 4404.6 4457.0 4459.9 4463.4 83364.0 84005.0 84486.6 89287.6 89576.6 10906.5 11065.8 11131.0 11418.3 11496.2 22076.6 22146.2 22170.1 22181.4 22218.7 8358.5 8429.1 8481.2 8549.4 8950.8 4773.3 4794.9 4795.5 4846.6 4914.1 3475.3 3589.2 3592.9 3597.6 3599.9 553.9 560.0 561.5 568.6 572.9 497.2 592.9 635.6 651.8 656.6 9011.8 9495.5 9561.6 9765.2 9767.5 630.7 635.9 662.2 664.6 688.3 4322.8 4623.2 4635.5 4653.6 4722.7 128252.0 129310.0 130886.3 131759.0 134883.3 68449.0 68706.0 94310.6 114414.0 116602.4 75965.6 76107.6 98016.5 99149.0 100492.5 8764.5 8786.3 8836.3 8891.7 8962.5 55093.7 57454.0 58873.7 59710.0 59882.0 48893.8 53944.3 86124.1 86920.6 88471.0 10900.9 10906.9 11016.6 11052.9 11100.6 12815.9 13816.8 14025.7 14087.6 14818.8 13839.9 13897.2 14060.4 14131.7 14219.4 12944.4 12974.4 13311.5 13637.6 13933.7 13050.8 13465.3 13543.1 13785.4 14003.2 10544.9 10640.7 10677.6 10942.2 10985.5 10197.6 10865.2 11054.2 11114.7 11361.7 16:34:42 INFO - PROCESS | 29582 | -------- Summary: end -------- 16:34:42 INFO - PROCESS | 29582 | 16:34:43 INFO - TEST-INFO | 29582: exit 0 16:34:43 INFO - TEST-OK | dromaeo_css | took 1115248ms 16:34:43 INFO - TEST-START | kraken 16:34:43 INFO - operating with platform_type : linux_ 16:34:43 INFO - Initialising browser for kraken test... 16:34:43 INFO - TEST-INFO | started process 29886 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDD5FEi/profile http://localhost:46018/getInfo.html) 16:34:47 INFO - PROCESS | 29886 | __metrics Screen width/height:1600/1200 16:34:47 INFO - PROCESS | 29886 | colorDepth:24 16:34:47 INFO - PROCESS | 29886 | Browser inner width/height: 1024/697 16:34:47 INFO - PROCESS | 29886 | __metrics 16:34:47 INFO - PROCESS | 29886 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:34:47 INFO - PROCESS | 29886 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:34:48 INFO - PROCESS | 29886 | console.error: PushService: 16:34:48 INFO - PROCESS | 29886 | stateChangeProcessEnqueue: Error transitioning state 16:34:48 INFO - PROCESS | 29886 | UnknownError 16:34:48 INFO - TEST-INFO | 29886: exit 0 16:34:48 INFO - Browser initialized. 16:34:48 INFO - Running cycle 1/1 for kraken test... 16:34:48 INFO - TEST-INFO | started process 29968 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDD5FEi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:35:00 INFO - PROCESS | 29968 | RSS: Main: 155852800 16:35:00 INFO - PROCESS | 29968 | 16:35:03 INFO - PROCESS | 29968 | Cycle 1(1): loaded http://localhost:46018/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46018/tests/kraken/driver.html?testName=audio-beat-detection) 16:35:04 INFO - PROCESS | 29968 | RSS: Main: 203771904 16:35:04 INFO - PROCESS | 29968 | 16:35:06 INFO - PROCESS | 29968 | Cycle 1(1): loaded http://localhost:46018/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46018/tests/kraken/driver.html?testName=audio-dft) 16:35:07 INFO - PROCESS | 29968 | RSS: Main: 194297856 16:35:07 INFO - PROCESS | 29968 | 16:35:10 INFO - PROCESS | 29968 | Cycle 1(1): loaded http://localhost:46018/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46018/tests/kraken/driver.html?testName=audio-fft) 16:35:11 INFO - PROCESS | 29968 | RSS: Main: 275451904 16:35:11 INFO - PROCESS | 29968 | 16:35:13 INFO - PROCESS | 29968 | Cycle 1(1): loaded http://localhost:46018/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46018/tests/kraken/driver.html?testName=audio-oscillator) 16:35:13 INFO - PROCESS | 29968 | RSS: Main: 185438208 16:35:13 INFO - PROCESS | 29968 | 16:35:16 INFO - PROCESS | 29968 | Cycle 1(1): loaded http://localhost:46018/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46018/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:35:16 INFO - PROCESS | 29968 | RSS: Main: 190894080 16:35:16 INFO - PROCESS | 29968 | 16:35:19 INFO - PROCESS | 29968 | Cycle 1(1): loaded http://localhost:46018/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46018/tests/kraken/driver.html?testName=imaging-darkroom) 16:35:20 INFO - PROCESS | 29968 | RSS: Main: 227119104 16:35:20 INFO - PROCESS | 29968 | 16:35:23 INFO - PROCESS | 29968 | Cycle 1(1): loaded http://localhost:46018/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46018/tests/kraken/driver.html?testName=imaging-desaturate) 16:35:24 INFO - PROCESS | 29968 | RSS: Main: 226697216 16:35:24 INFO - PROCESS | 29968 | 16:35:27 INFO - PROCESS | 29968 | Cycle 1(1): loaded http://localhost:46018/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46018/tests/kraken/driver.html?testName=json-parse-financial) 16:35:27 INFO - PROCESS | 29968 | RSS: Main: 226099200 16:35:27 INFO - PROCESS | 29968 | 16:35:29 INFO - PROCESS | 29968 | Cycle 1(1): loaded http://localhost:46018/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46018/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:35:29 INFO - PROCESS | 29968 | RSS: Main: 188563456 16:35:29 INFO - PROCESS | 29968 | 16:35:31 INFO - PROCESS | 29968 | Cycle 1(1): loaded http://localhost:46018/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46018/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:35:32 INFO - PROCESS | 29968 | RSS: Main: 196259840 16:35:32 INFO - PROCESS | 29968 | 16:35:34 INFO - PROCESS | 29968 | Cycle 1(1): loaded http://localhost:46018/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46018/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:35:34 INFO - PROCESS | 29968 | RSS: Main: 193576960 16:35:34 INFO - PROCESS | 29968 | 16:35:37 INFO - PROCESS | 29968 | Cycle 1(1): loaded http://localhost:46018/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46018/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:35:38 INFO - PROCESS | 29968 | RSS: Main: 187293696 16:35:38 INFO - PROCESS | 29968 | 16:35:40 INFO - PROCESS | 29968 | Cycle 1(1): loaded http://localhost:46018/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46018/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:35:41 INFO - PROCESS | 29968 | RSS: Main: 191893504 16:35:41 INFO - PROCESS | 29968 | 16:35:43 INFO - PROCESS | 29968 | Cycle 1(1): loaded http://localhost:46018/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46018/tests/kraken/driver.html?testName=ai-astar) 16:35:43 INFO - PROCESS | 29968 | RSS: Main: 242241536 16:35:43 INFO - PROCESS | 29968 | 16:35:43 INFO - PROCESS | 29968 | __start_tp_report 16:35:43 INFO - PROCESS | 29968 | _x_x_mozilla_page_load 16:35:43 INFO - PROCESS | 29968 | _x_x_mozilla_page_load_details 16:35:43 INFO - PROCESS | 29968 | |i|pagename|runs| 16:35:43 INFO - PROCESS | 29968 | |0;ai-astar;105;112;112;113;108;111;112;111;111;111 16:35:43 INFO - PROCESS | 29968 | |1;audio-beat-detection;144;115;119;187;123;122;146;116;160;131 16:35:43 INFO - PROCESS | 29968 | |2;audio-dft;160;160;161;160;161;160;161;161;168;161 16:35:43 INFO - PROCESS | 29968 | |3;audio-fft;75;76;74;117;77;76;75;75;125;75 16:35:43 INFO - PROCESS | 29968 | |4;audio-oscillator;84;86;141;86;86;86;121;84;85;122 16:35:43 INFO - PROCESS | 29968 | |5;imaging-gaussian-blur;116;116;117;116;117;116;117;116;117;117 16:35:43 INFO - PROCESS | 29968 | |6;imaging-darkroom;145;146;146;145;146;146;145;145;145;145 16:35:43 INFO - PROCESS | 29968 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 16:35:43 INFO - PROCESS | 29968 | |8;json-parse-financial;51;50;51;50;51;52;51;50;53;50 16:35:43 INFO - PROCESS | 29968 | |9;json-stringify-tinderbox;61;61;61;61;62;61;61;60;61;61 16:35:43 INFO - PROCESS | 29968 | |10;stanford-crypto-aes;80;79;86;78;78;79;80;79;78;78 16:35:43 INFO - PROCESS | 29968 | |11;stanford-crypto-ccm;128;128;121;123;121;122;126;123;140;136 16:35:43 INFO - PROCESS | 29968 | |12;stanford-crypto-pbkdf2;165;171;168;167;164;165;171;163;167;170 16:35:43 INFO - PROCESS | 29968 | |13;stanford-crypto-sha256-iterative;65;66;64;63;64;63;63;62;62;64 16:35:43 INFO - PROCESS | 29968 | __end_tp_report 16:35:43 INFO - PROCESS | 29968 | __start_cc_report 16:35:43 INFO - PROCESS | 29968 | _x_x_mozilla_cycle_collect,1721 16:35:43 INFO - PROCESS | 29968 | __end_cc_report 16:35:43 INFO - PROCESS | 29968 | __startTimestamp1471563343378__endTimestamp 16:35:43 INFO - PROCESS | 29968 | 16:35:43 INFO - PROCESS | 29968 | ------- Summary: start ------- 16:35:43 INFO - PROCESS | 29968 | Number of tests: 14 16:35:43 INFO - PROCESS | 29968 | 16:35:43 INFO - PROCESS | 29968 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.50 stddev:2.37 (2.1%) stddev-sans-first:1.39 16:35:43 INFO - PROCESS | 29968 | Values: 105.0 112.0 112.0 113.0 108.0 111.0 112.0 111.0 111.0 111.0 16:35:43 INFO - PROCESS | 29968 | 16:35:43 INFO - PROCESS | 29968 | [#1] audio-beat-detection Cycles:10 Average:136.30 Median:137.50 stddev:23.24 (16.9%) stddev-sans-first:24.48 16:35:43 INFO - PROCESS | 29968 | Values: 144.0 115.0 119.0 187.0 123.0 122.0 146.0 116.0 160.0 131.0 16:35:43 INFO - PROCESS | 29968 | 16:35:43 INFO - PROCESS | 29968 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:2.41 (1.5%) stddev-sans-first:2.51 16:35:43 INFO - PROCESS | 29968 | Values: 160.0 160.0 161.0 160.0 161.0 160.0 161.0 161.0 168.0 161.0 16:35:43 INFO - PROCESS | 29968 | 16:35:43 INFO - PROCESS | 29968 | [#3] audio-fft Cycles:10 Average:84.50 Median:75.00 stddev:19.35 (25.8%) stddev-sans-first:20.21 16:35:43 INFO - PROCESS | 29968 | Values: 75.0 76.0 74.0 117.0 77.0 76.0 75.0 75.0 125.0 75.0 16:35:43 INFO - PROCESS | 29968 | 16:35:43 INFO - PROCESS | 29968 | [#4] audio-oscillator Cycles:10 Average:98.10 Median:85.50 stddev:21.32 (24.9%) stddev-sans-first:21.99 16:35:43 INFO - PROCESS | 29968 | Values: 84.0 86.0 141.0 86.0 86.0 86.0 121.0 84.0 85.0 122.0 16:35:43 INFO - PROCESS | 29968 | 16:35:43 INFO - PROCESS | 29968 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 16:35:43 INFO - PROCESS | 29968 | Values: 116.0 116.0 117.0 116.0 117.0 116.0 117.0 116.0 117.0 117.0 16:35:43 INFO - PROCESS | 29968 | 16:35:43 INFO - PROCESS | 29968 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 16:35:43 INFO - PROCESS | 29968 | Values: 145.0 146.0 146.0 145.0 146.0 146.0 145.0 145.0 145.0 145.0 16:35:43 INFO - PROCESS | 29968 | 16:35:43 INFO - PROCESS | 29968 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 16:35:43 INFO - PROCESS | 29968 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 16:35:43 INFO - PROCESS | 29968 | 16:35:43 INFO - PROCESS | 29968 | [#8] json-parse-financial Cycles:10 Average:50.90 Median:51.00 stddev:0.99 (1.9%) stddev-sans-first:1.05 16:35:43 INFO - PROCESS | 29968 | Values: 51.0 50.0 51.0 50.0 51.0 52.0 51.0 50.0 53.0 50.0 16:35:43 INFO - PROCESS | 29968 | 16:35:43 INFO - PROCESS | 29968 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 16:35:43 INFO - PROCESS | 29968 | Values: 61.0 61.0 61.0 61.0 62.0 61.0 61.0 60.0 61.0 61.0 16:35:43 INFO - PROCESS | 29968 | 16:35:43 INFO - PROCESS | 29968 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:79.00 stddev:2.42 (3.1%) stddev-sans-first:2.55 16:35:43 INFO - PROCESS | 29968 | Values: 80.0 79.0 86.0 78.0 78.0 79.0 80.0 79.0 78.0 78.0 16:35:43 INFO - PROCESS | 29968 | 16:35:43 INFO - PROCESS | 29968 | [#11] stanford-crypto-ccm Cycles:10 Average:126.80 Median:127.00 stddev:6.51 (5.1%) stddev-sans-first:6.89 16:35:43 INFO - PROCESS | 29968 | Values: 128.0 128.0 121.0 123.0 121.0 122.0 126.0 123.0 140.0 136.0 16:35:43 INFO - PROCESS | 29968 | 16:35:43 INFO - PROCESS | 29968 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.10 Median:167.50 stddev:2.88 (1.7%) stddev-sans-first:2.96 16:35:43 INFO - PROCESS | 29968 | Values: 165.0 171.0 168.0 167.0 164.0 165.0 171.0 163.0 167.0 170.0 16:35:43 INFO - PROCESS | 29968 | 16:35:43 INFO - PROCESS | 29968 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:64.00 stddev:1.26 (2.0%) stddev-sans-first:1.24 16:35:43 INFO - PROCESS | 29968 | Values: 65.0 66.0 64.0 63.0 64.0 63.0 63.0 62.0 62.0 64.0 16:35:43 INFO - PROCESS | 29968 | -------- Summary: end -------- 16:35:43 INFO - PROCESS | 29968 | 16:35:44 INFO - TEST-INFO | 29968: exit 0 16:35:44 INFO - TEST-OK | kraken | took 61025ms 16:35:44 INFO - SUITE-END | took 1176s 16:35:44 INFO - Completed test suite (00:19:36) 16:35:44 INFO - javascript benchmark 16:35:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2980.582718419421, 3022.1235841605935, 3028.424599326128, 3036.3320069584684, 3057.5413687946807, 5186.611004174692, 5291.814786482474, 5333.839984800453, 5425.562593848512, 5515.47602977717, 5335.653182543132, 5343.438938911417, 5353.384360798509, 5390.460953904608, 5394.460553944604, 4832.130216561018, 4899.583535399477, 4916.901661966758, 4925.26121081837, 5083.983203359325, 4976.502349765013, 5003.849884503471, 5027.29617853499, 5043.899122017558, 5044.0, 4794.496577859327, 4912.533309335608, 4946.851594452172, 4998.475160108209, 5022.799088036474, 4827.179379505493, 4851.029794041206, 4853.174960256765, 4951.851444456636, 5003.974980125076, 4870.099031679115, 4907.901841963177, 4910.7299098549565, 4941.283513890502, 4976.900461990776, 5120.436751957282, 5252.343457067866, 5355.303810504648, 5398.433164517708, 5416.0, 5756.913646295309, 5801.24583804107, 5809.302883653946, 5809.738561764731, 5812.651240925516, 5810.041343178371, 5838.591298609099, 5839.591228613998, 5853.64878107315, 5857.062869940832, 5147.176451767699, 5262.894742105136, 5314.096603577401, 5331.920021199685, 5426.62013659044, 5942.465178133903, 5952.375000624958, 5952.494038006731, 5953.910691339634, 5958.910616340759, 5662.801801936913, 5698.116791897262, 5703.62926409782, 5706.144078388192, 5708.914366284509, 5551.805686800943, 5669.801556945487, 5709.172170035322, 5716.57125715573, 5788.710564471759, 5721.799737009268, 5732.369439361667, 5736.627119237236, 5742.569307301969, 5774.585226619505, 5676.318841739017, 5720.8283751487525, 5729.169270455761, 5737.741801618854, 5747.39652336507, 4285.871423857289, 4337.783110844445, 4340.739555626673, 4387.96882732564, 4389.473263208435, 3921.4117882317883, 3951.644352008333, 3956.090099277182, 3962.128331767007, 3964.0288129408477, 5363.946360536423, 5374.8656283592445, 5400.729963501888, 5490.862728431821, 5493.7802487900835, 5775.335836378787, 5775.5668324875805, 5775.595708300462, 5780.450857168562, 5783.045797443375, 5223.973880130575, 5391.514763671288, 5436.483534064258, 5445.972770136124, 5447.673139611636, 4883.34074899891, 4917.0, 4944.406671199479, 4984.102861484967, 5021.096202683552, 6004.309504406961, 6013.879722405527, 6016.0, 6018.789342372996, 6021.126936594169, 5552.305961754781, 5725.7137143141845, 5783.334916484489, 5794.594378393472, 5795.188673585617, 5924.289085309618, 5986.461218490357, 6006.819795406145, 6077.4226448487325, 6086.056661217518, 5663.0, 5707.6575405475805, 5710.486056254957, 5715.942840571541, 5718.313802343745, 5800.303963524404, 5807.738651760766, 5810.448007439287, 5811.56413269015, 5813.534917206698, 5423.918641220306, 5503.504684578407, 5527.198556209247, 5566.276384070045, 5688.232088667977, 5633.295838020247, 5640.858978525405, 5642.633228840113, 5647.181158731879, 5647.915281270866, 5590.329160500766, 5634.605577609528, 5647.378788333198, 5650.971745141248, 5658.971705141448, 5510.311211098613, 5587.636803607753, 5618.494335509824, 5630.239917611234, 5729.570282228933, 5520.751566179451, 5548.4174161712435, 5557.499825015606, 5575.219469274224, 5576.358718747396], "value": 5307.878597814908, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.2964868036655, 586.1764221269117, 613.6164896939413, 617.3702823120417, 636.5162476517845, 33561.66438335619, 34105.829470852645, 36359.63640363592, 36536.634633653724, 36631.08422289444, 45334.55985281763, 46420.767896160556, 46473.53526464734, 50308.0, 50353.49646503543, 8994.955025224881, 9139.99460059393, 9140.588673509708, 9144.725658230263, 9149.039350868163, 9068.637254509844, 9152.0, 9171.082891710808, 9180.0, 9182.219511341544, 9177.311701622371, 9209.171174594285, 9216.907830921706, 9221.585028673691, 9243.49160796156, 9185.724428267162, 9207.861882071775, 9213.907860921372, 9226.077392260788, 9226.800515932953, 9034.0, 9117.908820911773, 9118.088191180896, 9121.863172052424, 9130.817383652357, 45022.774886125684, 45227.773861130816, 45524.544754552364, 45534.77232613849, 45661.54338456606, 3353.5975682918206, 3412.436947903593, 3471.7396195285455, 3818.0, 4201.243776120297, 33414.33171336584, 33684.15789605255, 33790.1552461188, 34260.31479370398, 35540.0, 4243.80902859369, 4353.25994580922, 4397.340398940152, 4515.096980603892, 4526.502084770673, 346054.0, 347815.08739650383, 353739.0, 355288.0, 357923.0, 59842.00789960485, 60234.698826505584, 60830.3501789894, 60860.0, 60895.695521523, 54839.177412338846, 62890.37109628845, 66443.66778166174, 68273.0, 68753.0, 16605.0867202305, 16921.407750728664, 16996.57508562271, 16996.575085622957, 16996.915015424845, 12962.351882405843, 13053.086283960221, 13062.54281100176, 13063.150895191782, 13073.084884058215, 15478.845211547741, 17747.0, 17758.20088096013, 18267.255212681368, 18287.45137645873, 6125.601835880653, 6134.846628834225, 6213.596116252429, 6400.359964003563, 6414.422701956753, 951.5765484359532, 1030.2788048366024, 1087.1194332590626, 1090.3948308688596, 1128.4357821089454, 33287.66712332894, 33622.49566256508, 33829.83085084608, 34062.318753624786, 34191.31617367639, 1067.1036329483272, 1142.1319796954374, 1142.657202839145, 1156.6819124740596, 1190.5535424215918, 16558.0, 17550.473485795446, 17743.73384399235, 17781.0, 17809.376671816422, 522177.0, 537526.0, 543819.0, 549535.0, 757361.0, 61528.38471615316, 61801.381986179564, 61871.690641546506, 62004.37995620076, 62064.0, 1388.6597783543098, 1391.9443222270995, 1395.4418232706998, 1408.0777091005407, 1430.7353139669194, 31462.0, 34289.0, 34362.31275374528, 34548.604197363624, 34559.65440345665, 52961.20558191553, 53176.73411632917, 53215.4678453226, 53291.46708532865, 53317.0, 440489.0, 441060.0, 442250.4511800676, 443202.0, 443368.0, 25670.22989310324, 28129.296767580974, 29218.41563168682, 29456.263593410335, 29818.70181298159, 39097.6090239094, 41548.0, 41560.16879662329, 50606.2409063857, 50894.236586451974, 40623.0, 42896.35655465233, 43366.56633433751, 44746.55253447424, 45167.548324516334, 41589.81971580412, 42128.15743685048, 43037.78481107575, 43126.0, 44256.0, 42122.57877421186, 43147.84260787011, 43203.78398107989, 43260.35109473424, 43364.78317608392, 34225.82887085548, 37495.25009499849, 37536.62463375441, 37602.0, 38515.0, 28564.285892852844, 29236.561451577818, 29418.70581294245, 29576.852115739282, 29667.258318542208], "value": 20520.33062858769, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.8040857936713, 380.24711072077287, 390.732348341386, 396.1739772574183, 412.96902732295086, 18030.549236269082, 19651.115699793507, 19762.505937351572, 20024.4993875153, 20190.29333973311, 19113.808861911377, 19324.903375483103, 19714.50713732154, 19805.108770105344, 19933.800661993377, 5664.0, 5739.913901291484, 5752.539796816265, 5763.711814409284, 5879.647221166722, 4151.667866570667, 6267.592606480587, 6588.945768677013, 6596.60420374779, 6606.603603783764, 6318.652474113922, 6371.776987805428, 6519.543631945766, 6532.216134063919, 6533.15069041024, 6360.650164240965, 6367.7771278005275, 6454.644994525299, 6462.838429039265, 6470.417662410358, 5614.943850561483, 5637.408072152447, 5643.040683083886, 5667.801626943078, 5673.8297851064535, 24112.276631701076, 24196.758032419802, 24280.271591852274, 24290.0, 24524.0, 2320.3734991552355, 2346.4016675747744, 2420.3344080378038, 2427.1626288930293, 2470.542949554338, 14102.153870767685, 14670.853291467056, 14948.775768363483, 15025.173615451145, 15843.445479408281, 1918.2039453626728, 1961.4507937777446, 1972.7422702884853, 1975.9308424205228, 2010.6280338137344, 85575.0, 85651.0, 85750.57124714399, 86110.56944715299, 87352.56323718405, 10762.56949722018, 10808.243422960317, 11012.614558490415, 11075.280106793032, 11161.43739876418, 15284.082955022734, 15287.770683439758, 15291.158986255641, 15320.923395383175, 15328.310226039855, 8388.454750441202, 8465.83068338642, 8578.360980440702, 8619.870701939475, 8673.609687564074, 8197.34421246299, 8321.209485098905, 8334.083250842403, 8549.273311768446, 8592.48445093284, 4540.750258735801, 4588.632909367309, 4717.339572459859, 4732.38478997735, 4841.3222148899185, 1758.9007347850622, 1851.0559614596384, 1982.4845540159374, 1993.9302124425576, 2003.1586733571935, 883.7348795361365, 1018.2007124407453, 1050.8633877595864, 1062.644014255233, 1095.9397233152254, 17998.91000544989, 18751.90624046871, 19092.90453547751, 19299.035048247533, 21251.46871328229, 956.4357029352715, 972.1153750087528, 978.2663002747939, 1002.1181360402799, 1033.5865653738565, 10588.258821882548, 11228.992489018336, 11388.487518061707, 11395.202335836411, 11419.942900285612, 470626.0, 470847.0, 471453.0, 476890.0, 481596.0, 99147.50426247966, 101488.49255753674, 103204.19560141774, 105118.0, 106139.0, 982.8623992641036, 1016.8830584482731, 1052.9157667386437, 1059.4861492176287, 1062.3201151263197, 17519.21163547618, 17821.643567128845, 18427.355042573447, 18438.35465758692, 18523.814761852747, 42113.0, 42197.578024219365, 42828.28888822165, 43079.35380969225, 43107.0, 54716.72641636767, 59959.40040599538, 60561.394386057334, 60882.69558652178, 61339.38660613515, 8388.328933685412, 8562.315014798676, 8574.401250516654, 8874.245689116497, 8900.77748056278, 9796.216302695624, 12362.134650574373, 12803.487860485477, 13016.934915325362, 13448.93275533616, 11405.543778248777, 11562.653120406401, 11678.532858685558, 11826.82259766087, 12218.20581662189, 10984.06635435997, 11536.0, 11671.941640291745, 11743.530258789553, 12265.0, 11387.145964052896, 11688.415579221175, 11841.23032002917, 11861.347625880315, 12091.637250882488, 8497.2777313929, 8823.382363234512, 9013.233875120426, 9049.095090490899, 9111.681091161778, 10628.41543715103, 11319.773604528027, 11523.366214858263, 11803.468843902217, 12105.455254513392], "value": 9523.097846495788, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1355.5933220033987, 1489.5605796290092, 1495.4765831958816, 1636.4108920788515, 1815.5461134716313, 8592.398532102756, 8956.462612243253, 9039.90960090399, 9046.140616641425, 9053.185213330798, 8856.291496680265, 8978.86531702025, 8984.326175536844, 8994.505302208376, 8999.280057595393, 2137.9144834206613, 2397.0771253067605, 2473.6042233242683, 2501.062101711858, 2502.5370306493264, 2421.503591763693, 2440.5973014452684, 2461.59383701689, 2461.8645974471397, 2464.4331803685163, 2364.243442098529, 2379.0, 2379.1078345620394, 2393.868337241451, 2454.460018795862, 2300.861948283108, 2304.896279667419, 2305.158617104753, 2321.616933206019, 2403.9399015024587, 2360.834741568091, 2366.491204391047, 2375.6317770745563, 2379.0364902214455, 2383.1778036577525, 9260.120288572642, 9317.487538185396, 9320.067993200693, 9321.207697345733, 9336.813263734755, 5201.271821944931, 5344.118220493614, 5464.672119672832, 5484.91772623411, 5493.313335833021, 3535.9646403535894, 3612.277544491086, 3668.321360548307, 3687.7418580699364, 3699.038250054978, 1135.1259530161728, 1178.263585259213, 1190.65471013406, 1210.7760064388117, 1224.3755684600828, 12464.626061218178, 12521.060920431004, 12600.68498287541, 12611.684707882285, 12624.431900564497, 4296.462942132233, 4613.40025796651, 4627.907441851212, 4733.83431579893, 4762.52374762521, 9744.853827192597, 9750.122488976027, 9751.31740778153, 9751.414915105117, 9759.219262458986, 5297.841064768063, 5307.601929855199, 5315.920261196085, 5317.175837745156, 5318.335208098988, 4403.603675669206, 4900.632452566072, 4982.9252561211615, 4985.351904252424, 4988.201887698024, 3791.2227993261317, 3856.6721828644318, 3900.434437006675, 3916.882493525142, 3935.779908228458, 1169.187414746743, 1192.8389767117035, 1202.4228370382266, 1203.9759204815855, 1214.763121191377, 983.5279066048193, 996.8853581838036, 999.1008092716468, 1004.8542961270575, 1006.0894890124449, 5988.0, 6053.51571874249, 6088.238970128734, 6110.877782444415, 6153.507719382439, 959.8320293948531, 997.2271489595621, 1006.6879267426974, 1026.9383836969657, 1065.1159537583942, 3952.209558088394, 4260.510041345285, 4326.113146804897, 4385.978070109629, 4517.593416592523, 11024.393658348868, 11332.773344533229, 11360.318380897008, 11367.715807104723, 11407.885921140849, 11315.660530183943, 11333.773324533464, 11357.886421135849, 11398.886011139783, 11433.714157146138, 8030.237127472998, 8250.339972802161, 8387.119352468026, 8391.832163356821, 8572.142785721378, 6186.721597528032, 6312.3687631238345, 6351.841203969938, 6413.8717225656155, 6451.7096430766405, 10194.898051019394, 10241.07830295277, 10439.425831579336, 10483.842742358718, 10556.577736890438, 10494.895051049698, 10521.368717876952, 10526.684199474028, 10714.73213169677, 10771.946140269562, 7924.48490848093, 7998.120206777367, 8019.318357939641, 8134.6171150905675, 8153.55155466455, 8596.91403085961, 8634.697785577475, 8652.610632521677, 8663.95668021656, 8665.82668346617, 7695.807604809925, 7950.16523265072, 7983.92016079855, 8039.276465118168, 8178.713745018896, 7857.960710196412, 7863.52818830872, 7928.127905930228, 7944.682212711658, 7950.840983180188, 7149.7140114396925, 7166.068411106523, 7246.746363877239, 7255.56466612005, 7256.854862902818, 5166.3800343958965, 5183.663061900965, 5250.65870718402, 5290.312259406252, 5399.335190009839, 5287.233351163983, 5293.947060529345, 5339.626226164131, 5384.542313903362, 5521.089020311603], "value": 4761.664280251295, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.7264511487792, 332.869906666866, 335.96808303211185, 339.3890996206827, 340.8125530957972, 5215.305025866594, 5263.34208223972, 5292.311999440072, 5295.126304159814, 5313.442088580701, 4925.285833554132, 4996.800127994885, 5121.257417674435, 5162.767675454605, 5211.5309622134, 4088.9182216355657, 4089.161721847029, 4092.6725861931122, 4097.873084901661, 4104.8563300284495, 4099.405586190001, 4124.886280704208, 4125.855595054174, 4145.7719825409595, 4156.044109854735, 3898.2203559288114, 3911.3741801311794, 4053.918921621566, 4103.138340948404, 4126.46355973723, 4066.146109317047, 4075.4701888754566, 4078.6737061035046, 4096.91806163878, 4100.938485922714, 3662.3336381946415, 3662.7252956028137, 3663.9633603664156, 3668.926621467556, 3672.8530858765616, 4975.0, 5059.6458247922665, 5077.974610126926, 5105.132127538327, 5105.642605017651, 4651.674382793206, 4660.930086048712, 4698.060387922429, 4706.388169537938, 4709.952900470986, 5399.136138217867, 5407.161889907071, 5412.485813847678, 5462.235287059815, 5464.043792336325, 3745.1760612665444, 3928.8821335359985, 4045.939310910339, 4055.5336136344404, 4059.4925634295714, 5599.4120617335, 5648.717564121818, 5648.802291919763, 5651.463111004448, 5655.943440565583, 4029.435878976946, 4052.675785937118, 4052.878413647595, 4053.412255223035, 4068.779366190131, 3889.3193691103943, 4100.831263090005, 4104.363823607346, 4104.56902025289, 4122.711410201257, 4600.2978897808025, 4617.930731039037, 4621.976890115595, 4652.651051171176, 4660.86017419478, 5450.04624190765, 5453.127499600124, 5472.781088756485, 5478.808476609388, 5509.586780991442, 1358.4769863602387, 1405.220102842932, 1415.9646008849654, 1417.9078359906573, 1421.580633713057, 893.097971049245, 901.2114399900088, 903.6972614174325, 916.5005072235648, 918.6141820435433, 4692.601128904082, 4719.740414277179, 4720.0, 4745.335653008581, 4762.880927976828, 4542.772861356985, 4948.752562371867, 4966.850994470172, 4968.627352948543, 4972.676776009548, 4634.629229661619, 4647.55848194421, 4653.743489257881, 4660.836870709509, 4684.906301874012, 2603.6745406824148, 2617.952818872466, 2619.305883940757, 2620.371110933362, 2636.248669129289, 4759.619230461555, 5054.620903432184, 5071.797128114834, 5088.821891233863, 5113.948860511422, 4971.975140124348, 4989.176785830297, 4994.3507344045765, 5001.32402684027, 5026.271190677331, 5043.84868453947, 5047.646664733434, 5068.391792984866, 5104.897902042013, 5115.7442127893455, 4940.258961155855, 4941.728204948762, 4950.554450099508, 4960.677555958851, 5204.386640141568, 5550.167474878801, 5559.583031272751, 5577.693226872561, 5582.3859375467855, 5605.32736071674, 5828.59199856006, 5842.883142337045, 5852.882942341044, 5863.237779088691, 5875.883582119554, 3905.5899130592015, 4004.4771793769737, 4021.155557332993, 4045.130296986162, 4073.7759423232005, 5290.788368465218, 5398.757055932414, 5571.247881536103, 5602.85992850182, 5628.099504079328, 5474.698891561003, 5504.440435197653, 5517.558595312285, 5524.364698059614, 5530.336359636869, 5264.131418315935, 5435.918461223164, 5477.849651573214, 5507.311586051744, 5511.696856672921, 5431.782728690966, 5433.375161856437, 5445.128779395278, 5446.754896029767, 5447.264619276505, 5441.29263195782, 5457.399686034612, 5511.559075273888, 5512.586556008396, 5519.862003449946, 5286.867828304323, 5349.144136938071, 5380.623356365017, 5400.621956463167, 5410.161424979135], "value": 4068.1453024864286, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [638.3807706524669, 676.2763842688322, 685.9314068593139, 736.0394684936159, 811.5739236900627, 15330.770038449418, 16437.753433698505, 16580.419685311015, 16594.08732519711, 16652.16739163043, 14678.853211467882, 14945.551633450987, 15644.452444164457, 15681.372745090212, 16343.610793082602, 796.6733639207926, 819.1890028871434, 823.086374124721, 829.0548774397192, 831.7213733399318, 656.7537173559915, 785.3285440947993, 811.4968719393984, 812.2283830361151, 815.4291995603072, 858.0218550852034, 858.8024754306513, 859.282499113238, 859.3683642522741, 859.8151397449548, 851.9446235994641, 853.5220276645099, 853.799357151069, 854.5214679779313, 854.8290341931638, 507.11508417810785, 602.28027507129, 622.3838399983983, 623.0218556865723, 626.6616027345228, 14565.70868582633, 14578.12531248118, 14586.416543338253, 14599.197044162673, 14613.342399592044, 13908.374123164482, 14284.0, 14702.705945881129, 14801.925990370088, 14927.328270227867, 13145.145565538305, 13253.602391928258, 13440.932795336059, 13550.254735989516, 13993.0, 4371.14762621289, 4404.559544045602, 4457.0, 4459.904651000752, 4463.352813842007, 83364.0, 84005.0, 84486.57756711177, 89287.55356223242, 89576.552117239, 10906.5092070857, 11065.778684426266, 11131.0, 11418.257813242113, 11496.195266331277, 22076.55846883053, 22146.22488212937, 22170.113195472324, 22181.44546386321, 22218.66671999921, 8358.45670031446, 8429.114942931026, 8481.194286542892, 8549.444286121383, 8950.776230594287, 4773.331733557305, 4794.9280760788615, 4795.472498025214, 4846.588040016568, 4914.066327397854, 3475.3396854597545, 3589.2462582857893, 3592.9281414371567, 3597.6042635310096, 3599.856005759793, 553.8753780399378, 559.9888002239933, 561.53673219594, 568.5934556791914, 572.8882867840814, 497.1895809829954, 592.8646641681132, 635.6472157952381, 651.8012006338113, 656.6388486332498, 9011.774705632411, 9495.477748723748, 9561.61753529851, 9765.218782497383, 9767.462789546644, 630.678354039434, 635.920509936258, 662.2251965200727, 664.6078813500059, 688.3495097133261, 4322.762248076386, 4623.190941585209, 4635.513271106485, 4653.627709783209, 4722.716637001791, 128252.0, 129310.0, 130886.34556827345, 131759.0, 134883.32558337343, 68449.0, 68706.0, 94310.58534121994, 114414.0, 116602.41698791621, 75965.6201718999, 76107.61946190233, 98016.50991744996, 99149.0, 100492.49753751184, 8764.517951512727, 8786.25316848075, 8836.337274704294, 8891.688790892287, 8962.462252264884, 55093.72453137708, 57454.0, 58873.70563147157, 59710.0, 59882.0, 48893.755531222116, 53944.290027795374, 86124.13875861162, 86920.56539717515, 88471.0, 10900.890991090304, 10906.890931090906, 11016.614418495314, 11052.944735276273, 11100.61147859821, 12815.935920320338, 13816.792748108988, 14025.719485610434, 14087.577372678836, 14818.777718334019, 13839.861601383856, 13897.16617002983, 14060.437582496994, 14131.717365652425, 14219.431222751387, 12944.352782360656, 12974.351282435651, 13311.46754129824, 13637.590872273848, 13933.721325573635, 13050.804237936249, 13465.326733663474, 13543.119697220043, 13785.379657915217, 14003.159810411407, 10544.89455105439, 10640.680779576625, 10677.57289708403, 10942.17967980408, 10985.450727463434, 10197.643082492077, 10865.239433239598, 11054.170937179582, 11114.666560003212, 11361.715957101138], "value": 7530.7633990899, "unit": "score"}], "name": "dromaeo_css", "value": 7299.966113100228, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 112.0, 113.0, 108.0, 111.0, 112.0, 111.0, 111.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 115.0, 119.0, 187.0, 123.0, 122.0, 146.0, 116.0, 160.0, 131.0], "value": 136.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 160.0, 161.0, 160.0, 161.0, 161.0, 168.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 117.0, 77.0, 76.0, 75.0, 75.0, 125.0, 75.0], "value": 84.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 141.0, 86.0, 86.0, 86.0, 121.0, 84.0, 85.0, 122.0], "value": 98.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 51.0, 50.0, 51.0, 52.0, 51.0, 50.0, 53.0, 50.0], "value": 50.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 62.0, 61.0, 61.0, 60.0, 61.0, 61.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 86.0, 78.0, 78.0, 79.0, 80.0, 79.0, 78.0, 78.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 128.0, 121.0, 123.0, 121.0, 122.0, 126.0, 123.0, 140.0, 136.0], "value": 126.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 171.0, 168.0, 167.0, 164.0, 165.0, 171.0, 163.0, 167.0, 170.0], "value": 167.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 64.0, 63.0, 64.0, 63.0, 63.0, 62.0, 62.0, 64.0], "value": 63.6, "unit": "score"}], "name": "kraken", "value": 1496.5999999999997, "alertThreshold": 2.0}]} 16:35:44 INFO - Return code: 0 16:35:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:35:44 INFO - # TBPL SUCCESS # 16:35:44 INFO - Running post-action listener: _resource_record_post_action 16:35:44 INFO - [mozharness: 2016-08-18 23:35:44.674281Z] Finished run-tests step (success) 16:35:44 INFO - Running post-run listener: _resource_record_post_run 16:35:44 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 416878592; Read time: 16; Write time: 559124 16:35:44 INFO - TinderboxPrint: CPU usage
13.1% 16:35:44 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 16:35:44 INFO - TinderboxPrint: I/O write bytes / time
416,878,592 / 559,124 16:35:44 INFO - TinderboxPrint: CPU idle
8,284.4 (86.9%) 16:35:44 INFO - TinderboxPrint: CPU user
1,199.0 (12.6%) 16:35:44 INFO - TinderboxPrint: Swap in / out
0 / 0 16:35:44 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 127021056; Read time: 0; Write time: 211492 16:35:44 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 289513472; Read time: 0; Write time: 347632 16:35:45 INFO - Running post-run listener: _upload_blobber_files 16:35:45 INFO - Blob upload gear active. 16:35:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:35:45 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:35:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:35:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:35:45 INFO - (blobuploader) - INFO - Open directory for files ... 16:35:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:35:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:35:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:35:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:35:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:35:49 INFO - (blobuploader) - INFO - Done attempting. 16:35:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:35:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:35:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:35:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:35:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:35:50 INFO - (blobuploader) - INFO - Done attempting. 16:35:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:35:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:35:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:35:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:35:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:35:51 INFO - (blobuploader) - INFO - Done attempting. 16:35:51 INFO - (blobuploader) - INFO - Iteration through files over. 16:35:51 INFO - Return code: 0 16:35:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:35:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:35:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/be5095ac4965a2ed510d83e6a1a5ab05fdc7f4f42ad96bb380a28d22460e99fa498e3480f54569bbe6e8c790f8e55ca8bf316f20cca8c75dccb479cdc69714bd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a69eb85e0f1a74ac841601323015e0c5d1a131b5b2d625fc59ae69ab4d8100a1bef43b2e96819568ec91f9017b3ba2ed6f855809b8dda6f46b2f7c35a9a6f299", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ea41e858952f4b98225e96a1a25140019cf234ce58c01e21ff6ceaf12742b4b255b1bb11c068cd85d01f4e7a14ee23aaa0f3bec0f7dbf55339dac582e98f5604"} 16:35:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:35:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:35:51 INFO - Contents: 16:35:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/be5095ac4965a2ed510d83e6a1a5ab05fdc7f4f42ad96bb380a28d22460e99fa498e3480f54569bbe6e8c790f8e55ca8bf316f20cca8c75dccb479cdc69714bd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a69eb85e0f1a74ac841601323015e0c5d1a131b5b2d625fc59ae69ab4d8100a1bef43b2e96819568ec91f9017b3ba2ed6f855809b8dda6f46b2f7c35a9a6f299", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ea41e858952f4b98225e96a1a25140019cf234ce58c01e21ff6ceaf12742b4b255b1bb11c068cd85d01f4e7a14ee23aaa0f3bec0f7dbf55339dac582e98f5604"} 16:35:51 INFO - Running post-run listener: copy_logs_to_upload_dir 16:35:51 INFO - Copying logs to upload dir... 16:35:51 INFO - mkdir: /builds/slave/test/build/upload/logs 16:35:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.013807 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-18 16:35:51.068296) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-18 16:35:51.071445) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5bd038846534b2fdfa68eeae000001e2-1471562111.946310-1123868270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/be5095ac4965a2ed510d83e6a1a5ab05fdc7f4f42ad96bb380a28d22460e99fa498e3480f54569bbe6e8c790f8e55ca8bf316f20cca8c75dccb479cdc69714bd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a69eb85e0f1a74ac841601323015e0c5d1a131b5b2d625fc59ae69ab4d8100a1bef43b2e96819568ec91f9017b3ba2ed6f855809b8dda6f46b2f7c35a9a6f299", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ea41e858952f4b98225e96a1a25140019cf234ce58c01e21ff6ceaf12742b4b255b1bb11c068cd85d01f4e7a14ee23aaa0f3bec0f7dbf55339dac582e98f5604"} build_url:https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011394 build_url: 'https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/be5095ac4965a2ed510d83e6a1a5ab05fdc7f4f42ad96bb380a28d22460e99fa498e3480f54569bbe6e8c790f8e55ca8bf316f20cca8c75dccb479cdc69714bd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a69eb85e0f1a74ac841601323015e0c5d1a131b5b2d625fc59ae69ab4d8100a1bef43b2e96819568ec91f9017b3ba2ed6f855809b8dda6f46b2f7c35a9a6f299", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ea41e858952f4b98225e96a1a25140019cf234ce58c01e21ff6ceaf12742b4b255b1bb11c068cd85d01f4e7a14ee23aaa0f3bec0f7dbf55339dac582e98f5604"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-18 16:35:51.096161) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 16:35:51.096457) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5bd038846534b2fdfa68eeae000001e2-1471562111.946310-1123868270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004447 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 16:35:51.179034) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 16:35:51.179353) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 16:35:51.179639) ========= ========= Total master_lag: 0.17 =========