builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-033 starttime: 1477955539.42 results: success (0) buildid: 20161031120204 builduid: c6d2503dd6bb4f12a2c414ab3220dcb8 revision: 1aa20bcbb80e1014e4d01057f7d52269b0c2d908 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 16:12:19.417136) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 16:12:19.417763) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 16:12:19.418164) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 16:12:19.436594) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 16:12:19.436925) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1477955538.659919-782898617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-31 16:12:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 57.7M=0s 2016-10-31 16:12:19 (57.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.113465 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 16:12:19.564195) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 16:12:19.564515) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1477955538.659919-782898617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014980 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 16:12:19.614306) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 16:12:19.614697) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1aa20bcbb80e1014e4d01057f7d52269b0c2d908 --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 1aa20bcbb80e1014e4d01057f7d52269b0c2d908 --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=edae0fb5fee9fb758e8af6d3000002a4-1477955538.659919-782898617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-31 16:12:19,759 truncating revision to first 12 chars 2016-10-31 16:12:19,759 Setting DEBUG logging. 2016-10-31 16:12:19,759 attempt 1/10 2016-10-31 16:12:19,759 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1aa20bcbb80e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-31 16:12:20,079 unpacking tar archive at: fx-team-1aa20bcbb80e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.630468 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 16:12:20.258736) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 16:12:20.259075) ========= script_repo_revision: 1aa20bcbb80e1014e4d01057f7d52269b0c2d908 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 16:12:20.259508) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 16:12:20.259768) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 16:12:20.271212) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-10-31 16:12:20.271653) ========= /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=edae0fb5fee9fb758e8af6d3000002a4-1477955538.659919-782898617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:12:20 INFO - MultiFileLogger online at 20161031 16:12:20 in /builds/slave/test 16:12:20 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 16:12:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:12:20 INFO - {'append_to_log': False, 16:12:20 INFO - 'base_work_dir': '/builds/slave/test', 16:12:20 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:12:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:12:20 INFO - 'branch': 'Fx-Team-Non-PGO', 16:12:20 INFO - 'buildbot_json_path': 'buildprops.json', 16:12:20 INFO - 'config_files': ('talos/linux_config.py',), 16:12:20 INFO - 'default_actions': ('clobber', 16:12:20 INFO - 'read-buildbot-config', 16:12:20 INFO - 'download-and-extract', 16:12:20 INFO - 'populate-webroot', 16:12:20 INFO - 'create-virtualenv', 16:12:20 INFO - 'install', 16:12:20 INFO - 'run-tests'), 16:12:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:12:20 INFO - 'download_minidump_stackwalk': True, 16:12:20 INFO - 'download_symbols': 'ondemand', 16:12:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:12:20 INFO - 'tooltool.py': '/tools/tooltool.py', 16:12:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:12:20 INFO - '/tools/misc-python/virtualenv.py')}, 16:12:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:12:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:12:20 INFO - 'installer_path': 'installer.exe', 16:12:20 INFO - 'log_level': 'info', 16:12:20 INFO - 'log_name': 'talos', 16:12:20 INFO - 'log_to_console': True, 16:12:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:12:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:12:20 INFO - 'opt_config_files': (), 16:12:20 INFO - 'pip_index': False, 16:12:20 INFO - 'sps_profile': False, 16:12:20 INFO - 'sps_profile_interval': 0, 16:12:20 INFO - 'suite': 'dromaeojs', 16:12:20 INFO - 'system_bits': '32', 16:12:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:12:20 INFO - 'title': 'talos-linux64-ix-033', 16:12:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:12:20 INFO - 'use_talos_json': True, 16:12:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:12:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:12:20 INFO - 'work_dir': 'build'} 16:12:20 INFO - [mozharness: 2016-10-31 23:12:20.509044Z] Running clobber step. 16:12:20 INFO - Running pre-action listener: _resource_record_pre_action 16:12:20 INFO - Running main action method: clobber 16:12:20 INFO - rmtree: /builds/slave/test/build 16:12:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:12:20 INFO - Running post-action listener: _resource_record_post_action 16:12:20 INFO - [mozharness: 2016-10-31 23:12:20.971745Z] Finished clobber step (success) 16:12:20 INFO - [mozharness: 2016-10-31 23:12:20.971844Z] Running read-buildbot-config step. 16:12:20 INFO - Running pre-action listener: _resource_record_pre_action 16:12:20 INFO - Running main action method: read_buildbot_config 16:12:20 INFO - Using buildbot properties: 16:12:20 INFO - { 16:12:20 INFO - "project": "", 16:12:20 INFO - "product": "firefox", 16:12:20 INFO - "script_repo_revision": "production", 16:12:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:12:20 INFO - "repository": "", 16:12:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 16:12:20 INFO - "buildid": "20161031120204", 16:12:20 INFO - "pgo_build": "False", 16:12:20 INFO - "basedir": "/builds/slave/test", 16:12:20 INFO - "buildnumber": 2221, 16:12:20 INFO - "slavename": "talos-linux64-ix-033", 16:12:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:12:20 INFO - "platform": "ubuntu64_hw", 16:12:20 INFO - "scheduler": "tests-fx-team-linux64-talos", 16:12:20 INFO - "branch": "fx-team", 16:12:20 INFO - "repo_path": "integration/fx-team", 16:12:20 INFO - "revision": "1aa20bcbb80e1014e4d01057f7d52269b0c2d908", 16:12:20 INFO - "stage_platform": "linux64", 16:12:20 INFO - "builduid": "c6d2503dd6bb4f12a2c414ab3220dcb8", 16:12:20 INFO - "slavebuilddir": "test" 16:12:20 INFO - } 16:12:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/A5BeFCSLSau4DGm7p2LZ7w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 16:12:20 INFO - Running post-action listener: _resource_record_post_action 16:12:20 INFO - [mozharness: 2016-10-31 23:12:20.974287Z] Finished read-buildbot-config step (success) 16:12:20 INFO - [mozharness: 2016-10-31 23:12:20.974376Z] Running download-and-extract step. 16:12:20 INFO - Running pre-action listener: _resource_record_pre_action 16:12:20 INFO - Running main action method: download_and_extract 16:12:20 INFO - mkdir: /builds/slave/test/build/tests 16:12:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:20 INFO - trying https://queue.taskcluster.net/v1/task/A5BeFCSLSau4DGm7p2LZ7w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 16:12:20 INFO - Downloading https://queue.taskcluster.net/v1/task/A5BeFCSLSau4DGm7p2LZ7w/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 16:12:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A5BeFCSLSau4DGm7p2LZ7w/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 16:12:21 INFO - Downloaded 1361 bytes. 16:12:21 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 16:12:21 INFO - Using the following test package requirements: 16:12:21 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 16:12:21 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:12:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:12:21 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:12:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:12:21 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:12:21 INFO - u'jsshell-linux-x86_64.zip'], 16:12:21 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:12:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:12:21 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 16:12:21 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:12:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:12:21 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:12:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:12:21 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:12:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:12:21 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:12:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:12:21 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:12:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A5BeFCSLSau4DGm7p2LZ7w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 16:12:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A5BeFCSLSau4DGm7p2LZ7w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:12:21 INFO - Fetch https://queue.taskcluster.net/v1/task/A5BeFCSLSau4DGm7p2LZ7w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 16:12:22 INFO - Http code: 200 16:12:22 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 16:12:22 INFO - x-amz-cf-id: seFXNOQD9ljz3OTnDF6ttluhXOBIb23S0aL7ezKPIv6YFmEHU7hDRg== 16:12:22 INFO - x-amz-version-id: M.Cos5eD4RbrcsgWZtuS9bRU7bR5.9ZS 16:12:22 INFO - Expected file size: 20452472 16:12:22 INFO - Obtained file size: 20452472 16:12:26 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 16:12:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A5BeFCSLSau4DGm7p2LZ7w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 16:12:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A5BeFCSLSau4DGm7p2LZ7w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:12:26 INFO - Fetch https://queue.taskcluster.net/v1/task/A5BeFCSLSau4DGm7p2LZ7w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 16:12:27 INFO - Http code: 200 16:12:27 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 16:12:27 INFO - x-amz-cf-id: ruHCA1cDWAXqocn24k_SRVNeQP_wOr3E_RF9fsxTjqf9UQP7Kc-UbA== 16:12:27 INFO - x-amz-version-id: M.Cos5eD4RbrcsgWZtuS9bRU7bR5.9ZS 16:12:27 INFO - Expected file size: 20452472 16:12:27 INFO - Obtained file size: 20452472 16:12:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A5BeFCSLSau4DGm7p2LZ7w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 16:12:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A5BeFCSLSau4DGm7p2LZ7w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:12:31 INFO - Fetch https://queue.taskcluster.net/v1/task/A5BeFCSLSau4DGm7p2LZ7w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 16:12:32 INFO - Http code: 200 16:12:32 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 16:12:32 INFO - x-amz-cf-id: 3lgkPJMXv8iVd1unHzwib6MgsAct-za77mFgACr1hj7tyQLFoVSxXw== 16:12:32 INFO - x-amz-version-id: 4ItG.EevWsd3IEHrnpwIAPM62.BlWnsb 16:12:32 INFO - Expected file size: 14409038 16:12:32 INFO - Obtained file size: 14409038 16:12:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:32 INFO - trying https://queue.taskcluster.net/v1/task/A5BeFCSLSau4DGm7p2LZ7w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:12:32 INFO - Downloading https://queue.taskcluster.net/v1/task/A5BeFCSLSau4DGm7p2LZ7w/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 16:12:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A5BeFCSLSau4DGm7p2LZ7w/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 16:12:33 INFO - Downloaded 55817887 bytes. 16:12:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A5BeFCSLSau4DGm7p2LZ7w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:12:33 INFO - mkdir: /builds/slave/test/properties 16:12:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:12:33 INFO - Writing to file /builds/slave/test/properties/build_url 16:12:33 INFO - Contents: 16:12:33 INFO - build_url:https://queue.taskcluster.net/v1/task/A5BeFCSLSau4DGm7p2LZ7w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:12:34 INFO - Running post-action listener: _resource_record_post_action 16:12:34 INFO - Running post-action listener: set_extra_try_arguments 16:12:34 INFO - [mozharness: 2016-10-31 23:12:34.674270Z] Finished download-and-extract step (success) 16:12:34 INFO - [mozharness: 2016-10-31 23:12:34.674568Z] Running populate-webroot step. 16:12:34 INFO - Running pre-action listener: _resource_record_pre_action 16:12:34 INFO - Running main action method: populate_webroot 16:12:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:12:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:12:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:12:34 INFO - '--tppagecycles', 16:12:34 INFO - '7'], 16:12:34 INFO - 'tests': ['tsvgm']}}, 16:12:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:12:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:12:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:12:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:12:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:12:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:12:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:34 INFO - 'talos_options': ['--disable-e10s'], 16:12:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:12:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:12:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:34 INFO - 'talos_options': ['--disable-e10s'], 16:12:34 INFO - 'tests': ['damp', 'tps']}, 16:12:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:34 INFO - 'tests': ['damp', 'tps']}, 16:12:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:12:34 INFO - 'tests': ['dromaeo_dom']}, 16:12:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:12:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:12:34 INFO - 'tests': ['basic_compositor_video']}, 16:12:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:12:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:12:34 INFO - 'tests': ['a11yr', 16:12:34 INFO - 'ts_paint', 16:12:34 INFO - 'tpaint', 16:12:34 INFO - 'sessionrestore', 16:12:34 INFO - 'sessionrestore_no_auto_restore', 16:12:34 INFO - 'tabpaint']}, 16:12:34 INFO - 'other-e10s': {'tests': ['a11yr', 16:12:34 INFO - 'ts_paint', 16:12:34 INFO - 'tpaint', 16:12:34 INFO - 'sessionrestore', 16:12:34 INFO - 'sessionrestore_no_auto_restore', 16:12:34 INFO - 'tabpaint']}, 16:12:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:12:34 INFO - 'ts_paint', 16:12:34 INFO - 'tpaint', 16:12:34 INFO - 'sessionrestore', 16:12:34 INFO - 'sessionrestore_no_auto_restore', 16:12:34 INFO - 'tabpaint']}, 16:12:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:12:34 INFO - 'ts_paint', 16:12:34 INFO - 'tpaint', 16:12:34 INFO - 'sessionrestore', 16:12:34 INFO - 'sessionrestore_no_auto_restore', 16:12:34 INFO - 'tabpaint']}, 16:12:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:12:34 INFO - 'tests': ['a11yr', 16:12:34 INFO - 'ts_paint', 16:12:34 INFO - 'tpaint', 16:12:34 INFO - 'sessionrestore', 16:12:34 INFO - 'sessionrestore_no_auto_restore', 16:12:34 INFO - 'tabpaint']}, 16:12:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:12:34 INFO - 'tests': ['a11yr', 16:12:34 INFO - 'ts_paint', 16:12:34 INFO - 'tpaint', 16:12:34 INFO - 'sessionrestore', 16:12:34 INFO - 'sessionrestore_no_auto_restore', 16:12:34 INFO - 'tabpaint']}, 16:12:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:12:34 INFO - 'tests': ['tsvgx', 16:12:34 INFO - 'tsvgr_opacity', 16:12:34 INFO - 'tart', 16:12:34 INFO - 'tscrollx', 16:12:34 INFO - 'cart']}, 16:12:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:12:34 INFO - 'tsvgr_opacity', 16:12:34 INFO - 'tart', 16:12:34 INFO - 'tscrollx', 16:12:34 INFO - 'cart']}, 16:12:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:34 INFO - 'talos_options': ['--disable-e10s'], 16:12:34 INFO - 'tests': ['tp5o']}, 16:12:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:34 INFO - 'tests': ['tp5o']}, 16:12:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:34 INFO - 'talos_options': ['--disable-e10s', 16:12:34 INFO - '--xperf_path', 16:12:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:12:34 INFO - 'tests': ['tp5n']}, 16:12:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:34 INFO - 'talos_options': ['--xperf_path', 16:12:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:12:34 INFO - 'tests': ['tp5n']}}, 16:12:34 INFO - 'talos.zip': {'path': '', 16:12:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:12:34 INFO - Running post-action listener: _resource_record_post_action 16:12:34 INFO - [mozharness: 2016-10-31 23:12:34.691278Z] Finished populate-webroot step (success) 16:12:34 INFO - [mozharness: 2016-10-31 23:12:34.691370Z] Running create-virtualenv step. 16:12:34 INFO - Running pre-action listener: _resource_record_pre_action 16:12:34 INFO - Running main action method: create_virtualenv 16:12:34 INFO - Creating virtualenv /builds/slave/test/build/venv 16:12:34 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:12:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:12:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:12:34 INFO - Using real prefix '/usr' 16:12:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:12:35 INFO - Installing distribute.............................................................................................................................................................................................done. 16:12:37 INFO - Installing pip.................done. 16:12:37 INFO - Return code: 0 16:12:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:12:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:12:37 INFO - Reading from file tmpfile_stdout 16:12:37 INFO - Output received: 16:12:37 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) 16:12:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6fd19df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b60ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5df60>, '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 0x1b5ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b5f1d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1477955538.659919-782898617', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:12:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:12:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:12:37 INFO - Using env: {'DISPLAY': ':0', 16:12:37 INFO - 'HOME': '/home/cltbld', 16:12:37 INFO - 'LANG': 'en_US.UTF-8', 16:12:37 INFO - 'LANGUAGE': 'en_US:en', 16:12:37 INFO - 'LOGNAME': 'cltbld', 16:12:37 INFO - 'MAIL': '/var/mail/cltbld', 16:12:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:37 INFO - 'MOZ_NO_REMOTE': '1', 16:12:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:37 INFO - 'NO_EM_RESTART': '1', 16:12:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:37 INFO - 'PWD': '/builds/slave/test', 16:12:37 INFO - 'SHELL': '/bin/bash', 16:12:37 INFO - 'SHLVL': '1', 16:12:37 INFO - 'TERM': 'linux', 16:12:37 INFO - 'TMOUT': '86400', 16:12:37 INFO - 'USER': 'cltbld', 16:12:37 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1477955538.659919-782898617', 16:12:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:37 INFO - '_': '/tools/buildbot/bin/python'} 16:12:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:37 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:12:37 INFO - Cleaning up... 16:12:37 INFO - Return code: 0 16:12:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe6fd19df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b60ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5df60>, '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 0x1b5ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b5f1d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1477955538.659919-782898617', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:12:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:12:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:12:37 INFO - Using env: {'DISPLAY': ':0', 16:12:37 INFO - 'HOME': '/home/cltbld', 16:12:37 INFO - 'LANG': 'en_US.UTF-8', 16:12:37 INFO - 'LANGUAGE': 'en_US:en', 16:12:37 INFO - 'LOGNAME': 'cltbld', 16:12:37 INFO - 'MAIL': '/var/mail/cltbld', 16:12:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:37 INFO - 'MOZ_NO_REMOTE': '1', 16:12:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:37 INFO - 'NO_EM_RESTART': '1', 16:12:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:37 INFO - 'PWD': '/builds/slave/test', 16:12:37 INFO - 'SHELL': '/bin/bash', 16:12:37 INFO - 'SHLVL': '1', 16:12:37 INFO - 'TERM': 'linux', 16:12:37 INFO - 'TMOUT': '86400', 16:12:37 INFO - 'USER': 'cltbld', 16:12:37 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1477955538.659919-782898617', 16:12:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:37 INFO - '_': '/tools/buildbot/bin/python'} 16:12:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:37 INFO - Downloading/unpacking psutil>=3.1.1 16:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:12:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:12:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:12:39 INFO - Installing collected packages: psutil 16:12:39 INFO - Running setup.py install for psutil 16:12:40 INFO - building 'psutil._psutil_linux' extension 16:12:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:12:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:12:40 INFO - building 'psutil._psutil_posix' extension 16:12:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:12:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:12:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:12:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:12:40 INFO - Successfully installed psutil 16:12:40 INFO - Cleaning up... 16:12:40 INFO - Return code: 0 16:12:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:40 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 0x7fe6fd19df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b60ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5df60>, '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 0x1b5ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b5f1d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1477955538.659919-782898617', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:12:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:12:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:12:40 INFO - Using env: {'DISPLAY': ':0', 16:12:40 INFO - 'HOME': '/home/cltbld', 16:12:40 INFO - 'LANG': 'en_US.UTF-8', 16:12:40 INFO - 'LANGUAGE': 'en_US:en', 16:12:40 INFO - 'LOGNAME': 'cltbld', 16:12:40 INFO - 'MAIL': '/var/mail/cltbld', 16:12:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:40 INFO - 'MOZ_NO_REMOTE': '1', 16:12:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:40 INFO - 'NO_EM_RESTART': '1', 16:12:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:40 INFO - 'PWD': '/builds/slave/test', 16:12:40 INFO - 'SHELL': '/bin/bash', 16:12:40 INFO - 'SHLVL': '1', 16:12:40 INFO - 'TERM': 'linux', 16:12:40 INFO - 'TMOUT': '86400', 16:12:40 INFO - 'USER': 'cltbld', 16:12:40 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1477955538.659919-782898617', 16:12:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:40 INFO - '_': '/tools/buildbot/bin/python'} 16:12:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:12:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:12:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:12:42 INFO - Installing collected packages: mozsystemmonitor 16:12:42 INFO - Running setup.py install for mozsystemmonitor 16:12:42 INFO - Successfully installed mozsystemmonitor 16:12:42 INFO - Cleaning up... 16:12:42 INFO - Return code: 0 16:12:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:12:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:42 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 0x7fe6fd19df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b60ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5df60>, '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 0x1b5ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b5f1d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1477955538.659919-782898617', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:12:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:12:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:12:42 INFO - Using env: {'DISPLAY': ':0', 16:12:42 INFO - 'HOME': '/home/cltbld', 16:12:42 INFO - 'LANG': 'en_US.UTF-8', 16:12:42 INFO - 'LANGUAGE': 'en_US:en', 16:12:42 INFO - 'LOGNAME': 'cltbld', 16:12:42 INFO - 'MAIL': '/var/mail/cltbld', 16:12:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:42 INFO - 'MOZ_NO_REMOTE': '1', 16:12:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:42 INFO - 'NO_EM_RESTART': '1', 16:12:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:42 INFO - 'PWD': '/builds/slave/test', 16:12:42 INFO - 'SHELL': '/bin/bash', 16:12:42 INFO - 'SHLVL': '1', 16:12:42 INFO - 'TERM': 'linux', 16:12:42 INFO - 'TMOUT': '86400', 16:12:42 INFO - 'USER': 'cltbld', 16:12:42 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1477955538.659919-782898617', 16:12:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:42 INFO - '_': '/tools/buildbot/bin/python'} 16:12:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:43 INFO - Downloading/unpacking jsonschema==2.5.1 16:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:12:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:45 INFO - Downloading functools32-3.2.3-2.tar.gz 16:12:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:12:45 INFO - warning: no files found matching '*.txt' 16:12:45 INFO - no previously-included directories found matching 'build' 16:12:45 INFO - no previously-included directories found matching 'dist' 16:12:45 INFO - no previously-included directories found matching '.git*' 16:12:45 INFO - Installing collected packages: jsonschema, functools32 16:12:45 INFO - Running setup.py install for functools32 16:12:45 INFO - warning: no files found matching '*.txt' 16:12:45 INFO - no previously-included directories found matching 'build' 16:12:45 INFO - no previously-included directories found matching 'dist' 16:12:45 INFO - no previously-included directories found matching '.git*' 16:12:45 INFO - Successfully installed jsonschema functools32 16:12:45 INFO - Cleaning up... 16:12:45 INFO - Return code: 0 16:12:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:12:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:45 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 0x7fe6fd19df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b60ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5df60>, '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 0x1b5ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b5f1d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1477955538.659919-782898617', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:12:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:12:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:12:45 INFO - Using env: {'DISPLAY': ':0', 16:12:45 INFO - 'HOME': '/home/cltbld', 16:12:45 INFO - 'LANG': 'en_US.UTF-8', 16:12:45 INFO - 'LANGUAGE': 'en_US:en', 16:12:45 INFO - 'LOGNAME': 'cltbld', 16:12:45 INFO - 'MAIL': '/var/mail/cltbld', 16:12:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:45 INFO - 'MOZ_NO_REMOTE': '1', 16:12:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:45 INFO - 'NO_EM_RESTART': '1', 16:12:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:45 INFO - 'PWD': '/builds/slave/test', 16:12:45 INFO - 'SHELL': '/bin/bash', 16:12:45 INFO - 'SHLVL': '1', 16:12:45 INFO - 'TERM': 'linux', 16:12:45 INFO - 'TMOUT': '86400', 16:12:45 INFO - 'USER': 'cltbld', 16:12:45 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1477955538.659919-782898617', 16:12:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:45 INFO - '_': '/tools/buildbot/bin/python'} 16:12:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:12:45 INFO - Cleaning up... 16:12:45 INFO - Return code: 0 16:12:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:12:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:45 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 0x7fe6fd19df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b60ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5df60>, '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 0x1b5ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b5f1d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1477955538.659919-782898617', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:12:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:12:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:12:45 INFO - Using env: {'DISPLAY': ':0', 16:12:45 INFO - 'HOME': '/home/cltbld', 16:12:45 INFO - 'LANG': 'en_US.UTF-8', 16:12:45 INFO - 'LANGUAGE': 'en_US:en', 16:12:45 INFO - 'LOGNAME': 'cltbld', 16:12:45 INFO - 'MAIL': '/var/mail/cltbld', 16:12:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:45 INFO - 'MOZ_NO_REMOTE': '1', 16:12:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:45 INFO - 'NO_EM_RESTART': '1', 16:12:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:45 INFO - 'PWD': '/builds/slave/test', 16:12:45 INFO - 'SHELL': '/bin/bash', 16:12:45 INFO - 'SHLVL': '1', 16:12:45 INFO - 'TERM': 'linux', 16:12:45 INFO - 'TMOUT': '86400', 16:12:45 INFO - 'USER': 'cltbld', 16:12:45 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1477955538.659919-782898617', 16:12:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:45 INFO - '_': '/tools/buildbot/bin/python'} 16:12:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:45 INFO - Downloading/unpacking blobuploader==1.2.4 16:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:47 INFO - Downloading blobuploader-1.2.4.tar.gz 16:12:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:12:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:12:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:48 INFO - Downloading docopt-0.6.1.tar.gz 16:12:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:12:48 INFO - Installing collected packages: blobuploader, requests, docopt 16:12:48 INFO - Running setup.py install for blobuploader 16:12:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:12:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:12:48 INFO - Running setup.py install for requests 16:12:49 INFO - Running setup.py install for docopt 16:12:49 INFO - Successfully installed blobuploader requests docopt 16:12:49 INFO - Cleaning up... 16:12:49 INFO - Return code: 0 16:12:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:12:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:49 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 0x7fe6fd19df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b60ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5df60>, '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 0x1b5ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b5f1d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1477955538.659919-782898617', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:12:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:12:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:12:49 INFO - Using env: {'DISPLAY': ':0', 16:12:49 INFO - 'HOME': '/home/cltbld', 16:12:49 INFO - 'LANG': 'en_US.UTF-8', 16:12:49 INFO - 'LANGUAGE': 'en_US:en', 16:12:49 INFO - 'LOGNAME': 'cltbld', 16:12:49 INFO - 'MAIL': '/var/mail/cltbld', 16:12:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:49 INFO - 'MOZ_NO_REMOTE': '1', 16:12:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:49 INFO - 'NO_EM_RESTART': '1', 16:12:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:49 INFO - 'PWD': '/builds/slave/test', 16:12:49 INFO - 'SHELL': '/bin/bash', 16:12:49 INFO - 'SHLVL': '1', 16:12:49 INFO - 'TERM': 'linux', 16:12:49 INFO - 'TMOUT': '86400', 16:12:49 INFO - 'USER': 'cltbld', 16:12:49 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1477955538.659919-782898617', 16:12:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:49 INFO - '_': '/tools/buildbot/bin/python'} 16:12:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:12:49 INFO - Running setup.py (path:/tmp/pip-VIEsMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:12:49 INFO - Running setup.py (path:/tmp/pip-T3fV7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:12:49 INFO - Running setup.py (path:/tmp/pip-5bB1bR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:12:49 INFO - Running setup.py (path:/tmp/pip-ZU29s9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:12:49 INFO - Running setup.py (path:/tmp/pip-CGekbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:12:49 INFO - Running setup.py (path:/tmp/pip-R8b7fs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:12:49 INFO - Running setup.py (path:/tmp/pip-_o60nD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:12:49 INFO - Running setup.py (path:/tmp/pip-AtOIqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:12:50 INFO - Running setup.py (path:/tmp/pip-FDSicN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:12:50 INFO - Running setup.py (path:/tmp/pip-re1RGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:12:50 INFO - Running setup.py (path:/tmp/pip-OLpins-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:12:50 INFO - Running setup.py (path:/tmp/pip-OIZO5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:12:50 INFO - Running setup.py (path:/tmp/pip-sl7nNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:12:50 INFO - Running setup.py (path:/tmp/pip-PCzaZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:50 INFO - Running setup.py (path:/tmp/pip-nDe1iD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:12:50 INFO - Running setup.py (path:/tmp/pip-MTux6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:12:50 INFO - Running setup.py (path:/tmp/pip-lpK0US-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:12:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:12:50 INFO - Running setup.py install for manifestparser 16:12:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:12:50 INFO - Running setup.py install for mozcrash 16:12:50 INFO - Running setup.py install for mozdebug 16:12:51 INFO - Running setup.py install for mozdevice 16:12:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:12:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:12:51 INFO - Running setup.py install for mozfile 16:12:51 INFO - Running setup.py install for mozhttpd 16:12:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:12:51 INFO - Running setup.py install for mozinfo 16:12:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:12:51 INFO - Running setup.py install for mozInstall 16:12:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:12:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:12:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:12:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:12:51 INFO - Running setup.py install for mozleak 16:12:51 INFO - Running setup.py install for mozlog 16:12:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:12:51 INFO - Running setup.py install for moznetwork 16:12:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:12:51 INFO - Running setup.py install for mozprocess 16:12:51 INFO - Running setup.py install for mozprofile 16:12:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:12:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:12:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:12:52 INFO - Running setup.py install for mozrunner 16:12:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:12:52 INFO - Running setup.py install for mozscreenshot 16:12:52 INFO - Running setup.py install for moztest 16:12:52 INFO - Running setup.py install for mozversion 16:12:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:12:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:12:52 INFO - Cleaning up... 16:12:52 INFO - Return code: 0 16:12:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:52 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 0x7fe6fd19df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b60ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5df60>, '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 0x1b5ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b5f1d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1477955538.659919-782898617', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:12:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:12:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:12:52 INFO - Using env: {'DISPLAY': ':0', 16:12:52 INFO - 'HOME': '/home/cltbld', 16:12:52 INFO - 'LANG': 'en_US.UTF-8', 16:12:52 INFO - 'LANGUAGE': 'en_US:en', 16:12:52 INFO - 'LOGNAME': 'cltbld', 16:12:52 INFO - 'MAIL': '/var/mail/cltbld', 16:12:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:52 INFO - 'MOZ_NO_REMOTE': '1', 16:12:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:52 INFO - 'NO_EM_RESTART': '1', 16:12:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:52 INFO - 'PWD': '/builds/slave/test', 16:12:52 INFO - 'SHELL': '/bin/bash', 16:12:52 INFO - 'SHLVL': '1', 16:12:52 INFO - 'TERM': 'linux', 16:12:52 INFO - 'TMOUT': '86400', 16:12:52 INFO - 'USER': 'cltbld', 16:12:52 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1477955538.659919-782898617', 16:12:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:52 INFO - '_': '/tools/buildbot/bin/python'} 16:12:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:12:52 INFO - Running setup.py (path:/tmp/pip-WVEZeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:12:52 INFO - Running setup.py (path:/tmp/pip-tHQeEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:12:52 INFO - Running setup.py (path:/tmp/pip-qITeZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:12:52 INFO - Running setup.py (path:/tmp/pip-ziaOjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:12:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:12:53 INFO - Running setup.py (path:/tmp/pip-aJ4oVF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:12:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:12:53 INFO - Running setup.py (path:/tmp/pip-fdWZrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:12:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:12:53 INFO - Running setup.py (path:/tmp/pip-PKEnA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:12:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:12:53 INFO - Running setup.py (path:/tmp/pip-DrMrjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:12:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:12:53 INFO - Running setup.py (path:/tmp/pip-TomvoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:12:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:12:53 INFO - Running setup.py (path:/tmp/pip-shiyvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:12:53 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)) 16:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:12:53 INFO - Running setup.py (path:/tmp/pip-Fn0JaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:12:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:12:53 INFO - Running setup.py (path:/tmp/pip-WxPeRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:12:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:12:53 INFO - Running setup.py (path:/tmp/pip-9gwT5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:12:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:12:53 INFO - Running setup.py (path:/tmp/pip-Gly0CB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:12:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:53 INFO - Running setup.py (path:/tmp/pip-2HWF1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:12:53 INFO - Running setup.py (path:/tmp/pip-X6xPzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:12:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:12:53 INFO - Running setup.py (path:/tmp/pip-CkWMBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:12:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:12:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:12:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:12:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:12:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:12:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:12:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:55 INFO - Downloading blessings-1.6.tar.gz 16:12:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:12:55 INFO - Installing collected packages: blessings 16:12:55 INFO - Running setup.py install for blessings 16:12:56 INFO - Successfully installed blessings 16:12:56 INFO - Cleaning up... 16:12:56 INFO - Return code: 0 16:12:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:12:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:12:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:12:56 INFO - Reading from file tmpfile_stdout 16:12:56 INFO - Current package versions: 16:12:56 INFO - argparse == 1.2.1 16:12:56 INFO - blessings == 1.6 16:12:56 INFO - blobuploader == 1.2.4 16:12:56 INFO - docopt == 0.6.1 16:12:56 INFO - functools32 == 3.2.3-2 16:12:56 INFO - jsonschema == 2.5.1 16:12:56 INFO - manifestparser == 1.1 16:12:56 INFO - mozInstall == 1.12 16:12:56 INFO - mozcrash == 0.17 16:12:56 INFO - mozdebug == 0.1 16:12:56 INFO - mozdevice == 0.48 16:12:56 INFO - mozfile == 1.2 16:12:56 INFO - mozhttpd == 0.7 16:12:56 INFO - mozinfo == 0.9 16:12:56 INFO - mozleak == 0.1 16:12:56 INFO - mozlog == 3.4 16:12:56 INFO - moznetwork == 0.27 16:12:56 INFO - mozprocess == 0.23 16:12:56 INFO - mozprofile == 0.28 16:12:56 INFO - mozrunner == 6.12 16:12:56 INFO - mozscreenshot == 0.1 16:12:56 INFO - mozsystemmonitor == 0.3 16:12:56 INFO - moztest == 0.7 16:12:56 INFO - mozversion == 1.4 16:12:56 INFO - psutil == 3.1.1 16:12:56 INFO - requests == 1.2.3 16:12:56 INFO - wsgiref == 0.1.2 16:12:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:12:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:56 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 0x7fe6fd19df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b60ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5df60>, '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 0x1b5ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b5f1d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1477955538.659919-782898617', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:12:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:12:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:12:56 INFO - Using env: {'DISPLAY': ':0', 16:12:56 INFO - 'HOME': '/home/cltbld', 16:12:56 INFO - 'LANG': 'en_US.UTF-8', 16:12:56 INFO - 'LANGUAGE': 'en_US:en', 16:12:56 INFO - 'LOGNAME': 'cltbld', 16:12:56 INFO - 'MAIL': '/var/mail/cltbld', 16:12:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:56 INFO - 'MOZ_NO_REMOTE': '1', 16:12:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:56 INFO - 'NO_EM_RESTART': '1', 16:12:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:56 INFO - 'PWD': '/builds/slave/test', 16:12:56 INFO - 'SHELL': '/bin/bash', 16:12:56 INFO - 'SHLVL': '1', 16:12:56 INFO - 'TERM': 'linux', 16:12:56 INFO - 'TMOUT': '86400', 16:12:56 INFO - 'USER': 'cltbld', 16:12:56 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1477955538.659919-782898617', 16:12:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:56 INFO - '_': '/tools/buildbot/bin/python'} 16:12:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:12:56 INFO - Cleaning up... 16:12:56 INFO - Return code: 0 16:12:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:12:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:56 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 0x7fe6fd19df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b60ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5df60>, '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 0x1b5ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b5f1d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1477955538.659919-782898617', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:12:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:12:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:12:56 INFO - Using env: {'DISPLAY': ':0', 16:12:56 INFO - 'HOME': '/home/cltbld', 16:12:56 INFO - 'LANG': 'en_US.UTF-8', 16:12:56 INFO - 'LANGUAGE': 'en_US:en', 16:12:56 INFO - 'LOGNAME': 'cltbld', 16:12:56 INFO - 'MAIL': '/var/mail/cltbld', 16:12:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:56 INFO - 'MOZ_NO_REMOTE': '1', 16:12:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:56 INFO - 'NO_EM_RESTART': '1', 16:12:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:56 INFO - 'PWD': '/builds/slave/test', 16:12:56 INFO - 'SHELL': '/bin/bash', 16:12:56 INFO - 'SHLVL': '1', 16:12:56 INFO - 'TERM': 'linux', 16:12:56 INFO - 'TMOUT': '86400', 16:12:56 INFO - 'USER': 'cltbld', 16:12:56 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1477955538.659919-782898617', 16:12:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:56 INFO - '_': '/tools/buildbot/bin/python'} 16:12:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:12:56 INFO - Cleaning up... 16:12:56 INFO - Return code: 0 16:12:56 INFO - Running post-action listener: _resource_record_post_action 16:12:56 INFO - Running post-action listener: _start_resource_monitoring 16:12:56 INFO - Starting resource monitoring. 16:12:56 INFO - [mozharness: 2016-10-31 23:12:56.843289Z] Finished create-virtualenv step (success) 16:12:56 INFO - [mozharness: 2016-10-31 23:12:56.843797Z] Running install step. 16:12:56 INFO - Running pre-action listener: _resource_record_pre_action 16:12:56 INFO - Running main action method: install 16:12:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:12:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:12:57 INFO - Reading from file tmpfile_stdout 16:12:57 INFO - Detecting whether we're running mozinstall >=1.0... 16:12:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:12:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:12:57 INFO - Reading from file tmpfile_stdout 16:12:57 INFO - Output received: 16:12:57 INFO - Usage: mozinstall [options] installer 16:12:57 INFO - Options: 16:12:57 INFO - -h, --help show this help message and exit 16:12:57 INFO - -d DEST, --destination=DEST 16:12:57 INFO - Directory to install application into. [default: 16:12:57 INFO - "/builds/slave/test"] 16:12:57 INFO - --app=APP Application being installed. [default: firefox] 16:12:57 INFO - mkdir: /builds/slave/test/build/application 16:12:57 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'] 16:12:57 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 16:13:13 INFO - Reading from file tmpfile_stdout 16:13:13 INFO - Output received: 16:13:13 INFO - /builds/slave/test/build/application/firefox/firefox 16:13:13 INFO - Running post-action listener: _resource_record_post_action 16:13:13 INFO - [mozharness: 2016-10-31 23:13:13.244130Z] Finished install step (success) 16:13:13 INFO - [mozharness: 2016-10-31 23:13:13.244374Z] Running run-tests step. 16:13:13 INFO - Running pre-action listener: _resource_record_pre_action 16:13:13 INFO - Running main action method: run_tests 16:13:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:13:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:13:13 INFO - Python 2.7.3 16:13:13 INFO - Return code: 0 16:13:13 INFO - grabbing minidump binary from tooltool 16:13:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:13 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 0x1b5df60>, '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 0x1b5ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b5f1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:13:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:13:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:13:13 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:13:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:13:13 INFO - Return code: 0 16:13:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:13:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:13:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:13:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:13:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:13:13 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/A5BeFCSLSau4DGm7p2LZ7w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:13:13 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/A5BeFCSLSau4DGm7p2LZ7w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:13:13 INFO - Using env: {'DISPLAY': ':0', 16:13:13 INFO - 'HOME': '/home/cltbld', 16:13:13 INFO - 'LANG': 'en_US.UTF-8', 16:13:13 INFO - 'LANGUAGE': 'en_US:en', 16:13:13 INFO - 'LOGNAME': 'cltbld', 16:13:13 INFO - 'MAIL': '/var/mail/cltbld', 16:13:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:13:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:13:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:13 INFO - 'MOZ_NO_REMOTE': '1', 16:13:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:13:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:13 INFO - 'NO_EM_RESTART': '1', 16:13:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:13 INFO - 'PWD': '/builds/slave/test', 16:13:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:13:13 INFO - 'SHELL': '/bin/bash', 16:13:13 INFO - 'SHLVL': '1', 16:13:13 INFO - 'TERM': 'linux', 16:13:13 INFO - 'TMOUT': '86400', 16:13:13 INFO - 'USER': 'cltbld', 16:13:13 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1477955538.659919-782898617', 16:13:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:13 INFO - '_': '/tools/buildbot/bin/python'} 16:13:13 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/A5BeFCSLSau4DGm7p2LZ7w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:13:13 INFO - mozversion application_buildid: 20161031120204 16:13:13 INFO - mozversion application_changeset: 1aa20bcbb80e1014e4d01057f7d52269b0c2d908 16:13:13 INFO - mozversion application_display_name: Nightly 16:13:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:13:13 INFO - mozversion application_name: Firefox 16:13:13 INFO - mozversion application_remotingname: firefox 16:13:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:13:13 INFO - mozversion application_vendor: Mozilla 16:13:13 INFO - mozversion application_version: 52.0a1 16:13:13 INFO - mozversion platform_buildid: 20161031120204 16:13:13 INFO - mozversion platform_changeset: 1aa20bcbb80e1014e4d01057f7d52269b0c2d908 16:13:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:13:13 INFO - mozversion platform_version: 52.0a1 16:13:13 INFO - using testdate: 1477955593 16:13:13 INFO - actual date: 1477955593 16:13:13 INFO - starting webserver on 'localhost:33408' 16:13:13 INFO - SUITE-START | Running 2 tests 16:13:13 INFO - TEST-START | dromaeo_css 16:13:13 INFO - operating with platform_type : linux_ 16:13:13 INFO - Initialising browser for dromaeo_css test... 16:13:13 INFO - TEST-INFO | started process 20469 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpguS1xe/profile http://localhost:33408/getInfo.html) 16:13:18 INFO - PROCESS | 20469 | __metrics Screen width/height:1600/1200 16:13:18 INFO - PROCESS | 20469 | colorDepth:24 16:13:18 INFO - PROCESS | 20469 | Browser inner width/height: 1024/697 16:13:18 INFO - PROCESS | 20469 | __metrics 16:13:18 INFO - PROCESS | 20469 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:13:18 INFO - PROCESS | 20469 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:13:19 INFO - PROCESS | 20469 | console.error: PushService: 16:13:19 INFO - PROCESS | 20469 | stateChangeProcessEnqueue: Error transitioning state 16:13:19 INFO - PROCESS | 20469 | UnknownError 16:13:20 INFO - TEST-INFO | 20469: exit 0 16:13:20 INFO - Browser initialized. 16:13:20 INFO - Running cycle 1/1 for dromaeo_css test... 16:13:20 INFO - TEST-INFO | started process 20550 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpguS1xe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:13:32 INFO - PROCESS | 20550 | RSS: Main: 176463872 16:13:32 INFO - PROCESS | 20550 | 16:14:23 INFO - PROCESS | 20550 | 1477955663403 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:16:36 INFO - PROCESS | 20550 | Cycle 1(1): loaded http://localhost:33408/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33408/tests/dromaeo/cssquery-ext.html) 16:16:40 INFO - PROCESS | 20550 | RSS: Main: 463749120 16:16:40 INFO - PROCESS | 20550 | 16:19:43 INFO - PROCESS | 20550 | Cycle 1(1): loaded http://localhost:33408/tests/dromaeo/cssquery-ext.html (next: http://localhost:33408/tests/dromaeo/cssquery-jquery.html) 16:19:43 INFO - PROCESS | 20550 | RSS: Main: 281931776 16:19:43 INFO - PROCESS | 20550 | 16:22:45 INFO - PROCESS | 20550 | Cycle 1(1): loaded http://localhost:33408/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33408/tests/dromaeo/cssquery-mootools.html) 16:22:46 INFO - PROCESS | 20550 | RSS: Main: 258678784 16:22:46 INFO - PROCESS | 20550 | 16:25:48 INFO - PROCESS | 20550 | Cycle 1(1): loaded http://localhost:33408/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33408/tests/dromaeo/cssquery-prototype.html) 16:25:49 INFO - PROCESS | 20550 | RSS: Main: 226705408 16:25:49 INFO - PROCESS | 20550 | 16:28:52 INFO - PROCESS | 20550 | Cycle 1(1): loaded http://localhost:33408/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33408/tests/dromaeo/cssquery-yui.html) 16:28:52 INFO - PROCESS | 20550 | RSS: Main: 220053504 16:28:52 INFO - PROCESS | 20550 | 16:31:55 INFO - PROCESS | 20550 | Cycle 1(1): loaded http://localhost:33408/tests/dromaeo/cssquery-yui.html (next: http://localhost:33408/tests/dromaeo/cssquery-dojo.html) 16:31:56 INFO - PROCESS | 20550 | RSS: Main: 312127488 16:31:56 INFO - PROCESS | 20550 | 16:31:56 INFO - PROCESS | 20550 | __start_tp_report 16:31:56 INFO - PROCESS | 20550 | _x_x_mozilla_page_load 16:31:56 INFO - PROCESS | 20550 | _x_x_mozilla_page_load_details 16:31:56 INFO - PROCESS | 20550 | |i|pagename|runs| 16:31:56 INFO - PROCESS | 20550 | |0;dojo.html;2583.2508572513966;2599.75302346277;2631.6710411198605;2637.6702912135984;2643.510950474162;4607.516210797869;4674.579287864091;4709.0346478971815;4715.386999690036;4751.572358487735;4697.882552936178;4712.528747125286;4735.431748190222;4754.857354279368;4824.372831531896;4322.113966636847;4332.913341733163;4359.542248063955;4373.803178856959;4380.518143004283;4393.670474714393;4425.159219748253;4425.203463376591;4426.22541055314;4474.530174331697;4265.616094551505;4438.178936896685;4443.622292105175;4451.732896026217;4551.954480455202;4250.213710463574;4353.1293741251875;4358.476982762058;4363.759993200372;4371.956280437187;4289.270823959903;4340.131973605292;4344.7827608619755;4345.543717909637;4351.129774045204;4768.570828625406;4768.690035147704;4774.832880849153;4821.590164835993;4845.563899249049;5120.15517439622;5123.666961647518;5123.923141152885;5127.6154288428515;5186.1442861927735;4980.626453016038;5023.397192336943;5134.101532231844;5151.871203219912;5153.871153221199;4705.764711764398;4747.667663263538;4752.7623618818925;4755.358026666425;4778.689385189951;5211.973940130275;5233.031889100453;5236.973815130977;5237.476252374732;5239.1093514102695;4947.703137811743;4983.526564976321;5010.273510341053;5024.371953505812;5026.0199261143725;5122.154844450699;5140.997505486469;5143.8456846294675;5201.219817027476;5201.3238279024245;5088.92366614501;5091.0581542414775;5093.2105523643895;5095.108356037678;5151.25306830515;4872.3909511311085;4920.6555541111775;5072.51811077947;5076.873078173076;5129.9743501282255;4300.268954277781;4322.243607368698;4340.587644173798;4352.804123814436;4414.580614841585;3793.7534060285993;3798.677112445473;3802.5817160112365;3845.7884816335372;3847.2305538892333;4300.3549467580115;4323.373110898902;4358.389825424443;4359.564043595678;4395.934060989088;4990.925136122961;5047.41954675217;5088.542031217208;5091.439941606421;5110.565601923804;4288.378185163134;4310.827566897289;4315.115401342718;4316.935245971313;4317.956820431818;4588.403507543998;4598.034412773288;4600.493945665974;4604.309353596987;4615.5845973862515;4762.214234651313;4770.737609431376;4774.594159496482;4776.904461910812;4782.497837726988;5110.029094472038;5110.66780659256;5113.616478764033;5123.897522049613;5129.102407078821;4752.192127338291;4765.880852978703;4790.353302304145;4790.5448982346625;4791.47293797689;4939.158188709327;4967.950320496749;4987.9002419950675;4998.350214472095;5063.113955057924;5113.284140220298;5132.332796736549;5136.0241554104605;5138;5182.067227899014;4835.20219163834;4871.196252618278;4872.731999739906;4981.775820088177;4986.850394488171;4941.678790878582;4944.752762361795;4945.6043516517875;4945.97527012377;4951.77717002743;4880.292357608056;4880.658353915192;4881.316615673737;4882.609391248762;4894.119058569349;4973.502649734997;4985.750712464434;4988.800447982186;4992.650514464098;4999.275105109666;4846.321514987975;4847.175980083465;4858.17411040117;4858.5384388483035;4859.222524396079 16:31:56 INFO - PROCESS | 20550 | |1;ext.html;557.423067125525;568.4628026514945;578.4013545979911;581.4098689829824;593.9249957576784;37461.25077498448;38595.421068683994;38810.4178437323;44203.778981105046;44416.55583444165;39939.40090898639;40164.196716065664;40201.798991005075;40202.59797402025;40210.7989460053;7149.606771627558;7381.48329616927;7553.131389890164;7769.456138070337;7780.494267872598;10043.246756493256;10332.741681457986;10347.948260258689;10348.172146228284;10355.32690375127;10113.292069555135;10214.540345684461;10216.48917554123;10217.6934691959;10219.437930913797;10058.89941100587;10086.546105425274;10103.999999999927;10163.94918025405;10166.644167454178;9822.116009559173;9919.950400248024;9924.255680823895;9930.80138397228;9934.254930880214;35771.105722356886;35926.46110308347;35948.64051359479;36056.45915311272;36108.63891361105;2906.3170155013554;3052.740517056053;3056.159556122062;3084.1826915867314;3169.3344397676515;27858.86070569634;28077.85961070202;28936.42127157466;28974.42051158965;30198.84900575483;3462.255615042778;3530.947035794465;3531.29374125176;3577.177249232691;3577.372295605493;238090;239334;239952;240347;240841;51722;52092.479075208765;52098.47901521012;52115;52232.47767522352;32001.839990799897;33264.83367583147;33417.83291083578;35655.4651680225;35676.643233567855;13048.282344470956;13242.079898414677;13250.602481925365;13255.801162982563;13261.270630115243;8602.279544091207;8636.524991125549;10060.547275372479;10103;10297.742556436;17402.303907843543;17912.373066942593;17960.9101954492;17967.820321796615;18037.7294340585;6957.339052790078;7058.341494613531;7076.787696369117;7080.575165490087;7219.169795473483;790.1861083084432;862.9127299602546;902.0528445132585;906.1799071839995;948.1987720376271;26903.730962690515;27379.660966111816;27555;27653;27796.444071118465;962.8940816510178;968.1963969904962;980.9754756131153;983.1839573154265;1009.0968583118068;14051.508197213048;14224.217668028357;14647.340869660891;15016.624584385478;15173.924130379499;350242;353519;354604;354612;354699;48749;49330;49340.25989610159;49386.753066234436;49418.75290623524;1140.6521011091697;1155.3010428690857;1157.6064138193055;1198.2870192235605;1199.622119032502;25801.612975805754;26203;26660.466790664464;27208.319792005357;27618.86190569115;41643.58356416518;41900.580994189666;41916.58083419127;41936.790316048224;42049.78975105105;292476;293075;293595;293690;294925;21508.677369839777;22282.888585556968;23302.184423545095;24567.631485527374;25209.974803023753;40107.799461002505;40369;40375;40419.3937090938;40504.987375314675;33352;34421;34459.310813783086;34541.48187777135;34855.30289394147;33587.32825343431;34321.31357372888;34587.92472451661;34946.47580286247;35288.47067294044;33360.49959250564;34380.82809585936;34408;34534.48198276978;34988;29043.27391815137;30029.399412012073;31114.533282000335;31124.221894451915;31185.220369490944;24004.491836187357;24462.755372446758;24577;24802.25593232206;24980.750192497842 16:31:56 INFO - PROCESS | 20550 | |2;jquery.html;364.9927001459973;368.2671483747343;369.1454283334081;384.05330859431496;398.37455195343324;15997.200139993012;16719.498415047554;17170.82829171706;17303.48089557312;17313.39403120891;15192.392304307814;15505.612359691013;15998.840011599881;16056.71546276298;16062.357505699787;4874.8537543873745;5124.205748109049;5133.3326667533165;5139;5141.434442211354;4839.588634966032;4997.050560393532;5088.771005304751;5093.388793344804;5102.081625307444;4892.608591312704;4918.950810491885;4921.950780492185;4925.408950925894;4928.43323017854;4794.2808578713475;4934.950650493503;4982.476839931827;4984.950150498485;4987.0524600325825;4526.977365113154;4557.703749256288;4559.931601025987;4562.224421848294;4562.657800664931;19968.201271949103;20057;20148.697769533468;20268.493287667778;20497.5900481991;1994.8603597748163;2004.9398518044336;2154.396768904709;2210.701555290031;2261.8529795563236;12349.259044457362;12971;13166.86833131666;13450.663733406645;13760.449582016707;1642;1661.2275291989283;1685.2669088946348;1720.956976075608;1726.8273172682757;65675;65865.67067164682;66505.66747166234;67543.66228168877;68178.3182168182;8903.866442003375;9076.773080673036;9182.816343673088;9272.490013049348;9375.484193427465;11706.414679266003;11717.824232636518;11718.414079296172;11719.589814356457;11726.355050472306;6386.680665966683;6577.967110164419;6624.668766561653;6717.5297729159465;6757.93242067573;6239.875202496016;6265.373462653698;6441.194850643669;6442.420182183626;6459.063435801782;5904.643962848298;5940.613860099166;6078.817635470943;6083.878322433527;6087.482563982023;1670.2650833633163;1690.6280618263963;1710.8716846236582;1747.519432156167;1749.6500699860078;839.9496030238205;854.645322191296;856.4946681457969;884.8186121845006;989.8861630912393;16466.6706665866;16847.64133021378;17670.469885903443;17702.557436063944;17977.910110449364;869.3740506835069;876.912308769118;907.981840363189;915.3546749541557;916.4547094478775;9303.395279306824;9617.855732164024;10119.7470063249;10221.182305415548;10263.74340641475;373458;393442;394350;396021;397674;35069.64930350664;41722.37416438756;64109.358906411275;65708.34291657117;68195.31804681988;911.6399022386121;927.8051609162152;928.2759447630858;932.1750251027754;933.8365785987424;14477.348519316867;15376.923115384352;15676.843231567538;15815.446459373867;17167;36778;37107.443388348656;37162.442563362114;37347.626523735504;38461.230775384895;48552;48859.511404885496;48899.755501222266;49032.26451603157;50512.24231636455;7223.422126229784;7309.963450182928;7331.266873312626;7472.8879066815125;7636.31273185416;8049.154838742082;11065.612703555336;11731.648050558155;11766.941165294118;12267.509299627915;10192.337498062601;10450.947745261225;10680.252382333161;11149.72125696864;11332.263402878787;10079.294449388472;10318.226133039901;10545.789084218119;10562.894371056498;10603.469826508797;10404.739881503023;10563.521107044866;10626.415547144672;10728.624498142528;11231.26996745209;7481.738139165103;7727.188645192174;7904.328132108605;7932.484388514728;7955.562444065632;7999.600019999093;9154.267658587163;10393.792124157626;10409;10668.03987641116 16:31:56 INFO - PROCESS | 20550 | |3;mootools.html;1339.6516905604542;1365.8087867698523;1416.6458385403648;1602.2549514475766;1666.8916520426178;5773.971130144343;6021.488173505258;6465.094886715858;6803.421709154722;6805.897911531325;6393.648349340784;6593.439557637606;6607.405333519982;6744.954532047528;6758.2228043774985;2024.1498570600384;2049.907754151059;2051.620450216707;2053.9897300513476;2054.3734161080865;1749.5101371615967;1820.9908950455228;1996.4210378990076;2035.0333591544047;2039.1333683184662;1776.9378071767492;1793.3454289184485;1954.3452943263953;2017.4351181669156;2027.6654352031896;1988.8607797454183;1989.2043182727025;1993.800619938009;1994.0827219479056;1994.591108822695;1990.7013947907785;1996.5607566335384;2003.0685731135093;2038.4088614301984;2040.051376110101;6642.501812364044;6701.262861085277;6706.5640733352175;6798.932010679929;6831.351021652985;3974.066094467798;4091.5499295077516;4096.836126554964;4098.938515922264;4100.2414553307435;2667.5198464276423;2767.1975127213086;2796.203082121586;2833.886644534216;2835.801493895428;852.6163226548078;901.0989010989011;905.0858632780938;913.5112714697605;920.3235621817959;8467.915320846774;8507.234348908565;8565.271951884097;8567.228949394585;8580.82838343236;3654.1595433050015;3762.6801721853403;3852.4799152114106;3862.748921320105;3881.165549406891;7527.585982770891;7531.962340188264;7538.09542854861;7540.095188577406;7545.811354716176;4087.2234275487563;4092.1611069730634;4093.3859921012086;4093.5087789465456;4097.590240975938;3672.926541469156;3708.3325001499447;3719.460678201646;3724.0875985383755;3730.477733117366;3190.090824115116;3256.495243237302;3309.586301712286;3310.1062713067818;3312.138843900603;1134.3307448605362;1134.8978591926766;1138.277193981811;1142.828575713633;1147.4320211495196;739.5230076600562;754.9543881723852;828.6685325869701;840.4243093480985;843.9789005274795;4611.331356953223;4634.443866735945;4713.2404650397475;4729.337892695025;4853;396.60141557734295;398.8982809383589;404.96557792587373;410.27381534683445;413.6194700875202;3321.65122662117;3336.132605522582;3359.5296658467832;3431.1936694876686;3445.13871532117;7472.439567032494;7845.333146682482;7895.171007044292;7969.402294827911;7975.082865470429;7946.523208607502;7957.283844454027;7961.880571791427;7962.482438641469;7971.800704982422;6210.782622608187;6236;6299.338569450142;6350.1109844622715;6351.428371446592;4637.907241855077;4672.602828759457;4722.1028004680375;4729.574338309569;4782.52174782519;7342.155652100077;7403.7408690695565;7424.257574242532;7425.405967522694;7445.255474452511;7367.263273672805;7451.105867295959;7465.514741541782;7477.626118694152;7555.6977720890545;5813.534917206698;5882.176495290748;5922.378150294329;5926.4666180044005;5935.169076329404;6314.968425157845;6400.23197216337;6405.295417503978;6412.9358706414205;6414.230292364946;5582.720863956867;5645.350784659652;5668.744906479136;5689.402612725769;5824.534037276923;5641.605087643826;5693.516051135534;5704.458076482728;5716.114002329646;5810.767569297181;5408.675479471244;5506.201600767947;5512.145617429305;5513.393526711979;5515.420880807618;4030.1133750574827;4114.876553703393;4183.435236243068;4227.801543197582;4289.6139347458875;4168.6039826216465;4185.079282557833;4282.657387409062;4308.289132293262;4374.2563764160805 16:31:56 INFO - PROCESS | 20550 | |4;prototype.html;284.80490863758325;293.22588366711886;294.6581964920692;299.28769528522116;304.0816733464936;4754.619630429566;4887.2913427552985;4905.117078925792;4937.975310123449;4966.428860681022;4817.205161148407;4840.56434920857;4850.951490485094;4867.659263851532;4868.97565512172;3528.682418582327;3630.7640003399692;3650.926981460369;3779.281936432083;3784.7539909905768;3641.963580364189;3647.252313275772;3648.6351364863567;3772.1512659651635;3798.2783271178387;3728.5712143103483;3752.4934133891984;3753.2305877295225;3753.680937120348;3754.099016236097;3726.6273372662786;3728.869489567879;3736.327461057009;3749.737518373715;3751.4185301278208;3188.537662038991;3264.934701305984;3280.6063272407223;3281.950770738441;3293.670632936687;4718.150732868083;4722.984558319978;4730.550597693214;4732.881677958044;4746.620270378361;4290.356446533014;4292;4296.054867929081;4298.376735373354;4302.720323178984;4920.384951881015;4990.525900039527;5025.874353141201;5037.5642941761425;5095.490450954912;3553.7157027437743;3576.409892367756;3582.229820588586;3584.784912905208;3591.497190393347;5247.2653828464045;5306.734663266821;5320.600954928396;5329.440408757064;5355.598330125217;3560.7151427885706;3652.945205821915;3657.4148136298063;3660.7071434285194;3667.3765459871884;3652.3060618482405;3669.7614655047337;3674.154944362758;3693.7045036397026;3705.758570878732;4208.158368326347;4216.3464662977285;4217.472815898012;4221.409002739619;4223.366495025771;5039.118154322979;5054.241863720398;5056.862206003693;5058.367704036996;5074.3657042869645;1246.3269834289563;1260.6596219020812;1275.324078238535;1278.1755767529892;1280.6158152554196;764.4686942574857;784.6939693519532;796.3350602247189;797.9680812767424;798.3174385900088;3940.940885886714;3943.4479172915817;3954.367301231789;4244.554321796229;4385.122975404868;5049.747512624354;5185.714785686823;5191.532762051434;5200.231921146753;5207.244949482304;4397.9560204398185;4399.846005389796;4411.382406463098;4415.278041563793;4429.202743506135;2730.7165632152855;2784.554471284585;2798.776097912162;2813.6482939632547;2824.378636699923;4917.606591472673;4929.926051109236;4943.826966056243;4947.307376967227;4966.553010229097;5345.625806193607;5373.677579345252;5376.193570964387;5399.244105825188;5430.185472179205;4783;4938.506149385033;4944.159492886146;4965.329680493087;4974.502549744997;5215;5234.712090835041;5247.317848679647;5256.4743525648655;5260.579153667774;5140.845774626767;5166.121759301003;5176.22356646491;5189.429162792166;5209.817656382009;4823.059503396944;4906.988134864831;4928.901421971612;4930.531599498186;4951.876203094951;3637.199816040467;3639.381305178179;3644.8177591119806;3648.21563363878;3649.5620525537106;5239.441685733436;5245.947540524546;5246.868828279324;5252.107141785829;5273.551748101454;4798.520147985174;5010.724410157331;5042.647014708935;5058.367704036996;5091.389033316026;5031.446540880574;5034.338668239546;5039.924401133912;5042.0168067228005;5044.772985215601;4980.452150263541;4989.201727723692;4992.425871024879;4993.775280112331;4994.775235114356;4917.901641967069;4966.034664986232;5028.296038554532;5105.591552675703;5108.821191258288;4749.453812811571;4809.663323567317;4898.387701537308;4970.583383735618;4978.775955081957 16:31:56 INFO - PROCESS | 20550 | |5;yui.html;661.9503537234708;689.9068625735524;702.1503980183977;734.4418242135976;756.9432292578058;12078.335691536962;13057.934710326435;13078.084534082618;13079;13101.868981310185;12071.4567844447;12116.273023618589;12154.817677734818;12169.878301216986;12172.81740773889;612.3906712820727;629.5624540944045;634.4543692424511;781.5545139270617;796.044746304434;632.2760439297025;634.6223996721943;769.7806125254303;792.1761368177089;797.2784629909941;830.0786127398583;836.7113345895656;837.0666706622103;837.2172019162073;837.2757564706546;827.6027506796771;827.7227128911761;827.9254867061964;828.1428721273513;828.4035494444021;471.7641179410295;479.9568038876483;602.2712517853403;612.5865041097242;613.7851751886849;11943.880561194364;12532.561360352343;12549.309787961658;12576.434060467209;12586.874131258754;11998.460069296903;12110.515579376814;12151.210171338835;12283.57007504733;12776.744465110645;11076;11249.55001799927;11269.830952535718;11307.660770176908;11566.826497602542;3965.722399432041;3966.3455529837543;4067.9186416271805;4090.550039495653;4097.733647312915;51543;52028;52505.7374713124;52548;53447.19829202565;9430.339876208736;9434.905650943403;9656.37233579815;9836.557354919047;9898;16958.915205424142;17074.402395916084;17109.23008464622;17169.656606867793;17268.395606153725;6242.656653883989;6346.048092786119;6405.935940640627;6680.3987641112535;6834.897476537856;3386.4581666933173;3417.2482053948092;3431.1422144463886;3562.4656301554455;3576.910577235538;2764.737349951751;2859.9428011439654;2860.313524754086;2865.025891197003;2865.555838844982;474.43779121740846;481.63395819176975;492.0454318621862;502.92456131580553;533.8291746641115;563.9633423827438;590.3358721438382;592.380961894821;603.8580933480629;612.8467883029243;7705.653245603961;7731.736669291487;8003.399745019147;8012;8078.192180781874;466.56143225368726;562.9774809007594;597.6234971967633;614.8923938310778;628.2492421556196;3427.880024199141;3544.7164226862305;3568.553930758655;3598.1184609770776;3619.800910949923;42535.149297014505;54858.17712734312;67838;72229.2777072233;74293;64756;65524.672376638766;65593.34406655967;65729.34270657328;68801.65599171972;57290.713546432;57796.711016445486;58912;59314.40685593175;59551.40448595458;6528.771492997722;6615.933840661532;6663.200415950117;6755.966220168868;6871.965640171967;41090.383644244765;41101.383479248434;41111.588884111974;41730.58269417267;42442.78778606211;31978.84010579932;39356.01609959659;43837.780811097015;45780;48885.2667209985;9855.507224638883;10167.339122956984;10465.267431279737;10808.675739727822;11112.22214444981;11348.432578371214;11704.239224450383;11864.169508134348;12027.21823081497;12453.25280483174;11376.94311528437;11435;12209.572664956684;12342.876571234172;12353.444095015566;11305.152113591677;11565.306081635128;11705.531778729097;12100.394980250776;12503.37483125822;10355.482225888525;10427.94786026065;10504;10791;11649.708757280796;8466.661333546836;8571.82856342882;8857.3799834011;8926.73219803407;9390;9283.48940808235;9573.138417542455;9782.510874456391;9841.163501102486;9842.60629574809 16:31:56 INFO - PROCESS | 20550 | __end_tp_report 16:31:56 INFO - PROCESS | 20550 | __start_cc_report 16:31:56 INFO - PROCESS | 20550 | _x_x_mozilla_cycle_collect,3523 16:31:56 INFO - PROCESS | 20550 | __end_cc_report 16:31:56 INFO - PROCESS | 20550 | __startTimestamp1477956716208__endTimestamp 16:31:56 INFO - PROCESS | 20550 | 16:31:56 INFO - PROCESS | 20550 | ------- Summary: start ------- 16:31:56 INFO - PROCESS | 20550 | Number of tests: 6 16:31:56 INFO - PROCESS | 20550 | 16:31:56 INFO - PROCESS | 20550 | [#0] dojo.html Cycles:165 Average:4699.75 Median:4821.59 stddev:498.29 (10.3%) stddev-sans-first:471.35 16:31:56 INFO - PROCESS | 20550 | Values: 2583.3 2599.8 2631.7 2637.7 2643.5 4607.5 4674.6 4709.0 4715.4 4751.6 4697.9 4712.5 4735.4 4754.9 4824.4 4322.1 4332.9 4359.5 4373.8 4380.5 4393.7 4425.2 4425.2 4426.2 4474.5 4265.6 4438.2 4443.6 4451.7 4552.0 4250.2 4353.1 4358.5 4363.8 4372.0 4289.3 4340.1 4344.8 4345.5 4351.1 4768.6 4768.7 4774.8 4821.6 4845.6 5120.2 5123.7 5123.9 5127.6 5186.1 4980.6 5023.4 5134.1 5151.9 5153.9 4705.8 4747.7 4752.8 4755.4 4778.7 5212.0 5233.0 5237.0 5237.5 5239.1 4947.7 4983.5 5010.3 5024.4 5026.0 5122.2 5141.0 5143.8 5201.2 5201.3 5088.9 5091.1 5093.2 5095.1 5151.3 4872.4 4920.7 5072.5 5076.9 5130.0 4300.3 4322.2 4340.6 4352.8 4414.6 3793.8 3798.7 3802.6 3845.8 3847.2 4300.4 4323.4 4358.4 4359.6 4395.9 4990.9 5047.4 5088.5 5091.4 5110.6 4288.4 4310.8 4315.1 4316.9 4318.0 4588.4 4598.0 4600.5 4604.3 4615.6 4762.2 4770.7 4774.6 4776.9 4782.5 5110.0 5110.7 5113.6 5123.9 5129.1 4752.2 4765.9 4790.4 4790.5 4791.5 4939.2 4968.0 4987.9 4998.4 5063.1 5113.3 5132.3 5136.0 5138.0 5182.1 4835.2 4871.2 4872.7 4981.8 4986.9 4941.7 4944.8 4945.6 4946.0 4951.8 4880.3 4880.7 4881.3 4882.6 4894.1 4973.5 4985.8 4988.8 4992.7 4999.3 4846.3 4847.2 4858.2 4858.5 4859.2 16:31:56 INFO - PROCESS | 20550 | 16:31:56 INFO - PROCESS | 20550 | [#1] ext.html Cycles:180 Average:44619.39 Median:34351.07 stddev:78476.13 (228.5%) stddev-sans-first:78626.54 16:31:56 INFO - PROCESS | 20550 | Values: 557.4 568.5 578.4 581.4 593.9 37461.3 38595.4 38810.4 44203.8 44416.6 39939.4 40164.2 40201.8 40202.6 40210.8 7149.6 7381.5 7553.1 7769.5 7780.5 10043.2 10332.7 10347.9 10348.2 10355.3 10113.3 10214.5 10216.5 10217.7 10219.4 10058.9 10086.5 10104.0 10163.9 10166.6 9822.1 9920.0 9924.3 9930.8 9934.3 35771.1 35926.5 35948.6 36056.5 36108.6 2906.3 3052.7 3056.2 3084.2 3169.3 27858.9 28077.9 28936.4 28974.4 30198.8 3462.3 3530.9 3531.3 3577.2 3577.4 238090.0 239334.0 239952.0 240347.0 240841.0 51722.0 52092.5 52098.5 52115.0 52232.5 32001.8 33264.8 33417.8 35655.5 35676.6 13048.3 13242.1 13250.6 13255.8 13261.3 8602.3 8636.5 10060.5 10103.0 10297.7 17402.3 17912.4 17960.9 17967.8 18037.7 6957.3 7058.3 7076.8 7080.6 7219.2 790.2 862.9 902.1 906.2 948.2 26903.7 27379.7 27555.0 27653.0 27796.4 962.9 968.2 981.0 983.2 1009.1 14051.5 14224.2 14647.3 15016.6 15173.9 350242.0 353519.0 354604.0 354612.0 354699.0 48749.0 49330.0 49340.3 49386.8 49418.8 1140.7 1155.3 1157.6 1198.3 1199.6 25801.6 26203.0 26660.5 27208.3 27618.9 41643.6 41900.6 41916.6 41936.8 42049.8 292476.0 293075.0 293595.0 293690.0 294925.0 21508.7 22282.9 23302.2 24567.6 25210.0 40107.8 40369.0 40375.0 40419.4 40505.0 33352.0 34421.0 34459.3 34541.5 34855.3 33587.3 34321.3 34587.9 34946.5 35288.5 33360.5 34380.8 34408.0 34534.5 34988.0 29043.3 30029.4 31114.5 31124.2 31185.2 24004.5 24462.8 24577.0 24802.3 24980.8 16:31:56 INFO - PROCESS | 20550 | 16:31:56 INFO - PROCESS | 20550 | [#2] jquery.html Cycles:180 Average:23582.72 Median:21060.37 stddev:64149.34 (304.6%) stddev-sans-first:64305.61 16:31:56 INFO - PROCESS | 20550 | Values: 365.0 368.3 369.1 384.1 398.4 15997.2 16719.5 17170.8 17303.5 17313.4 15192.4 15505.6 15998.8 16056.7 16062.4 4874.9 5124.2 5133.3 5139.0 5141.4 4839.6 4997.1 5088.8 5093.4 5102.1 4892.6 4919.0 4922.0 4925.4 4928.4 4794.3 4935.0 4982.5 4985.0 4987.1 4527.0 4557.7 4559.9 4562.2 4562.7 19968.2 20057.0 20148.7 20268.5 20497.6 1994.9 2004.9 2154.4 2210.7 2261.9 12349.3 12971.0 13166.9 13450.7 13760.4 1642.0 1661.2 1685.3 1721.0 1726.8 65675.0 65865.7 66505.7 67543.7 68178.3 8903.9 9076.8 9182.8 9272.5 9375.5 11706.4 11717.8 11718.4 11719.6 11726.4 6386.7 6578.0 6624.7 6717.5 6757.9 6239.9 6265.4 6441.2 6442.4 6459.1 5904.6 5940.6 6078.8 6083.9 6087.5 1670.3 1690.6 1710.9 1747.5 1749.7 839.9 854.6 856.5 884.8 989.9 16466.7 16847.6 17670.5 17702.6 17977.9 869.4 876.9 908.0 915.4 916.5 9303.4 9617.9 10119.7 10221.2 10263.7 373458.0 393442.0 394350.0 396021.0 397674.0 35069.6 41722.4 64109.4 65708.3 68195.3 911.6 927.8 928.3 932.2 933.8 14477.3 15376.9 15676.8 15815.4 17167.0 36778.0 37107.4 37162.4 37347.6 38461.2 48552.0 48859.5 48899.8 49032.3 50512.2 7223.4 7310.0 7331.3 7472.9 7636.3 8049.2 11065.6 11731.6 11766.9 12267.5 10192.3 10450.9 10680.3 11149.7 11332.3 10079.3 10318.2 10545.8 10562.9 10603.5 10404.7 10563.5 10626.4 10728.6 11231.3 7481.7 7727.2 7904.3 7932.5 7955.6 7999.6 9154.3 10393.8 10409.0 10668.0 16:31:56 INFO - PROCESS | 20550 | 16:31:56 INFO - PROCESS | 20550 | [#3] mootools.html Cycles:180 Average:4430.83 Median:4725.72 stddev:2331.72 (49.3%) stddev-sans-first:2326.68 16:31:56 INFO - PROCESS | 20550 | Values: 1339.7 1365.8 1416.6 1602.3 1666.9 5774.0 6021.5 6465.1 6803.4 6805.9 6393.6 6593.4 6607.4 6745.0 6758.2 2024.1 2049.9 2051.6 2054.0 2054.4 1749.5 1821.0 1996.4 2035.0 2039.1 1776.9 1793.3 1954.3 2017.4 2027.7 1988.9 1989.2 1993.8 1994.1 1994.6 1990.7 1996.6 2003.1 2038.4 2040.1 6642.5 6701.3 6706.6 6798.9 6831.4 3974.1 4091.5 4096.8 4098.9 4100.2 2667.5 2767.2 2796.2 2833.9 2835.8 852.6 901.1 905.1 913.5 920.3 8467.9 8507.2 8565.3 8567.2 8580.8 3654.2 3762.7 3852.5 3862.7 3881.2 7527.6 7532.0 7538.1 7540.1 7545.8 4087.2 4092.2 4093.4 4093.5 4097.6 3672.9 3708.3 3719.5 3724.1 3730.5 3190.1 3256.5 3309.6 3310.1 3312.1 1134.3 1134.9 1138.3 1142.8 1147.4 739.5 755.0 828.7 840.4 844.0 4611.3 4634.4 4713.2 4729.3 4853.0 396.6 398.9 405.0 410.3 413.6 3321.7 3336.1 3359.5 3431.2 3445.1 7472.4 7845.3 7895.2 7969.4 7975.1 7946.5 7957.3 7961.9 7962.5 7971.8 6210.8 6236.0 6299.3 6350.1 6351.4 4637.9 4672.6 4722.1 4729.6 4782.5 7342.2 7403.7 7424.3 7425.4 7445.3 7367.3 7451.1 7465.5 7477.6 7555.7 5813.5 5882.2 5922.4 5926.5 5935.2 6315.0 6400.2 6405.3 6412.9 6414.2 5582.7 5645.4 5668.7 5689.4 5824.5 5641.6 5693.5 5704.5 5716.1 5810.8 5408.7 5506.2 5512.1 5513.4 5515.4 4030.1 4114.9 4183.4 4227.8 4289.6 4168.6 4185.1 4282.7 4308.3 4374.3 16:31:56 INFO - PROCESS | 20550 | 16:31:56 INFO - PROCESS | 20550 | [#4] prototype.html Cycles:180 Average:4183.52 Median:4820.13 stddev:1236.21 (25.6%) stddev-sans-first:1204.55 16:31:56 INFO - PROCESS | 20550 | Values: 284.8 293.2 294.7 299.3 304.1 4754.6 4887.3 4905.1 4938.0 4966.4 4817.2 4840.6 4851.0 4867.7 4869.0 3528.7 3630.8 3650.9 3779.3 3784.8 3642.0 3647.3 3648.6 3772.2 3798.3 3728.6 3752.5 3753.2 3753.7 3754.1 3726.6 3728.9 3736.3 3749.7 3751.4 3188.5 3264.9 3280.6 3282.0 3293.7 4718.2 4723.0 4730.6 4732.9 4746.6 4290.4 4292.0 4296.1 4298.4 4302.7 4920.4 4990.5 5025.9 5037.6 5095.5 3553.7 3576.4 3582.2 3584.8 3591.5 5247.3 5306.7 5320.6 5329.4 5355.6 3560.7 3652.9 3657.4 3660.7 3667.4 3652.3 3669.8 3674.2 3693.7 3705.8 4208.2 4216.3 4217.5 4221.4 4223.4 5039.1 5054.2 5056.9 5058.4 5074.4 1246.3 1260.7 1275.3 1278.2 1280.6 764.5 784.7 796.3 798.0 798.3 3940.9 3943.4 3954.4 4244.6 4385.1 5049.7 5185.7 5191.5 5200.2 5207.2 4398.0 4399.8 4411.4 4415.3 4429.2 2730.7 2784.6 2798.8 2813.6 2824.4 4917.6 4929.9 4943.8 4947.3 4966.6 5345.6 5373.7 5376.2 5399.2 5430.2 4783.0 4938.5 4944.2 4965.3 4974.5 5215.0 5234.7 5247.3 5256.5 5260.6 5140.8 5166.1 5176.2 5189.4 5209.8 4823.1 4907.0 4928.9 4930.5 4951.9 3637.2 3639.4 3644.8 3648.2 3649.6 5239.4 5245.9 5246.9 5252.1 5273.6 4798.5 5010.7 5042.6 5058.4 5091.4 5031.4 5034.3 5039.9 5042.0 5044.8 4980.5 4989.2 4992.4 4993.8 4994.8 4917.9 4966.0 5028.3 5105.6 5108.8 4749.5 4809.7 4898.4 4970.6 4978.8 16:31:56 INFO - PROCESS | 20550 | 16:31:56 INFO - PROCESS | 20550 | [#5] yui.html Cycles:180 Average:14640.73 Median:497.48 stddev:18714.00 (3761.7%) stddev-sans-first:18737.06 16:31:56 INFO - PROCESS | 20550 | Values: 662.0 689.9 702.2 734.4 756.9 12078.3 13057.9 13078.1 13079.0 13101.9 12071.5 12116.3 12154.8 12169.9 12172.8 612.4 629.6 634.5 781.6 796.0 632.3 634.6 769.8 792.2 797.3 830.1 836.7 837.1 837.2 837.3 827.6 827.7 827.9 828.1 828.4 471.8 480.0 602.3 612.6 613.8 11943.9 12532.6 12549.3 12576.4 12586.9 11998.5 12110.5 12151.2 12283.6 12776.7 11076.0 11249.6 11269.8 11307.7 11566.8 3965.7 3966.3 4067.9 4090.6 4097.7 51543.0 52028.0 52505.7 52548.0 53447.2 9430.3 9434.9 9656.4 9836.6 9898.0 16958.9 17074.4 17109.2 17169.7 17268.4 6242.7 6346.0 6405.9 6680.4 6834.9 3386.5 3417.2 3431.1 3562.5 3576.9 2764.7 2859.9 2860.3 2865.0 2865.6 474.4 481.6 492.0 502.9 533.8 564.0 590.3 592.4 603.9 612.8 7705.7 7731.7 8003.4 8012.0 8078.2 466.6 563.0 597.6 614.9 628.2 3427.9 3544.7 3568.6 3598.1 3619.8 42535.1 54858.2 67838.0 72229.3 74293.0 64756.0 65524.7 65593.3 65729.3 68801.7 57290.7 57796.7 58912.0 59314.4 59551.4 6528.8 6615.9 6663.2 6756.0 6872.0 41090.4 41101.4 41111.6 41730.6 42442.8 31978.8 39356.0 43837.8 45780.0 48885.3 9855.5 10167.3 10465.3 10808.7 11112.2 11348.4 11704.2 11864.2 12027.2 12453.3 11376.9 11435.0 12209.6 12342.9 12353.4 11305.2 11565.3 11705.5 12100.4 12503.4 10355.5 10427.9 10504.0 10791.0 11649.7 8466.7 8571.8 8857.4 8926.7 9390.0 9283.5 9573.1 9782.5 9841.2 9842.6 16:31:56 INFO - PROCESS | 20550 | -------- Summary: end -------- 16:31:56 INFO - PROCESS | 20550 | 16:31:57 INFO - TEST-INFO | 20550: exit 0 16:31:57 INFO - TEST-OK | dromaeo_css | took 1123642ms 16:31:57 INFO - TEST-START | kraken 16:31:57 INFO - operating with platform_type : linux_ 16:31:57 INFO - Initialising browser for kraken test... 16:31:57 INFO - TEST-INFO | started process 20859 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNdRHjV/profile http://localhost:33408/getInfo.html) 16:32:01 INFO - PROCESS | 20859 | __metrics Screen width/height:1600/1200 16:32:01 INFO - PROCESS | 20859 | colorDepth:24 16:32:01 INFO - PROCESS | 20859 | Browser inner width/height: 1024/697 16:32:01 INFO - PROCESS | 20859 | __metrics 16:32:02 INFO - PROCESS | 20859 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:32:02 INFO - PROCESS | 20859 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:32:03 INFO - PROCESS | 20859 | console.error: PushService: 16:32:03 INFO - PROCESS | 20859 | stateChangeProcessEnqueue: Error transitioning state 16:32:03 INFO - PROCESS | 20859 | UnknownError 16:32:04 INFO - TEST-INFO | 20859: exit 0 16:32:04 INFO - Browser initialized. 16:32:04 INFO - Running cycle 1/1 for kraken test... 16:32:04 INFO - TEST-INFO | started process 20941 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNdRHjV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:32:16 INFO - PROCESS | 20941 | RSS: Main: 176148480 16:32:16 INFO - PROCESS | 20941 | 16:32:19 INFO - PROCESS | 20941 | Cycle 1(1): loaded http://localhost:33408/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33408/tests/kraken/driver.html?testName=audio-beat-detection) 16:32:20 INFO - PROCESS | 20941 | RSS: Main: 232837120 16:32:20 INFO - PROCESS | 20941 | 16:32:22 INFO - PROCESS | 20941 | Cycle 1(1): loaded http://localhost:33408/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33408/tests/kraken/driver.html?testName=audio-dft) 16:32:23 INFO - PROCESS | 20941 | RSS: Main: 220069888 16:32:23 INFO - PROCESS | 20941 | 16:32:26 INFO - PROCESS | 20941 | Cycle 1(1): loaded http://localhost:33408/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33408/tests/kraken/driver.html?testName=audio-fft) 16:32:27 INFO - PROCESS | 20941 | RSS: Main: 301895680 16:32:27 INFO - PROCESS | 20941 | 16:32:29 INFO - PROCESS | 20941 | Cycle 1(1): loaded http://localhost:33408/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33408/tests/kraken/driver.html?testName=audio-oscillator) 16:32:30 INFO - PROCESS | 20941 | RSS: Main: 212500480 16:32:30 INFO - PROCESS | 20941 | 16:32:32 INFO - PROCESS | 20941 | Cycle 1(1): loaded http://localhost:33408/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33408/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:32:33 INFO - PROCESS | 20941 | RSS: Main: 215138304 16:32:33 INFO - PROCESS | 20941 | 16:32:36 INFO - PROCESS | 20941 | Cycle 1(1): loaded http://localhost:33408/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33408/tests/kraken/driver.html?testName=imaging-darkroom) 16:32:36 INFO - PROCESS | 20941 | RSS: Main: 251506688 16:32:36 INFO - PROCESS | 20941 | 16:32:40 INFO - PROCESS | 20941 | Cycle 1(1): loaded http://localhost:33408/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33408/tests/kraken/driver.html?testName=imaging-desaturate) 16:32:40 INFO - PROCESS | 20941 | RSS: Main: 250331136 16:32:40 INFO - PROCESS | 20941 | 16:32:43 INFO - PROCESS | 20941 | Cycle 1(1): loaded http://localhost:33408/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33408/tests/kraken/driver.html?testName=json-parse-financial) 16:32:44 INFO - PROCESS | 20941 | RSS: Main: 250015744 16:32:44 INFO - PROCESS | 20941 | 16:32:45 INFO - PROCESS | 20941 | Cycle 1(1): loaded http://localhost:33408/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33408/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:32:46 INFO - PROCESS | 20941 | RSS: Main: 212721664 16:32:46 INFO - PROCESS | 20941 | 16:32:48 INFO - PROCESS | 20941 | Cycle 1(1): loaded http://localhost:33408/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33408/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:32:49 INFO - PROCESS | 20941 | RSS: Main: 220090368 16:32:49 INFO - PROCESS | 20941 | 16:32:51 INFO - PROCESS | 20941 | Cycle 1(1): loaded http://localhost:33408/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33408/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:32:51 INFO - PROCESS | 20941 | RSS: Main: 229298176 16:32:51 INFO - PROCESS | 20941 | 16:32:54 INFO - PROCESS | 20941 | Cycle 1(1): loaded http://localhost:33408/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33408/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:32:55 INFO - PROCESS | 20941 | RSS: Main: 237453312 16:32:55 INFO - PROCESS | 20941 | 16:32:58 INFO - PROCESS | 20941 | Cycle 1(1): loaded http://localhost:33408/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33408/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:32:59 INFO - PROCESS | 20941 | RSS: Main: 233775104 16:32:59 INFO - PROCESS | 20941 | 16:33:00 INFO - PROCESS | 20941 | Cycle 1(1): loaded http://localhost:33408/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33408/tests/kraken/driver.html?testName=ai-astar) 16:33:01 INFO - PROCESS | 20941 | RSS: Main: 285216768 16:33:01 INFO - PROCESS | 20941 | 16:33:01 INFO - PROCESS | 20941 | __start_tp_report 16:33:01 INFO - PROCESS | 20941 | _x_x_mozilla_page_load 16:33:01 INFO - PROCESS | 20941 | _x_x_mozilla_page_load_details 16:33:01 INFO - PROCESS | 20941 | |i|pagename|runs| 16:33:01 INFO - PROCESS | 20941 | |0;ai-astar;108;118;118;118;117;119;117;116;119;116 16:33:01 INFO - PROCESS | 20941 | |1;audio-beat-detection;158;128;133;170;128;128;132;143;159;132 16:33:01 INFO - PROCESS | 20941 | |2;audio-dft;161;161;162;162;159;161;162;162;162;160 16:33:01 INFO - PROCESS | 20941 | |3;audio-fft;82;77;76;112;76;76;76;75;119;76 16:33:01 INFO - PROCESS | 20941 | |4;audio-oscillator;84;84;119;84;84;85;115;84;85;122 16:33:01 INFO - PROCESS | 20941 | |5;imaging-gaussian-blur;118;117;116;117;117;116;117;116;116;117 16:33:01 INFO - PROCESS | 20941 | |6;imaging-darkroom;147;146;147;147;147;148;148;148;148;146 16:33:01 INFO - PROCESS | 20941 | |7;imaging-desaturate;84;85;85;84;84;84;85;85;85;84 16:33:01 INFO - PROCESS | 20941 | |8;json-parse-financial;65;62;62;62;63;63;63;63;66;63 16:33:01 INFO - PROCESS | 20941 | |9;json-stringify-tinderbox;65;66;65;65;67;65;66;66;67;66 16:33:01 INFO - PROCESS | 20941 | |10;stanford-crypto-aes;85;83;91;82;83;84;91;84;84;82 16:33:01 INFO - PROCESS | 20941 | |11;stanford-crypto-ccm;146;143;142;142;146;141;143;147;179;142 16:33:01 INFO - PROCESS | 20941 | |12;stanford-crypto-pbkdf2;179;180;179;175;180;182;177;177;176;177 16:33:01 INFO - PROCESS | 20941 | |13;stanford-crypto-sha256-iterative;73;70;68;71;68;69;69;73;75;71 16:33:01 INFO - PROCESS | 20941 | __end_tp_report 16:33:01 INFO - PROCESS | 20941 | __start_cc_report 16:33:01 INFO - PROCESS | 20941 | _x_x_mozilla_cycle_collect,1989 16:33:01 INFO - PROCESS | 20941 | __end_cc_report 16:33:01 INFO - PROCESS | 20941 | __startTimestamp1477956781133__endTimestamp 16:33:01 INFO - PROCESS | 20941 | 16:33:01 INFO - PROCESS | 20941 | ------- Summary: start ------- 16:33:01 INFO - PROCESS | 20941 | Number of tests: 14 16:33:01 INFO - PROCESS | 20941 | 16:33:01 INFO - PROCESS | 20941 | [#0] ai-astar Cycles:10 Average:116.60 Median:118.00 stddev:3.20 (2.7%) stddev-sans-first:1.13 16:33:01 INFO - PROCESS | 20941 | Values: 108.0 118.0 118.0 118.0 117.0 119.0 117.0 116.0 119.0 116.0 16:33:01 INFO - PROCESS | 20941 | 16:33:01 INFO - PROCESS | 20941 | [#1] audio-beat-detection Cycles:10 Average:141.10 Median:138.00 stddev:15.60 (11.3%) stddev-sans-first:15.30 16:33:01 INFO - PROCESS | 20941 | Values: 158.0 128.0 133.0 170.0 128.0 128.0 132.0 143.0 159.0 132.0 16:33:01 INFO - PROCESS | 20941 | 16:33:01 INFO - PROCESS | 20941 | [#2] audio-dft Cycles:10 Average:161.20 Median:162.00 stddev:1.03 (0.6%) stddev-sans-first:1.09 16:33:01 INFO - PROCESS | 20941 | Values: 161.0 161.0 162.0 162.0 159.0 161.0 162.0 162.0 162.0 160.0 16:33:01 INFO - PROCESS | 20941 | 16:33:01 INFO - PROCESS | 20941 | [#3] audio-fft Cycles:10 Average:84.50 Median:76.00 stddev:16.53 (21.8%) stddev-sans-first:17.51 16:33:01 INFO - PROCESS | 20941 | Values: 82.0 77.0 76.0 112.0 76.0 76.0 76.0 75.0 119.0 76.0 16:33:01 INFO - PROCESS | 20941 | 16:33:01 INFO - PROCESS | 20941 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:84.00 stddev:16.69 (19.9%) stddev-sans-first:17.26 16:33:01 INFO - PROCESS | 20941 | Values: 84.0 84.0 119.0 84.0 84.0 85.0 115.0 84.0 85.0 122.0 16:33:01 INFO - PROCESS | 20941 | 16:33:01 INFO - PROCESS | 20941 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.53 16:33:01 INFO - PROCESS | 20941 | Values: 118.0 117.0 116.0 117.0 117.0 116.0 117.0 116.0 116.0 117.0 16:33:01 INFO - PROCESS | 20941 | 16:33:01 INFO - PROCESS | 20941 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 16:33:01 INFO - PROCESS | 20941 | Values: 147.0 146.0 147.0 147.0 147.0 148.0 148.0 148.0 148.0 146.0 16:33:01 INFO - PROCESS | 20941 | 16:33:01 INFO - PROCESS | 20941 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:85.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 16:33:01 INFO - PROCESS | 20941 | Values: 84.0 85.0 85.0 84.0 84.0 84.0 85.0 85.0 85.0 84.0 16:33:01 INFO - PROCESS | 20941 | 16:33:01 INFO - PROCESS | 20941 | [#8] json-parse-financial Cycles:10 Average:63.20 Median:63.00 stddev:1.32 (2.1%) stddev-sans-first:1.22 16:33:01 INFO - PROCESS | 20941 | Values: 65.0 62.0 62.0 62.0 63.0 63.0 63.0 63.0 66.0 63.0 16:33:01 INFO - PROCESS | 20941 | 16:33:01 INFO - PROCESS | 20941 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 16:33:01 INFO - PROCESS | 20941 | Values: 65.0 66.0 65.0 65.0 67.0 65.0 66.0 66.0 67.0 66.0 16:33:01 INFO - PROCESS | 20941 | 16:33:01 INFO - PROCESS | 20941 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:84.00 stddev:3.35 (4.0%) stddev-sans-first:3.55 16:33:01 INFO - PROCESS | 20941 | Values: 85.0 83.0 91.0 82.0 83.0 84.0 91.0 84.0 84.0 82.0 16:33:01 INFO - PROCESS | 20941 | 16:33:01 INFO - PROCESS | 20941 | [#11] stanford-crypto-ccm Cycles:10 Average:147.10 Median:144.50 stddev:11.40 (7.9%) stddev-sans-first:12.08 16:33:01 INFO - PROCESS | 20941 | Values: 146.0 143.0 142.0 142.0 146.0 141.0 143.0 147.0 179.0 142.0 16:33:01 INFO - PROCESS | 20941 | 16:33:01 INFO - PROCESS | 20941 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.20 Median:179.00 stddev:2.15 (1.2%) stddev-sans-first:2.26 16:33:01 INFO - PROCESS | 20941 | Values: 179.0 180.0 179.0 175.0 180.0 182.0 177.0 177.0 176.0 177.0 16:33:01 INFO - PROCESS | 20941 | 16:33:01 INFO - PROCESS | 20941 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:71.00 stddev:2.36 (3.3%) stddev-sans-first:2.35 16:33:01 INFO - PROCESS | 20941 | Values: 73.0 70.0 68.0 71.0 68.0 69.0 69.0 73.0 75.0 71.0 16:33:01 INFO - PROCESS | 20941 | -------- Summary: end -------- 16:33:01 INFO - PROCESS | 20941 | 16:33:02 INFO - TEST-INFO | 20941: exit 0 16:33:02 INFO - TEST-OK | kraken | took 65361ms 16:33:02 INFO - SUITE-END | took 1189s 16:33:02 INFO - Completed test suite (00:19:49) 16:33:02 INFO - javascript benchmark 16:33:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2583.2508572513966, 2599.75302346277, 2631.6710411198605, 2637.6702912135984, 2643.510950474162, 4607.516210797869, 4674.579287864091, 4709.0346478971815, 4715.386999690036, 4751.572358487735, 4697.882552936178, 4712.528747125286, 4735.431748190222, 4754.857354279368, 4824.372831531896, 4322.113966636847, 4332.913341733163, 4359.542248063955, 4373.803178856959, 4380.518143004283, 4393.670474714393, 4425.159219748253, 4425.203463376591, 4426.22541055314, 4474.530174331697, 4265.616094551505, 4438.178936896685, 4443.622292105175, 4451.732896026217, 4551.954480455202, 4250.213710463574, 4353.1293741251875, 4358.476982762058, 4363.759993200372, 4371.956280437187, 4289.270823959903, 4340.131973605292, 4344.7827608619755, 4345.543717909637, 4351.129774045204, 4768.570828625406, 4768.690035147704, 4774.832880849153, 4821.590164835993, 4845.563899249049, 5120.15517439622, 5123.666961647518, 5123.923141152885, 5127.6154288428515, 5186.1442861927735, 4980.626453016038, 5023.397192336943, 5134.101532231844, 5151.871203219912, 5153.871153221199, 4705.764711764398, 4747.667663263538, 4752.7623618818925, 4755.358026666425, 4778.689385189951, 5211.973940130275, 5233.031889100453, 5236.973815130977, 5237.476252374732, 5239.1093514102695, 4947.703137811743, 4983.526564976321, 5010.273510341053, 5024.371953505812, 5026.0199261143725, 5122.154844450699, 5140.997505486469, 5143.8456846294675, 5201.219817027476, 5201.3238279024245, 5088.92366614501, 5091.0581542414775, 5093.2105523643895, 5095.108356037678, 5151.25306830515, 4872.3909511311085, 4920.6555541111775, 5072.51811077947, 5076.873078173076, 5129.9743501282255, 4300.268954277781, 4322.243607368698, 4340.587644173798, 4352.804123814436, 4414.580614841585, 3793.7534060285993, 3798.677112445473, 3802.5817160112365, 3845.7884816335372, 3847.2305538892333, 4300.3549467580115, 4323.373110898902, 4358.389825424443, 4359.564043595678, 4395.934060989088, 4990.925136122961, 5047.41954675217, 5088.542031217208, 5091.439941606421, 5110.565601923804, 4288.378185163134, 4310.827566897289, 4315.115401342718, 4316.935245971313, 4317.956820431818, 4588.403507543998, 4598.034412773288, 4600.493945665974, 4604.309353596987, 4615.5845973862515, 4762.214234651313, 4770.737609431376, 4774.594159496482, 4776.904461910812, 4782.497837726988, 5110.029094472038, 5110.66780659256, 5113.616478764033, 5123.897522049613, 5129.102407078821, 4752.192127338291, 4765.880852978703, 4790.353302304145, 4790.5448982346625, 4791.47293797689, 4939.158188709327, 4967.950320496749, 4987.9002419950675, 4998.350214472095, 5063.113955057924, 5113.284140220298, 5132.332796736549, 5136.0241554104605, 5138.0, 5182.067227899014, 4835.20219163834, 4871.196252618278, 4872.731999739906, 4981.775820088177, 4986.850394488171, 4941.678790878582, 4944.752762361795, 4945.6043516517875, 4945.97527012377, 4951.77717002743, 4880.292357608056, 4880.658353915192, 4881.316615673737, 4882.609391248762, 4894.119058569349, 4973.502649734997, 4985.750712464434, 4988.800447982186, 4992.650514464098, 4999.275105109666, 4846.321514987975, 4847.175980083465, 4858.17411040117, 4858.5384388483035, 4859.222524396079], "value": 4667.336783355606, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.423067125525, 568.4628026514945, 578.4013545979911, 581.4098689829824, 593.9249957576784, 37461.25077498448, 38595.421068683994, 38810.4178437323, 44203.778981105046, 44416.55583444165, 39939.40090898639, 40164.196716065664, 40201.798991005075, 40202.59797402025, 40210.7989460053, 7149.606771627558, 7381.48329616927, 7553.131389890164, 7769.456138070337, 7780.494267872598, 10043.246756493256, 10332.741681457986, 10347.948260258689, 10348.172146228284, 10355.32690375127, 10113.292069555135, 10214.540345684461, 10216.48917554123, 10217.6934691959, 10219.437930913797, 10058.89941100587, 10086.546105425274, 10103.999999999927, 10163.94918025405, 10166.644167454178, 9822.116009559173, 9919.950400248024, 9924.255680823895, 9930.80138397228, 9934.254930880214, 35771.105722356886, 35926.46110308347, 35948.64051359479, 36056.45915311272, 36108.63891361105, 2906.3170155013554, 3052.740517056053, 3056.159556122062, 3084.1826915867314, 3169.3344397676515, 27858.86070569634, 28077.85961070202, 28936.42127157466, 28974.42051158965, 30198.84900575483, 3462.255615042778, 3530.947035794465, 3531.29374125176, 3577.177249232691, 3577.372295605493, 238090.0, 239334.0, 239952.0, 240347.0, 240841.0, 51722.0, 52092.479075208765, 52098.47901521012, 52115.0, 52232.47767522352, 32001.839990799897, 33264.83367583147, 33417.83291083578, 35655.4651680225, 35676.643233567855, 13048.282344470956, 13242.079898414677, 13250.602481925365, 13255.801162982563, 13261.270630115243, 8602.279544091207, 8636.524991125549, 10060.547275372479, 10103.0, 10297.742556436, 17402.303907843543, 17912.373066942593, 17960.9101954492, 17967.820321796615, 18037.7294340585, 6957.339052790078, 7058.341494613531, 7076.787696369117, 7080.575165490087, 7219.169795473483, 790.1861083084432, 862.9127299602546, 902.0528445132585, 906.1799071839995, 948.1987720376271, 26903.730962690515, 27379.660966111816, 27555.0, 27653.0, 27796.444071118465, 962.8940816510178, 968.1963969904962, 980.9754756131153, 983.1839573154265, 1009.0968583118068, 14051.508197213048, 14224.217668028357, 14647.340869660891, 15016.624584385478, 15173.924130379499, 350242.0, 353519.0, 354604.0, 354612.0, 354699.0, 48749.0, 49330.0, 49340.25989610159, 49386.753066234436, 49418.75290623524, 1140.6521011091697, 1155.3010428690857, 1157.6064138193055, 1198.2870192235605, 1199.622119032502, 25801.612975805754, 26203.0, 26660.466790664464, 27208.319792005357, 27618.86190569115, 41643.58356416518, 41900.580994189666, 41916.58083419127, 41936.790316048224, 42049.78975105105, 292476.0, 293075.0, 293595.0, 293690.0, 294925.0, 21508.677369839777, 22282.888585556968, 23302.184423545095, 24567.631485527374, 25209.974803023753, 40107.799461002505, 40369.0, 40375.0, 40419.3937090938, 40504.987375314675, 33352.0, 34421.0, 34459.310813783086, 34541.48187777135, 34855.30289394147, 33587.32825343431, 34321.31357372888, 34587.92472451661, 34946.47580286247, 35288.47067294044, 33360.49959250564, 34380.82809585936, 34408.0, 34534.48198276978, 34988.0, 29043.27391815137, 30029.399412012073, 31114.533282000335, 31124.221894451915, 31185.220369490944, 24004.491836187357, 24462.755372446758, 24577.0, 24802.25593232206, 24980.750192497842], "value": 17308.674013307194, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.9927001459973, 368.2671483747343, 369.1454283334081, 384.05330859431496, 398.37455195343324, 15997.200139993012, 16719.498415047554, 17170.82829171706, 17303.48089557312, 17313.39403120891, 15192.392304307814, 15505.612359691013, 15998.840011599881, 16056.71546276298, 16062.357505699787, 4874.8537543873745, 5124.205748109049, 5133.3326667533165, 5139.0, 5141.434442211354, 4839.588634966032, 4997.050560393532, 5088.771005304751, 5093.388793344804, 5102.081625307444, 4892.608591312704, 4918.950810491885, 4921.950780492185, 4925.408950925894, 4928.43323017854, 4794.2808578713475, 4934.950650493503, 4982.476839931827, 4984.950150498485, 4987.0524600325825, 4526.977365113154, 4557.703749256288, 4559.931601025987, 4562.224421848294, 4562.657800664931, 19968.201271949103, 20057.0, 20148.697769533468, 20268.493287667778, 20497.5900481991, 1994.8603597748163, 2004.9398518044336, 2154.396768904709, 2210.701555290031, 2261.8529795563236, 12349.259044457362, 12971.0, 13166.86833131666, 13450.663733406645, 13760.449582016707, 1642.0, 1661.2275291989283, 1685.2669088946348, 1720.956976075608, 1726.8273172682757, 65675.0, 65865.67067164682, 66505.66747166234, 67543.66228168877, 68178.3182168182, 8903.866442003375, 9076.773080673036, 9182.816343673088, 9272.490013049348, 9375.484193427465, 11706.414679266003, 11717.824232636518, 11718.414079296172, 11719.589814356457, 11726.355050472306, 6386.680665966683, 6577.967110164419, 6624.668766561653, 6717.5297729159465, 6757.93242067573, 6239.875202496016, 6265.373462653698, 6441.194850643669, 6442.420182183626, 6459.063435801782, 5904.643962848298, 5940.613860099166, 6078.817635470943, 6083.878322433527, 6087.482563982023, 1670.2650833633163, 1690.6280618263963, 1710.8716846236582, 1747.519432156167, 1749.6500699860078, 839.9496030238205, 854.645322191296, 856.4946681457969, 884.8186121845006, 989.8861630912393, 16466.6706665866, 16847.64133021378, 17670.469885903443, 17702.557436063944, 17977.910110449364, 869.3740506835069, 876.912308769118, 907.981840363189, 915.3546749541557, 916.4547094478775, 9303.395279306824, 9617.855732164024, 10119.7470063249, 10221.182305415548, 10263.74340641475, 373458.0, 393442.0, 394350.0, 396021.0, 397674.0, 35069.64930350664, 41722.37416438756, 64109.358906411275, 65708.34291657117, 68195.31804681988, 911.6399022386121, 927.8051609162152, 928.2759447630858, 932.1750251027754, 933.8365785987424, 14477.348519316867, 15376.923115384352, 15676.843231567538, 15815.446459373867, 17167.0, 36778.0, 37107.443388348656, 37162.442563362114, 37347.626523735504, 38461.230775384895, 48552.0, 48859.511404885496, 48899.755501222266, 49032.26451603157, 50512.24231636455, 7223.422126229784, 7309.963450182928, 7331.266873312626, 7472.8879066815125, 7636.31273185416, 8049.154838742082, 11065.612703555336, 11731.648050558155, 11766.941165294118, 12267.509299627915, 10192.337498062601, 10450.947745261225, 10680.252382333161, 11149.72125696864, 11332.263402878787, 10079.294449388472, 10318.226133039901, 10545.789084218119, 10562.894371056498, 10603.469826508797, 10404.739881503023, 10563.521107044866, 10626.415547144672, 10728.624498142528, 11231.26996745209, 7481.738139165103, 7727.188645192174, 7904.328132108605, 7932.484388514728, 7955.562444065632, 7999.600019999093, 9154.267658587163, 10393.792124157626, 10409.0, 10668.03987641116], "value": 8091.946863364883, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.6516905604542, 1365.8087867698523, 1416.6458385403648, 1602.2549514475766, 1666.8916520426178, 5773.971130144343, 6021.488173505258, 6465.094886715858, 6803.421709154722, 6805.897911531325, 6393.648349340784, 6593.439557637606, 6607.405333519982, 6744.954532047528, 6758.2228043774985, 2024.1498570600384, 2049.907754151059, 2051.620450216707, 2053.9897300513476, 2054.3734161080865, 1749.5101371615967, 1820.9908950455228, 1996.4210378990076, 2035.0333591544047, 2039.1333683184662, 1776.9378071767492, 1793.3454289184485, 1954.3452943263953, 2017.4351181669156, 2027.6654352031896, 1988.8607797454183, 1989.2043182727025, 1993.800619938009, 1994.0827219479056, 1994.591108822695, 1990.7013947907785, 1996.5607566335384, 2003.0685731135093, 2038.4088614301984, 2040.051376110101, 6642.501812364044, 6701.262861085277, 6706.5640733352175, 6798.932010679929, 6831.351021652985, 3974.066094467798, 4091.5499295077516, 4096.836126554964, 4098.938515922264, 4100.2414553307435, 2667.5198464276423, 2767.1975127213086, 2796.203082121586, 2833.886644534216, 2835.801493895428, 852.6163226548078, 901.0989010989011, 905.0858632780938, 913.5112714697605, 920.3235621817959, 8467.915320846774, 8507.234348908565, 8565.271951884097, 8567.228949394585, 8580.82838343236, 3654.1595433050015, 3762.6801721853403, 3852.4799152114106, 3862.748921320105, 3881.165549406891, 7527.585982770891, 7531.962340188264, 7538.09542854861, 7540.095188577406, 7545.811354716176, 4087.2234275487563, 4092.1611069730634, 4093.3859921012086, 4093.5087789465456, 4097.590240975938, 3672.926541469156, 3708.3325001499447, 3719.460678201646, 3724.0875985383755, 3730.477733117366, 3190.090824115116, 3256.495243237302, 3309.586301712286, 3310.1062713067818, 3312.138843900603, 1134.3307448605362, 1134.8978591926766, 1138.277193981811, 1142.828575713633, 1147.4320211495196, 739.5230076600562, 754.9543881723852, 828.6685325869701, 840.4243093480985, 843.9789005274795, 4611.331356953223, 4634.443866735945, 4713.2404650397475, 4729.337892695025, 4853.0, 396.60141557734295, 398.8982809383589, 404.96557792587373, 410.27381534683445, 413.6194700875202, 3321.65122662117, 3336.132605522582, 3359.5296658467832, 3431.1936694876686, 3445.13871532117, 7472.439567032494, 7845.333146682482, 7895.171007044292, 7969.402294827911, 7975.082865470429, 7946.523208607502, 7957.283844454027, 7961.880571791427, 7962.482438641469, 7971.800704982422, 6210.782622608187, 6236.0, 6299.338569450142, 6350.1109844622715, 6351.428371446592, 4637.907241855077, 4672.602828759457, 4722.1028004680375, 4729.574338309569, 4782.52174782519, 7342.155652100077, 7403.7408690695565, 7424.257574242532, 7425.405967522694, 7445.255474452511, 7367.263273672805, 7451.105867295959, 7465.514741541782, 7477.626118694152, 7555.6977720890545, 5813.534917206698, 5882.176495290748, 5922.378150294329, 5926.4666180044005, 5935.169076329404, 6314.968425157845, 6400.23197216337, 6405.295417503978, 6412.9358706414205, 6414.230292364946, 5582.720863956867, 5645.350784659652, 5668.744906479136, 5689.402612725769, 5824.534037276923, 5641.605087643826, 5693.516051135534, 5704.458076482728, 5716.114002329646, 5810.767569297181, 5408.675479471244, 5506.201600767947, 5512.145617429305, 5513.393526711979, 5515.420880807618, 4030.1133750574827, 4114.876553703393, 4183.435236243068, 4227.801543197582, 4289.6139347458875, 4168.6039826216465, 4185.079282557833, 4282.657387409062, 4308.289132293262, 4374.2563764160805], "value": 3606.4685912169953, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.80490863758325, 293.22588366711886, 294.6581964920692, 299.28769528522116, 304.0816733464936, 4754.619630429566, 4887.2913427552985, 4905.117078925792, 4937.975310123449, 4966.428860681022, 4817.205161148407, 4840.56434920857, 4850.951490485094, 4867.659263851532, 4868.97565512172, 3528.682418582327, 3630.7640003399692, 3650.926981460369, 3779.281936432083, 3784.7539909905768, 3641.963580364189, 3647.252313275772, 3648.6351364863567, 3772.1512659651635, 3798.2783271178387, 3728.5712143103483, 3752.4934133891984, 3753.2305877295225, 3753.680937120348, 3754.099016236097, 3726.6273372662786, 3728.869489567879, 3736.327461057009, 3749.737518373715, 3751.4185301278208, 3188.537662038991, 3264.934701305984, 3280.6063272407223, 3281.950770738441, 3293.670632936687, 4718.150732868083, 4722.984558319978, 4730.550597693214, 4732.881677958044, 4746.620270378361, 4290.356446533014, 4292.0, 4296.054867929081, 4298.376735373354, 4302.720323178984, 4920.384951881015, 4990.525900039527, 5025.874353141201, 5037.5642941761425, 5095.490450954912, 3553.7157027437743, 3576.409892367756, 3582.229820588586, 3584.784912905208, 3591.497190393347, 5247.2653828464045, 5306.734663266821, 5320.600954928396, 5329.440408757064, 5355.598330125217, 3560.7151427885706, 3652.945205821915, 3657.4148136298063, 3660.7071434285194, 3667.3765459871884, 3652.3060618482405, 3669.7614655047337, 3674.154944362758, 3693.7045036397026, 3705.758570878732, 4208.158368326347, 4216.3464662977285, 4217.472815898012, 4221.409002739619, 4223.366495025771, 5039.118154322979, 5054.241863720398, 5056.862206003693, 5058.367704036996, 5074.3657042869645, 1246.3269834289563, 1260.6596219020812, 1275.324078238535, 1278.1755767529892, 1280.6158152554196, 764.4686942574857, 784.6939693519532, 796.3350602247189, 797.9680812767424, 798.3174385900088, 3940.940885886714, 3943.4479172915817, 3954.367301231789, 4244.554321796229, 4385.122975404868, 5049.747512624354, 5185.714785686823, 5191.532762051434, 5200.231921146753, 5207.244949482304, 4397.9560204398185, 4399.846005389796, 4411.382406463098, 4415.278041563793, 4429.202743506135, 2730.7165632152855, 2784.554471284585, 2798.776097912162, 2813.6482939632547, 2824.378636699923, 4917.606591472673, 4929.926051109236, 4943.826966056243, 4947.307376967227, 4966.553010229097, 5345.625806193607, 5373.677579345252, 5376.193570964387, 5399.244105825188, 5430.185472179205, 4783.0, 4938.506149385033, 4944.159492886146, 4965.329680493087, 4974.502549744997, 5215.0, 5234.712090835041, 5247.317848679647, 5256.4743525648655, 5260.579153667774, 5140.845774626767, 5166.121759301003, 5176.22356646491, 5189.429162792166, 5209.817656382009, 4823.059503396944, 4906.988134864831, 4928.901421971612, 4930.531599498186, 4951.876203094951, 3637.199816040467, 3639.381305178179, 3644.8177591119806, 3648.21563363878, 3649.5620525537106, 5239.441685733436, 5245.947540524546, 5246.868828279324, 5252.107141785829, 5273.551748101454, 4798.520147985174, 5010.724410157331, 5042.647014708935, 5058.367704036996, 5091.389033316026, 5031.446540880574, 5034.338668239546, 5039.924401133912, 5042.0168067228005, 5044.772985215601, 4980.452150263541, 4989.201727723692, 4992.425871024879, 4993.775280112331, 4994.775235114356, 4917.901641967069, 4966.034664986232, 5028.296038554532, 5105.591552675703, 5108.821191258288, 4749.453812811571, 4809.663323567317, 4898.387701537308, 4970.583383735618, 4978.775955081957], "value": 3785.155887657363, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [661.9503537234708, 689.9068625735524, 702.1503980183977, 734.4418242135976, 756.9432292578058, 12078.335691536962, 13057.934710326435, 13078.084534082618, 13079.0, 13101.868981310185, 12071.4567844447, 12116.273023618589, 12154.817677734818, 12169.878301216986, 12172.81740773889, 612.3906712820727, 629.5624540944045, 634.4543692424511, 781.5545139270617, 796.044746304434, 632.2760439297025, 634.6223996721943, 769.7806125254303, 792.1761368177089, 797.2784629909941, 830.0786127398583, 836.7113345895656, 837.0666706622103, 837.2172019162073, 837.2757564706546, 827.6027506796771, 827.7227128911761, 827.9254867061964, 828.1428721273513, 828.4035494444021, 471.7641179410295, 479.9568038876483, 602.2712517853403, 612.5865041097242, 613.7851751886849, 11943.880561194364, 12532.561360352343, 12549.309787961658, 12576.434060467209, 12586.874131258754, 11998.460069296903, 12110.515579376814, 12151.210171338835, 12283.57007504733, 12776.744465110645, 11076.0, 11249.55001799927, 11269.830952535718, 11307.660770176908, 11566.826497602542, 3965.722399432041, 3966.3455529837543, 4067.9186416271805, 4090.550039495653, 4097.733647312915, 51543.0, 52028.0, 52505.7374713124, 52548.0, 53447.19829202565, 9430.339876208736, 9434.905650943403, 9656.37233579815, 9836.557354919047, 9898.0, 16958.915205424142, 17074.402395916084, 17109.23008464622, 17169.656606867793, 17268.395606153725, 6242.656653883989, 6346.048092786119, 6405.935940640627, 6680.3987641112535, 6834.897476537856, 3386.4581666933173, 3417.2482053948092, 3431.1422144463886, 3562.4656301554455, 3576.910577235538, 2764.737349951751, 2859.9428011439654, 2860.313524754086, 2865.025891197003, 2865.555838844982, 474.43779121740846, 481.63395819176975, 492.0454318621862, 502.92456131580553, 533.8291746641115, 563.9633423827438, 590.3358721438382, 592.380961894821, 603.8580933480629, 612.8467883029243, 7705.653245603961, 7731.736669291487, 8003.399745019147, 8012.0, 8078.192180781874, 466.56143225368726, 562.9774809007594, 597.6234971967633, 614.8923938310778, 628.2492421556196, 3427.880024199141, 3544.7164226862305, 3568.553930758655, 3598.1184609770776, 3619.800910949923, 42535.149297014505, 54858.17712734312, 67838.0, 72229.2777072233, 74293.0, 64756.0, 65524.672376638766, 65593.34406655967, 65729.34270657328, 68801.65599171972, 57290.713546432, 57796.711016445486, 58912.0, 59314.40685593175, 59551.40448595458, 6528.771492997722, 6615.933840661532, 6663.200415950117, 6755.966220168868, 6871.965640171967, 41090.383644244765, 41101.383479248434, 41111.588884111974, 41730.58269417267, 42442.78778606211, 31978.84010579932, 39356.01609959659, 43837.780811097015, 45780.0, 48885.2667209985, 9855.507224638883, 10167.339122956984, 10465.267431279737, 10808.675739727822, 11112.22214444981, 11348.432578371214, 11704.239224450383, 11864.169508134348, 12027.21823081497, 12453.25280483174, 11376.94311528437, 11435.0, 12209.572664956684, 12342.876571234172, 12353.444095015566, 11305.152113591677, 11565.306081635128, 11705.531778729097, 12100.394980250776, 12503.37483125822, 10355.482225888525, 10427.94786026065, 10504.0, 10791.0, 11649.708757280796, 8466.661333546836, 8571.82856342882, 8857.3799834011, 8926.73219803407, 9390.0, 9283.48940808235, 9573.138417542455, 9782.510874456391, 9841.163501102486, 9842.60629574809], "value": 6093.755273810167, "unit": "score"}], "name": "dromaeo_css", "value": 6155.291561898986, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 118.0, 118.0, 118.0, 117.0, 119.0, 117.0, 116.0, 119.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 128.0, 133.0, 170.0, 128.0, 128.0, 132.0, 143.0, 159.0, 132.0], "value": 141.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 162.0, 159.0, 161.0, 162.0, 162.0, 162.0, 160.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 77.0, 76.0, 112.0, 76.0, 76.0, 76.0, 75.0, 119.0, 76.0], "value": 84.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 119.0, 84.0, 84.0, 85.0, 115.0, 84.0, 85.0, 122.0], "value": 94.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 147.0, 147.0, 148.0, 148.0, 148.0, 148.0, 146.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 84.0, 84.0, 84.0, 85.0, 85.0, 85.0, 84.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 62.0, 62.0, 63.0, 63.0, 63.0, 63.0, 66.0, 63.0], "value": 63.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 67.0, 65.0, 66.0, 66.0, 67.0, 66.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 91.0, 82.0, 83.0, 84.0, 91.0, 84.0, 84.0, 82.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 143.0, 142.0, 142.0, 146.0, 141.0, 143.0, 147.0, 179.0, 142.0], "value": 147.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 180.0, 179.0, 175.0, 180.0, 182.0, 177.0, 177.0, 176.0, 177.0], "value": 178.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 70.0, 68.0, 71.0, 68.0, 69.0, 69.0, 73.0, 75.0, 71.0], "value": 70.7, "unit": "score"}], "name": "kraken", "value": 1556.3000000000002, "alertThreshold": 2.0}]} 16:33:02 INFO - Return code: 0 16:33:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:33:02 INFO - # TBPL SUCCESS # 16:33:02 INFO - Running post-action listener: _resource_record_post_action 16:33:02 INFO - [mozharness: 2016-10-31 23:33:02.940052Z] Finished run-tests step (success) 16:33:02 INFO - Running post-run listener: _resource_record_post_run 16:33:03 INFO - Total resource usage - Wall time: 1206s; CPU: 13.0%; Read bytes: 4096; Write bytes: 397889536; Read time: 12; Write time: 385440 16:33:03 INFO - TinderboxPrint: CPU usage
13.1% 16:33:03 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 16:33:03 INFO - TinderboxPrint: I/O write bytes / time
397,889,536 / 385,440 16:33:03 INFO - TinderboxPrint: CPU idle
8,365.5 (86.9%) 16:33:03 INFO - TinderboxPrint: CPU user
1,206.4 (12.5%) 16:33:03 INFO - TinderboxPrint: Swap in / out
0 / 0 16:33:03 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107466752; Read time: 0; Write time: 122152 16:33:03 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 290422784; Read time: 0; Write time: 263288 16:33:03 INFO - Running post-run listener: _upload_blobber_files 16:33:03 INFO - Blob upload gear active. 16:33:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:33:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:33:03 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'] 16:33:03 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 16:33:04 INFO - (blobuploader) - INFO - Open directory for files ... 16:33:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:33:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:33:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:33:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:33:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:33:08 INFO - (blobuploader) - INFO - Done attempting. 16:33:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:33:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:33:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:33:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:33:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:33:09 INFO - (blobuploader) - INFO - Done attempting. 16:33:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:33:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:33:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:33:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:33:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:33:10 INFO - (blobuploader) - INFO - Done attempting. 16:33:10 INFO - (blobuploader) - INFO - Iteration through files over. 16:33:10 INFO - Return code: 0 16:33:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:33:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:33:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a888c8050fb7bd671caef1e235fcc5b565a077e59bb84d91836575c676c9927e5ad95665c598182f31eedac2de690d694c4adb75610663f9c5c38d0f85a4d4ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bcd875bed653bb206a319f18f96718fe7edee6ba02673424e374cec5f8a78a60e96e1feb0f41e3b4c656b1bdb116696ac2716cf0a78a329fb56eae285c476c92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0f8afde66f0174e32b9f22e1b7d3cd627cf662031d6477df4ef1577d0776507e5bd6859f8507c6db5865114994a03f5915e2f29d409b556f838fd3453cfcda2d"} 16:33:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:33:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:33:10 INFO - Contents: 16:33:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a888c8050fb7bd671caef1e235fcc5b565a077e59bb84d91836575c676c9927e5ad95665c598182f31eedac2de690d694c4adb75610663f9c5c38d0f85a4d4ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bcd875bed653bb206a319f18f96718fe7edee6ba02673424e374cec5f8a78a60e96e1feb0f41e3b4c656b1bdb116696ac2716cf0a78a329fb56eae285c476c92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0f8afde66f0174e32b9f22e1b7d3cd627cf662031d6477df4ef1577d0776507e5bd6859f8507c6db5865114994a03f5915e2f29d409b556f838fd3453cfcda2d"} 16:33:10 INFO - Running post-run listener: copy_logs_to_upload_dir 16:33:10 INFO - Copying logs to upload dir... 16:33:10 INFO - mkdir: /builds/slave/test/build/upload/logs 16:33:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.960354 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-10-31 16:33:10.259977) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 16:33:10.263838) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1477955538.659919-782898617 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/a888c8050fb7bd671caef1e235fcc5b565a077e59bb84d91836575c676c9927e5ad95665c598182f31eedac2de690d694c4adb75610663f9c5c38d0f85a4d4ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bcd875bed653bb206a319f18f96718fe7edee6ba02673424e374cec5f8a78a60e96e1feb0f41e3b4c656b1bdb116696ac2716cf0a78a329fb56eae285c476c92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0f8afde66f0174e32b9f22e1b7d3cd627cf662031d6477df4ef1577d0776507e5bd6859f8507c6db5865114994a03f5915e2f29d409b556f838fd3453cfcda2d"} build_url:https://queue.taskcluster.net/v1/task/A5BeFCSLSau4DGm7p2LZ7w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011317 build_url: 'https://queue.taskcluster.net/v1/task/A5BeFCSLSau4DGm7p2LZ7w/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/a888c8050fb7bd671caef1e235fcc5b565a077e59bb84d91836575c676c9927e5ad95665c598182f31eedac2de690d694c4adb75610663f9c5c38d0f85a4d4ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bcd875bed653bb206a319f18f96718fe7edee6ba02673424e374cec5f8a78a60e96e1feb0f41e3b4c656b1bdb116696ac2716cf0a78a329fb56eae285c476c92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0f8afde66f0174e32b9f22e1b7d3cd627cf662031d6477df4ef1577d0776507e5bd6859f8507c6db5865114994a03f5915e2f29d409b556f838fd3453cfcda2d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 16:33:10.289393) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 16:33:10.289803) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1477955538.659919-782898617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004414 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 16:33:10.373206) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 16:33:10.373526) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 16:33:10.374076) ========= ========= Total master_lag: 0.18 =========