builder: autoland_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-032 starttime: 1468836958.32 results: success (0) buildid: 20160718003001 builduid: 5ffc9c4f480f4673ae4f08247195a1dd revision: ec74ba5a1d15f796c640e6df9632261547904185 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 03:15:58.317646) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 03:15:58.318111) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 03:15:58.318431) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 03:15:58.333272) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 03:15:58.333649) ========= 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=745a4373a2a16df560f216e000000264-1468836957.856193-325568411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-18 03:15:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2016-07-18 03:15:58 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.070282 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 03:15:58.417527) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 03:15:58.417836) ========= 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=745a4373a2a16df560f216e000000264-1468836957.856193-325568411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020436 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 03:15:58.467266) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 03:15:58.467649) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev ec74ba5a1d15f796c640e6df9632261547904185 --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 ec74ba5a1d15f796c640e6df9632261547904185 --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=745a4373a2a16df560f216e000000264-1468836957.856193-325568411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-18 03:15:58,956 truncating revision to first 12 chars 2016-07-18 03:15:58,956 Setting DEBUG logging. 2016-07-18 03:15:58,956 attempt 1/10 2016-07-18 03:15:58,956 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/ec74ba5a1d15?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-18 03:15:59,260 unpacking tar archive at: autoland-ec74ba5a1d15/testing/mozharness/ program finished with exit code 0 elapsedTime=0.776650 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 03:15:59.258519) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 03:15:59.258850) ========= script_repo_revision: ec74ba5a1d15f796c640e6df9632261547904185 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 03:15:59.259245) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 03:15:59.259529) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 03:15:59.273124) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-07-18 03:15:59.273499) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=745a4373a2a16df560f216e000000264-1468836957.856193-325568411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:15:59 INFO - MultiFileLogger online at 20160718 03:15:59 in /builds/slave/test 03:15:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 03:15:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:15:59 INFO - {'append_to_log': False, 03:15:59 INFO - 'base_work_dir': '/builds/slave/test', 03:15:59 INFO - 'blob_upload_branch': 'Autoland', 03:15:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:15:59 INFO - 'branch': 'Autoland', 03:15:59 INFO - 'buildbot_json_path': 'buildprops.json', 03:15:59 INFO - 'config_files': ('talos/linux_config.py',), 03:15:59 INFO - 'default_actions': ('clobber', 03:15:59 INFO - 'read-buildbot-config', 03:15:59 INFO - 'download-and-extract', 03:15:59 INFO - 'populate-webroot', 03:15:59 INFO - 'create-virtualenv', 03:15:59 INFO - 'install', 03:15:59 INFO - 'run-tests'), 03:15:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:15:59 INFO - 'download_minidump_stackwalk': True, 03:15:59 INFO - 'download_symbols': 'ondemand', 03:15:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:15:59 INFO - 'tooltool.py': '/tools/tooltool.py', 03:15:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:15:59 INFO - '/tools/misc-python/virtualenv.py')}, 03:15:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:15:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:15:59 INFO - 'installer_path': 'installer.exe', 03:15:59 INFO - 'log_level': 'info', 03:15:59 INFO - 'log_name': 'talos', 03:15:59 INFO - 'log_to_console': True, 03:15:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:15:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:15:59 INFO - 'opt_config_files': (), 03:15:59 INFO - 'pip_index': False, 03:15:59 INFO - 'sps_profile': False, 03:15:59 INFO - 'sps_profile_interval': 0, 03:15:59 INFO - 'suite': 'dromaeojs-e10s', 03:15:59 INFO - 'system_bits': '32', 03:15:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:15:59 INFO - 'title': 'talos-linux64-ix-032', 03:15:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:15:59 INFO - 'use_talos_json': True, 03:15:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:15:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:15:59 INFO - 'work_dir': 'build'} 03:15:59 INFO - ##### 03:15:59 INFO - ##### Running clobber step. 03:15:59 INFO - ##### 03:15:59 INFO - Running pre-action listener: _resource_record_pre_action 03:15:59 INFO - Running main action method: clobber 03:15:59 INFO - rmtree: /builds/slave/test/build 03:15:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:16:00 INFO - Running post-action listener: _resource_record_post_action 03:16:00 INFO - ##### 03:16:00 INFO - ##### Finished clobber step (success) 03:16:00 INFO - ##### 03:16:00 INFO - ##### 03:16:00 INFO - ##### Running read-buildbot-config step. 03:16:00 INFO - ##### 03:16:00 INFO - Running pre-action listener: _resource_record_pre_action 03:16:00 INFO - Running main action method: read_buildbot_config 03:16:00 INFO - Using buildbot properties: 03:16:00 INFO - { 03:16:00 INFO - "project": "", 03:16:00 INFO - "product": "firefox", 03:16:00 INFO - "script_repo_revision": "production", 03:16:00 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 03:16:00 INFO - "repository": "", 03:16:00 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs-e10s", 03:16:00 INFO - "buildid": "20160718003001", 03:16:00 INFO - "pgo_build": "True", 03:16:00 INFO - "basedir": "/builds/slave/test", 03:16:00 INFO - "buildnumber": 42, 03:16:00 INFO - "slavename": "talos-linux64-ix-032", 03:16:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:16:00 INFO - "platform": "ubuntu64_hw", 03:16:00 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 03:16:00 INFO - "branch": "autoland", 03:16:00 INFO - "repo_path": "integration/autoland", 03:16:00 INFO - "revision": "ec74ba5a1d15f796c640e6df9632261547904185", 03:16:00 INFO - "stage_platform": "linux64-pgo", 03:16:00 INFO - "builduid": "5ffc9c4f480f4673ae4f08247195a1dd", 03:16:00 INFO - "slavebuilddir": "test" 03:16:00 INFO - } 03:16:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/apnqKzxMSxuxzw_gH8AJQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 03:16:00 INFO - Running post-action listener: _resource_record_post_action 03:16:00 INFO - ##### 03:16:00 INFO - ##### Finished read-buildbot-config step (success) 03:16:00 INFO - ##### 03:16:00 INFO - ##### 03:16:00 INFO - ##### Running download-and-extract step. 03:16:00 INFO - ##### 03:16:00 INFO - Running pre-action listener: _resource_record_pre_action 03:16:00 INFO - Running main action method: download_and_extract 03:16:00 INFO - mkdir: /builds/slave/test/build/tests 03:16:00 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:00 INFO - https://queue.taskcluster.net/v1/task/apnqKzxMSxuxzw_gH8AJQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:16:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnqKzxMSxuxzw_gH8AJQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:16:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnqKzxMSxuxzw_gH8AJQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:16:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnqKzxMSxuxzw_gH8AJQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:16:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnqKzxMSxuxzw_gH8AJQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:16:00 INFO - Downloaded 1361 bytes. 03:16:00 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:16:00 INFO - Using the following test package requirements: 03:16:00 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:16:00 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:16:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:16:00 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:16:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:16:00 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:16:00 INFO - u'jsshell-linux-x86_64.zip'], 03:16:00 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:16:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:16:01 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:16:01 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:16:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:16:01 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:16:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:16:01 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:16:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:16:01 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:16:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:16:01 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:16:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:01 INFO - https://queue.taskcluster.net/v1/task/apnqKzxMSxuxzw_gH8AJQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:16:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnqKzxMSxuxzw_gH8AJQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:16:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnqKzxMSxuxzw_gH8AJQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:16:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnqKzxMSxuxzw_gH8AJQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:16:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnqKzxMSxuxzw_gH8AJQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:16:04 INFO - Downloaded 24333116 bytes. 03:16:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:16:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:16:05 INFO - Return code: 0 03:16:05 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:16:05 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:05 INFO - https://queue.taskcluster.net/v1/task/apnqKzxMSxuxzw_gH8AJQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:16:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnqKzxMSxuxzw_gH8AJQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:16:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnqKzxMSxuxzw_gH8AJQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:16:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnqKzxMSxuxzw_gH8AJQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:16:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnqKzxMSxuxzw_gH8AJQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:16:06 INFO - Downloaded 24333116 bytes. 03:16:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:16:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:16:08 INFO - Return code: 0 03:16:08 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:08 INFO - https://queue.taskcluster.net/v1/task/apnqKzxMSxuxzw_gH8AJQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:16:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnqKzxMSxuxzw_gH8AJQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:16:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnqKzxMSxuxzw_gH8AJQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:16:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnqKzxMSxuxzw_gH8AJQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:16:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnqKzxMSxuxzw_gH8AJQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:16:09 INFO - Downloaded 14403317 bytes. 03:16:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:16:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:16:09 INFO - Return code: 0 03:16:09 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:09 INFO - https://queue.taskcluster.net/v1/task/apnqKzxMSxuxzw_gH8AJQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:16:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnqKzxMSxuxzw_gH8AJQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:16:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnqKzxMSxuxzw_gH8AJQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:16:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnqKzxMSxuxzw_gH8AJQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:16:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnqKzxMSxuxzw_gH8AJQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:16:10 INFO - Downloaded 60813856 bytes. 03:16:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/apnqKzxMSxuxzw_gH8AJQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:16:10 INFO - mkdir: /builds/slave/test/properties 03:16:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:16:10 INFO - Writing to file /builds/slave/test/properties/build_url 03:16:10 INFO - Contents: 03:16:10 INFO - build_url:https://queue.taskcluster.net/v1/task/apnqKzxMSxuxzw_gH8AJQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:16:11 INFO - Running post-action listener: _resource_record_post_action 03:16:11 INFO - Running post-action listener: set_extra_try_arguments 03:16:11 INFO - ##### 03:16:11 INFO - ##### Finished download-and-extract step (success) 03:16:11 INFO - ##### 03:16:11 INFO - ##### 03:16:11 INFO - ##### Running populate-webroot step. 03:16:11 INFO - ##### 03:16:11 INFO - Running pre-action listener: _resource_record_pre_action 03:16:11 INFO - Running main action method: populate_webroot 03:16:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:16:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:16:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:16:11 INFO - '--tppagecycles', 03:16:11 INFO - '7'], 03:16:11 INFO - 'tests': ['tsvgm']}}, 03:16:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:16:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:16:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:16:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:16:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:16:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:16:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:11 INFO - 'talos_options': ['--disable-e10s'], 03:16:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:16:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:16:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:11 INFO - 'talos_options': ['--disable-e10s'], 03:16:11 INFO - 'tests': ['damp', 'tps']}, 03:16:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:11 INFO - 'tests': ['damp', 'tps']}, 03:16:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:16:11 INFO - 'tests': ['dromaeo_dom']}, 03:16:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:16:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:16:11 INFO - 'tests': ['basic_compositor_video']}, 03:16:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:16:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:16:11 INFO - 'tests': ['a11yr', 03:16:11 INFO - 'ts_paint', 03:16:11 INFO - 'tpaint', 03:16:11 INFO - 'sessionrestore', 03:16:11 INFO - 'sessionrestore_no_auto_restore', 03:16:11 INFO - 'tabpaint']}, 03:16:11 INFO - 'other-e10s': {'tests': ['a11yr', 03:16:11 INFO - 'ts_paint', 03:16:11 INFO - 'tpaint', 03:16:11 INFO - 'sessionrestore', 03:16:11 INFO - 'sessionrestore_no_auto_restore', 03:16:11 INFO - 'tabpaint']}, 03:16:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:16:11 INFO - 'ts_paint', 03:16:11 INFO - 'tpaint', 03:16:11 INFO - 'sessionrestore', 03:16:11 INFO - 'sessionrestore_no_auto_restore', 03:16:11 INFO - 'tabpaint']}, 03:16:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:16:11 INFO - 'ts_paint', 03:16:11 INFO - 'tpaint', 03:16:11 INFO - 'sessionrestore', 03:16:11 INFO - 'sessionrestore_no_auto_restore', 03:16:11 INFO - 'tabpaint']}, 03:16:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:16:11 INFO - 'tests': ['a11yr', 03:16:11 INFO - 'ts_paint', 03:16:11 INFO - 'tpaint', 03:16:11 INFO - 'sessionrestore', 03:16:11 INFO - 'sessionrestore_no_auto_restore', 03:16:11 INFO - 'tabpaint']}, 03:16:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:16:11 INFO - 'tests': ['a11yr', 03:16:11 INFO - 'ts_paint', 03:16:11 INFO - 'tpaint', 03:16:11 INFO - 'sessionrestore', 03:16:11 INFO - 'sessionrestore_no_auto_restore', 03:16:11 INFO - 'tabpaint']}, 03:16:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:16:11 INFO - 'tests': ['tsvgx', 03:16:11 INFO - 'tsvgr_opacity', 03:16:11 INFO - 'tart', 03:16:11 INFO - 'tscrollx', 03:16:11 INFO - 'cart']}, 03:16:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:16:11 INFO - 'tsvgr_opacity', 03:16:11 INFO - 'tart', 03:16:11 INFO - 'tscrollx', 03:16:11 INFO - 'cart']}, 03:16:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:11 INFO - 'talos_options': ['--disable-e10s'], 03:16:11 INFO - 'tests': ['tp5o']}, 03:16:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:11 INFO - 'tests': ['tp5o']}, 03:16:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:11 INFO - 'talos_options': ['--disable-e10s', 03:16:11 INFO - '--xperf_path', 03:16:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:16:11 INFO - 'tests': ['tp5n']}, 03:16:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:11 INFO - 'talos_options': ['--xperf_path', 03:16:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:16:11 INFO - 'tests': ['tp5n']}}, 03:16:11 INFO - 'talos.zip': {'path': '', 03:16:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:16:11 INFO - Running post-action listener: _resource_record_post_action 03:16:11 INFO - ##### 03:16:11 INFO - ##### Finished populate-webroot step (success) 03:16:11 INFO - ##### 03:16:11 INFO - ##### 03:16:11 INFO - ##### Running create-virtualenv step. 03:16:11 INFO - ##### 03:16:11 INFO - Running pre-action listener: _resource_record_pre_action 03:16:11 INFO - Running main action method: create_virtualenv 03:16:11 INFO - Creating virtualenv /builds/slave/test/build/venv 03:16:11 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 03:16:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:16:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:16:11 INFO - Using real prefix '/usr' 03:16:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:16:12 INFO - Installing distribute.............................................................................................................................................................................................done. 03:16:14 INFO - Installing pip.................done. 03:16:14 INFO - Return code: 0 03:16:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:16:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:14 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 0x2486030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2747180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27453b0>, '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 0x27462b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2746740>, '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': '745a4373a2a16df560f216e000000264-1468836957.856193-325568411', '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 03:16:14 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 03:16:14 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 03:16:14 INFO - Using env: {'DISPLAY': ':0', 03:16:14 INFO - 'HOME': '/home/cltbld', 03:16:14 INFO - 'LANG': 'en_US.UTF-8', 03:16:14 INFO - 'LANGUAGE': 'en_US:en', 03:16:14 INFO - 'LOGNAME': 'cltbld', 03:16:14 INFO - 'MAIL': '/var/mail/cltbld', 03:16:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:14 INFO - 'MOZ_NO_REMOTE': '1', 03:16:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:14 INFO - 'NO_EM_RESTART': '1', 03:16:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:14 INFO - 'PWD': '/builds/slave/test', 03:16:14 INFO - 'SHELL': '/bin/bash', 03:16:14 INFO - 'SHLVL': '1', 03:16:14 INFO - 'TERM': 'linux', 03:16:14 INFO - 'TMOUT': '86400', 03:16:14 INFO - 'USER': 'cltbld', 03:16:14 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468836957.856193-325568411', 03:16:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:14 INFO - '_': '/tools/buildbot/bin/python'} 03:16:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:14 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 03:16:14 INFO - Cleaning up... 03:16:14 INFO - Return code: 0 03:16:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:16:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:14 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 0x2486030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2747180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27453b0>, '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 0x27462b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2746740>, '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': '745a4373a2a16df560f216e000000264-1468836957.856193-325568411', '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 03:16:14 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 03:16:14 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 03:16:14 INFO - Using env: {'DISPLAY': ':0', 03:16:14 INFO - 'HOME': '/home/cltbld', 03:16:14 INFO - 'LANG': 'en_US.UTF-8', 03:16:14 INFO - 'LANGUAGE': 'en_US:en', 03:16:14 INFO - 'LOGNAME': 'cltbld', 03:16:14 INFO - 'MAIL': '/var/mail/cltbld', 03:16:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:14 INFO - 'MOZ_NO_REMOTE': '1', 03:16:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:14 INFO - 'NO_EM_RESTART': '1', 03:16:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:14 INFO - 'PWD': '/builds/slave/test', 03:16:14 INFO - 'SHELL': '/bin/bash', 03:16:14 INFO - 'SHLVL': '1', 03:16:14 INFO - 'TERM': 'linux', 03:16:14 INFO - 'TMOUT': '86400', 03:16:14 INFO - 'USER': 'cltbld', 03:16:14 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468836957.856193-325568411', 03:16:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:14 INFO - '_': '/tools/buildbot/bin/python'} 03:16:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:14 INFO - Downloading/unpacking psutil>=3.1.1 03:16:14 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 03:16:14 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 03:16:14 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 03:16:14 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 03:16:14 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 03:16:14 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 03:16:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:16:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:16:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:16:16 INFO - Installing collected packages: psutil 03:16:16 INFO - Running setup.py install for psutil 03:16:16 INFO - building 'psutil._psutil_linux' extension 03:16:16 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 03:16:16 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 03:16:16 INFO - building 'psutil._psutil_posix' extension 03:16:16 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 03:16:17 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 03:16:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:16:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:16:17 INFO - Successfully installed psutil 03:16:17 INFO - Cleaning up... 03:16:17 INFO - Return code: 0 03:16:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:16:17 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:17 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:17 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 0x2486030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2747180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27453b0>, '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 0x27462b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2746740>, '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': '745a4373a2a16df560f216e000000264-1468836957.856193-325568411', '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 03:16:17 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 03:16:17 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 03:16:17 INFO - Using env: {'DISPLAY': ':0', 03:16:17 INFO - 'HOME': '/home/cltbld', 03:16:17 INFO - 'LANG': 'en_US.UTF-8', 03:16:17 INFO - 'LANGUAGE': 'en_US:en', 03:16:17 INFO - 'LOGNAME': 'cltbld', 03:16:17 INFO - 'MAIL': '/var/mail/cltbld', 03:16:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:17 INFO - 'MOZ_NO_REMOTE': '1', 03:16:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:17 INFO - 'NO_EM_RESTART': '1', 03:16:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:17 INFO - 'PWD': '/builds/slave/test', 03:16:17 INFO - 'SHELL': '/bin/bash', 03:16:17 INFO - 'SHLVL': '1', 03:16:17 INFO - 'TERM': 'linux', 03:16:17 INFO - 'TMOUT': '86400', 03:16:17 INFO - 'USER': 'cltbld', 03:16:17 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468836957.856193-325568411', 03:16:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:17 INFO - '_': '/tools/buildbot/bin/python'} 03:16:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:16:17 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 03:16:17 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 03:16:17 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 03:16:17 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 03:16:17 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 03:16:17 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 03:16:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:16:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:16:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:16:19 INFO - Installing collected packages: mozsystemmonitor 03:16:19 INFO - Running setup.py install for mozsystemmonitor 03:16:19 INFO - Successfully installed mozsystemmonitor 03:16:19 INFO - Cleaning up... 03:16:19 INFO - Return code: 0 03:16:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:16:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2486030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2747180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27453b0>, '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 0x27462b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2746740>, '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': '745a4373a2a16df560f216e000000264-1468836957.856193-325568411', '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 03:16:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:16:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:16:19 INFO - Using env: {'DISPLAY': ':0', 03:16:19 INFO - 'HOME': '/home/cltbld', 03:16:19 INFO - 'LANG': 'en_US.UTF-8', 03:16:19 INFO - 'LANGUAGE': 'en_US:en', 03:16:19 INFO - 'LOGNAME': 'cltbld', 03:16:19 INFO - 'MAIL': '/var/mail/cltbld', 03:16:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:19 INFO - 'MOZ_NO_REMOTE': '1', 03:16:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:19 INFO - 'NO_EM_RESTART': '1', 03:16:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:19 INFO - 'PWD': '/builds/slave/test', 03:16:19 INFO - 'SHELL': '/bin/bash', 03:16:19 INFO - 'SHLVL': '1', 03:16:19 INFO - 'TERM': 'linux', 03:16:19 INFO - 'TMOUT': '86400', 03:16:19 INFO - 'USER': 'cltbld', 03:16:19 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468836957.856193-325568411', 03:16:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:19 INFO - '_': '/tools/buildbot/bin/python'} 03:16:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:19 INFO - Downloading/unpacking jsonschema==2.5.1 03:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:16:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:16:21 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 03:16:21 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 03:16:21 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 03:16:21 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 03:16:21 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 03:16:21 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 03:16:21 INFO - Downloading functools32-3.2.3-2.tar.gz 03:16:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:16:21 INFO - warning: no files found matching '*.txt' 03:16:21 INFO - no previously-included directories found matching 'build' 03:16:21 INFO - no previously-included directories found matching 'dist' 03:16:21 INFO - no previously-included directories found matching '.git*' 03:16:22 INFO - Installing collected packages: jsonschema, functools32 03:16:22 INFO - Running setup.py install for functools32 03:16:22 INFO - warning: no files found matching '*.txt' 03:16:22 INFO - no previously-included directories found matching 'build' 03:16:22 INFO - no previously-included directories found matching 'dist' 03:16:22 INFO - no previously-included directories found matching '.git*' 03:16:22 INFO - Successfully installed jsonschema functools32 03:16:22 INFO - Cleaning up... 03:16:22 INFO - Return code: 0 03:16:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:16: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2486030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2747180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27453b0>, '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 0x27462b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2746740>, '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': '745a4373a2a16df560f216e000000264-1468836957.856193-325568411', '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 03:16:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:16:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:16:22 INFO - Using env: {'DISPLAY': ':0', 03:16:22 INFO - 'HOME': '/home/cltbld', 03:16:22 INFO - 'LANG': 'en_US.UTF-8', 03:16:22 INFO - 'LANGUAGE': 'en_US:en', 03:16:22 INFO - 'LOGNAME': 'cltbld', 03:16:22 INFO - 'MAIL': '/var/mail/cltbld', 03:16:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:22 INFO - 'MOZ_NO_REMOTE': '1', 03:16:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:22 INFO - 'NO_EM_RESTART': '1', 03:16:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:22 INFO - 'PWD': '/builds/slave/test', 03:16:22 INFO - 'SHELL': '/bin/bash', 03:16:22 INFO - 'SHLVL': '1', 03:16:22 INFO - 'TERM': 'linux', 03:16:22 INFO - 'TMOUT': '86400', 03:16:22 INFO - 'USER': 'cltbld', 03:16:22 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468836957.856193-325568411', 03:16:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:22 INFO - '_': '/tools/buildbot/bin/python'} 03:16:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:22 INFO - Downloading/unpacking blobuploader==1.2.4 03:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:24 INFO - Downloading blobuploader-1.2.4.tar.gz 03:16:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:16:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:16:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:25 INFO - Downloading docopt-0.6.1.tar.gz 03:16:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:16:25 INFO - Installing collected packages: blobuploader, requests, docopt 03:16:25 INFO - Running setup.py install for blobuploader 03:16:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:16:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:16:25 INFO - Running setup.py install for requests 03:16:25 INFO - Running setup.py install for docopt 03:16:25 INFO - Successfully installed blobuploader requests docopt 03:16:25 INFO - Cleaning up... 03:16:25 INFO - Return code: 0 03:16:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:16:25 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:25 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:25 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 0x2486030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2747180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27453b0>, '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 0x27462b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2746740>, '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': '745a4373a2a16df560f216e000000264-1468836957.856193-325568411', '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 03:16:25 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 03:16:25 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 03:16:25 INFO - Using env: {'DISPLAY': ':0', 03:16:25 INFO - 'HOME': '/home/cltbld', 03:16:25 INFO - 'LANG': 'en_US.UTF-8', 03:16:25 INFO - 'LANGUAGE': 'en_US:en', 03:16:25 INFO - 'LOGNAME': 'cltbld', 03:16:25 INFO - 'MAIL': '/var/mail/cltbld', 03:16:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:25 INFO - 'MOZ_NO_REMOTE': '1', 03:16:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:25 INFO - 'NO_EM_RESTART': '1', 03:16:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:25 INFO - 'PWD': '/builds/slave/test', 03:16:25 INFO - 'SHELL': '/bin/bash', 03:16:25 INFO - 'SHLVL': '1', 03:16:25 INFO - 'TERM': 'linux', 03:16:25 INFO - 'TMOUT': '86400', 03:16:25 INFO - 'USER': 'cltbld', 03:16:25 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468836957.856193-325568411', 03:16:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:25 INFO - '_': '/tools/buildbot/bin/python'} 03:16:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:16:25 INFO - Running setup.py (path:/tmp/pip-LqqGdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:16:25 INFO - Running setup.py (path:/tmp/pip-piqoT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:16:26 INFO - Running setup.py (path:/tmp/pip-y2b_us-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:16:26 INFO - Running setup.py (path:/tmp/pip-VyWgXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:16:26 INFO - Running setup.py (path:/tmp/pip-Ge8fwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:16:26 INFO - Running setup.py (path:/tmp/pip-eCu07d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:16:26 INFO - Running setup.py (path:/tmp/pip-Srm4eI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:16:26 INFO - Running setup.py (path:/tmp/pip-qrFlNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:16:26 INFO - Running setup.py (path:/tmp/pip-p8bHp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:16:26 INFO - Running setup.py (path:/tmp/pip-HmGMTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:16:26 INFO - Running setup.py (path:/tmp/pip-aVGuF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:16:26 INFO - Running setup.py (path:/tmp/pip-9DJceM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:16:26 INFO - Running setup.py (path:/tmp/pip-9UO33x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:16:26 INFO - Running setup.py (path:/tmp/pip-Bu8GWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:26 INFO - Running setup.py (path:/tmp/pip-AToDjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:16:27 INFO - Running setup.py (path:/tmp/pip-h2Ovon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:16:27 INFO - Running setup.py (path:/tmp/pip-tlatFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:16:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:16:27 INFO - Running setup.py install for manifestparser 03:16:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:16:27 INFO - Running setup.py install for mozcrash 03:16:27 INFO - Running setup.py install for mozdebug 03:16:27 INFO - Running setup.py install for mozdevice 03:16:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:16:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:16:27 INFO - Running setup.py install for mozfile 03:16:27 INFO - Running setup.py install for mozhttpd 03:16:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:16:27 INFO - Running setup.py install for mozinfo 03:16:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:16:27 INFO - Running setup.py install for mozInstall 03:16:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:16:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:16:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:16:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:16:27 INFO - Running setup.py install for mozleak 03:16:28 INFO - Running setup.py install for mozlog 03:16:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:16:28 INFO - Running setup.py install for moznetwork 03:16:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:16:28 INFO - Running setup.py install for mozprocess 03:16:28 INFO - Running setup.py install for mozprofile 03:16:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:16:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:16:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:16:28 INFO - Running setup.py install for mozrunner 03:16:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:16:28 INFO - Running setup.py install for mozscreenshot 03:16:28 INFO - Running setup.py install for moztest 03:16:28 INFO - Running setup.py install for mozversion 03:16:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:16:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:16:28 INFO - Cleaning up... 03:16:28 INFO - Return code: 0 03:16:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:16:28 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:28 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:28 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 0x2486030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2747180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27453b0>, '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 0x27462b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2746740>, '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': '745a4373a2a16df560f216e000000264-1468836957.856193-325568411', '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 03:16:28 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 03:16:28 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 03:16:28 INFO - Using env: {'DISPLAY': ':0', 03:16:28 INFO - 'HOME': '/home/cltbld', 03:16:28 INFO - 'LANG': 'en_US.UTF-8', 03:16:28 INFO - 'LANGUAGE': 'en_US:en', 03:16:28 INFO - 'LOGNAME': 'cltbld', 03:16:28 INFO - 'MAIL': '/var/mail/cltbld', 03:16:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:28 INFO - 'MOZ_NO_REMOTE': '1', 03:16:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:28 INFO - 'NO_EM_RESTART': '1', 03:16:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:28 INFO - 'PWD': '/builds/slave/test', 03:16:28 INFO - 'SHELL': '/bin/bash', 03:16:28 INFO - 'SHLVL': '1', 03:16:28 INFO - 'TERM': 'linux', 03:16:28 INFO - 'TMOUT': '86400', 03:16:28 INFO - 'USER': 'cltbld', 03:16:28 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468836957.856193-325568411', 03:16:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:28 INFO - '_': '/tools/buildbot/bin/python'} 03:16:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:16:29 INFO - Running setup.py (path:/tmp/pip-ZN_niR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:16:29 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)) 03:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:16:29 INFO - Running setup.py (path:/tmp/pip-W2jhAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:16:29 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)) 03:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:16:29 INFO - Running setup.py (path:/tmp/pip-xZP14q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:16:29 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)) 03:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:16:29 INFO - Running setup.py (path:/tmp/pip-DHlDsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:16:29 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)) 03:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:16:29 INFO - Running setup.py (path:/tmp/pip-Mw0iY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:16:29 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)) 03:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:16:29 INFO - Running setup.py (path:/tmp/pip-eqmrD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:16:29 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)) 03:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:16:29 INFO - Running setup.py (path:/tmp/pip-u6piBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:16:29 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)) 03:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:16:29 INFO - Running setup.py (path:/tmp/pip-rZ2938-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:16:29 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)) 03:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:16:29 INFO - Running setup.py (path:/tmp/pip-V6U2ZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:16:29 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)) 03:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:16:29 INFO - Running setup.py (path:/tmp/pip-n6RTX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:16:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 03:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:16:29 INFO - Running setup.py (path:/tmp/pip-0gFunw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:16:29 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)) 03:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:16:29 INFO - Running setup.py (path:/tmp/pip-DNRSIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:16:30 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)) 03:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:16:30 INFO - Running setup.py (path:/tmp/pip-s08T42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:16:30 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)) 03:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:16:30 INFO - Running setup.py (path:/tmp/pip-2SHX_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:16:30 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)) 03:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:30 INFO - Running setup.py (path:/tmp/pip-RpNX4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:30 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)) 03:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:16:30 INFO - Running setup.py (path:/tmp/pip-tsQHIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:16:30 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)) 03:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:16:30 INFO - Running setup.py (path:/tmp/pip-ZJRQBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:16:30 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)) 03:16:30 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)) 03:16:30 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)) 03:16:30 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)) 03:16:30 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)) 03:16:30 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)) 03:16:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16:32 INFO - Downloading blessings-1.6.tar.gz 03:16:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:16:32 INFO - Installing collected packages: blessings 03:16:32 INFO - Running setup.py install for blessings 03:16:32 INFO - Successfully installed blessings 03:16:32 INFO - Cleaning up... 03:16:32 INFO - Return code: 0 03:16:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:16:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:16:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:16:32 INFO - Reading from file tmpfile_stdout 03:16:32 INFO - Current package versions: 03:16:32 INFO - argparse == 1.2.1 03:16:32 INFO - blessings == 1.6 03:16:32 INFO - blobuploader == 1.2.4 03:16:32 INFO - docopt == 0.6.1 03:16:32 INFO - functools32 == 3.2.3-2 03:16:32 INFO - jsonschema == 2.5.1 03:16:32 INFO - manifestparser == 1.1 03:16:32 INFO - mozInstall == 1.12 03:16:32 INFO - mozcrash == 0.17 03:16:32 INFO - mozdebug == 0.1 03:16:32 INFO - mozdevice == 0.48 03:16:32 INFO - mozfile == 1.2 03:16:32 INFO - mozhttpd == 0.7 03:16:32 INFO - mozinfo == 0.9 03:16:32 INFO - mozleak == 0.1 03:16:32 INFO - mozlog == 3.2 03:16:32 INFO - moznetwork == 0.27 03:16:32 INFO - mozprocess == 0.23 03:16:32 INFO - mozprofile == 0.28 03:16:32 INFO - mozrunner == 6.12 03:16:32 INFO - mozscreenshot == 0.1 03:16:32 INFO - mozsystemmonitor == 0.3 03:16:32 INFO - moztest == 0.7 03:16:32 INFO - mozversion == 1.4 03:16:32 INFO - psutil == 3.1.1 03:16:32 INFO - requests == 1.2.3 03:16:32 INFO - wsgiref == 0.1.2 03:16:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:16: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:32 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 0x2486030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2747180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27453b0>, '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 0x27462b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2746740>, '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': '745a4373a2a16df560f216e000000264-1468836957.856193-325568411', '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 03:16:32 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 03:16:32 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 03:16:32 INFO - Using env: {'DISPLAY': ':0', 03:16:32 INFO - 'HOME': '/home/cltbld', 03:16:32 INFO - 'LANG': 'en_US.UTF-8', 03:16:32 INFO - 'LANGUAGE': 'en_US:en', 03:16:32 INFO - 'LOGNAME': 'cltbld', 03:16:32 INFO - 'MAIL': '/var/mail/cltbld', 03:16:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:32 INFO - 'MOZ_NO_REMOTE': '1', 03:16:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:32 INFO - 'NO_EM_RESTART': '1', 03:16:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:32 INFO - 'PWD': '/builds/slave/test', 03:16:32 INFO - 'SHELL': '/bin/bash', 03:16:32 INFO - 'SHLVL': '1', 03:16:32 INFO - 'TERM': 'linux', 03:16:32 INFO - 'TMOUT': '86400', 03:16:32 INFO - 'USER': 'cltbld', 03:16:32 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468836957.856193-325568411', 03:16:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:32 INFO - '_': '/tools/buildbot/bin/python'} 03:16:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:32 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)) 03:16:32 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)) 03:16:32 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)) 03:16:32 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)) 03:16:32 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)) 03:16:32 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)) 03:16:32 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)) 03:16:32 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)) 03:16:32 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)) 03:16:32 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)) 03:16:32 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)) 03:16:32 INFO - Cleaning up... 03:16:33 INFO - Return code: 0 03:16:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:16:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:33 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 0x2486030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2747180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27453b0>, '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 0x27462b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2746740>, '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': '745a4373a2a16df560f216e000000264-1468836957.856193-325568411', '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 03:16:33 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 03:16:33 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 03:16:33 INFO - Using env: {'DISPLAY': ':0', 03:16:33 INFO - 'HOME': '/home/cltbld', 03:16:33 INFO - 'LANG': 'en_US.UTF-8', 03:16:33 INFO - 'LANGUAGE': 'en_US:en', 03:16:33 INFO - 'LOGNAME': 'cltbld', 03:16:33 INFO - 'MAIL': '/var/mail/cltbld', 03:16:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:33 INFO - 'MOZ_NO_REMOTE': '1', 03:16:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:33 INFO - 'NO_EM_RESTART': '1', 03:16:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:33 INFO - 'PWD': '/builds/slave/test', 03:16:33 INFO - 'SHELL': '/bin/bash', 03:16:33 INFO - 'SHLVL': '1', 03:16:33 INFO - 'TERM': 'linux', 03:16:33 INFO - 'TMOUT': '86400', 03:16:33 INFO - 'USER': 'cltbld', 03:16:33 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468836957.856193-325568411', 03:16:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:33 INFO - '_': '/tools/buildbot/bin/python'} 03:16:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:16:33 INFO - Cleaning up... 03:16:33 INFO - Return code: 0 03:16:33 INFO - Running post-action listener: _resource_record_post_action 03:16:33 INFO - Running post-action listener: _start_resource_monitoring 03:16:33 INFO - Starting resource monitoring. 03:16:33 INFO - ##### 03:16:33 INFO - ##### Finished create-virtualenv step (success) 03:16:33 INFO - ##### 03:16:33 INFO - ##### 03:16:33 INFO - ##### Running install step. 03:16:33 INFO - ##### 03:16:33 INFO - Running pre-action listener: _resource_record_pre_action 03:16:33 INFO - Running main action method: install 03:16:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:16:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:16:33 INFO - Reading from file tmpfile_stdout 03:16:33 INFO - Detecting whether we're running mozinstall >=1.0... 03:16:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:16:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:16:33 INFO - Reading from file tmpfile_stdout 03:16:33 INFO - Output received: 03:16:33 INFO - Usage: mozinstall [options] installer 03:16:33 INFO - Options: 03:16:33 INFO - -h, --help show this help message and exit 03:16:33 INFO - -d DEST, --destination=DEST 03:16:33 INFO - Directory to install application into. [default: 03:16:33 INFO - "/builds/slave/test"] 03:16:33 INFO - --app=APP Application being installed. [default: firefox] 03:16:33 INFO - mkdir: /builds/slave/test/build/application 03:16:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:16:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:16:51 INFO - Reading from file tmpfile_stdout 03:16:51 INFO - Output received: 03:16:51 INFO - /builds/slave/test/build/application/firefox/firefox 03:16:51 INFO - Running post-action listener: _resource_record_post_action 03:16:51 INFO - ##### 03:16:51 INFO - ##### Finished install step (success) 03:16:51 INFO - ##### 03:16:51 INFO - ##### 03:16:51 INFO - ##### Running run-tests step. 03:16:51 INFO - ##### 03:16:51 INFO - Running pre-action listener: _resource_record_pre_action 03:16:51 INFO - Running main action method: run_tests 03:16:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:16:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:16:51 INFO - Python 2.7.3 03:16:51 INFO - Return code: 0 03:16:51 INFO - grabbing minidump binary from tooltool 03:16:51 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:51 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 0x27453b0>, '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 0x27462b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2746740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:16:51 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 03:16:51 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 03:16:51 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 03:16:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:16:51 INFO - Return code: 0 03:16:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:16:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:16:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:16:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:16:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:16:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/apnqKzxMSxuxzw_gH8AJQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:16:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/apnqKzxMSxuxzw_gH8AJQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:16:51 INFO - Using env: {'DISPLAY': ':0', 03:16:51 INFO - 'HOME': '/home/cltbld', 03:16:51 INFO - 'LANG': 'en_US.UTF-8', 03:16:51 INFO - 'LANGUAGE': 'en_US:en', 03:16:51 INFO - 'LOGNAME': 'cltbld', 03:16:51 INFO - 'MAIL': '/var/mail/cltbld', 03:16:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:16:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:16:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:51 INFO - 'MOZ_NO_REMOTE': '1', 03:16:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:16:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:51 INFO - 'NO_EM_RESTART': '1', 03:16:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:51 INFO - 'PWD': '/builds/slave/test', 03:16:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:16:51 INFO - 'SHELL': '/bin/bash', 03:16:51 INFO - 'SHLVL': '1', 03:16:51 INFO - 'TERM': 'linux', 03:16:51 INFO - 'TMOUT': '86400', 03:16:51 INFO - 'USER': 'cltbld', 03:16:51 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468836957.856193-325568411', 03:16:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:51 INFO - '_': '/tools/buildbot/bin/python'} 03:16:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/apnqKzxMSxuxzw_gH8AJQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:16:52 INFO - mozversion application_buildid: 20160718003001 03:16:52 INFO - mozversion application_changeset: ec74ba5a1d15f796c640e6df9632261547904185 03:16:52 INFO - mozversion application_display_name: Nightly 03:16:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:16:52 INFO - mozversion application_name: Firefox 03:16:52 INFO - mozversion application_remotingname: firefox 03:16:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 03:16:52 INFO - mozversion application_vendor: Mozilla 03:16:52 INFO - mozversion application_version: 50.0a1 03:16:52 INFO - mozversion platform_buildid: 20160718003001 03:16:52 INFO - mozversion platform_changeset: ec74ba5a1d15f796c640e6df9632261547904185 03:16:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 03:16:52 INFO - mozversion platform_version: 50.0a1 03:16:52 INFO - using testdate: 1468837012 03:16:52 INFO - actual date: 1468837012 03:16:52 INFO - starting webserver on 'localhost:34449' 03:16:52 INFO - SUITE-START | Running 2 tests 03:16:52 INFO - TEST-START | dromaeo_css 03:16:52 INFO - operating with platform_type : linux_ 03:16:52 INFO - Initialising browser for dromaeo_css test... 03:16:52 INFO - TEST-INFO | started process 31635 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1pZIv1/profile http://localhost:34449/getInfo.html) 03:16:56 INFO - PROCESS | 31635 | JavaScript error: , line 0: uncaught exception: undefined 03:16:57 INFO - PROCESS | 31635 | __metrics Screen width/height:1600/1200 03:16:57 INFO - PROCESS | 31635 | colorDepth:24 03:16:57 INFO - PROCESS | 31635 | Browser inner width/height: 1024/697 03:16:57 INFO - PROCESS | 31635 | __metrics 03:16:58 ERROR - PROCESS | 31635 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 03:16:59 INFO - TEST-INFO | 31635: exit 0 03:16:59 INFO - Browser initialized. 03:16:59 INFO - Running cycle 1/1 for dromaeo_css test... 03:16:59 INFO - TEST-INFO | started process 31757 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1pZIv1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:17:11 INFO - PROCESS | 31757 | RSS: Main: 168587264 03:17:11 INFO - PROCESS | 31757 | 03:18:00 INFO - PROCESS | 31757 | 1468837080951 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] 03:20:08 INFO - PROCESS | 31757 | Cycle 1(1): loaded http://localhost:34449/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34449/tests/dromaeo/cssquery-ext.html) 03:20:10 INFO - PROCESS | 31757 | RSS: Main: 172474368 03:20:10 INFO - PROCESS | 31757 | 03:23:12 INFO - PROCESS | 31757 | Cycle 1(1): loaded http://localhost:34449/tests/dromaeo/cssquery-ext.html (next: http://localhost:34449/tests/dromaeo/cssquery-jquery.html) 03:23:12 INFO - PROCESS | 31757 | RSS: Main: 168820736 03:23:12 INFO - PROCESS | 31757 | 03:26:14 INFO - PROCESS | 31757 | Cycle 1(1): loaded http://localhost:34449/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34449/tests/dromaeo/cssquery-mootools.html) 03:26:15 INFO - PROCESS | 31757 | RSS: Main: 173273088 03:26:15 INFO - PROCESS | 31757 | 03:29:17 INFO - PROCESS | 31757 | Cycle 1(1): loaded http://localhost:34449/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34449/tests/dromaeo/cssquery-prototype.html) 03:29:17 INFO - PROCESS | 31757 | RSS: Main: 167657472 03:29:17 INFO - PROCESS | 31757 | 03:32:20 INFO - PROCESS | 31757 | Cycle 1(1): loaded http://localhost:34449/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34449/tests/dromaeo/cssquery-yui.html) 03:32:20 INFO - PROCESS | 31757 | RSS: Main: 169422848 03:32:20 INFO - PROCESS | 31757 | 03:35:23 INFO - PROCESS | 31757 | Cycle 1(1): loaded http://localhost:34449/tests/dromaeo/cssquery-yui.html (next: http://localhost:34449/tests/dromaeo/cssquery-dojo.html) 03:35:23 INFO - PROCESS | 31757 | RSS: Main: 172314624 03:35:23 INFO - PROCESS | 31757 | 03:35:23 INFO - PROCESS | 31757 | __start_tp_report 03:35:23 INFO - PROCESS | 31757 | _x_x_mozilla_page_load 03:35:23 INFO - PROCESS | 31757 | _x_x_mozilla_page_load_details 03:35:23 INFO - PROCESS | 31757 | |i|pagename|runs| 03:35:23 INFO - PROCESS | 31757 | |0;dojo.html;3117.703818137277;3121.2821051158226;3135.890243841466;3138.4664607016803;3141.74866010719;5480.890382192359;5486.039943009972;5515.558755299577;5542.307211598551;5593.776248950047;5397.541208997231;5442.619016668835;5446.509814116729;5485;5502.2296878437055;4914.262860570916;4948.57937075349;5040.143175660147;5103.5917126629965;5156.149235376159;783.9050407504369;4939.333190019355;5081.8221362252325;5136.049830781299;5148.794048238066;4914.992426552548;4954.677945933521;4964.5531902128805;4975.3283306753665;4978.551930326288;4843.4430040545085;4920.0651876143775;4967.279744437073;4989.201727723546;5033.219850923113;4895.094407534618;4912.926306105375;4913.8771530711665;4926.975365123151;4934.703917764946;5437.102878025121;5536.529395001389;5546.639468434539;5549.556035517149;5565.721713914329;5828.1549175369755;5861.17943487912;5888.411158884077;5900.64596124234;5914.378990206053;5869.442402971711;5922;5938.910916336258;5967;6013.428724271231;5530.5022547970875;5554.86112847178;5571.4150014248735;5591.133374326986;5591.2731344925305;5729.140628905614;5992.760289588455;5995.700214989321;6062.696865156725;6063.272407311151;5793.391693872167;5803.245578074823;5815.302163740378;5817.970910145506;5837.737301821428;5827.096799996008;5827.155062515912;5837.29952405714;5844.6785426801935;5852;5721.199032135504;5871.383504732027;5899.174115623816;5932.110183472428;5982.850428739316;5714.5999780015;5902.970485147547;5912.822615321547;5960.850978725566;5978.910316345171;4525.547445255514;4531.161735078955;4542.046170304207;4557.498675145731;4580.24425969718;3880.767153970771;3991.461152744342;3991.720579559403;4029.3351596986754;4050.9189816204102;5747.25285712863;5762.222100016528;5768.567357448208;5772.336181339199;5797.507211887037;5997.280326360865;6009.2188015557695;6026.578139530191;6066.75732970685;6089.878202436015;5401.135818269058;5647.943520564824;5661.235733176051;5676.318841739017;5692.0608099663095;5060.49395060491;5115;5116.641835071584;5121.231815227746;5140.768665410065;5867.031939729982;6157.384261573807;6158.938410615926;6165.876682466325;6166.7224974876235;5963.314218864886;6014.759409623566;6038.3357830637715;6069.119977603311;6075.1191077294425;6176.950831550867;6203.875922481616;6237.906431403442;6251.749930002749;6252.093446450148;5656.123300888369;5797.362290147996;5917.754757649836;5918.911216331845;5980.850478738066;5951;6005.6396616203165;6033.547483938634;6074.969625151846;6087.360827113266;5855.3559108497175;5878.647281163144;5924.585279030599;5929.733162007634;5931.851703707442;5680.715964201856;5733.512651424676;5750.424957504216;5899.764009439575;5916.3492015877355;5450.727463626724;5479.753411096431;5688.601797874109;5710.771569137354;5838.737256823538;5704.486596206361;5752.539796816328;5829.650220986754;5832.94167058324;5845.766169353178;5563.721813909207;5677.659340439587;5682.516986056066;5737.48362647347;5747.166660834239 03:35:23 INFO - PROCESS | 31757 | |1;ext.html;555.1865327609627;591.2727345365204;598.8712426828232;609.4332270987982;611.5505103748744;32026.879059232902;35891.82054089729;46784.76607616965;48000.519994800045;48061.75969120158;46466;47373.526264737346;47377.28934065992;47542.762286188605;47616;8993.010768815442;9160;9160.267178625727;9172.357934944557;9190.908090919105;8932.374733768638;9014.188723014928;9064.410813297147;9100.907891053082;9103.271738260923;9086.136817002407;9147.679831205909;9152;9156.679516216935;9161.587728552231;9011.819763604692;9031.142041506046;9053.683121090764;9103.271738260957;9147.954260228722;8931;8978.461292322416;8982;8985.775355616097;8995.5052472114;43643.12713745707;43746.34380484295;44037;44095;44201;3805.2009078093633;3810.1427178884805;3821.7515861468914;4069.3285607874664;4343.826246950118;34016.82991585026;34026.31947361064;34155.487667685;34422.655773442195;35886.46170307448;4123.134141830219;4330.2638551446325;4427.158839820424;4451.198784218839;4529.592336689714;297546;396418;398661;399004.9999999971;399508;32023.51964720531;63317.366826332065;63792.68103659545;64073.35926640674;64165.67917160384;37104.25791484155;37188;37366;37434.62565374366;37556;14874.107553546823;14976.775348369783;15020.624484387978;15046.247687615576;15084.396624135132;12492.312922789151;12521.186122902165;12527.123101382998;12569.685757856127;12573.434195461226;8302.418830681794;8387.496750195009;8389.916100838913;8437.789055273544;8450.577471126418;3206.823624700617;3218.6459489456142;3222.3072039511617;3256.951145732816;3263.379957808009;1076.6178006807627;1083.989160108389;1100.5982816272162;1148.5807680196835;1161.1117495116243;33803.83098084494;34123.829380852934;34317.313653726786;34547.82726086354;34594.308113837586;1097.3032124600777;1106.9391183484986;1107.900288973996;1125.8797496491045;1170.5668902506127;17487.475375738748;17601.471955841345;17695.646087078185;17768.423578581034;17823;592745;596678;597446;598704;599660;40517.797411013344;41550;41768.37347439791;41792;41836.372454413206;1340.0686522866708;1357.830271216098;1364.4814970311218;1369.794530820365;1381.053978025056;30931.381372371976;33350.66649333476;33358.33283334368;33429.66570334265;33431.33137337289;53226.4677353237;53469.19796202982;53564.73217633887;53574.46425535851;54029.189562155814;362039;367518;369981;371900;372263;28725.138245852657;29031.419371612872;29482.262943426587;29564.852175738983;29633.25916852096;49534.50465495299;50538.2419263704;50707.74646126746;50742.74628626981;52022.47977520176;42034.78982605068;43352.78323608362;43492.782536087114;43819.34270985874;44653.10693786171;42424.78787606042;42426.787866061706;42457.67264190319;43041.569584303754;43198.13603727845;36687.816560918094;41823.37264940968;41917.37123943205;42783.57216427796;42912;35650;38649.80675096719;38736.61263387443;39097.8045109784;39345.60654393419;29188.854055729586;29394;29512.262193444476;29597.408051839273;29794 03:35:23 INFO - PROCESS | 31757 | |2;jquery.html;376.3357673705911;382.7646544181978;383.2297082863444;394.5718894998926;403.6084997552375;17752.467425977226;19743.901280493577;20144.09351579179;20164;20172.991350432476;18843.717344239813;19014;19587;20248.29130980416;20317.0857311421;5777.508911742497;5839.941600583982;5929.88140237195;5934.406559344075;5983.730732117066;5706.457886500776;5731.426857314256;5777.942220577783;5782;5783.5084017858535;5759.049756790125;5764.913526297109;5820.679862607576;5834.416558344153;5837.1536127261525;5568.777248910039;5765.884682306372;5769.076947688371;5775;5830.154627578999;5086.77109530072;5143.5113664201845;5157.7936882524655;5174.301469301634;5183.144781111112;23497.76502234973;24038.15866444666;24087.277381678578;24405.145819896396;24594.385140371454;2173.7717539658424;2292.6331786914016;2295;2411.770881766229;2472.950540989188;9978.900210997943;10157.796844063078;10220.233482488844;10242.53908574116;10313.27807053499;1947.1043320072642;2041.3773798991301;2062.83497320214;2065.493953981269;2074.471009892483;85819.57090214572;88602.5569872153;88836.55581722115;90375;91096.54451727765;10436.686899392878;10549.103326217204;10907.945460272807;10935.343879367263;11038.448077596087;14960.0275982063;14998.850011499964;15027;15054.473093441897;15169.24153792306;7905.841883162305;8358.665653373919;8368.079511253758;8447.32421406286;8467.153284671607;8005.919940800634;8129.105798362176;8191.262786349257;8277.172282771795;8297.875531867026;4518.6611004174165;4555.9772201138785;4592.691083041317;4597.287420449836;4618.745968971672;1880.8213219744102;1912.407153782332;1943.6112777444569;1963.9312624058089;1966.1742068331334;1000.5047501486665;1033.3076838518061;1059.5761695321778;1071.4696225368493;1090.9618163364244;18747.812521874606;19898.50253743668;19949.60100797976;20100.497487562636;20203.898980505004;978.1392374710351;982.8574856645746;1012.9240306977006;1035.9326643768131;1047.0942634621;10632.468376581295;11223.38271395081;11238.21332506733;11287.49206285719;11307.151963602762;510259;510456;517989;522601;524171;94988.57517137249;95002.524987376;95027.52486237524;95775;95868.52065739626;994.9253805964581;1011.9494025298706;1017.6539976408205;1020.4795554267378;1026.697124348319;17103.657926841643;17439.56401089983;17852.285908563514;17916.10419479047;18119;30646.84676576603;42132.78933605312;43247.9188020302;44211.55788442074;46857;56502;64359.35640643721;64554;65948.67025664842;66504.6674766623;8416.789580260542;8480.872786908325;8485.703000394957;8646.308295336485;8685.478871267744;12580.748385032432;13849.307534623431;13915.930420347833;14305.070170438888;14325.068870523382;12364.341666541737;12478.688032799253;12563.87436125627;12702.491900324254;12816.487340506648;11815.291082535075;12068.758624827278;12086.576969806014;12324.383780810744;12342.938285308875;12528.37358132108;12558.932490738389;12628;12711.237325760483;12992.415341309475;8520.233179013918;8679.826403472021;8730.083341249077;8749.08134645853;8823.955880220557;11184.94407527957;11731.47208375608;12161.756764864476;12320.137590368946;12645.747085058063 03:35:23 INFO - PROCESS | 31757 | |3;mootools.html;1480.4078368652538;1517.1124891938216;1661.5596866830285;1789.5526118470382;1800.2618926240236;7805.843883122348;8704.521251331182;8715.128487151282;9349.345545811795;9368.765780855474;8774.605142768574;9028.41315314504;9093.63625454981;9125.771855703611;9131.817363652723;2330.312557795446;2359.6932398788217;2361;2365.7515960824126;2402.6396040593963;2330.533893221354;2357.3635118518077;2412.264259400882;2422.358075110097;2424.9272521824373;2368.3250273672006;2380.809535237177;2392.820538459614;2419.6128619420897;2432.5621388150125;2296.2996286132725;2297.8046866016407;2305.6772051912744;2308.0998410619873;2332.0555175153922;2257.0520381439833;2257.198694463458;2272.091163534583;2282.349530383849;2284.1776960294283;8982.10178982103;9083.909930808279;9105.726828195166;9129.954350228272;9133.543322833899;5060.949390506122;5100.923486147711;5133.589312855;5148.716820574867;5156.767945442464;3453.3611281912677;3597.172650290448;3680.907977300562;3691.8154092295276;3711.77729336238;1148.0987424871437;1179.1569028144918;1186.371223251678;1193.7791508570856;1212.6422705301957;11681.824772628417;11759.17685761997;11774.411279435993;11777.941110294394;11787.528498860036;4414.580614841585;4556.749378784199;4664.043871006504;4665.136949664323;4674.859754207379;10059.5473203706;10085.142762865093;10122.240831937634;10150.543225554868;10165.644202452879;5300.522952934178;5312.973435132877;5316.73416329182;5316.813911513079;5333.146696528537;4273.188094262143;4827.903441931212;4834.395700537433;4963.181075122637;4984.850454486371;3860.2665493556133;3907.3943538751537;4023.2239754569255;4071.206114807584;4126.566710495415;1262.3372729316998;1280.1423046558828;1282.8460584729892;1295.0675513630172;1297.54585894936;879.8020445399862;974.288769198489;979.8383266761048;993.096282383028;1005.4771518810178;6206.379362063848;6259.4679452246155;6475.902861457082;6494.6103233806125;6496.155499785093;445.3097698567208;448.7285192458581;453.0712040317402;456.4203461603745;457.1611093643202;4455.910881782411;4475.351074094238;4497.730136191839;4502.212112880233;4515.893606066535;11024.50389732464;11280.379579123062;11333.489992950172;11416.086713062936;11416.37209953444;10393.324433911772;10843.945780271048;10911.890881091247;11187.888121118847;11208.21542492034;8217.424780265324;8447.95776021116;8469.74590762278;8471.322294216448;8480.957595211985;6203.4416902479;6595.208574970842;6626.072349871119;6663.067170596023;6688.3646053624825;9801.85297220528;10221.28451008452;10404.791904162026;10530.526126324487;10563.683089507327;10294.124999375137;10386.584536618451;10444.582216711246;10500.894991050298;10545.630902918669;7109.075820143348;7793.727219547289;8016.278534931884;8061.4760040597175;8304.792380190544;8806;8860.512671803113;8867.0689577596;8906;8941.687040953535;7897.368210543258;8125.268725814705;8147.877781833158;8157.79605509867;8194.057683366489;7802.29779319864;7912.762617121495;7943.721969731032;7981.880271796043;8053.959730201312;6733.3939945405145;6763.7632682855865;6838.726450942106;6840.213375461885;7060.470464715064;5307.734613269398;5321.988822123784;5527.088030474926;5638.323401191719;5645.350784659652;5339.626226164287;5353.866153346197;5359.946400535945;5454.59090568201;5489.862753431196 03:35:23 INFO - PROCESS | 31757 | |4;prototype.html;307.28249537330345;320.51602080857907;324.8343344894103;326.7794238888751;327.8360819590205;5180.171172612383;5699.857503562403;5714.942850571493;5780.393058728836;5788.392218817022;5529.391766905637;5570.86072848179;5588.552915766739;5588.804391846286;5593.916440998064;4375.234333991555;4379.211741886459;4389.429374181352;4391.9341209881795;4396.802143903532;4113.424120623115;4369.519352871182;4412.183746006999;4414.22751018572;4415.66882483815;4271.444712187411;4296.183725092238;4302.784860756965;4309.470138100976;4311.8706438806885;4313.598080623794;4321.654267658596;4323.119443042287;4328.437303150602;4354.86773438905;3774.358359078963;3778.376567866299;3799.1831756172555;3804.448354988539;3807.6382743639588;5219.556337711299;5463.470228336033;5492;5496.395396506381;5566.805161819358;4926.704397736147;4944.431390390115;4962.975185124052;4966.081274964107;4973.104841128596;5720.427957204246;5822.446867547576;5909.940900590982;5920.763169473216;5936.7031648417405;4120.670346372283;4126.133511962492;4132.462779838632;4136.607022332903;4152.875413737593;5782.335031471351;5830.621009634403;6083.209182806251;6085.756569737206;6122.448979591813;4139.710220284612;4142.212979533879;4149.398337241144;4157.958420415817;4164.4586203793915;4189.162167566499;4190.601892820238;4195.098053918422;4226.36604509326;4243.215005224043;4805.447373552016;4867.148249056401;4918.262260660858;4928.581070608967;4937.456879743226;5898.469137777534;5900.557458190653;5915.733791979371;5937.732802023919;5959.374265702126;1438.4965262158162;1443.220660843133;1447.3703938786662;1452.7893455449112;1464.1727424005403;892.3797960417447;916.5234078279391;930.181440332503;940;946.7159852044359;5089.821856235014;5101.719405432663;5107.693538387634;5143;5143.871403214949;5277.709725965032;5322.92015619766;5415;5436.945630543644;5469.07025805614;5047;5113.769880355393;5118.718470484085;5372.677639341652;5844.853878653068;3228.2090887732656;3254.4792833147058;3255.8046517209045;3265.5264986576813;3267.2648654053123;6063.787767428207;6283.5287353448675;6308.463780578611;6335.904961425582;6356.555041147075;6227.221597300338;6227.314995350508;6229;6246.219827349184;6281.905771413432;6273.086708553935;6275.717592708339;6315.55791094619;6334.9683251584365;6356.396142366468;5854.482572493868;6090.23872015998;6090.502893813516;6090.786822461369;6119.510439164945;6019.18740969981;6025.397460253939;6034.577579569388;6040.275166979991;6078.115784106941;6011.579189456696;6011.969940150271;6205.968970155121;6260.779148066265;6265.929694449595;4203.852865149705;4204.927743425407;4210.789460527023;4236.597523235288;4262.126264115786;5814.215080964016;6105.755769769159;6171.84570385744;6200.472959798287;6210.534209934182;5904.409559044061;5959.73181206838;5966.164736936746;5996.670183139795;6009.429104235091;5822.243108395882;5913.58604897653;5938.762449502145;5944.910826337695;5954.434328738763;5665.745041473226;5849.093390524476;5863.73613187399;5882.323532793784;5900.318409253342;5981.7607295707685;5982.252218472691;6001.359401863167;6007.579469437097;6033.547483938634;5595.132754423071;5787.479126878601;5880.176775251553;5906;5908.586398952032 03:35:23 INFO - PROCESS | 31757 | |5;yui.html;734.6951015328639;769.630577322885;775.6121939030485;834.5368320582074;858.0989960541432;15245.466408675698;15738.291776870039;16098.75851862223;16107.516774496755;16113.838861611395;15394.538163855073;15517.224138793043;15517.689646207069;15517.92241038796;15527.068375897454;638.4286063972753;782.182619162976;801.9318357939553;802.2859654907137;809.6194788449419;793.1513280789558;803.2850762821093;808.022293025437;808.1030056637128;809.3039985612398;844.7170197983683;851.9574021298941;852.0797538658265;853.0914575976597;854.6026097864492;844.2486187293314;844.4342290665269;845.9915400845974;846.6317152038882;848.245061894914;619.5291578400403;620.3672254300589;621.3599992008238;622.0948519903529;623.5697368815503;15217.31522081509;15305.846941530664;15379.692406151815;15381.615459613487;15430.3827846886;15684.137372444511;15988.840111598967;16042.679146417124;16049.598760030976;16056;12373.392823352531;12375;12474.126811123226;12503.812442813365;12677.492900283978;3915.7846318452475;3919.431682406035;3941.467901833273;3945.5265368156006;4027.7180597357906;78740.60629696872;78980;79656.60171699163;79744.99999999942;80437;11908.345041022654;11993.88006119945;12020.63938081859;12059.095567832448;12248.20386674881;19961;20435;20459.59080818375;21708.89145554262;21723.456913577287;7895.407844411692;7981.72063977758;8162.918370816335;8208.507489550646;8536.274416674529;4924.482929292372;4941.703497790072;4974.253861920741;5021.271915572222;5085.440601533828;3731.5149030625844;3803.904902377463;3835.67396771272;3864.14988702485;3864.2271545690974;627.2410383436094;639.6226226526372;650.5576208178389;658.7628453756644;664.3257094049544;696.4393663101151;753.3784627682185;768.873135932576;781.5662307419436;793.6111305460283;10269.7432564185;10292.588296468208;10417.791644167226;10695.090917271964;10836.945815270874;628.7139351595014;640.6316368088368;667.506045526307;706.9717211311593;779.1701837542998;4865.829695960624;5013.473585273494;5032.295478632995;5170.870728231825;5209.244659524347;92280;125416.37291813483;127133.36433317959;127237;127495.07534472497;107312;110343;110534.44732776284;110670;112003;87601.56199219091;87839.1216087831;89122;92576.53711731399;94983.52508237415;9455.527223638928;9474.147326740627;9657.758556036155;9732.610695572097;10086.509840618715;47019.76490117527;52154.47845521648;52940.73529632481;53433;54058.729706351216;57190.14214786698;66105.66947165233;74450.62774686092;74813.62593187217;75470.62264688642;13680.93159534196;13738.725225495235;13833.930830345784;13851.792223116863;13983.091099078527;15432.757978393145;15757.763633545277;15988.280527376064;16069.116198609188;16481.093539855425;14429.92785036068;14686.265686715407;14870.182139981973;15002.099874007594;15449.104189773587;14435.78346324827;14454.27728613586;14864.62838429048;14918.32867520986;14926.626834329229;14710.705785884436;15096.622584435478;15153.24233788284;15180.848191518386;15209.695806083595;11592.536298547964;11746.706332341419;11821.349825759322;12156.209846359958;12215.206011609573;12218.327991960528;12275.754484910072;12464.626061218178;12500.867152272083;12811.423485943342 03:35:23 INFO - PROCESS | 31757 | __end_tp_report 03:35:23 INFO - PROCESS | 31757 | __start_cc_report 03:35:23 INFO - PROCESS | 31757 | _x_x_mozilla_cycle_collect,375 03:35:23 INFO - PROCESS | 31757 | __end_cc_report 03:35:23 INFO - PROCESS | 31757 | __startTimestamp1468838123807__endTimestamp 03:35:23 INFO - PROCESS | 31757 | 03:35:23 INFO - PROCESS | 31757 | ------- Summary: start ------- 03:35:23 INFO - PROCESS | 31757 | Number of tests: 6 03:35:23 INFO - PROCESS | 31757 | 03:35:23 INFO - PROCESS | 31757 | [#0] dojo.html Cycles:165 Average:5473.32 Median:5733.51 stddev:745.88 (13.0%) stddev-sans-first:724.92 03:35:23 INFO - PROCESS | 31757 | Values: 3117.7 3121.3 3135.9 3138.5 3141.7 5480.9 5486.0 5515.6 5542.3 5593.8 5397.5 5442.6 5446.5 5485.0 5502.2 4914.3 4948.6 5040.1 5103.6 5156.1 783.9 4939.3 5081.8 5136.0 5148.8 4915.0 4954.7 4964.6 4975.3 4978.6 4843.4 4920.1 4967.3 4989.2 5033.2 4895.1 4912.9 4913.9 4927.0 4934.7 5437.1 5536.5 5546.6 5549.6 5565.7 5828.2 5861.2 5888.4 5900.6 5914.4 5869.4 5922.0 5938.9 5967.0 6013.4 5530.5 5554.9 5571.4 5591.1 5591.3 5729.1 5992.8 5995.7 6062.7 6063.3 5793.4 5803.2 5815.3 5818.0 5837.7 5827.1 5827.2 5837.3 5844.7 5852.0 5721.2 5871.4 5899.2 5932.1 5982.9 5714.6 5903.0 5912.8 5960.9 5978.9 4525.5 4531.2 4542.0 4557.5 4580.2 3880.8 3991.5 3991.7 4029.3 4050.9 5747.3 5762.2 5768.6 5772.3 5797.5 5997.3 6009.2 6026.6 6066.8 6089.9 5401.1 5647.9 5661.2 5676.3 5692.1 5060.5 5115.0 5116.6 5121.2 5140.8 5867.0 6157.4 6158.9 6165.9 6166.7 5963.3 6014.8 6038.3 6069.1 6075.1 6177.0 6203.9 6237.9 6251.7 6252.1 5656.1 5797.4 5917.8 5918.9 5980.9 5951.0 6005.6 6033.5 6075.0 6087.4 5855.4 5878.6 5924.6 5929.7 5931.9 5680.7 5733.5 5750.4 5899.8 5916.3 5450.7 5479.8 5688.6 5710.8 5838.7 5704.5 5752.5 5829.7 5832.9 5845.8 5563.7 5677.7 5682.5 5737.5 5747.2 03:35:23 INFO - PROCESS | 31757 | 03:35:23 INFO - PROCESS | 31757 | [#1] ext.html Cycles:180 Average:59968.57 Median:41659.19 stddev:122699.91 (294.5%) stddev-sans-first:122963.03 03:35:23 INFO - PROCESS | 31757 | Values: 555.2 591.3 598.9 609.4 611.6 32026.9 35891.8 46784.8 48000.5 48061.8 46466.0 47373.5 47377.3 47542.8 47616.0 8993.0 9160.0 9160.3 9172.4 9190.9 8932.4 9014.2 9064.4 9100.9 9103.3 9086.1 9147.7 9152.0 9156.7 9161.6 9011.8 9031.1 9053.7 9103.3 9148.0 8931.0 8978.5 8982.0 8985.8 8995.5 43643.1 43746.3 44037.0 44095.0 44201.0 3805.2 3810.1 3821.8 4069.3 4343.8 34016.8 34026.3 34155.5 34422.7 35886.5 4123.1 4330.3 4427.2 4451.2 4529.6 297546.0 396418.0 398661.0 399005.0 399508.0 32023.5 63317.4 63792.7 64073.4 64165.7 37104.3 37188.0 37366.0 37434.6 37556.0 14874.1 14976.8 15020.6 15046.2 15084.4 12492.3 12521.2 12527.1 12569.7 12573.4 8302.4 8387.5 8389.9 8437.8 8450.6 3206.8 3218.6 3222.3 3257.0 3263.4 1076.6 1084.0 1100.6 1148.6 1161.1 33803.8 34123.8 34317.3 34547.8 34594.3 1097.3 1106.9 1107.9 1125.9 1170.6 17487.5 17601.5 17695.6 17768.4 17823.0 592745.0 596678.0 597446.0 598704.0 599660.0 40517.8 41550.0 41768.4 41792.0 41836.4 1340.1 1357.8 1364.5 1369.8 1381.1 30931.4 33350.7 33358.3 33429.7 33431.3 53226.5 53469.2 53564.7 53574.5 54029.2 362039.0 367518.0 369981.0 371900.0 372263.0 28725.1 29031.4 29482.3 29564.9 29633.3 49534.5 50538.2 50707.7 50742.7 52022.5 42034.8 43352.8 43492.8 43819.3 44653.1 42424.8 42426.8 42457.7 43041.6 43198.1 36687.8 41823.4 41917.4 42783.6 42912.0 35650.0 38649.8 38736.6 39097.8 39345.6 29188.9 29394.0 29512.3 29597.4 29794.0 03:35:23 INFO - PROCESS | 31757 | 03:35:23 INFO - PROCESS | 31757 | [#2] jquery.html Cycles:180 Average:30386.40 Median:24062.72 stddev:85367.76 (354.8%) stddev-sans-first:85577.50 03:35:23 INFO - PROCESS | 31757 | Values: 376.3 382.8 383.2 394.6 403.6 17752.5 19743.9 20144.1 20164.0 20173.0 18843.7 19014.0 19587.0 20248.3 20317.1 5777.5 5839.9 5929.9 5934.4 5983.7 5706.5 5731.4 5777.9 5782.0 5783.5 5759.0 5764.9 5820.7 5834.4 5837.2 5568.8 5765.9 5769.1 5775.0 5830.2 5086.8 5143.5 5157.8 5174.3 5183.1 23497.8 24038.2 24087.3 24405.1 24594.4 2173.8 2292.6 2295.0 2411.8 2473.0 9978.9 10157.8 10220.2 10242.5 10313.3 1947.1 2041.4 2062.8 2065.5 2074.5 85819.6 88602.6 88836.6 90375.0 91096.5 10436.7 10549.1 10907.9 10935.3 11038.4 14960.0 14998.9 15027.0 15054.5 15169.2 7905.8 8358.7 8368.1 8447.3 8467.2 8005.9 8129.1 8191.3 8277.2 8297.9 4518.7 4556.0 4592.7 4597.3 4618.7 1880.8 1912.4 1943.6 1963.9 1966.2 1000.5 1033.3 1059.6 1071.5 1091.0 18747.8 19898.5 19949.6 20100.5 20203.9 978.1 982.9 1012.9 1035.9 1047.1 10632.5 11223.4 11238.2 11287.5 11307.2 510259.0 510456.0 517989.0 522601.0 524171.0 94988.6 95002.5 95027.5 95775.0 95868.5 994.9 1011.9 1017.7 1020.5 1026.7 17103.7 17439.6 17852.3 17916.1 18119.0 30646.8 42132.8 43247.9 44211.6 46857.0 56502.0 64359.4 64554.0 65948.7 66504.7 8416.8 8480.9 8485.7 8646.3 8685.5 12580.7 13849.3 13915.9 14305.1 14325.1 12364.3 12478.7 12563.9 12702.5 12816.5 11815.3 12068.8 12086.6 12324.4 12342.9 12528.4 12558.9 12628.0 12711.2 12992.4 8520.2 8679.8 8730.1 8749.1 8824.0 11184.9 11731.5 12161.8 12320.1 12645.7 03:35:23 INFO - PROCESS | 31757 | 03:35:23 INFO - PROCESS | 31757 | [#3] mootools.html Cycles:180 Average:5910.59 Median:2506.58 stddev:3338.37 (133.2%) stddev-sans-first:3331.13 03:35:23 INFO - PROCESS | 31757 | Values: 1480.4 1517.1 1661.6 1789.6 1800.3 7805.8 8704.5 8715.1 9349.3 9368.8 8774.6 9028.4 9093.6 9125.8 9131.8 2330.3 2359.7 2361.0 2365.8 2402.6 2330.5 2357.4 2412.3 2422.4 2424.9 2368.3 2380.8 2392.8 2419.6 2432.6 2296.3 2297.8 2305.7 2308.1 2332.1 2257.1 2257.2 2272.1 2282.3 2284.2 8982.1 9083.9 9105.7 9130.0 9133.5 5060.9 5100.9 5133.6 5148.7 5156.8 3453.4 3597.2 3680.9 3691.8 3711.8 1148.1 1179.2 1186.4 1193.8 1212.6 11681.8 11759.2 11774.4 11777.9 11787.5 4414.6 4556.7 4664.0 4665.1 4674.9 10059.5 10085.1 10122.2 10150.5 10165.6 5300.5 5313.0 5316.7 5316.8 5333.1 4273.2 4827.9 4834.4 4963.2 4984.9 3860.3 3907.4 4023.2 4071.2 4126.6 1262.3 1280.1 1282.8 1295.1 1297.5 879.8 974.3 979.8 993.1 1005.5 6206.4 6259.5 6475.9 6494.6 6496.2 445.3 448.7 453.1 456.4 457.2 4455.9 4475.4 4497.7 4502.2 4515.9 11024.5 11280.4 11333.5 11416.1 11416.4 10393.3 10843.9 10911.9 11187.9 11208.2 8217.4 8448.0 8469.7 8471.3 8481.0 6203.4 6595.2 6626.1 6663.1 6688.4 9801.9 10221.3 10404.8 10530.5 10563.7 10294.1 10386.6 10444.6 10500.9 10545.6 7109.1 7793.7 8016.3 8061.5 8304.8 8806.0 8860.5 8867.1 8906.0 8941.7 7897.4 8125.3 8147.9 8157.8 8194.1 7802.3 7912.8 7943.7 7981.9 8054.0 6733.4 6763.8 6838.7 6840.2 7060.5 5307.7 5322.0 5527.1 5638.3 5645.4 5339.6 5353.9 5359.9 5454.6 5489.9 03:35:23 INFO - PROCESS | 31757 | 03:35:23 INFO - PROCESS | 31757 | [#4] prototype.html Cycles:180 Average:4904.99 Median:5568.83 stddev:1471.29 (26.4%) stddev-sans-first:1434.38 03:35:23 INFO - PROCESS | 31757 | Values: 307.3 320.5 324.8 326.8 327.8 5180.2 5699.9 5714.9 5780.4 5788.4 5529.4 5570.9 5588.6 5588.8 5593.9 4375.2 4379.2 4389.4 4391.9 4396.8 4113.4 4369.5 4412.2 4414.2 4415.7 4271.4 4296.2 4302.8 4309.5 4311.9 4313.6 4321.7 4323.1 4328.4 4354.9 3774.4 3778.4 3799.2 3804.4 3807.6 5219.6 5463.5 5492.0 5496.4 5566.8 4926.7 4944.4 4963.0 4966.1 4973.1 5720.4 5822.4 5909.9 5920.8 5936.7 4120.7 4126.1 4132.5 4136.6 4152.9 5782.3 5830.6 6083.2 6085.8 6122.4 4139.7 4142.2 4149.4 4158.0 4164.5 4189.2 4190.6 4195.1 4226.4 4243.2 4805.4 4867.1 4918.3 4928.6 4937.5 5898.5 5900.6 5915.7 5937.7 5959.4 1438.5 1443.2 1447.4 1452.8 1464.2 892.4 916.5 930.2 940.0 946.7 5089.8 5101.7 5107.7 5143.0 5143.9 5277.7 5322.9 5415.0 5436.9 5469.1 5047.0 5113.8 5118.7 5372.7 5844.9 3228.2 3254.5 3255.8 3265.5 3267.3 6063.8 6283.5 6308.5 6335.9 6356.6 6227.2 6227.3 6229.0 6246.2 6281.9 6273.1 6275.7 6315.6 6335.0 6356.4 5854.5 6090.2 6090.5 6090.8 6119.5 6019.2 6025.4 6034.6 6040.3 6078.1 6011.6 6012.0 6206.0 6260.8 6265.9 4203.9 4204.9 4210.8 4236.6 4262.1 5814.2 6105.8 6171.8 6200.5 6210.5 5904.4 5959.7 5966.2 5996.7 6009.4 5822.2 5913.6 5938.8 5944.9 5954.4 5665.7 5849.1 5863.7 5882.3 5900.3 5981.8 5982.3 6001.4 6007.6 6033.5 5595.1 5787.5 5880.2 5906.0 5908.6 03:35:23 INFO - PROCESS | 31757 | 03:35:23 INFO - PROCESS | 31757 | [#5] yui.html Cycles:180 Average:21703.67 Median:3917.61 stddev:31419.40 (802.0%) stddev-sans-first:31468.09 03:35:23 INFO - PROCESS | 31757 | Values: 734.7 769.6 775.6 834.5 858.1 15245.5 15738.3 16098.8 16107.5 16113.8 15394.5 15517.2 15517.7 15517.9 15527.1 638.4 782.2 801.9 802.3 809.6 793.2 803.3 808.0 808.1 809.3 844.7 852.0 852.1 853.1 854.6 844.2 844.4 846.0 846.6 848.2 619.5 620.4 621.4 622.1 623.6 15217.3 15305.8 15379.7 15381.6 15430.4 15684.1 15988.8 16042.7 16049.6 16056.0 12373.4 12375.0 12474.1 12503.8 12677.5 3915.8 3919.4 3941.5 3945.5 4027.7 78740.6 78980.0 79656.6 79745.0 80437.0 11908.3 11993.9 12020.6 12059.1 12248.2 19961.0 20435.0 20459.6 21708.9 21723.5 7895.4 7981.7 8162.9 8208.5 8536.3 4924.5 4941.7 4974.3 5021.3 5085.4 3731.5 3803.9 3835.7 3864.1 3864.2 627.2 639.6 650.6 658.8 664.3 696.4 753.4 768.9 781.6 793.6 10269.7 10292.6 10417.8 10695.1 10836.9 628.7 640.6 667.5 707.0 779.2 4865.8 5013.5 5032.3 5170.9 5209.2 92280.0 125416.4 127133.4 127237.0 127495.1 107312.0 110343.0 110534.4 110670.0 112003.0 87601.6 87839.1 89122.0 92576.5 94983.5 9455.5 9474.1 9657.8 9732.6 10086.5 47019.8 52154.5 52940.7 53433.0 54058.7 57190.1 66105.7 74450.6 74813.6 75470.6 13680.9 13738.7 13833.9 13851.8 13983.1 15432.8 15757.8 15988.3 16069.1 16481.1 14429.9 14686.3 14870.2 15002.1 15449.1 14435.8 14454.3 14864.6 14918.3 14926.6 14710.7 15096.6 15153.2 15180.8 15209.7 11592.5 11746.7 11821.3 12156.2 12215.2 12218.3 12275.8 12464.6 12500.9 12811.4 03:35:23 INFO - PROCESS | 31757 | -------- Summary: end -------- 03:35:23 INFO - PROCESS | 31757 | 03:35:24 INFO - TEST-INFO | 31757: exit 0 03:35:24 INFO - TEST-OK | dromaeo_css | took 1112489ms 03:35:24 INFO - TEST-START | kraken 03:35:24 INFO - operating with platform_type : linux_ 03:35:24 INFO - Initialising browser for kraken test... 03:35:24 INFO - TEST-INFO | started process 32003 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW8D8CT/profile http://localhost:34449/getInfo.html) 03:35:28 INFO - PROCESS | 32003 | JavaScript error: , line 0: uncaught exception: undefined 03:35:29 INFO - PROCESS | 32003 | __metrics Screen width/height:1600/1200 03:35:29 INFO - PROCESS | 32003 | colorDepth:24 03:35:29 INFO - PROCESS | 32003 | Browser inner width/height: 1024/697 03:35:29 INFO - PROCESS | 32003 | __metrics 03:35:30 ERROR - PROCESS | 32003 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 03:35:31 INFO - TEST-INFO | 32003: exit 0 03:35:31 INFO - Browser initialized. 03:35:31 INFO - Running cycle 1/1 for kraken test... 03:35:31 INFO - TEST-INFO | started process 32124 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW8D8CT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:35:43 INFO - PROCESS | 32124 | RSS: Main: 168501248 03:35:43 INFO - PROCESS | 32124 | 03:35:45 INFO - PROCESS | 32124 | Cycle 1(1): loaded http://localhost:34449/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34449/tests/kraken/driver.html?testName=audio-beat-detection) 03:35:46 INFO - PROCESS | 32124 | RSS: Main: 173088768 03:35:46 INFO - PROCESS | 32124 | 03:35:49 INFO - PROCESS | 32124 | Cycle 1(1): loaded http://localhost:34449/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34449/tests/kraken/driver.html?testName=audio-dft) 03:35:49 INFO - PROCESS | 32124 | RSS: Main: 172900352 03:35:49 INFO - PROCESS | 32124 | 03:35:52 INFO - PROCESS | 32124 | Cycle 1(1): loaded http://localhost:34449/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34449/tests/kraken/driver.html?testName=audio-fft) 03:35:53 INFO - PROCESS | 32124 | RSS: Main: 167149568 03:35:53 INFO - PROCESS | 32124 | 03:35:55 INFO - PROCESS | 32124 | Cycle 1(1): loaded http://localhost:34449/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34449/tests/kraken/driver.html?testName=audio-oscillator) 03:35:55 INFO - PROCESS | 32124 | RSS: Main: 168189952 03:35:55 INFO - PROCESS | 32124 | 03:35:58 INFO - PROCESS | 32124 | Cycle 1(1): loaded http://localhost:34449/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34449/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:35:58 INFO - PROCESS | 32124 | RSS: Main: 168468480 03:35:58 INFO - PROCESS | 32124 | 03:36:01 INFO - PROCESS | 32124 | Cycle 1(1): loaded http://localhost:34449/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34449/tests/kraken/driver.html?testName=imaging-darkroom) 03:36:02 INFO - PROCESS | 32124 | RSS: Main: 168542208 03:36:02 INFO - PROCESS | 32124 | 03:36:05 INFO - PROCESS | 32124 | Cycle 1(1): loaded http://localhost:34449/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34449/tests/kraken/driver.html?testName=imaging-desaturate) 03:36:06 INFO - PROCESS | 32124 | RSS: Main: 169394176 03:36:06 INFO - PROCESS | 32124 | 03:36:09 INFO - PROCESS | 32124 | Cycle 1(1): loaded http://localhost:34449/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34449/tests/kraken/driver.html?testName=json-parse-financial) 03:36:10 INFO - PROCESS | 32124 | RSS: Main: 169062400 03:36:10 INFO - PROCESS | 32124 | 03:36:11 INFO - PROCESS | 32124 | Cycle 1(1): loaded http://localhost:34449/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34449/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:36:12 INFO - PROCESS | 32124 | RSS: Main: 169197568 03:36:12 INFO - PROCESS | 32124 | 03:36:14 INFO - PROCESS | 32124 | Cycle 1(1): loaded http://localhost:34449/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34449/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:36:14 INFO - PROCESS | 32124 | RSS: Main: 169152512 03:36:14 INFO - PROCESS | 32124 | 03:36:16 INFO - PROCESS | 32124 | Cycle 1(1): loaded http://localhost:34449/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34449/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:36:17 INFO - PROCESS | 32124 | RSS: Main: 169619456 03:36:17 INFO - PROCESS | 32124 | 03:36:20 INFO - PROCESS | 32124 | Cycle 1(1): loaded http://localhost:34449/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34449/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:36:20 INFO - PROCESS | 32124 | RSS: Main: 169455616 03:36:20 INFO - PROCESS | 32124 | 03:36:23 INFO - PROCESS | 32124 | Cycle 1(1): loaded http://localhost:34449/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34449/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:36:24 INFO - PROCESS | 32124 | RSS: Main: 169684992 03:36:24 INFO - PROCESS | 32124 | 03:36:25 INFO - PROCESS | 32124 | Cycle 1(1): loaded http://localhost:34449/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34449/tests/kraken/driver.html?testName=ai-astar) 03:36:25 INFO - PROCESS | 32124 | RSS: Main: 170729472 03:36:25 INFO - PROCESS | 32124 | 03:36:25 INFO - PROCESS | 32124 | __start_tp_report 03:36:25 INFO - PROCESS | 32124 | _x_x_mozilla_page_load 03:36:25 INFO - PROCESS | 32124 | _x_x_mozilla_page_load_details 03:36:25 INFO - PROCESS | 32124 | |i|pagename|runs| 03:36:25 INFO - PROCESS | 32124 | |0;ai-astar;102;113;105;113;111;113;113;113;113;112 03:36:25 INFO - PROCESS | 32124 | |1;audio-beat-detection;157;118;148;187;117;147;149;119;187;122 03:36:25 INFO - PROCESS | 32124 | |2;audio-dft;163;163;164;163;161;166;168;168;164;164 03:36:25 INFO - PROCESS | 32124 | |3;audio-fft;75;76;76;157;77;76;75;76;170;76 03:36:25 INFO - PROCESS | 32124 | |4;audio-oscillator;84;84;150;85;86;84;131;84;84;164 03:36:25 INFO - PROCESS | 32124 | |5;imaging-gaussian-blur;117;117;117;117;117;117;118;117;118;118 03:36:25 INFO - PROCESS | 32124 | |6;imaging-darkroom;148;148;147;147;148;148;147;148;147;147 03:36:25 INFO - PROCESS | 32124 | |7;imaging-desaturate;96;97;95;96;96;96;96;96;95;95 03:36:25 INFO - PROCESS | 32124 | |8;json-parse-financial;53;54;54;54;55;53;53;52;53;52 03:36:25 INFO - PROCESS | 32124 | |9;json-stringify-tinderbox;62;63;63;62;64;63;62;62;62;63 03:36:25 INFO - PROCESS | 32124 | |10;stanford-crypto-aes;76;76;81;82;76;76;76;76;81;76 03:36:25 INFO - PROCESS | 32124 | |11;stanford-crypto-ccm;129;121;120;129;130;131;133;132;182;130 03:36:25 INFO - PROCESS | 32124 | |12;stanford-crypto-pbkdf2;160;164;158;159;158;161;159;164;160;163 03:36:25 INFO - PROCESS | 32124 | |13;stanford-crypto-sha256-iterative;71;63;64;64;63;64;66;63;69;63 03:36:25 INFO - PROCESS | 32124 | __end_tp_report 03:36:25 INFO - PROCESS | 32124 | __start_cc_report 03:36:25 INFO - PROCESS | 32124 | _x_x_mozilla_cycle_collect,916 03:36:25 INFO - PROCESS | 32124 | __end_cc_report 03:36:25 INFO - PROCESS | 32124 | __startTimestamp1468838185964__endTimestamp 03:36:25 INFO - PROCESS | 32124 | 03:36:25 INFO - PROCESS | 32124 | ------- Summary: start ------- 03:36:25 INFO - PROCESS | 32124 | Number of tests: 14 03:36:25 INFO - PROCESS | 32124 | 03:36:25 INFO - PROCESS | 32124 | [#0] ai-astar Cycles:10 Average:110.80 Median:113.00 stddev:3.97 (3.5%) stddev-sans-first:2.64 03:36:25 INFO - PROCESS | 32124 | Values: 102.0 113.0 105.0 113.0 111.0 113.0 113.0 113.0 113.0 112.0 03:36:25 INFO - PROCESS | 32124 | 03:36:25 INFO - PROCESS | 32124 | [#1] audio-beat-detection Cycles:10 Average:145.10 Median:148.50 stddev:26.71 (18.0%) stddev-sans-first:27.98 03:36:25 INFO - PROCESS | 32124 | Values: 157.0 118.0 148.0 187.0 117.0 147.0 149.0 119.0 187.0 122.0 03:36:25 INFO - PROCESS | 32124 | 03:36:25 INFO - PROCESS | 32124 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.00 stddev:2.27 (1.4%) stddev-sans-first:2.35 03:36:25 INFO - PROCESS | 32124 | Values: 163.0 163.0 164.0 163.0 161.0 166.0 168.0 168.0 164.0 164.0 03:36:25 INFO - PROCESS | 32124 | 03:36:25 INFO - PROCESS | 32124 | [#3] audio-fft Cycles:10 Average:93.40 Median:76.00 stddev:37.08 (48.8%) stddev-sans-first:38.72 03:36:25 INFO - PROCESS | 32124 | Values: 75.0 76.0 76.0 157.0 77.0 76.0 75.0 76.0 170.0 76.0 03:36:25 INFO - PROCESS | 32124 | 03:36:25 INFO - PROCESS | 32124 | [#4] audio-oscillator Cycles:10 Average:103.60 Median:84.00 stddev:31.85 (37.9%) stddev-sans-first:32.98 03:36:25 INFO - PROCESS | 32124 | Values: 84.0 84.0 150.0 85.0 86.0 84.0 131.0 84.0 84.0 164.0 03:36:25 INFO - PROCESS | 32124 | 03:36:25 INFO - PROCESS | 32124 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 03:36:25 INFO - PROCESS | 32124 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 118.0 118.0 03:36:25 INFO - PROCESS | 32124 | 03:36:25 INFO - PROCESS | 32124 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 03:36:25 INFO - PROCESS | 32124 | Values: 148.0 148.0 147.0 147.0 148.0 148.0 147.0 148.0 147.0 147.0 03:36:25 INFO - PROCESS | 32124 | 03:36:25 INFO - PROCESS | 32124 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 03:36:25 INFO - PROCESS | 32124 | Values: 96.0 97.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 03:36:25 INFO - PROCESS | 32124 | 03:36:25 INFO - PROCESS | 32124 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:53.50 stddev:0.95 (1.8%) stddev-sans-first:1.00 03:36:25 INFO - PROCESS | 32124 | Values: 53.0 54.0 54.0 54.0 55.0 53.0 53.0 52.0 53.0 52.0 03:36:25 INFO - PROCESS | 32124 | 03:36:25 INFO - PROCESS | 32124 | [#9] json-stringify-tinderbox Cycles:10 Average:62.60 Median:63.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 03:36:25 INFO - PROCESS | 32124 | Values: 62.0 63.0 63.0 62.0 64.0 63.0 62.0 62.0 62.0 63.0 03:36:25 INFO - PROCESS | 32124 | 03:36:25 INFO - PROCESS | 32124 | [#10] stanford-crypto-aes Cycles:10 Average:77.60 Median:76.00 stddev:2.59 (3.4%) stddev-sans-first:2.68 03:36:25 INFO - PROCESS | 32124 | Values: 76.0 76.0 81.0 82.0 76.0 76.0 76.0 76.0 81.0 76.0 03:36:25 INFO - PROCESS | 32124 | 03:36:25 INFO - PROCESS | 32124 | [#11] stanford-crypto-ccm Cycles:10 Average:133.70 Median:130.50 stddev:17.52 (13.4%) stddev-sans-first:18.51 03:36:25 INFO - PROCESS | 32124 | Values: 129.0 121.0 120.0 129.0 130.0 131.0 133.0 132.0 182.0 130.0 03:36:25 INFO - PROCESS | 32124 | 03:36:25 INFO - PROCESS | 32124 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.60 Median:160.50 stddev:2.32 (1.4%) stddev-sans-first:2.45 03:36:25 INFO - PROCESS | 32124 | Values: 160.0 164.0 158.0 159.0 158.0 161.0 159.0 164.0 160.0 163.0 03:36:25 INFO - PROCESS | 32124 | 03:36:25 INFO - PROCESS | 32124 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:64.00 stddev:2.83 (4.4%) stddev-sans-first:2.00 03:36:25 INFO - PROCESS | 32124 | Values: 71.0 63.0 64.0 64.0 63.0 64.0 66.0 63.0 69.0 63.0 03:36:25 INFO - PROCESS | 32124 | -------- Summary: end -------- 03:36:25 INFO - PROCESS | 32124 | 03:36:26 INFO - TEST-INFO | 32124: exit 0 03:36:27 INFO - TEST-OK | kraken | took 62423ms 03:36:27 INFO - SUITE-END | took 1174s 03:36:27 INFO - Completed test suite (00:19:35) 03:36:27 INFO - javascript benchmark 03:36:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7358.8631434024155, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3117.703818137277, 3121.2821051158226, 3135.890243841466, 3138.4664607016803, 3141.74866010719, 5480.890382192359, 5486.039943009972, 5515.558755299577, 5542.307211598551, 5593.776248950047, 5397.541208997231, 5442.619016668835, 5446.509814116729, 5485.0, 5502.2296878437055, 4914.262860570916, 4948.57937075349, 5040.143175660147, 5103.5917126629965, 5156.149235376159, 783.9050407504369, 4939.333190019355, 5081.8221362252325, 5136.049830781299, 5148.794048238066, 4914.992426552548, 4954.677945933521, 4964.5531902128805, 4975.3283306753665, 4978.551930326288, 4843.4430040545085, 4920.0651876143775, 4967.279744437073, 4989.201727723546, 5033.219850923113, 4895.094407534618, 4912.926306105375, 4913.8771530711665, 4926.975365123151, 4934.703917764946, 5437.102878025121, 5536.529395001389, 5546.639468434539, 5549.556035517149, 5565.721713914329, 5828.1549175369755, 5861.17943487912, 5888.411158884077, 5900.64596124234, 5914.378990206053, 5869.442402971711, 5922.0, 5938.910916336258, 5967.0, 6013.428724271231, 5530.5022547970875, 5554.86112847178, 5571.4150014248735, 5591.133374326986, 5591.2731344925305, 5729.140628905614, 5992.760289588455, 5995.700214989321, 6062.696865156725, 6063.272407311151, 5793.391693872167, 5803.245578074823, 5815.302163740378, 5817.970910145506, 5837.737301821428, 5827.096799996008, 5827.155062515912, 5837.29952405714, 5844.6785426801935, 5852.0, 5721.199032135504, 5871.383504732027, 5899.174115623816, 5932.110183472428, 5982.850428739316, 5714.5999780015, 5902.970485147547, 5912.822615321547, 5960.850978725566, 5978.910316345171, 4525.547445255514, 4531.161735078955, 4542.046170304207, 4557.498675145731, 4580.24425969718, 3880.767153970771, 3991.461152744342, 3991.720579559403, 4029.3351596986754, 4050.9189816204102, 5747.25285712863, 5762.222100016528, 5768.567357448208, 5772.336181339199, 5797.507211887037, 5997.280326360865, 6009.2188015557695, 6026.578139530191, 6066.75732970685, 6089.878202436015, 5401.135818269058, 5647.943520564824, 5661.235733176051, 5676.318841739017, 5692.0608099663095, 5060.49395060491, 5115.0, 5116.641835071584, 5121.231815227746, 5140.768665410065, 5867.031939729982, 6157.384261573807, 6158.938410615926, 6165.876682466325, 6166.7224974876235, 5963.314218864886, 6014.759409623566, 6038.3357830637715, 6069.119977603311, 6075.1191077294425, 6176.950831550867, 6203.875922481616, 6237.906431403442, 6251.749930002749, 6252.093446450148, 5656.123300888369, 5797.362290147996, 5917.754757649836, 5918.911216331845, 5980.850478738066, 5951.0, 6005.6396616203165, 6033.547483938634, 6074.969625151846, 6087.360827113266, 5855.3559108497175, 5878.647281163144, 5924.585279030599, 5929.733162007634, 5931.851703707442, 5680.715964201856, 5733.512651424676, 5750.424957504216, 5899.764009439575, 5916.3492015877355, 5450.727463626724, 5479.753411096431, 5688.601797874109, 5710.771569137354, 5838.737256823538, 5704.486596206361, 5752.539796816328, 5829.650220986754, 5832.94167058324, 5845.766169353178, 5563.721813909207, 5677.659340439587, 5682.516986056066, 5737.48362647347, 5747.166660834239], "value": 5423.046837030273, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.1865327609627, 591.2727345365204, 598.8712426828232, 609.4332270987982, 611.5505103748744, 32026.879059232902, 35891.82054089729, 46784.76607616965, 48000.519994800045, 48061.75969120158, 46466.0, 47373.526264737346, 47377.28934065992, 47542.762286188605, 47616.0, 8993.010768815442, 9160.0, 9160.267178625727, 9172.357934944557, 9190.908090919105, 8932.374733768638, 9014.188723014928, 9064.410813297147, 9100.907891053082, 9103.271738260923, 9086.136817002407, 9147.679831205909, 9152.0, 9156.679516216935, 9161.587728552231, 9011.819763604692, 9031.142041506046, 9053.683121090764, 9103.271738260957, 9147.954260228722, 8931.0, 8978.461292322416, 8982.0, 8985.775355616097, 8995.5052472114, 43643.12713745707, 43746.34380484295, 44037.0, 44095.0, 44201.0, 3805.2009078093633, 3810.1427178884805, 3821.7515861468914, 4069.3285607874664, 4343.826246950118, 34016.82991585026, 34026.31947361064, 34155.487667685, 34422.655773442195, 35886.46170307448, 4123.134141830219, 4330.2638551446325, 4427.158839820424, 4451.198784218839, 4529.592336689714, 297546.0, 396418.0, 398661.0, 399004.9999999971, 399508.0, 32023.51964720531, 63317.366826332065, 63792.68103659545, 64073.35926640674, 64165.67917160384, 37104.25791484155, 37188.0, 37366.0, 37434.62565374366, 37556.0, 14874.107553546823, 14976.775348369783, 15020.624484387978, 15046.247687615576, 15084.396624135132, 12492.312922789151, 12521.186122902165, 12527.123101382998, 12569.685757856127, 12573.434195461226, 8302.418830681794, 8387.496750195009, 8389.916100838913, 8437.789055273544, 8450.577471126418, 3206.823624700617, 3218.6459489456142, 3222.3072039511617, 3256.951145732816, 3263.379957808009, 1076.6178006807627, 1083.989160108389, 1100.5982816272162, 1148.5807680196835, 1161.1117495116243, 33803.83098084494, 34123.829380852934, 34317.313653726786, 34547.82726086354, 34594.308113837586, 1097.3032124600777, 1106.9391183484986, 1107.900288973996, 1125.8797496491045, 1170.5668902506127, 17487.475375738748, 17601.471955841345, 17695.646087078185, 17768.423578581034, 17823.0, 592745.0, 596678.0, 597446.0, 598704.0, 599660.0, 40517.797411013344, 41550.0, 41768.37347439791, 41792.0, 41836.372454413206, 1340.0686522866708, 1357.830271216098, 1364.4814970311218, 1369.794530820365, 1381.053978025056, 30931.381372371976, 33350.66649333476, 33358.33283334368, 33429.66570334265, 33431.33137337289, 53226.4677353237, 53469.19796202982, 53564.73217633887, 53574.46425535851, 54029.189562155814, 362039.0, 367518.0, 369981.0, 371900.0, 372263.0, 28725.138245852657, 29031.419371612872, 29482.262943426587, 29564.852175738983, 29633.25916852096, 49534.50465495299, 50538.2419263704, 50707.74646126746, 50742.74628626981, 52022.47977520176, 42034.78982605068, 43352.78323608362, 43492.782536087114, 43819.34270985874, 44653.10693786171, 42424.78787606042, 42426.787866061706, 42457.67264190319, 43041.569584303754, 43198.13603727845, 36687.816560918094, 41823.37264940968, 41917.37123943205, 42783.57216427796, 42912.0, 35650.0, 38649.80675096719, 38736.61263387443, 39097.8045109784, 39345.60654393419, 29188.854055729586, 29394.0, 29512.262193444476, 29597.408051839273, 29794.0], "value": 19237.978086047795, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.3357673705911, 382.7646544181978, 383.2297082863444, 394.5718894998926, 403.6084997552375, 17752.467425977226, 19743.901280493577, 20144.09351579179, 20164.0, 20172.991350432476, 18843.717344239813, 19014.0, 19587.0, 20248.29130980416, 20317.0857311421, 5777.508911742497, 5839.941600583982, 5929.88140237195, 5934.406559344075, 5983.730732117066, 5706.457886500776, 5731.426857314256, 5777.942220577783, 5782.0, 5783.5084017858535, 5759.049756790125, 5764.913526297109, 5820.679862607576, 5834.416558344153, 5837.1536127261525, 5568.777248910039, 5765.884682306372, 5769.076947688371, 5775.0, 5830.154627578999, 5086.77109530072, 5143.5113664201845, 5157.7936882524655, 5174.301469301634, 5183.144781111112, 23497.76502234973, 24038.15866444666, 24087.277381678578, 24405.145819896396, 24594.385140371454, 2173.7717539658424, 2292.6331786914016, 2295.0, 2411.770881766229, 2472.950540989188, 9978.900210997943, 10157.796844063078, 10220.233482488844, 10242.53908574116, 10313.27807053499, 1947.1043320072642, 2041.3773798991301, 2062.83497320214, 2065.493953981269, 2074.471009892483, 85819.57090214572, 88602.5569872153, 88836.55581722115, 90375.0, 91096.54451727765, 10436.686899392878, 10549.103326217204, 10907.945460272807, 10935.343879367263, 11038.448077596087, 14960.0275982063, 14998.850011499964, 15027.0, 15054.473093441897, 15169.24153792306, 7905.841883162305, 8358.665653373919, 8368.079511253758, 8447.32421406286, 8467.153284671607, 8005.919940800634, 8129.105798362176, 8191.262786349257, 8277.172282771795, 8297.875531867026, 4518.6611004174165, 4555.9772201138785, 4592.691083041317, 4597.287420449836, 4618.745968971672, 1880.8213219744102, 1912.407153782332, 1943.6112777444569, 1963.9312624058089, 1966.1742068331334, 1000.5047501486665, 1033.3076838518061, 1059.5761695321778, 1071.4696225368493, 1090.9618163364244, 18747.812521874606, 19898.50253743668, 19949.60100797976, 20100.497487562636, 20203.898980505004, 978.1392374710351, 982.8574856645746, 1012.9240306977006, 1035.9326643768131, 1047.0942634621, 10632.468376581295, 11223.38271395081, 11238.21332506733, 11287.49206285719, 11307.151963602762, 510259.0, 510456.0, 517989.0, 522601.0, 524171.0, 94988.57517137249, 95002.524987376, 95027.52486237524, 95775.0, 95868.52065739626, 994.9253805964581, 1011.9494025298706, 1017.6539976408205, 1020.4795554267378, 1026.697124348319, 17103.657926841643, 17439.56401089983, 17852.285908563514, 17916.10419479047, 18119.0, 30646.84676576603, 42132.78933605312, 43247.9188020302, 44211.55788442074, 46857.0, 56502.0, 64359.35640643721, 64554.0, 65948.67025664842, 66504.6674766623, 8416.789580260542, 8480.872786908325, 8485.703000394957, 8646.308295336485, 8685.478871267744, 12580.748385032432, 13849.307534623431, 13915.930420347833, 14305.070170438888, 14325.068870523382, 12364.341666541737, 12478.688032799253, 12563.87436125627, 12702.491900324254, 12816.487340506648, 11815.291082535075, 12068.758624827278, 12086.576969806014, 12324.383780810744, 12342.938285308875, 12528.37358132108, 12558.932490738389, 12628.0, 12711.237325760483, 12992.415341309475, 8520.233179013918, 8679.826403472021, 8730.083341249077, 8749.08134645853, 8823.955880220557, 11184.94407527957, 11731.47208375608, 12161.756764864476, 12320.137590368946, 12645.747085058063], "value": 9416.250194073304, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1480.4078368652538, 1517.1124891938216, 1661.5596866830285, 1789.5526118470382, 1800.2618926240236, 7805.843883122348, 8704.521251331182, 8715.128487151282, 9349.345545811795, 9368.765780855474, 8774.605142768574, 9028.41315314504, 9093.63625454981, 9125.771855703611, 9131.817363652723, 2330.312557795446, 2359.6932398788217, 2361.0, 2365.7515960824126, 2402.6396040593963, 2330.533893221354, 2357.3635118518077, 2412.264259400882, 2422.358075110097, 2424.9272521824373, 2368.3250273672006, 2380.809535237177, 2392.820538459614, 2419.6128619420897, 2432.5621388150125, 2296.2996286132725, 2297.8046866016407, 2305.6772051912744, 2308.0998410619873, 2332.0555175153922, 2257.0520381439833, 2257.198694463458, 2272.091163534583, 2282.349530383849, 2284.1776960294283, 8982.10178982103, 9083.909930808279, 9105.726828195166, 9129.954350228272, 9133.543322833899, 5060.949390506122, 5100.923486147711, 5133.589312855, 5148.716820574867, 5156.767945442464, 3453.3611281912677, 3597.172650290448, 3680.907977300562, 3691.8154092295276, 3711.77729336238, 1148.0987424871437, 1179.1569028144918, 1186.371223251678, 1193.7791508570856, 1212.6422705301957, 11681.824772628417, 11759.17685761997, 11774.411279435993, 11777.941110294394, 11787.528498860036, 4414.580614841585, 4556.749378784199, 4664.043871006504, 4665.136949664323, 4674.859754207379, 10059.5473203706, 10085.142762865093, 10122.240831937634, 10150.543225554868, 10165.644202452879, 5300.522952934178, 5312.973435132877, 5316.73416329182, 5316.813911513079, 5333.146696528537, 4273.188094262143, 4827.903441931212, 4834.395700537433, 4963.181075122637, 4984.850454486371, 3860.2665493556133, 3907.3943538751537, 4023.2239754569255, 4071.206114807584, 4126.566710495415, 1262.3372729316998, 1280.1423046558828, 1282.8460584729892, 1295.0675513630172, 1297.54585894936, 879.8020445399862, 974.288769198489, 979.8383266761048, 993.096282383028, 1005.4771518810178, 6206.379362063848, 6259.4679452246155, 6475.902861457082, 6494.6103233806125, 6496.155499785093, 445.3097698567208, 448.7285192458581, 453.0712040317402, 456.4203461603745, 457.1611093643202, 4455.910881782411, 4475.351074094238, 4497.730136191839, 4502.212112880233, 4515.893606066535, 11024.50389732464, 11280.379579123062, 11333.489992950172, 11416.086713062936, 11416.37209953444, 10393.324433911772, 10843.945780271048, 10911.890881091247, 11187.888121118847, 11208.21542492034, 8217.424780265324, 8447.95776021116, 8469.74590762278, 8471.322294216448, 8480.957595211985, 6203.4416902479, 6595.208574970842, 6626.072349871119, 6663.067170596023, 6688.3646053624825, 9801.85297220528, 10221.28451008452, 10404.791904162026, 10530.526126324487, 10563.683089507327, 10294.124999375137, 10386.584536618451, 10444.582216711246, 10500.894991050298, 10545.630902918669, 7109.075820143348, 7793.727219547289, 8016.278534931884, 8061.4760040597175, 8304.792380190544, 8806.0, 8860.512671803113, 8867.0689577596, 8906.0, 8941.687040953535, 7897.368210543258, 8125.268725814705, 8147.877781833158, 8157.79605509867, 8194.057683366489, 7802.29779319864, 7912.762617121495, 7943.721969731032, 7981.880271796043, 8053.959730201312, 6733.3939945405145, 6763.7632682855865, 6838.726450942106, 6840.213375461885, 7060.470464715064, 5307.734613269398, 5321.988822123784, 5527.088030474926, 5638.323401191719, 5645.350784659652, 5339.626226164287, 5353.866153346197, 5359.946400535945, 5454.59090568201, 5489.862753431196], "value": 4654.752195018322, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.28249537330345, 320.51602080857907, 324.8343344894103, 326.7794238888751, 327.8360819590205, 5180.171172612383, 5699.857503562403, 5714.942850571493, 5780.393058728836, 5788.392218817022, 5529.391766905637, 5570.86072848179, 5588.552915766739, 5588.804391846286, 5593.916440998064, 4375.234333991555, 4379.211741886459, 4389.429374181352, 4391.9341209881795, 4396.802143903532, 4113.424120623115, 4369.519352871182, 4412.183746006999, 4414.22751018572, 4415.66882483815, 4271.444712187411, 4296.183725092238, 4302.784860756965, 4309.470138100976, 4311.8706438806885, 4313.598080623794, 4321.654267658596, 4323.119443042287, 4328.437303150602, 4354.86773438905, 3774.358359078963, 3778.376567866299, 3799.1831756172555, 3804.448354988539, 3807.6382743639588, 5219.556337711299, 5463.470228336033, 5492.0, 5496.395396506381, 5566.805161819358, 4926.704397736147, 4944.431390390115, 4962.975185124052, 4966.081274964107, 4973.104841128596, 5720.427957204246, 5822.446867547576, 5909.940900590982, 5920.763169473216, 5936.7031648417405, 4120.670346372283, 4126.133511962492, 4132.462779838632, 4136.607022332903, 4152.875413737593, 5782.335031471351, 5830.621009634403, 6083.209182806251, 6085.756569737206, 6122.448979591813, 4139.710220284612, 4142.212979533879, 4149.398337241144, 4157.958420415817, 4164.4586203793915, 4189.162167566499, 4190.601892820238, 4195.098053918422, 4226.36604509326, 4243.215005224043, 4805.447373552016, 4867.148249056401, 4918.262260660858, 4928.581070608967, 4937.456879743226, 5898.469137777534, 5900.557458190653, 5915.733791979371, 5937.732802023919, 5959.374265702126, 1438.4965262158162, 1443.220660843133, 1447.3703938786662, 1452.7893455449112, 1464.1727424005403, 892.3797960417447, 916.5234078279391, 930.181440332503, 940.0, 946.7159852044359, 5089.821856235014, 5101.719405432663, 5107.693538387634, 5143.0, 5143.871403214949, 5277.709725965032, 5322.92015619766, 5415.0, 5436.945630543644, 5469.07025805614, 5047.0, 5113.769880355393, 5118.718470484085, 5372.677639341652, 5844.853878653068, 3228.2090887732656, 3254.4792833147058, 3255.8046517209045, 3265.5264986576813, 3267.2648654053123, 6063.787767428207, 6283.5287353448675, 6308.463780578611, 6335.904961425582, 6356.555041147075, 6227.221597300338, 6227.314995350508, 6229.0, 6246.219827349184, 6281.905771413432, 6273.086708553935, 6275.717592708339, 6315.55791094619, 6334.9683251584365, 6356.396142366468, 5854.482572493868, 6090.23872015998, 6090.502893813516, 6090.786822461369, 6119.510439164945, 6019.18740969981, 6025.397460253939, 6034.577579569388, 6040.275166979991, 6078.115784106941, 6011.579189456696, 6011.969940150271, 6205.968970155121, 6260.779148066265, 6265.929694449595, 4203.852865149705, 4204.927743425407, 4210.789460527023, 4236.597523235288, 4262.126264115786, 5814.215080964016, 6105.755769769159, 6171.84570385744, 6200.472959798287, 6210.534209934182, 5904.409559044061, 5959.73181206838, 5966.164736936746, 5996.670183139795, 6009.429104235091, 5822.243108395882, 5913.58604897653, 5938.762449502145, 5944.910826337695, 5954.434328738763, 5665.745041473226, 5849.093390524476, 5863.73613187399, 5882.323532793784, 5900.318409253342, 5981.7607295707685, 5982.252218472691, 6001.359401863167, 6007.579469437097, 6033.547483938634, 5595.132754423071, 5787.479126878601, 5880.176775251553, 5906.0, 5908.586398952032], "value": 4423.250267873759, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [734.6951015328639, 769.630577322885, 775.6121939030485, 834.5368320582074, 858.0989960541432, 15245.466408675698, 15738.291776870039, 16098.75851862223, 16107.516774496755, 16113.838861611395, 15394.538163855073, 15517.224138793043, 15517.689646207069, 15517.92241038796, 15527.068375897454, 638.4286063972753, 782.182619162976, 801.9318357939553, 802.2859654907137, 809.6194788449419, 793.1513280789558, 803.2850762821093, 808.022293025437, 808.1030056637128, 809.3039985612398, 844.7170197983683, 851.9574021298941, 852.0797538658265, 853.0914575976597, 854.6026097864492, 844.2486187293314, 844.4342290665269, 845.9915400845974, 846.6317152038882, 848.245061894914, 619.5291578400403, 620.3672254300589, 621.3599992008238, 622.0948519903529, 623.5697368815503, 15217.31522081509, 15305.846941530664, 15379.692406151815, 15381.615459613487, 15430.3827846886, 15684.137372444511, 15988.840111598967, 16042.679146417124, 16049.598760030976, 16056.0, 12373.392823352531, 12375.0, 12474.126811123226, 12503.812442813365, 12677.492900283978, 3915.7846318452475, 3919.431682406035, 3941.467901833273, 3945.5265368156006, 4027.7180597357906, 78740.60629696872, 78980.0, 79656.60171699163, 79744.99999999942, 80437.0, 11908.345041022654, 11993.88006119945, 12020.63938081859, 12059.095567832448, 12248.20386674881, 19961.0, 20435.0, 20459.59080818375, 21708.89145554262, 21723.456913577287, 7895.407844411692, 7981.72063977758, 8162.918370816335, 8208.507489550646, 8536.274416674529, 4924.482929292372, 4941.703497790072, 4974.253861920741, 5021.271915572222, 5085.440601533828, 3731.5149030625844, 3803.904902377463, 3835.67396771272, 3864.14988702485, 3864.2271545690974, 627.2410383436094, 639.6226226526372, 650.5576208178389, 658.7628453756644, 664.3257094049544, 696.4393663101151, 753.3784627682185, 768.873135932576, 781.5662307419436, 793.6111305460283, 10269.7432564185, 10292.588296468208, 10417.791644167226, 10695.090917271964, 10836.945815270874, 628.7139351595014, 640.6316368088368, 667.506045526307, 706.9717211311593, 779.1701837542998, 4865.829695960624, 5013.473585273494, 5032.295478632995, 5170.870728231825, 5209.244659524347, 92280.0, 125416.37291813483, 127133.36433317959, 127237.0, 127495.07534472497, 107312.0, 110343.0, 110534.44732776284, 110670.0, 112003.0, 87601.56199219091, 87839.1216087831, 89122.0, 92576.53711731399, 94983.52508237415, 9455.527223638928, 9474.147326740627, 9657.758556036155, 9732.610695572097, 10086.509840618715, 47019.76490117527, 52154.47845521648, 52940.73529632481, 53433.0, 54058.729706351216, 57190.14214786698, 66105.66947165233, 74450.62774686092, 74813.62593187217, 75470.62264688642, 13680.93159534196, 13738.725225495235, 13833.930830345784, 13851.792223116863, 13983.091099078527, 15432.757978393145, 15757.763633545277, 15988.280527376064, 16069.116198609188, 16481.093539855425, 14429.92785036068, 14686.265686715407, 14870.182139981973, 15002.099874007594, 15449.104189773587, 14435.78346324827, 14454.27728613586, 14864.62838429048, 14918.32867520986, 14926.626834329229, 14710.705785884436, 15096.622584435478, 15153.24233788284, 15180.848191518386, 15209.695806083595, 11592.536298547964, 11746.706332341419, 11821.349825759322, 12156.209846359958, 12215.206011609573, 12218.327991960528, 12275.754484910072, 12464.626061218178, 12500.867152272083, 12811.423485943342], "value": 7850.621398613875, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1530.6999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 105.0, 113.0, 111.0, 113.0, 113.0, 113.0, 113.0, 112.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 118.0, 148.0, 187.0, 117.0, 147.0, 149.0, 119.0, 187.0, 122.0], "value": 145.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 163.0, 161.0, 166.0, 168.0, 168.0, 164.0, 164.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 157.0, 77.0, 76.0, 75.0, 76.0, 170.0, 76.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 150.0, 85.0, 86.0, 84.0, 131.0, 84.0, 84.0, 164.0], "value": 103.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 147.0, 148.0, 148.0, 147.0, 148.0, 147.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 54.0, 55.0, 53.0, 53.0, 52.0, 53.0, 52.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 62.0, 64.0, 63.0, 62.0, 62.0, 62.0, 63.0], "value": 62.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 81.0, 82.0, 76.0, 76.0, 76.0, 76.0, 81.0, 76.0], "value": 77.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 121.0, 120.0, 129.0, 130.0, 131.0, 133.0, 132.0, 182.0, 130.0], "value": 133.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 164.0, 158.0, 159.0, 158.0, 161.0, 159.0, 164.0, 160.0, 163.0], "value": 160.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 63.0, 64.0, 64.0, 63.0, 64.0, 66.0, 63.0, 69.0, 63.0], "value": 65.0, "unit": "score"}]}]} 03:36:27 INFO - Return code: 0 03:36:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:36:27 ERROR - # TBPL SUCCESS # 03:36:27 INFO - Running post-action listener: _resource_record_post_action 03:36:27 INFO - ##### 03:36:27 INFO - ##### Finished run-tests step (success) 03:36:27 INFO - ##### 03:36:27 INFO - Running post-run listener: _resource_record_post_run 03:36:27 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 553869312; Read time: 0; Write time: 1395844 03:36:27 INFO - TinderboxPrint: CPU usage
13.4% 03:36:27 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 03:36:27 INFO - TinderboxPrint: I/O write bytes / time
553,869,312 / 1,395,844 03:36:27 INFO - TinderboxPrint: CPU idle
8,238.6 (86.5%) 03:36:27 INFO - TinderboxPrint: CPU user
1,214.4 (12.8%) 03:36:27 INFO - TinderboxPrint: Swap in / out
0 / 0 03:36:27 INFO - install - Wall time: 19s; CPU: 18.0%; Read bytes: 0; Write bytes: 258064384; Read time: 0; Write time: 838940 03:36:27 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 295804928; Read time: 0; Write time: 556904 03:36:27 INFO - Running post-run listener: _upload_blobber_files 03:36:27 INFO - Blob upload gear active. 03:36:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:36:27 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 03:36:27 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:36:27 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:36:28 INFO - (blobuploader) - INFO - Open directory for files ... 03:36:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:36:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:36:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:36:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:36:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:36:32 INFO - (blobuploader) - INFO - Done attempting. 03:36:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:36:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:36:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:36:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:36:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:36:33 INFO - (blobuploader) - INFO - Done attempting. 03:36:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:36:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:36:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:36:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:36:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:36:34 INFO - (blobuploader) - INFO - Done attempting. 03:36:34 INFO - (blobuploader) - INFO - Iteration through files over. 03:36:34 INFO - Return code: 0 03:36:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:36:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:36:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b63ed8b2bb75d6373a2ac4f251dc9b5693b55a9b54f64c71dc2e0deeb6a4afa21f72f23ad9d67609fcb6eee5cfb434b9644e232248029e2828a41d219788920a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f62f7d2a8831514b7f1c71ca6050f16db30f7f17aa65d735db1340c6f862da967248b84fdd1398b7ac4d32754531b2468d3a1090eae1029756f5d638b5641740", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/587153408b4df3bed57867a9fadaaa5b7aa2fd9a8397e247aec2474a77a9b5ceb6ae170370cda97d4becf571c62d5fd2e74fdedfbed29154ccd59c56212dc73d"} 03:36:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:36:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:36:34 INFO - Contents: 03:36:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b63ed8b2bb75d6373a2ac4f251dc9b5693b55a9b54f64c71dc2e0deeb6a4afa21f72f23ad9d67609fcb6eee5cfb434b9644e232248029e2828a41d219788920a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f62f7d2a8831514b7f1c71ca6050f16db30f7f17aa65d735db1340c6f862da967248b84fdd1398b7ac4d32754531b2468d3a1090eae1029756f5d638b5641740", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/587153408b4df3bed57867a9fadaaa5b7aa2fd9a8397e247aec2474a77a9b5ceb6ae170370cda97d4becf571c62d5fd2e74fdedfbed29154ccd59c56212dc73d"} 03:36:34 INFO - Running post-run listener: copy_logs_to_upload_dir 03:36:34 INFO - Copying logs to upload dir... 03:36:34 INFO - mkdir: /builds/slave/test/build/upload/logs 03:36:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.948566 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-07-18 03:36:34.235523) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 03:36:34.238743) ========= 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=745a4373a2a16df560f216e000000264-1468836957.856193-325568411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b63ed8b2bb75d6373a2ac4f251dc9b5693b55a9b54f64c71dc2e0deeb6a4afa21f72f23ad9d67609fcb6eee5cfb434b9644e232248029e2828a41d219788920a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f62f7d2a8831514b7f1c71ca6050f16db30f7f17aa65d735db1340c6f862da967248b84fdd1398b7ac4d32754531b2468d3a1090eae1029756f5d638b5641740", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/587153408b4df3bed57867a9fadaaa5b7aa2fd9a8397e247aec2474a77a9b5ceb6ae170370cda97d4becf571c62d5fd2e74fdedfbed29154ccd59c56212dc73d"} build_url:https://queue.taskcluster.net/v1/task/apnqKzxMSxuxzw_gH8AJQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011176 build_url: 'https://queue.taskcluster.net/v1/task/apnqKzxMSxuxzw_gH8AJQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b63ed8b2bb75d6373a2ac4f251dc9b5693b55a9b54f64c71dc2e0deeb6a4afa21f72f23ad9d67609fcb6eee5cfb434b9644e232248029e2828a41d219788920a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f62f7d2a8831514b7f1c71ca6050f16db30f7f17aa65d735db1340c6f862da967248b84fdd1398b7ac4d32754531b2468d3a1090eae1029756f5d638b5641740", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/587153408b4df3bed57867a9fadaaa5b7aa2fd9a8397e247aec2474a77a9b5ceb6ae170370cda97d4becf571c62d5fd2e74fdedfbed29154ccd59c56212dc73d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 03:36:34.263439) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 03:36:34.263765) ========= 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=745a4373a2a16df560f216e000000264-1468836957.856193-325568411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004687 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 03:36:34.347296) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 03:36:34.347628) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 03:36:34.347927) ========= ========= Total master_lag: 0.16 =========