builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-046 starttime: 1476850440.75 results: success (0) buildid: 20161018195923 builduid: 3526de9da3f441f2bf1608e295abe08f revision: f52b380bc02e1022631ab8dcd43ed246930974c3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-18 21:14:00.755204) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-18 21:14:00.757477) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-18 21:14:00.760811) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-18 21:14:00.780589) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 21:14:00.780997) ========= 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=652eb03db935cfc1c15ebda0000001ad-1476849198.497072-2087272351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-18 21:14:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-10-18 21:14:00 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122250 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 21:14:00.916721) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 21:14:00.917027) ========= 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=652eb03db935cfc1c15ebda0000001ad-1476849198.497072-2087272351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020449 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 21:14:00.966435) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-18 21:14:00.966821) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f52b380bc02e1022631ab8dcd43ed246930974c3 --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 f52b380bc02e1022631ab8dcd43ed246930974c3 --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=652eb03db935cfc1c15ebda0000001ad-1476849198.497072-2087272351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-18 21:14:01,028 truncating revision to first 12 chars 2016-10-18 21:14:01,028 Setting DEBUG logging. 2016-10-18 21:14:01,029 attempt 1/10 2016-10-18 21:14:01,029 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f52b380bc02e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-18 21:14:02,215 unpacking tar archive at: fx-team-f52b380bc02e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.497768 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-18 21:14:02.478846) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-18 21:14:02.479273) ========= script_repo_revision: f52b380bc02e1022631ab8dcd43ed246930974c3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-18 21:14:02.479811) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-18 21:14:02.480172) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-18 21:14:02.490165) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-18 21:14:02.490433) ========= /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=652eb03db935cfc1c15ebda0000001ad-1476849198.497072-2087272351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:14:02 INFO - MultiFileLogger online at 20161018 21:14:02 in /builds/slave/test 21:14:02 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 21:14:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:14:02 INFO - {'append_to_log': False, 21:14:02 INFO - 'base_work_dir': '/builds/slave/test', 21:14:02 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 21:14:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:14:02 INFO - 'branch': 'Fx-Team-Non-PGO', 21:14:02 INFO - 'buildbot_json_path': 'buildprops.json', 21:14:02 INFO - 'config_files': ('talos/linux_config.py',), 21:14:02 INFO - 'default_actions': ('clobber', 21:14:02 INFO - 'read-buildbot-config', 21:14:02 INFO - 'download-and-extract', 21:14:02 INFO - 'populate-webroot', 21:14:02 INFO - 'create-virtualenv', 21:14:02 INFO - 'install', 21:14:02 INFO - 'run-tests'), 21:14:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:14:02 INFO - 'download_minidump_stackwalk': True, 21:14:02 INFO - 'download_symbols': 'ondemand', 21:14:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:14:02 INFO - 'tooltool.py': '/tools/tooltool.py', 21:14:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:14:02 INFO - '/tools/misc-python/virtualenv.py')}, 21:14:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:14:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:14:02 INFO - 'installer_path': 'installer.exe', 21:14:02 INFO - 'log_level': 'info', 21:14:02 INFO - 'log_name': 'talos', 21:14:02 INFO - 'log_to_console': True, 21:14:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:14:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:14:02 INFO - 'opt_config_files': (), 21:14:02 INFO - 'pip_index': False, 21:14:02 INFO - 'sps_profile': False, 21:14:02 INFO - 'sps_profile_interval': 0, 21:14:02 INFO - 'suite': 'dromaeojs', 21:14:02 INFO - 'system_bits': '32', 21:14:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:14:02 INFO - 'title': 'talos-linux64-ix-046', 21:14:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:14:02 INFO - 'use_talos_json': True, 21:14:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:14:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:14:02 INFO - 'work_dir': 'build'} 21:14:02 INFO - [mozharness: 2016-10-19 04:14:02.648957Z] Running clobber step. 21:14:02 INFO - Running pre-action listener: _resource_record_pre_action 21:14:02 INFO - Running main action method: clobber 21:14:02 INFO - rmtree: /builds/slave/test/build 21:14:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:14:03 INFO - Running post-action listener: _resource_record_post_action 21:14:03 INFO - [mozharness: 2016-10-19 04:14:03.101157Z] Finished clobber step (success) 21:14:03 INFO - [mozharness: 2016-10-19 04:14:03.101258Z] Running read-buildbot-config step. 21:14:03 INFO - Running pre-action listener: _resource_record_pre_action 21:14:03 INFO - Running main action method: read_buildbot_config 21:14:03 INFO - Using buildbot properties: 21:14:03 INFO - { 21:14:03 INFO - "project": "", 21:14:03 INFO - "product": "firefox", 21:14:03 INFO - "script_repo_revision": "production", 21:14:03 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 21:14:03 INFO - "repository": "", 21:14:03 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 21:14:03 INFO - "buildid": "20161018195923", 21:14:03 INFO - "pgo_build": "False", 21:14:03 INFO - "basedir": "/builds/slave/test", 21:14:03 INFO - "buildnumber": 1980, 21:14:03 INFO - "slavename": "talos-linux64-ix-046", 21:14:03 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:14:03 INFO - "platform": "ubuntu64_hw", 21:14:03 INFO - "scheduler": "tests-fx-team-linux64-talos", 21:14:03 INFO - "branch": "fx-team", 21:14:03 INFO - "repo_path": "integration/fx-team", 21:14:03 INFO - "revision": "f52b380bc02e1022631ab8dcd43ed246930974c3", 21:14:03 INFO - "stage_platform": "linux64", 21:14:03 INFO - "builduid": "3526de9da3f441f2bf1608e295abe08f", 21:14:03 INFO - "slavebuilddir": "test" 21:14:03 INFO - } 21:14:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/aLUBWTcIRsKhL-YTEbjDzQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 21:14:03 INFO - Running post-action listener: _resource_record_post_action 21:14:03 INFO - [mozharness: 2016-10-19 04:14:03.103731Z] Finished read-buildbot-config step (success) 21:14:03 INFO - [mozharness: 2016-10-19 04:14:03.103818Z] Running download-and-extract step. 21:14:03 INFO - Running pre-action listener: _resource_record_pre_action 21:14:03 INFO - Running main action method: download_and_extract 21:14:03 INFO - mkdir: /builds/slave/test/build/tests 21:14:03 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')]} 21:14:03 INFO - trying https://queue.taskcluster.net/v1/task/aLUBWTcIRsKhL-YTEbjDzQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:14:03 INFO - Downloading https://queue.taskcluster.net/v1/task/aLUBWTcIRsKhL-YTEbjDzQ/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 21:14:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aLUBWTcIRsKhL-YTEbjDzQ/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 21:14:03 INFO - Downloaded 1361 bytes. 21:14:03 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:14:03 INFO - Using the following test package requirements: 21:14:03 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:14:03 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:14:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:14:03 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:14:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:14:03 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:14:03 INFO - u'jsshell-linux-x86_64.zip'], 21:14:03 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:14:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:14:03 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:14:03 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:14:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:14:03 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:14:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:14:03 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:14:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:14:03 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:14:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:14:03 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:14:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aLUBWTcIRsKhL-YTEbjDzQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:14:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aLUBWTcIRsKhL-YTEbjDzQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:14:03 INFO - Fetch https://queue.taskcluster.net/v1/task/aLUBWTcIRsKhL-YTEbjDzQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:14:04 INFO - Http code: 200 21:14:04 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 21:14:04 INFO - x-amz-cf-id: WpG0_pJGb8Axfk7kenxJJyt-JDLTNuQghktBn_S6hAI7kOa4r4AuNQ== 21:14:04 INFO - x-amz-version-id: IsyORyGNWwjbAuKo3_0CJUh94VFpCn5x 21:14:04 INFO - Expected file size: 20542178 21:14:04 INFO - Obtained file size: 20542178 21:14:08 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 21:14:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aLUBWTcIRsKhL-YTEbjDzQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:14:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aLUBWTcIRsKhL-YTEbjDzQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:14:08 INFO - Fetch https://queue.taskcluster.net/v1/task/aLUBWTcIRsKhL-YTEbjDzQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:14:09 INFO - Http code: 200 21:14:09 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 21:14:09 INFO - x-amz-cf-id: 9w5UXxw2wKRcVk4zn7f8DrgNix_mbXUE4RHodz184R0tEGdpRyC1Rg== 21:14:09 INFO - x-amz-version-id: IsyORyGNWwjbAuKo3_0CJUh94VFpCn5x 21:14:09 INFO - Expected file size: 20542178 21:14:09 INFO - Obtained file size: 20542178 21:14:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aLUBWTcIRsKhL-YTEbjDzQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 21:14:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aLUBWTcIRsKhL-YTEbjDzQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:14:13 INFO - Fetch https://queue.taskcluster.net/v1/task/aLUBWTcIRsKhL-YTEbjDzQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 21:14:14 INFO - Http code: 200 21:14:14 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 21:14:14 INFO - x-amz-cf-id: xEDpd1lRk5AR_8XQuXEa9y5ja5qgFMXsXMB2_CnNTo1-pmeOC952ig== 21:14:14 INFO - x-amz-version-id: l6VCPnijHsPdjPGLPReVJlS28Yr4cNrs 21:14:14 INFO - Expected file size: 14409028 21:14:14 INFO - Obtained file size: 14409028 21:14:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:15 INFO - trying https://queue.taskcluster.net/v1/task/aLUBWTcIRsKhL-YTEbjDzQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:14:15 INFO - Downloading https://queue.taskcluster.net/v1/task/aLUBWTcIRsKhL-YTEbjDzQ/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 21:14:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aLUBWTcIRsKhL-YTEbjDzQ/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 21:14:16 INFO - Downloaded 55596490 bytes. 21:14:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aLUBWTcIRsKhL-YTEbjDzQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:14:16 INFO - mkdir: /builds/slave/test/properties 21:14:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:14:16 INFO - Writing to file /builds/slave/test/properties/build_url 21:14:16 INFO - Contents: 21:14:16 INFO - build_url:https://queue.taskcluster.net/v1/task/aLUBWTcIRsKhL-YTEbjDzQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:14:16 INFO - Running post-action listener: _resource_record_post_action 21:14:16 INFO - Running post-action listener: set_extra_try_arguments 21:14:16 INFO - [mozharness: 2016-10-19 04:14:16.742221Z] Finished download-and-extract step (success) 21:14:16 INFO - [mozharness: 2016-10-19 04:14:16.742447Z] Running populate-webroot step. 21:14:16 INFO - Running pre-action listener: _resource_record_pre_action 21:14:16 INFO - Running main action method: populate_webroot 21:14:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:14:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:14:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:14:16 INFO - '--tppagecycles', 21:14:16 INFO - '7'], 21:14:16 INFO - 'tests': ['tsvgm']}}, 21:14:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:14:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:14:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:14:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:14:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:14:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:14:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:14:16 INFO - 'talos_options': ['--disable-e10s'], 21:14:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:14:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:14:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:14:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:14:16 INFO - 'talos_options': ['--disable-e10s'], 21:14:16 INFO - 'tests': ['damp', 'tps']}, 21:14:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:14:16 INFO - 'tests': ['damp', 'tps']}, 21:14:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:14:16 INFO - 'tests': ['dromaeo_dom']}, 21:14:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:14:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:14:16 INFO - 'tests': ['basic_compositor_video']}, 21:14:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:14:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:14:16 INFO - 'tests': ['a11yr', 21:14:16 INFO - 'ts_paint', 21:14:16 INFO - 'tpaint', 21:14:16 INFO - 'sessionrestore', 21:14:16 INFO - 'sessionrestore_no_auto_restore', 21:14:16 INFO - 'tabpaint']}, 21:14:16 INFO - 'other-e10s': {'tests': ['a11yr', 21:14:16 INFO - 'ts_paint', 21:14:16 INFO - 'tpaint', 21:14:16 INFO - 'sessionrestore', 21:14:16 INFO - 'sessionrestore_no_auto_restore', 21:14:16 INFO - 'tabpaint']}, 21:14:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:14:16 INFO - 'ts_paint', 21:14:16 INFO - 'tpaint', 21:14:16 INFO - 'sessionrestore', 21:14:16 INFO - 'sessionrestore_no_auto_restore', 21:14:16 INFO - 'tabpaint']}, 21:14:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:14:16 INFO - 'ts_paint', 21:14:16 INFO - 'tpaint', 21:14:16 INFO - 'sessionrestore', 21:14:16 INFO - 'sessionrestore_no_auto_restore', 21:14:16 INFO - 'tabpaint']}, 21:14:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:14:16 INFO - 'tests': ['a11yr', 21:14:16 INFO - 'ts_paint', 21:14:16 INFO - 'tpaint', 21:14:16 INFO - 'sessionrestore', 21:14:16 INFO - 'sessionrestore_no_auto_restore', 21:14:16 INFO - 'tabpaint']}, 21:14:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:14:16 INFO - 'tests': ['a11yr', 21:14:16 INFO - 'ts_paint', 21:14:16 INFO - 'tpaint', 21:14:16 INFO - 'sessionrestore', 21:14:16 INFO - 'sessionrestore_no_auto_restore', 21:14:16 INFO - 'tabpaint']}, 21:14:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:14:16 INFO - 'tests': ['tsvgx', 21:14:16 INFO - 'tsvgr_opacity', 21:14:16 INFO - 'tart', 21:14:16 INFO - 'tscrollx', 21:14:16 INFO - 'cart']}, 21:14:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:14:16 INFO - 'tsvgr_opacity', 21:14:16 INFO - 'tart', 21:14:16 INFO - 'tscrollx', 21:14:16 INFO - 'cart']}, 21:14:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:14:16 INFO - 'talos_options': ['--disable-e10s'], 21:14:16 INFO - 'tests': ['tp5o']}, 21:14:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:14:16 INFO - 'tests': ['tp5o']}, 21:14:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:14:16 INFO - 'talos_options': ['--disable-e10s', 21:14:16 INFO - '--xperf_path', 21:14:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:14:16 INFO - 'tests': ['tp5n']}, 21:14:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:14:16 INFO - 'talos_options': ['--xperf_path', 21:14:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:14:16 INFO - 'tests': ['tp5n']}}, 21:14:16 INFO - 'talos.zip': {'path': '', 21:14:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:14:16 INFO - Running post-action listener: _resource_record_post_action 21:14:16 INFO - [mozharness: 2016-10-19 04:14:16.757676Z] Finished populate-webroot step (success) 21:14:16 INFO - [mozharness: 2016-10-19 04:14:16.757764Z] Running create-virtualenv step. 21:14:16 INFO - Running pre-action listener: _resource_record_pre_action 21:14:16 INFO - Running main action method: create_virtualenv 21:14:16 INFO - Creating virtualenv /builds/slave/test/build/venv 21:14: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 21:14:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:14:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:14:16 INFO - Using real prefix '/usr' 21:14:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:14:17 INFO - Installing distribute.............................................................................................................................................................................................done. 21:14:19 INFO - Installing pip.................done. 21:14:19 INFO - Return code: 0 21:14:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:14:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:14:19 INFO - Reading from file tmpfile_stdout 21:14:19 INFO - Output received: 21:14:19 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) 21:14:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:14: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')]} 21:14:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14: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')]} 21:14:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f02afc2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29e5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e2f60>, '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 0x29e3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e41d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1476849198.497072-2087272351', '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 21:14: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', 'pip>=1.5'] in /builds/slave/test/build 21:14: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 pip>=1.5 21:14:19 INFO - Using env: {'DISPLAY': ':0', 21:14:19 INFO - 'HOME': '/home/cltbld', 21:14:19 INFO - 'LANG': 'en_US.UTF-8', 21:14:19 INFO - 'LANGUAGE': 'en_US:en', 21:14:19 INFO - 'LOGNAME': 'cltbld', 21:14:19 INFO - 'MAIL': '/var/mail/cltbld', 21:14:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:19 INFO - 'MOZ_NO_REMOTE': '1', 21:14:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:14:19 INFO - 'NO_EM_RESTART': '1', 21:14:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:14:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:19 INFO - 'PWD': '/builds/slave/test', 21:14:19 INFO - 'SHELL': '/bin/bash', 21:14:19 INFO - 'SHLVL': '1', 21:14:19 INFO - 'TERM': 'linux', 21:14:19 INFO - 'TMOUT': '86400', 21:14:19 INFO - 'USER': 'cltbld', 21:14:19 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1476849198.497072-2087272351', 21:14:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:19 INFO - '_': '/tools/buildbot/bin/python'} 21:14:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14: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 21:14:19 INFO - Cleaning up... 21:14:19 INFO - Return code: 0 21:14:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:14: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')]} 21:14:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14: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')]} 21:14:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14: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 0x7f02afc2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29e5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e2f60>, '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 0x29e3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e41d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1476849198.497072-2087272351', '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 21:14: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 21:14: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 21:14:19 INFO - Using env: {'DISPLAY': ':0', 21:14:19 INFO - 'HOME': '/home/cltbld', 21:14:19 INFO - 'LANG': 'en_US.UTF-8', 21:14:19 INFO - 'LANGUAGE': 'en_US:en', 21:14:19 INFO - 'LOGNAME': 'cltbld', 21:14:19 INFO - 'MAIL': '/var/mail/cltbld', 21:14:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:19 INFO - 'MOZ_NO_REMOTE': '1', 21:14:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:14:19 INFO - 'NO_EM_RESTART': '1', 21:14:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:14:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:19 INFO - 'PWD': '/builds/slave/test', 21:14:19 INFO - 'SHELL': '/bin/bash', 21:14:19 INFO - 'SHLVL': '1', 21:14:19 INFO - 'TERM': 'linux', 21:14:19 INFO - 'TMOUT': '86400', 21:14:19 INFO - 'USER': 'cltbld', 21:14:19 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1476849198.497072-2087272351', 21:14:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:19 INFO - '_': '/tools/buildbot/bin/python'} 21:14:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:19 INFO - Downloading/unpacking psutil>=3.1.1 21:14: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 21:14: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 21:14: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 21:14: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 21:14: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 21:14: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 21:14:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:14:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:14:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:14:22 INFO - Installing collected packages: psutil 21:14:22 INFO - Running setup.py install for psutil 21:14:22 INFO - building 'psutil._psutil_linux' extension 21:14:22 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 21:14:22 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 21:14:22 INFO - building 'psutil._psutil_posix' extension 21:14:22 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 21:14:22 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 21:14:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:14:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:14:22 INFO - Successfully installed psutil 21:14:22 INFO - Cleaning up... 21:14:22 INFO - Return code: 0 21:14:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:14:22 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')]} 21:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:22 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')]} 21:14:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:22 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 0x7f02afc2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29e5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e2f60>, '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 0x29e3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e41d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1476849198.497072-2087272351', '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 21:14:22 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 21:14:22 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 21:14:22 INFO - Using env: {'DISPLAY': ':0', 21:14:22 INFO - 'HOME': '/home/cltbld', 21:14:22 INFO - 'LANG': 'en_US.UTF-8', 21:14:22 INFO - 'LANGUAGE': 'en_US:en', 21:14:22 INFO - 'LOGNAME': 'cltbld', 21:14:22 INFO - 'MAIL': '/var/mail/cltbld', 21:14:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:22 INFO - 'MOZ_NO_REMOTE': '1', 21:14:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:14:22 INFO - 'NO_EM_RESTART': '1', 21:14:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:14:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:22 INFO - 'PWD': '/builds/slave/test', 21:14:22 INFO - 'SHELL': '/bin/bash', 21:14:22 INFO - 'SHLVL': '1', 21:14:22 INFO - 'TERM': 'linux', 21:14:22 INFO - 'TMOUT': '86400', 21:14:22 INFO - 'USER': 'cltbld', 21:14:22 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1476849198.497072-2087272351', 21:14:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:22 INFO - '_': '/tools/buildbot/bin/python'} 21:14:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:14: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 21:14: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 21:14: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 21:14: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 21:14: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 21:14: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 21:14:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:14:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:14:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:14:24 INFO - Installing collected packages: mozsystemmonitor 21:14:24 INFO - Running setup.py install for mozsystemmonitor 21:14:24 INFO - Successfully installed mozsystemmonitor 21:14:24 INFO - Cleaning up... 21:14:24 INFO - Return code: 0 21:14:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:14: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')]} 21:14:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14: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')]} 21:14:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14: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 0x7f02afc2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29e5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e2f60>, '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 0x29e3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e41d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1476849198.497072-2087272351', '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 21:14: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 21:14: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 21:14:24 INFO - Using env: {'DISPLAY': ':0', 21:14:24 INFO - 'HOME': '/home/cltbld', 21:14:24 INFO - 'LANG': 'en_US.UTF-8', 21:14:24 INFO - 'LANGUAGE': 'en_US:en', 21:14:24 INFO - 'LOGNAME': 'cltbld', 21:14:24 INFO - 'MAIL': '/var/mail/cltbld', 21:14:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:24 INFO - 'MOZ_NO_REMOTE': '1', 21:14:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:14:24 INFO - 'NO_EM_RESTART': '1', 21:14:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:14:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:24 INFO - 'PWD': '/builds/slave/test', 21:14:24 INFO - 'SHELL': '/bin/bash', 21:14:24 INFO - 'SHLVL': '1', 21:14:24 INFO - 'TERM': 'linux', 21:14:24 INFO - 'TMOUT': '86400', 21:14:24 INFO - 'USER': 'cltbld', 21:14:24 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1476849198.497072-2087272351', 21:14:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:24 INFO - '_': '/tools/buildbot/bin/python'} 21:14:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:25 INFO - Downloading/unpacking jsonschema==2.5.1 21:14:25 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 21:14:25 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 21:14:25 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 21:14:25 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 21:14:25 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 21:14:25 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 21:14:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:14:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:14: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 21:14: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 21:14: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 21:14: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 21:14: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 21:14: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 21:14:27 INFO - Downloading functools32-3.2.3-2.tar.gz 21:14:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:14:27 INFO - warning: no files found matching '*.txt' 21:14:27 INFO - no previously-included directories found matching 'build' 21:14:27 INFO - no previously-included directories found matching 'dist' 21:14:27 INFO - no previously-included directories found matching '.git*' 21:14:27 INFO - Installing collected packages: jsonschema, functools32 21:14:27 INFO - Running setup.py install for functools32 21:14:27 INFO - warning: no files found matching '*.txt' 21:14:27 INFO - no previously-included directories found matching 'build' 21:14:27 INFO - no previously-included directories found matching 'dist' 21:14:27 INFO - no previously-included directories found matching '.git*' 21:14:27 INFO - Successfully installed jsonschema functools32 21:14:27 INFO - Cleaning up... 21:14:27 INFO - Return code: 0 21:14:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:14: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')]} 21:14:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14: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')]} 21:14:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14: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', '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 0x7f02afc2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29e5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e2f60>, '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 0x29e3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e41d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1476849198.497072-2087272351', '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 21:14: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:14: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 functools32==3.2.3-2 21:14:27 INFO - Using env: {'DISPLAY': ':0', 21:14:27 INFO - 'HOME': '/home/cltbld', 21:14:27 INFO - 'LANG': 'en_US.UTF-8', 21:14:27 INFO - 'LANGUAGE': 'en_US:en', 21:14:27 INFO - 'LOGNAME': 'cltbld', 21:14:27 INFO - 'MAIL': '/var/mail/cltbld', 21:14:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:27 INFO - 'MOZ_NO_REMOTE': '1', 21:14:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:14:27 INFO - 'NO_EM_RESTART': '1', 21:14:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:14:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:27 INFO - 'PWD': '/builds/slave/test', 21:14:27 INFO - 'SHELL': '/bin/bash', 21:14:27 INFO - 'SHLVL': '1', 21:14:27 INFO - 'TERM': 'linux', 21:14:27 INFO - 'TMOUT': '86400', 21:14:27 INFO - 'USER': 'cltbld', 21:14:27 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1476849198.497072-2087272351', 21:14:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:27 INFO - '_': '/tools/buildbot/bin/python'} 21:14:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:14:27 INFO - Cleaning up... 21:14:27 INFO - Return code: 0 21:14:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:14: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')]} 21:14:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14: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')]} 21:14:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14: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 0x7f02afc2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29e5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e2f60>, '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 0x29e3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e41d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1476849198.497072-2087272351', '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 21:14: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 21:14: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 21:14:27 INFO - Using env: {'DISPLAY': ':0', 21:14:27 INFO - 'HOME': '/home/cltbld', 21:14:27 INFO - 'LANG': 'en_US.UTF-8', 21:14:27 INFO - 'LANGUAGE': 'en_US:en', 21:14:27 INFO - 'LOGNAME': 'cltbld', 21:14:27 INFO - 'MAIL': '/var/mail/cltbld', 21:14:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:27 INFO - 'MOZ_NO_REMOTE': '1', 21:14:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:14:27 INFO - 'NO_EM_RESTART': '1', 21:14:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:14:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:27 INFO - 'PWD': '/builds/slave/test', 21:14:27 INFO - 'SHELL': '/bin/bash', 21:14:27 INFO - 'SHLVL': '1', 21:14:27 INFO - 'TERM': 'linux', 21:14:27 INFO - 'TMOUT': '86400', 21:14:27 INFO - 'USER': 'cltbld', 21:14:27 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1476849198.497072-2087272351', 21:14:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:27 INFO - '_': '/tools/buildbot/bin/python'} 21:14:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:27 INFO - Downloading/unpacking blobuploader==1.2.4 21:14: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 21:14: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 21:14: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 21:14: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 21:14: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 21:14: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 21:14:29 INFO - Downloading blobuploader-1.2.4.tar.gz 21:14:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:14:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:14: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 21:14: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 21:14: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 21:14: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 21:14: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 21:14: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 21:14:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:14:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:14:30 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 21:14:30 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 21:14:30 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 21:14:30 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 21:14:30 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 21:14:30 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 21:14:30 INFO - Downloading docopt-0.6.1.tar.gz 21:14:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:14:30 INFO - Installing collected packages: blobuploader, requests, docopt 21:14:30 INFO - Running setup.py install for blobuploader 21:14:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:14:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:14:30 INFO - Running setup.py install for requests 21:14:31 INFO - Running setup.py install for docopt 21:14:31 INFO - Successfully installed blobuploader requests docopt 21:14:31 INFO - Cleaning up... 21:14:31 INFO - Return code: 0 21:14:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:31 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 0x7f02afc2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29e5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e2f60>, '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 0x29e3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e41d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1476849198.497072-2087272351', '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 21:14:31 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 21:14:31 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 21:14:31 INFO - Using env: {'DISPLAY': ':0', 21:14:31 INFO - 'HOME': '/home/cltbld', 21:14:31 INFO - 'LANG': 'en_US.UTF-8', 21:14:31 INFO - 'LANGUAGE': 'en_US:en', 21:14:31 INFO - 'LOGNAME': 'cltbld', 21:14:31 INFO - 'MAIL': '/var/mail/cltbld', 21:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:31 INFO - 'MOZ_NO_REMOTE': '1', 21:14:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:14:31 INFO - 'NO_EM_RESTART': '1', 21:14:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:31 INFO - 'PWD': '/builds/slave/test', 21:14:31 INFO - 'SHELL': '/bin/bash', 21:14:31 INFO - 'SHLVL': '1', 21:14:31 INFO - 'TERM': 'linux', 21:14:31 INFO - 'TMOUT': '86400', 21:14:31 INFO - 'USER': 'cltbld', 21:14:31 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1476849198.497072-2087272351', 21:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:31 INFO - '_': '/tools/buildbot/bin/python'} 21:14:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:14:31 INFO - Running setup.py (path:/tmp/pip-ArV0NS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:14:31 INFO - Running setup.py (path:/tmp/pip-YrVDkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:14:31 INFO - Running setup.py (path:/tmp/pip-35hDei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:14:31 INFO - Running setup.py (path:/tmp/pip-lRLIql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:14:31 INFO - Running setup.py (path:/tmp/pip-lRbSvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:14:31 INFO - Running setup.py (path:/tmp/pip-o5j6Er-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:14:31 INFO - Running setup.py (path:/tmp/pip-CFF59m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:14:32 INFO - Running setup.py (path:/tmp/pip-LijSHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:14:32 INFO - Running setup.py (path:/tmp/pip-6_Iuxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:14:32 INFO - Running setup.py (path:/tmp/pip-DcSNlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:14:32 INFO - Running setup.py (path:/tmp/pip-vJzYOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:14:32 INFO - Running setup.py (path:/tmp/pip-ByXmid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:14:32 INFO - Running setup.py (path:/tmp/pip-ZdiiUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:14:32 INFO - Running setup.py (path:/tmp/pip-YSlenM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:14:32 INFO - Running setup.py (path:/tmp/pip-kEndYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:14:32 INFO - Running setup.py (path:/tmp/pip-_68DfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:14:32 INFO - Running setup.py (path:/tmp/pip-21ueK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:14:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:14:32 INFO - Running setup.py install for manifestparser 21:14:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:14:32 INFO - Running setup.py install for mozcrash 21:14:32 INFO - Running setup.py install for mozdebug 21:14:33 INFO - Running setup.py install for mozdevice 21:14:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:14:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:14:33 INFO - Running setup.py install for mozfile 21:14:33 INFO - Running setup.py install for mozhttpd 21:14:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:14:33 INFO - Running setup.py install for mozinfo 21:14:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:14:33 INFO - Running setup.py install for mozInstall 21:14:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:14:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:14:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:14:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:14:33 INFO - Running setup.py install for mozleak 21:14:33 INFO - Running setup.py install for mozlog 21:14:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:14:33 INFO - Running setup.py install for moznetwork 21:14:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:14:33 INFO - Running setup.py install for mozprocess 21:14:33 INFO - Running setup.py install for mozprofile 21:14:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:14:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:14:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:14:34 INFO - Running setup.py install for mozrunner 21:14:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:14:34 INFO - Running setup.py install for mozscreenshot 21:14:34 INFO - Running setup.py install for moztest 21:14:34 INFO - Running setup.py install for mozversion 21:14:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:14:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:14:34 INFO - Cleaning up... 21:14:34 INFO - Return code: 0 21:14:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:34 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 0x7f02afc2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29e5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e2f60>, '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 0x29e3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e41d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1476849198.497072-2087272351', '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 21:14:34 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 21:14:34 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 21:14:34 INFO - Using env: {'DISPLAY': ':0', 21:14:34 INFO - 'HOME': '/home/cltbld', 21:14:34 INFO - 'LANG': 'en_US.UTF-8', 21:14:34 INFO - 'LANGUAGE': 'en_US:en', 21:14:34 INFO - 'LOGNAME': 'cltbld', 21:14:34 INFO - 'MAIL': '/var/mail/cltbld', 21:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:34 INFO - 'MOZ_NO_REMOTE': '1', 21:14:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:14:34 INFO - 'NO_EM_RESTART': '1', 21:14:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:34 INFO - 'PWD': '/builds/slave/test', 21:14:34 INFO - 'SHELL': '/bin/bash', 21:14:34 INFO - 'SHLVL': '1', 21:14:34 INFO - 'TERM': 'linux', 21:14:34 INFO - 'TMOUT': '86400', 21:14:34 INFO - 'USER': 'cltbld', 21:14:34 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1476849198.497072-2087272351', 21:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:34 INFO - '_': '/tools/buildbot/bin/python'} 21:14:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:14:34 INFO - Running setup.py (path:/tmp/pip-fwgi8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:14: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)) 21:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:14:34 INFO - Running setup.py (path:/tmp/pip-thLKZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:14: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)) 21:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:14:34 INFO - Running setup.py (path:/tmp/pip-mUMVac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:14: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)) 21:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:14:34 INFO - Running setup.py (path:/tmp/pip-b0rom6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:14:35 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)) 21:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:14:35 INFO - Running setup.py (path:/tmp/pip-cEQSxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:14:35 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)) 21:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:14:35 INFO - Running setup.py (path:/tmp/pip-yvkPgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:14:35 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)) 21:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:14:35 INFO - Running setup.py (path:/tmp/pip-iL6Vce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:14:35 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)) 21:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:14:35 INFO - Running setup.py (path:/tmp/pip-1b8kuu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:14:35 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)) 21:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:14:35 INFO - Running setup.py (path:/tmp/pip-QolU9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:14:35 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)) 21:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:14:35 INFO - Running setup.py (path:/tmp/pip-ZJ_xN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:14:35 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)) 21:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:14:35 INFO - Running setup.py (path:/tmp/pip-MGOXwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:14:35 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)) 21:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:14:35 INFO - Running setup.py (path:/tmp/pip-gaVpgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:14:35 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)) 21:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:14:35 INFO - Running setup.py (path:/tmp/pip-ztcdlB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:14: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)) 21:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:14:35 INFO - Running setup.py (path:/tmp/pip-cFqifp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:14: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)) 21:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:14:35 INFO - Running setup.py (path:/tmp/pip-vJ9Ei1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:14: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)) 21:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:14:35 INFO - Running setup.py (path:/tmp/pip-GOrBP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:14: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)) 21:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:14:35 INFO - Running setup.py (path:/tmp/pip-_z_FPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:14: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)) 21:14: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)) 21:14: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)) 21:14: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)) 21:14: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)) 21:14: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)) 21:14:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:14:36 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 21:14:36 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 21:14:36 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 21:14:36 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 21:14:36 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 21:14:36 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 21:14:37 INFO - Downloading blessings-1.6.tar.gz 21:14:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:14:38 INFO - Installing collected packages: blessings 21:14:38 INFO - Running setup.py install for blessings 21:14:38 INFO - Successfully installed blessings 21:14:38 INFO - Cleaning up... 21:14:38 INFO - Return code: 0 21:14:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:14:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:14:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:14:38 INFO - Reading from file tmpfile_stdout 21:14:38 INFO - Current package versions: 21:14:38 INFO - argparse == 1.2.1 21:14:38 INFO - blessings == 1.6 21:14:38 INFO - blobuploader == 1.2.4 21:14:38 INFO - docopt == 0.6.1 21:14:38 INFO - functools32 == 3.2.3-2 21:14:38 INFO - jsonschema == 2.5.1 21:14:38 INFO - manifestparser == 1.1 21:14:38 INFO - mozInstall == 1.12 21:14:38 INFO - mozcrash == 0.17 21:14:38 INFO - mozdebug == 0.1 21:14:38 INFO - mozdevice == 0.48 21:14:38 INFO - mozfile == 1.2 21:14:38 INFO - mozhttpd == 0.7 21:14:38 INFO - mozinfo == 0.9 21:14:38 INFO - mozleak == 0.1 21:14:38 INFO - mozlog == 3.4 21:14:38 INFO - moznetwork == 0.27 21:14:38 INFO - mozprocess == 0.23 21:14:38 INFO - mozprofile == 0.28 21:14:38 INFO - mozrunner == 6.12 21:14:38 INFO - mozscreenshot == 0.1 21:14:38 INFO - mozsystemmonitor == 0.3 21:14:38 INFO - moztest == 0.7 21:14:38 INFO - mozversion == 1.4 21:14:38 INFO - psutil == 3.1.1 21:14:38 INFO - requests == 1.2.3 21:14:38 INFO - wsgiref == 0.1.2 21:14:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:14:38 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')]} 21:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:38 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')]} 21:14:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:38 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 0x7f02afc2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29e5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e2f60>, '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 0x29e3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e41d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1476849198.497072-2087272351', '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 21:14:38 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 21:14:38 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 21:14:38 INFO - Using env: {'DISPLAY': ':0', 21:14:38 INFO - 'HOME': '/home/cltbld', 21:14:38 INFO - 'LANG': 'en_US.UTF-8', 21:14:38 INFO - 'LANGUAGE': 'en_US:en', 21:14:38 INFO - 'LOGNAME': 'cltbld', 21:14:38 INFO - 'MAIL': '/var/mail/cltbld', 21:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:38 INFO - 'MOZ_NO_REMOTE': '1', 21:14:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:14:38 INFO - 'NO_EM_RESTART': '1', 21:14:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:38 INFO - 'PWD': '/builds/slave/test', 21:14:38 INFO - 'SHELL': '/bin/bash', 21:14:38 INFO - 'SHLVL': '1', 21:14:38 INFO - 'TERM': 'linux', 21:14:38 INFO - 'TMOUT': '86400', 21:14:38 INFO - 'USER': 'cltbld', 21:14:38 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1476849198.497072-2087272351', 21:14:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:38 INFO - '_': '/tools/buildbot/bin/python'} 21:14:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:38 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)) 21:14:38 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)) 21:14:38 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)) 21:14:38 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)) 21:14:38 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)) 21:14:38 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)) 21:14:38 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)) 21:14:38 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)) 21:14:38 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)) 21:14:38 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)) 21:14:38 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)) 21:14:38 INFO - Cleaning up... 21:14:38 INFO - Return code: 0 21:14:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:14:38 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')]} 21:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:38 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')]} 21:14:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:38 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 0x7f02afc2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29e5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e2f60>, '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 0x29e3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e41d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1476849198.497072-2087272351', '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 21:14:38 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 21:14:38 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 21:14:38 INFO - Using env: {'DISPLAY': ':0', 21:14:38 INFO - 'HOME': '/home/cltbld', 21:14:38 INFO - 'LANG': 'en_US.UTF-8', 21:14:38 INFO - 'LANGUAGE': 'en_US:en', 21:14:38 INFO - 'LOGNAME': 'cltbld', 21:14:38 INFO - 'MAIL': '/var/mail/cltbld', 21:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:38 INFO - 'MOZ_NO_REMOTE': '1', 21:14:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:14:38 INFO - 'NO_EM_RESTART': '1', 21:14:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:38 INFO - 'PWD': '/builds/slave/test', 21:14:38 INFO - 'SHELL': '/bin/bash', 21:14:38 INFO - 'SHLVL': '1', 21:14:38 INFO - 'TERM': 'linux', 21:14:38 INFO - 'TMOUT': '86400', 21:14:38 INFO - 'USER': 'cltbld', 21:14:38 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1476849198.497072-2087272351', 21:14:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:38 INFO - '_': '/tools/buildbot/bin/python'} 21:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:14:39 INFO - Cleaning up... 21:14:39 INFO - Return code: 0 21:14:39 INFO - Running post-action listener: _resource_record_post_action 21:14:39 INFO - Running post-action listener: _start_resource_monitoring 21:14:39 INFO - Starting resource monitoring. 21:14:39 INFO - [mozharness: 2016-10-19 04:14:39.092463Z] Finished create-virtualenv step (success) 21:14:39 INFO - [mozharness: 2016-10-19 04:14:39.092925Z] Running install step. 21:14:39 INFO - Running pre-action listener: _resource_record_pre_action 21:14:39 INFO - Running main action method: install 21:14:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:14:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:14:39 INFO - Reading from file tmpfile_stdout 21:14:39 INFO - Detecting whether we're running mozinstall >=1.0... 21:14:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:14:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:14:39 INFO - Reading from file tmpfile_stdout 21:14:39 INFO - Output received: 21:14:39 INFO - Usage: mozinstall [options] installer 21:14:39 INFO - Options: 21:14:39 INFO - -h, --help show this help message and exit 21:14:39 INFO - -d DEST, --destination=DEST 21:14:39 INFO - Directory to install application into. [default: 21:14:39 INFO - "/builds/slave/test"] 21:14:39 INFO - --app=APP Application being installed. [default: firefox] 21:14:39 INFO - mkdir: /builds/slave/test/build/application 21:14:39 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'] 21:14:39 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 21:14:55 INFO - Reading from file tmpfile_stdout 21:14:55 INFO - Output received: 21:14:55 INFO - /builds/slave/test/build/application/firefox/firefox 21:14:55 INFO - Running post-action listener: _resource_record_post_action 21:14:55 INFO - [mozharness: 2016-10-19 04:14:55.442610Z] Finished install step (success) 21:14:55 INFO - [mozharness: 2016-10-19 04:14:55.442856Z] Running run-tests step. 21:14:55 INFO - Running pre-action listener: _resource_record_pre_action 21:14:55 INFO - Running main action method: run_tests 21:14:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:14:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:14:55 INFO - Python 2.7.3 21:14:55 INFO - Return code: 0 21:14:55 INFO - grabbing minidump binary from tooltool 21:14:55 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')]} 21:14:55 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 0x29e2f60>, '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 0x29e3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e41d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:14:55 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 21:14:55 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 21:14:55 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 21:14:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:14:55 INFO - Return code: 0 21:14:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:14:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:14:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:14:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:14:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:14:55 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/aLUBWTcIRsKhL-YTEbjDzQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 21:14:55 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/aLUBWTcIRsKhL-YTEbjDzQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 21:14:55 INFO - Using env: {'DISPLAY': ':0', 21:14:55 INFO - 'HOME': '/home/cltbld', 21:14:55 INFO - 'LANG': 'en_US.UTF-8', 21:14:55 INFO - 'LANGUAGE': 'en_US:en', 21:14:55 INFO - 'LOGNAME': 'cltbld', 21:14:55 INFO - 'MAIL': '/var/mail/cltbld', 21:14:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:14:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:14:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:55 INFO - 'MOZ_NO_REMOTE': '1', 21:14:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:14:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:14:55 INFO - 'NO_EM_RESTART': '1', 21:14:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:14:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:55 INFO - 'PWD': '/builds/slave/test', 21:14:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:14:55 INFO - 'SHELL': '/bin/bash', 21:14:55 INFO - 'SHLVL': '1', 21:14:55 INFO - 'TERM': 'linux', 21:14:55 INFO - 'TMOUT': '86400', 21:14:55 INFO - 'USER': 'cltbld', 21:14:55 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1476849198.497072-2087272351', 21:14:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:55 INFO - '_': '/tools/buildbot/bin/python'} 21:14:55 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/aLUBWTcIRsKhL-YTEbjDzQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 21:14:55 INFO - mozversion application_buildid: 20161018195923 21:14:55 INFO - mozversion application_changeset: f52b380bc02e1022631ab8dcd43ed246930974c3 21:14:55 INFO - mozversion application_display_name: Nightly 21:14:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:14:55 INFO - mozversion application_name: Firefox 21:14:55 INFO - mozversion application_remotingname: firefox 21:14:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:14:55 INFO - mozversion application_vendor: Mozilla 21:14:55 INFO - mozversion application_version: 52.0a1 21:14:55 INFO - mozversion platform_buildid: 20161018195923 21:14:55 INFO - mozversion platform_changeset: f52b380bc02e1022631ab8dcd43ed246930974c3 21:14:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:14:55 INFO - mozversion platform_version: 52.0a1 21:14:55 INFO - using testdate: 1476850495 21:14:55 INFO - actual date: 1476850495 21:14:55 INFO - starting webserver on 'localhost:53161' 21:14:55 INFO - SUITE-START | Running 2 tests 21:14:55 INFO - TEST-START | dromaeo_css 21:14:55 INFO - operating with platform_type : linux_ 21:14:55 INFO - Initialising browser for dromaeo_css test... 21:14:55 INFO - TEST-INFO | started process 15999 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1RImTJ/profile http://localhost:53161/getInfo.html) 21:15:00 INFO - PROCESS | 15999 | __metrics Screen width/height:1600/1200 21:15:00 INFO - PROCESS | 15999 | colorDepth:24 21:15:00 INFO - PROCESS | 15999 | Browser inner width/height: 1024/697 21:15:00 INFO - PROCESS | 15999 | __metrics 21:15:00 INFO - PROCESS | 15999 | 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" 21:15:00 INFO - PROCESS | 15999 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:15:01 INFO - PROCESS | 15999 | console.error: PushService: 21:15:01 INFO - PROCESS | 15999 | stateChangeProcessEnqueue: Error transitioning state 21:15:01 INFO - PROCESS | 15999 | UnknownError 21:15:02 INFO - TEST-INFO | 15999: exit 0 21:15:02 INFO - Browser initialized. 21:15:02 INFO - Running cycle 1/1 for dromaeo_css test... 21:15:02 INFO - TEST-INFO | started process 16083 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1RImTJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:15:14 INFO - PROCESS | 16083 | RSS: Main: 173895680 21:15:14 INFO - PROCESS | 16083 | 21:16:05 INFO - PROCESS | 16083 | 1476850565809 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] 21:18:19 INFO - PROCESS | 16083 | Cycle 1(1): loaded http://localhost:53161/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53161/tests/dromaeo/cssquery-ext.html) 21:18:21 INFO - PROCESS | 16083 | RSS: Main: 339423232 21:18:21 INFO - PROCESS | 16083 | 21:21:24 INFO - PROCESS | 16083 | Cycle 1(1): loaded http://localhost:53161/tests/dromaeo/cssquery-ext.html (next: http://localhost:53161/tests/dromaeo/cssquery-jquery.html) 21:21:24 INFO - PROCESS | 16083 | RSS: Main: 283205632 21:21:24 INFO - PROCESS | 16083 | 21:24:26 INFO - PROCESS | 16083 | Cycle 1(1): loaded http://localhost:53161/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53161/tests/dromaeo/cssquery-mootools.html) 21:24:27 INFO - PROCESS | 16083 | RSS: Main: 247824384 21:24:27 INFO - PROCESS | 16083 | 21:27:29 INFO - PROCESS | 16083 | Cycle 1(1): loaded http://localhost:53161/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53161/tests/dromaeo/cssquery-prototype.html) 21:27:30 INFO - PROCESS | 16083 | RSS: Main: 257777664 21:27:30 INFO - PROCESS | 16083 | 21:30:33 INFO - PROCESS | 16083 | Cycle 1(1): loaded http://localhost:53161/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53161/tests/dromaeo/cssquery-yui.html) 21:30:34 INFO - PROCESS | 16083 | RSS: Main: 220266496 21:30:34 INFO - PROCESS | 16083 | 21:33:37 INFO - PROCESS | 16083 | Cycle 1(1): loaded http://localhost:53161/tests/dromaeo/cssquery-yui.html (next: http://localhost:53161/tests/dromaeo/cssquery-dojo.html) 21:33:37 INFO - PROCESS | 16083 | RSS: Main: 311857152 21:33:37 INFO - PROCESS | 16083 | 21:33:37 INFO - PROCESS | 16083 | __start_tp_report 21:33:37 INFO - PROCESS | 16083 | _x_x_mozilla_page_load 21:33:37 INFO - PROCESS | 16083 | _x_x_mozilla_page_load_details 21:33:37 INFO - PROCESS | 16083 | |i|pagename|runs| 21:33:37 INFO - PROCESS | 16083 | |0;dojo.html;2548.7833534149595;2581.8579978101207;2593.0664960614176;2602.1803132013415;2622.8688565571724;4603.240465323226;4665.580097791198;4736.3369128322065;4739.218029025211;4750.263709125091;4688.2030054890665;4690.624750019999;4700.85897423077;4711.387519622444;4715.03341814928;4324.091940692459;4346.717463364871;4359.171757366106;4388.429504164455;4421.159979603881;4392.450943632046;4404.075144219718;4420.580044895746;4427.114577084596;4428.579284967923;4327.63215126713;4338.609525142737;4362.8909277268;4386.38590597315;4420.403245561856;4401;4423.535528769497;4430.889227769299;4462.776861156945;4479.776011199427;4232.534421213664;4263.360495925605;4268.829246830123;4329.220740266751;4343.500497442803;4659.370984917026;4685.5314468553215;4707.435107787088;4711.0342379812055;4785.3300537924715;4996.12567800637;5033.119204139261;5044.192929131358;5061.316722242524;5082.08522465956;4911.533404326583;4979.153543897546;4984.40187177541;4991.276264941599;5072.594192464594;4707.505711900236;4734.384530011076;4735.266033764772;4772;4776.641751868624;5170.560502357266;5181.248718935809;5181.974090129525;5184;5245.737713114329;4838.443578988461;4877.048975449753;4957.90084198314;4964.875878103004;5027.296178535008;4994.525520075587;5022.146235140035;5050.04049230645;5051.6716413433005;5120.820771272987;5013.273075404119;5020.246962955513;5023;5025.095482813129;5082.898342033212;4977.626677999165;4985.227289770091;4999.175136102575;5001.7499125043605;5065.848024559269;4227.852025179104;4234.809433575497;4269.060806622538;4278.016056307005;4316.482022157361;3730.8880733578035;3741.3639681254253;3761.8307176177136;3782.924341513154;3803.6196380361744;4292.763897985641;4301.139772045603;4303.311470164758;4327.610515053598;4358.65130789536;4942.505749425029;4988.750562471934;4995.775190116454;5038.3198268234055;5042.117629414838;4285.46431696038;4298.398224248608;4307.6769242306955;4309.1381723655395;4310.37499562568;4505.7296562206375;4565.972656152406;4566.817327306937;4567.040921406476;4569.817207311737;4727.598154156935;4729.054189162112;4731.668783185213;4731.834385796481;4734.384530011076;5028.446870844277;5049.495050494921;5066.113430149635;5086.694798312114;5158.664686795346;4712.50518695532;4755.500672429345;4756.904861902812;4804.0872234275375;4816.735079570657;4988.351514303117;5004.524570165974;5009.298698182331;5010.574101201439;5037.19404895215;4935.876603084808;4990;4994.900101998012;5079.034983353151;5148.150555158507;4914.975425122851;4927.162382395073;4929.852104436873;4932.260160975882;4932.4327702314695;4913.9017219656125;4919.827806026772;4922.803087876445;4924.926126108039;4925.802967881388;4795.712257264436;4832.540908613676;4846.39420072491;4853.611711063036;4903.460619331942;4880.243562247857;4929.605631549539;4949.406071271471;4992.301077849032;5006.3992320921725;4806.723024562628;4815.807367705253;4823.300621409946;4873.926891096708;4881.804727810848 21:33:37 INFO - PROCESS | 16083 | |1;ext.html;564.5709260961669;574.6236215278993;578.5863107877866;581.2937281203338;582.1529674323859;28071.298217544572;38495.80752096243;40125.598744012554;40212;43903;40112;40330.59669403305;40474.59525404745;40540;40568.59431405692;7652.426068044905;7796.337311328544;7802.921970780305;7812.453128281023;7814.921850781505;6948.617826019592;7154.785356439289;9751.414915105117;10022.498875056255;10022.79726432829;10052.396856188616;10106.242031847603;10111;10113.494325283744;10116.494175291244;10015.59937602495;10097.19222462205;10102;10113.443760593165;10114;9928.255380846465;9937.80124397508;9993.650222242186;10003.149732272766;10012.69961901144;37267.627323726956;37999.620003799886;38013.80993095045;38015;38042;2920.2115428834095;2926.4293462774767;2980.6125203723595;3046.329807442359;3131.4206871728575;27689.44621107587;27801.304967375774;27853.442931141468;27878.3030424241;27896;3267.9836600816843;3286.8849590264226;3350.547676063725;3392.728581713457;3414.0270023043563;241113;241762;241831;242937;243526;52447.213291800654;52773.7361313191;52849;52856.73571632117;52945.73527132417;54188.93582981292;54197;54224.728876355366;54298.72850635721;54361.72819135879;12972.416241269166;13057.934710326577;13063.934680326727;13114.082014259102;13114.147580407243;11321.207515473838;11325.660230193107;11329.320240785579;11339.262947908524;11345.432728363548;13431.731365372832;13809.792853107212;14959.551213463395;15261.771073433907;15510.922445387701;5413.891722165535;5614.915776263278;5766.971165144231;5787.594868359174;5845.444682755132;755.4522970846093;827.3629305434781;854.2055888024197;877.7673916412156;973.4159504297365;25041.24876253679;25729.88156544797;26496.8675156623;26892.462150756874;27066.729332706815;931.001866955864;938.3290946972947;949.9382540134869;1045.2004216774174;1070.2719323913498;14207.73170016945;14272.785908211385;14509.274536273144;14537.636559085897;14624.707505850036;350400;351446;352691;352767;353867;41678;42874.35688464675;42920.78539607282;47459.28811067837;48356.27465588019;1136.4033882211904;1154.8152295632658;1181.4919584578713;1189.5955375172482;1199.1366216324232;27408.588871167347;28253.15240542787;28644.713552864203;28705.28236794097;28901.132966011053;42584.36123458089;43002.569974299855;43024;43038.56961430471;43052.56947430611;365633;374450;375580;577004;578618;24484.265472035866;24508.142215022388;24776.50446991014;24787.752122478545;24805.62791558164;40743.1851362977;40946;41433.79283103565;41752.164956700086;42504.78747606242;35083.824580876935;35147.82426087853;35626.8218658905;35803.641963580034;35895;34897.953061408196;35435.114122147155;35632.82183589065;35633.82183089172;35802.641973580976;32915.34169316648;34095.65904340925;34294.14264643404;35102.297954041285;35567.82216088903;30234.54648180235;32669;32799;32906.341873161924;32991;24294.27117186487;24632.876835616426;24654;24713;24820.25539233826 21:33:37 INFO - PROCESS | 16083 | |2;jquery.html;336.2619051182652;344.7035549427492;363.7962740865116;366.43203035295295;377.47719408619054;12266.386680665975;13266.66833329166;15774.13242271676;16009.19954002301;16599.83400165998;15022.549323520285;15044.774328385083;15049.77425338618;15180.089194648328;15357.15535645539;4799.448063472693;5052.115879721034;5055.090083784918;5055.570276526481;5056.974715126419;4998.675086119409;5234.214867769827;5262.526372626463;5321.388040375348;5329.360476742777;5295.735213239323;5312.362516498026;5316.707581083039;5351.7324133793345;5355.6251062425645;5109.386873575158;5244.711540865251;5275.630705850592;5281.128613778722;5286.101362768339;4981.950180498185;5122.154844450662;5126.051680439131;5126.512981266774;5132.358455193101;12272.754544909052;16005.839941600552;19544.80455195458;20219.898900505552;20285;1810.3663717698832;1861.4229588827507;1950.6878899376175;2388.713354397466;2391.976080239193;8997.640094396216;9320.673776417792;10024.19806415485;11596.188266821326;13266.800997985038;1663.7005339038967;1690.8140104588485;1718.6390857919853;1734.9219285132199;1756.771619689432;59913.40086599165;63826.36173638297;64991;65174.674126629536;65425.3457465424;9623.903760962441;9812.411255324703;9837.950810245902;10071.129728027478;10096.848547271797;13633.727325453436;13642.522511712043;13651.453941842414;13657.112287701466;13671.111377760413;7032.683529241196;7201.603911784798;7233.132024157135;7395.149557800922;7413.518121322205;6910.7581234656545;6917.89623155653;7069.293070692889;7114.57312561248;7141.82145446368;4165.500139983222;4178.26880295947;4232.703710740218;4323.870283891489;4378;1734.6443978984278;1776.7740259221096;1818.1545581304756;1830.9176087076114;1842.5025243184266;652.3443938841434;777.1179711027911;784.5488843914658;844.025150950653;890.3633901760272;15875.444359447363;16309.429169978994;16552.586185345222;16752.41366552165;17135;768.4352001279055;814.0638265994036;823.283743143469;878.1262643669589;884.7301573020162;8755.737327880173;9300.162985331353;9384.343095983351;9408.717738467856;9477.336586439022;404346;408864;410219;410891;411879;66351.66824165944;67889.32110678928;70110.64944675346;70657;75566.62216688882;930.4603330068544;941.4022095969109;987.9950600247097;992.4095163377779;999.3404353126901;15197.77203341973;15437.0737755735;15555.14446705442;15575.688486230438;16169.838301617303;36858;36898;37158.8142059288;37774.43338349872;38049.239015218984;48820.45642012705;48853.755731221114;51614;52406.73796630993;52962.2055669173;7185.748498802517;7250.238724933806;7283.672234749343;7433.219511951167;7434.182239953709;8304.252617264476;10919.344839309666;11010.449477526252;11027.61403350911;11380.430978450879;9683.612655493702;9722.513874306398;9877.259205559469;9893.307468477138;10185.439800810731;10024.649137280452;10053.648122315684;10113.19094472455;10401.739956500845;10443;9882.357646752938;10119.342242754197;10144.644937427154;10260;10263.23025773055;7450.515716478411;7490.812729681802;7548.924510755041;7585.734499292719;7750.031246094239;9709.417434953926;9884.25868059884;9895.55470003866;9971.623835977813;10316.381017138996 21:33:37 INFO - PROCESS | 16083 | |3;mootools.html;1357.104311154638;1405.114777690055;1481.2593703148425;1612.6290953080797;1688.0968681755264;6625.933740662592;6884.793456196322;7146.928530714691;7709.922900770991;7715.72994945177;7492.9625351873165;7755.650995705193;7765.107012693542;7969.282764551189;7983.481073730203;2151.290074275493;2165.71845660064;2173.467500462389;2182.9126834926583;2183.4541364658835;1754.8947063176186;1807.060328629112;2086.09254974086;2155.752088509818;2159.5788821179876;2067.7001834733956;2132.019271135272;2133.8506304558687;2156.8166705829944;2165.8483906126576;2129.3079749081458;2151.6449785785403;2155.676648502729;2171.543975765091;2187.278198194592;2062.247279742883;2068.2037415594955;2072.927447539344;2074.9377518674464;2076.0553947953645;7605.543667379975;7732.961335193288;7736.419768517328;7746.535207887545;7747.302742753123;4357.629601483878;4494.1910456117885;4501.257292546726;4501.48232953208;4502.932456013163;2691.542437785581;2762.1575419497044;2797.5384061629807;2799.930001749952;2801.6918139004692;886.2865393358344;889.155302462663;900.6307413960245;904.186232390847;910.0444533240071;10329.483525823678;10339.844902326397;10457.790844183073;10505.2646314758;10518.579256829718;3881.514810648669;4103.815328310233;4213.073123912734;4248.617624413818;4273.594008569181;8886.11138886119;8890.955545222361;8894.777630559287;8912.153345432174;8915.910840891507;4567.2464043432465;4583.129205450954;4600.148972440109;4600.401947746772;4601.930971035437;4090.141070375195;4123.587641235912;4129.421880936671;4133.111381053028;4136.31750761121;3565.6790888820133;3569.23261498779;3647.343478173901;3666.5233519642275;3694.039549717093;1037.5434808684154;1085.913126949842;1161.5644133449957;1174.629991552658;1174.9823752643717;623.9469645080219;693.9826504337432;729.6023667101442;761.9466637335444;815.4943934760487;4921.163402221631;5015.163399999004;5087.771050302671;5128.282040514331;5141.922871156936;761.6572542355962;802.5385403393072;822.5023860564391;847.8092429203504;868.2489646455771;3313.5526703894666;3421.3841508528703;3427.7943323400677;3444.569428821397;3482.91292717679;9346.953265233631;9618.663346782829;9700.320977531504;9718.319717619841;9745.707628771148;8918.464892106495;9647.035296470296;9650.276229282832;9668.129868311746;9674.03259674041;7007.299270072952;7133.89299160513;7142.964285178541;7149.142102947576;7189.382388962546;4832.34763306949;4935.284383764262;5051;5085.542301192911;5199.55803756685;8533.146685331418;8600;8798.12018798115;8939.284857211278;8947.463152210888;8779.692710755093;9111.088891110836;9120.270378369847;9137;9234.95382523083;6707.5304728668525;6786.185657721105;6861.245263020964;6868.450523958171;6869.862602748017;7462.216467270859;7479.214682458482;7521.5111017783665;7548.056492938383;7556.962215188889;6482.384173503509;6531.11829902957;6557.9344206557325;6720.932790672031;6760.560563563353;6415.775447859302;6538.346165383424;6567.934320656732;6583.604983700993;6598.076269322395;6016.097585362056;6150;6150;6150.723217455135;6150.7847225346895;4214.704970652025;4236.809343579608;4239.936400953927;4267.466566679165;4354.412154359121;4208.410822484793;4294.506131794884;4318.9568104319815;4385.780710964503;4512.029913568598 21:33:37 INFO - PROCESS | 16083 | |4;prototype.html;286.49433749432256;291.0714819725077;293.9882404703812;294.3788606041254;298.26031442023793;4596.218642830719;4720.90558188836;4780.42634883814;4797.784099715513;4814.927776083362;4532.229520981433;4650.488446270908;4672.205725026745;4696;4714.5756881880625;3748.1941382602736;3763.322601931651;3779.489768881207;3783.9621603783885;3790.298794722985;3540.468929660559;3738.1589142443004;3750.324941510527;3765.755225910307;3776.603456637055;3454.7236221102253;3711.183539621279;3712.1462063725357;3716.4053751399783;3718.293524230401;3713.591504934455;3721.62783721627;3725.4784330193793;3738.214974855284;3738.3831667774784;3305.7190138838228;3314.5691060162267;3315.3037862049;3320.3027364253535;3329.983350083234;4527.4340707411575;4579.335996280521;4615.26155815068;4642.234031384817;4655.766221951186;4209.473815773028;4217.768022758747;4228.365745138223;4237.258479766028;4238.7880605969885;4906.656534042619;4915.5330243626795;4936.48166942473;4941.604671626261;4947.678400903929;3519.489673997256;3594.9149493293826;3599.470225154299;3600.243948770761;3612.7832330060282;5079.746012699387;5109.3613298337705;5112;5120.3855537335385;5130.4356520782685;3652.160003199279;3659.524261845943;3666.7433279670167;3668.211334563082;3670.743047986669;3719.902628724533;3740.121071548184;3770.7171962102952;3784;3794.29805485986;3971.8808435746973;4197.8320867165585;4211.7262377945335;4308.892277693083;4316;4947.406311242674;4970.3290055842;4982.487346420765;4997.675151115239;5015;1157.2535714464123;1190.6902407351843;1239.9938000309942;1259.7102666386781;1269.1306455078302;819.6516480495766;846.1073567386344;852.778277647816;852.8038551133274;860.4794099569796;4307.935380969226;4319.222539942778;4342.609165175149;4344;4356.346548017823;5031.509402845615;5036.3380084572;5059.468755780664;5060.367454068241;5073.492650734897;4217.1776503581505;4314.80583373749;4329.393884856123;4330.7401555906745;4331.393604895317;2654.588538776493;2683.114572191172;2684.9731502685113;2696.9865150674123;2699.757021868002;4752.835555288907;4766.404199475066;4780.4741478437345;4786.856394308176;4795.880102997453;4936.703797772145;5135.6405051646025;5157.200633901752;5166.767495462713;5175.654329874184;4738.19450693383;4740.123077230654;4744.169770290255;4746.19314716506;4747.192977193817;5025;5047.4952504749235;5056.974715126401;5067.797288108434;5071.644984851025;4730.148573256847;4849.58778503817;4908.386451693538;4931.260310953242;4964.4539100698175;4693.436787585511;4699.942512934563;4709.293605959134;4712.952870471388;4713.410823647044;3556.377633914003;3564.6435356464144;3569.126208740432;3574.7855128692363;3589.9102522437147;4871.687252668078;5059.165237735732;5060.8987820242655;5144.7942082316285;5180.48195180494;5003.2745251938995;5015.64890457679;5020.874478138076;5028.245763135413;5037.808553279335;4992.276119962513;4993.775280112331;5022.573081288131;5025.3718285214345;5042.109209046607;4665.883352916204;4780.808767649255;4872.829450969199;4906.0433215522635;4939;4877.756112194447;4894.388201474816;4894.895195066156;4900.975495122501;4942.283368911416;4787.353707249476;4830.66185367035;4912.754362281943;4959.660891559331;4982.676126051795 21:33:37 INFO - PROCESS | 16083 | |5;yui.html;636.9012803015535;657.8256761958081;659.5020759326708;681.4616453002128;720.1897864901986;12577.11960162788;13616.251106189156;13866.37601307941;13868.098573592722;13879.791803122936;12338.136330456871;12403.503859845596;12407.441665125069;12410.441530131144;12417.813732794015;625.4839757200306;633.4805459523193;741.6477173342673;752.8155601877547;760.4068826315469;774.8217909880731;780.1418439716296;780.3718007004359;782.886481460188;783.2872086401376;853.7225401744427;853.7353420439683;854.8803167556547;856.0113069404816;856.8971723393202;656.6946369937978;665.1585744033802;813.369638530138;822.6873787960536;841.247083859945;607.2318517075903;607.32890156377;607.875385545962;608.1334098909036;608.4068033667183;12229.571964981273;12241.143119981605;12257.816132758016;12285.262884226975;12374;11525.884741152566;11649.417529123595;11659.304485535376;11939.522419103312;12651.557195498113;10891.83662245067;11059;11221.775564488746;11258.943705281503;11328.263662861887;4043.5349934757587;4063.3295506241434;4155.8753237402925;4169.437125987984;4316.136772645484;62027.069593955675;62039.6898015507;62289.377106228814;63199.36800631981;64989.67505162444;9231.307651926132;9284.7678808029;9307.556204204488;9457.10157535033;9476.289278304155;16474.505764826834;16775.496735097968;16787.664246714998;16890.83109168917;17987.370442034728;6288.371162883766;6314.589551679126;6367.076773867763;6472.449841763503;6505.60966342021;3322.302316513559;3334.533165356852;3348.196432856097;3426.623071462137;3452.171478845059;2774.18161642316;2798.860056997142;2815.1835967569177;2832.830030198195;2835.9007434739683;499.370792801066;500.39702158899166;503.4361515103108;506.23811164197645;513.2865317209082;441.5672640812022;443.4146926057637;539.2046731071638;542.452123355406;581.5957909253028;6825.931740682529;6862.451003919675;6893.827654308582;7249.383802376857;7314;449.4180036852284;472.65732344050974;473.2404490792229;490.8429302623198;491.1772780592493;3428.4171690812623;3470.843812028414;3490.860365585399;3572.5534308211472;3601.5858176309534;71247.64376178086;93843.53078234565;100400.497997511;101337.49331253444;101692.49153754332;45317.54682453199;58598;64227;77416.2258377409;78042.60978695184;42268.788656056524;54326.72836635871;59470;66069.66965165336;66725;7570.886436703344;8297.336213103057;8310.168983101641;8480.575971201291;8538.487690738575;30651.08046758601;40341.39487907625;41363.379549307385;42364;42807.785961069996;55299.723501382236;55997;58649;61565;64483;10093.343932644355;10276.743081423025;10953.233273670767;11200.271982321123;11387.0321022714;12269.509219631473;12539.749205015665;12668.303243321705;13052.15161014531;13181.472741090249;10329.483525823829;10777.407242601732;10983.890161098287;11459.36973466434;11581.24721893108;10959.561617535528;10971.341719496855;11118.221724479208;11891.28652280866;11908.821367679318;10493.632722854663;10508.21188410857;10826.945865270623;10937.890621093688;11381.146414018816;9306.348555601044;9464.148226659634;9503.429794212369;9604.567794449405;10403.323783954018;9935.354201976848;9964.302498825013;10131.87087124517;10184;10218.795624087625 21:33:37 INFO - PROCESS | 16083 | __end_tp_report 21:33:37 INFO - PROCESS | 16083 | __start_cc_report 21:33:37 INFO - PROCESS | 16083 | _x_x_mozilla_cycle_collect,1671 21:33:37 INFO - PROCESS | 16083 | __end_cc_report 21:33:37 INFO - PROCESS | 16083 | __startTimestamp1476851617585__endTimestamp 21:33:37 INFO - PROCESS | 16083 | 21:33:37 INFO - PROCESS | 16083 | ------- Summary: start ------- 21:33:37 INFO - PROCESS | 16083 | Number of tests: 6 21:33:37 INFO - PROCESS | 16083 | 21:33:37 INFO - PROCESS | 16083 | [#0] dojo.html Cycles:165 Average:4662.87 Median:4785.33 stddev:489.37 (10.2%) stddev-sans-first:461.92 21:33:37 INFO - PROCESS | 16083 | Values: 2548.8 2581.9 2593.1 2602.2 2622.9 4603.2 4665.6 4736.3 4739.2 4750.3 4688.2 4690.6 4700.9 4711.4 4715.0 4324.1 4346.7 4359.2 4388.4 4421.2 4392.5 4404.1 4420.6 4427.1 4428.6 4327.6 4338.6 4362.9 4386.4 4420.4 4401.0 4423.5 4430.9 4462.8 4479.8 4232.5 4263.4 4268.8 4329.2 4343.5 4659.4 4685.5 4707.4 4711.0 4785.3 4996.1 5033.1 5044.2 5061.3 5082.1 4911.5 4979.2 4984.4 4991.3 5072.6 4707.5 4734.4 4735.3 4772.0 4776.6 5170.6 5181.2 5182.0 5184.0 5245.7 4838.4 4877.0 4957.9 4964.9 5027.3 4994.5 5022.1 5050.0 5051.7 5120.8 5013.3 5020.2 5023.0 5025.1 5082.9 4977.6 4985.2 4999.2 5001.7 5065.8 4227.9 4234.8 4269.1 4278.0 4316.5 3730.9 3741.4 3761.8 3782.9 3803.6 4292.8 4301.1 4303.3 4327.6 4358.7 4942.5 4988.8 4995.8 5038.3 5042.1 4285.5 4298.4 4307.7 4309.1 4310.4 4505.7 4566.0 4566.8 4567.0 4569.8 4727.6 4729.1 4731.7 4731.8 4734.4 5028.4 5049.5 5066.1 5086.7 5158.7 4712.5 4755.5 4756.9 4804.1 4816.7 4988.4 5004.5 5009.3 5010.6 5037.2 4935.9 4990.0 4994.9 5079.0 5148.2 4915.0 4927.2 4929.9 4932.3 4932.4 4913.9 4919.8 4922.8 4924.9 4925.8 4795.7 4832.5 4846.4 4853.6 4903.5 4880.2 4929.6 4949.4 4992.3 5006.4 4806.7 4815.8 4823.3 4873.9 4881.8 21:33:37 INFO - PROCESS | 16083 | 21:33:37 INFO - PROCESS | 16083 | [#1] ext.html Cycles:180 Average:49624.43 Median:192648.98 stddev:96869.20 (50.3%) stddev-sans-first:97070.91 21:33:37 INFO - PROCESS | 16083 | Values: 564.6 574.6 578.6 581.3 582.2 28071.3 38495.8 40125.6 40212.0 43903.0 40112.0 40330.6 40474.6 40540.0 40568.6 7652.4 7796.3 7802.9 7812.5 7814.9 6948.6 7154.8 9751.4 10022.5 10022.8 10052.4 10106.2 10111.0 10113.5 10116.5 10015.6 10097.2 10102.0 10113.4 10114.0 9928.3 9937.8 9993.7 10003.1 10012.7 37267.6 37999.6 38013.8 38015.0 38042.0 2920.2 2926.4 2980.6 3046.3 3131.4 27689.4 27801.3 27853.4 27878.3 27896.0 3268.0 3286.9 3350.5 3392.7 3414.0 241113.0 241762.0 241831.0 242937.0 243526.0 52447.2 52773.7 52849.0 52856.7 52945.7 54188.9 54197.0 54224.7 54298.7 54361.7 12972.4 13057.9 13063.9 13114.1 13114.1 11321.2 11325.7 11329.3 11339.3 11345.4 13431.7 13809.8 14959.6 15261.8 15510.9 5413.9 5614.9 5767.0 5787.6 5845.4 755.5 827.4 854.2 877.8 973.4 25041.2 25729.9 26496.9 26892.5 27066.7 931.0 938.3 949.9 1045.2 1070.3 14207.7 14272.8 14509.3 14537.6 14624.7 350400.0 351446.0 352691.0 352767.0 353867.0 41678.0 42874.4 42920.8 47459.3 48356.3 1136.4 1154.8 1181.5 1189.6 1199.1 27408.6 28253.2 28644.7 28705.3 28901.1 42584.4 43002.6 43024.0 43038.6 43052.6 365633.0 374450.0 375580.0 577004.0 578618.0 24484.3 24508.1 24776.5 24787.8 24805.6 40743.2 40946.0 41433.8 41752.2 42504.8 35083.8 35147.8 35626.8 35803.6 35895.0 34898.0 35435.1 35632.8 35633.8 35802.6 32915.3 34095.7 34294.1 35102.3 35567.8 30234.5 32669.0 32799.0 32906.3 32991.0 24294.3 24632.9 24654.0 24713.0 24820.3 21:33:37 INFO - PROCESS | 16083 | 21:33:37 INFO - PROCESS | 16083 | [#2] jquery.html Cycles:180 Average:24255.62 Median:5053.60 stddev:67263.68 (1331.0%) stddev-sans-first:67428.40 21:33:37 INFO - PROCESS | 16083 | Values: 336.3 344.7 363.8 366.4 377.5 12266.4 13266.7 15774.1 16009.2 16599.8 15022.5 15044.8 15049.8 15180.1 15357.2 4799.4 5052.1 5055.1 5055.6 5057.0 4998.7 5234.2 5262.5 5321.4 5329.4 5295.7 5312.4 5316.7 5351.7 5355.6 5109.4 5244.7 5275.6 5281.1 5286.1 4982.0 5122.2 5126.1 5126.5 5132.4 12272.8 16005.8 19544.8 20219.9 20285.0 1810.4 1861.4 1950.7 2388.7 2392.0 8997.6 9320.7 10024.2 11596.2 13266.8 1663.7 1690.8 1718.6 1734.9 1756.8 59913.4 63826.4 64991.0 65174.7 65425.3 9623.9 9812.4 9838.0 10071.1 10096.8 13633.7 13642.5 13651.5 13657.1 13671.1 7032.7 7201.6 7233.1 7395.1 7413.5 6910.8 6917.9 7069.3 7114.6 7141.8 4165.5 4178.3 4232.7 4323.9 4378.0 1734.6 1776.8 1818.2 1830.9 1842.5 652.3 777.1 784.5 844.0 890.4 15875.4 16309.4 16552.6 16752.4 17135.0 768.4 814.1 823.3 878.1 884.7 8755.7 9300.2 9384.3 9408.7 9477.3 404346.0 408864.0 410219.0 410891.0 411879.0 66351.7 67889.3 70110.6 70657.0 75566.6 930.5 941.4 988.0 992.4 999.3 15197.8 15437.1 15555.1 15575.7 16169.8 36858.0 36898.0 37158.8 37774.4 38049.2 48820.5 48853.8 51614.0 52406.7 52962.2 7185.7 7250.2 7283.7 7433.2 7434.2 8304.3 10919.3 11010.4 11027.6 11380.4 9683.6 9722.5 9877.3 9893.3 10185.4 10024.6 10053.6 10113.2 10401.7 10443.0 9882.4 10119.3 10144.6 10260.0 10263.2 7450.5 7490.8 7548.9 7585.7 7750.0 9709.4 9884.3 9895.6 9971.6 10316.4 21:33:37 INFO - PROCESS | 16083 | 21:33:37 INFO - PROCESS | 16083 | [#3] mootools.html Cycles:180 Average:5033.33 Median:5086.66 stddev:2856.71 (56.2%) stddev-sans-first:2851.37 21:33:37 INFO - PROCESS | 16083 | Values: 1357.1 1405.1 1481.3 1612.6 1688.1 6625.9 6884.8 7146.9 7709.9 7715.7 7493.0 7755.7 7765.1 7969.3 7983.5 2151.3 2165.7 2173.5 2182.9 2183.5 1754.9 1807.1 2086.1 2155.8 2159.6 2067.7 2132.0 2133.9 2156.8 2165.8 2129.3 2151.6 2155.7 2171.5 2187.3 2062.2 2068.2 2072.9 2074.9 2076.1 7605.5 7733.0 7736.4 7746.5 7747.3 4357.6 4494.2 4501.3 4501.5 4502.9 2691.5 2762.2 2797.5 2799.9 2801.7 886.3 889.2 900.6 904.2 910.0 10329.5 10339.8 10457.8 10505.3 10518.6 3881.5 4103.8 4213.1 4248.6 4273.6 8886.1 8891.0 8894.8 8912.2 8915.9 4567.2 4583.1 4600.1 4600.4 4601.9 4090.1 4123.6 4129.4 4133.1 4136.3 3565.7 3569.2 3647.3 3666.5 3694.0 1037.5 1085.9 1161.6 1174.6 1175.0 623.9 694.0 729.6 761.9 815.5 4921.2 5015.2 5087.8 5128.3 5141.9 761.7 802.5 822.5 847.8 868.2 3313.6 3421.4 3427.8 3444.6 3482.9 9347.0 9618.7 9700.3 9718.3 9745.7 8918.5 9647.0 9650.3 9668.1 9674.0 7007.3 7133.9 7143.0 7149.1 7189.4 4832.3 4935.3 5051.0 5085.5 5199.6 8533.1 8600.0 8798.1 8939.3 8947.5 8779.7 9111.1 9120.3 9137.0 9235.0 6707.5 6786.2 6861.2 6868.5 6869.9 7462.2 7479.2 7521.5 7548.1 7557.0 6482.4 6531.1 6557.9 6720.9 6760.6 6415.8 6538.3 6567.9 6583.6 6598.1 6016.1 6150.0 6150.0 6150.7 6150.8 4214.7 4236.8 4239.9 4267.5 4354.4 4208.4 4294.5 4319.0 4385.8 4512.0 21:33:37 INFO - PROCESS | 16083 | 21:33:37 INFO - PROCESS | 16083 | [#4] prototype.html Cycles:180 Average:4110.07 Median:4694.72 stddev:1184.16 (25.2%) stddev-sans-first:1152.19 21:33:37 INFO - PROCESS | 16083 | Values: 286.5 291.1 294.0 294.4 298.3 4596.2 4720.9 4780.4 4797.8 4814.9 4532.2 4650.5 4672.2 4696.0 4714.6 3748.2 3763.3 3779.5 3784.0 3790.3 3540.5 3738.2 3750.3 3765.8 3776.6 3454.7 3711.2 3712.1 3716.4 3718.3 3713.6 3721.6 3725.5 3738.2 3738.4 3305.7 3314.6 3315.3 3320.3 3330.0 4527.4 4579.3 4615.3 4642.2 4655.8 4209.5 4217.8 4228.4 4237.3 4238.8 4906.7 4915.5 4936.5 4941.6 4947.7 3519.5 3594.9 3599.5 3600.2 3612.8 5079.7 5109.4 5112.0 5120.4 5130.4 3652.2 3659.5 3666.7 3668.2 3670.7 3719.9 3740.1 3770.7 3784.0 3794.3 3971.9 4197.8 4211.7 4308.9 4316.0 4947.4 4970.3 4982.5 4997.7 5015.0 1157.3 1190.7 1240.0 1259.7 1269.1 819.7 846.1 852.8 852.8 860.5 4307.9 4319.2 4342.6 4344.0 4356.3 5031.5 5036.3 5059.5 5060.4 5073.5 4217.2 4314.8 4329.4 4330.7 4331.4 2654.6 2683.1 2685.0 2697.0 2699.8 4752.8 4766.4 4780.5 4786.9 4795.9 4936.7 5135.6 5157.2 5166.8 5175.7 4738.2 4740.1 4744.2 4746.2 4747.2 5025.0 5047.5 5057.0 5067.8 5071.6 4730.1 4849.6 4908.4 4931.3 4964.5 4693.4 4699.9 4709.3 4713.0 4713.4 3556.4 3564.6 3569.1 3574.8 3589.9 4871.7 5059.2 5060.9 5144.8 5180.5 5003.3 5015.6 5020.9 5028.2 5037.8 4992.3 4993.8 5022.6 5025.4 5042.1 4665.9 4780.8 4872.8 4906.0 4939.0 4877.8 4894.4 4894.9 4901.0 4942.3 4787.4 4830.7 4912.8 4959.7 4982.7 21:33:37 INFO - PROCESS | 16083 | 21:33:37 INFO - PROCESS | 16083 | [#5] yui.html Cycles:180 Average:16202.36 Median:22883.48 stddev:22709.31 (99.2%) stddev-sans-first:22742.94 21:33:37 INFO - PROCESS | 16083 | Values: 636.9 657.8 659.5 681.5 720.2 12577.1 13616.3 13866.4 13868.1 13879.8 12338.1 12403.5 12407.4 12410.4 12417.8 625.5 633.5 741.6 752.8 760.4 774.8 780.1 780.4 782.9 783.3 853.7 853.7 854.9 856.0 856.9 656.7 665.2 813.4 822.7 841.2 607.2 607.3 607.9 608.1 608.4 12229.6 12241.1 12257.8 12285.3 12374.0 11525.9 11649.4 11659.3 11939.5 12651.6 10891.8 11059.0 11221.8 11258.9 11328.3 4043.5 4063.3 4155.9 4169.4 4316.1 62027.1 62039.7 62289.4 63199.4 64989.7 9231.3 9284.8 9307.6 9457.1 9476.3 16474.5 16775.5 16787.7 16890.8 17987.4 6288.4 6314.6 6367.1 6472.4 6505.6 3322.3 3334.5 3348.2 3426.6 3452.2 2774.2 2798.9 2815.2 2832.8 2835.9 499.4 500.4 503.4 506.2 513.3 441.6 443.4 539.2 542.5 581.6 6825.9 6862.5 6893.8 7249.4 7314.0 449.4 472.7 473.2 490.8 491.2 3428.4 3470.8 3490.9 3572.6 3601.6 71247.6 93843.5 100400.5 101337.5 101692.5 45317.5 58598.0 64227.0 77416.2 78042.6 42268.8 54326.7 59470.0 66069.7 66725.0 7570.9 8297.3 8310.2 8480.6 8538.5 30651.1 40341.4 41363.4 42364.0 42807.8 55299.7 55997.0 58649.0 61565.0 64483.0 10093.3 10276.7 10953.2 11200.3 11387.0 12269.5 12539.7 12668.3 13052.2 13181.5 10329.5 10777.4 10983.9 11459.4 11581.2 10959.6 10971.3 11118.2 11891.3 11908.8 10493.6 10508.2 10826.9 10937.9 11381.1 9306.3 9464.1 9503.4 9604.6 10403.3 9935.4 9964.3 10131.9 10184.0 10218.8 21:33:37 INFO - PROCESS | 16083 | -------- Summary: end -------- 21:33:37 INFO - PROCESS | 16083 | 21:33:38 INFO - TEST-INFO | 16083: exit 0 21:33:38 INFO - TEST-OK | dromaeo_css | took 1122920ms 21:33:38 INFO - TEST-START | kraken 21:33:38 INFO - operating with platform_type : linux_ 21:33:38 INFO - Initialising browser for kraken test... 21:33:38 INFO - TEST-INFO | started process 16389 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1_gyXf/profile http://localhost:53161/getInfo.html) 21:33:42 INFO - PROCESS | 16389 | __metrics Screen width/height:1600/1200 21:33:42 INFO - PROCESS | 16389 | colorDepth:24 21:33:42 INFO - PROCESS | 16389 | Browser inner width/height: 1024/697 21:33:42 INFO - PROCESS | 16389 | __metrics 21:33:43 INFO - PROCESS | 16389 | 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" 21:33:43 INFO - PROCESS | 16389 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:33:44 INFO - TEST-INFO | 16389: exit 0 21:33:44 INFO - Browser initialized. 21:33:44 INFO - Running cycle 1/1 for kraken test... 21:33:44 INFO - TEST-INFO | started process 16470 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1_gyXf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:33:57 INFO - PROCESS | 16470 | RSS: Main: 173666304 21:33:57 INFO - PROCESS | 16470 | 21:33:59 INFO - PROCESS | 16470 | Cycle 1(1): loaded http://localhost:53161/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53161/tests/kraken/driver.html?testName=audio-beat-detection) 21:34:00 INFO - PROCESS | 16470 | RSS: Main: 235143168 21:34:00 INFO - PROCESS | 16470 | 21:34:03 INFO - PROCESS | 16470 | Cycle 1(1): loaded http://localhost:53161/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53161/tests/kraken/driver.html?testName=audio-dft) 21:34:04 INFO - PROCESS | 16470 | RSS: Main: 217219072 21:34:04 INFO - PROCESS | 16470 | 21:34:07 INFO - PROCESS | 16470 | Cycle 1(1): loaded http://localhost:53161/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53161/tests/kraken/driver.html?testName=audio-fft) 21:34:08 INFO - PROCESS | 16470 | RSS: Main: 299520000 21:34:08 INFO - PROCESS | 16470 | 21:34:10 INFO - PROCESS | 16470 | Cycle 1(1): loaded http://localhost:53161/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53161/tests/kraken/driver.html?testName=audio-oscillator) 21:34:10 INFO - PROCESS | 16470 | RSS: Main: 209776640 21:34:10 INFO - PROCESS | 16470 | 21:34:13 INFO - PROCESS | 16470 | Cycle 1(1): loaded http://localhost:53161/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53161/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:34:13 INFO - PROCESS | 16470 | RSS: Main: 212439040 21:34:13 INFO - PROCESS | 16470 | 21:34:16 INFO - PROCESS | 16470 | Cycle 1(1): loaded http://localhost:53161/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53161/tests/kraken/driver.html?testName=imaging-darkroom) 21:34:17 INFO - PROCESS | 16470 | RSS: Main: 249569280 21:34:17 INFO - PROCESS | 16470 | 21:34:21 INFO - PROCESS | 16470 | Cycle 1(1): loaded http://localhost:53161/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53161/tests/kraken/driver.html?testName=imaging-desaturate) 21:34:21 INFO - PROCESS | 16470 | RSS: Main: 248590336 21:34:21 INFO - PROCESS | 16470 | 21:34:24 INFO - PROCESS | 16470 | Cycle 1(1): loaded http://localhost:53161/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53161/tests/kraken/driver.html?testName=json-parse-financial) 21:34:24 INFO - PROCESS | 16470 | RSS: Main: 247746560 21:34:24 INFO - PROCESS | 16470 | 21:34:26 INFO - PROCESS | 16470 | Cycle 1(1): loaded http://localhost:53161/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53161/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:34:27 INFO - PROCESS | 16470 | RSS: Main: 210325504 21:34:27 INFO - PROCESS | 16470 | 21:34:29 INFO - PROCESS | 16470 | Cycle 1(1): loaded http://localhost:53161/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53161/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:34:29 INFO - PROCESS | 16470 | RSS: Main: 217460736 21:34:29 INFO - PROCESS | 16470 | 21:34:31 INFO - PROCESS | 16470 | Cycle 1(1): loaded http://localhost:53161/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53161/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:34:32 INFO - PROCESS | 16470 | RSS: Main: 226664448 21:34:32 INFO - PROCESS | 16470 | 21:34:35 INFO - PROCESS | 16470 | Cycle 1(1): loaded http://localhost:53161/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53161/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:34:36 INFO - PROCESS | 16470 | RSS: Main: 234729472 21:34:36 INFO - PROCESS | 16470 | 21:34:39 INFO - PROCESS | 16470 | Cycle 1(1): loaded http://localhost:53161/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53161/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:34:39 INFO - PROCESS | 16470 | RSS: Main: 231673856 21:34:39 INFO - PROCESS | 16470 | 21:34:41 INFO - PROCESS | 16470 | Cycle 1(1): loaded http://localhost:53161/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53161/tests/kraken/driver.html?testName=ai-astar) 21:34:41 INFO - PROCESS | 16470 | RSS: Main: 282865664 21:34:41 INFO - PROCESS | 16470 | 21:34:41 INFO - PROCESS | 16470 | __start_tp_report 21:34:41 INFO - PROCESS | 16470 | _x_x_mozilla_page_load 21:34:41 INFO - PROCESS | 16470 | _x_x_mozilla_page_load_details 21:34:41 INFO - PROCESS | 16470 | |i|pagename|runs| 21:34:41 INFO - PROCESS | 16470 | |0;ai-astar;105;113;113;113;113;114;112;114;112;113 21:34:41 INFO - PROCESS | 16470 | |1;audio-beat-detection;154;137;130;175;128;128;127;136;164;126 21:34:41 INFO - PROCESS | 16470 | |2;audio-dft;161;162;162;163;160;160;161;162;161;160 21:34:41 INFO - PROCESS | 16470 | |3;audio-fft;75;78;77;110;78;77;78;78;111;76 21:34:41 INFO - PROCESS | 16470 | |4;audio-oscillator;83;83;120;83;84;84;109;83;83;114 21:34:41 INFO - PROCESS | 16470 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 21:34:41 INFO - PROCESS | 16470 | |6;imaging-darkroom;148;147;148;148;148;148;148;147;148;147 21:34:41 INFO - PROCESS | 16470 | |7;imaging-desaturate;85;84;84;84;84;84;84;84;84;84 21:34:41 INFO - PROCESS | 16470 | |8;json-parse-financial;64;64;63;62;71;65;65;65;64;67 21:34:41 INFO - PROCESS | 16470 | |9;json-stringify-tinderbox;68;68;67;67;68;67;66;66;69;68 21:34:41 INFO - PROCESS | 16470 | |10;stanford-crypto-aes;83;83;92;88;83;82;83;82;82;82 21:34:41 INFO - PROCESS | 16470 | |11;stanford-crypto-ccm;140;152;141;139;139;139;140;139;182;142 21:34:41 INFO - PROCESS | 16470 | |12;stanford-crypto-pbkdf2;185;179;189;185;185;177;178;177;177;178 21:34:41 INFO - PROCESS | 16470 | |13;stanford-crypto-sha256-iterative;70;70;70;69;71;78;70;69;69;67 21:34:41 INFO - PROCESS | 16470 | __end_tp_report 21:34:41 INFO - PROCESS | 16470 | __start_cc_report 21:34:41 INFO - PROCESS | 16470 | _x_x_mozilla_cycle_collect,1976 21:34:41 INFO - PROCESS | 16470 | __end_cc_report 21:34:41 INFO - PROCESS | 16470 | __startTimestamp1476851681872__endTimestamp 21:34:41 INFO - PROCESS | 16470 | 21:34:41 INFO - PROCESS | 16470 | ------- Summary: start ------- 21:34:41 INFO - PROCESS | 16470 | Number of tests: 14 21:34:41 INFO - PROCESS | 16470 | 21:34:41 INFO - PROCESS | 16470 | [#0] ai-astar Cycles:10 Average:112.20 Median:113.00 stddev:2.62 (2.3%) stddev-sans-first:0.71 21:34:41 INFO - PROCESS | 16470 | Values: 105.0 113.0 113.0 113.0 113.0 114.0 112.0 114.0 112.0 113.0 21:34:41 INFO - PROCESS | 16470 | 21:34:41 INFO - PROCESS | 16470 | [#1] audio-beat-detection Cycles:10 Average:140.50 Median:136.50 stddev:17.55 (12.9%) stddev-sans-first:17.92 21:34:41 INFO - PROCESS | 16470 | Values: 154.0 137.0 130.0 175.0 128.0 128.0 127.0 136.0 164.0 126.0 21:34:41 INFO - PROCESS | 16470 | 21:34:41 INFO - PROCESS | 16470 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.03 (0.6%) stddev-sans-first:1.09 21:34:41 INFO - PROCESS | 16470 | Values: 161.0 162.0 162.0 163.0 160.0 160.0 161.0 162.0 161.0 160.0 21:34:41 INFO - PROCESS | 16470 | 21:34:41 INFO - PROCESS | 16470 | [#3] audio-fft Cycles:10 Average:83.80 Median:77.50 stddev:14.11 (18.2%) stddev-sans-first:14.60 21:34:41 INFO - PROCESS | 16470 | Values: 75.0 78.0 77.0 110.0 78.0 77.0 78.0 78.0 111.0 76.0 21:34:41 INFO - PROCESS | 16470 | 21:34:41 INFO - PROCESS | 16470 | [#4] audio-oscillator Cycles:10 Average:92.60 Median:83.00 stddev:15.23 (18.3%) stddev-sans-first:15.75 21:34:41 INFO - PROCESS | 16470 | Values: 83.0 83.0 120.0 83.0 84.0 84.0 109.0 83.0 83.0 114.0 21:34:41 INFO - PROCESS | 16470 | 21:34:41 INFO - PROCESS | 16470 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 21:34:41 INFO - PROCESS | 16470 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 21:34:41 INFO - PROCESS | 16470 | 21:34:41 INFO - PROCESS | 16470 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 21:34:41 INFO - PROCESS | 16470 | Values: 148.0 147.0 148.0 148.0 148.0 148.0 148.0 147.0 148.0 147.0 21:34:41 INFO - PROCESS | 16470 | 21:34:41 INFO - PROCESS | 16470 | [#7] imaging-desaturate Cycles:10 Average:84.10 Median:84.00 stddev:0.32 (0.4%) stddev-sans-first:0.00 21:34:41 INFO - PROCESS | 16470 | Values: 85.0 84.0 84.0 84.0 84.0 84.0 84.0 84.0 84.0 84.0 21:34:41 INFO - PROCESS | 16470 | 21:34:41 INFO - PROCESS | 16470 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:65.00 stddev:2.49 (3.8%) stddev-sans-first:2.62 21:34:41 INFO - PROCESS | 16470 | Values: 64.0 64.0 63.0 62.0 71.0 65.0 65.0 65.0 64.0 67.0 21:34:41 INFO - PROCESS | 16470 | 21:34:41 INFO - PROCESS | 16470 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:68.00 stddev:0.97 (1.4%) stddev-sans-first:1.00 21:34:41 INFO - PROCESS | 16470 | Values: 68.0 68.0 67.0 67.0 68.0 67.0 66.0 66.0 69.0 68.0 21:34:41 INFO - PROCESS | 16470 | 21:34:41 INFO - PROCESS | 16470 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:83.00 stddev:3.33 (4.0%) stddev-sans-first:3.52 21:34:41 INFO - PROCESS | 16470 | Values: 83.0 83.0 92.0 88.0 83.0 82.0 83.0 82.0 82.0 82.0 21:34:41 INFO - PROCESS | 16470 | 21:34:41 INFO - PROCESS | 16470 | [#11] stanford-crypto-ccm Cycles:10 Average:145.30 Median:140.50 stddev:13.48 (9.6%) stddev-sans-first:14.16 21:34:41 INFO - PROCESS | 16470 | Values: 140.0 152.0 141.0 139.0 139.0 139.0 140.0 139.0 182.0 142.0 21:34:41 INFO - PROCESS | 16470 | 21:34:41 INFO - PROCESS | 16470 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.00 Median:182.00 stddev:4.50 (2.5%) stddev-sans-first:4.53 21:34:41 INFO - PROCESS | 16470 | Values: 185.0 179.0 189.0 185.0 185.0 177.0 178.0 177.0 177.0 178.0 21:34:41 INFO - PROCESS | 16470 | 21:34:41 INFO - PROCESS | 16470 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:70.00 stddev:2.91 (4.2%) stddev-sans-first:3.08 21:34:41 INFO - PROCESS | 16470 | Values: 70.0 70.0 70.0 69.0 71.0 78.0 70.0 69.0 69.0 67.0 21:34:41 INFO - PROCESS | 16470 | -------- Summary: end -------- 21:34:41 INFO - PROCESS | 16470 | 21:34:43 INFO - TEST-INFO | 16470: exit 0 21:34:43 INFO - TEST-OK | kraken | took 64741ms 21:34:43 INFO - SUITE-END | took 1187s 21:34:43 INFO - Completed test suite (00:19:47) 21:34:43 INFO - javascript benchmark 21:34:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2548.7833534149595, 2581.8579978101207, 2593.0664960614176, 2602.1803132013415, 2622.8688565571724, 4603.240465323226, 4665.580097791198, 4736.3369128322065, 4739.218029025211, 4750.263709125091, 4688.2030054890665, 4690.624750019999, 4700.85897423077, 4711.387519622444, 4715.03341814928, 4324.091940692459, 4346.717463364871, 4359.171757366106, 4388.429504164455, 4421.159979603881, 4392.450943632046, 4404.075144219718, 4420.580044895746, 4427.114577084596, 4428.579284967923, 4327.63215126713, 4338.609525142737, 4362.8909277268, 4386.38590597315, 4420.403245561856, 4401.0, 4423.535528769497, 4430.889227769299, 4462.776861156945, 4479.776011199427, 4232.534421213664, 4263.360495925605, 4268.829246830123, 4329.220740266751, 4343.500497442803, 4659.370984917026, 4685.5314468553215, 4707.435107787088, 4711.0342379812055, 4785.3300537924715, 4996.12567800637, 5033.119204139261, 5044.192929131358, 5061.316722242524, 5082.08522465956, 4911.533404326583, 4979.153543897546, 4984.40187177541, 4991.276264941599, 5072.594192464594, 4707.505711900236, 4734.384530011076, 4735.266033764772, 4772.0, 4776.641751868624, 5170.560502357266, 5181.248718935809, 5181.974090129525, 5184.0, 5245.737713114329, 4838.443578988461, 4877.048975449753, 4957.90084198314, 4964.875878103004, 5027.296178535008, 4994.525520075587, 5022.146235140035, 5050.04049230645, 5051.6716413433005, 5120.820771272987, 5013.273075404119, 5020.246962955513, 5023.0, 5025.095482813129, 5082.898342033212, 4977.626677999165, 4985.227289770091, 4999.175136102575, 5001.7499125043605, 5065.848024559269, 4227.852025179104, 4234.809433575497, 4269.060806622538, 4278.016056307005, 4316.482022157361, 3730.8880733578035, 3741.3639681254253, 3761.8307176177136, 3782.924341513154, 3803.6196380361744, 4292.763897985641, 4301.139772045603, 4303.311470164758, 4327.610515053598, 4358.65130789536, 4942.505749425029, 4988.750562471934, 4995.775190116454, 5038.3198268234055, 5042.117629414838, 4285.46431696038, 4298.398224248608, 4307.6769242306955, 4309.1381723655395, 4310.37499562568, 4505.7296562206375, 4565.972656152406, 4566.817327306937, 4567.040921406476, 4569.817207311737, 4727.598154156935, 4729.054189162112, 4731.668783185213, 4731.834385796481, 4734.384530011076, 5028.446870844277, 5049.495050494921, 5066.113430149635, 5086.694798312114, 5158.664686795346, 4712.50518695532, 4755.500672429345, 4756.904861902812, 4804.0872234275375, 4816.735079570657, 4988.351514303117, 5004.524570165974, 5009.298698182331, 5010.574101201439, 5037.19404895215, 4935.876603084808, 4990.0, 4994.900101998012, 5079.034983353151, 5148.150555158507, 4914.975425122851, 4927.162382395073, 4929.852104436873, 4932.260160975882, 4932.4327702314695, 4913.9017219656125, 4919.827806026772, 4922.803087876445, 4924.926126108039, 4925.802967881388, 4795.712257264436, 4832.540908613676, 4846.39420072491, 4853.611711063036, 4903.460619331942, 4880.243562247857, 4929.605631549539, 4949.406071271471, 4992.301077849032, 5006.3992320921725, 4806.723024562628, 4815.807367705253, 4823.300621409946, 4873.926891096708, 4881.804727810848], "value": 4631.051230494243, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.5709260961669, 574.6236215278993, 578.5863107877866, 581.2937281203338, 582.1529674323859, 28071.298217544572, 38495.80752096243, 40125.598744012554, 40212.0, 43903.0, 40112.0, 40330.59669403305, 40474.59525404745, 40540.0, 40568.59431405692, 7652.426068044905, 7796.337311328544, 7802.921970780305, 7812.453128281023, 7814.921850781505, 6948.617826019592, 7154.785356439289, 9751.414915105117, 10022.498875056255, 10022.79726432829, 10052.396856188616, 10106.242031847603, 10111.0, 10113.494325283744, 10116.494175291244, 10015.59937602495, 10097.19222462205, 10102.0, 10113.443760593165, 10114.0, 9928.255380846465, 9937.80124397508, 9993.650222242186, 10003.149732272766, 10012.69961901144, 37267.627323726956, 37999.620003799886, 38013.80993095045, 38015.0, 38042.0, 2920.2115428834095, 2926.4293462774767, 2980.6125203723595, 3046.329807442359, 3131.4206871728575, 27689.44621107587, 27801.304967375774, 27853.442931141468, 27878.3030424241, 27896.0, 3267.9836600816843, 3286.8849590264226, 3350.547676063725, 3392.728581713457, 3414.0270023043563, 241113.0, 241762.0, 241831.0, 242937.0, 243526.0, 52447.213291800654, 52773.7361313191, 52849.0, 52856.73571632117, 52945.73527132417, 54188.93582981292, 54197.0, 54224.728876355366, 54298.72850635721, 54361.72819135879, 12972.416241269166, 13057.934710326577, 13063.934680326727, 13114.082014259102, 13114.147580407243, 11321.207515473838, 11325.660230193107, 11329.320240785579, 11339.262947908524, 11345.432728363548, 13431.731365372832, 13809.792853107212, 14959.551213463395, 15261.771073433907, 15510.922445387701, 5413.891722165535, 5614.915776263278, 5766.971165144231, 5787.594868359174, 5845.444682755132, 755.4522970846093, 827.3629305434781, 854.2055888024197, 877.7673916412156, 973.4159504297365, 25041.24876253679, 25729.88156544797, 26496.8675156623, 26892.462150756874, 27066.729332706815, 931.001866955864, 938.3290946972947, 949.9382540134869, 1045.2004216774174, 1070.2719323913498, 14207.73170016945, 14272.785908211385, 14509.274536273144, 14537.636559085897, 14624.707505850036, 350400.0, 351446.0, 352691.0, 352767.0, 353867.0, 41678.0, 42874.35688464675, 42920.78539607282, 47459.28811067837, 48356.27465588019, 1136.4033882211904, 1154.8152295632658, 1181.4919584578713, 1189.5955375172482, 1199.1366216324232, 27408.588871167347, 28253.15240542787, 28644.713552864203, 28705.28236794097, 28901.132966011053, 42584.36123458089, 43002.569974299855, 43024.0, 43038.56961430471, 43052.56947430611, 365633.0, 374450.0, 375580.0, 577004.0, 578618.0, 24484.265472035866, 24508.142215022388, 24776.50446991014, 24787.752122478545, 24805.62791558164, 40743.1851362977, 40946.0, 41433.79283103565, 41752.164956700086, 42504.78747606242, 35083.824580876935, 35147.82426087853, 35626.8218658905, 35803.641963580034, 35895.0, 34897.953061408196, 35435.114122147155, 35632.82183589065, 35633.82183089172, 35802.641973580976, 32915.34169316648, 34095.65904340925, 34294.14264643404, 35102.297954041285, 35567.82216088903, 30234.54648180235, 32669.0, 32799.0, 32906.341873161924, 32991.0, 24294.27117186487, 24632.876835616426, 24654.0, 24713.0, 24820.25539233826], "value": 17567.062705591514, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.2619051182652, 344.7035549427492, 363.7962740865116, 366.43203035295295, 377.47719408619054, 12266.386680665975, 13266.66833329166, 15774.13242271676, 16009.19954002301, 16599.83400165998, 15022.549323520285, 15044.774328385083, 15049.77425338618, 15180.089194648328, 15357.15535645539, 4799.448063472693, 5052.115879721034, 5055.090083784918, 5055.570276526481, 5056.974715126419, 4998.675086119409, 5234.214867769827, 5262.526372626463, 5321.388040375348, 5329.360476742777, 5295.735213239323, 5312.362516498026, 5316.707581083039, 5351.7324133793345, 5355.6251062425645, 5109.386873575158, 5244.711540865251, 5275.630705850592, 5281.128613778722, 5286.101362768339, 4981.950180498185, 5122.154844450662, 5126.051680439131, 5126.512981266774, 5132.358455193101, 12272.754544909052, 16005.839941600552, 19544.80455195458, 20219.898900505552, 20285.0, 1810.3663717698832, 1861.4229588827507, 1950.6878899376175, 2388.713354397466, 2391.976080239193, 8997.640094396216, 9320.673776417792, 10024.19806415485, 11596.188266821326, 13266.800997985038, 1663.7005339038967, 1690.8140104588485, 1718.6390857919853, 1734.9219285132199, 1756.771619689432, 59913.40086599165, 63826.36173638297, 64991.0, 65174.674126629536, 65425.3457465424, 9623.903760962441, 9812.411255324703, 9837.950810245902, 10071.129728027478, 10096.848547271797, 13633.727325453436, 13642.522511712043, 13651.453941842414, 13657.112287701466, 13671.111377760413, 7032.683529241196, 7201.603911784798, 7233.132024157135, 7395.149557800922, 7413.518121322205, 6910.7581234656545, 6917.89623155653, 7069.293070692889, 7114.57312561248, 7141.82145446368, 4165.500139983222, 4178.26880295947, 4232.703710740218, 4323.870283891489, 4378.0, 1734.6443978984278, 1776.7740259221096, 1818.1545581304756, 1830.9176087076114, 1842.5025243184266, 652.3443938841434, 777.1179711027911, 784.5488843914658, 844.025150950653, 890.3633901760272, 15875.444359447363, 16309.429169978994, 16552.586185345222, 16752.41366552165, 17135.0, 768.4352001279055, 814.0638265994036, 823.283743143469, 878.1262643669589, 884.7301573020162, 8755.737327880173, 9300.162985331353, 9384.343095983351, 9408.717738467856, 9477.336586439022, 404346.0, 408864.0, 410219.0, 410891.0, 411879.0, 66351.66824165944, 67889.32110678928, 70110.64944675346, 70657.0, 75566.62216688882, 930.4603330068544, 941.4022095969109, 987.9950600247097, 992.4095163377779, 999.3404353126901, 15197.77203341973, 15437.0737755735, 15555.14446705442, 15575.688486230438, 16169.838301617303, 36858.0, 36898.0, 37158.8142059288, 37774.43338349872, 38049.239015218984, 48820.45642012705, 48853.755731221114, 51614.0, 52406.73796630993, 52962.2055669173, 7185.748498802517, 7250.238724933806, 7283.672234749343, 7433.219511951167, 7434.182239953709, 8304.252617264476, 10919.344839309666, 11010.449477526252, 11027.61403350911, 11380.430978450879, 9683.612655493702, 9722.513874306398, 9877.259205559469, 9893.307468477138, 10185.439800810731, 10024.649137280452, 10053.648122315684, 10113.19094472455, 10401.739956500845, 10443.0, 9882.357646752938, 10119.342242754197, 10144.644937427154, 10260.0, 10263.23025773055, 7450.515716478411, 7490.812729681802, 7548.924510755041, 7585.734499292719, 7750.031246094239, 9709.417434953926, 9884.25868059884, 9895.55470003866, 9971.623835977813, 10316.381017138996], "value": 8006.227580148249, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1357.104311154638, 1405.114777690055, 1481.2593703148425, 1612.6290953080797, 1688.0968681755264, 6625.933740662592, 6884.793456196322, 7146.928530714691, 7709.922900770991, 7715.72994945177, 7492.9625351873165, 7755.650995705193, 7765.107012693542, 7969.282764551189, 7983.481073730203, 2151.290074275493, 2165.71845660064, 2173.467500462389, 2182.9126834926583, 2183.4541364658835, 1754.8947063176186, 1807.060328629112, 2086.09254974086, 2155.752088509818, 2159.5788821179876, 2067.7001834733956, 2132.019271135272, 2133.8506304558687, 2156.8166705829944, 2165.8483906126576, 2129.3079749081458, 2151.6449785785403, 2155.676648502729, 2171.543975765091, 2187.278198194592, 2062.247279742883, 2068.2037415594955, 2072.927447539344, 2074.9377518674464, 2076.0553947953645, 7605.543667379975, 7732.961335193288, 7736.419768517328, 7746.535207887545, 7747.302742753123, 4357.629601483878, 4494.1910456117885, 4501.257292546726, 4501.48232953208, 4502.932456013163, 2691.542437785581, 2762.1575419497044, 2797.5384061629807, 2799.930001749952, 2801.6918139004692, 886.2865393358344, 889.155302462663, 900.6307413960245, 904.186232390847, 910.0444533240071, 10329.483525823678, 10339.844902326397, 10457.790844183073, 10505.2646314758, 10518.579256829718, 3881.514810648669, 4103.815328310233, 4213.073123912734, 4248.617624413818, 4273.594008569181, 8886.11138886119, 8890.955545222361, 8894.777630559287, 8912.153345432174, 8915.910840891507, 4567.2464043432465, 4583.129205450954, 4600.148972440109, 4600.401947746772, 4601.930971035437, 4090.141070375195, 4123.587641235912, 4129.421880936671, 4133.111381053028, 4136.31750761121, 3565.6790888820133, 3569.23261498779, 3647.343478173901, 3666.5233519642275, 3694.039549717093, 1037.5434808684154, 1085.913126949842, 1161.5644133449957, 1174.629991552658, 1174.9823752643717, 623.9469645080219, 693.9826504337432, 729.6023667101442, 761.9466637335444, 815.4943934760487, 4921.163402221631, 5015.163399999004, 5087.771050302671, 5128.282040514331, 5141.922871156936, 761.6572542355962, 802.5385403393072, 822.5023860564391, 847.8092429203504, 868.2489646455771, 3313.5526703894666, 3421.3841508528703, 3427.7943323400677, 3444.569428821397, 3482.91292717679, 9346.953265233631, 9618.663346782829, 9700.320977531504, 9718.319717619841, 9745.707628771148, 8918.464892106495, 9647.035296470296, 9650.276229282832, 9668.129868311746, 9674.03259674041, 7007.299270072952, 7133.89299160513, 7142.964285178541, 7149.142102947576, 7189.382388962546, 4832.34763306949, 4935.284383764262, 5051.0, 5085.542301192911, 5199.55803756685, 8533.146685331418, 8600.0, 8798.12018798115, 8939.284857211278, 8947.463152210888, 8779.692710755093, 9111.088891110836, 9120.270378369847, 9137.0, 9234.95382523083, 6707.5304728668525, 6786.185657721105, 6861.245263020964, 6868.450523958171, 6869.862602748017, 7462.216467270859, 7479.214682458482, 7521.5111017783665, 7548.056492938383, 7556.962215188889, 6482.384173503509, 6531.11829902957, 6557.9344206557325, 6720.932790672031, 6760.560563563353, 6415.775447859302, 6538.346165383424, 6567.934320656732, 6583.604983700993, 6598.076269322395, 6016.097585362056, 6150.0, 6150.0, 6150.723217455135, 6150.7847225346895, 4214.704970652025, 4236.809343579608, 4239.936400953927, 4267.466566679165, 4354.412154359121, 4208.410822484793, 4294.506131794884, 4318.9568104319815, 4385.780710964503, 4512.029913568598], "value": 4027.383386872341, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.49433749432256, 291.0714819725077, 293.9882404703812, 294.3788606041254, 298.26031442023793, 4596.218642830719, 4720.90558188836, 4780.42634883814, 4797.784099715513, 4814.927776083362, 4532.229520981433, 4650.488446270908, 4672.205725026745, 4696.0, 4714.5756881880625, 3748.1941382602736, 3763.322601931651, 3779.489768881207, 3783.9621603783885, 3790.298794722985, 3540.468929660559, 3738.1589142443004, 3750.324941510527, 3765.755225910307, 3776.603456637055, 3454.7236221102253, 3711.183539621279, 3712.1462063725357, 3716.4053751399783, 3718.293524230401, 3713.591504934455, 3721.62783721627, 3725.4784330193793, 3738.214974855284, 3738.3831667774784, 3305.7190138838228, 3314.5691060162267, 3315.3037862049, 3320.3027364253535, 3329.983350083234, 4527.4340707411575, 4579.335996280521, 4615.26155815068, 4642.234031384817, 4655.766221951186, 4209.473815773028, 4217.768022758747, 4228.365745138223, 4237.258479766028, 4238.7880605969885, 4906.656534042619, 4915.5330243626795, 4936.48166942473, 4941.604671626261, 4947.678400903929, 3519.489673997256, 3594.9149493293826, 3599.470225154299, 3600.243948770761, 3612.7832330060282, 5079.746012699387, 5109.3613298337705, 5112.0, 5120.3855537335385, 5130.4356520782685, 3652.160003199279, 3659.524261845943, 3666.7433279670167, 3668.211334563082, 3670.743047986669, 3719.902628724533, 3740.121071548184, 3770.7171962102952, 3784.0, 3794.29805485986, 3971.8808435746973, 4197.8320867165585, 4211.7262377945335, 4308.892277693083, 4316.0, 4947.406311242674, 4970.3290055842, 4982.487346420765, 4997.675151115239, 5015.0, 1157.2535714464123, 1190.6902407351843, 1239.9938000309942, 1259.7102666386781, 1269.1306455078302, 819.6516480495766, 846.1073567386344, 852.778277647816, 852.8038551133274, 860.4794099569796, 4307.935380969226, 4319.222539942778, 4342.609165175149, 4344.0, 4356.346548017823, 5031.509402845615, 5036.3380084572, 5059.468755780664, 5060.367454068241, 5073.492650734897, 4217.1776503581505, 4314.80583373749, 4329.393884856123, 4330.7401555906745, 4331.393604895317, 2654.588538776493, 2683.114572191172, 2684.9731502685113, 2696.9865150674123, 2699.757021868002, 4752.835555288907, 4766.404199475066, 4780.4741478437345, 4786.856394308176, 4795.880102997453, 4936.703797772145, 5135.6405051646025, 5157.200633901752, 5166.767495462713, 5175.654329874184, 4738.19450693383, 4740.123077230654, 4744.169770290255, 4746.19314716506, 4747.192977193817, 5025.0, 5047.4952504749235, 5056.974715126401, 5067.797288108434, 5071.644984851025, 4730.148573256847, 4849.58778503817, 4908.386451693538, 4931.260310953242, 4964.4539100698175, 4693.436787585511, 4699.942512934563, 4709.293605959134, 4712.952870471388, 4713.410823647044, 3556.377633914003, 3564.6435356464144, 3569.126208740432, 3574.7855128692363, 3589.9102522437147, 4871.687252668078, 5059.165237735732, 5060.8987820242655, 5144.7942082316285, 5180.48195180494, 5003.2745251938995, 5015.64890457679, 5020.874478138076, 5028.245763135413, 5037.808553279335, 4992.276119962513, 4993.775280112331, 5022.573081288131, 5025.3718285214345, 5042.109209046607, 4665.883352916204, 4780.808767649255, 4872.829450969199, 4906.0433215522635, 4939.0, 4877.756112194447, 4894.388201474816, 4894.895195066156, 4900.975495122501, 4942.283368911416, 4787.353707249476, 4830.66185367035, 4912.754362281943, 4959.660891559331, 4982.676126051795], "value": 3731.679677960705, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [636.9012803015535, 657.8256761958081, 659.5020759326708, 681.4616453002128, 720.1897864901986, 12577.11960162788, 13616.251106189156, 13866.37601307941, 13868.098573592722, 13879.791803122936, 12338.136330456871, 12403.503859845596, 12407.441665125069, 12410.441530131144, 12417.813732794015, 625.4839757200306, 633.4805459523193, 741.6477173342673, 752.8155601877547, 760.4068826315469, 774.8217909880731, 780.1418439716296, 780.3718007004359, 782.886481460188, 783.2872086401376, 853.7225401744427, 853.7353420439683, 854.8803167556547, 856.0113069404816, 856.8971723393202, 656.6946369937978, 665.1585744033802, 813.369638530138, 822.6873787960536, 841.247083859945, 607.2318517075903, 607.32890156377, 607.875385545962, 608.1334098909036, 608.4068033667183, 12229.571964981273, 12241.143119981605, 12257.816132758016, 12285.262884226975, 12374.0, 11525.884741152566, 11649.417529123595, 11659.304485535376, 11939.522419103312, 12651.557195498113, 10891.83662245067, 11059.0, 11221.775564488746, 11258.943705281503, 11328.263662861887, 4043.5349934757587, 4063.3295506241434, 4155.8753237402925, 4169.437125987984, 4316.136772645484, 62027.069593955675, 62039.6898015507, 62289.377106228814, 63199.36800631981, 64989.67505162444, 9231.307651926132, 9284.7678808029, 9307.556204204488, 9457.10157535033, 9476.289278304155, 16474.505764826834, 16775.496735097968, 16787.664246714998, 16890.83109168917, 17987.370442034728, 6288.371162883766, 6314.589551679126, 6367.076773867763, 6472.449841763503, 6505.60966342021, 3322.302316513559, 3334.533165356852, 3348.196432856097, 3426.623071462137, 3452.171478845059, 2774.18161642316, 2798.860056997142, 2815.1835967569177, 2832.830030198195, 2835.9007434739683, 499.370792801066, 500.39702158899166, 503.4361515103108, 506.23811164197645, 513.2865317209082, 441.5672640812022, 443.4146926057637, 539.2046731071638, 542.452123355406, 581.5957909253028, 6825.931740682529, 6862.451003919675, 6893.827654308582, 7249.383802376857, 7314.0, 449.4180036852284, 472.65732344050974, 473.2404490792229, 490.8429302623198, 491.1772780592493, 3428.4171690812623, 3470.843812028414, 3490.860365585399, 3572.5534308211472, 3601.5858176309534, 71247.64376178086, 93843.53078234565, 100400.497997511, 101337.49331253444, 101692.49153754332, 45317.54682453199, 58598.0, 64227.0, 77416.2258377409, 78042.60978695184, 42268.788656056524, 54326.72836635871, 59470.0, 66069.66965165336, 66725.0, 7570.886436703344, 8297.336213103057, 8310.168983101641, 8480.575971201291, 8538.487690738575, 30651.08046758601, 40341.39487907625, 41363.379549307385, 42364.0, 42807.785961069996, 55299.723501382236, 55997.0, 58649.0, 61565.0, 64483.0, 10093.343932644355, 10276.743081423025, 10953.233273670767, 11200.271982321123, 11387.0321022714, 12269.509219631473, 12539.749205015665, 12668.303243321705, 13052.15161014531, 13181.472741090249, 10329.483525823829, 10777.407242601732, 10983.890161098287, 11459.36973466434, 11581.24721893108, 10959.561617535528, 10971.341719496855, 11118.221724479208, 11891.28652280866, 11908.821367679318, 10493.632722854663, 10508.21188410857, 10826.945865270623, 10937.890621093688, 11381.146414018816, 9306.348555601044, 9464.148226659634, 9503.429794212369, 9604.567794449405, 10403.323783954018, 9935.354201976848, 9964.302498825013, 10131.87087124517, 10184.0, 10218.795624087625], "value": 6218.816562533897, "unit": "score"}], "name": "dromaeo_css", "value": 6272.136664226405, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 113.0, 113.0, 113.0, 114.0, 112.0, 114.0, 112.0, 113.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 137.0, 130.0, 175.0, 128.0, 128.0, 127.0, 136.0, 164.0, 126.0], "value": 140.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 163.0, 160.0, 160.0, 161.0, 162.0, 161.0, 160.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 77.0, 110.0, 78.0, 77.0, 78.0, 78.0, 111.0, 76.0], "value": 83.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 120.0, 83.0, 84.0, 84.0, 109.0, 83.0, 83.0, 114.0], "value": 92.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 148.0, 148.0, 148.0, 148.0, 147.0, 148.0, 147.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 84.0, 84.0, 84.0, 84.0, 84.0, 84.0, 84.0], "value": 84.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 62.0, 71.0, 65.0, 65.0, 65.0, 64.0, 67.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 67.0, 68.0, 67.0, 66.0, 66.0, 69.0, 68.0], "value": 67.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 92.0, 88.0, 83.0, 82.0, 83.0, 82.0, 82.0, 82.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 152.0, 141.0, 139.0, 139.0, 139.0, 140.0, 139.0, 182.0, 142.0], "value": 145.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 179.0, 189.0, 185.0, 185.0, 177.0, 178.0, 177.0, 177.0, 178.0], "value": 181.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 70.0, 69.0, 71.0, 78.0, 70.0, 69.0, 69.0, 67.0], "value": 70.3, "unit": "score"}], "name": "kraken", "value": 1552.1, "alertThreshold": 2.0}]} 21:34:43 INFO - Return code: 0 21:34:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:34:43 INFO - # TBPL SUCCESS # 21:34:43 INFO - Running post-action listener: _resource_record_post_action 21:34:43 INFO - [mozharness: 2016-10-19 04:34:43.691593Z] Finished run-tests step (success) 21:34:43 INFO - Running post-run listener: _resource_record_post_run 21:34:43 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 12288; Write bytes: 400740352; Read time: 108; Write time: 278480 21:34:43 INFO - TinderboxPrint: CPU usage
13.0% 21:34:43 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 108 21:34:43 INFO - TinderboxPrint: I/O write bytes / time
400,740,352 / 278,480 21:34:43 INFO - TinderboxPrint: CPU idle
8,357.1 (87.0%) 21:34:43 INFO - TinderboxPrint: CPU user
1,200.5 (12.5%) 21:34:43 INFO - TinderboxPrint: Swap in / out
0 / 0 21:34:43 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110292992; Read time: 0; Write time: 75516 21:34:43 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 8192; Write bytes: 289316864; Read time: 96; Write time: 202936 21:34:44 INFO - Running post-run listener: _upload_blobber_files 21:34:44 INFO - Blob upload gear active. 21:34:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:34:44 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 21:34:44 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'] 21:34:44 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 21:34:44 INFO - (blobuploader) - INFO - Open directory for files ... 21:34:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:34:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:34:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:34:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:34:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:34:45 INFO - (blobuploader) - INFO - Done attempting. 21:34:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:34:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:34:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:34:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:34:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:34:46 INFO - (blobuploader) - INFO - Done attempting. 21:34:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:34:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:34:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:34:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:34:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:34:49 INFO - (blobuploader) - INFO - Done attempting. 21:34:49 INFO - (blobuploader) - INFO - Iteration through files over. 21:34:49 INFO - Return code: 0 21:34:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:34:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:34:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/382a95387664320331a90697a8d4c054e04708175937dbc0f5c27c86cda511746b9c95dd54b22ff4688db2052c77729e80beed64a874e3f383b5006cbb508c7b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cdd5478ee69c48ba26508b151effccf785992f2d1136e6c2d474e2906af2c4f224d64740422c2d8ecc01610da88a38bf68c13b6172b9355725ecce14aa36e5dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/058db768f664920446e907d67058226649741cc60e8d5979124e73c7433b49c22fa9024a8a757e2868d457f546b9abc440a6beff0ca1a752d6b977fe7e8357cf"} 21:34:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:34:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:34:49 INFO - Contents: 21:34:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/382a95387664320331a90697a8d4c054e04708175937dbc0f5c27c86cda511746b9c95dd54b22ff4688db2052c77729e80beed64a874e3f383b5006cbb508c7b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cdd5478ee69c48ba26508b151effccf785992f2d1136e6c2d474e2906af2c4f224d64740422c2d8ecc01610da88a38bf68c13b6172b9355725ecce14aa36e5dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/058db768f664920446e907d67058226649741cc60e8d5979124e73c7433b49c22fa9024a8a757e2868d457f546b9abc440a6beff0ca1a752d6b977fe7e8357cf"} 21:34:49 INFO - Running post-run listener: copy_logs_to_upload_dir 21:34:49 INFO - Copying logs to upload dir... 21:34:49 INFO - mkdir: /builds/slave/test/build/upload/logs 21:34:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.728151 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-18 21:34:49.237660) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-18 21:34:49.241179) ========= 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=652eb03db935cfc1c15ebda0000001ad-1476849198.497072-2087272351 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/382a95387664320331a90697a8d4c054e04708175937dbc0f5c27c86cda511746b9c95dd54b22ff4688db2052c77729e80beed64a874e3f383b5006cbb508c7b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cdd5478ee69c48ba26508b151effccf785992f2d1136e6c2d474e2906af2c4f224d64740422c2d8ecc01610da88a38bf68c13b6172b9355725ecce14aa36e5dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/058db768f664920446e907d67058226649741cc60e8d5979124e73c7433b49c22fa9024a8a757e2868d457f546b9abc440a6beff0ca1a752d6b977fe7e8357cf"} build_url:https://queue.taskcluster.net/v1/task/aLUBWTcIRsKhL-YTEbjDzQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011366 build_url: 'https://queue.taskcluster.net/v1/task/aLUBWTcIRsKhL-YTEbjDzQ/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/382a95387664320331a90697a8d4c054e04708175937dbc0f5c27c86cda511746b9c95dd54b22ff4688db2052c77729e80beed64a874e3f383b5006cbb508c7b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cdd5478ee69c48ba26508b151effccf785992f2d1136e6c2d474e2906af2c4f224d64740422c2d8ecc01610da88a38bf68c13b6172b9355725ecce14aa36e5dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/058db768f664920446e907d67058226649741cc60e8d5979124e73c7433b49c22fa9024a8a757e2868d457f546b9abc440a6beff0ca1a752d6b977fe7e8357cf"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-18 21:34:49.267235) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 21:34:49.267566) ========= 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=652eb03db935cfc1c15ebda0000001ad-1476849198.497072-2087272351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004391 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 21:34:49.351595) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-18 21:34:49.352151) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-18 21:34:49.352715) ========= ========= Total master_lag: 0.17 =========