builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-033 starttime: 1475250788.0 results: success (0) buildid: 20160930073719 builduid: 2e9c3ca3befa420b9ae08c3c5c6044be revision: 13d0743bcaa67972a09e45472b161a787eceee7e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-30 08:53:08.002687) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-30 08:53:08.003262) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 08:53:08.003557) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 08:53:08.023723) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 08:53:08.024232) ========= 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-1475248419.679544-21133969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-30 08:53:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.4M=0s 2016-09-30 08:53:08 (50.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086104 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 08:53:08.125617) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 08:53:08.125943) ========= 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-1475248419.679544-21133969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023443 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 08:53:08.175049) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 08:53:08.175376) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 13d0743bcaa67972a09e45472b161a787eceee7e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 13d0743bcaa67972a09e45472b161a787eceee7e --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-1475248419.679544-21133969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-30 08:53:08,577 truncating revision to first 12 chars 2016-09-30 08:53:08,578 Setting DEBUG logging. 2016-09-30 08:53:08,578 attempt 1/10 2016-09-30 08:53:08,578 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/13d0743bcaa6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-30 08:53:08,898 unpacking tar archive at: autoland-13d0743bcaa6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.658502 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 08:53:08.856469) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 08:53:08.856793) ========= script_repo_revision: 13d0743bcaa67972a09e45472b161a787eceee7e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 08:53:08.857201) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 08:53:08.857467) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 08:53:08.868071) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-09-30 08:53:08.868475) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-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', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-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-1475248419.679544-21133969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:53:09 INFO - MultiFileLogger online at 20160930 08:53:09 in /builds/slave/test 08:53:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 08:53:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:53:09 INFO - {'append_to_log': False, 08:53:09 INFO - 'base_work_dir': '/builds/slave/test', 08:53:09 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 08:53:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:53:09 INFO - 'branch': 'Autoland-Non-PGO', 08:53:09 INFO - 'buildbot_json_path': 'buildprops.json', 08:53:09 INFO - 'config_files': ('talos/linux_config.py',), 08:53:09 INFO - 'default_actions': ('clobber', 08:53:09 INFO - 'read-buildbot-config', 08:53:09 INFO - 'download-and-extract', 08:53:09 INFO - 'populate-webroot', 08:53:09 INFO - 'create-virtualenv', 08:53:09 INFO - 'install', 08:53:09 INFO - 'run-tests'), 08:53:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:53:09 INFO - 'download_minidump_stackwalk': True, 08:53:09 INFO - 'download_symbols': 'ondemand', 08:53:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:53:09 INFO - 'tooltool.py': '/tools/tooltool.py', 08:53:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:53:09 INFO - '/tools/misc-python/virtualenv.py')}, 08:53:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:53:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:53:09 INFO - 'installer_path': 'installer.exe', 08:53:09 INFO - 'log_level': 'info', 08:53:09 INFO - 'log_name': 'talos', 08:53:09 INFO - 'log_to_console': True, 08:53:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:53:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:53:09 INFO - 'opt_config_files': (), 08:53:09 INFO - 'pip_index': False, 08:53:09 INFO - 'sps_profile': False, 08:53:09 INFO - 'sps_profile_interval': 0, 08:53:09 INFO - 'suite': 'dromaeojs', 08:53:09 INFO - 'system_bits': '32', 08:53:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:53:09 INFO - 'title': 'talos-linux64-ix-033', 08:53:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:53:09 INFO - 'use_talos_json': True, 08:53:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:53:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:53:09 INFO - 'work_dir': 'build'} 08:53:09 INFO - [mozharness: 2016-09-30 15:53:09.377916Z] Running clobber step. 08:53:09 INFO - Running pre-action listener: _resource_record_pre_action 08:53:09 INFO - Running main action method: clobber 08:53:09 INFO - rmtree: /builds/slave/test/build 08:53:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:53:10 INFO - Running post-action listener: _resource_record_post_action 08:53:10 INFO - [mozharness: 2016-09-30 15:53:10.357307Z] Finished clobber step (success) 08:53:10 INFO - [mozharness: 2016-09-30 15:53:10.357451Z] Running read-buildbot-config step. 08:53:10 INFO - Running pre-action listener: _resource_record_pre_action 08:53:10 INFO - Running main action method: read_buildbot_config 08:53:10 INFO - Using buildbot properties: 08:53:10 INFO - { 08:53:10 INFO - "project": "", 08:53:10 INFO - "product": "firefox", 08:53:10 INFO - "script_repo_revision": "production", 08:53:10 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 08:53:10 INFO - "repository": "", 08:53:10 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 08:53:10 INFO - "buildid": "20160930073719", 08:53:10 INFO - "pgo_build": "False", 08:53:10 INFO - "basedir": "/builds/slave/test", 08:53:10 INFO - "buildnumber": 746, 08:53:10 INFO - "slavename": "talos-linux64-ix-033", 08:53:10 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:53:10 INFO - "platform": "ubuntu64_hw", 08:53:10 INFO - "scheduler": "tests-autoland-linux64-talos", 08:53:10 INFO - "branch": "autoland", 08:53:10 INFO - "repo_path": "integration/autoland", 08:53:10 INFO - "revision": "13d0743bcaa67972a09e45472b161a787eceee7e", 08:53:10 INFO - "stage_platform": "linux64", 08:53:10 INFO - "builduid": "2e9c3ca3befa420b9ae08c3c5c6044be", 08:53:10 INFO - "slavebuilddir": "test" 08:53:10 INFO - } 08:53:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/Vx_x4IjhTViUWnnULn5bmw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 08:53:10 INFO - Running post-action listener: _resource_record_post_action 08:53:10 INFO - [mozharness: 2016-09-30 15:53:10.359899Z] Finished read-buildbot-config step (success) 08:53:10 INFO - [mozharness: 2016-09-30 15:53:10.359987Z] Running download-and-extract step. 08:53:10 INFO - Running pre-action listener: _resource_record_pre_action 08:53:10 INFO - Running main action method: download_and_extract 08:53:10 INFO - mkdir: /builds/slave/test/build/tests 08:53:10 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')]} 08:53:10 INFO - trying https://queue.taskcluster.net/v1/task/Vx_x4IjhTViUWnnULn5bmw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 08:53:10 INFO - Downloading https://queue.taskcluster.net/v1/task/Vx_x4IjhTViUWnnULn5bmw/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 08:53:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Vx_x4IjhTViUWnnULn5bmw/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 08:53:10 INFO - Downloaded 1361 bytes. 08:53:10 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 08:53:10 INFO - Using the following test package requirements: 08:53:10 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 08:53:10 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:53:10 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:53:10 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:10 INFO - u'jsshell-linux-x86_64.zip'], 08:53:10 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:53:10 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 08:53:10 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:53:10 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:53:10 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:53:10 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:53:10 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:53:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Vx_x4IjhTViUWnnULn5bmw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 08:53:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Vx_x4IjhTViUWnnULn5bmw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:53:10 INFO - Fetch https://queue.taskcluster.net/v1/task/Vx_x4IjhTViUWnnULn5bmw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:53:11 INFO - Http code: 200 08:53:11 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 08:53:11 INFO - x-amz-cf-id: wWXVsFhqg-acvessQRaKQf88KqxlJn7x-xWG22SdXbJxPZK_diPDCw== 08:53:11 INFO - x-amz-version-id: wtmWxl1i1gGlFTO_7rqFXVvjgEk9dq8T 08:53:11 INFO - Expected file size: 20417787 08:53:11 INFO - Obtained file size: 20417787 08:53:15 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 08:53:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Vx_x4IjhTViUWnnULn5bmw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 08:53:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Vx_x4IjhTViUWnnULn5bmw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:53:15 INFO - Fetch https://queue.taskcluster.net/v1/task/Vx_x4IjhTViUWnnULn5bmw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:53:16 INFO - Http code: 200 08:53:16 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 08:53:16 INFO - x-amz-cf-id: o5FAPDt-oklYYJ42c1mB3qGq6XOJGBaSOfQSkSScVAjtdYu3NDjOww== 08:53:16 INFO - x-amz-version-id: wtmWxl1i1gGlFTO_7rqFXVvjgEk9dq8T 08:53:16 INFO - Expected file size: 20417787 08:53:16 INFO - Obtained file size: 20417787 08:53:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Vx_x4IjhTViUWnnULn5bmw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 08:53:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Vx_x4IjhTViUWnnULn5bmw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:53:21 INFO - Fetch https://queue.taskcluster.net/v1/task/Vx_x4IjhTViUWnnULn5bmw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 08:53:21 INFO - Http code: 200 08:53:21 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 08:53:21 INFO - x-amz-cf-id: SEotPrFjoycyTBTktXtiv3QWtbWmtI_qU7cM0XqJ5Ym8yZ8oxj2Smw== 08:53:21 INFO - x-amz-version-id: .f0wxCfHLWSKv_IuIG0VJiZitkPBCBhr 08:53:21 INFO - Expected file size: 14408522 08:53:21 INFO - Obtained file size: 14408522 08:53:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:22 INFO - trying https://queue.taskcluster.net/v1/task/Vx_x4IjhTViUWnnULn5bmw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:53:22 INFO - Downloading https://queue.taskcluster.net/v1/task/Vx_x4IjhTViUWnnULn5bmw/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 08:53:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Vx_x4IjhTViUWnnULn5bmw/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 08:53:23 INFO - Downloaded 55727513 bytes. 08:53:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Vx_x4IjhTViUWnnULn5bmw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:53:23 INFO - mkdir: /builds/slave/test/properties 08:53:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:53:23 INFO - Writing to file /builds/slave/test/properties/build_url 08:53:23 INFO - Contents: 08:53:23 INFO - build_url:https://queue.taskcluster.net/v1/task/Vx_x4IjhTViUWnnULn5bmw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:53:24 INFO - Running post-action listener: _resource_record_post_action 08:53:24 INFO - Running post-action listener: set_extra_try_arguments 08:53:24 INFO - [mozharness: 2016-09-30 15:53:24.018346Z] Finished download-and-extract step (success) 08:53:24 INFO - [mozharness: 2016-09-30 15:53:24.018573Z] Running populate-webroot step. 08:53:24 INFO - Running pre-action listener: _resource_record_pre_action 08:53:24 INFO - Running main action method: populate_webroot 08:53:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:53:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:53:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:53:24 INFO - '--tppagecycles', 08:53:24 INFO - '7'], 08:53:24 INFO - 'tests': ['tsvgm']}}, 08:53:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:53:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:53:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:53:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:53:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:53:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:53:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:24 INFO - 'talos_options': ['--disable-e10s'], 08:53:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:53:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:53:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:24 INFO - 'talos_options': ['--disable-e10s'], 08:53:24 INFO - 'tests': ['damp', 'tps']}, 08:53:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:24 INFO - 'tests': ['damp', 'tps']}, 08:53:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:53:24 INFO - 'tests': ['dromaeo_dom']}, 08:53:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:53:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:53:24 INFO - 'tests': ['basic_compositor_video']}, 08:53:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:53:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:53:24 INFO - 'tests': ['a11yr', 08:53:24 INFO - 'ts_paint', 08:53:24 INFO - 'tpaint', 08:53:24 INFO - 'sessionrestore', 08:53:24 INFO - 'sessionrestore_no_auto_restore', 08:53:24 INFO - 'tabpaint']}, 08:53:24 INFO - 'other-e10s': {'tests': ['a11yr', 08:53:24 INFO - 'ts_paint', 08:53:24 INFO - 'tpaint', 08:53:24 INFO - 'sessionrestore', 08:53:24 INFO - 'sessionrestore_no_auto_restore', 08:53:24 INFO - 'tabpaint']}, 08:53:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:53:24 INFO - 'ts_paint', 08:53:24 INFO - 'tpaint', 08:53:24 INFO - 'sessionrestore', 08:53:24 INFO - 'sessionrestore_no_auto_restore', 08:53:24 INFO - 'tabpaint']}, 08:53:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:53:24 INFO - 'ts_paint', 08:53:24 INFO - 'tpaint', 08:53:24 INFO - 'sessionrestore', 08:53:24 INFO - 'sessionrestore_no_auto_restore', 08:53:24 INFO - 'tabpaint']}, 08:53:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:53:24 INFO - 'tests': ['a11yr', 08:53:24 INFO - 'ts_paint', 08:53:24 INFO - 'tpaint', 08:53:24 INFO - 'sessionrestore', 08:53:24 INFO - 'sessionrestore_no_auto_restore', 08:53:24 INFO - 'tabpaint']}, 08:53:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:53:24 INFO - 'tests': ['a11yr', 08:53:24 INFO - 'ts_paint', 08:53:24 INFO - 'tpaint', 08:53:24 INFO - 'sessionrestore', 08:53:24 INFO - 'sessionrestore_no_auto_restore', 08:53:24 INFO - 'tabpaint']}, 08:53:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:53:24 INFO - 'tests': ['tsvgx', 08:53:24 INFO - 'tsvgr_opacity', 08:53:24 INFO - 'tart', 08:53:24 INFO - 'tscrollx', 08:53:24 INFO - 'cart']}, 08:53:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:53:24 INFO - 'tsvgr_opacity', 08:53:24 INFO - 'tart', 08:53:24 INFO - 'tscrollx', 08:53:24 INFO - 'cart']}, 08:53:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:24 INFO - 'talos_options': ['--disable-e10s'], 08:53:24 INFO - 'tests': ['tp5o']}, 08:53:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:24 INFO - 'tests': ['tp5o']}, 08:53:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:24 INFO - 'talos_options': ['--disable-e10s', 08:53:24 INFO - '--xperf_path', 08:53:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:53:24 INFO - 'tests': ['tp5n']}, 08:53:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:24 INFO - 'talos_options': ['--xperf_path', 08:53:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:53:24 INFO - 'tests': ['tp5n']}}, 08:53:24 INFO - 'talos.zip': {'path': '', 08:53:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:53:24 INFO - Running post-action listener: _resource_record_post_action 08:53:24 INFO - [mozharness: 2016-09-30 15:53:24.033740Z] Finished populate-webroot step (success) 08:53:24 INFO - [mozharness: 2016-09-30 15:53:24.033828Z] Running create-virtualenv step. 08:53:24 INFO - Running pre-action listener: _resource_record_pre_action 08:53:24 INFO - Running main action method: create_virtualenv 08:53:24 INFO - Creating virtualenv /builds/slave/test/build/venv 08:53:24 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 08:53:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:53:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:53:24 INFO - Using real prefix '/usr' 08:53:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:53:24 INFO - Installing distribute.............................................................................................................................................................................................done. 08:53:26 INFO - Installing pip.................done. 08:53:26 INFO - Return code: 0 08:53:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:53:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:53:26 INFO - Reading from file tmpfile_stdout 08:53:26 INFO - Output received: 08:53:26 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) 08:53:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:53:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f208250df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c2cf60>, '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 0x2c2dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2e1d0>, '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-1475248419.679544-21133969', '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 08:53:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:53:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:53:26 INFO - Using env: {'DISPLAY': ':0', 08:53:26 INFO - 'HOME': '/home/cltbld', 08:53:26 INFO - 'LANG': 'en_US.UTF-8', 08:53:26 INFO - 'LANGUAGE': 'en_US:en', 08:53:26 INFO - 'LOGNAME': 'cltbld', 08:53:26 INFO - 'MAIL': '/var/mail/cltbld', 08:53:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:26 INFO - 'MOZ_NO_REMOTE': '1', 08:53:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:26 INFO - 'NO_EM_RESTART': '1', 08:53:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:26 INFO - 'PWD': '/builds/slave/test', 08:53:26 INFO - 'SHELL': '/bin/bash', 08:53:26 INFO - 'SHLVL': '1', 08:53:26 INFO - 'TERM': 'linux', 08:53:26 INFO - 'TMOUT': '86400', 08:53:26 INFO - 'USER': 'cltbld', 08:53:26 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1475248419.679544-21133969', 08:53:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:26 INFO - '_': '/tools/buildbot/bin/python'} 08:53:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:27 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 08:53:27 INFO - Cleaning up... 08:53:27 INFO - Return code: 0 08:53:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f208250df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c2cf60>, '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 0x2c2dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2e1d0>, '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-1475248419.679544-21133969', '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 08:53:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:53:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:53:27 INFO - Using env: {'DISPLAY': ':0', 08:53:27 INFO - 'HOME': '/home/cltbld', 08:53:27 INFO - 'LANG': 'en_US.UTF-8', 08:53:27 INFO - 'LANGUAGE': 'en_US:en', 08:53:27 INFO - 'LOGNAME': 'cltbld', 08:53:27 INFO - 'MAIL': '/var/mail/cltbld', 08:53:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:27 INFO - 'MOZ_NO_REMOTE': '1', 08:53:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:27 INFO - 'NO_EM_RESTART': '1', 08:53:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:27 INFO - 'PWD': '/builds/slave/test', 08:53:27 INFO - 'SHELL': '/bin/bash', 08:53:27 INFO - 'SHLVL': '1', 08:53:27 INFO - 'TERM': 'linux', 08:53:27 INFO - 'TMOUT': '86400', 08:53:27 INFO - 'USER': 'cltbld', 08:53:27 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1475248419.679544-21133969', 08:53:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:27 INFO - '_': '/tools/buildbot/bin/python'} 08:53:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:27 INFO - Downloading/unpacking psutil>=3.1.1 08:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:53:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:53:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:53:29 INFO - Installing collected packages: psutil 08:53:29 INFO - Running setup.py install for psutil 08:53:29 INFO - building 'psutil._psutil_linux' extension 08:53:29 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 08:53:29 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 08:53:29 INFO - building 'psutil._psutil_posix' extension 08:53:29 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 08:53:29 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 08:53:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:53:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:53:29 INFO - Successfully installed psutil 08:53:29 INFO - Cleaning up... 08:53:29 INFO - Return code: 0 08:53:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:53:29 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')]} 08:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:29 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')]} 08:53:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:29 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 0x7f208250df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c2cf60>, '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 0x2c2dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2e1d0>, '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-1475248419.679544-21133969', '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 08:53:29 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 08:53:29 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 08:53:29 INFO - Using env: {'DISPLAY': ':0', 08:53:29 INFO - 'HOME': '/home/cltbld', 08:53:29 INFO - 'LANG': 'en_US.UTF-8', 08:53:29 INFO - 'LANGUAGE': 'en_US:en', 08:53:29 INFO - 'LOGNAME': 'cltbld', 08:53:29 INFO - 'MAIL': '/var/mail/cltbld', 08:53:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:29 INFO - 'MOZ_NO_REMOTE': '1', 08:53:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:29 INFO - 'NO_EM_RESTART': '1', 08:53:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:29 INFO - 'PWD': '/builds/slave/test', 08:53:29 INFO - 'SHELL': '/bin/bash', 08:53:29 INFO - 'SHLVL': '1', 08:53:29 INFO - 'TERM': 'linux', 08:53:29 INFO - 'TMOUT': '86400', 08:53:29 INFO - 'USER': 'cltbld', 08:53:29 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1475248419.679544-21133969', 08:53:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:29 INFO - '_': '/tools/buildbot/bin/python'} 08:53:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:53:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:53:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:53:32 INFO - Installing collected packages: mozsystemmonitor 08:53:32 INFO - Running setup.py install for mozsystemmonitor 08:53:32 INFO - Successfully installed mozsystemmonitor 08:53:32 INFO - Cleaning up... 08:53:32 INFO - Return code: 0 08:53:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:53: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')]} 08:53:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53: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')]} 08:53:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:32 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 0x7f208250df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c2cf60>, '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 0x2c2dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2e1d0>, '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-1475248419.679544-21133969', '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 08:53:32 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 08:53:32 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 08:53:32 INFO - Using env: {'DISPLAY': ':0', 08:53:32 INFO - 'HOME': '/home/cltbld', 08:53:32 INFO - 'LANG': 'en_US.UTF-8', 08:53:32 INFO - 'LANGUAGE': 'en_US:en', 08:53:32 INFO - 'LOGNAME': 'cltbld', 08:53:32 INFO - 'MAIL': '/var/mail/cltbld', 08:53:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:32 INFO - 'MOZ_NO_REMOTE': '1', 08:53:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:32 INFO - 'NO_EM_RESTART': '1', 08:53:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:32 INFO - 'PWD': '/builds/slave/test', 08:53:32 INFO - 'SHELL': '/bin/bash', 08:53:32 INFO - 'SHLVL': '1', 08:53:32 INFO - 'TERM': 'linux', 08:53:32 INFO - 'TMOUT': '86400', 08:53:32 INFO - 'USER': 'cltbld', 08:53:32 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1475248419.679544-21133969', 08:53:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:32 INFO - '_': '/tools/buildbot/bin/python'} 08:53:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:32 INFO - Downloading/unpacking jsonschema==2.5.1 08:53:32 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 08:53:32 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 08:53:32 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 08:53:32 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 08:53:32 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 08:53:32 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 08:53:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:53:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:34 INFO - Downloading functools32-3.2.3-2.tar.gz 08:53:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:53:34 INFO - warning: no files found matching '*.txt' 08:53:34 INFO - no previously-included directories found matching 'build' 08:53:34 INFO - no previously-included directories found matching 'dist' 08:53:34 INFO - no previously-included directories found matching '.git*' 08:53:34 INFO - Installing collected packages: jsonschema, functools32 08:53:34 INFO - Running setup.py install for functools32 08:53:34 INFO - warning: no files found matching '*.txt' 08:53:34 INFO - no previously-included directories found matching 'build' 08:53:34 INFO - no previously-included directories found matching 'dist' 08:53:34 INFO - no previously-included directories found matching '.git*' 08:53:34 INFO - Successfully installed jsonschema functools32 08:53:34 INFO - Cleaning up... 08:53:34 INFO - Return code: 0 08:53:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:53:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f208250df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c2cf60>, '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 0x2c2dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2e1d0>, '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-1475248419.679544-21133969', '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 08:53:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:53:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:53:34 INFO - Using env: {'DISPLAY': ':0', 08:53:34 INFO - 'HOME': '/home/cltbld', 08:53:34 INFO - 'LANG': 'en_US.UTF-8', 08:53:34 INFO - 'LANGUAGE': 'en_US:en', 08:53:34 INFO - 'LOGNAME': 'cltbld', 08:53:34 INFO - 'MAIL': '/var/mail/cltbld', 08:53:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:34 INFO - 'MOZ_NO_REMOTE': '1', 08:53:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:34 INFO - 'NO_EM_RESTART': '1', 08:53:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:34 INFO - 'PWD': '/builds/slave/test', 08:53:34 INFO - 'SHELL': '/bin/bash', 08:53:34 INFO - 'SHLVL': '1', 08:53:34 INFO - 'TERM': 'linux', 08:53:34 INFO - 'TMOUT': '86400', 08:53:34 INFO - 'USER': 'cltbld', 08:53:34 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1475248419.679544-21133969', 08:53:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:34 INFO - '_': '/tools/buildbot/bin/python'} 08:53:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:53:34 INFO - Cleaning up... 08:53:34 INFO - Return code: 0 08:53:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:53:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f208250df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c2cf60>, '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 0x2c2dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2e1d0>, '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-1475248419.679544-21133969', '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 08:53:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:53:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:53:34 INFO - Using env: {'DISPLAY': ':0', 08:53:34 INFO - 'HOME': '/home/cltbld', 08:53:34 INFO - 'LANG': 'en_US.UTF-8', 08:53:34 INFO - 'LANGUAGE': 'en_US:en', 08:53:34 INFO - 'LOGNAME': 'cltbld', 08:53:34 INFO - 'MAIL': '/var/mail/cltbld', 08:53:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:34 INFO - 'MOZ_NO_REMOTE': '1', 08:53:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:34 INFO - 'NO_EM_RESTART': '1', 08:53:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:34 INFO - 'PWD': '/builds/slave/test', 08:53:34 INFO - 'SHELL': '/bin/bash', 08:53:34 INFO - 'SHLVL': '1', 08:53:34 INFO - 'TERM': 'linux', 08:53:34 INFO - 'TMOUT': '86400', 08:53:34 INFO - 'USER': 'cltbld', 08:53:34 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1475248419.679544-21133969', 08:53:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:34 INFO - '_': '/tools/buildbot/bin/python'} 08:53:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:35 INFO - Downloading/unpacking blobuploader==1.2.4 08:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:37 INFO - Downloading blobuploader-1.2.4.tar.gz 08:53:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:53:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:53:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53:37 INFO - Downloading docopt-0.6.1.tar.gz 08:53:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:53:37 INFO - Installing collected packages: blobuploader, requests, docopt 08:53:37 INFO - Running setup.py install for blobuploader 08:53:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:53:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:53:37 INFO - Running setup.py install for requests 08:53:38 INFO - Running setup.py install for docopt 08:53:38 INFO - Successfully installed blobuploader requests docopt 08:53:38 INFO - Cleaning up... 08:53:38 INFO - Return code: 0 08:53:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:38 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 0x7f208250df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c2cf60>, '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 0x2c2dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2e1d0>, '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-1475248419.679544-21133969', '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 08:53:38 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 08:53:38 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 08:53:38 INFO - Using env: {'DISPLAY': ':0', 08:53:38 INFO - 'HOME': '/home/cltbld', 08:53:38 INFO - 'LANG': 'en_US.UTF-8', 08:53:38 INFO - 'LANGUAGE': 'en_US:en', 08:53:38 INFO - 'LOGNAME': 'cltbld', 08:53:38 INFO - 'MAIL': '/var/mail/cltbld', 08:53:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:38 INFO - 'MOZ_NO_REMOTE': '1', 08:53:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:38 INFO - 'NO_EM_RESTART': '1', 08:53:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:38 INFO - 'PWD': '/builds/slave/test', 08:53:38 INFO - 'SHELL': '/bin/bash', 08:53:38 INFO - 'SHLVL': '1', 08:53:38 INFO - 'TERM': 'linux', 08:53:38 INFO - 'TMOUT': '86400', 08:53:38 INFO - 'USER': 'cltbld', 08:53:38 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1475248419.679544-21133969', 08:53:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:38 INFO - '_': '/tools/buildbot/bin/python'} 08:53:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:53:38 INFO - Running setup.py (path:/tmp/pip-bq0WrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:53:38 INFO - Running setup.py (path:/tmp/pip-aaKbE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:53:38 INFO - Running setup.py (path:/tmp/pip-xux9nU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:53:38 INFO - Running setup.py (path:/tmp/pip-8SPxRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:53:38 INFO - Running setup.py (path:/tmp/pip-aKWS1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:53:39 INFO - Running setup.py (path:/tmp/pip-JBGgY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:53:39 INFO - Running setup.py (path:/tmp/pip-wWxkoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:53:39 INFO - Running setup.py (path:/tmp/pip-kUE54p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:53:39 INFO - Running setup.py (path:/tmp/pip-j4Yorf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:53:39 INFO - Running setup.py (path:/tmp/pip-sJtYAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:53:39 INFO - Running setup.py (path:/tmp/pip-oWcUiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:53:39 INFO - Running setup.py (path:/tmp/pip-oZ343l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:53:39 INFO - Running setup.py (path:/tmp/pip-pzJ9we-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:53:39 INFO - Running setup.py (path:/tmp/pip-6brZxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:39 INFO - Running setup.py (path:/tmp/pip-y9YBM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:53:39 INFO - Running setup.py (path:/tmp/pip-6tXmhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:53:39 INFO - Running setup.py (path:/tmp/pip-cgaoYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:53:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:53:39 INFO - Running setup.py install for manifestparser 08:53:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:53:39 INFO - Running setup.py install for mozcrash 08:53:40 INFO - Running setup.py install for mozdebug 08:53:40 INFO - Running setup.py install for mozdevice 08:53:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:53:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:53:40 INFO - Running setup.py install for mozfile 08:53:40 INFO - Running setup.py install for mozhttpd 08:53:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:53:40 INFO - Running setup.py install for mozinfo 08:53:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:53:40 INFO - Running setup.py install for mozInstall 08:53:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:53:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:53:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:53:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:53:40 INFO - Running setup.py install for mozleak 08:53:40 INFO - Running setup.py install for mozlog 08:53:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:53:40 INFO - Running setup.py install for moznetwork 08:53:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:53:41 INFO - Running setup.py install for mozprocess 08:53:41 INFO - Running setup.py install for mozprofile 08:53:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:53:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:53:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:53:41 INFO - Running setup.py install for mozrunner 08:53:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:53:41 INFO - Running setup.py install for mozscreenshot 08:53:41 INFO - Running setup.py install for moztest 08:53:41 INFO - Running setup.py install for mozversion 08:53:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:53:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:53:41 INFO - Cleaning up... 08:53:41 INFO - Return code: 0 08:53:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53:41 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')]} 08:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:41 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')]} 08:53:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:41 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 0x7f208250df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c2cf60>, '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 0x2c2dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2e1d0>, '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-1475248419.679544-21133969', '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 08:53:41 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 08:53:41 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 08:53:41 INFO - Using env: {'DISPLAY': ':0', 08:53:41 INFO - 'HOME': '/home/cltbld', 08:53:41 INFO - 'LANG': 'en_US.UTF-8', 08:53:41 INFO - 'LANGUAGE': 'en_US:en', 08:53:41 INFO - 'LOGNAME': 'cltbld', 08:53:41 INFO - 'MAIL': '/var/mail/cltbld', 08:53:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:41 INFO - 'MOZ_NO_REMOTE': '1', 08:53:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:41 INFO - 'NO_EM_RESTART': '1', 08:53:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:41 INFO - 'PWD': '/builds/slave/test', 08:53:41 INFO - 'SHELL': '/bin/bash', 08:53:41 INFO - 'SHLVL': '1', 08:53:41 INFO - 'TERM': 'linux', 08:53:41 INFO - 'TMOUT': '86400', 08:53:41 INFO - 'USER': 'cltbld', 08:53:41 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1475248419.679544-21133969', 08:53:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:41 INFO - '_': '/tools/buildbot/bin/python'} 08:53:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:53:41 INFO - Running setup.py (path:/tmp/pip-7yN_EI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:53:42 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)) 08:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:53:42 INFO - Running setup.py (path:/tmp/pip-sMke_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:53:42 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)) 08:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:53:42 INFO - Running setup.py (path:/tmp/pip-pacFKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:53:42 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)) 08:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:53:42 INFO - Running setup.py (path:/tmp/pip-O8Xfzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:53:42 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)) 08:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:53:42 INFO - Running setup.py (path:/tmp/pip-dNhzo2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:53:42 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)) 08:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:53:42 INFO - Running setup.py (path:/tmp/pip-p3o2Y7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:53:42 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)) 08:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:53:42 INFO - Running setup.py (path:/tmp/pip-8x0jZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:53:42 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)) 08:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:53:42 INFO - Running setup.py (path:/tmp/pip-W5VP9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:53:42 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)) 08:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:53:42 INFO - Running setup.py (path:/tmp/pip-wJ4Zkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:53:42 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)) 08:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:53:42 INFO - Running setup.py (path:/tmp/pip-peD3Kr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:53:42 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)) 08:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:53:42 INFO - Running setup.py (path:/tmp/pip-BtZnQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:53:42 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)) 08:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:53:42 INFO - Running setup.py (path:/tmp/pip-g3zq4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:53:42 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)) 08:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:53:42 INFO - Running setup.py (path:/tmp/pip-TsjpcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:53:42 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)) 08:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:53:42 INFO - Running setup.py (path:/tmp/pip-DS6jX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:53:42 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)) 08:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:42 INFO - Running setup.py (path:/tmp/pip-vHADxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:43 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)) 08:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:53:43 INFO - Running setup.py (path:/tmp/pip-VTpLuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:53:43 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)) 08:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:53:43 INFO - Running setup.py (path:/tmp/pip-65ng6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:53:43 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)) 08:53:43 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)) 08:53:43 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)) 08:53:43 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)) 08:53:43 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)) 08:53:43 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)) 08:53:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53:45 INFO - Downloading blessings-1.6.tar.gz 08:53:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:53:45 INFO - Installing collected packages: blessings 08:53:45 INFO - Running setup.py install for blessings 08:53:45 INFO - Successfully installed blessings 08:53:45 INFO - Cleaning up... 08:53:45 INFO - Return code: 0 08:53:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:53:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:53:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:53:45 INFO - Reading from file tmpfile_stdout 08:53:45 INFO - Current package versions: 08:53:45 INFO - argparse == 1.2.1 08:53:45 INFO - blessings == 1.6 08:53:45 INFO - blobuploader == 1.2.4 08:53:45 INFO - docopt == 0.6.1 08:53:45 INFO - functools32 == 3.2.3-2 08:53:45 INFO - jsonschema == 2.5.1 08:53:45 INFO - manifestparser == 1.1 08:53:45 INFO - mozInstall == 1.12 08:53:45 INFO - mozcrash == 0.17 08:53:45 INFO - mozdebug == 0.1 08:53:45 INFO - mozdevice == 0.48 08:53:45 INFO - mozfile == 1.2 08:53:45 INFO - mozhttpd == 0.7 08:53:45 INFO - mozinfo == 0.9 08:53:45 INFO - mozleak == 0.1 08:53:45 INFO - mozlog == 3.4 08:53:45 INFO - moznetwork == 0.27 08:53:45 INFO - mozprocess == 0.23 08:53:45 INFO - mozprofile == 0.28 08:53:45 INFO - mozrunner == 6.12 08:53:45 INFO - mozscreenshot == 0.1 08:53:45 INFO - mozsystemmonitor == 0.3 08:53:45 INFO - moztest == 0.7 08:53:45 INFO - mozversion == 1.4 08:53:45 INFO - psutil == 3.1.1 08:53:45 INFO - requests == 1.2.3 08:53:45 INFO - wsgiref == 0.1.2 08:53:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53: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')]} 08:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53: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')]} 08:53:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:45 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 0x7f208250df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c2cf60>, '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 0x2c2dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2e1d0>, '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-1475248419.679544-21133969', '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 08:53:45 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 08:53:45 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 08:53:45 INFO - Using env: {'DISPLAY': ':0', 08:53:45 INFO - 'HOME': '/home/cltbld', 08:53:45 INFO - 'LANG': 'en_US.UTF-8', 08:53:45 INFO - 'LANGUAGE': 'en_US:en', 08:53:45 INFO - 'LOGNAME': 'cltbld', 08:53:45 INFO - 'MAIL': '/var/mail/cltbld', 08:53:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:45 INFO - 'MOZ_NO_REMOTE': '1', 08:53:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:45 INFO - 'NO_EM_RESTART': '1', 08:53:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:45 INFO - 'PWD': '/builds/slave/test', 08:53:45 INFO - 'SHELL': '/bin/bash', 08:53:45 INFO - 'SHLVL': '1', 08:53:45 INFO - 'TERM': 'linux', 08:53:45 INFO - 'TMOUT': '86400', 08:53:45 INFO - 'USER': 'cltbld', 08:53:45 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1475248419.679544-21133969', 08:53:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:45 INFO - '_': '/tools/buildbot/bin/python'} 08:53:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:45 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)) 08:53:45 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)) 08:53:45 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)) 08:53:45 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)) 08:53:45 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)) 08:53:45 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)) 08:53:45 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)) 08:53:45 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)) 08:53:45 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)) 08:53:45 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)) 08:53:45 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)) 08:53:45 INFO - Cleaning up... 08:53:45 INFO - Return code: 0 08:53:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:53: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')]} 08:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53: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')]} 08:53:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f208250df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c2cf60>, '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 0x2c2dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2e1d0>, '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-1475248419.679544-21133969', '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 08:53: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', 'jsonschema'] in /builds/slave/test/build 08:53: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 jsonschema 08:53:45 INFO - Using env: {'DISPLAY': ':0', 08:53:45 INFO - 'HOME': '/home/cltbld', 08:53:45 INFO - 'LANG': 'en_US.UTF-8', 08:53:45 INFO - 'LANGUAGE': 'en_US:en', 08:53:45 INFO - 'LOGNAME': 'cltbld', 08:53:45 INFO - 'MAIL': '/var/mail/cltbld', 08:53:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:45 INFO - 'MOZ_NO_REMOTE': '1', 08:53:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:45 INFO - 'NO_EM_RESTART': '1', 08:53:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:45 INFO - 'PWD': '/builds/slave/test', 08:53:45 INFO - 'SHELL': '/bin/bash', 08:53:45 INFO - 'SHLVL': '1', 08:53:45 INFO - 'TERM': 'linux', 08:53:45 INFO - 'TMOUT': '86400', 08:53:45 INFO - 'USER': 'cltbld', 08:53:45 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1475248419.679544-21133969', 08:53:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:45 INFO - '_': '/tools/buildbot/bin/python'} 08:53:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:53:46 INFO - Cleaning up... 08:53:46 INFO - Return code: 0 08:53:46 INFO - Running post-action listener: _resource_record_post_action 08:53:46 INFO - Running post-action listener: _start_resource_monitoring 08:53:46 INFO - Starting resource monitoring. 08:53:46 INFO - [mozharness: 2016-09-30 15:53:46.047226Z] Finished create-virtualenv step (success) 08:53:46 INFO - [mozharness: 2016-09-30 15:53:46.047693Z] Running install step. 08:53:46 INFO - Running pre-action listener: _resource_record_pre_action 08:53:46 INFO - Running main action method: install 08:53:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:53:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:53:46 INFO - Reading from file tmpfile_stdout 08:53:46 INFO - Detecting whether we're running mozinstall >=1.0... 08:53:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:53:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:53:46 INFO - Reading from file tmpfile_stdout 08:53:46 INFO - Output received: 08:53:46 INFO - Usage: mozinstall [options] installer 08:53:46 INFO - Options: 08:53:46 INFO - -h, --help show this help message and exit 08:53:46 INFO - -d DEST, --destination=DEST 08:53:46 INFO - Directory to install application into. [default: 08:53:46 INFO - "/builds/slave/test"] 08:53:46 INFO - --app=APP Application being installed. [default: firefox] 08:53:46 INFO - mkdir: /builds/slave/test/build/application 08:53:46 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'] 08:53:46 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 08:54:02 INFO - Reading from file tmpfile_stdout 08:54:02 INFO - Output received: 08:54:02 INFO - /builds/slave/test/build/application/firefox/firefox 08:54:02 INFO - Running post-action listener: _resource_record_post_action 08:54:02 INFO - [mozharness: 2016-09-30 15:54:02.465270Z] Finished install step (success) 08:54:02 INFO - [mozharness: 2016-09-30 15:54:02.465581Z] Running run-tests step. 08:54:02 INFO - Running pre-action listener: _resource_record_pre_action 08:54:02 INFO - Running main action method: run_tests 08:54:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:54:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:54:02 INFO - Python 2.7.3 08:54:02 INFO - Return code: 0 08:54:02 INFO - grabbing minidump binary from tooltool 08:54:02 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')]} 08:54:02 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 0x2c2cf60>, '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 0x2c2dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2e1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:54:02 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 08:54:02 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 08:54:02 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 08:54:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:54:02 INFO - Return code: 0 08:54:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:54:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:54:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:54:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:54:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:54:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vx_x4IjhTViUWnnULn5bmw/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 08:54:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Vx_x4IjhTViUWnnULn5bmw/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 08:54:02 INFO - Using env: {'DISPLAY': ':0', 08:54:02 INFO - 'HOME': '/home/cltbld', 08:54:02 INFO - 'LANG': 'en_US.UTF-8', 08:54:02 INFO - 'LANGUAGE': 'en_US:en', 08:54:02 INFO - 'LOGNAME': 'cltbld', 08:54:02 INFO - 'MAIL': '/var/mail/cltbld', 08:54:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:54:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:54:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:02 INFO - 'MOZ_NO_REMOTE': '1', 08:54:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:54:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:02 INFO - 'NO_EM_RESTART': '1', 08:54:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:02 INFO - 'PWD': '/builds/slave/test', 08:54:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:54:02 INFO - 'SHELL': '/bin/bash', 08:54:02 INFO - 'SHLVL': '1', 08:54:02 INFO - 'TERM': 'linux', 08:54:02 INFO - 'TMOUT': '86400', 08:54:02 INFO - 'USER': 'cltbld', 08:54:02 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1475248419.679544-21133969', 08:54:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:02 INFO - '_': '/tools/buildbot/bin/python'} 08:54:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vx_x4IjhTViUWnnULn5bmw/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 08:54:02 INFO - mozversion application_buildid: 20160930073719 08:54:02 INFO - mozversion application_changeset: 13d0743bcaa67972a09e45472b161a787eceee7e 08:54:02 INFO - mozversion application_display_name: Nightly 08:54:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:54:02 INFO - mozversion application_name: Firefox 08:54:02 INFO - mozversion application_remotingname: firefox 08:54:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 08:54:02 INFO - mozversion application_vendor: Mozilla 08:54:02 INFO - mozversion application_version: 52.0a1 08:54:02 INFO - mozversion platform_buildid: 20160930073719 08:54:02 INFO - mozversion platform_changeset: 13d0743bcaa67972a09e45472b161a787eceee7e 08:54:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 08:54:02 INFO - mozversion platform_version: 52.0a1 08:54:02 INFO - using testdate: 1475250842 08:54:02 INFO - actual date: 1475250842 08:54:02 INFO - starting webserver on 'localhost:44743' 08:54:02 INFO - SUITE-START | Running 2 tests 08:54:02 INFO - TEST-START | dromaeo_css 08:54:02 INFO - operating with platform_type : linux_ 08:54:02 INFO - Initialising browser for dromaeo_css test... 08:54:02 INFO - TEST-INFO | started process 16743 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4V_Q15/profile http://localhost:44743/getInfo.html) 08:54:07 INFO - PROCESS | 16743 | __metrics Screen width/height:1600/1200 08:54:07 INFO - PROCESS | 16743 | colorDepth:24 08:54:07 INFO - PROCESS | 16743 | Browser inner width/height: 1024/697 08:54:07 INFO - PROCESS | 16743 | __metrics 08:54:08 INFO - PROCESS | 16743 | 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" 08:54:08 INFO - PROCESS | 16743 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:54:09 INFO - PROCESS | 16743 | console.error: PushService: 08:54:09 INFO - PROCESS | 16743 | stateChangeProcessEnqueue: Error transitioning state 08:54:09 INFO - PROCESS | 16743 | UnknownError 08:54:10 INFO - TEST-INFO | 16743: exit 0 08:54:10 INFO - Browser initialized. 08:54:10 INFO - Running cycle 1/1 for dromaeo_css test... 08:54:10 INFO - TEST-INFO | started process 16824 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4V_Q15/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:54:22 INFO - PROCESS | 16824 | RSS: Main: 175779840 08:54:22 INFO - PROCESS | 16824 | 08:55:13 INFO - PROCESS | 16824 | 1475250913208 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] 08:57:27 INFO - PROCESS | 16824 | Cycle 1(1): loaded http://localhost:44743/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44743/tests/dromaeo/cssquery-ext.html) 08:57:28 INFO - PROCESS | 16824 | RSS: Main: 288280576 08:57:28 INFO - PROCESS | 16824 | 09:00:30 INFO - PROCESS | 16824 | Cycle 1(1): loaded http://localhost:44743/tests/dromaeo/cssquery-ext.html (next: http://localhost:44743/tests/dromaeo/cssquery-jquery.html) 09:00:31 INFO - PROCESS | 16824 | RSS: Main: 281841664 09:00:31 INFO - PROCESS | 16824 | 09:03:33 INFO - PROCESS | 16824 | Cycle 1(1): loaded http://localhost:44743/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44743/tests/dromaeo/cssquery-mootools.html) 09:03:34 INFO - PROCESS | 16824 | RSS: Main: 220880896 09:03:34 INFO - PROCESS | 16824 | 09:06:36 INFO - PROCESS | 16824 | Cycle 1(1): loaded http://localhost:44743/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44743/tests/dromaeo/cssquery-prototype.html) 09:06:37 INFO - PROCESS | 16824 | RSS: Main: 221020160 09:06:37 INFO - PROCESS | 16824 | 09:09:40 INFO - PROCESS | 16824 | Cycle 1(1): loaded http://localhost:44743/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44743/tests/dromaeo/cssquery-yui.html) 09:09:40 INFO - PROCESS | 16824 | RSS: Main: 221167616 09:09:40 INFO - PROCESS | 16824 | 09:12:43 INFO - PROCESS | 16824 | Cycle 1(1): loaded http://localhost:44743/tests/dromaeo/cssquery-yui.html (next: http://localhost:44743/tests/dromaeo/cssquery-dojo.html) 09:12:44 INFO - PROCESS | 16824 | RSS: Main: 314097664 09:12:44 INFO - PROCESS | 16824 | 09:12:44 INFO - PROCESS | 16824 | __start_tp_report 09:12:44 INFO - PROCESS | 16824 | _x_x_mozilla_page_load 09:12:44 INFO - PROCESS | 16824 | _x_x_mozilla_page_load_details 09:12:44 INFO - PROCESS | 16824 | |i|pagename|runs| 09:12:44 INFO - PROCESS | 16824 | |0;dojo.html;2584.147231413633;2609.5824668053115;2635.0250407349276;2641.181233817517;2654.3496843273388;4568.451785785702;4667.15991121598;4741.620670346372;4756.40544931884;4778.924741933068;4654.953450465494;4692.038132182903;4698.7415692137;4719.976400117995;4765.571098601125;4311.5472875348105;4341.196878577458;4385.605295523403;4392.934105988413;4401.163778882018;4377.102693947749;4418.005948661557;4431.800568974388;4437;4447.599716025557;4218.535961044283;4379.343098535213;4379.75911324877;4396.428464299621;4492.550744925514;4250.638695710868;4286;4301.505326887417;4302.225599392108;4309.030468144642;4272.060146767706;4276.059266961263;4287.892802679927;4336.1978034063795;4340.023494713664;4646.117237724821;4665.4168228971375;4691.812327506896;4700.623950083985;4702.788374523155;4943.134951383494;4975.203967365204;4999.550040496373;5024.095662780698;5049.823256186052;5061.468545802712;5066.69599824008;5072.873178170538;5113.897722045575;5126.71803050832;4721.999999999965;4722.88192795176;4723.055388922229;4724.787384567703;4782.904341913142;5058.898822023539;5112.71880046601;5155;5162.096633089194;5225.843224703265;4989.650724449254;5008.12357837377;5009.148444764399;5061.670991385548;5064.18972964324;5067.366579177603;5067.923981140286;5071;5072.67027643202;5131.281620573122;4824.589909857631;4878.02439512099;5004;5006.299118123466;5007.874803129878;4874.341963834908;4929.975350123226;4935.136351138536;4938.061768264019;4985.725785081855;4415.690901636919;4418.64650827933;4421.358902959053;4423.447069116361;4425.513193548707;3788.261289048609;3807.447920051577;3810.8856734298015;3847.769133851978;3860.3244432224246;4366.170427618742;4366.563343665672;4366.890827729332;4371.934420983688;4426.601605855489;4922.852314430573;4974.328465657162;5031.974840125849;5068.290439338495;5089.6691715038405;4360.694751367374;4370.868873933787;4377.146456441027;4415.735055896656;4422.425084739028;4598.563136502027;4606.124836281096;4606.355110284563;4607.401037865056;4664.883377915511;4654.534546545318;4714.151452738402;4714.999999999932;4731;4781.258904869751;5111;5118.129917913889;5141.562967147835;5165;5200.6619569727845;4779.259214821708;4789.042191561772;4796.640251981185;4805.951940480551;4856.878578035577;4846.466888642176;4907.656464047483;4910.8281210157475;5045.2432135180015;5109.872253193551;4980.153373926369;5018.573421259234;5025.170846810235;5091.261767043832;5092.694438333564;4884.242942343943;4886.584640305614;4896.583790377857;4909.852704418873;4941.65408421407;4766.833160839354;4815.036992601424;4883.218685010382;4919.729414882073;4976.701397915992;4803.687760295569;4841.830535931225;4855.028994201244;4855.465898751064;4911.926321105115;4927.901441971212;4934.50654934518;4938.08645400602;4964.25536169563;4966.180580204225;4686.976565117153;4696.1546921554445;4721.7403042832975;4738.50245724194;4740.549647783455 09:12:44 INFO - PROCESS | 16824 | |1;ext.html;573.4580821124038;584.465214328889;584.6024703201821;586.6392168816179;590.9113632955053;27753.167404977834;38028;39420.211595768065;39493.802530987305;43009.35485967713;40744.79627601858;41194.7940260299;41205.58794412055;41227;41231.58768412315;7564.016677831888;7755.534667919915;7755.6509957051785;7756.767296981071;7759.262870027366;7657.502262352957;7701.191374905638;7718.343940765014;7741.845163096735;7747.186545412706;7713.652885620132;7754.185810489902;7757.301842834144;7758.612069396536;7790.130368711497;7712.074551053882;7725.304722574995;7753.418493612945;7756;7757.107932587768;7636.350910172642;7729.613519324012;7729.961350193269;7730.111037230734;7731.845363092762;38191.61808381936;38470;38500;38534;38548.61451385478;2927.2096533935933;2946.587477753116;2978.285211549234;3157.842107894619;3551.8224088795455;27920.86039569789;28163.295917602223;28780.568291475643;29575;29863.70136298631;3359.932801343984;3377.9831100844585;3411.9147021324416;3457.844397002141;3463.79217246966;257374;257907;258212;258474;258832;30584;31691.36617267642;50615.746921265156;51009.48990510122;51037;33714.83142584271;33947.490787638206;33983.83008084993;33998;34030.319393611986;13277.867221327662;13461.461541538229;13467.259300738357;13477.056606037484;13480.93259533696;10947.726306842393;11088.944555277172;11097.278676885977;11098.2786118902;11102.500387482583;7774.416918731118;7810.218978102258;7825.413094017971;7903.920960790433;7911.960440197878;3121.734652554558;3155.0692545699076;3158.98420507896;3162.920926976844;3200.0879749271344;818.2267756969726;875.5490922175085;922.4880191493651;948.2461443152711;960.70698436976;27516.724832751417;28236;28333.716662833107;28671;28681;900.243795212012;948.0330063335497;974.8785124664254;1036.4506811389974;1058.9364638121738;14562.63593410152;14788.11271323724;15060.623484412758;15239.238038098272;15245.771313430307;380407;452549;464441;464920;687878;49384.50615493871;49970.50029499731;50021.24968125481;50034.74982625136;50074.49925500698;1169.0647482014353;1174.6241202815017;1175.4299164905015;1177.735009622828;1186.5846953566183;27055.86472067627;28233.858830705714;28630;28878.711212887603;29194.56208156922;41457.37813932733;42006;42110.36834447424;42327;42404;360939;363179;363782;363933;366406;23837.404064898517;23895.52208955846;24235.515289693754;24236.515269694155;24255.272341829772;40324;40565.39151912665;40802.79598601988;41042.79478602588;41074.58925410708;34844.82577587197;34929;35349.646503534634;36342.63657363393;36497.817510912275;34788.82605586956;34850.30299394049;34919.65080349164;34954.65045349514;34989.650103498636;28295.575566366108;29026.12921612355;34419;34440.178375028016;34589.48115778215;26559.867200663874;31146.532802007536;32014.839925801152;32158;32162.35675286528;24499.38751531226;24672;24708.752912470645;25103.497930041663;25143.245702628952 09:12:44 INFO - PROCESS | 16824 | |2;jquery.html;335.08354650032175;351.4219109564766;351.7361978516113;352.0758010223164;376.9302679004384;12421.875781242185;15893.2848021839;16908.98546087234;16941.57646058846;17409.47771566855;16495.587610309747;17114.657706845886;17285.481435556954;17565.121743912787;17702.380416685417;4900.362952816146;4977.925331120027;5144.279800827869;5201.0898092833795;5206.843794686166;3300.2409445827475;5123.769430375642;5156.175011998081;5156.793728250866;5158.097332966735;3470.8785192518267;4794.472608013116;5038.244263360507;5044.672096313746;5116.386033675964;4941.530554597343;5086.92369614456;5092.898142037157;5102.566281866046;5103.744812759366;4936.851894443173;4965.90068198634;4973.801047958077;4981.825636102719;4985.376827896513;11252.887471125267;11267.661970140909;11273.718157046058;17257.223424945907;19857.304994325128;1737.3658614605579;1868.2433614386196;1927.9228830846748;1998.7101870228735;2259.751427342991;8189.95905020477;9052.8642070369;9754.561044753003;10079.949600252025;13416.46334146633;1633.4854520825902;1681.1846254566647;1685.2500637216444;1735.3579175704945;1744.3981826269917;64758.67620661914;71075.28924710739;72135.27864721337;73230;74835.62582187109;7648.42636802242;8144.837103257902;8232.324494539298;8284.25441710237;9315.953420232856;10810.567577296977;10823.188260880466;10829.350238985686;10831;10849.67450976472;6634.170728658918;6743.561668491532;6796.184457865088;6923.134608173978;6945.548539345027;6859.142607174103;7002.859942801116;7127.607981561064;7128.429725621938;7189.209186989427;3369.3935091683243;3416.538767266437;3474.1934194218866;3521.4717792331357;3549.432090865449;1620.3842539834786;1642.5893526618345;1648.406573633491;1656.9171541422882;1676.4048762689313;808.4946908182386;829.6473998550592;855.5764896376334;858.7166235142388;935.3919952031098;16742.74885876713;16974.745378819327;17123.828761712222;17365.131743412778;17887;824.9917500824915;837.8073043199976;840.4411066640738;886.534569351083;891.1534042659499;8050.396220283385;9534.427934323823;9843.901560984299;9894.505274736379;9934;378068;387439;388680;390397;391635;78071.60964195256;78625.60687196527;78768;80058.59970700226;80313.59843200746;870.1081391573562;892.2193081054078;893.8748575199477;894.8970868350093;896.6010125494092;14528.346224420138;15065.17141557225;15360.769588455958;15596.532104036896;15691.764623530884;36682;36762;37178.44232336463;37408.81295593505;38109.61890381061;47242;48237.517624823304;49737.75131124321;51090.489095108576;51481.22778158406;4444.8444304449185;6769.578388538462;7276.4542659299705;7390.260973902567;7516.661750221144;9170.495622740547;11537.884621154017;11766.647000589996;11794.52821887115;11903.821442678194;9943.801123977624;10187.592496300362;10457.058864702214;10517.894821051692;10720.088792452729;10171.13545348624;10288.588456461657;10323.225758068025;10540.683779486628;10592.099671527698;9959.352642078242;10224.233182511192;10273.075423211947;10334.534945927602;10904.836427453753;7149.60677162761;7226.241244669234;7464.1789403166695;7531.510451820614;7665.348445382205;9669.564869580745;9838.311318207656;9979.20166386702;10038.146757525692;10129.493525323556 09:12:44 INFO - PROCESS | 16824 | |3;mootools.html;1159.5709587452643;1319.0239222974994;1351.8512963574005;1360.46261726618;1661.8005839299285;6402.679866006699;6872.140982377203;6942.097527321447;7302.306280903305;7316.634168291591;7139.785806425815;7485.401167906568;7491.737789177379;7499;7505.8874116888155;2045.9488512787188;2075.553755942472;2100.6323893318686;2105.4841563816885;2107.093949601671;2039.612473630013;2066.1218981932693;2077.6779599162155;2088.749350077993;2094.4345026842743;2073.284716772711;2075.439631299548;2078.449210959097;2078.802513761198;2080.4070839810656;2025.7467816522935;2034.338839877031;2034.5117171878717;2036.2771216218325;2041.806028427297;1986.1658103596524;2015.2140665140607;2053.4558342039372;2053.8254248388903;2062.7730949595534;7309.707611695579;7382.151052628909;7389.667464964035;7393.741219057307;7401.814954626124;4207.305794543897;4392.209402307583;4392.626626736731;4438.15675021748;4453.376527286183;2683.9597406038924;2819.323362393011;2851;2866.312085099582;2866.498362786525;957.3394357893101;957.5260246178186;972.397113789448;973.5132433783108;981.259149342242;9900.752481188028;10078.294519383646;10109.797804043877;10120.696379108638;10123.645672401504;3781.205946751158;3791.260704162662;3855.6722678572073;3920.6079392060565;3951.407288906687;8784.297256219486;8839.51382673959;8843.159899809507;8848.955755221183;8857.734267971971;4391.451068616423;4405.7797110144365;4414.359917811899;4414.911701766011;4417.160739459492;3466.6360032196762;3609.9278014439565;3706.8702595409572;3960.20795840833;4012.25773231953;3170.5402716605963;3510.9122271943406;3511.964880351215;3543.4153364694535;3543.5924868639922;1097.5609756097465;1133.9716507087223;1140.4468832616174;1147.8737338892715;1157.89578937896;788.1724189600897;812.5774597209418;827.7475370012083;831.5426515416497;856.7258477287209;4647.674662773641;4924.3105965164905;4970.2793095001025;5021.84934451967;5071.619628527875;368.1697771525194;378.34546235013033;378.69325846064777;390.38124572552255;392.75256588349157;3233.288676491168;3277.836108194581;3290.7860989035635;3322.401967645799;3373.645767194458;8874.378793484395;8976.820463590691;9103.544822758835;9158.587863546156;9174.724758257264;9145.176934075966;9149.039350868195;9163.633454661873;9167;9171.312151588658;6985.3713165815325;7030.789076327718;7037.753678621224;7041;7051.8237044073285;4715.962488252579;4779.1636463619425;4870.537298956593;4881.170201065756;4997.600191984705;7755.2244775521995;7874.13384527713;8134.75595732129;8167.0607880092175;8168.264856162974;8046.597670116354;8199.836003279781;8205.917940820515;8227.724702671096;8280.668773249003;6175.722092505938;6273.65494897785;6279.623222606659;6281.96859015702;6284.528660350401;6684.899726504009;6689.264180939996;6739.191297044386;6747;6759.357861003196;6049.576529642883;6075.179850720273;6088.817335479943;6103.176071230505;6205.193324867739;5911.733971971185;5922.496587790086;5929.199558059607;5957.880842383215;6099.237595300588;5635.9436405635415;5673.5461163107675;5674.460926212003;5721.170430287668;5724.227229323988;4152.418661387469;4235.30117530604;4236.6187043166265;4360.847370342023;4470.977645111753;4192.790360482025;4265.168292182994;4321.286987647003;4393.033532622818;4406.955930440783 09:12:44 INFO - PROCESS | 16824 | |4;prototype.html;265.92155314182315;271.8681439501841;284.4879217408664;293.82076933070823;296.4530441335735;4646.279826626874;4799.400074990626;4887.3890763654545;4889.046635906;4895.873948991725;4735.692180008297;4817.421909370881;4818.59041981432;4819.710817350952;4826.444958829736;3720.790743008526;3771.6039815819354;3777.471154038437;3791.317562838688;3807.1243613968804;3578.57057153142;3657.4330978698345;3694.741368104234;3747.4378843173467;3796.90507737306;3710.0910276982177;3729.1236559408517;3734.2158146789207;3740.738148329618;3746.1009357754215;3719.2933342664805;3740.8690695825653;3745.2883952049024;3757.304898593769;3773.1699026214187;3270.787398819069;3297.835108244602;3302.3890580242733;3311.2549676322874;3312.271300313927;4454.977725111354;4687;4701.435827700664;4704.176769065434;4719.598834099105;4229.91540169198;4233.597808208216;4234.978825105854;4246.787660616957;4257.531671516131;5020.171671674169;5033.974830125826;5052.368453943257;5057.848264552069;5095.439501654815;3314.3537010283003;3487;3491.528643633128;3494.668006539375;3564.803935783531;5224.947750522484;5252.3171987641745;5271.973640131813;5289.508924110069;5296.894062118736;3619.4027985382645;3620.1356301504748;3621.63783621641;3626.401643728808;3627.981860090683;3578.320119177348;3702.259548090393;3703.2963736890442;3708;3713.3872910969926;4060.4924384451942;4142.5857414258935;4164.979175104105;4241.384999175164;4247.745135291892;5049.293098966147;5051;5067.493250674903;5067.847964561069;5070.01134778722;1272.732726127505;1283.794592865137;1284.8843604075491;1289.8258735070644;1291.231717128307;797.5214871077308;841.2134654098437;853.3002937591116;868.7350358140701;868.9522076285865;4014.157027024299;4015.6185162409524;4021.561564862001;4039.818208180639;4060.2894493463527;4590.495045544987;4604.707634041676;4616.884577885579;4621.078551342809;4627.838025669085;3948.7038472114705;3996.18078293949;4012.478377810866;4013.8595149169637;4023.7786921719585;2435.3424575364907;2562.2825608829557;2758.4483103379403;2780.304923769058;2796.804223704321;4905.607551395879;4914.434839993375;4917.87705307363;4929.285253638202;4933.432655244693;5385.219143224289;5386.569074474032;5417.295751552352;5466.644668096561;5475.589330800126;4844.612431005582;4914.65597408178;4941.53055459738;4945.612255604922;4947.455779864212;5268.841934741964;5274.498922602346;5283.815066472809;5284.172967462389;5295.470452954673;4936.901261974668;5195.350581177353;5213.13983192769;5216.9739151304;5227.738613069408;4798.592119669727;4872.293517439881;4880.292357608198;4885.706857588556;4888.340074089952;3655.7075433964687;3664.615215402451;3675.50380698613;3705.333040052816;3710.962890371062;4970.975145124251;5085.423518709212;5302.973485132549;5328.49379308965;5355.98236335095;5031.4213865405945;5110.284560161506;5113.335266415343;5124.56441202502;5146.562542183956;5110.71891045996;5112.412072611697;5123.592810780789;5126.513640884243;5143.3284182640045;4803.390864060579;4980.900381992412;5035.295058691713;5050.823221187241;5056.0140772549;5130.640855140105;5140.177571588528;5148.510891465305;5150.922736159036;5159.871003224949;4982.925256121233;5012.273220383097;5019.472955339636;5036;5043.722595257296 09:12:44 INFO - PROCESS | 16824 | |5;yui.html;619.4889216396473;639.6865535887416;675.3786516404907;708.0971761004722;721.433674565466;12330.938345308272;13421.127626704281;13431.731365372687;13446.999999999987;13509.392077356519;12732.936335318334;12911.612651620466;12918.677033074178;12922.676933076678;12925.806112908314;607.5929127484596;623.2116372788427;733.8092096055037;743.6281859070451;767.0718430698861;758.7003133762161;767.5126294802812;768.0514564512822;768.1933969332207;768.2471178245323;808.1918081918081;809.5668817182808;809.9919000809975;810.1331575214523;810.2748040503745;629.5561629051531;646.6184950878957;768.5926458976751;782.8825676148566;804.1154729797206;590.2297501760202;590.3506143242399;590.4036922708053;590.5924911810837;590.6928397233457;12715.55495557651;12763.808542871864;12829.935850320782;12839.165454245443;12856;11784.175107742461;12126.696832579168;12349.25904445727;12430.564930227398;12856;9971.40171589707;10011.399316041061;10431.426271555138;10589.682309530726;11634.94182529082;3127.4996000640017;3145.3394787094508;3146.3549972255632;3257.7882437641715;3291.670832916713;60044.39955600432;60359;60575.394246057855;63105.36894631087;63492.36507634911;9557.761055973517;10389.584416623251;10561.947190264;10616.150707943347;10691;20229.49426264355;20457.07943142562;20469.59060818805;20645.690314645293;20647.58704825925;6562.245341785756;6675.7997260082275;6721.697523611351;6770.5599136056;7160.677769500385;3412.8293585320635;3469.3237952631303;3515;3637.5816781070516;3696.1129328960856;2828.420173864353;2911.403162351713;2915.8687859046395;2916.6500019997734;2916.6791652918164;525.3039722367878;541.196323459662;542.3058485139028;547.9945200547943;562.9577781666392;532.5260518138859;593.5815250248564;595.3867516458055;619.8140557832722;626.9749210031548;8340.61593316325;8545.529995850164;8615.569221538897;8854.203121719076;8868;502.85919942416183;543.7906406033626;545.5989847462113;606.8118883146238;621.3724138620026;3905.7851818149707;4027.1945610877356;4138.896527586774;4329.242382583036;4459.420275364182;99149.50425247828;103403.48298258611;106384;106909;106938;63927;71900.64049679822;79729;87167;97295.51352243194;44042.898927525785;66918.66540667265;68895;69308.999999999;74132.25867741361;8426.41015128935;8790.560471976503;9147.63409463614;9197.954010229905;9286.814263714823;42374;43893.34159987539;44113.77943110264;44658.55341446674;45151;56297.43702563086;61884.690576546825;63249.36750632435;63269;66837;11056.115510758958;11122.944385278022;11236.269642473213;11279.718007049561;11729.472173752372;12733.108682392143;12760.936195318964;12768.808467873176;13159.53941612039;13364.331783410986;12117.69705757363;12160.209586376857;12403.441845116811;12416.317102559085;12961.092723509264;11982.940085299517;12336.568220112253;12572.622821315375;13167.53913613019;13306.334683265992;11627.941860290983;11940.52237910474;11984.520619175135;13032.41354139085;13034.543790967271;10074.19406447497;10085.344452610558;10383.273170878269;10699.839502407314;11035.779284414428;8915.331350148635;9065.773355665897;10378.325408848401;10675.412852293199;10726.356418614909 09:12:44 INFO - PROCESS | 16824 | __end_tp_report 09:12:44 INFO - PROCESS | 16824 | __start_cc_report 09:12:44 INFO - PROCESS | 16824 | _x_x_mozilla_cycle_collect,1017 09:12:44 INFO - PROCESS | 16824 | __end_cc_report 09:12:44 INFO - PROCESS | 16824 | __startTimestamp1475251964110__endTimestamp 09:12:44 INFO - PROCESS | 16824 | 09:12:44 INFO - PROCESS | 16824 | ------- Summary: start ------- 09:12:44 INFO - PROCESS | 16824 | Number of tests: 6 09:12:44 INFO - PROCESS | 16824 | 09:12:44 INFO - PROCESS | 16824 | [#0] dojo.html Cycles:165 Average:4667.78 Median:4766.83 stddev:477.15 (10.0%) stddev-sans-first:449.75 09:12:44 INFO - PROCESS | 16824 | Values: 2584.1 2609.6 2635.0 2641.2 2654.3 4568.5 4667.2 4741.6 4756.4 4778.9 4655.0 4692.0 4698.7 4720.0 4765.6 4311.5 4341.2 4385.6 4392.9 4401.2 4377.1 4418.0 4431.8 4437.0 4447.6 4218.5 4379.3 4379.8 4396.4 4492.6 4250.6 4286.0 4301.5 4302.2 4309.0 4272.1 4276.1 4287.9 4336.2 4340.0 4646.1 4665.4 4691.8 4700.6 4702.8 4943.1 4975.2 4999.6 5024.1 5049.8 5061.5 5066.7 5072.9 5113.9 5126.7 4722.0 4722.9 4723.1 4724.8 4782.9 5058.9 5112.7 5155.0 5162.1 5225.8 4989.7 5008.1 5009.1 5061.7 5064.2 5067.4 5067.9 5071.0 5072.7 5131.3 4824.6 4878.0 5004.0 5006.3 5007.9 4874.3 4930.0 4935.1 4938.1 4985.7 4415.7 4418.6 4421.4 4423.4 4425.5 3788.3 3807.4 3810.9 3847.8 3860.3 4366.2 4366.6 4366.9 4371.9 4426.6 4922.9 4974.3 5032.0 5068.3 5089.7 4360.7 4370.9 4377.1 4415.7 4422.4 4598.6 4606.1 4606.4 4607.4 4664.9 4654.5 4714.2 4715.0 4731.0 4781.3 5111.0 5118.1 5141.6 5165.0 5200.7 4779.3 4789.0 4796.6 4806.0 4856.9 4846.5 4907.7 4910.8 5045.2 5109.9 4980.2 5018.6 5025.2 5091.3 5092.7 4884.2 4886.6 4896.6 4909.9 4941.7 4766.8 4815.0 4883.2 4919.7 4976.7 4803.7 4841.8 4855.0 4855.5 4911.9 4927.9 4934.5 4938.1 4964.3 4966.2 4687.0 4696.2 4721.7 4738.5 4740.5 09:12:44 INFO - PROCESS | 16824 | 09:12:44 INFO - PROCESS | 16824 | [#1] ext.html Cycles:180 Average:50161.62 Median:35169.65 stddev:103280.79 (293.7%) stddev-sans-first:103503.41 09:12:44 INFO - PROCESS | 16824 | Values: 573.5 584.5 584.6 586.6 590.9 27753.2 38028.0 39420.2 39493.8 43009.4 40744.8 41194.8 41205.6 41227.0 41231.6 7564.0 7755.5 7755.7 7756.8 7759.3 7657.5 7701.2 7718.3 7741.8 7747.2 7713.7 7754.2 7757.3 7758.6 7790.1 7712.1 7725.3 7753.4 7756.0 7757.1 7636.4 7729.6 7730.0 7730.1 7731.8 38191.6 38470.0 38500.0 38534.0 38548.6 2927.2 2946.6 2978.3 3157.8 3551.8 27920.9 28163.3 28780.6 29575.0 29863.7 3359.9 3378.0 3411.9 3457.8 3463.8 257374.0 257907.0 258212.0 258474.0 258832.0 30584.0 31691.4 50615.7 51009.5 51037.0 33714.8 33947.5 33983.8 33998.0 34030.3 13277.9 13461.5 13467.3 13477.1 13480.9 10947.7 11088.9 11097.3 11098.3 11102.5 7774.4 7810.2 7825.4 7903.9 7912.0 3121.7 3155.1 3159.0 3162.9 3200.1 818.2 875.5 922.5 948.2 960.7 27516.7 28236.0 28333.7 28671.0 28681.0 900.2 948.0 974.9 1036.5 1058.9 14562.6 14788.1 15060.6 15239.2 15245.8 380407.0 452549.0 464441.0 464920.0 687878.0 49384.5 49970.5 50021.2 50034.7 50074.5 1169.1 1174.6 1175.4 1177.7 1186.6 27055.9 28233.9 28630.0 28878.7 29194.6 41457.4 42006.0 42110.4 42327.0 42404.0 360939.0 363179.0 363782.0 363933.0 366406.0 23837.4 23895.5 24235.5 24236.5 24255.3 40324.0 40565.4 40802.8 41042.8 41074.6 34844.8 34929.0 35349.6 36342.6 36497.8 34788.8 34850.3 34919.7 34954.7 34989.7 28295.6 29026.1 34419.0 34440.2 34589.5 26559.9 31146.5 32014.8 32158.0 32162.4 24499.4 24672.0 24708.8 25103.5 25143.2 09:12:44 INFO - PROCESS | 16824 | 09:12:44 INFO - PROCESS | 16824 | [#2] jquery.html Cycles:180 Average:23873.16 Median:26516.00 stddev:64129.25 (241.9%) stddev-sans-first:64284.79 09:12:44 INFO - PROCESS | 16824 | Values: 335.1 351.4 351.7 352.1 376.9 12421.9 15893.3 16909.0 16941.6 17409.5 16495.6 17114.7 17285.5 17565.1 17702.4 4900.4 4977.9 5144.3 5201.1 5206.8 3300.2 5123.8 5156.2 5156.8 5158.1 3470.9 4794.5 5038.2 5044.7 5116.4 4941.5 5086.9 5092.9 5102.6 5103.7 4936.9 4965.9 4973.8 4981.8 4985.4 11252.9 11267.7 11273.7 17257.2 19857.3 1737.4 1868.2 1927.9 1998.7 2259.8 8190.0 9052.9 9754.6 10079.9 13416.5 1633.5 1681.2 1685.3 1735.4 1744.4 64758.7 71075.3 72135.3 73230.0 74835.6 7648.4 8144.8 8232.3 8284.3 9316.0 10810.6 10823.2 10829.4 10831.0 10849.7 6634.2 6743.6 6796.2 6923.1 6945.5 6859.1 7002.9 7127.6 7128.4 7189.2 3369.4 3416.5 3474.2 3521.5 3549.4 1620.4 1642.6 1648.4 1656.9 1676.4 808.5 829.6 855.6 858.7 935.4 16742.7 16974.7 17123.8 17365.1 17887.0 825.0 837.8 840.4 886.5 891.2 8050.4 9534.4 9843.9 9894.5 9934.0 378068.0 387439.0 388680.0 390397.0 391635.0 78071.6 78625.6 78768.0 80058.6 80313.6 870.1 892.2 893.9 894.9 896.6 14528.3 15065.2 15360.8 15596.5 15691.8 36682.0 36762.0 37178.4 37408.8 38109.6 47242.0 48237.5 49737.8 51090.5 51481.2 4444.8 6769.6 7276.5 7390.3 7516.7 9170.5 11537.9 11766.6 11794.5 11903.8 9943.8 10187.6 10457.1 10517.9 10720.1 10171.1 10288.6 10323.2 10540.7 10592.1 9959.4 10224.2 10273.1 10334.5 10904.8 7149.6 7226.2 7464.2 7531.5 7665.3 9669.6 9838.3 9979.2 10038.1 10129.5 09:12:44 INFO - PROCESS | 16824 | 09:12:44 INFO - PROCESS | 16824 | [#3] mootools.html Cycles:180 Average:4783.41 Median:4747.56 stddev:2693.68 (56.7%) stddev-sans-first:2687.47 09:12:44 INFO - PROCESS | 16824 | Values: 1159.6 1319.0 1351.9 1360.5 1661.8 6402.7 6872.1 6942.1 7302.3 7316.6 7139.8 7485.4 7491.7 7499.0 7505.9 2045.9 2075.6 2100.6 2105.5 2107.1 2039.6 2066.1 2077.7 2088.7 2094.4 2073.3 2075.4 2078.4 2078.8 2080.4 2025.7 2034.3 2034.5 2036.3 2041.8 1986.2 2015.2 2053.5 2053.8 2062.8 7309.7 7382.2 7389.7 7393.7 7401.8 4207.3 4392.2 4392.6 4438.2 4453.4 2684.0 2819.3 2851.0 2866.3 2866.5 957.3 957.5 972.4 973.5 981.3 9900.8 10078.3 10109.8 10120.7 10123.6 3781.2 3791.3 3855.7 3920.6 3951.4 8784.3 8839.5 8843.2 8849.0 8857.7 4391.5 4405.8 4414.4 4414.9 4417.2 3466.6 3609.9 3706.9 3960.2 4012.3 3170.5 3510.9 3512.0 3543.4 3543.6 1097.6 1134.0 1140.4 1147.9 1157.9 788.2 812.6 827.7 831.5 856.7 4647.7 4924.3 4970.3 5021.8 5071.6 368.2 378.3 378.7 390.4 392.8 3233.3 3277.8 3290.8 3322.4 3373.6 8874.4 8976.8 9103.5 9158.6 9174.7 9145.2 9149.0 9163.6 9167.0 9171.3 6985.4 7030.8 7037.8 7041.0 7051.8 4716.0 4779.2 4870.5 4881.2 4997.6 7755.2 7874.1 8134.8 8167.1 8168.3 8046.6 8199.8 8205.9 8227.7 8280.7 6175.7 6273.7 6279.6 6282.0 6284.5 6684.9 6689.3 6739.2 6747.0 6759.4 6049.6 6075.2 6088.8 6103.2 6205.2 5911.7 5922.5 5929.2 5957.9 6099.2 5635.9 5673.5 5674.5 5721.2 5724.2 4152.4 4235.3 4236.6 4360.8 4471.0 4192.8 4265.2 4321.3 4393.0 4407.0 09:12:44 INFO - PROCESS | 16824 | 09:12:44 INFO - PROCESS | 16824 | [#4] prototype.html Cycles:180 Average:4157.08 Median:4727.65 stddev:1231.80 (26.1%) stddev-sans-first:1200.13 09:12:44 INFO - PROCESS | 16824 | Values: 265.9 271.9 284.5 293.8 296.5 4646.3 4799.4 4887.4 4889.0 4895.9 4735.7 4817.4 4818.6 4819.7 4826.4 3720.8 3771.6 3777.5 3791.3 3807.1 3578.6 3657.4 3694.7 3747.4 3796.9 3710.1 3729.1 3734.2 3740.7 3746.1 3719.3 3740.9 3745.3 3757.3 3773.2 3270.8 3297.8 3302.4 3311.3 3312.3 4455.0 4687.0 4701.4 4704.2 4719.6 4229.9 4233.6 4235.0 4246.8 4257.5 5020.2 5034.0 5052.4 5057.8 5095.4 3314.4 3487.0 3491.5 3494.7 3564.8 5224.9 5252.3 5272.0 5289.5 5296.9 3619.4 3620.1 3621.6 3626.4 3628.0 3578.3 3702.3 3703.3 3708.0 3713.4 4060.5 4142.6 4165.0 4241.4 4247.7 5049.3 5051.0 5067.5 5067.8 5070.0 1272.7 1283.8 1284.9 1289.8 1291.2 797.5 841.2 853.3 868.7 869.0 4014.2 4015.6 4021.6 4039.8 4060.3 4590.5 4604.7 4616.9 4621.1 4627.8 3948.7 3996.2 4012.5 4013.9 4023.8 2435.3 2562.3 2758.4 2780.3 2796.8 4905.6 4914.4 4917.9 4929.3 4933.4 5385.2 5386.6 5417.3 5466.6 5475.6 4844.6 4914.7 4941.5 4945.6 4947.5 5268.8 5274.5 5283.8 5284.2 5295.5 4936.9 5195.4 5213.1 5217.0 5227.7 4798.6 4872.3 4880.3 4885.7 4888.3 3655.7 3664.6 3675.5 3705.3 3711.0 4971.0 5085.4 5303.0 5328.5 5356.0 5031.4 5110.3 5113.3 5124.6 5146.6 5110.7 5112.4 5123.6 5126.5 5143.3 4803.4 4980.9 5035.3 5050.8 5056.0 5130.6 5140.2 5148.5 5150.9 5159.9 4982.9 5012.3 5019.5 5036.0 5043.7 09:12:44 INFO - PROCESS | 16824 | 09:12:44 INFO - PROCESS | 16824 | [#5] yui.html Cycles:180 Average:17664.07 Median:43968.12 stddev:25168.82 (57.2%) stddev-sans-first:25206.88 09:12:44 INFO - PROCESS | 16824 | Values: 619.5 639.7 675.4 708.1 721.4 12330.9 13421.1 13431.7 13447.0 13509.4 12732.9 12911.6 12918.7 12922.7 12925.8 607.6 623.2 733.8 743.6 767.1 758.7 767.5 768.1 768.2 768.2 808.2 809.6 810.0 810.1 810.3 629.6 646.6 768.6 782.9 804.1 590.2 590.4 590.4 590.6 590.7 12715.6 12763.8 12829.9 12839.2 12856.0 11784.2 12126.7 12349.3 12430.6 12856.0 9971.4 10011.4 10431.4 10589.7 11634.9 3127.5 3145.3 3146.4 3257.8 3291.7 60044.4 60359.0 60575.4 63105.4 63492.4 9557.8 10389.6 10561.9 10616.2 10691.0 20229.5 20457.1 20469.6 20645.7 20647.6 6562.2 6675.8 6721.7 6770.6 7160.7 3412.8 3469.3 3515.0 3637.6 3696.1 2828.4 2911.4 2915.9 2916.7 2916.7 525.3 541.2 542.3 548.0 563.0 532.5 593.6 595.4 619.8 627.0 8340.6 8545.5 8615.6 8854.2 8868.0 502.9 543.8 545.6 606.8 621.4 3905.8 4027.2 4138.9 4329.2 4459.4 99149.5 103403.5 106384.0 106909.0 106938.0 63927.0 71900.6 79729.0 87167.0 97295.5 44042.9 66918.7 68895.0 69309.0 74132.3 8426.4 8790.6 9147.6 9198.0 9286.8 42374.0 43893.3 44113.8 44658.6 45151.0 56297.4 61884.7 63249.4 63269.0 66837.0 11056.1 11122.9 11236.3 11279.7 11729.5 12733.1 12760.9 12768.8 13159.5 13364.3 12117.7 12160.2 12403.4 12416.3 12961.1 11982.9 12336.6 12572.6 13167.5 13306.3 11627.9 11940.5 11984.5 13032.4 13034.5 10074.2 10085.3 10383.3 10699.8 11035.8 8915.3 9065.8 10378.3 10675.4 10726.4 09:12:44 INFO - PROCESS | 16824 | -------- Summary: end -------- 09:12:44 INFO - PROCESS | 16824 | 09:12:45 INFO - TEST-INFO | 16824: exit 0 09:12:45 INFO - TEST-OK | dromaeo_css | took 1122467ms 09:12:45 INFO - TEST-START | kraken 09:12:45 INFO - operating with platform_type : linux_ 09:12:45 INFO - Initialising browser for kraken test... 09:12:45 INFO - TEST-INFO | started process 17125 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbyA7eC/profile http://localhost:44743/getInfo.html) 09:12:50 INFO - PROCESS | 17125 | __metrics Screen width/height:1600/1200 09:12:50 INFO - PROCESS | 17125 | colorDepth:24 09:12:50 INFO - PROCESS | 17125 | Browser inner width/height: 1024/697 09:12:50 INFO - PROCESS | 17125 | __metrics 09:12:50 INFO - PROCESS | 17125 | 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" 09:12:50 INFO - PROCESS | 17125 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:12:51 INFO - PROCESS | 17125 | console.error: PushService: 09:12:51 INFO - PROCESS | 17125 | stateChangeProcessEnqueue: Error transitioning state 09:12:51 INFO - PROCESS | 17125 | UnknownError 09:12:52 INFO - TEST-INFO | 17125: exit 0 09:12:52 INFO - Browser initialized. 09:12:52 INFO - Running cycle 1/1 for kraken test... 09:12:52 INFO - TEST-INFO | started process 17204 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbyA7eC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:13:04 INFO - PROCESS | 17204 | RSS: Main: 175259648 09:13:04 INFO - PROCESS | 17204 | 09:13:07 INFO - PROCESS | 17204 | Cycle 1(1): loaded http://localhost:44743/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44743/tests/kraken/driver.html?testName=audio-beat-detection) 09:13:08 INFO - PROCESS | 17204 | RSS: Main: 233947136 09:13:08 INFO - PROCESS | 17204 | 09:13:11 INFO - PROCESS | 17204 | Cycle 1(1): loaded http://localhost:44743/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44743/tests/kraken/driver.html?testName=audio-dft) 09:13:11 INFO - PROCESS | 17204 | RSS: Main: 218554368 09:13:11 INFO - PROCESS | 17204 | 09:13:14 INFO - PROCESS | 17204 | Cycle 1(1): loaded http://localhost:44743/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44743/tests/kraken/driver.html?testName=audio-fft) 09:13:15 INFO - PROCESS | 17204 | RSS: Main: 300367872 09:13:15 INFO - PROCESS | 17204 | 09:13:17 INFO - PROCESS | 17204 | Cycle 1(1): loaded http://localhost:44743/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44743/tests/kraken/driver.html?testName=audio-oscillator) 09:13:18 INFO - PROCESS | 17204 | RSS: Main: 209883136 09:13:18 INFO - PROCESS | 17204 | 09:13:20 INFO - PROCESS | 17204 | Cycle 1(1): loaded http://localhost:44743/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44743/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:13:21 INFO - PROCESS | 17204 | RSS: Main: 214020096 09:13:21 INFO - PROCESS | 17204 | 09:13:24 INFO - PROCESS | 17204 | Cycle 1(1): loaded http://localhost:44743/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44743/tests/kraken/driver.html?testName=imaging-darkroom) 09:13:25 INFO - PROCESS | 17204 | RSS: Main: 250376192 09:13:25 INFO - PROCESS | 17204 | 09:13:28 INFO - PROCESS | 17204 | Cycle 1(1): loaded http://localhost:44743/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44743/tests/kraken/driver.html?testName=imaging-desaturate) 09:13:29 INFO - PROCESS | 17204 | RSS: Main: 244203520 09:13:29 INFO - PROCESS | 17204 | 09:13:32 INFO - PROCESS | 17204 | Cycle 1(1): loaded http://localhost:44743/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44743/tests/kraken/driver.html?testName=json-parse-financial) 09:13:32 INFO - PROCESS | 17204 | RSS: Main: 247447552 09:13:32 INFO - PROCESS | 17204 | 09:13:34 INFO - PROCESS | 17204 | Cycle 1(1): loaded http://localhost:44743/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44743/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:13:35 INFO - PROCESS | 17204 | RSS: Main: 211292160 09:13:35 INFO - PROCESS | 17204 | 09:13:36 INFO - PROCESS | 17204 | Cycle 1(1): loaded http://localhost:44743/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44743/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:13:37 INFO - PROCESS | 17204 | RSS: Main: 219017216 09:13:37 INFO - PROCESS | 17204 | 09:13:39 INFO - PROCESS | 17204 | Cycle 1(1): loaded http://localhost:44743/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44743/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:13:40 INFO - PROCESS | 17204 | RSS: Main: 222814208 09:13:40 INFO - PROCESS | 17204 | 09:13:43 INFO - PROCESS | 17204 | Cycle 1(1): loaded http://localhost:44743/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44743/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:13:43 INFO - PROCESS | 17204 | RSS: Main: 223649792 09:13:43 INFO - PROCESS | 17204 | 09:13:46 INFO - PROCESS | 17204 | Cycle 1(1): loaded http://localhost:44743/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44743/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:13:47 INFO - PROCESS | 17204 | RSS: Main: 221765632 09:13:47 INFO - PROCESS | 17204 | 09:13:49 INFO - PROCESS | 17204 | Cycle 1(1): loaded http://localhost:44743/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44743/tests/kraken/driver.html?testName=ai-astar) 09:13:49 INFO - PROCESS | 17204 | RSS: Main: 273543168 09:13:49 INFO - PROCESS | 17204 | 09:13:49 INFO - PROCESS | 17204 | __start_tp_report 09:13:49 INFO - PROCESS | 17204 | _x_x_mozilla_page_load 09:13:49 INFO - PROCESS | 17204 | _x_x_mozilla_page_load_details 09:13:49 INFO - PROCESS | 17204 | |i|pagename|runs| 09:13:49 INFO - PROCESS | 17204 | |0;ai-astar;114;116;115;117;115;118;116;116;115;115 09:13:49 INFO - PROCESS | 17204 | |1;audio-beat-detection;154;127;128;178;134;134;132;127;158;131 09:13:49 INFO - PROCESS | 17204 | |2;audio-dft;161;161;160;160;160;160;164;160;160;160 09:13:49 INFO - PROCESS | 17204 | |3;audio-fft;76;75;76;105;78;89;77;78;105;78 09:13:49 INFO - PROCESS | 17204 | |4;audio-oscillator;84;83;116;83;83;83;114;83;83;109 09:13:49 INFO - PROCESS | 17204 | |5;imaging-gaussian-blur;117;117;117;117;117;118;118;118;118;117 09:13:49 INFO - PROCESS | 17204 | |6;imaging-darkroom;146;146;145;146;146;146;145;145;146;146 09:13:49 INFO - PROCESS | 17204 | |7;imaging-desaturate;94;95;95;95;96;94;95;95;94;94 09:13:49 INFO - PROCESS | 17204 | |8;json-parse-financial;63;63;75;62;63;64;64;64;64;64 09:13:49 INFO - PROCESS | 17204 | |9;json-stringify-tinderbox;67;66;67;67;68;67;67;67;67;66 09:13:49 INFO - PROCESS | 17204 | |10;stanford-crypto-aes;84;84;84;85;83;85;84;82;83;82 09:13:49 INFO - PROCESS | 17204 | |11;stanford-crypto-ccm;139;135;136;138;134;137;140;142;175;139 09:13:49 INFO - PROCESS | 17204 | |12;stanford-crypto-pbkdf2;178;177;176;180;179;178;175;178;175;175 09:13:49 INFO - PROCESS | 17204 | |13;stanford-crypto-sha256-iterative;72;70;70;74;85;70;73;70;69;77 09:13:49 INFO - PROCESS | 17204 | __end_tp_report 09:13:49 INFO - PROCESS | 17204 | __start_cc_report 09:13:49 INFO - PROCESS | 17204 | _x_x_mozilla_cycle_collect,1964 09:13:49 INFO - PROCESS | 17204 | __end_cc_report 09:13:49 INFO - PROCESS | 17204 | __startTimestamp1475252029572__endTimestamp 09:13:49 INFO - PROCESS | 17204 | 09:13:49 INFO - PROCESS | 17204 | ------- Summary: start ------- 09:13:49 INFO - PROCESS | 17204 | Number of tests: 14 09:13:49 INFO - PROCESS | 17204 | 09:13:49 INFO - PROCESS | 17204 | [#0] ai-astar Cycles:10 Average:115.70 Median:116.00 stddev:1.16 (1.0%) stddev-sans-first:1.05 09:13:49 INFO - PROCESS | 17204 | Values: 114.0 116.0 115.0 117.0 115.0 118.0 116.0 116.0 115.0 115.0 09:13:49 INFO - PROCESS | 17204 | 09:13:49 INFO - PROCESS | 17204 | [#1] audio-beat-detection Cycles:10 Average:140.30 Median:134.00 stddev:17.20 (12.8%) stddev-sans-first:17.51 09:13:49 INFO - PROCESS | 17204 | Values: 154.0 127.0 128.0 178.0 134.0 134.0 132.0 127.0 158.0 131.0 09:13:49 INFO - PROCESS | 17204 | 09:13:49 INFO - PROCESS | 17204 | [#2] audio-dft Cycles:10 Average:160.60 Median:160.00 stddev:1.26 (0.8%) stddev-sans-first:1.33 09:13:49 INFO - PROCESS | 17204 | Values: 161.0 161.0 160.0 160.0 160.0 160.0 164.0 160.0 160.0 160.0 09:13:49 INFO - PROCESS | 17204 | 09:13:49 INFO - PROCESS | 17204 | [#3] audio-fft Cycles:10 Average:83.70 Median:77.50 stddev:11.89 (15.3%) stddev-sans-first:12.28 09:13:49 INFO - PROCESS | 17204 | Values: 76.0 75.0 76.0 105.0 78.0 89.0 77.0 78.0 105.0 78.0 09:13:49 INFO - PROCESS | 17204 | 09:13:49 INFO - PROCESS | 17204 | [#4] audio-oscillator Cycles:10 Average:92.10 Median:83.00 stddev:14.53 (17.5%) stddev-sans-first:15.11 09:13:49 INFO - PROCESS | 17204 | Values: 84.0 83.0 116.0 83.0 83.0 83.0 114.0 83.0 83.0 109.0 09:13:49 INFO - PROCESS | 17204 | 09:13:49 INFO - PROCESS | 17204 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 09:13:49 INFO - PROCESS | 17204 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 118.0 118.0 118.0 117.0 09:13:49 INFO - PROCESS | 17204 | 09:13:49 INFO - PROCESS | 17204 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 09:13:49 INFO - PROCESS | 17204 | Values: 146.0 146.0 145.0 146.0 146.0 146.0 145.0 145.0 146.0 146.0 09:13:49 INFO - PROCESS | 17204 | 09:13:49 INFO - PROCESS | 17204 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 09:13:49 INFO - PROCESS | 17204 | Values: 94.0 95.0 95.0 95.0 96.0 94.0 95.0 95.0 94.0 94.0 09:13:49 INFO - PROCESS | 17204 | 09:13:49 INFO - PROCESS | 17204 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:64.00 stddev:3.72 (5.8%) stddev-sans-first:3.90 09:13:49 INFO - PROCESS | 17204 | Values: 63.0 63.0 75.0 62.0 63.0 64.0 64.0 64.0 64.0 64.0 09:13:49 INFO - PROCESS | 17204 | 09:13:49 INFO - PROCESS | 17204 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:67.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 09:13:49 INFO - PROCESS | 17204 | Values: 67.0 66.0 67.0 67.0 68.0 67.0 67.0 67.0 67.0 66.0 09:13:49 INFO - PROCESS | 17204 | 09:13:49 INFO - PROCESS | 17204 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:84.00 stddev:1.07 (1.3%) stddev-sans-first:1.13 09:13:49 INFO - PROCESS | 17204 | Values: 84.0 84.0 84.0 85.0 83.0 85.0 84.0 82.0 83.0 82.0 09:13:49 INFO - PROCESS | 17204 | 09:13:49 INFO - PROCESS | 17204 | [#11] stanford-crypto-ccm Cycles:10 Average:141.50 Median:139.00 stddev:12.01 (8.6%) stddev-sans-first:12.71 09:13:49 INFO - PROCESS | 17204 | Values: 139.0 135.0 136.0 138.0 134.0 137.0 140.0 142.0 175.0 139.0 09:13:49 INFO - PROCESS | 17204 | 09:13:49 INFO - PROCESS | 17204 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.10 Median:178.00 stddev:1.79 (1.0%) stddev-sans-first:1.87 09:13:49 INFO - PROCESS | 17204 | Values: 178.0 177.0 176.0 180.0 179.0 178.0 175.0 178.0 175.0 175.0 09:13:49 INFO - PROCESS | 17204 | 09:13:49 INFO - PROCESS | 17204 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.00 Median:72.50 stddev:4.88 (6.7%) stddev-sans-first:5.16 09:13:49 INFO - PROCESS | 17204 | Values: 72.0 70.0 70.0 74.0 85.0 70.0 73.0 70.0 69.0 77.0 09:13:49 INFO - PROCESS | 17204 | -------- Summary: end -------- 09:13:49 INFO - PROCESS | 17204 | 09:13:50 INFO - TEST-INFO | 17204: exit 0 09:13:50 INFO - TEST-OK | kraken | took 65768ms 09:13:50 INFO - SUITE-END | took 1188s 09:13:51 INFO - Completed test suite (00:19:48) 09:13:51 INFO - javascript benchmark 09:13:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2584.147231413633, 2609.5824668053115, 2635.0250407349276, 2641.181233817517, 2654.3496843273388, 4568.451785785702, 4667.15991121598, 4741.620670346372, 4756.40544931884, 4778.924741933068, 4654.953450465494, 4692.038132182903, 4698.7415692137, 4719.976400117995, 4765.571098601125, 4311.5472875348105, 4341.196878577458, 4385.605295523403, 4392.934105988413, 4401.163778882018, 4377.102693947749, 4418.005948661557, 4431.800568974388, 4437.0, 4447.599716025557, 4218.535961044283, 4379.343098535213, 4379.75911324877, 4396.428464299621, 4492.550744925514, 4250.638695710868, 4286.0, 4301.505326887417, 4302.225599392108, 4309.030468144642, 4272.060146767706, 4276.059266961263, 4287.892802679927, 4336.1978034063795, 4340.023494713664, 4646.117237724821, 4665.4168228971375, 4691.812327506896, 4700.623950083985, 4702.788374523155, 4943.134951383494, 4975.203967365204, 4999.550040496373, 5024.095662780698, 5049.823256186052, 5061.468545802712, 5066.69599824008, 5072.873178170538, 5113.897722045575, 5126.71803050832, 4721.999999999965, 4722.88192795176, 4723.055388922229, 4724.787384567703, 4782.904341913142, 5058.898822023539, 5112.71880046601, 5155.0, 5162.096633089194, 5225.843224703265, 4989.650724449254, 5008.12357837377, 5009.148444764399, 5061.670991385548, 5064.18972964324, 5067.366579177603, 5067.923981140286, 5071.0, 5072.67027643202, 5131.281620573122, 4824.589909857631, 4878.02439512099, 5004.0, 5006.299118123466, 5007.874803129878, 4874.341963834908, 4929.975350123226, 4935.136351138536, 4938.061768264019, 4985.725785081855, 4415.690901636919, 4418.64650827933, 4421.358902959053, 4423.447069116361, 4425.513193548707, 3788.261289048609, 3807.447920051577, 3810.8856734298015, 3847.769133851978, 3860.3244432224246, 4366.170427618742, 4366.563343665672, 4366.890827729332, 4371.934420983688, 4426.601605855489, 4922.852314430573, 4974.328465657162, 5031.974840125849, 5068.290439338495, 5089.6691715038405, 4360.694751367374, 4370.868873933787, 4377.146456441027, 4415.735055896656, 4422.425084739028, 4598.563136502027, 4606.124836281096, 4606.355110284563, 4607.401037865056, 4664.883377915511, 4654.534546545318, 4714.151452738402, 4714.999999999932, 4731.0, 4781.258904869751, 5111.0, 5118.129917913889, 5141.562967147835, 5165.0, 5200.6619569727845, 4779.259214821708, 4789.042191561772, 4796.640251981185, 4805.951940480551, 4856.878578035577, 4846.466888642176, 4907.656464047483, 4910.8281210157475, 5045.2432135180015, 5109.872253193551, 4980.153373926369, 5018.573421259234, 5025.170846810235, 5091.261767043832, 5092.694438333564, 4884.242942343943, 4886.584640305614, 4896.583790377857, 4909.852704418873, 4941.65408421407, 4766.833160839354, 4815.036992601424, 4883.218685010382, 4919.729414882073, 4976.701397915992, 4803.687760295569, 4841.830535931225, 4855.028994201244, 4855.465898751064, 4911.926321105115, 4927.901441971212, 4934.50654934518, 4938.08645400602, 4964.25536169563, 4966.180580204225, 4686.976565117153, 4696.1546921554445, 4721.7403042832975, 4738.50245724194, 4740.549647783455], "value": 4637.729598218195, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.4580821124038, 584.465214328889, 584.6024703201821, 586.6392168816179, 590.9113632955053, 27753.167404977834, 38028.0, 39420.211595768065, 39493.802530987305, 43009.35485967713, 40744.79627601858, 41194.7940260299, 41205.58794412055, 41227.0, 41231.58768412315, 7564.016677831888, 7755.534667919915, 7755.6509957051785, 7756.767296981071, 7759.262870027366, 7657.502262352957, 7701.191374905638, 7718.343940765014, 7741.845163096735, 7747.186545412706, 7713.652885620132, 7754.185810489902, 7757.301842834144, 7758.612069396536, 7790.130368711497, 7712.074551053882, 7725.304722574995, 7753.418493612945, 7756.0, 7757.107932587768, 7636.350910172642, 7729.613519324012, 7729.961350193269, 7730.111037230734, 7731.845363092762, 38191.61808381936, 38470.0, 38500.0, 38534.0, 38548.61451385478, 2927.2096533935933, 2946.587477753116, 2978.285211549234, 3157.842107894619, 3551.8224088795455, 27920.86039569789, 28163.295917602223, 28780.568291475643, 29575.0, 29863.70136298631, 3359.932801343984, 3377.9831100844585, 3411.9147021324416, 3457.844397002141, 3463.79217246966, 257374.0, 257907.0, 258212.0, 258474.0, 258832.0, 30584.0, 31691.36617267642, 50615.746921265156, 51009.48990510122, 51037.0, 33714.83142584271, 33947.490787638206, 33983.83008084993, 33998.0, 34030.319393611986, 13277.867221327662, 13461.461541538229, 13467.259300738357, 13477.056606037484, 13480.93259533696, 10947.726306842393, 11088.944555277172, 11097.278676885977, 11098.2786118902, 11102.500387482583, 7774.416918731118, 7810.218978102258, 7825.413094017971, 7903.920960790433, 7911.960440197878, 3121.734652554558, 3155.0692545699076, 3158.98420507896, 3162.920926976844, 3200.0879749271344, 818.2267756969726, 875.5490922175085, 922.4880191493651, 948.2461443152711, 960.70698436976, 27516.724832751417, 28236.0, 28333.716662833107, 28671.0, 28681.0, 900.243795212012, 948.0330063335497, 974.8785124664254, 1036.4506811389974, 1058.9364638121738, 14562.63593410152, 14788.11271323724, 15060.623484412758, 15239.238038098272, 15245.771313430307, 380407.0, 452549.0, 464441.0, 464920.0, 687878.0, 49384.50615493871, 49970.50029499731, 50021.24968125481, 50034.74982625136, 50074.49925500698, 1169.0647482014353, 1174.6241202815017, 1175.4299164905015, 1177.735009622828, 1186.5846953566183, 27055.86472067627, 28233.858830705714, 28630.0, 28878.711212887603, 29194.56208156922, 41457.37813932733, 42006.0, 42110.36834447424, 42327.0, 42404.0, 360939.0, 363179.0, 363782.0, 363933.0, 366406.0, 23837.404064898517, 23895.52208955846, 24235.515289693754, 24236.515269694155, 24255.272341829772, 40324.0, 40565.39151912665, 40802.79598601988, 41042.79478602588, 41074.58925410708, 34844.82577587197, 34929.0, 35349.646503534634, 36342.63657363393, 36497.817510912275, 34788.82605586956, 34850.30299394049, 34919.65080349164, 34954.65045349514, 34989.650103498636, 28295.575566366108, 29026.12921612355, 34419.0, 34440.178375028016, 34589.48115778215, 26559.867200663874, 31146.532802007536, 32014.839925801152, 32158.0, 32162.35675286528, 24499.38751531226, 24672.0, 24708.752912470645, 25103.497930041663, 25143.245702628952], "value": 16428.862789813866, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.08354650032175, 351.4219109564766, 351.7361978516113, 352.0758010223164, 376.9302679004384, 12421.875781242185, 15893.2848021839, 16908.98546087234, 16941.57646058846, 17409.47771566855, 16495.587610309747, 17114.657706845886, 17285.481435556954, 17565.121743912787, 17702.380416685417, 4900.362952816146, 4977.925331120027, 5144.279800827869, 5201.0898092833795, 5206.843794686166, 3300.2409445827475, 5123.769430375642, 5156.175011998081, 5156.793728250866, 5158.097332966735, 3470.8785192518267, 4794.472608013116, 5038.244263360507, 5044.672096313746, 5116.386033675964, 4941.530554597343, 5086.92369614456, 5092.898142037157, 5102.566281866046, 5103.744812759366, 4936.851894443173, 4965.90068198634, 4973.801047958077, 4981.825636102719, 4985.376827896513, 11252.887471125267, 11267.661970140909, 11273.718157046058, 17257.223424945907, 19857.304994325128, 1737.3658614605579, 1868.2433614386196, 1927.9228830846748, 1998.7101870228735, 2259.751427342991, 8189.95905020477, 9052.8642070369, 9754.561044753003, 10079.949600252025, 13416.46334146633, 1633.4854520825902, 1681.1846254566647, 1685.2500637216444, 1735.3579175704945, 1744.3981826269917, 64758.67620661914, 71075.28924710739, 72135.27864721337, 73230.0, 74835.62582187109, 7648.42636802242, 8144.837103257902, 8232.324494539298, 8284.25441710237, 9315.953420232856, 10810.567577296977, 10823.188260880466, 10829.350238985686, 10831.0, 10849.67450976472, 6634.170728658918, 6743.561668491532, 6796.184457865088, 6923.134608173978, 6945.548539345027, 6859.142607174103, 7002.859942801116, 7127.607981561064, 7128.429725621938, 7189.209186989427, 3369.3935091683243, 3416.538767266437, 3474.1934194218866, 3521.4717792331357, 3549.432090865449, 1620.3842539834786, 1642.5893526618345, 1648.406573633491, 1656.9171541422882, 1676.4048762689313, 808.4946908182386, 829.6473998550592, 855.5764896376334, 858.7166235142388, 935.3919952031098, 16742.74885876713, 16974.745378819327, 17123.828761712222, 17365.131743412778, 17887.0, 824.9917500824915, 837.8073043199976, 840.4411066640738, 886.534569351083, 891.1534042659499, 8050.396220283385, 9534.427934323823, 9843.901560984299, 9894.505274736379, 9934.0, 378068.0, 387439.0, 388680.0, 390397.0, 391635.0, 78071.60964195256, 78625.60687196527, 78768.0, 80058.59970700226, 80313.59843200746, 870.1081391573562, 892.2193081054078, 893.8748575199477, 894.8970868350093, 896.6010125494092, 14528.346224420138, 15065.17141557225, 15360.769588455958, 15596.532104036896, 15691.764623530884, 36682.0, 36762.0, 37178.44232336463, 37408.81295593505, 38109.61890381061, 47242.0, 48237.517624823304, 49737.75131124321, 51090.489095108576, 51481.22778158406, 4444.8444304449185, 6769.578388538462, 7276.4542659299705, 7390.260973902567, 7516.661750221144, 9170.495622740547, 11537.884621154017, 11766.647000589996, 11794.52821887115, 11903.821442678194, 9943.801123977624, 10187.592496300362, 10457.058864702214, 10517.894821051692, 10720.088792452729, 10171.13545348624, 10288.588456461657, 10323.225758068025, 10540.683779486628, 10592.099671527698, 9959.352642078242, 10224.233182511192, 10273.075423211947, 10334.534945927602, 10904.836427453753, 7149.60677162761, 7226.241244669234, 7464.1789403166695, 7531.510451820614, 7665.348445382205, 9669.564869580745, 9838.311318207656, 9979.20166386702, 10038.146757525692, 10129.493525323556], "value": 7803.180078444091, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1159.5709587452643, 1319.0239222974994, 1351.8512963574005, 1360.46261726618, 1661.8005839299285, 6402.679866006699, 6872.140982377203, 6942.097527321447, 7302.306280903305, 7316.634168291591, 7139.785806425815, 7485.401167906568, 7491.737789177379, 7499.0, 7505.8874116888155, 2045.9488512787188, 2075.553755942472, 2100.6323893318686, 2105.4841563816885, 2107.093949601671, 2039.612473630013, 2066.1218981932693, 2077.6779599162155, 2088.749350077993, 2094.4345026842743, 2073.284716772711, 2075.439631299548, 2078.449210959097, 2078.802513761198, 2080.4070839810656, 2025.7467816522935, 2034.338839877031, 2034.5117171878717, 2036.2771216218325, 2041.806028427297, 1986.1658103596524, 2015.2140665140607, 2053.4558342039372, 2053.8254248388903, 2062.7730949595534, 7309.707611695579, 7382.151052628909, 7389.667464964035, 7393.741219057307, 7401.814954626124, 4207.305794543897, 4392.209402307583, 4392.626626736731, 4438.15675021748, 4453.376527286183, 2683.9597406038924, 2819.323362393011, 2851.0, 2866.312085099582, 2866.498362786525, 957.3394357893101, 957.5260246178186, 972.397113789448, 973.5132433783108, 981.259149342242, 9900.752481188028, 10078.294519383646, 10109.797804043877, 10120.696379108638, 10123.645672401504, 3781.205946751158, 3791.260704162662, 3855.6722678572073, 3920.6079392060565, 3951.407288906687, 8784.297256219486, 8839.51382673959, 8843.159899809507, 8848.955755221183, 8857.734267971971, 4391.451068616423, 4405.7797110144365, 4414.359917811899, 4414.911701766011, 4417.160739459492, 3466.6360032196762, 3609.9278014439565, 3706.8702595409572, 3960.20795840833, 4012.25773231953, 3170.5402716605963, 3510.9122271943406, 3511.964880351215, 3543.4153364694535, 3543.5924868639922, 1097.5609756097465, 1133.9716507087223, 1140.4468832616174, 1147.8737338892715, 1157.89578937896, 788.1724189600897, 812.5774597209418, 827.7475370012083, 831.5426515416497, 856.7258477287209, 4647.674662773641, 4924.3105965164905, 4970.2793095001025, 5021.84934451967, 5071.619628527875, 368.1697771525194, 378.34546235013033, 378.69325846064777, 390.38124572552255, 392.75256588349157, 3233.288676491168, 3277.836108194581, 3290.7860989035635, 3322.401967645799, 3373.645767194458, 8874.378793484395, 8976.820463590691, 9103.544822758835, 9158.587863546156, 9174.724758257264, 9145.176934075966, 9149.039350868195, 9163.633454661873, 9167.0, 9171.312151588658, 6985.3713165815325, 7030.789076327718, 7037.753678621224, 7041.0, 7051.8237044073285, 4715.962488252579, 4779.1636463619425, 4870.537298956593, 4881.170201065756, 4997.600191984705, 7755.2244775521995, 7874.13384527713, 8134.75595732129, 8167.0607880092175, 8168.264856162974, 8046.597670116354, 8199.836003279781, 8205.917940820515, 8227.724702671096, 8280.668773249003, 6175.722092505938, 6273.65494897785, 6279.623222606659, 6281.96859015702, 6284.528660350401, 6684.899726504009, 6689.264180939996, 6739.191297044386, 6747.0, 6759.357861003196, 6049.576529642883, 6075.179850720273, 6088.817335479943, 6103.176071230505, 6205.193324867739, 5911.733971971185, 5922.496587790086, 5929.199558059607, 5957.880842383215, 6099.237595300588, 5635.9436405635415, 5673.5461163107675, 5674.460926212003, 5721.170430287668, 5724.227229323988, 4152.418661387469, 4235.30117530604, 4236.6187043166265, 4360.847370342023, 4470.977645111753, 4192.790360482025, 4265.168292182994, 4321.286987647003, 4393.033532622818, 4406.955930440783], "value": 3806.9800481545626, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [265.92155314182315, 271.8681439501841, 284.4879217408664, 293.82076933070823, 296.4530441335735, 4646.279826626874, 4799.400074990626, 4887.3890763654545, 4889.046635906, 4895.873948991725, 4735.692180008297, 4817.421909370881, 4818.59041981432, 4819.710817350952, 4826.444958829736, 3720.790743008526, 3771.6039815819354, 3777.471154038437, 3791.317562838688, 3807.1243613968804, 3578.57057153142, 3657.4330978698345, 3694.741368104234, 3747.4378843173467, 3796.90507737306, 3710.0910276982177, 3729.1236559408517, 3734.2158146789207, 3740.738148329618, 3746.1009357754215, 3719.2933342664805, 3740.8690695825653, 3745.2883952049024, 3757.304898593769, 3773.1699026214187, 3270.787398819069, 3297.835108244602, 3302.3890580242733, 3311.2549676322874, 3312.271300313927, 4454.977725111354, 4687.0, 4701.435827700664, 4704.176769065434, 4719.598834099105, 4229.91540169198, 4233.597808208216, 4234.978825105854, 4246.787660616957, 4257.531671516131, 5020.171671674169, 5033.974830125826, 5052.368453943257, 5057.848264552069, 5095.439501654815, 3314.3537010283003, 3487.0, 3491.528643633128, 3494.668006539375, 3564.803935783531, 5224.947750522484, 5252.3171987641745, 5271.973640131813, 5289.508924110069, 5296.894062118736, 3619.4027985382645, 3620.1356301504748, 3621.63783621641, 3626.401643728808, 3627.981860090683, 3578.320119177348, 3702.259548090393, 3703.2963736890442, 3708.0, 3713.3872910969926, 4060.4924384451942, 4142.5857414258935, 4164.979175104105, 4241.384999175164, 4247.745135291892, 5049.293098966147, 5051.0, 5067.493250674903, 5067.847964561069, 5070.01134778722, 1272.732726127505, 1283.794592865137, 1284.8843604075491, 1289.8258735070644, 1291.231717128307, 797.5214871077308, 841.2134654098437, 853.3002937591116, 868.7350358140701, 868.9522076285865, 4014.157027024299, 4015.6185162409524, 4021.561564862001, 4039.818208180639, 4060.2894493463527, 4590.495045544987, 4604.707634041676, 4616.884577885579, 4621.078551342809, 4627.838025669085, 3948.7038472114705, 3996.18078293949, 4012.478377810866, 4013.8595149169637, 4023.7786921719585, 2435.3424575364907, 2562.2825608829557, 2758.4483103379403, 2780.304923769058, 2796.804223704321, 4905.607551395879, 4914.434839993375, 4917.87705307363, 4929.285253638202, 4933.432655244693, 5385.219143224289, 5386.569074474032, 5417.295751552352, 5466.644668096561, 5475.589330800126, 4844.612431005582, 4914.65597408178, 4941.53055459738, 4945.612255604922, 4947.455779864212, 5268.841934741964, 5274.498922602346, 5283.815066472809, 5284.172967462389, 5295.470452954673, 4936.901261974668, 5195.350581177353, 5213.13983192769, 5216.9739151304, 5227.738613069408, 4798.592119669727, 4872.293517439881, 4880.292357608198, 4885.706857588556, 4888.340074089952, 3655.7075433964687, 3664.615215402451, 3675.50380698613, 3705.333040052816, 3710.962890371062, 4970.975145124251, 5085.423518709212, 5302.973485132549, 5328.49379308965, 5355.98236335095, 5031.4213865405945, 5110.284560161506, 5113.335266415343, 5124.56441202502, 5146.562542183956, 5110.71891045996, 5112.412072611697, 5123.592810780789, 5126.513640884243, 5143.3284182640045, 4803.390864060579, 4980.900381992412, 5035.295058691713, 5050.823221187241, 5056.0140772549, 5130.640855140105, 5140.177571588528, 5148.510891465305, 5150.922736159036, 5159.871003224949, 4982.925256121233, 5012.273220383097, 5019.472955339636, 5036.0, 5043.722595257296], "value": 3763.234562433601, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [619.4889216396473, 639.6865535887416, 675.3786516404907, 708.0971761004722, 721.433674565466, 12330.938345308272, 13421.127626704281, 13431.731365372687, 13446.999999999987, 13509.392077356519, 12732.936335318334, 12911.612651620466, 12918.677033074178, 12922.676933076678, 12925.806112908314, 607.5929127484596, 623.2116372788427, 733.8092096055037, 743.6281859070451, 767.0718430698861, 758.7003133762161, 767.5126294802812, 768.0514564512822, 768.1933969332207, 768.2471178245323, 808.1918081918081, 809.5668817182808, 809.9919000809975, 810.1331575214523, 810.2748040503745, 629.5561629051531, 646.6184950878957, 768.5926458976751, 782.8825676148566, 804.1154729797206, 590.2297501760202, 590.3506143242399, 590.4036922708053, 590.5924911810837, 590.6928397233457, 12715.55495557651, 12763.808542871864, 12829.935850320782, 12839.165454245443, 12856.0, 11784.175107742461, 12126.696832579168, 12349.25904445727, 12430.564930227398, 12856.0, 9971.40171589707, 10011.399316041061, 10431.426271555138, 10589.682309530726, 11634.94182529082, 3127.4996000640017, 3145.3394787094508, 3146.3549972255632, 3257.7882437641715, 3291.670832916713, 60044.39955600432, 60359.0, 60575.394246057855, 63105.36894631087, 63492.36507634911, 9557.761055973517, 10389.584416623251, 10561.947190264, 10616.150707943347, 10691.0, 20229.49426264355, 20457.07943142562, 20469.59060818805, 20645.690314645293, 20647.58704825925, 6562.245341785756, 6675.7997260082275, 6721.697523611351, 6770.5599136056, 7160.677769500385, 3412.8293585320635, 3469.3237952631303, 3515.0, 3637.5816781070516, 3696.1129328960856, 2828.420173864353, 2911.403162351713, 2915.8687859046395, 2916.6500019997734, 2916.6791652918164, 525.3039722367878, 541.196323459662, 542.3058485139028, 547.9945200547943, 562.9577781666392, 532.5260518138859, 593.5815250248564, 595.3867516458055, 619.8140557832722, 626.9749210031548, 8340.61593316325, 8545.529995850164, 8615.569221538897, 8854.203121719076, 8868.0, 502.85919942416183, 543.7906406033626, 545.5989847462113, 606.8118883146238, 621.3724138620026, 3905.7851818149707, 4027.1945610877356, 4138.896527586774, 4329.242382583036, 4459.420275364182, 99149.50425247828, 103403.48298258611, 106384.0, 106909.0, 106938.0, 63927.0, 71900.64049679822, 79729.0, 87167.0, 97295.51352243194, 44042.898927525785, 66918.66540667265, 68895.0, 69308.999999999, 74132.25867741361, 8426.41015128935, 8790.560471976503, 9147.63409463614, 9197.954010229905, 9286.814263714823, 42374.0, 43893.34159987539, 44113.77943110264, 44658.55341446674, 45151.0, 56297.43702563086, 61884.690576546825, 63249.36750632435, 63269.0, 66837.0, 11056.115510758958, 11122.944385278022, 11236.269642473213, 11279.718007049561, 11729.472173752372, 12733.108682392143, 12760.936195318964, 12768.808467873176, 13159.53941612039, 13364.331783410986, 12117.69705757363, 12160.209586376857, 12403.441845116811, 12416.317102559085, 12961.092723509264, 11982.940085299517, 12336.568220112253, 12572.622821315375, 13167.53913613019, 13306.334683265992, 11627.941860290983, 11940.52237910474, 11984.520619175135, 13032.41354139085, 13034.543790967271, 10074.19406447497, 10085.344452610558, 10383.273170878269, 10699.839502407314, 11035.779284414428, 8915.331350148635, 9065.773355665897, 10378.325408848401, 10675.412852293199, 10726.356418614909], "value": 6567.252244858899, "unit": "score"}], "name": "dromaeo_css", "value": 6184.339947005993, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 115.0, 117.0, 115.0, 118.0, 116.0, 116.0, 115.0, 115.0], "value": 115.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 127.0, 128.0, 178.0, 134.0, 134.0, 132.0, 127.0, 158.0, 131.0], "value": 140.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 160.0, 160.0, 160.0, 164.0, 160.0, 160.0, 160.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 105.0, 78.0, 89.0, 77.0, 78.0, 105.0, 78.0], "value": 83.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 116.0, 83.0, 83.0, 83.0, 114.0, 83.0, 83.0, 109.0], "value": 92.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 96.0, 94.0, 95.0, 95.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 75.0, 62.0, 63.0, 64.0, 64.0, 64.0, 64.0, 64.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 67.0, 68.0, 67.0, 67.0, 67.0, 67.0, 66.0], "value": 66.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 85.0, 83.0, 85.0, 84.0, 82.0, 83.0, 82.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 135.0, 136.0, 138.0, 134.0, 137.0, 140.0, 142.0, 175.0, 139.0], "value": 141.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 177.0, 176.0, 180.0, 179.0, 178.0, 175.0, 178.0, 175.0, 175.0], "value": 177.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 70.0, 70.0, 74.0, 85.0, 70.0, 73.0, 70.0, 69.0, 77.0], "value": 73.0, "unit": "score"}], "name": "kraken", "value": 1556.8999999999999, "alertThreshold": 2.0}]} 09:13:51 INFO - Return code: 0 09:13:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:13:51 INFO - # TBPL SUCCESS # 09:13:51 INFO - Running post-action listener: _resource_record_post_action 09:13:51 INFO - [mozharness: 2016-09-30 16:13:51.364104Z] Finished run-tests step (success) 09:13:51 INFO - Running post-run listener: _resource_record_post_run 09:13:51 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 4096; Write bytes: 388571136; Read time: 8; Write time: 734980 09:13:51 INFO - TinderboxPrint: CPU usage
13.1% 09:13:51 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 09:13:51 INFO - TinderboxPrint: I/O write bytes / time
388,571,136 / 734,980 09:13:51 INFO - TinderboxPrint: CPU idle
8,357.0 (86.9%) 09:13:51 INFO - TinderboxPrint: CPU user
1,204.3 (12.5%) 09:13:51 INFO - TinderboxPrint: Swap in / out
0 / 0 09:13:51 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99069952; Read time: 0; Write time: 129644 09:13:51 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 289501184; Read time: 0; Write time: 605336 09:13:52 INFO - Running post-run listener: _upload_blobber_files 09:13:52 INFO - Blob upload gear active. 09:13:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:13:52 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 09:13:52 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:13:52 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:13:52 INFO - (blobuploader) - INFO - Open directory for files ... 09:13:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:13:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:13:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:13:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:13:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:13:56 INFO - (blobuploader) - INFO - Done attempting. 09:13:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:13:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:13:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:13:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:13:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:13:56 INFO - (blobuploader) - INFO - Done attempting. 09:13:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:13:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:13:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:13:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:13:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:13:57 INFO - (blobuploader) - INFO - Done attempting. 09:13:57 INFO - (blobuploader) - INFO - Iteration through files over. 09:13:57 INFO - Return code: 0 09:13:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:13:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:13:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1d5450dcbf566d30855125f538a825e725964b893f3cd3eff3b024541b5d6c33225cb7b44c579d76dd578f8ab0ab3c021359ae60f4022ce6575cda50820a206a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/cba478858b30df5a92d9de97c9c9100d66bc9009058a4bf7d684815cd78defdc0976d21c4cbf5592c0ca83a30be6584af0ca81494d4c566e878ced5f7fb83ea2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/59398f07a82bb633ef3f61e75da4131c664f70a4034013425938953ca1f1f3689e5e398763ce08953d8a63b30c6fef7f298e2b0e56146e80a304d3fa3789d053"} 09:13:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:13:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:13:57 INFO - Contents: 09:13:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1d5450dcbf566d30855125f538a825e725964b893f3cd3eff3b024541b5d6c33225cb7b44c579d76dd578f8ab0ab3c021359ae60f4022ce6575cda50820a206a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/cba478858b30df5a92d9de97c9c9100d66bc9009058a4bf7d684815cd78defdc0976d21c4cbf5592c0ca83a30be6584af0ca81494d4c566e878ced5f7fb83ea2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/59398f07a82bb633ef3f61e75da4131c664f70a4034013425938953ca1f1f3689e5e398763ce08953d8a63b30c6fef7f298e2b0e56146e80a304d3fa3789d053"} 09:13:57 INFO - Running post-run listener: copy_logs_to_upload_dir 09:13:57 INFO - Copying logs to upload dir... 09:13:57 INFO - mkdir: /builds/slave/test/build/upload/logs 09:13:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.548640 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-09-30 09:13:57.446959) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-30 09:13:57.450190) ========= 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-1475248419.679544-21133969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1d5450dcbf566d30855125f538a825e725964b893f3cd3eff3b024541b5d6c33225cb7b44c579d76dd578f8ab0ab3c021359ae60f4022ce6575cda50820a206a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/cba478858b30df5a92d9de97c9c9100d66bc9009058a4bf7d684815cd78defdc0976d21c4cbf5592c0ca83a30be6584af0ca81494d4c566e878ced5f7fb83ea2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/59398f07a82bb633ef3f61e75da4131c664f70a4034013425938953ca1f1f3689e5e398763ce08953d8a63b30c6fef7f298e2b0e56146e80a304d3fa3789d053"} build_url:https://queue.taskcluster.net/v1/task/Vx_x4IjhTViUWnnULn5bmw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011439 build_url: 'https://queue.taskcluster.net/v1/task/Vx_x4IjhTViUWnnULn5bmw/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/Autoland-Non-PGO/sha512/1d5450dcbf566d30855125f538a825e725964b893f3cd3eff3b024541b5d6c33225cb7b44c579d76dd578f8ab0ab3c021359ae60f4022ce6575cda50820a206a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/cba478858b30df5a92d9de97c9c9100d66bc9009058a4bf7d684815cd78defdc0976d21c4cbf5592c0ca83a30be6584af0ca81494d4c566e878ced5f7fb83ea2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/59398f07a82bb633ef3f61e75da4131c664f70a4034013425938953ca1f1f3689e5e398763ce08953d8a63b30c6fef7f298e2b0e56146e80a304d3fa3789d053"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-30 09:13:57.480879) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 09:13:57.481249) ========= 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-1475248419.679544-21133969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004418 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 09:13:57.567054) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-30 09:13:57.567898) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-30 09:13:57.568607) ========= ========= Total master_lag: 0.19 =========