builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-012 starttime: 1477464238.53 results: success (0) buildid: 20161025221325 builduid: 09ad6336a6c94ab980a15525118f2c43 revision: f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-25 23:43:58.529975) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-25 23:43:58.530435) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-25 23:43:58.530723) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-25 23:43:58.545322) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 23:43:58.545633) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1477463450.445442-788762110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-25 23:43:58-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 208M=0s 2016-10-25 23:43:58 (208 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.139127 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 23:43:58.698202) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 23:43:58.698544) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1477463450.445442-788762110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014196 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 23:43:58.747971) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-25 23:43:58.748303) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 --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 f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 --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=2c5dd2b0a310ecf02fd87158000001b4-1477463450.445442-788762110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-25 23:43:58,915 truncating revision to first 12 chars 2016-10-25 23:43:58,915 Setting DEBUG logging. 2016-10-25 23:43:58,915 attempt 1/10 2016-10-25 23:43:58,915 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f9f3cc95d728?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-25 23:44:00,485 unpacking tar archive at: fx-team-f9f3cc95d728/testing/mozharness/ program finished with exit code 0 elapsedTime=1.936177 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-25 23:44:00.698238) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-25 23:44:00.698576) ========= script_repo_revision: f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-25 23:44:00.698978) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-25 23:44:00.699250) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-25 23:44:00.709686) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-10-25 23:44:00.710010) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=2c5dd2b0a310ecf02fd87158000001b4-1477463450.445442-788762110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:44:00 INFO - MultiFileLogger online at 20161025 23:44:00 in /builds/slave/test 23:44:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 23:44:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:44:00 INFO - {'append_to_log': False, 23:44:00 INFO - 'base_work_dir': '/builds/slave/test', 23:44:00 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 23:44:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:44:00 INFO - 'branch': 'Fx-Team-Non-PGO', 23:44:00 INFO - 'buildbot_json_path': 'buildprops.json', 23:44:00 INFO - 'config_files': ('talos/linux_config.py',), 23:44:00 INFO - 'default_actions': ('clobber', 23:44:00 INFO - 'read-buildbot-config', 23:44:00 INFO - 'download-and-extract', 23:44:00 INFO - 'populate-webroot', 23:44:00 INFO - 'create-virtualenv', 23:44:00 INFO - 'install', 23:44:00 INFO - 'run-tests'), 23:44:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:44:00 INFO - 'download_minidump_stackwalk': True, 23:44:00 INFO - 'download_symbols': 'ondemand', 23:44:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:44:00 INFO - 'tooltool.py': '/tools/tooltool.py', 23:44:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:44:00 INFO - '/tools/misc-python/virtualenv.py')}, 23:44:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:44:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:44:00 INFO - 'installer_path': 'installer.exe', 23:44:00 INFO - 'log_level': 'info', 23:44:00 INFO - 'log_name': 'talos', 23:44:00 INFO - 'log_to_console': True, 23:44:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:44:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:44:00 INFO - 'opt_config_files': (), 23:44:00 INFO - 'pip_index': False, 23:44:00 INFO - 'sps_profile': False, 23:44:00 INFO - 'sps_profile_interval': 0, 23:44:00 INFO - 'suite': 'dromaeojs', 23:44:00 INFO - 'system_bits': '32', 23:44:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:44:00 INFO - 'title': 'talos-linux64-ix-012', 23:44:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:44:00 INFO - 'use_talos_json': True, 23:44:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:44:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:44:00 INFO - 'work_dir': 'build'} 23:44:00 INFO - [mozharness: 2016-10-26 06:44:00.973058Z] Running clobber step. 23:44:00 INFO - Running pre-action listener: _resource_record_pre_action 23:44:00 INFO - Running main action method: clobber 23:44:00 INFO - rmtree: /builds/slave/test/build 23:44:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:44:01 INFO - Running post-action listener: _resource_record_post_action 23:44:01 INFO - [mozharness: 2016-10-26 06:44:01.423425Z] Finished clobber step (success) 23:44:01 INFO - [mozharness: 2016-10-26 06:44:01.423526Z] Running read-buildbot-config step. 23:44:01 INFO - Running pre-action listener: _resource_record_pre_action 23:44:01 INFO - Running main action method: read_buildbot_config 23:44:01 INFO - Using buildbot properties: 23:44:01 INFO - { 23:44:01 INFO - "project": "", 23:44:01 INFO - "product": "firefox", 23:44:01 INFO - "script_repo_revision": "production", 23:44:01 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:44:01 INFO - "repository": "", 23:44:01 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 23:44:01 INFO - "buildid": "20161025221325", 23:44:01 INFO - "pgo_build": "False", 23:44:01 INFO - "basedir": "/builds/slave/test", 23:44:01 INFO - "buildnumber": 1987, 23:44:01 INFO - "slavename": "talos-linux64-ix-012", 23:44:01 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:44:01 INFO - "platform": "ubuntu64_hw", 23:44:01 INFO - "scheduler": "tests-fx-team-linux64-talos", 23:44:01 INFO - "branch": "fx-team", 23:44:01 INFO - "repo_path": "integration/fx-team", 23:44:01 INFO - "revision": "f9f3cc95d7282f1fd83f66dd74acbcdbfe821915", 23:44:01 INFO - "stage_platform": "linux64", 23:44:01 INFO - "builduid": "09ad6336a6c94ab980a15525118f2c43", 23:44:01 INFO - "slavebuilddir": "test" 23:44:01 INFO - } 23:44:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/UKkR3Ji_SFC7cyd_QxMHIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 23:44:01 INFO - Running post-action listener: _resource_record_post_action 23:44:01 INFO - [mozharness: 2016-10-26 06:44:01.426294Z] Finished read-buildbot-config step (success) 23:44:01 INFO - [mozharness: 2016-10-26 06:44:01.426382Z] Running download-and-extract step. 23:44:01 INFO - Running pre-action listener: _resource_record_pre_action 23:44:01 INFO - Running main action method: download_and_extract 23:44:01 INFO - mkdir: /builds/slave/test/build/tests 23:44:01 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')]} 23:44:01 INFO - trying https://queue.taskcluster.net/v1/task/UKkR3Ji_SFC7cyd_QxMHIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 23:44:01 INFO - Downloading https://queue.taskcluster.net/v1/task/UKkR3Ji_SFC7cyd_QxMHIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 23:44:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UKkR3Ji_SFC7cyd_QxMHIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:44:01 INFO - Downloaded 1361 bytes. 23:44:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 23:44:01 INFO - Using the following test package requirements: 23:44:01 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 23:44:01 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:44:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:44:01 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:44:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:44:01 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:44:01 INFO - u'jsshell-linux-x86_64.zip'], 23:44:01 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:44:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:44:01 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 23:44:01 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:44:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:44:01 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:44:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:44:01 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:44:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:44:01 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:44:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:44:01 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:44:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UKkR3Ji_SFC7cyd_QxMHIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 23:44:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UKkR3Ji_SFC7cyd_QxMHIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:44:01 INFO - Fetch https://queue.taskcluster.net/v1/task/UKkR3Ji_SFC7cyd_QxMHIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 23:44:02 INFO - Http code: 200 23:44:02 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 23:44:02 INFO - x-amz-cf-id: ee381BeQrnQiUjYEutvgB4HoTdYF5q5zZ_N5CSNLUExUoIQKrABssQ== 23:44:02 INFO - x-amz-version-id: o1JRAOU.L_7RHq_T1o3AYONL1d_t7w1p 23:44:02 INFO - Expected file size: 20483125 23:44:02 INFO - Obtained file size: 20483125 23:44:06 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:44:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UKkR3Ji_SFC7cyd_QxMHIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 23:44:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UKkR3Ji_SFC7cyd_QxMHIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:44:06 INFO - Fetch https://queue.taskcluster.net/v1/task/UKkR3Ji_SFC7cyd_QxMHIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 23:44:07 INFO - Http code: 200 23:44:07 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 23:44:07 INFO - x-amz-cf-id: vQllWHqhbMJ_ILqKxCfReVcfhO1dgCjhnU0IDjCHzKIXH53Vb0KAIw== 23:44:07 INFO - x-amz-version-id: o1JRAOU.L_7RHq_T1o3AYONL1d_t7w1p 23:44:07 INFO - Expected file size: 20483125 23:44:07 INFO - Obtained file size: 20483125 23:44:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UKkR3Ji_SFC7cyd_QxMHIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 23:44:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UKkR3Ji_SFC7cyd_QxMHIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:44:12 INFO - Fetch https://queue.taskcluster.net/v1/task/UKkR3Ji_SFC7cyd_QxMHIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 23:44:12 INFO - Http code: 200 23:44:12 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 23:44:12 INFO - x-amz-cf-id: 4B5rWQlSiG7vADVer1Si-dzkXGRjS-__m-O6A539FhCkR72lk8-b7Q== 23:44:12 INFO - x-amz-version-id: I6pO_3A_mrVQqC4DsCkcKIBgTnPD026a 23:44:12 INFO - Expected file size: 14409028 23:44:12 INFO - Obtained file size: 14409028 23:44:13 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')]} 23:44:13 INFO - trying https://queue.taskcluster.net/v1/task/UKkR3Ji_SFC7cyd_QxMHIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:44:13 INFO - Downloading https://queue.taskcluster.net/v1/task/UKkR3Ji_SFC7cyd_QxMHIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:44:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UKkR3Ji_SFC7cyd_QxMHIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:44:15 INFO - Downloaded 55728827 bytes. 23:44:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UKkR3Ji_SFC7cyd_QxMHIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:44:15 INFO - mkdir: /builds/slave/test/properties 23:44:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:44:15 INFO - Writing to file /builds/slave/test/properties/build_url 23:44:15 INFO - Contents: 23:44:15 INFO - build_url:https://queue.taskcluster.net/v1/task/UKkR3Ji_SFC7cyd_QxMHIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:44:16 INFO - Running post-action listener: _resource_record_post_action 23:44:16 INFO - Running post-action listener: set_extra_try_arguments 23:44:16 INFO - [mozharness: 2016-10-26 06:44:16.082985Z] Finished download-and-extract step (success) 23:44:16 INFO - [mozharness: 2016-10-26 06:44:16.083211Z] Running populate-webroot step. 23:44:16 INFO - Running pre-action listener: _resource_record_pre_action 23:44:16 INFO - Running main action method: populate_webroot 23:44:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:44:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:44:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:44:16 INFO - '--tppagecycles', 23:44:16 INFO - '7'], 23:44:16 INFO - 'tests': ['tsvgm']}}, 23:44:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:44:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:44:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:44:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:44:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:44:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:44:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:44:16 INFO - 'talos_options': ['--disable-e10s'], 23:44:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:44:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:44:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:44:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:44:16 INFO - 'talos_options': ['--disable-e10s'], 23:44:16 INFO - 'tests': ['damp', 'tps']}, 23:44:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:44:16 INFO - 'tests': ['damp', 'tps']}, 23:44:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:44:16 INFO - 'tests': ['dromaeo_dom']}, 23:44:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:44:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:44:16 INFO - 'tests': ['basic_compositor_video']}, 23:44:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:44:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:44:16 INFO - 'tests': ['a11yr', 23:44:16 INFO - 'ts_paint', 23:44:16 INFO - 'tpaint', 23:44:16 INFO - 'sessionrestore', 23:44:16 INFO - 'sessionrestore_no_auto_restore', 23:44:16 INFO - 'tabpaint']}, 23:44:16 INFO - 'other-e10s': {'tests': ['a11yr', 23:44:16 INFO - 'ts_paint', 23:44:16 INFO - 'tpaint', 23:44:16 INFO - 'sessionrestore', 23:44:16 INFO - 'sessionrestore_no_auto_restore', 23:44:16 INFO - 'tabpaint']}, 23:44:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:44:16 INFO - 'ts_paint', 23:44:16 INFO - 'tpaint', 23:44:16 INFO - 'sessionrestore', 23:44:16 INFO - 'sessionrestore_no_auto_restore', 23:44:16 INFO - 'tabpaint']}, 23:44:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:44:16 INFO - 'ts_paint', 23:44:16 INFO - 'tpaint', 23:44:16 INFO - 'sessionrestore', 23:44:16 INFO - 'sessionrestore_no_auto_restore', 23:44:16 INFO - 'tabpaint']}, 23:44:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:44:16 INFO - 'tests': ['a11yr', 23:44:16 INFO - 'ts_paint', 23:44:16 INFO - 'tpaint', 23:44:16 INFO - 'sessionrestore', 23:44:16 INFO - 'sessionrestore_no_auto_restore', 23:44:16 INFO - 'tabpaint']}, 23:44:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:44:16 INFO - 'tests': ['a11yr', 23:44:16 INFO - 'ts_paint', 23:44:16 INFO - 'tpaint', 23:44:16 INFO - 'sessionrestore', 23:44:16 INFO - 'sessionrestore_no_auto_restore', 23:44:16 INFO - 'tabpaint']}, 23:44:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:44:16 INFO - 'tests': ['tsvgx', 23:44:16 INFO - 'tsvgr_opacity', 23:44:16 INFO - 'tart', 23:44:16 INFO - 'tscrollx', 23:44:16 INFO - 'cart']}, 23:44:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:44:16 INFO - 'tsvgr_opacity', 23:44:16 INFO - 'tart', 23:44:16 INFO - 'tscrollx', 23:44:16 INFO - 'cart']}, 23:44:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:44:16 INFO - 'talos_options': ['--disable-e10s'], 23:44:16 INFO - 'tests': ['tp5o']}, 23:44:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:44:16 INFO - 'tests': ['tp5o']}, 23:44:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:44:16 INFO - 'talos_options': ['--disable-e10s', 23:44:16 INFO - '--xperf_path', 23:44:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:44:16 INFO - 'tests': ['tp5n']}, 23:44:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:44:16 INFO - 'talos_options': ['--xperf_path', 23:44:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:44:16 INFO - 'tests': ['tp5n']}}, 23:44:16 INFO - 'talos.zip': {'path': '', 23:44:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:44:16 INFO - Running post-action listener: _resource_record_post_action 23:44:16 INFO - [mozharness: 2016-10-26 06:44:16.100341Z] Finished populate-webroot step (success) 23:44:16 INFO - [mozharness: 2016-10-26 06:44:16.100429Z] Running create-virtualenv step. 23:44:16 INFO - Running pre-action listener: _resource_record_pre_action 23:44:16 INFO - Running main action method: create_virtualenv 23:44:16 INFO - Creating virtualenv /builds/slave/test/build/venv 23:44:16 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 23:44:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:44:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:44:16 INFO - Using real prefix '/usr' 23:44:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:44:16 INFO - Installing distribute.............................................................................................................................................................................................done. 23:44:18 INFO - Installing pip.................done. 23:44:18 INFO - Return code: 0 23:44:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 23:44:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 23:44:18 INFO - Reading from file tmpfile_stdout 23:44:18 INFO - Output received: 23:44:18 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 23:44:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:44:18 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')]} 23:44:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:44:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:44:18 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')]} 23:44:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:44:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:44:18 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 0x7fb22adc0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b38e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254c100>, '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 0x25439d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543e60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1477463450.445442-788762110', '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 23:44:18 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 23:44:18 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 23:44:18 INFO - Using env: {'DISPLAY': ':0', 23:44:18 INFO - 'HOME': '/home/cltbld', 23:44:18 INFO - 'LANG': 'en_US.UTF-8', 23:44:18 INFO - 'LANGUAGE': 'en_US:en', 23:44:18 INFO - 'LOGNAME': 'cltbld', 23:44:18 INFO - 'MAIL': '/var/mail/cltbld', 23:44:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:44:18 INFO - 'MOZ_NO_REMOTE': '1', 23:44:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:44:18 INFO - 'NO_EM_RESTART': '1', 23:44:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:44:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:44:18 INFO - 'PWD': '/builds/slave/test', 23:44:18 INFO - 'SHELL': '/bin/bash', 23:44:18 INFO - 'SHLVL': '1', 23:44:18 INFO - 'TERM': 'linux', 23:44:18 INFO - 'TMOUT': '86400', 23:44:18 INFO - 'USER': 'cltbld', 23:44:18 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477463450.445442-788762110', 23:44:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:44:18 INFO - '_': '/tools/buildbot/bin/python'} 23:44:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:44:19 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 23:44:19 INFO - Cleaning up... 23:44:19 INFO - Return code: 0 23:44:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:44:19 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')]} 23:44:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:44:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:44:19 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')]} 23:44:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:44:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:44:19 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 0x7fb22adc0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b38e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254c100>, '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 0x25439d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543e60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1477463450.445442-788762110', '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 23:44:19 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 23:44:19 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 23:44:19 INFO - Using env: {'DISPLAY': ':0', 23:44:19 INFO - 'HOME': '/home/cltbld', 23:44:19 INFO - 'LANG': 'en_US.UTF-8', 23:44:19 INFO - 'LANGUAGE': 'en_US:en', 23:44:19 INFO - 'LOGNAME': 'cltbld', 23:44:19 INFO - 'MAIL': '/var/mail/cltbld', 23:44:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:44:19 INFO - 'MOZ_NO_REMOTE': '1', 23:44:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:44:19 INFO - 'NO_EM_RESTART': '1', 23:44:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:44:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:44:19 INFO - 'PWD': '/builds/slave/test', 23:44:19 INFO - 'SHELL': '/bin/bash', 23:44:19 INFO - 'SHLVL': '1', 23:44:19 INFO - 'TERM': 'linux', 23:44:19 INFO - 'TMOUT': '86400', 23:44:19 INFO - 'USER': 'cltbld', 23:44:19 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477463450.445442-788762110', 23:44:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:44:19 INFO - '_': '/tools/buildbot/bin/python'} 23:44:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:44:19 INFO - Downloading/unpacking psutil>=3.1.1 23:44:19 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 23:44:19 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 23:44:19 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 23:44:19 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 23:44:19 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 23:44:19 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 23:44:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:44:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:44:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:44:21 INFO - Installing collected packages: psutil 23:44:21 INFO - Running setup.py install for psutil 23:44:21 INFO - building 'psutil._psutil_linux' extension 23:44:21 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 23:44:21 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 23:44:21 INFO - building 'psutil._psutil_posix' extension 23:44:21 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 23:44:21 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 23:44:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:44:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:44:21 INFO - Successfully installed psutil 23:44:21 INFO - Cleaning up... 23:44:21 INFO - Return code: 0 23:44:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:44:21 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')]} 23:44:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:44:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:44:21 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')]} 23:44:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:44:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:44:21 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 0x7fb22adc0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b38e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254c100>, '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 0x25439d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543e60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1477463450.445442-788762110', '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 23:44:21 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 23:44:21 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 23:44:21 INFO - Using env: {'DISPLAY': ':0', 23:44:21 INFO - 'HOME': '/home/cltbld', 23:44:21 INFO - 'LANG': 'en_US.UTF-8', 23:44:21 INFO - 'LANGUAGE': 'en_US:en', 23:44:21 INFO - 'LOGNAME': 'cltbld', 23:44:21 INFO - 'MAIL': '/var/mail/cltbld', 23:44:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:44:21 INFO - 'MOZ_NO_REMOTE': '1', 23:44:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:44:21 INFO - 'NO_EM_RESTART': '1', 23:44:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:44:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:44:21 INFO - 'PWD': '/builds/slave/test', 23:44:21 INFO - 'SHELL': '/bin/bash', 23:44:21 INFO - 'SHLVL': '1', 23:44:21 INFO - 'TERM': 'linux', 23:44:21 INFO - 'TMOUT': '86400', 23:44:21 INFO - 'USER': 'cltbld', 23:44:21 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477463450.445442-788762110', 23:44:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:44:21 INFO - '_': '/tools/buildbot/bin/python'} 23:44:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:44:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:44:22 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 23:44:22 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 23:44:22 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 23:44:22 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 23:44:22 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 23:44:22 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 23:44:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:44:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:44:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:44:24 INFO - Installing collected packages: mozsystemmonitor 23:44:24 INFO - Running setup.py install for mozsystemmonitor 23:44:24 INFO - Successfully installed mozsystemmonitor 23:44:24 INFO - Cleaning up... 23:44:24 INFO - Return code: 0 23:44:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:44:24 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')]} 23:44:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:44:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:44:24 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')]} 23:44:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:44:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:44:24 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 0x7fb22adc0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b38e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254c100>, '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 0x25439d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543e60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1477463450.445442-788762110', '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 23:44:24 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 23:44:24 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 23:44:24 INFO - Using env: {'DISPLAY': ':0', 23:44:24 INFO - 'HOME': '/home/cltbld', 23:44:24 INFO - 'LANG': 'en_US.UTF-8', 23:44:24 INFO - 'LANGUAGE': 'en_US:en', 23:44:24 INFO - 'LOGNAME': 'cltbld', 23:44:24 INFO - 'MAIL': '/var/mail/cltbld', 23:44:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:44:24 INFO - 'MOZ_NO_REMOTE': '1', 23:44:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:44:24 INFO - 'NO_EM_RESTART': '1', 23:44:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:44:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:44:24 INFO - 'PWD': '/builds/slave/test', 23:44:24 INFO - 'SHELL': '/bin/bash', 23:44:24 INFO - 'SHLVL': '1', 23:44:24 INFO - 'TERM': 'linux', 23:44:24 INFO - 'TMOUT': '86400', 23:44:24 INFO - 'USER': 'cltbld', 23:44:24 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477463450.445442-788762110', 23:44:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:44:24 INFO - '_': '/tools/buildbot/bin/python'} 23:44:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:44:24 INFO - Downloading/unpacking jsonschema==2.5.1 23:44:24 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 23:44:24 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 23:44:24 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 23:44:24 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 23:44:24 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 23:44:24 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 23:44:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:44:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:44:26 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 23:44:26 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 23:44:26 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 23:44:26 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 23:44:26 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 23:44:26 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 23:44:26 INFO - Downloading functools32-3.2.3-2.tar.gz 23:44:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:44:26 INFO - warning: no files found matching '*.txt' 23:44:26 INFO - no previously-included directories found matching 'build' 23:44:26 INFO - no previously-included directories found matching 'dist' 23:44:26 INFO - no previously-included directories found matching '.git*' 23:44:26 INFO - Installing collected packages: jsonschema, functools32 23:44:26 INFO - Running setup.py install for functools32 23:44:26 INFO - warning: no files found matching '*.txt' 23:44:26 INFO - no previously-included directories found matching 'build' 23:44:26 INFO - no previously-included directories found matching 'dist' 23:44:26 INFO - no previously-included directories found matching '.git*' 23:44:26 INFO - Successfully installed jsonschema functools32 23:44:26 INFO - Cleaning up... 23:44:26 INFO - Return code: 0 23:44:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:44: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')]} 23:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:44:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:44: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')]} 23:44:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:44:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:44:26 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 0x7fb22adc0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b38e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254c100>, '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 0x25439d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543e60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1477463450.445442-788762110', '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 23:44:26 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 23:44:26 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 23:44:26 INFO - Using env: {'DISPLAY': ':0', 23:44:26 INFO - 'HOME': '/home/cltbld', 23:44:26 INFO - 'LANG': 'en_US.UTF-8', 23:44:26 INFO - 'LANGUAGE': 'en_US:en', 23:44:26 INFO - 'LOGNAME': 'cltbld', 23:44:26 INFO - 'MAIL': '/var/mail/cltbld', 23:44:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:44:26 INFO - 'MOZ_NO_REMOTE': '1', 23:44:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:44:26 INFO - 'NO_EM_RESTART': '1', 23:44:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:44:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:44:26 INFO - 'PWD': '/builds/slave/test', 23:44:26 INFO - 'SHELL': '/bin/bash', 23:44:26 INFO - 'SHLVL': '1', 23:44:26 INFO - 'TERM': 'linux', 23:44:26 INFO - 'TMOUT': '86400', 23:44:26 INFO - 'USER': 'cltbld', 23:44:26 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477463450.445442-788762110', 23:44:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:44:26 INFO - '_': '/tools/buildbot/bin/python'} 23:44:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:44:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:44:27 INFO - Cleaning up... 23:44:27 INFO - Return code: 0 23:44:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:44: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')]} 23:44:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:44:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:44: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')]} 23:44:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:44:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:44:27 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 0x7fb22adc0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b38e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254c100>, '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 0x25439d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543e60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1477463450.445442-788762110', '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 23:44:27 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 23:44:27 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 23:44:27 INFO - Using env: {'DISPLAY': ':0', 23:44:27 INFO - 'HOME': '/home/cltbld', 23:44:27 INFO - 'LANG': 'en_US.UTF-8', 23:44:27 INFO - 'LANGUAGE': 'en_US:en', 23:44:27 INFO - 'LOGNAME': 'cltbld', 23:44:27 INFO - 'MAIL': '/var/mail/cltbld', 23:44:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:44:27 INFO - 'MOZ_NO_REMOTE': '1', 23:44:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:44:27 INFO - 'NO_EM_RESTART': '1', 23:44:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:44:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:44:27 INFO - 'PWD': '/builds/slave/test', 23:44:27 INFO - 'SHELL': '/bin/bash', 23:44:27 INFO - 'SHLVL': '1', 23:44:27 INFO - 'TERM': 'linux', 23:44:27 INFO - 'TMOUT': '86400', 23:44:27 INFO - 'USER': 'cltbld', 23:44:27 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477463450.445442-788762110', 23:44:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:44:27 INFO - '_': '/tools/buildbot/bin/python'} 23:44:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:44:27 INFO - Downloading/unpacking blobuploader==1.2.4 23:44:27 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 23:44:27 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 23:44:27 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 23:44:27 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 23:44:27 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 23:44:27 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 23:44:29 INFO - Downloading blobuploader-1.2.4.tar.gz 23:44:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:44:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:44:29 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 23:44:29 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 23:44:29 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 23:44:29 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 23:44:29 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 23:44:29 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 23:44:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:44:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:44:29 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 23:44:29 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 23:44:29 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 23:44:29 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 23:44:29 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 23:44:29 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 23:44:29 INFO - Downloading docopt-0.6.1.tar.gz 23:44:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:44:30 INFO - Installing collected packages: blobuploader, requests, docopt 23:44:30 INFO - Running setup.py install for blobuploader 23:44:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:44:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:44:30 INFO - Running setup.py install for requests 23:44:30 INFO - Running setup.py install for docopt 23:44:30 INFO - Successfully installed blobuploader requests docopt 23:44:30 INFO - Cleaning up... 23:44:30 INFO - Return code: 0 23:44:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:44:30 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')]} 23:44:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:44:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:44:30 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')]} 23:44:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:44:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:44:30 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 0x7fb22adc0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b38e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254c100>, '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 0x25439d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543e60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1477463450.445442-788762110', '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 23:44:30 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 23:44:30 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 23:44:30 INFO - Using env: {'DISPLAY': ':0', 23:44:30 INFO - 'HOME': '/home/cltbld', 23:44:30 INFO - 'LANG': 'en_US.UTF-8', 23:44:30 INFO - 'LANGUAGE': 'en_US:en', 23:44:30 INFO - 'LOGNAME': 'cltbld', 23:44:30 INFO - 'MAIL': '/var/mail/cltbld', 23:44:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:44:30 INFO - 'MOZ_NO_REMOTE': '1', 23:44:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:44:30 INFO - 'NO_EM_RESTART': '1', 23:44:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:44:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:44:30 INFO - 'PWD': '/builds/slave/test', 23:44:30 INFO - 'SHELL': '/bin/bash', 23:44:30 INFO - 'SHLVL': '1', 23:44:30 INFO - 'TERM': 'linux', 23:44:30 INFO - 'TMOUT': '86400', 23:44:30 INFO - 'USER': 'cltbld', 23:44:30 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477463450.445442-788762110', 23:44:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:44:30 INFO - '_': '/tools/buildbot/bin/python'} 23:44:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:44:30 INFO - Running setup.py (path:/tmp/pip-QEVeaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:44:30 INFO - Running setup.py (path:/tmp/pip-SlcUzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:44:31 INFO - Running setup.py (path:/tmp/pip-ZcbtP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:44:31 INFO - Running setup.py (path:/tmp/pip-Caxt6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:44:31 INFO - Running setup.py (path:/tmp/pip-kNLlmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:44:31 INFO - Running setup.py (path:/tmp/pip-tT8QrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:44:31 INFO - Running setup.py (path:/tmp/pip-Aj1uwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:44:31 INFO - Running setup.py (path:/tmp/pip-aphiDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:44:31 INFO - Running setup.py (path:/tmp/pip-rNcvUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:44:31 INFO - Running setup.py (path:/tmp/pip-ICZFOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:44:31 INFO - Running setup.py (path:/tmp/pip-OAUHhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:44:31 INFO - Running setup.py (path:/tmp/pip-V7Nld7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:44:31 INFO - Running setup.py (path:/tmp/pip-lzetsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:44:31 INFO - Running setup.py (path:/tmp/pip-K1ELE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:44:31 INFO - Running setup.py (path:/tmp/pip-th23C9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:44:31 INFO - Running setup.py (path:/tmp/pip-4ga6OB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:44:32 INFO - Running setup.py (path:/tmp/pip-34qv66-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:44:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:44:32 INFO - Running setup.py install for manifestparser 23:44:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:44:32 INFO - Running setup.py install for mozcrash 23:44:32 INFO - Running setup.py install for mozdebug 23:44:32 INFO - Running setup.py install for mozdevice 23:44:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:44:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:44:32 INFO - Running setup.py install for mozfile 23:44:32 INFO - Running setup.py install for mozhttpd 23:44:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:44:32 INFO - Running setup.py install for mozinfo 23:44:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:44:32 INFO - Running setup.py install for mozInstall 23:44:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:44:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:44:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:44:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:44:32 INFO - Running setup.py install for mozleak 23:44:32 INFO - Running setup.py install for mozlog 23:44:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:44:33 INFO - Running setup.py install for moznetwork 23:44:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:44:33 INFO - Running setup.py install for mozprocess 23:44:33 INFO - Running setup.py install for mozprofile 23:44:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:44:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:44:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:44:33 INFO - Running setup.py install for mozrunner 23:44:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:44:33 INFO - Running setup.py install for mozscreenshot 23:44:33 INFO - Running setup.py install for moztest 23:44:33 INFO - Running setup.py install for mozversion 23:44:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:44:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:44:33 INFO - Cleaning up... 23:44:33 INFO - Return code: 0 23:44:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:44:33 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')]} 23:44:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:44:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:44:33 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')]} 23:44:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:44:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:44:33 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 0x7fb22adc0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b38e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254c100>, '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 0x25439d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543e60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1477463450.445442-788762110', '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 23:44:33 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 23:44:33 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 23:44:33 INFO - Using env: {'DISPLAY': ':0', 23:44:33 INFO - 'HOME': '/home/cltbld', 23:44:33 INFO - 'LANG': 'en_US.UTF-8', 23:44:33 INFO - 'LANGUAGE': 'en_US:en', 23:44:33 INFO - 'LOGNAME': 'cltbld', 23:44:33 INFO - 'MAIL': '/var/mail/cltbld', 23:44:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:44:33 INFO - 'MOZ_NO_REMOTE': '1', 23:44:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:44:33 INFO - 'NO_EM_RESTART': '1', 23:44:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:44:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:44:33 INFO - 'PWD': '/builds/slave/test', 23:44:33 INFO - 'SHELL': '/bin/bash', 23:44:33 INFO - 'SHLVL': '1', 23:44:33 INFO - 'TERM': 'linux', 23:44:33 INFO - 'TMOUT': '86400', 23:44:33 INFO - 'USER': 'cltbld', 23:44:33 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477463450.445442-788762110', 23:44:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:44:33 INFO - '_': '/tools/buildbot/bin/python'} 23:44:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:44:34 INFO - Running setup.py (path:/tmp/pip-FSu9AH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:44:34 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)) 23:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:44:34 INFO - Running setup.py (path:/tmp/pip-C92GYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:44:34 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)) 23:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:44:34 INFO - Running setup.py (path:/tmp/pip-3HLC8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:44:34 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)) 23:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:44:34 INFO - Running setup.py (path:/tmp/pip-2U1Jfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:44:34 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)) 23:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:44:34 INFO - Running setup.py (path:/tmp/pip-guHfoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:44:34 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)) 23:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:44:34 INFO - Running setup.py (path:/tmp/pip-mMkIH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:44:34 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)) 23:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:44:34 INFO - Running setup.py (path:/tmp/pip-kY1gCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:44:34 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)) 23:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:44:34 INFO - Running setup.py (path:/tmp/pip-R0Y2Ve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:44:34 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)) 23:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:44:34 INFO - Running setup.py (path:/tmp/pip-3I5m4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:44:34 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)) 23:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:44:34 INFO - Running setup.py (path:/tmp/pip-Qjmcup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 23:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:44:34 INFO - Running setup.py (path:/tmp/pip-v59CBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:44:34 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)) 23:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:44:34 INFO - Running setup.py (path:/tmp/pip-jPpjYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:44:34 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)) 23:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:44:34 INFO - Running setup.py (path:/tmp/pip-mylIbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:44:35 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)) 23:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:44:35 INFO - Running setup.py (path:/tmp/pip-nXtyMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:44:35 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)) 23:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:44:35 INFO - Running setup.py (path:/tmp/pip-5iZxQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:44:35 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)) 23:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:44:35 INFO - Running setup.py (path:/tmp/pip-21SzWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:44:35 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)) 23:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:44:35 INFO - Running setup.py (path:/tmp/pip-_nT4Er-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:44:35 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)) 23:44:35 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)) 23:44:35 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)) 23:44:35 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)) 23:44:35 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)) 23:44:35 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)) 23:44:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:44:35 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 23:44:35 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 23:44:35 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 23:44:35 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 23:44:35 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 23:44:35 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 23:44:37 INFO - Downloading blessings-1.6.tar.gz 23:44:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:44:37 INFO - Installing collected packages: blessings 23:44:37 INFO - Running setup.py install for blessings 23:44:37 INFO - Successfully installed blessings 23:44:37 INFO - Cleaning up... 23:44:37 INFO - Return code: 0 23:44:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:44:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:44:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:44:37 INFO - Reading from file tmpfile_stdout 23:44:37 INFO - Current package versions: 23:44:37 INFO - argparse == 1.2.1 23:44:37 INFO - blessings == 1.6 23:44:37 INFO - blobuploader == 1.2.4 23:44:37 INFO - docopt == 0.6.1 23:44:37 INFO - functools32 == 3.2.3-2 23:44:37 INFO - jsonschema == 2.5.1 23:44:37 INFO - manifestparser == 1.1 23:44:37 INFO - mozInstall == 1.12 23:44:37 INFO - mozcrash == 0.17 23:44:37 INFO - mozdebug == 0.1 23:44:37 INFO - mozdevice == 0.48 23:44:37 INFO - mozfile == 1.2 23:44:37 INFO - mozhttpd == 0.7 23:44:37 INFO - mozinfo == 0.9 23:44:37 INFO - mozleak == 0.1 23:44:37 INFO - mozlog == 3.4 23:44:37 INFO - moznetwork == 0.27 23:44:37 INFO - mozprocess == 0.23 23:44:37 INFO - mozprofile == 0.28 23:44:37 INFO - mozrunner == 6.12 23:44:37 INFO - mozscreenshot == 0.1 23:44:37 INFO - mozsystemmonitor == 0.3 23:44:37 INFO - moztest == 0.7 23:44:37 INFO - mozversion == 1.4 23:44:37 INFO - psutil == 3.1.1 23:44:37 INFO - requests == 1.2.3 23:44:37 INFO - wsgiref == 0.1.2 23:44:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:44:37 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')]} 23:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:44:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:44:37 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')]} 23:44:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:44:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:44:37 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 0x7fb22adc0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b38e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254c100>, '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 0x25439d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543e60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1477463450.445442-788762110', '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 23:44:37 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 23:44:37 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 23:44:37 INFO - Using env: {'DISPLAY': ':0', 23:44:37 INFO - 'HOME': '/home/cltbld', 23:44:37 INFO - 'LANG': 'en_US.UTF-8', 23:44:37 INFO - 'LANGUAGE': 'en_US:en', 23:44:37 INFO - 'LOGNAME': 'cltbld', 23:44:37 INFO - 'MAIL': '/var/mail/cltbld', 23:44:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:44:37 INFO - 'MOZ_NO_REMOTE': '1', 23:44:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:44:37 INFO - 'NO_EM_RESTART': '1', 23:44:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:44:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:44:37 INFO - 'PWD': '/builds/slave/test', 23:44:37 INFO - 'SHELL': '/bin/bash', 23:44:37 INFO - 'SHLVL': '1', 23:44:37 INFO - 'TERM': 'linux', 23:44:37 INFO - 'TMOUT': '86400', 23:44:37 INFO - 'USER': 'cltbld', 23:44:37 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477463450.445442-788762110', 23:44:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:44:37 INFO - '_': '/tools/buildbot/bin/python'} 23:44:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:44:37 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)) 23:44:37 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)) 23:44:37 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)) 23:44:37 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)) 23:44:37 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)) 23:44:37 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)) 23:44:37 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)) 23:44:37 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)) 23:44:37 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)) 23:44:37 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)) 23:44:37 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)) 23:44:37 INFO - Cleaning up... 23:44:37 INFO - Return code: 0 23:44:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:44:37 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')]} 23:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:44:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:44:37 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')]} 23:44:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:44:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:44:37 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 0x7fb22adc0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b38e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254c100>, '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 0x25439d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543e60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1477463450.445442-788762110', '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 23:44:37 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 23:44:37 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 23:44:37 INFO - Using env: {'DISPLAY': ':0', 23:44:37 INFO - 'HOME': '/home/cltbld', 23:44:37 INFO - 'LANG': 'en_US.UTF-8', 23:44:37 INFO - 'LANGUAGE': 'en_US:en', 23:44:37 INFO - 'LOGNAME': 'cltbld', 23:44:37 INFO - 'MAIL': '/var/mail/cltbld', 23:44:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:44:37 INFO - 'MOZ_NO_REMOTE': '1', 23:44:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:44:37 INFO - 'NO_EM_RESTART': '1', 23:44:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:44:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:44:37 INFO - 'PWD': '/builds/slave/test', 23:44:37 INFO - 'SHELL': '/bin/bash', 23:44:37 INFO - 'SHLVL': '1', 23:44:37 INFO - 'TERM': 'linux', 23:44:37 INFO - 'TMOUT': '86400', 23:44:37 INFO - 'USER': 'cltbld', 23:44:37 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477463450.445442-788762110', 23:44:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:44:37 INFO - '_': '/tools/buildbot/bin/python'} 23:44:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:44:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:44:38 INFO - Cleaning up... 23:44:38 INFO - Return code: 0 23:44:38 INFO - Running post-action listener: _resource_record_post_action 23:44:38 INFO - Running post-action listener: _start_resource_monitoring 23:44:38 INFO - Starting resource monitoring. 23:44:38 INFO - [mozharness: 2016-10-26 06:44:38.234322Z] Finished create-virtualenv step (success) 23:44:38 INFO - [mozharness: 2016-10-26 06:44:38.234785Z] Running install step. 23:44:38 INFO - Running pre-action listener: _resource_record_pre_action 23:44:38 INFO - Running main action method: install 23:44:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:44:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:44:38 INFO - Reading from file tmpfile_stdout 23:44:38 INFO - Detecting whether we're running mozinstall >=1.0... 23:44:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:44:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:44:38 INFO - Reading from file tmpfile_stdout 23:44:38 INFO - Output received: 23:44:38 INFO - Usage: mozinstall [options] installer 23:44:38 INFO - Options: 23:44:38 INFO - -h, --help show this help message and exit 23:44:38 INFO - -d DEST, --destination=DEST 23:44:38 INFO - Directory to install application into. [default: 23:44:38 INFO - "/builds/slave/test"] 23:44:38 INFO - --app=APP Application being installed. [default: firefox] 23:44:38 INFO - mkdir: /builds/slave/test/build/application 23:44:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:44:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:44:54 INFO - Reading from file tmpfile_stdout 23:44:54 INFO - Output received: 23:44:54 INFO - /builds/slave/test/build/application/firefox/firefox 23:44:54 INFO - Running post-action listener: _resource_record_post_action 23:44:54 INFO - [mozharness: 2016-10-26 06:44:54.580297Z] Finished install step (success) 23:44:54 INFO - [mozharness: 2016-10-26 06:44:54.580540Z] Running run-tests step. 23:44:54 INFO - Running pre-action listener: _resource_record_pre_action 23:44:54 INFO - Running main action method: run_tests 23:44:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:44:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:44:54 INFO - Python 2.7.3 23:44:54 INFO - Return code: 0 23:44:54 INFO - grabbing minidump binary from tooltool 23:44:54 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')]} 23:44:54 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 0x254c100>, '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 0x25439d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543e60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:44:54 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 23:44:54 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 23:44:54 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 23:44:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:44:54 INFO - Return code: 0 23:44:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:44:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:44:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:44:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:44:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:44:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UKkR3Ji_SFC7cyd_QxMHIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 23:44:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UKkR3Ji_SFC7cyd_QxMHIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 23:44:54 INFO - Using env: {'DISPLAY': ':0', 23:44:54 INFO - 'HOME': '/home/cltbld', 23:44:54 INFO - 'LANG': 'en_US.UTF-8', 23:44:54 INFO - 'LANGUAGE': 'en_US:en', 23:44:54 INFO - 'LOGNAME': 'cltbld', 23:44:54 INFO - 'MAIL': '/var/mail/cltbld', 23:44:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:44:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:44:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:44:54 INFO - 'MOZ_NO_REMOTE': '1', 23:44:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:44:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:44:54 INFO - 'NO_EM_RESTART': '1', 23:44:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:44:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:44:54 INFO - 'PWD': '/builds/slave/test', 23:44:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:44:54 INFO - 'SHELL': '/bin/bash', 23:44:54 INFO - 'SHLVL': '1', 23:44:54 INFO - 'TERM': 'linux', 23:44:54 INFO - 'TMOUT': '86400', 23:44:54 INFO - 'USER': 'cltbld', 23:44:54 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477463450.445442-788762110', 23:44:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:44:54 INFO - '_': '/tools/buildbot/bin/python'} 23:44:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UKkR3Ji_SFC7cyd_QxMHIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 23:44:54 INFO - mozversion application_buildid: 20161025221325 23:44:54 INFO - mozversion application_changeset: f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 23:44:54 INFO - mozversion application_display_name: Nightly 23:44:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:44:54 INFO - mozversion application_name: Firefox 23:44:54 INFO - mozversion application_remotingname: firefox 23:44:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:44:54 INFO - mozversion application_vendor: Mozilla 23:44:54 INFO - mozversion application_version: 52.0a1 23:44:54 INFO - mozversion platform_buildid: 20161025221325 23:44:54 INFO - mozversion platform_changeset: f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 23:44:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:44:54 INFO - mozversion platform_version: 52.0a1 23:44:54 INFO - using testdate: 1477464294 23:44:54 INFO - actual date: 1477464294 23:44:54 INFO - starting webserver on 'localhost:51121' 23:44:54 INFO - SUITE-START | Running 2 tests 23:44:54 INFO - TEST-START | dromaeo_css 23:44:54 INFO - operating with platform_type : linux_ 23:44:54 INFO - Initialising browser for dromaeo_css test... 23:44:54 INFO - TEST-INFO | started process 14803 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpep3w2K/profile http://localhost:51121/getInfo.html) 23:44:59 INFO - PROCESS | 14803 | __metrics Screen width/height:1600/1200 23:44:59 INFO - PROCESS | 14803 | colorDepth:24 23:44:59 INFO - PROCESS | 14803 | Browser inner width/height: 1024/697 23:44:59 INFO - PROCESS | 14803 | __metrics 23:44:59 INFO - PROCESS | 14803 | 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" 23:44:59 INFO - PROCESS | 14803 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:45:00 INFO - TEST-INFO | 14803: exit 0 23:45:00 INFO - Browser initialized. 23:45:00 INFO - Running cycle 1/1 for dromaeo_css test... 23:45:00 INFO - TEST-INFO | started process 14884 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpep3w2K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:45:13 INFO - PROCESS | 14884 | RSS: Main: 173654016 23:45:13 INFO - PROCESS | 14884 | 23:46:04 INFO - PROCESS | 14884 | 1477464364038 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] 23:48:18 INFO - PROCESS | 14884 | Cycle 1(1): loaded http://localhost:51121/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51121/tests/dromaeo/cssquery-ext.html) 23:48:20 INFO - PROCESS | 14884 | RSS: Main: 383684608 23:48:20 INFO - PROCESS | 14884 | 23:51:23 INFO - PROCESS | 14884 | Cycle 1(1): loaded http://localhost:51121/tests/dromaeo/cssquery-ext.html (next: http://localhost:51121/tests/dromaeo/cssquery-jquery.html) 23:51:23 INFO - PROCESS | 14884 | RSS: Main: 285675520 23:51:23 INFO - PROCESS | 14884 | 23:54:26 INFO - PROCESS | 14884 | Cycle 1(1): loaded http://localhost:51121/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51121/tests/dromaeo/cssquery-mootools.html) 23:54:26 INFO - PROCESS | 14884 | RSS: Main: 218853376 23:54:26 INFO - PROCESS | 14884 | 23:57:28 INFO - PROCESS | 14884 | Cycle 1(1): loaded http://localhost:51121/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51121/tests/dromaeo/cssquery-prototype.html) 23:57:29 INFO - PROCESS | 14884 | RSS: Main: 246308864 23:57:29 INFO - PROCESS | 14884 | 00:00:32 INFO - PROCESS | 14884 | Cycle 1(1): loaded http://localhost:51121/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51121/tests/dromaeo/cssquery-yui.html) 00:00:33 INFO - PROCESS | 14884 | RSS: Main: 222961664 00:00:33 INFO - PROCESS | 14884 | 00:03:36 INFO - PROCESS | 14884 | Cycle 1(1): loaded http://localhost:51121/tests/dromaeo/cssquery-yui.html (next: http://localhost:51121/tests/dromaeo/cssquery-dojo.html) 00:03:36 INFO - PROCESS | 14884 | RSS: Main: 308592640 00:03:36 INFO - PROCESS | 14884 | 00:03:36 INFO - PROCESS | 14884 | __start_tp_report 00:03:36 INFO - PROCESS | 14884 | _x_x_mozilla_page_load 00:03:36 INFO - PROCESS | 14884 | _x_x_mozilla_page_load_details 00:03:36 INFO - PROCESS | 14884 | |i|pagename|runs| 00:03:36 INFO - PROCESS | 14884 | |0;dojo.html;2567.1528395629443;2576.1756238003823;2613.2944105091624;2620.331815387076;2623.6195751616015;4402.779861006945;4478.19392509349;4565.360849481071;4568.200564901145;4568.588827005568;4483.058557702886;4508.211063063959;4509.458864936204;4521.412216411862;4541.046380260149;4182.393552934823;4208.621224089831;4212.789360531977;4255.425517555137;4270.274053410928;4249.87250382489;4278;4282.74303541787;4283.7215580987295;4288.463942007249;4139.3997870308785;4146.170765846828;4157.106222162234;4232.238197124517;4286.657067434613;4200.327947528381;4200.411942328076;4209.158168366339;4212.368144778277;4266.722663026893;4031.717779755418;4064.1871625674985;4064.7764372959477;4140.068484590973;4163.895902602429;4465.977670111661;4467.955320446787;4469.44131983502;4480.260756975095;4530.161920044769;4748;4751.287306903992;4755.833545825914;4818.638602104821;4864.951350486521;4814.638902082358;4838.806447742086;4847.927281090787;4849;4904;4396.186705459436;4448.288273876229;4575.17646823575;4613.284940834176;4622.352870598119;5036.5718913892;5044.319016932741;5044.369453818273;5048.62135339851;5067.619928505377;4839.879003024953;4844.346013288161;4845.3216549683075;4848.8302909398;4905.779239934212;4710.317004034396;4733.668643195012;4748.074125545486;4798.04039192163;4803.5916947059895;4756.7859446325;4759.143354196278;4780.689255198401;4817.13291607507;4820.8794780130775;4730.5032971538185;4736.407949006374;4739.502352253033;4740.170470167707;4798.088363210979;3887.358585833306;3924.60753924611;3929;3989.3018721723583;4034.8789536313957;3493.9301213975577;3559.839807208682;3564.6613571710645;3566.144125409883;3624.5106910566737;4228.534861165269;4231.344141658048;4236.724612900151;4279.015826359955;4288.7855607220135;4760.666753327303;4845.709257444564;4848.12733707936;4850.369451971221;4900.803967841246;4202.957970420318;4249.723767955073;4251.829926802893;4281.571842815756;4294.055307832272;4357.586029327209;4361.563843615613;4361.934570981438;4383.780810959439;4414.161309351213;4653.906921861544;4667.183242932541;4667.533246675441;4667.883302917454;4734.07685501324;4675.181843177498;4768.1417344878255;4772.427308722837;4817.9518204817505;4918.213085906238;4585.10590434862;4590.42619672541;4592.793324300348;4595.37962375075;4601.723896566216;4749.382580264543;4751.192297309397;4757.524247575353;4758.5241475852135;4762.404699412574;4804.42346918372;4808.783604737865;4809.975950120227;4812.711237325771;4816.916193856495;4630.467496237976;4664.253719404879;4667.906641867212;4667.906641867212;4673.719576825401;4728.952710472989;4744.952550474589;4749.2876068589985;4749.311349854321;4753.738544380092;4612.884677883079;4614.815407383801;4620.722756634613;4671.205894997926;4674.6026587740425;4739.360186374795;4748.857534273978;4750.406199225097;4801.615870730403;4809.44691360498;4486.7756612168605;4534.02518458533;4611.377464042312;4624.491305956275;4647.209974304309 00:03:36 INFO - PROCESS | 14884 | |1;ext.html;558.6899270904647;571.7084287013622;573.1030936584248;573.4523530028823;586.9845167859605;27625.30936726583;37677;38789.41815872764;38968.41547376791;43431.348529771996;40115.979703551835;40388;40493.79753101238;40505;40628.59371406285;7703.229677032308;7855.214478552156;7861.331786798129;7862.803429914241;7866.370690344787;7715.421343399239;7796.064472263336;7802.33680137189;7804.453688241825;7806.1413244543055;7810.687572497093;7857.8035549111155;7862.135165131859;7864.960675196616;7867.134615192324;7796.142424333319;7813.179616140309;7837.608119593998;7844.450888437812;7844.9215507844765;7682.539047657103;7753.108392534874;7753.922460775433;7756.185600511922;7756.961215193888;37617.623823761685;37858.81070594657;37991.24017519634;38020;38051.238975220615;2863.2412410711177;2900.419916016784;3085.4600444922276;3104.5032794752733;3483.4426491761196;27479.725202747915;27532;27902.720972790215;27924.162275131777;28443.431131377463;3442.1394651337164;3499.2826470573727;3507.9649203507893;3531.5408996830247;3549.4853246279404;229972;230642;232179;232343;233304;49450;49690.50309496859;49800.50199498031;49812.25281620779;49837.50162498401;31332.37335253282;32091.839540802146;32110.197245068593;34256.31487370239;50961.23558146631;12226.877731222574;12245.93877030627;12279.57021504261;12282.14025018258;12297.569585064659;9133.223675987483;9182.770430739285;9185.494797786187;9186.127317904788;9232.90767092334;17374.56563585895;17409.303627854744;17414.390496332566;17424.82575174232;17492.12539373026;6734.629595372204;6906.136732908387;6965.721371145199;6980.201971819774;7159;793.714262865368;872.9916945927464;876.3033388456192;941.4962994797751;954.1222075690381;26565.601515977276;26799.732002679724;26971.460570788473;26983.595246071323;27135.1859444217;923.4736200365727;924.4684306523776;943.3261163600627;990.1336330710628;1025.7692019295598;14614.342354593857;14759.262036898326;14762.8927830411;14823.851761482463;14957.401703931939;351469.94120235415;352586;352721;353283;353669;31454;31631.84184079111;31636.209094772355;31661.683383166335;31662.841685791886;1041.5365162502615;1090.574675876409;1093.3986307530827;1137.249415385858;1141.3095077478172;26753.866230668722;29124.85437572883;30564.694353056184;30990;31115.37769244557;44116.55883441125;44270.557294426646;44605.55394446144;44722.3291650632;44885.326720099874;314115;317020;317717;318121;318146;20945.37163885086;21543.892280539123;21548.35354939354;23711.881440592686;24919.50160996806;33989.83005084959;34270.314593708485;35235.47146792749;36373.63626363808;36502.4524632136;32731.34537309193;33684.49473257854;35061;35184.296314073064;35239;33869;33993.83003084969;34322.656773432944;34410.655893440744;35183;34328.48507272343;34430.13924651904;34615.13462163466;34972.47541286934;35200.82399587986;30065.849670751508;32126.678733212368;32187;32284.35431291408;32303.838480807444;24226;24784.876075619508;24801.379965501008;24806.751932480445;25243.49513009766 00:03:36 INFO - PROCESS | 14884 | |2;jquery.html;358.6521074557678;362.82947014902993;365.6617628693458;381.8396273565102;384.8953503445113;15336.38654453822;16273.267702953366;16957.915210423947;17002.659946801057;17016.06411647359;15129.394824207018;16726.24731887065;16752.497425077236;16874.325026998937;16895.662086758257;4919.729414882189;5170.922436163461;5175.948240517603;5178.88653939403;5179.8446046618665;3650.908727281813;3847.999520124774;5001.949980500203;5713.371529131792;6067.332593414721;6041.093835924603;6127.81616551502;6130.049842274455;6132.26412830461;6140.478059364959;5850.0932355484965;6038.5471089668235;6059.333473317932;6065.939340606626;6069.119977603267;5340.652857564246;5345.492178243061;5350.063738845686;5354.651947623392;6400.39196276353;21243.362699118898;22966.65550016751;23020.76979230203;23135.305940821803;23170.65244021341;1886.7452893859427;1910.1595298068805;1917.5781328107794;2033.827124694388;2111.820495257905;13758.449662013507;13772.931135344359;13773.793393099111;13803.03378763487;14568.70862582753;1832.1022698877455;1945.3191383015974;2059.845511586637;2061.5361543652707;2102.6005059038735;71170.64414677945;72969.63515182443;74281.25718742797;75945.62027189828;80737.59631201865;15326.463573774865;15634.452794152377;16108.436204732778;16417.91791041061;16650.916745416194;27608.723912761016;27645.30886727848;27678;27747.16758497248;27873.44253114967;8042.477238979448;8519.74440766778;8562.78593035179;8788.824223515494;8794.912050879537;6988.93011069893;7050.788476345718;7241.493095483265;7246.637668116573;7260.782176534713;7856.051269410895;8083.272505474535;8189.631466583899;8327.791805204797;8337.666493340319;2530.63305820655;3051.642019301434;3170.7146356827534;3208.8716451341684;3349.6650334966307;369.39234958493665;371.21117625046776;371.25933762144155;396.6033966033966;874.580201503282;10292.764868215861;10495.580176792842;10668.839967400496;10678.305910115818;10978.396188209565;765.8315170662445;832.4297855968681;845.4758050008911;863.3524856357732;882.7087061269893;9172.174504294646;9495.905040949501;9524.904750952403;9648.597981731915;9692.612295508101;349692;351941.7281580581;351965.0043744532;354222;359114;79014;82892.58553707313;83076.58461707653;83190.58404708059;83414;894.11929249689;898.2589363774781;921.1617428140494;924.7318277699526;926.8146370725882;15335.386584536494;15353.238456577763;15918.761218581962;16075.919620401823;16304.266308015931;26903.461930761667;35525.644743552235;36330.27339453143;36601.26797463983;36829.815850921645;50037.74981125071;51206;51353.7432312836;53426;54116.45883541272;6992.713424690387;7129.180144283474;7271.4546409020595;7324.304191101837;7597.164311925794;10830.458477075957;10986.945065274622;11513.769724605629;11775.882241177478;11883.168178227786;9617.663381781604;10346.741331466774;10515.789684206426;10522.579096836042;10629.096526795309;9945.30382873192;10161.491925403849;10214.285000049926;10281.383117013003;10390.116840068376;5758.654480731169;6435.903461448176;9618;10058.247193702973;10202.948985255027;6701.631410272482;6785.694643740945;6931.89602155958;7014.333638304353;7085.291470852873;8172.34621230312;9728.708138755848;9733.318667693193;9738.464384458639;9993.350432221881 00:03:36 INFO - PROCESS | 14884 | |3;mootools.html;1317.2820812657103;1387.2300873015477;1436.3679980808442;1673.9748903766454;1694.8728845336602;6465.644389558573;6714.362135597123;6999.300069993004;7539.32146106851;7542.245775422455;6909.170899492068;7189.352958233758;7202.279772022795;7337.0828646419195;7362.521436106649;2041.9387418377435;2060.9484762880898;2062.5668609592003;2070.647989841723;2072.7927207279304;1815.047100272361;1901.7812951510616;2057.86623869448;2065.173930427826;2068.879398616423;1975.1803001754254;2045.9795402046013;2047.140201115535;2054.7637021742466;2059.7116403703494;1986.0963261715885;1990.0248878049797;2009.8291645210174;2018.0716870239708;2026.0275067967311;2101.516651170224;2103.5582527669208;2103.905324260412;2111.862728922615;2119.184114116061;7180.28197180283;7208.891866622005;7290.854182916365;7317.634118294064;7342.4493163012985;4209.116085622023;4337.587929146726;4339.652827773771;4350.042990542107;4352.847650332224;2539.352465121382;2609.582466805321;2780.6107144999714;2806.9719302806916;2808.14351622757;851.7870532366908;861.452977359375;870.234193909362;884.9778755531163;911.1981456318464;9825.4104753715;9835.901640983642;9843.655472058443;9852.802943941153;9953.75115622108;3634.5638523377365;3826.6364695353896;3912.158885839558;3939.995301198176;3958.3072962231495;8454.32365410778;8480.363972701949;8485.539193633776;8490.575471226413;8494.660213591387;4368.541303163186;4373.606375426227;4375.846845360397;4383.473983122046;4386.627136693417;3839.078621130964;3984.5218573770753;3984.621460961204;3991.720579559461;3993.3211354069877;3300.3234336960863;3317.303366293057;3397.5413319202084;3433.038749150242;3461.1828789885512;955.7371722776293;956.9808603827885;1094.3980810554162;1107.5126944144552;1114.6154576671197;754.6038329876749;769.8421823526276;794.5749024271987;834.2533432577809;871.5947084605689;4748.311494833299;4770.42754869411;4791.113643975876;4954.380702412199;4991.625628077909;797.7566842113096;831.8253166834911;845.7251393297203;853.1468531468531;871.930245580352;3386.864525419005;3426.4517677171534;3440.397930362177;3444.3283559705615;3503.071686003211;8375.958120209481;8877.422967507091;8880.644774209088;8897.599608017656;8922.910770892338;8895.555222238861;8896.466212027299;8904.065073167354;8905.243054340324;8908.73273801787;6773.9322606774285;6796.388325050769;6832.795016149524;6846.178458585002;6864.279250678706;4914.778834952507;4951.529604687549;4972.627052970969;4976.2286845539;5020.297158397754;7988.121306656147;8042.718504852302;8138;8159.3880458967005;8208.753737387888;7988.560629165219;8090.595470226347;8236.464629799044;8269;8288.50268983863;6276.435120839146;6442.903356449563;6450.290468048417;6452.935470645233;6463.289038205699;6572.244191917991;6583.177102862142;6616.5368424211765;6625.635590042594;6645.435138013323;5946.851328716817;5962.731677074456;6005.459508644243;6022.45797878193;6101.786437474667;5640.576956728344;5739.569532285179;5821.854453638693;5997.820065398045;6082.057281121433;5492.313460817398;5645;5683.346415162144;5687.402822703557;5691.260136182435;3987.501562304712;4036.8990775230855;4043.9797801010805;4082;4180.372944058416;4117.835286588503;4159.916801664011;4174.833006679699;4228.51372092201;4248.553901840262 00:03:36 INFO - PROCESS | 14884 | |4;prototype.html;279.8488816039339;285.1431448497267;289.0605532020932;296.9613950186477;298.98654560544776;4515.841945531907;4707.10513034483;4734.976325118374;4791;4800;4524.502304746476;4625.236835922077;4633.860984170472;4656.604188643969;4710.317004034413;3734.346489364364;3763.9435408468757;3767.472553842464;3768.133329334241;3773.188764415657;3531.8234088295612;3734.804862444019;3738.1402277476195;3738.7943663098517;3741.7006639468914;3427.485877118427;3640.6359364063514;3667.339878821811;3674.375356189441;3676.7977761223256;3630.80030598317;3648.0697422157446;3659.0669379308238;3668.6514781095752;3673.246984368198;3194.4409728297687;3217.549543063973;3235.3205826776407;3241.38413701396;3244.91887702807;4478.216312145394;4501.549845015505;4546.636009197227;4580.816767329303;4617.591634551461;4160.625543701081;4166.416701661769;4168.3955826405;4171.97914010431;4181.811818468176;4877.926831097537;4881.072596206709;4887.340209071801;4894.290327902434;4899.92201715622;3521.3485505181366;3526.5415495985612;3527.2416430467574;3528.2943411317838;3528.341679410673;4909.3126962225315;5055.191169412913;5080.390353157608;5110.361204849394;5110.770015349318;3575.2670702505925;3580.1407662160896;3581.212133330663;3589.766665166756;3590.551181102362;3647.3040036382677;3663.5970043295215;3674.1733110050027;3676.356637588411;3692.9815350923072;4013.5986401360215;4169.958300417018;4194.266003449384;4196.832126714898;4200.138971510833;4880.755962201875;4890.828820991248;4891.633127515451;4894.951050489521;4907.656464047483;1208.9335086570322;1236.9628911132681;1286.5754301080622;1304.8434187897512;1309.5154792726753;876.412803421709;899.8335307968047;903.9864402033975;906.3836591118103;907.1835348186685;4351.586599273127;4358.694891357638;4372.978135109304;4376.737395756201;4384.69307148503;5018.623603229772;5040.899182016339;5050.595952323805;5052.444231134572;5068.771905264272;4250.873518517596;4410.470743510799;4452.5547445255215;4493;4500.3123828564285;2688.1129227354927;2698.905538306189;2712.1592306385082;2716.443129158518;2719.225020869043;4839.322494850724;4854.708717476963;4881.780319885614;4893.926591101136;4899.314096026559;5056.469070747518;5192.7403629818355;5241.633085683966;5251.474852514718;5254.395744489356;4859.902801944012;4863.878403039952;4869.63477739171;4882.6826256293225;4889.584385327216;5127.846234597335;5132.3327967364;5137.640365174402;5146.919146979177;5150.330457040561;4786.133407970825;4986.476419975996;5024.120778863758;5026.667932997685;5027.59779217669;4859.854204373874;4862.878428039327;4872.6832755870755;4875.341828853059;4919.385076865392;3613.1689711367057;3624.583172935146;3645.3256147611714;3647.4711166881184;3651.507046548682;4892.559669629751;5078.339815823919;5105.5149760772665;5107.591392688651;5127.923081153711;4928.531789479994;4935.087008903364;4940.382452193476;4942.135126352946;4948.925766113439;4955.1576232039915;4956.950430495649;4958.181899986462;4958.950410495849;4961.627877909099;4638.721676699274;4745.952540474689;4780.95219047819;4848.612111031039;4875.414950205998;4850.369451971221;4937;4943.283223932582;4957.429895562056;4961.561147267396;4829.5653391194965;4844.297576851266;4846.491118432514;4847.418309802846;4849.709017458964 00:03:36 INFO - PROCESS | 14884 | |5;yui.html;594.4887396838718;596.0433504225715;646.4149944300408;709.7764204275653;754.7132089805873;10620.362778233302;11072.446377681114;11394.886051139487;11797.646070617873;11854.466549005294;13385.799213011813;13396.866031339683;13535.390907409166;13620.72758544831;13640.522581709618;621.3103455164763;761.8666733321675;787.8660627693278;790.115071120346;790.6876783670447;633.4932054356519;776.503038055642;786.6027656033694;797.2306724011328;798.8122791144076;825.0305890578576;825.5624519004907;828.349745449822;829.8008477965275;832.267604508032;647.6017249391638;821.9013718353806;826.4669288309007;827.5283088639478;827.8468483330573;481.52569718826925;592.7954855574819;604.9516038716893;606.0787602843697;611.5474548833876;11718.824217636742;11745.647630571097;11753.706157346049;11758.118141139448;11769.823452648217;11480.311181329147;11672.88327116735;11836;11987.280763154238;12141.089418293663;10721.678349649523;10876.456177191109;10929.234953553254;10937.45312734368;11269;3951.802409879523;3979.343408337621;3979.462772525701;4022.1955608878047;4024.63778259958;44218.33672494915;44547;45927.31109033367;48397.27404088942;50290.245646315336;9364.531773411301;9880.160186384093;9908.80182396348;9984.60061597528;9986.251031172691;17243.482695519153;17385;17449.21478533469;17586.12069396525;17806.109694515224;6209.627422354673;6324.778632747923;6394.584352017104;6531.183602049744;6606.537542372084;3217.501287300472;3230.2408933900515;3263.4452143135723;3278.164068162603;3510.78935263885;2679.6516452861;2776.1532732516775;2786.164150754806;2790.9860450698025;2799.1042866283;474.3501403077806;484.0874950717922;486.55723291804287;490.82821012645286;492.65267986069733;489.06832484117814;498.2280282922385;509.4497942222391;509.8623371689623;519.7453247908574;7639.465237433326;8138.104808471064;8179;8193.918060819435;8510.00059943651;577.4514211499093;583.3495652347602;586.865021045162;599.1402337645493;600.3606159440183;3786.2995345861104;4050.5746896576024;4102.446169767043;4173.561776013536;4179.435776170239;41419.1716165675;50852.23721644178;65573.34426655767;70654.2934570658;70740.2925970744;36820.63179368172;37114;59454.70272648609;59495.40504594899;61445.692771535854;52207.47792522102;52633.47366526362;52662.21006684903;53004.20493692598;53972;8094.83810323802;8468.915310846813;8687.522186279562;8721;8884.60019299146;32721;35465.29069418545;36656.08359791026;36744.265114697024;37142.25715485729;32473.675263247063;33364.165895851824;34398.14004649904;46736;48567.757161215384;10091.798164036825;10476.738081548023;10527.263091583516;10599.735006624896;10674.412907290174;11467.827982580102;11835.230710003822;11844.526218951145;11859.229150105215;12433.37833108359;11401.828972565252;11440.656780296604;11722.94138529302;11963.282203067844;12065.155439119528;10896;11193.496292667012;11224.10207183407;11296.943515282372;11708.88291117078;10464.372137671764;10468.162546996069;10589.735256618646;10982.231243812856;11664.708382290171;8710.608022639124;9477.289203309918;9492.098250666175;9533.445307788383;9542.952285238529;9716.174125199155;9824.164945979672;10123.59505619767;10145.746356341151;10209.74475638115 00:03:36 INFO - PROCESS | 14884 | __end_tp_report 00:03:36 INFO - PROCESS | 14884 | __start_cc_report 00:03:36 INFO - PROCESS | 14884 | _x_x_mozilla_cycle_collect,2357 00:03:36 INFO - PROCESS | 14884 | __end_cc_report 00:03:36 INFO - PROCESS | 14884 | __startTimestamp1477465416646__endTimestamp 00:03:36 INFO - PROCESS | 14884 | 00:03:36 INFO - PROCESS | 14884 | ------- Summary: start ------- 00:03:36 INFO - PROCESS | 14884 | Number of tests: 6 00:03:36 INFO - PROCESS | 14884 | 00:03:36 INFO - PROCESS | 14884 | [#0] dojo.html Cycles:165 Average:4477.31 Median:4613.28 stddev:457.24 (9.9%) stddev-sans-first:433.39 00:03:36 INFO - PROCESS | 14884 | Values: 2567.2 2576.2 2613.3 2620.3 2623.6 4402.8 4478.2 4565.4 4568.2 4568.6 4483.1 4508.2 4509.5 4521.4 4541.0 4182.4 4208.6 4212.8 4255.4 4270.3 4249.9 4278.0 4282.7 4283.7 4288.5 4139.4 4146.2 4157.1 4232.2 4286.7 4200.3 4200.4 4209.2 4212.4 4266.7 4031.7 4064.2 4064.8 4140.1 4163.9 4466.0 4468.0 4469.4 4480.3 4530.2 4748.0 4751.3 4755.8 4818.6 4865.0 4814.6 4838.8 4847.9 4849.0 4904.0 4396.2 4448.3 4575.2 4613.3 4622.4 5036.6 5044.3 5044.4 5048.6 5067.6 4839.9 4844.3 4845.3 4848.8 4905.8 4710.3 4733.7 4748.1 4798.0 4803.6 4756.8 4759.1 4780.7 4817.1 4820.9 4730.5 4736.4 4739.5 4740.2 4798.1 3887.4 3924.6 3929.0 3989.3 4034.9 3493.9 3559.8 3564.7 3566.1 3624.5 4228.5 4231.3 4236.7 4279.0 4288.8 4760.7 4845.7 4848.1 4850.4 4900.8 4203.0 4249.7 4251.8 4281.6 4294.1 4357.6 4361.6 4361.9 4383.8 4414.2 4653.9 4667.2 4667.5 4667.9 4734.1 4675.2 4768.1 4772.4 4818.0 4918.2 4585.1 4590.4 4592.8 4595.4 4601.7 4749.4 4751.2 4757.5 4758.5 4762.4 4804.4 4808.8 4810.0 4812.7 4816.9 4630.5 4664.3 4667.9 4667.9 4673.7 4729.0 4745.0 4749.3 4749.3 4753.7 4612.9 4614.8 4620.7 4671.2 4674.6 4739.4 4748.9 4750.4 4801.6 4809.4 4486.8 4534.0 4611.4 4624.5 4647.2 00:03:36 INFO - PROCESS | 14884 | 00:03:36 INFO - PROCESS | 14884 | [#1] ext.html Cycles:180 Average:44197.84 Median:19284.48 stddev:80165.28 (415.7%) stddev-sans-first:80323.21 00:03:36 INFO - PROCESS | 14884 | Values: 558.7 571.7 573.1 573.5 587.0 27625.3 37677.0 38789.4 38968.4 43431.3 40116.0 40388.0 40493.8 40505.0 40628.6 7703.2 7855.2 7861.3 7862.8 7866.4 7715.4 7796.1 7802.3 7804.5 7806.1 7810.7 7857.8 7862.1 7865.0 7867.1 7796.1 7813.2 7837.6 7844.5 7844.9 7682.5 7753.1 7753.9 7756.2 7757.0 37617.6 37858.8 37991.2 38020.0 38051.2 2863.2 2900.4 3085.5 3104.5 3483.4 27479.7 27532.0 27902.7 27924.2 28443.4 3442.1 3499.3 3508.0 3531.5 3549.5 229972.0 230642.0 232179.0 232343.0 233304.0 49450.0 49690.5 49800.5 49812.3 49837.5 31332.4 32091.8 32110.2 34256.3 50961.2 12226.9 12245.9 12279.6 12282.1 12297.6 9133.2 9182.8 9185.5 9186.1 9232.9 17374.6 17409.3 17414.4 17424.8 17492.1 6734.6 6906.1 6965.7 6980.2 7159.0 793.7 873.0 876.3 941.5 954.1 26565.6 26799.7 26971.5 26983.6 27135.2 923.5 924.5 943.3 990.1 1025.8 14614.3 14759.3 14762.9 14823.9 14957.4 351469.9 352586.0 352721.0 353283.0 353669.0 31454.0 31631.8 31636.2 31661.7 31662.8 1041.5 1090.6 1093.4 1137.2 1141.3 26753.9 29124.9 30564.7 30990.0 31115.4 44116.6 44270.6 44605.6 44722.3 44885.3 314115.0 317020.0 317717.0 318121.0 318146.0 20945.4 21543.9 21548.4 23711.9 24919.5 33989.8 34270.3 35235.5 36373.6 36502.5 32731.3 33684.5 35061.0 35184.3 35239.0 33869.0 33993.8 34322.7 34410.7 35183.0 34328.5 34430.1 34615.1 34972.5 35200.8 30065.8 32126.7 32187.0 32284.4 32303.8 24226.0 24784.9 24801.4 24806.8 25243.5 00:03:36 INFO - PROCESS | 14884 | 00:03:36 INFO - PROCESS | 14884 | [#2] jquery.html Cycles:180 Average:24212.00 Median:2658.17 stddev:58810.65 (2212.5%) stddev-sans-first:58948.36 00:03:36 INFO - PROCESS | 14884 | Values: 358.7 362.8 365.7 381.8 384.9 15336.4 16273.3 16957.9 17002.7 17016.1 15129.4 16726.2 16752.5 16874.3 16895.7 4919.7 5170.9 5175.9 5178.9 5179.8 3650.9 3848.0 5001.9 5713.4 6067.3 6041.1 6127.8 6130.0 6132.3 6140.5 5850.1 6038.5 6059.3 6065.9 6069.1 5340.7 5345.5 5350.1 5354.7 6400.4 21243.4 22966.7 23020.8 23135.3 23170.7 1886.7 1910.2 1917.6 2033.8 2111.8 13758.4 13772.9 13773.8 13803.0 14568.7 1832.1 1945.3 2059.8 2061.5 2102.6 71170.6 72969.6 74281.3 75945.6 80737.6 15326.5 15634.5 16108.4 16417.9 16650.9 27608.7 27645.3 27678.0 27747.2 27873.4 8042.5 8519.7 8562.8 8788.8 8794.9 6988.9 7050.8 7241.5 7246.6 7260.8 7856.1 8083.3 8189.6 8327.8 8337.7 2530.6 3051.6 3170.7 3208.9 3349.7 369.4 371.2 371.3 396.6 874.6 10292.8 10495.6 10668.8 10678.3 10978.4 765.8 832.4 845.5 863.4 882.7 9172.2 9495.9 9524.9 9648.6 9692.6 349692.0 351941.7 351965.0 354222.0 359114.0 79014.0 82892.6 83076.6 83190.6 83414.0 894.1 898.3 921.2 924.7 926.8 15335.4 15353.2 15918.8 16075.9 16304.3 26903.5 35525.6 36330.3 36601.3 36829.8 50037.7 51206.0 51353.7 53426.0 54116.5 6992.7 7129.2 7271.5 7324.3 7597.2 10830.5 10986.9 11513.8 11775.9 11883.2 9617.7 10346.7 10515.8 10522.6 10629.1 9945.3 10161.5 10214.3 10281.4 10390.1 5758.7 6435.9 9618.0 10058.2 10202.9 6701.6 6785.7 6931.9 7014.3 7085.3 8172.3 9728.7 9733.3 9738.5 9993.4 00:03:36 INFO - PROCESS | 14884 | 00:03:36 INFO - PROCESS | 14884 | [#3] mootools.html Cycles:180 Average:4737.89 Median:5664.17 stddev:2621.67 (46.3%) stddev-sans-first:2616.43 00:03:36 INFO - PROCESS | 14884 | Values: 1317.3 1387.2 1436.4 1674.0 1694.9 6465.6 6714.4 6999.3 7539.3 7542.2 6909.2 7189.4 7202.3 7337.1 7362.5 2041.9 2060.9 2062.6 2070.6 2072.8 1815.0 1901.8 2057.9 2065.2 2068.9 1975.2 2046.0 2047.1 2054.8 2059.7 1986.1 1990.0 2009.8 2018.1 2026.0 2101.5 2103.6 2103.9 2111.9 2119.2 7180.3 7208.9 7290.9 7317.6 7342.4 4209.1 4337.6 4339.7 4350.0 4352.8 2539.4 2609.6 2780.6 2807.0 2808.1 851.8 861.5 870.2 885.0 911.2 9825.4 9835.9 9843.7 9852.8 9953.8 3634.6 3826.6 3912.2 3940.0 3958.3 8454.3 8480.4 8485.5 8490.6 8494.7 4368.5 4373.6 4375.8 4383.5 4386.6 3839.1 3984.5 3984.6 3991.7 3993.3 3300.3 3317.3 3397.5 3433.0 3461.2 955.7 957.0 1094.4 1107.5 1114.6 754.6 769.8 794.6 834.3 871.6 4748.3 4770.4 4791.1 4954.4 4991.6 797.8 831.8 845.7 853.1 871.9 3386.9 3426.5 3440.4 3444.3 3503.1 8376.0 8877.4 8880.6 8897.6 8922.9 8895.6 8896.5 8904.1 8905.2 8908.7 6773.9 6796.4 6832.8 6846.2 6864.3 4914.8 4951.5 4972.6 4976.2 5020.3 7988.1 8042.7 8138.0 8159.4 8208.8 7988.6 8090.6 8236.5 8269.0 8288.5 6276.4 6442.9 6450.3 6452.9 6463.3 6572.2 6583.2 6616.5 6625.6 6645.4 5946.9 5962.7 6005.5 6022.5 6101.8 5640.6 5739.6 5821.9 5997.8 6082.1 5492.3 5645.0 5683.3 5687.4 5691.3 3987.5 4036.9 4044.0 4082.0 4180.4 4117.8 4159.9 4174.8 4228.5 4248.6 00:03:36 INFO - PROCESS | 14884 | 00:03:36 INFO - PROCESS | 14884 | [#4] prototype.html Cycles:180 Average:4107.38 Median:4681.85 stddev:1184.99 (25.3%) stddev-sans-first:1152.97 00:03:36 INFO - PROCESS | 14884 | Values: 279.8 285.1 289.1 297.0 299.0 4515.8 4707.1 4735.0 4791.0 4800.0 4524.5 4625.2 4633.9 4656.6 4710.3 3734.3 3763.9 3767.5 3768.1 3773.2 3531.8 3734.8 3738.1 3738.8 3741.7 3427.5 3640.6 3667.3 3674.4 3676.8 3630.8 3648.1 3659.1 3668.7 3673.2 3194.4 3217.5 3235.3 3241.4 3244.9 4478.2 4501.5 4546.6 4580.8 4617.6 4160.6 4166.4 4168.4 4172.0 4181.8 4877.9 4881.1 4887.3 4894.3 4899.9 3521.3 3526.5 3527.2 3528.3 3528.3 4909.3 5055.2 5080.4 5110.4 5110.8 3575.3 3580.1 3581.2 3589.8 3590.6 3647.3 3663.6 3674.2 3676.4 3693.0 4013.6 4170.0 4194.3 4196.8 4200.1 4880.8 4890.8 4891.6 4895.0 4907.7 1208.9 1237.0 1286.6 1304.8 1309.5 876.4 899.8 904.0 906.4 907.2 4351.6 4358.7 4373.0 4376.7 4384.7 5018.6 5040.9 5050.6 5052.4 5068.8 4250.9 4410.5 4452.6 4493.0 4500.3 2688.1 2698.9 2712.2 2716.4 2719.2 4839.3 4854.7 4881.8 4893.9 4899.3 5056.5 5192.7 5241.6 5251.5 5254.4 4859.9 4863.9 4869.6 4882.7 4889.6 5127.8 5132.3 5137.6 5146.9 5150.3 4786.1 4986.5 5024.1 5026.7 5027.6 4859.9 4862.9 4872.7 4875.3 4919.4 3613.2 3624.6 3645.3 3647.5 3651.5 4892.6 5078.3 5105.5 5107.6 5127.9 4928.5 4935.1 4940.4 4942.1 4948.9 4955.2 4957.0 4958.2 4959.0 4961.6 4638.7 4746.0 4781.0 4848.6 4875.4 4850.4 4937.0 4943.3 4957.4 4961.6 4829.6 4844.3 4846.5 4847.4 4849.7 00:03:36 INFO - PROCESS | 14884 | 00:03:36 INFO - PROCESS | 14884 | [#5] yui.html Cycles:180 Average:13626.56 Median:45237.16 stddev:16513.06 (36.5%) stddev-sans-first:16530.39 00:03:36 INFO - PROCESS | 14884 | Values: 594.5 596.0 646.4 709.8 754.7 10620.4 11072.4 11394.9 11797.6 11854.5 13385.8 13396.9 13535.4 13620.7 13640.5 621.3 761.9 787.9 790.1 790.7 633.5 776.5 786.6 797.2 798.8 825.0 825.6 828.3 829.8 832.3 647.6 821.9 826.5 827.5 827.8 481.5 592.8 605.0 606.1 611.5 11718.8 11745.6 11753.7 11758.1 11769.8 11480.3 11672.9 11836.0 11987.3 12141.1 10721.7 10876.5 10929.2 10937.5 11269.0 3951.8 3979.3 3979.5 4022.2 4024.6 44218.3 44547.0 45927.3 48397.3 50290.2 9364.5 9880.2 9908.8 9984.6 9986.3 17243.5 17385.0 17449.2 17586.1 17806.1 6209.6 6324.8 6394.6 6531.2 6606.5 3217.5 3230.2 3263.4 3278.2 3510.8 2679.7 2776.2 2786.2 2791.0 2799.1 474.4 484.1 486.6 490.8 492.7 489.1 498.2 509.4 509.9 519.7 7639.5 8138.1 8179.0 8193.9 8510.0 577.5 583.3 586.9 599.1 600.4 3786.3 4050.6 4102.4 4173.6 4179.4 41419.2 50852.2 65573.3 70654.3 70740.3 36820.6 37114.0 59454.7 59495.4 61445.7 52207.5 52633.5 52662.2 53004.2 53972.0 8094.8 8468.9 8687.5 8721.0 8884.6 32721.0 35465.3 36656.1 36744.3 37142.3 32473.7 33364.2 34398.1 46736.0 48567.8 10091.8 10476.7 10527.3 10599.7 10674.4 11467.8 11835.2 11844.5 11859.2 12433.4 11401.8 11440.7 11722.9 11963.3 12065.2 10896.0 11193.5 11224.1 11296.9 11708.9 10464.4 10468.2 10589.7 10982.2 11664.7 8710.6 9477.3 9492.1 9533.4 9543.0 9716.2 9824.2 10123.6 10145.7 10209.7 00:03:36 INFO - PROCESS | 14884 | -------- Summary: end -------- 00:03:36 INFO - PROCESS | 14884 | 00:03:37 INFO - TEST-INFO | 14884: exit 0 00:03:37 INFO - TEST-OK | dromaeo_css | took 1122858ms 00:03:37 INFO - TEST-START | kraken 00:03:37 INFO - operating with platform_type : linux_ 00:03:37 INFO - Initialising browser for kraken test... 00:03:37 INFO - TEST-INFO | started process 15190 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUhtlrO/profile http://localhost:51121/getInfo.html) 00:03:41 INFO - PROCESS | 15190 | __metrics Screen width/height:1600/1200 00:03:41 INFO - PROCESS | 15190 | colorDepth:24 00:03:41 INFO - PROCESS | 15190 | Browser inner width/height: 1024/697 00:03:41 INFO - PROCESS | 15190 | __metrics 00:03:42 INFO - PROCESS | 15190 | 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" 00:03:42 INFO - PROCESS | 15190 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:03:43 INFO - TEST-INFO | 15190: exit 0 00:03:43 INFO - Browser initialized. 00:03:43 INFO - Running cycle 1/1 for kraken test... 00:03:43 INFO - TEST-INFO | started process 15275 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUhtlrO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:03:55 INFO - PROCESS | 15275 | RSS: Main: 173047808 00:03:55 INFO - PROCESS | 15275 | 00:03:58 INFO - PROCESS | 15275 | Cycle 1(1): loaded http://localhost:51121/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51121/tests/kraken/driver.html?testName=audio-beat-detection) 00:03:59 INFO - PROCESS | 15275 | RSS: Main: 238374912 00:03:59 INFO - PROCESS | 15275 | 00:04:02 INFO - PROCESS | 15275 | Cycle 1(1): loaded http://localhost:51121/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51121/tests/kraken/driver.html?testName=audio-dft) 00:04:03 INFO - PROCESS | 15275 | RSS: Main: 217407488 00:04:03 INFO - PROCESS | 15275 | 00:04:06 INFO - PROCESS | 15275 | Cycle 1(1): loaded http://localhost:51121/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51121/tests/kraken/driver.html?testName=audio-fft) 00:04:06 INFO - PROCESS | 15275 | RSS: Main: 299237376 00:04:06 INFO - PROCESS | 15275 | 00:04:09 INFO - PROCESS | 15275 | Cycle 1(1): loaded http://localhost:51121/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51121/tests/kraken/driver.html?testName=audio-oscillator) 00:04:09 INFO - PROCESS | 15275 | RSS: Main: 207425536 00:04:09 INFO - PROCESS | 15275 | 00:04:11 INFO - PROCESS | 15275 | Cycle 1(1): loaded http://localhost:51121/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51121/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:04:12 INFO - PROCESS | 15275 | RSS: Main: 212758528 00:04:12 INFO - PROCESS | 15275 | 00:04:15 INFO - PROCESS | 15275 | Cycle 1(1): loaded http://localhost:51121/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51121/tests/kraken/driver.html?testName=imaging-darkroom) 00:04:16 INFO - PROCESS | 15275 | RSS: Main: 248397824 00:04:16 INFO - PROCESS | 15275 | 00:04:19 INFO - PROCESS | 15275 | Cycle 1(1): loaded http://localhost:51121/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51121/tests/kraken/driver.html?testName=imaging-desaturate) 00:04:20 INFO - PROCESS | 15275 | RSS: Main: 248549376 00:04:20 INFO - PROCESS | 15275 | 00:04:23 INFO - PROCESS | 15275 | Cycle 1(1): loaded http://localhost:51121/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51121/tests/kraken/driver.html?testName=json-parse-financial) 00:04:23 INFO - PROCESS | 15275 | RSS: Main: 247713792 00:04:23 INFO - PROCESS | 15275 | 00:04:25 INFO - PROCESS | 15275 | Cycle 1(1): loaded http://localhost:51121/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51121/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:04:26 INFO - PROCESS | 15275 | RSS: Main: 210026496 00:04:26 INFO - PROCESS | 15275 | 00:04:27 INFO - PROCESS | 15275 | Cycle 1(1): loaded http://localhost:51121/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51121/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:04:28 INFO - PROCESS | 15275 | RSS: Main: 216829952 00:04:28 INFO - PROCESS | 15275 | 00:04:30 INFO - PROCESS | 15275 | Cycle 1(1): loaded http://localhost:51121/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51121/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:04:31 INFO - PROCESS | 15275 | RSS: Main: 226070528 00:04:31 INFO - PROCESS | 15275 | 00:04:34 INFO - PROCESS | 15275 | Cycle 1(1): loaded http://localhost:51121/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51121/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:04:34 INFO - PROCESS | 15275 | RSS: Main: 230715392 00:04:34 INFO - PROCESS | 15275 | 00:04:37 INFO - PROCESS | 15275 | Cycle 1(1): loaded http://localhost:51121/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51121/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:04:38 INFO - PROCESS | 15275 | RSS: Main: 231526400 00:04:38 INFO - PROCESS | 15275 | 00:04:40 INFO - PROCESS | 15275 | Cycle 1(1): loaded http://localhost:51121/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51121/tests/kraken/driver.html?testName=ai-astar) 00:04:40 INFO - PROCESS | 15275 | RSS: Main: 283049984 00:04:40 INFO - PROCESS | 15275 | 00:04:40 INFO - PROCESS | 15275 | __start_tp_report 00:04:40 INFO - PROCESS | 15275 | _x_x_mozilla_page_load 00:04:40 INFO - PROCESS | 15275 | _x_x_mozilla_page_load_details 00:04:40 INFO - PROCESS | 15275 | |i|pagename|runs| 00:04:40 INFO - PROCESS | 15275 | |0;ai-astar;110;117;116;116;114;117;116;115;116;115 00:04:40 INFO - PROCESS | 15275 | |1;audio-beat-detection;163;128;128;166;128;132;128;130;164;129 00:04:40 INFO - PROCESS | 15275 | |2;audio-dft;162;163;163;163;160;160;164;163;163;162 00:04:40 INFO - PROCESS | 15275 | |3;audio-fft;75;77;75;106;76;78;77;76;111;78 00:04:40 INFO - PROCESS | 15275 | |4;audio-oscillator;84;84;119;84;85;84;109;84;84;127 00:04:40 INFO - PROCESS | 15275 | |5;imaging-gaussian-blur;119;117;118;118;118;118;118;118;118;118 00:04:40 INFO - PROCESS | 15275 | |6;imaging-darkroom;148;147;147;147;148;146;147;146;147;145 00:04:40 INFO - PROCESS | 15275 | |7;imaging-desaturate;86;84;84;85;84;85;85;84;84;85 00:04:40 INFO - PROCESS | 15275 | |8;json-parse-financial;63;63;63;63;65;66;64;64;64;64 00:04:40 INFO - PROCESS | 15275 | |9;json-stringify-tinderbox;66;74;67;67;67;65;67;66;67;71 00:04:40 INFO - PROCESS | 15275 | |10;stanford-crypto-aes;85;85;84;83;83;82;83;84;84;84 00:04:40 INFO - PROCESS | 15275 | |11;stanford-crypto-ccm;162;141;140;145;150;141;146;146;203;144 00:04:40 INFO - PROCESS | 15275 | |12;stanford-crypto-pbkdf2;184;185;177;176;180;182;179;178;179;182 00:04:40 INFO - PROCESS | 15275 | |13;stanford-crypto-sha256-iterative;72;74;72;71;70;71;71;72;69;69 00:04:40 INFO - PROCESS | 15275 | __end_tp_report 00:04:40 INFO - PROCESS | 15275 | __start_cc_report 00:04:40 INFO - PROCESS | 15275 | _x_x_mozilla_cycle_collect,1925 00:04:40 INFO - PROCESS | 15275 | __end_cc_report 00:04:40 INFO - PROCESS | 15275 | __startTimestamp1477465480615__endTimestamp 00:04:40 INFO - PROCESS | 15275 | 00:04:40 INFO - PROCESS | 15275 | ------- Summary: start ------- 00:04:40 INFO - PROCESS | 15275 | Number of tests: 14 00:04:40 INFO - PROCESS | 15275 | 00:04:40 INFO - PROCESS | 15275 | [#0] ai-astar Cycles:10 Average:115.20 Median:116.00 stddev:2.04 (1.8%) stddev-sans-first:0.97 00:04:40 INFO - PROCESS | 15275 | Values: 110.0 117.0 116.0 116.0 114.0 117.0 116.0 115.0 116.0 115.0 00:04:40 INFO - PROCESS | 15275 | 00:04:40 INFO - PROCESS | 15275 | [#1] audio-beat-detection Cycles:10 Average:139.60 Median:131.00 stddev:17.13 (13.1%) stddev-sans-first:15.94 00:04:40 INFO - PROCESS | 15275 | Values: 163.0 128.0 128.0 166.0 128.0 132.0 128.0 130.0 164.0 129.0 00:04:40 INFO - PROCESS | 15275 | 00:04:40 INFO - PROCESS | 15275 | [#2] audio-dft Cycles:10 Average:162.30 Median:163.00 stddev:1.34 (0.8%) stddev-sans-first:1.41 00:04:40 INFO - PROCESS | 15275 | Values: 162.0 163.0 163.0 163.0 160.0 160.0 164.0 163.0 163.0 162.0 00:04:40 INFO - PROCESS | 15275 | 00:04:40 INFO - PROCESS | 15275 | [#3] audio-fft Cycles:10 Average:82.90 Median:76.50 stddev:13.58 (17.8%) stddev-sans-first:14.10 00:04:40 INFO - PROCESS | 15275 | Values: 75.0 77.0 75.0 106.0 76.0 78.0 77.0 76.0 111.0 78.0 00:04:40 INFO - PROCESS | 15275 | 00:04:40 INFO - PROCESS | 15275 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:84.00 stddev:17.06 (20.3%) stddev-sans-first:17.67 00:04:40 INFO - PROCESS | 15275 | Values: 84.0 84.0 119.0 84.0 85.0 84.0 109.0 84.0 84.0 127.0 00:04:40 INFO - PROCESS | 15275 | 00:04:40 INFO - PROCESS | 15275 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 00:04:40 INFO - PROCESS | 15275 | Values: 119.0 117.0 118.0 118.0 118.0 118.0 118.0 118.0 118.0 118.0 00:04:40 INFO - PROCESS | 15275 | 00:04:40 INFO - PROCESS | 15275 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 00:04:40 INFO - PROCESS | 15275 | Values: 148.0 147.0 147.0 147.0 148.0 146.0 147.0 146.0 147.0 145.0 00:04:40 INFO - PROCESS | 15275 | 00:04:40 INFO - PROCESS | 15275 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:0.70 (0.8%) stddev-sans-first:0.53 00:04:40 INFO - PROCESS | 15275 | Values: 86.0 84.0 84.0 85.0 84.0 85.0 85.0 84.0 84.0 85.0 00:04:40 INFO - PROCESS | 15275 | 00:04:40 INFO - PROCESS | 15275 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:64.00 stddev:0.99 (1.6%) stddev-sans-first:1.00 00:04:40 INFO - PROCESS | 15275 | Values: 63.0 63.0 63.0 63.0 65.0 66.0 64.0 64.0 64.0 64.0 00:04:40 INFO - PROCESS | 15275 | 00:04:40 INFO - PROCESS | 15275 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:67.00 stddev:2.71 (4.0%) stddev-sans-first:2.80 00:04:40 INFO - PROCESS | 15275 | Values: 66.0 74.0 67.0 67.0 67.0 65.0 67.0 66.0 67.0 71.0 00:04:40 INFO - PROCESS | 15275 | 00:04:40 INFO - PROCESS | 15275 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:84.00 stddev:0.95 (1.1%) stddev-sans-first:0.88 00:04:40 INFO - PROCESS | 15275 | Values: 85.0 85.0 84.0 83.0 83.0 82.0 83.0 84.0 84.0 84.0 00:04:40 INFO - PROCESS | 15275 | 00:04:40 INFO - PROCESS | 15275 | [#11] stanford-crypto-ccm Cycles:10 Average:151.80 Median:146.00 stddev:19.08 (13.1%) stddev-sans-first:19.87 00:04:40 INFO - PROCESS | 15275 | Values: 162.0 141.0 140.0 145.0 150.0 141.0 146.0 146.0 203.0 144.0 00:04:40 INFO - PROCESS | 15275 | 00:04:40 INFO - PROCESS | 15275 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.20 Median:181.00 stddev:2.97 (1.6%) stddev-sans-first:2.82 00:04:40 INFO - PROCESS | 15275 | Values: 184.0 185.0 177.0 176.0 180.0 182.0 179.0 178.0 179.0 182.0 00:04:40 INFO - PROCESS | 15275 | 00:04:40 INFO - PROCESS | 15275 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:71.50 stddev:1.52 (2.1%) stddev-sans-first:1.58 00:04:40 INFO - PROCESS | 15275 | Values: 72.0 74.0 72.0 71.0 70.0 71.0 71.0 72.0 69.0 69.0 00:04:40 INFO - PROCESS | 15275 | -------- Summary: end -------- 00:04:40 INFO - PROCESS | 15275 | 00:04:41 INFO - TEST-INFO | 15275: exit 0 00:04:41 INFO - TEST-OK | kraken | took 64142ms 00:04:41 INFO - SUITE-END | took 1187s 00:04:42 INFO - Completed test suite (00:19:47) 00:04:42 INFO - javascript benchmark 00:04:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2567.1528395629443, 2576.1756238003823, 2613.2944105091624, 2620.331815387076, 2623.6195751616015, 4402.779861006945, 4478.19392509349, 4565.360849481071, 4568.200564901145, 4568.588827005568, 4483.058557702886, 4508.211063063959, 4509.458864936204, 4521.412216411862, 4541.046380260149, 4182.393552934823, 4208.621224089831, 4212.789360531977, 4255.425517555137, 4270.274053410928, 4249.87250382489, 4278.0, 4282.74303541787, 4283.7215580987295, 4288.463942007249, 4139.3997870308785, 4146.170765846828, 4157.106222162234, 4232.238197124517, 4286.657067434613, 4200.327947528381, 4200.411942328076, 4209.158168366339, 4212.368144778277, 4266.722663026893, 4031.717779755418, 4064.1871625674985, 4064.7764372959477, 4140.068484590973, 4163.895902602429, 4465.977670111661, 4467.955320446787, 4469.44131983502, 4480.260756975095, 4530.161920044769, 4748.0, 4751.287306903992, 4755.833545825914, 4818.638602104821, 4864.951350486521, 4814.638902082358, 4838.806447742086, 4847.927281090787, 4849.0, 4904.0, 4396.186705459436, 4448.288273876229, 4575.17646823575, 4613.284940834176, 4622.352870598119, 5036.5718913892, 5044.319016932741, 5044.369453818273, 5048.62135339851, 5067.619928505377, 4839.879003024953, 4844.346013288161, 4845.3216549683075, 4848.8302909398, 4905.779239934212, 4710.317004034396, 4733.668643195012, 4748.074125545486, 4798.04039192163, 4803.5916947059895, 4756.7859446325, 4759.143354196278, 4780.689255198401, 4817.13291607507, 4820.8794780130775, 4730.5032971538185, 4736.407949006374, 4739.502352253033, 4740.170470167707, 4798.088363210979, 3887.358585833306, 3924.60753924611, 3929.0, 3989.3018721723583, 4034.8789536313957, 3493.9301213975577, 3559.839807208682, 3564.6613571710645, 3566.144125409883, 3624.5106910566737, 4228.534861165269, 4231.344141658048, 4236.724612900151, 4279.015826359955, 4288.7855607220135, 4760.666753327303, 4845.709257444564, 4848.12733707936, 4850.369451971221, 4900.803967841246, 4202.957970420318, 4249.723767955073, 4251.829926802893, 4281.571842815756, 4294.055307832272, 4357.586029327209, 4361.563843615613, 4361.934570981438, 4383.780810959439, 4414.161309351213, 4653.906921861544, 4667.183242932541, 4667.533246675441, 4667.883302917454, 4734.07685501324, 4675.181843177498, 4768.1417344878255, 4772.427308722837, 4817.9518204817505, 4918.213085906238, 4585.10590434862, 4590.42619672541, 4592.793324300348, 4595.37962375075, 4601.723896566216, 4749.382580264543, 4751.192297309397, 4757.524247575353, 4758.5241475852135, 4762.404699412574, 4804.42346918372, 4808.783604737865, 4809.975950120227, 4812.711237325771, 4816.916193856495, 4630.467496237976, 4664.253719404879, 4667.906641867212, 4667.906641867212, 4673.719576825401, 4728.952710472989, 4744.952550474589, 4749.2876068589985, 4749.311349854321, 4753.738544380092, 4612.884677883079, 4614.815407383801, 4620.722756634613, 4671.205894997926, 4674.6026587740425, 4739.360186374795, 4748.857534273978, 4750.406199225097, 4801.615870730403, 4809.44691360498, 4486.7756612168605, 4534.02518458533, 4611.377464042312, 4624.491305956275, 4647.209974304309], "value": 4449.116735399349, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.6899270904647, 571.7084287013622, 573.1030936584248, 573.4523530028823, 586.9845167859605, 27625.30936726583, 37677.0, 38789.41815872764, 38968.41547376791, 43431.348529771996, 40115.979703551835, 40388.0, 40493.79753101238, 40505.0, 40628.59371406285, 7703.229677032308, 7855.214478552156, 7861.331786798129, 7862.803429914241, 7866.370690344787, 7715.421343399239, 7796.064472263336, 7802.33680137189, 7804.453688241825, 7806.1413244543055, 7810.687572497093, 7857.8035549111155, 7862.135165131859, 7864.960675196616, 7867.134615192324, 7796.142424333319, 7813.179616140309, 7837.608119593998, 7844.450888437812, 7844.9215507844765, 7682.539047657103, 7753.108392534874, 7753.922460775433, 7756.185600511922, 7756.961215193888, 37617.623823761685, 37858.81070594657, 37991.24017519634, 38020.0, 38051.238975220615, 2863.2412410711177, 2900.419916016784, 3085.4600444922276, 3104.5032794752733, 3483.4426491761196, 27479.725202747915, 27532.0, 27902.720972790215, 27924.162275131777, 28443.431131377463, 3442.1394651337164, 3499.2826470573727, 3507.9649203507893, 3531.5408996830247, 3549.4853246279404, 229972.0, 230642.0, 232179.0, 232343.0, 233304.0, 49450.0, 49690.50309496859, 49800.50199498031, 49812.25281620779, 49837.50162498401, 31332.37335253282, 32091.839540802146, 32110.197245068593, 34256.31487370239, 50961.23558146631, 12226.877731222574, 12245.93877030627, 12279.57021504261, 12282.14025018258, 12297.569585064659, 9133.223675987483, 9182.770430739285, 9185.494797786187, 9186.127317904788, 9232.90767092334, 17374.56563585895, 17409.303627854744, 17414.390496332566, 17424.82575174232, 17492.12539373026, 6734.629595372204, 6906.136732908387, 6965.721371145199, 6980.201971819774, 7159.0, 793.714262865368, 872.9916945927464, 876.3033388456192, 941.4962994797751, 954.1222075690381, 26565.601515977276, 26799.732002679724, 26971.460570788473, 26983.595246071323, 27135.1859444217, 923.4736200365727, 924.4684306523776, 943.3261163600627, 990.1336330710628, 1025.7692019295598, 14614.342354593857, 14759.262036898326, 14762.8927830411, 14823.851761482463, 14957.401703931939, 351469.94120235415, 352586.0, 352721.0, 353283.0, 353669.0, 31454.0, 31631.84184079111, 31636.209094772355, 31661.683383166335, 31662.841685791886, 1041.5365162502615, 1090.574675876409, 1093.3986307530827, 1137.249415385858, 1141.3095077478172, 26753.866230668722, 29124.85437572883, 30564.694353056184, 30990.0, 31115.37769244557, 44116.55883441125, 44270.557294426646, 44605.55394446144, 44722.3291650632, 44885.326720099874, 314115.0, 317020.0, 317717.0, 318121.0, 318146.0, 20945.37163885086, 21543.892280539123, 21548.35354939354, 23711.881440592686, 24919.50160996806, 33989.83005084959, 34270.314593708485, 35235.47146792749, 36373.63626363808, 36502.4524632136, 32731.34537309193, 33684.49473257854, 35061.0, 35184.296314073064, 35239.0, 33869.0, 33993.83003084969, 34322.656773432944, 34410.655893440744, 35183.0, 34328.48507272343, 34430.13924651904, 34615.13462163466, 34972.47541286934, 35200.82399587986, 30065.849670751508, 32126.678733212368, 32187.0, 32284.35431291408, 32303.838480807444, 24226.0, 24784.876075619508, 24801.379965501008, 24806.751932480445, 25243.49513009766], "value": 16537.325333384695, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.6521074557678, 362.82947014902993, 365.6617628693458, 381.8396273565102, 384.8953503445113, 15336.38654453822, 16273.267702953366, 16957.915210423947, 17002.659946801057, 17016.06411647359, 15129.394824207018, 16726.24731887065, 16752.497425077236, 16874.325026998937, 16895.662086758257, 4919.729414882189, 5170.922436163461, 5175.948240517603, 5178.88653939403, 5179.8446046618665, 3650.908727281813, 3847.999520124774, 5001.949980500203, 5713.371529131792, 6067.332593414721, 6041.093835924603, 6127.81616551502, 6130.049842274455, 6132.26412830461, 6140.478059364959, 5850.0932355484965, 6038.5471089668235, 6059.333473317932, 6065.939340606626, 6069.119977603267, 5340.652857564246, 5345.492178243061, 5350.063738845686, 5354.651947623392, 6400.39196276353, 21243.362699118898, 22966.65550016751, 23020.76979230203, 23135.305940821803, 23170.65244021341, 1886.7452893859427, 1910.1595298068805, 1917.5781328107794, 2033.827124694388, 2111.820495257905, 13758.449662013507, 13772.931135344359, 13773.793393099111, 13803.03378763487, 14568.70862582753, 1832.1022698877455, 1945.3191383015974, 2059.845511586637, 2061.5361543652707, 2102.6005059038735, 71170.64414677945, 72969.63515182443, 74281.25718742797, 75945.62027189828, 80737.59631201865, 15326.463573774865, 15634.452794152377, 16108.436204732778, 16417.91791041061, 16650.916745416194, 27608.723912761016, 27645.30886727848, 27678.0, 27747.16758497248, 27873.44253114967, 8042.477238979448, 8519.74440766778, 8562.78593035179, 8788.824223515494, 8794.912050879537, 6988.93011069893, 7050.788476345718, 7241.493095483265, 7246.637668116573, 7260.782176534713, 7856.051269410895, 8083.272505474535, 8189.631466583899, 8327.791805204797, 8337.666493340319, 2530.63305820655, 3051.642019301434, 3170.7146356827534, 3208.8716451341684, 3349.6650334966307, 369.39234958493665, 371.21117625046776, 371.25933762144155, 396.6033966033966, 874.580201503282, 10292.764868215861, 10495.580176792842, 10668.839967400496, 10678.305910115818, 10978.396188209565, 765.8315170662445, 832.4297855968681, 845.4758050008911, 863.3524856357732, 882.7087061269893, 9172.174504294646, 9495.905040949501, 9524.904750952403, 9648.597981731915, 9692.612295508101, 349692.0, 351941.7281580581, 351965.0043744532, 354222.0, 359114.0, 79014.0, 82892.58553707313, 83076.58461707653, 83190.58404708059, 83414.0, 894.11929249689, 898.2589363774781, 921.1617428140494, 924.7318277699526, 926.8146370725882, 15335.386584536494, 15353.238456577763, 15918.761218581962, 16075.919620401823, 16304.266308015931, 26903.461930761667, 35525.644743552235, 36330.27339453143, 36601.26797463983, 36829.815850921645, 50037.74981125071, 51206.0, 51353.7432312836, 53426.0, 54116.45883541272, 6992.713424690387, 7129.180144283474, 7271.4546409020595, 7324.304191101837, 7597.164311925794, 10830.458477075957, 10986.945065274622, 11513.769724605629, 11775.882241177478, 11883.168178227786, 9617.663381781604, 10346.741331466774, 10515.789684206426, 10522.579096836042, 10629.096526795309, 9945.30382873192, 10161.491925403849, 10214.285000049926, 10281.383117013003, 10390.116840068376, 5758.654480731169, 6435.903461448176, 9618.0, 10058.247193702973, 10202.948985255027, 6701.631410272482, 6785.694643740945, 6931.89602155958, 7014.333638304353, 7085.291470852873, 8172.34621230312, 9728.708138755848, 9733.318667693193, 9738.464384458639, 9993.350432221881], "value": 8620.605713877934, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1317.2820812657103, 1387.2300873015477, 1436.3679980808442, 1673.9748903766454, 1694.8728845336602, 6465.644389558573, 6714.362135597123, 6999.300069993004, 7539.32146106851, 7542.245775422455, 6909.170899492068, 7189.352958233758, 7202.279772022795, 7337.0828646419195, 7362.521436106649, 2041.9387418377435, 2060.9484762880898, 2062.5668609592003, 2070.647989841723, 2072.7927207279304, 1815.047100272361, 1901.7812951510616, 2057.86623869448, 2065.173930427826, 2068.879398616423, 1975.1803001754254, 2045.9795402046013, 2047.140201115535, 2054.7637021742466, 2059.7116403703494, 1986.0963261715885, 1990.0248878049797, 2009.8291645210174, 2018.0716870239708, 2026.0275067967311, 2101.516651170224, 2103.5582527669208, 2103.905324260412, 2111.862728922615, 2119.184114116061, 7180.28197180283, 7208.891866622005, 7290.854182916365, 7317.634118294064, 7342.4493163012985, 4209.116085622023, 4337.587929146726, 4339.652827773771, 4350.042990542107, 4352.847650332224, 2539.352465121382, 2609.582466805321, 2780.6107144999714, 2806.9719302806916, 2808.14351622757, 851.7870532366908, 861.452977359375, 870.234193909362, 884.9778755531163, 911.1981456318464, 9825.4104753715, 9835.901640983642, 9843.655472058443, 9852.802943941153, 9953.75115622108, 3634.5638523377365, 3826.6364695353896, 3912.158885839558, 3939.995301198176, 3958.3072962231495, 8454.32365410778, 8480.363972701949, 8485.539193633776, 8490.575471226413, 8494.660213591387, 4368.541303163186, 4373.606375426227, 4375.846845360397, 4383.473983122046, 4386.627136693417, 3839.078621130964, 3984.5218573770753, 3984.621460961204, 3991.720579559461, 3993.3211354069877, 3300.3234336960863, 3317.303366293057, 3397.5413319202084, 3433.038749150242, 3461.1828789885512, 955.7371722776293, 956.9808603827885, 1094.3980810554162, 1107.5126944144552, 1114.6154576671197, 754.6038329876749, 769.8421823526276, 794.5749024271987, 834.2533432577809, 871.5947084605689, 4748.311494833299, 4770.42754869411, 4791.113643975876, 4954.380702412199, 4991.625628077909, 797.7566842113096, 831.8253166834911, 845.7251393297203, 853.1468531468531, 871.930245580352, 3386.864525419005, 3426.4517677171534, 3440.397930362177, 3444.3283559705615, 3503.071686003211, 8375.958120209481, 8877.422967507091, 8880.644774209088, 8897.599608017656, 8922.910770892338, 8895.555222238861, 8896.466212027299, 8904.065073167354, 8905.243054340324, 8908.73273801787, 6773.9322606774285, 6796.388325050769, 6832.795016149524, 6846.178458585002, 6864.279250678706, 4914.778834952507, 4951.529604687549, 4972.627052970969, 4976.2286845539, 5020.297158397754, 7988.121306656147, 8042.718504852302, 8138.0, 8159.3880458967005, 8208.753737387888, 7988.560629165219, 8090.595470226347, 8236.464629799044, 8269.0, 8288.50268983863, 6276.435120839146, 6442.903356449563, 6450.290468048417, 6452.935470645233, 6463.289038205699, 6572.244191917991, 6583.177102862142, 6616.5368424211765, 6625.635590042594, 6645.435138013323, 5946.851328716817, 5962.731677074456, 6005.459508644243, 6022.45797878193, 6101.786437474667, 5640.576956728344, 5739.569532285179, 5821.854453638693, 5997.820065398045, 6082.057281121433, 5492.313460817398, 5645.0, 5683.346415162144, 5687.402822703557, 5691.260136182435, 3987.501562304712, 4036.8990775230855, 4043.9797801010805, 4082.0, 4180.372944058416, 4117.835286588503, 4159.916801664011, 4174.833006679699, 4228.51372092201, 4248.553901840262], "value": 3843.788316919067, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.8488816039339, 285.1431448497267, 289.0605532020932, 296.9613950186477, 298.98654560544776, 4515.841945531907, 4707.10513034483, 4734.976325118374, 4791.0, 4800.0, 4524.502304746476, 4625.236835922077, 4633.860984170472, 4656.604188643969, 4710.317004034413, 3734.346489364364, 3763.9435408468757, 3767.472553842464, 3768.133329334241, 3773.188764415657, 3531.8234088295612, 3734.804862444019, 3738.1402277476195, 3738.7943663098517, 3741.7006639468914, 3427.485877118427, 3640.6359364063514, 3667.339878821811, 3674.375356189441, 3676.7977761223256, 3630.80030598317, 3648.0697422157446, 3659.0669379308238, 3668.6514781095752, 3673.246984368198, 3194.4409728297687, 3217.549543063973, 3235.3205826776407, 3241.38413701396, 3244.91887702807, 4478.216312145394, 4501.549845015505, 4546.636009197227, 4580.816767329303, 4617.591634551461, 4160.625543701081, 4166.416701661769, 4168.3955826405, 4171.97914010431, 4181.811818468176, 4877.926831097537, 4881.072596206709, 4887.340209071801, 4894.290327902434, 4899.92201715622, 3521.3485505181366, 3526.5415495985612, 3527.2416430467574, 3528.2943411317838, 3528.341679410673, 4909.3126962225315, 5055.191169412913, 5080.390353157608, 5110.361204849394, 5110.770015349318, 3575.2670702505925, 3580.1407662160896, 3581.212133330663, 3589.766665166756, 3590.551181102362, 3647.3040036382677, 3663.5970043295215, 3674.1733110050027, 3676.356637588411, 3692.9815350923072, 4013.5986401360215, 4169.958300417018, 4194.266003449384, 4196.832126714898, 4200.138971510833, 4880.755962201875, 4890.828820991248, 4891.633127515451, 4894.951050489521, 4907.656464047483, 1208.9335086570322, 1236.9628911132681, 1286.5754301080622, 1304.8434187897512, 1309.5154792726753, 876.412803421709, 899.8335307968047, 903.9864402033975, 906.3836591118103, 907.1835348186685, 4351.586599273127, 4358.694891357638, 4372.978135109304, 4376.737395756201, 4384.69307148503, 5018.623603229772, 5040.899182016339, 5050.595952323805, 5052.444231134572, 5068.771905264272, 4250.873518517596, 4410.470743510799, 4452.5547445255215, 4493.0, 4500.3123828564285, 2688.1129227354927, 2698.905538306189, 2712.1592306385082, 2716.443129158518, 2719.225020869043, 4839.322494850724, 4854.708717476963, 4881.780319885614, 4893.926591101136, 4899.314096026559, 5056.469070747518, 5192.7403629818355, 5241.633085683966, 5251.474852514718, 5254.395744489356, 4859.902801944012, 4863.878403039952, 4869.63477739171, 4882.6826256293225, 4889.584385327216, 5127.846234597335, 5132.3327967364, 5137.640365174402, 5146.919146979177, 5150.330457040561, 4786.133407970825, 4986.476419975996, 5024.120778863758, 5026.667932997685, 5027.59779217669, 4859.854204373874, 4862.878428039327, 4872.6832755870755, 4875.341828853059, 4919.385076865392, 3613.1689711367057, 3624.583172935146, 3645.3256147611714, 3647.4711166881184, 3651.507046548682, 4892.559669629751, 5078.339815823919, 5105.5149760772665, 5107.591392688651, 5127.923081153711, 4928.531789479994, 4935.087008903364, 4940.382452193476, 4942.135126352946, 4948.925766113439, 4955.1576232039915, 4956.950430495649, 4958.181899986462, 4958.950410495849, 4961.627877909099, 4638.721676699274, 4745.952540474689, 4780.95219047819, 4848.612111031039, 4875.414950205998, 4850.369451971221, 4937.0, 4943.283223932582, 4957.429895562056, 4961.561147267396, 4829.5653391194965, 4844.297576851266, 4846.491118432514, 4847.418309802846, 4849.709017458964], "value": 3733.8632519808916, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.4887396838718, 596.0433504225715, 646.4149944300408, 709.7764204275653, 754.7132089805873, 10620.362778233302, 11072.446377681114, 11394.886051139487, 11797.646070617873, 11854.466549005294, 13385.799213011813, 13396.866031339683, 13535.390907409166, 13620.72758544831, 13640.522581709618, 621.3103455164763, 761.8666733321675, 787.8660627693278, 790.115071120346, 790.6876783670447, 633.4932054356519, 776.503038055642, 786.6027656033694, 797.2306724011328, 798.8122791144076, 825.0305890578576, 825.5624519004907, 828.349745449822, 829.8008477965275, 832.267604508032, 647.6017249391638, 821.9013718353806, 826.4669288309007, 827.5283088639478, 827.8468483330573, 481.52569718826925, 592.7954855574819, 604.9516038716893, 606.0787602843697, 611.5474548833876, 11718.824217636742, 11745.647630571097, 11753.706157346049, 11758.118141139448, 11769.823452648217, 11480.311181329147, 11672.88327116735, 11836.0, 11987.280763154238, 12141.089418293663, 10721.678349649523, 10876.456177191109, 10929.234953553254, 10937.45312734368, 11269.0, 3951.802409879523, 3979.343408337621, 3979.462772525701, 4022.1955608878047, 4024.63778259958, 44218.33672494915, 44547.0, 45927.31109033367, 48397.27404088942, 50290.245646315336, 9364.531773411301, 9880.160186384093, 9908.80182396348, 9984.60061597528, 9986.251031172691, 17243.482695519153, 17385.0, 17449.21478533469, 17586.12069396525, 17806.109694515224, 6209.627422354673, 6324.778632747923, 6394.584352017104, 6531.183602049744, 6606.537542372084, 3217.501287300472, 3230.2408933900515, 3263.4452143135723, 3278.164068162603, 3510.78935263885, 2679.6516452861, 2776.1532732516775, 2786.164150754806, 2790.9860450698025, 2799.1042866283, 474.3501403077806, 484.0874950717922, 486.55723291804287, 490.82821012645286, 492.65267986069733, 489.06832484117814, 498.2280282922385, 509.4497942222391, 509.8623371689623, 519.7453247908574, 7639.465237433326, 8138.104808471064, 8179.0, 8193.918060819435, 8510.00059943651, 577.4514211499093, 583.3495652347602, 586.865021045162, 599.1402337645493, 600.3606159440183, 3786.2995345861104, 4050.5746896576024, 4102.446169767043, 4173.561776013536, 4179.435776170239, 41419.1716165675, 50852.23721644178, 65573.34426655767, 70654.2934570658, 70740.2925970744, 36820.63179368172, 37114.0, 59454.70272648609, 59495.40504594899, 61445.692771535854, 52207.47792522102, 52633.47366526362, 52662.21006684903, 53004.20493692598, 53972.0, 8094.83810323802, 8468.915310846813, 8687.522186279562, 8721.0, 8884.60019299146, 32721.0, 35465.29069418545, 36656.08359791026, 36744.265114697024, 37142.25715485729, 32473.675263247063, 33364.165895851824, 34398.14004649904, 46736.0, 48567.757161215384, 10091.798164036825, 10476.738081548023, 10527.263091583516, 10599.735006624896, 10674.412907290174, 11467.827982580102, 11835.230710003822, 11844.526218951145, 11859.229150105215, 12433.37833108359, 11401.828972565252, 11440.656780296604, 11722.94138529302, 11963.282203067844, 12065.155439119528, 10896.0, 11193.496292667012, 11224.10207183407, 11296.943515282372, 11708.88291117078, 10464.372137671764, 10468.162546996069, 10589.735256618646, 10982.231243812856, 11664.708382290171, 8710.608022639124, 9477.289203309918, 9492.098250666175, 9533.445307788383, 9542.952285238529, 9716.174125199155, 9824.164945979672, 10123.59505619767, 10145.746356341151, 10209.74475638115], "value": 5989.223448657604, "unit": "score"}], "name": "dromaeo_css", "value": 6157.952797597635, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 117.0, 116.0, 116.0, 114.0, 117.0, 116.0, 115.0, 116.0, 115.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 128.0, 128.0, 166.0, 128.0, 132.0, 128.0, 130.0, 164.0, 129.0], "value": 139.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 163.0, 160.0, 160.0, 164.0, 163.0, 163.0, 162.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 75.0, 106.0, 76.0, 78.0, 77.0, 76.0, 111.0, 78.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 119.0, 84.0, 85.0, 84.0, 109.0, 84.0, 84.0, 127.0], "value": 94.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 147.0, 148.0, 146.0, 147.0, 146.0, 147.0, 145.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 84.0, 85.0, 84.0, 85.0, 85.0, 84.0, 84.0, 85.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 65.0, 66.0, 64.0, 64.0, 64.0, 64.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 74.0, 67.0, 67.0, 67.0, 65.0, 67.0, 66.0, 67.0, 71.0], "value": 67.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 83.0, 83.0, 82.0, 83.0, 84.0, 84.0, 84.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 141.0, 140.0, 145.0, 150.0, 141.0, 146.0, 146.0, 203.0, 144.0], "value": 151.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 185.0, 177.0, 176.0, 180.0, 182.0, 179.0, 178.0, 179.0, 182.0], "value": 180.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 72.0, 71.0, 70.0, 71.0, 71.0, 72.0, 69.0, 69.0], "value": 71.1, "unit": "score"}], "name": "kraken", "value": 1562.2, "alertThreshold": 2.0}]} 00:04:42 INFO - Return code: 0 00:04:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:04:42 INFO - # TBPL SUCCESS # 00:04:42 INFO - Running post-action listener: _resource_record_post_action 00:04:42 INFO - [mozharness: 2016-10-26 07:04:42.435918Z] Finished run-tests step (success) 00:04:42 INFO - Running post-run listener: _resource_record_post_run 00:04:42 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 8192; Write bytes: 404131840; Read time: 88; Write time: 212380 00:04:42 INFO - TinderboxPrint: CPU usage
13.0% 00:04:42 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 88 00:04:42 INFO - TinderboxPrint: I/O write bytes / time
404,131,840 / 212,380 00:04:42 INFO - TinderboxPrint: CPU idle
8,353.8 (87.0%) 00:04:42 INFO - TinderboxPrint: CPU user
1,203.9 (12.5%) 00:04:42 INFO - TinderboxPrint: Swap in / out
0 / 0 00:04:42 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99913728; Read time: 0; Write time: 70252 00:04:42 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292913152; Read time: 72; Write time: 140308 00:04:43 INFO - Running post-run listener: _upload_blobber_files 00:04:43 INFO - Blob upload gear active. 00:04:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:04:43 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 00:04:43 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:04:43 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:04:43 INFO - (blobuploader) - INFO - Open directory for files ... 00:04:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:04:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:04:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:04:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:04:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:04:44 INFO - (blobuploader) - INFO - Done attempting. 00:04:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:04:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:04:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:04:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:04:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:04:49 INFO - (blobuploader) - INFO - Done attempting. 00:04:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:04:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:04:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:04:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:04:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:04:50 INFO - (blobuploader) - INFO - Done attempting. 00:04:50 INFO - (blobuploader) - INFO - Iteration through files over. 00:04:50 INFO - Return code: 0 00:04:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:04:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:04:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aa7752767178b770d82369750282f9eb7d262b9d29f250621b449774fe9b85ca41f859b31362aa51c20df053a313f31292e6c62e9e41c228e72aafa179264e47", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f0da09cc05c5ed26cd22f23dfae3bbf9fff35f3748d23f7e4117c8e0dbf846901da95978a9c3469ec46ebc2804eb9e2bb126c678ac5178bf78e6e45adb3580d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1df816c6fdceb2a8d8d55e16316ead99e619e0f2473dcaff7f977e0c7a946e7da7d45238a0be7177b083e378b637d2035a7eef34ed4705a5685012a65fa7e7ca"} 00:04:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:04:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:04:50 INFO - Contents: 00:04:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aa7752767178b770d82369750282f9eb7d262b9d29f250621b449774fe9b85ca41f859b31362aa51c20df053a313f31292e6c62e9e41c228e72aafa179264e47", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f0da09cc05c5ed26cd22f23dfae3bbf9fff35f3748d23f7e4117c8e0dbf846901da95978a9c3469ec46ebc2804eb9e2bb126c678ac5178bf78e6e45adb3580d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1df816c6fdceb2a8d8d55e16316ead99e619e0f2473dcaff7f977e0c7a946e7da7d45238a0be7177b083e378b637d2035a7eef34ed4705a5685012a65fa7e7ca"} 00:04:50 INFO - Running post-run listener: copy_logs_to_upload_dir 00:04:50 INFO - Copying logs to upload dir... 00:04:50 INFO - mkdir: /builds/slave/test/build/upload/logs 00:04:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.228994 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-10-26 00:04:49.958909) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 00:04:49.962898) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1477463450.445442-788762110 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-Non-PGO/sha512/aa7752767178b770d82369750282f9eb7d262b9d29f250621b449774fe9b85ca41f859b31362aa51c20df053a313f31292e6c62e9e41c228e72aafa179264e47", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f0da09cc05c5ed26cd22f23dfae3bbf9fff35f3748d23f7e4117c8e0dbf846901da95978a9c3469ec46ebc2804eb9e2bb126c678ac5178bf78e6e45adb3580d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1df816c6fdceb2a8d8d55e16316ead99e619e0f2473dcaff7f977e0c7a946e7da7d45238a0be7177b083e378b637d2035a7eef34ed4705a5685012a65fa7e7ca"} build_url:https://queue.taskcluster.net/v1/task/UKkR3Ji_SFC7cyd_QxMHIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011302 build_url: 'https://queue.taskcluster.net/v1/task/UKkR3Ji_SFC7cyd_QxMHIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aa7752767178b770d82369750282f9eb7d262b9d29f250621b449774fe9b85ca41f859b31362aa51c20df053a313f31292e6c62e9e41c228e72aafa179264e47", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f0da09cc05c5ed26cd22f23dfae3bbf9fff35f3748d23f7e4117c8e0dbf846901da95978a9c3469ec46ebc2804eb9e2bb126c678ac5178bf78e6e45adb3580d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1df816c6fdceb2a8d8d55e16316ead99e619e0f2473dcaff7f977e0c7a946e7da7d45238a0be7177b083e378b637d2035a7eef34ed4705a5685012a65fa7e7ca"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 00:04:49.988282) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 00:04:49.988623) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1477463450.445442-788762110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004576 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 00:04:50.070296) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 00:04:50.070625) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 00:04:50.070926) ========= ========= Total master_lag: 0.17 =========