builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-032 starttime: 1465468058.98 results: success (0) buildid: 20160609025529 builduid: 1c33681c03b94873ba880be0408ca68f revision: 5adb34ff698d8fc8eb2df3434eacef87b5b5d0b9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 03:27:38.976349) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 03:27:38.976853) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 03:27:38.977169) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 03:27:38.994298) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 03:27:38.994618) ========= 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-1465467267.419532-619775607 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 03:27:39-- 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% 40.7M=0s 2016-06-09 03:27:39 (40.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125518 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 03:27:39.140239) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 03:27:39.140562) ========= 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-1465467267.419532-619775607 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018088 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 03:27:39.195892) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 03:27:39.196229) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5adb34ff698d8fc8eb2df3434eacef87b5b5d0b9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 5adb34ff698d8fc8eb2df3434eacef87b5b5d0b9 --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-1465467267.419532-619775607 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 03:27:39,295 truncating revision to first 12 chars 2016-06-09 03:27:39,295 Setting DEBUG logging. 2016-06-09 03:27:39,295 attempt 1/10 2016-06-09 03:27:39,295 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5adb34ff698d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 03:27:40,726 unpacking tar archive at: fx-team-5adb34ff698d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.770198 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 03:27:40.982676) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 03:27:40.982987) ========= script_repo_revision: 5adb34ff698d8fc8eb2df3434eacef87b5b5d0b9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 03:27:40.983401) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 03:27:40.983698) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 03:27:40.993245) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-06-09 03:27:40.993554) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1465467267.419532-619775607 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:27:41 INFO - MultiFileLogger online at 20160609 03:27:41 in /builds/slave/test 03:27:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 03:27:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:27:41 INFO - {'append_to_log': False, 03:27:41 INFO - 'base_work_dir': '/builds/slave/test', 03:27:41 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:27:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:27:41 INFO - 'branch': 'Fx-Team-Non-PGO', 03:27:41 INFO - 'buildbot_json_path': 'buildprops.json', 03:27:41 INFO - 'config_files': ('talos/linux_config.py',), 03:27:41 INFO - 'default_actions': ('clobber', 03:27:41 INFO - 'read-buildbot-config', 03:27:41 INFO - 'download-and-extract', 03:27:41 INFO - 'populate-webroot', 03:27:41 INFO - 'create-virtualenv', 03:27:41 INFO - 'install', 03:27:41 INFO - 'run-tests'), 03:27:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:27:41 INFO - 'download_minidump_stackwalk': True, 03:27:41 INFO - 'download_symbols': 'ondemand', 03:27:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:27:41 INFO - 'tooltool.py': '/tools/tooltool.py', 03:27:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:27:41 INFO - '/tools/misc-python/virtualenv.py')}, 03:27:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:27:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:27:41 INFO - 'installer_path': 'installer.exe', 03:27:41 INFO - 'log_level': 'info', 03:27:41 INFO - 'log_name': 'talos', 03:27:41 INFO - 'log_to_console': True, 03:27:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:27:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:27:41 INFO - 'opt_config_files': (), 03:27:41 INFO - 'pip_index': False, 03:27:41 INFO - 'sps_profile': False, 03:27:41 INFO - 'sps_profile_interval': 0, 03:27:41 INFO - 'suite': 'dromaeojs', 03:27:41 INFO - 'system_bits': '32', 03:27:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:27:41 INFO - 'title': 'talos-linux64-ix-032', 03:27:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:27:41 INFO - 'use_talos_json': True, 03:27:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:27:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:27:41 INFO - 'work_dir': 'build'} 03:27:41 INFO - ##### 03:27:41 INFO - ##### Running clobber step. 03:27:41 INFO - ##### 03:27:41 INFO - Running pre-action listener: _resource_record_pre_action 03:27:41 INFO - Running main action method: clobber 03:27:41 INFO - rmtree: /builds/slave/test/build 03:27:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:27:42 INFO - Running post-action listener: _resource_record_post_action 03:27:42 INFO - ##### 03:27:42 INFO - ##### Finished clobber step (success) 03:27:42 INFO - ##### 03:27:42 INFO - ##### 03:27:42 INFO - ##### Running read-buildbot-config step. 03:27:42 INFO - ##### 03:27:42 INFO - Running pre-action listener: _resource_record_pre_action 03:27:42 INFO - Running main action method: read_buildbot_config 03:27:42 INFO - Using buildbot properties: 03:27:42 INFO - { 03:27:42 INFO - "project": "", 03:27:42 INFO - "product": "firefox", 03:27:42 INFO - "script_repo_revision": "production", 03:27:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 03:27:42 INFO - "repository": "", 03:27:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 03:27:42 INFO - "buildid": "20160609025529", 03:27:42 INFO - "pgo_build": "False", 03:27:42 INFO - "basedir": "/builds/slave/test", 03:27:42 INFO - "buildnumber": 3072, 03:27:42 INFO - "slavename": "talos-linux64-ix-032", 03:27:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:27:42 INFO - "platform": "ubuntu64_hw", 03:27:42 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:27:42 INFO - "branch": "fx-team", 03:27:42 INFO - "repo_path": "integration/fx-team", 03:27:42 INFO - "revision": "5adb34ff698d8fc8eb2df3434eacef87b5b5d0b9", 03:27:42 INFO - "stage_platform": "linux64", 03:27:42 INFO - "builduid": "1c33681c03b94873ba880be0408ca68f", 03:27:42 INFO - "slavebuilddir": "test" 03:27:42 INFO - } 03:27:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/bdTr2E_bRkeICnAHs--hnA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 03:27:42 INFO - Running post-action listener: _resource_record_post_action 03:27:42 INFO - ##### 03:27:42 INFO - ##### Finished read-buildbot-config step (success) 03:27:42 INFO - ##### 03:27:42 INFO - ##### 03:27:42 INFO - ##### Running download-and-extract step. 03:27:42 INFO - ##### 03:27:42 INFO - Running pre-action listener: _resource_record_pre_action 03:27:42 INFO - Running main action method: download_and_extract 03:27:42 INFO - mkdir: /builds/slave/test/build/tests 03:27:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:27:42 INFO - https://queue.taskcluster.net/v1/task/bdTr2E_bRkeICnAHs--hnA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:27:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bdTr2E_bRkeICnAHs--hnA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:27:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bdTr2E_bRkeICnAHs--hnA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:27:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bdTr2E_bRkeICnAHs--hnA/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:27:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bdTr2E_bRkeICnAHs--hnA/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:27:44 INFO - Downloaded 1361 bytes. 03:27:44 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:27:44 INFO - Using the following test package requirements: 03:27:44 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:27:44 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:27:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:27:44 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:27:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:27:44 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:27:44 INFO - u'jsshell-linux-x86_64.zip'], 03:27:44 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:27:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:27:44 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:27:44 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:27:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:27:44 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:27:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:27:44 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:27:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:27:44 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:27:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:27:44 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:27:44 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:27:44 INFO - https://queue.taskcluster.net/v1/task/bdTr2E_bRkeICnAHs--hnA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:27:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bdTr2E_bRkeICnAHs--hnA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:27:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bdTr2E_bRkeICnAHs--hnA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:27:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bdTr2E_bRkeICnAHs--hnA/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:27:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bdTr2E_bRkeICnAHs--hnA/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:27:53 INFO - Downloaded 22879062 bytes. 03:27:53 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:27:53 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:27:54 INFO - Return code: 0 03:27:54 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:27:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:27:54 INFO - https://queue.taskcluster.net/v1/task/bdTr2E_bRkeICnAHs--hnA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:27:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bdTr2E_bRkeICnAHs--hnA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:27:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bdTr2E_bRkeICnAHs--hnA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:27:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bdTr2E_bRkeICnAHs--hnA/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:27:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bdTr2E_bRkeICnAHs--hnA/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:27:57 INFO - Downloaded 22879062 bytes. 03:27:57 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:27:57 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:27:59 INFO - Return code: 0 03:27:59 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:27:59 INFO - https://queue.taskcluster.net/v1/task/bdTr2E_bRkeICnAHs--hnA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:27:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bdTr2E_bRkeICnAHs--hnA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:27:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bdTr2E_bRkeICnAHs--hnA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:27:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bdTr2E_bRkeICnAHs--hnA/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:27:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bdTr2E_bRkeICnAHs--hnA/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:28:01 INFO - Downloaded 10833369 bytes. 03:28:01 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:28:01 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:28:01 INFO - Return code: 0 03:28: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:28:01 INFO - https://queue.taskcluster.net/v1/task/bdTr2E_bRkeICnAHs--hnA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:28:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bdTr2E_bRkeICnAHs--hnA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:28:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bdTr2E_bRkeICnAHs--hnA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:28:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bdTr2E_bRkeICnAHs--hnA/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:28:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bdTr2E_bRkeICnAHs--hnA/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:28:07 INFO - Downloaded 55342800 bytes. 03:28:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bdTr2E_bRkeICnAHs--hnA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:28:07 INFO - mkdir: /builds/slave/test/properties 03:28:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:28:07 INFO - Writing to file /builds/slave/test/properties/build_url 03:28:07 INFO - Contents: 03:28:07 INFO - build_url:https://queue.taskcluster.net/v1/task/bdTr2E_bRkeICnAHs--hnA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:28:08 INFO - Running post-action listener: _resource_record_post_action 03:28:08 INFO - Running post-action listener: set_extra_try_arguments 03:28:08 INFO - ##### 03:28:08 INFO - ##### Finished download-and-extract step (success) 03:28:08 INFO - ##### 03:28:08 INFO - ##### 03:28:08 INFO - ##### Running populate-webroot step. 03:28:08 INFO - ##### 03:28:08 INFO - Running pre-action listener: _resource_record_pre_action 03:28:08 INFO - Running main action method: populate_webroot 03:28:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:28:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:28:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:28:08 INFO - '--tppagecycles', 03:28:08 INFO - '7'], 03:28:08 INFO - 'tests': ['tsvgm']}}, 03:28:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:28:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:28:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:28:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:28:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:28:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:28:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:08 INFO - 'talos_options': ['--disable-e10s'], 03:28:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:28:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:28:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:08 INFO - 'talos_options': ['--disable-e10s'], 03:28:08 INFO - 'tests': ['damp', 'tps']}, 03:28:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:08 INFO - 'tests': ['damp', 'tps']}, 03:28:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:28:08 INFO - 'tests': ['dromaeo_dom']}, 03:28:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:28:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:28:08 INFO - 'tests': ['a11yr', 03:28:08 INFO - 'ts_paint', 03:28:08 INFO - 'tpaint', 03:28:08 INFO - 'sessionrestore', 03:28:08 INFO - 'sessionrestore_no_auto_restore', 03:28:08 INFO - 'tabpaint']}, 03:28:08 INFO - 'other-e10s': {'tests': ['a11yr', 03:28:08 INFO - 'ts_paint', 03:28:08 INFO - 'tpaint', 03:28:08 INFO - 'sessionrestore', 03:28:08 INFO - 'sessionrestore_no_auto_restore', 03:28:08 INFO - 'tabpaint']}, 03:28:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:28:08 INFO - 'ts_paint', 03:28:08 INFO - 'tpaint', 03:28:08 INFO - 'sessionrestore', 03:28:08 INFO - 'sessionrestore_no_auto_restore', 03:28:08 INFO - 'tabpaint']}, 03:28:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:28:08 INFO - 'ts_paint', 03:28:08 INFO - 'tpaint', 03:28:08 INFO - 'sessionrestore', 03:28:08 INFO - 'sessionrestore_no_auto_restore', 03:28:08 INFO - 'tabpaint']}, 03:28:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:28:08 INFO - 'tests': ['a11yr', 03:28:08 INFO - 'ts_paint', 03:28:08 INFO - 'tpaint', 03:28:08 INFO - 'sessionrestore', 03:28:08 INFO - 'sessionrestore_no_auto_restore', 03:28:08 INFO - 'tabpaint']}, 03:28:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:28:08 INFO - 'tests': ['a11yr', 03:28:08 INFO - 'ts_paint', 03:28:08 INFO - 'tpaint', 03:28:08 INFO - 'sessionrestore', 03:28:08 INFO - 'sessionrestore_no_auto_restore', 03:28:08 INFO - 'tabpaint']}, 03:28:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:28:08 INFO - 'tests': ['tsvgx', 03:28:08 INFO - 'tsvgr_opacity', 03:28:08 INFO - 'tart', 03:28:08 INFO - 'tscrollx', 03:28:08 INFO - 'cart']}, 03:28:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:28:08 INFO - 'tsvgr_opacity', 03:28:08 INFO - 'tart', 03:28:08 INFO - 'tscrollx', 03:28:08 INFO - 'cart']}, 03:28:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:08 INFO - 'talos_options': ['--disable-e10s'], 03:28:08 INFO - 'tests': ['tp5o']}, 03:28:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:08 INFO - 'tests': ['tp5o']}, 03:28:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:08 INFO - 'talos_options': ['--disable-e10s', 03:28:08 INFO - '--xperf_path', 03:28:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:28:08 INFO - 'tests': ['tp5n']}, 03:28:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:08 INFO - 'talos_options': ['--xperf_path', 03:28:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:28:08 INFO - 'tests': ['tp5n']}}, 03:28:08 INFO - 'talos.zip': {'path': '', 03:28:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:28:08 INFO - Running post-action listener: _resource_record_post_action 03:28:08 INFO - ##### 03:28:08 INFO - ##### Finished populate-webroot step (success) 03:28:08 INFO - ##### 03:28:08 INFO - ##### 03:28:08 INFO - ##### Running create-virtualenv step. 03:28:08 INFO - ##### 03:28:08 INFO - Running pre-action listener: _resource_record_pre_action 03:28:08 INFO - Running main action method: create_virtualenv 03:28:08 INFO - Creating virtualenv /builds/slave/test/build/venv 03:28:08 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:28:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:28:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:28:08 INFO - Using real prefix '/usr' 03:28:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:28:09 INFO - Installing distribute.............................................................................................................................................................................................done. 03:28:11 INFO - Installing pip.................done. 03:28:11 INFO - Return code: 0 03:28:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:28:11 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:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:11 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:28:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:11 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 0x7f4809f9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2965020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f72e0>, '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 0x2963140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29635d0>, '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-1465467267.419532-619775607', '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:28:11 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:28:11 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:28:11 INFO - Using env: {'DISPLAY': ':0', 03:28:11 INFO - 'HOME': '/home/cltbld', 03:28:11 INFO - 'LANG': 'en_US.UTF-8', 03:28:11 INFO - 'LANGUAGE': 'en_US:en', 03:28:11 INFO - 'LOGNAME': 'cltbld', 03:28:11 INFO - 'MAIL': '/var/mail/cltbld', 03:28:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:11 INFO - 'MOZ_NO_REMOTE': '1', 03:28:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:11 INFO - 'NO_EM_RESTART': '1', 03:28:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:11 INFO - 'PWD': '/builds/slave/test', 03:28:11 INFO - 'SHELL': '/bin/bash', 03:28:11 INFO - 'SHLVL': '1', 03:28:11 INFO - 'TERM': 'linux', 03:28:11 INFO - 'TMOUT': '86400', 03:28:11 INFO - 'USER': 'cltbld', 03:28:11 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1465467267.419532-619775607', 03:28:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:11 INFO - '_': '/tools/buildbot/bin/python'} 03:28:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:11 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:28:11 INFO - Cleaning up... 03:28:11 INFO - Return code: 0 03:28:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:28:11 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:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:11 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:28:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:11 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 0x7f4809f9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2965020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f72e0>, '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 0x2963140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29635d0>, '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-1465467267.419532-619775607', '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:28:11 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:28:11 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:28:11 INFO - Using env: {'DISPLAY': ':0', 03:28:11 INFO - 'HOME': '/home/cltbld', 03:28:11 INFO - 'LANG': 'en_US.UTF-8', 03:28:11 INFO - 'LANGUAGE': 'en_US:en', 03:28:11 INFO - 'LOGNAME': 'cltbld', 03:28:11 INFO - 'MAIL': '/var/mail/cltbld', 03:28:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:11 INFO - 'MOZ_NO_REMOTE': '1', 03:28:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:11 INFO - 'NO_EM_RESTART': '1', 03:28:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:11 INFO - 'PWD': '/builds/slave/test', 03:28:11 INFO - 'SHELL': '/bin/bash', 03:28:11 INFO - 'SHLVL': '1', 03:28:11 INFO - 'TERM': 'linux', 03:28:11 INFO - 'TMOUT': '86400', 03:28:11 INFO - 'USER': 'cltbld', 03:28:11 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1465467267.419532-619775607', 03:28:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:11 INFO - '_': '/tools/buildbot/bin/python'} 03:28:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:11 INFO - Downloading/unpacking psutil>=3.1.1 03:28:11 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:28:11 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:28:11 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:28:11 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:28:11 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:28:11 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:28:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:28:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:28:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:28:13 INFO - Installing collected packages: psutil 03:28:13 INFO - Running setup.py install for psutil 03:28:13 INFO - building 'psutil._psutil_linux' extension 03:28:13 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:28:14 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:28:14 INFO - building 'psutil._psutil_posix' extension 03:28:14 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:28:14 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:28:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:28:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:28:14 INFO - Successfully installed psutil 03:28:14 INFO - Cleaning up... 03:28:14 INFO - Return code: 0 03:28:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:28: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:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28: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:28:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4809f9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2965020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f72e0>, '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 0x2963140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29635d0>, '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-1465467267.419532-619775607', '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:28: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:28: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 mozsystemmonitor==0.3 03:28:14 INFO - Using env: {'DISPLAY': ':0', 03:28:14 INFO - 'HOME': '/home/cltbld', 03:28:14 INFO - 'LANG': 'en_US.UTF-8', 03:28:14 INFO - 'LANGUAGE': 'en_US:en', 03:28:14 INFO - 'LOGNAME': 'cltbld', 03:28:14 INFO - 'MAIL': '/var/mail/cltbld', 03:28:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:14 INFO - 'MOZ_NO_REMOTE': '1', 03:28:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:14 INFO - 'NO_EM_RESTART': '1', 03:28:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:14 INFO - 'PWD': '/builds/slave/test', 03:28:14 INFO - 'SHELL': '/bin/bash', 03:28:14 INFO - 'SHLVL': '1', 03:28:14 INFO - 'TERM': 'linux', 03:28:14 INFO - 'TMOUT': '86400', 03:28:14 INFO - 'USER': 'cltbld', 03:28:14 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1465467267.419532-619775607', 03:28:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:14 INFO - '_': '/tools/buildbot/bin/python'} 03:28:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:28: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:28: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:28: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:28: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:28: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:28: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:28:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:28:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:28:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:28:16 INFO - Installing collected packages: mozsystemmonitor 03:28:16 INFO - Running setup.py install for mozsystemmonitor 03:28:16 INFO - Successfully installed mozsystemmonitor 03:28:16 INFO - Cleaning up... 03:28:16 INFO - Return code: 0 03:28:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:28:16 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:28:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:16 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:28:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:16 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 0x7f4809f9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2965020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f72e0>, '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 0x2963140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29635d0>, '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-1465467267.419532-619775607', '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:28:16 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:28:16 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:28:16 INFO - Using env: {'DISPLAY': ':0', 03:28:16 INFO - 'HOME': '/home/cltbld', 03:28:16 INFO - 'LANG': 'en_US.UTF-8', 03:28:16 INFO - 'LANGUAGE': 'en_US:en', 03:28:16 INFO - 'LOGNAME': 'cltbld', 03:28:16 INFO - 'MAIL': '/var/mail/cltbld', 03:28:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:16 INFO - 'MOZ_NO_REMOTE': '1', 03:28:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:16 INFO - 'NO_EM_RESTART': '1', 03:28:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:16 INFO - 'PWD': '/builds/slave/test', 03:28:16 INFO - 'SHELL': '/bin/bash', 03:28:16 INFO - 'SHLVL': '1', 03:28:16 INFO - 'TERM': 'linux', 03:28:16 INFO - 'TMOUT': '86400', 03:28:16 INFO - 'USER': 'cltbld', 03:28:16 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1465467267.419532-619775607', 03:28:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:16 INFO - '_': '/tools/buildbot/bin/python'} 03:28:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:16 INFO - Downloading/unpacking jsonschema==2.5.1 03:28:16 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:28:16 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:28:16 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:28:16 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:28:16 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:28:16 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:28:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:28:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:28:18 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:28:18 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:28:18 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:28:18 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:28:18 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:28:18 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:28:18 INFO - Downloading functools32-3.2.3-2.tar.gz 03:28:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:28:19 INFO - warning: no files found matching '*.txt' 03:28:19 INFO - no previously-included directories found matching 'build' 03:28:19 INFO - no previously-included directories found matching 'dist' 03:28:19 INFO - no previously-included directories found matching '.git*' 03:28:19 INFO - Installing collected packages: jsonschema, functools32 03:28:19 INFO - Running setup.py install for functools32 03:28:19 INFO - warning: no files found matching '*.txt' 03:28:19 INFO - no previously-included directories found matching 'build' 03:28:19 INFO - no previously-included directories found matching 'dist' 03:28:19 INFO - no previously-included directories found matching '.git*' 03:28:19 INFO - Successfully installed jsonschema functools32 03:28:19 INFO - Cleaning up... 03:28:19 INFO - Return code: 0 03:28:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:28: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:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28: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:28:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28: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', '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 0x7f4809f9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2965020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f72e0>, '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 0x2963140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29635d0>, '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-1465467267.419532-619775607', '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:28: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:28: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 blobuploader==1.2.4 03:28:19 INFO - Using env: {'DISPLAY': ':0', 03:28:19 INFO - 'HOME': '/home/cltbld', 03:28:19 INFO - 'LANG': 'en_US.UTF-8', 03:28:19 INFO - 'LANGUAGE': 'en_US:en', 03:28:19 INFO - 'LOGNAME': 'cltbld', 03:28:19 INFO - 'MAIL': '/var/mail/cltbld', 03:28:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:19 INFO - 'MOZ_NO_REMOTE': '1', 03:28:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:19 INFO - 'NO_EM_RESTART': '1', 03:28:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:19 INFO - 'PWD': '/builds/slave/test', 03:28:19 INFO - 'SHELL': '/bin/bash', 03:28:19 INFO - 'SHLVL': '1', 03:28:19 INFO - 'TERM': 'linux', 03:28:19 INFO - 'TMOUT': '86400', 03:28:19 INFO - 'USER': 'cltbld', 03:28:19 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1465467267.419532-619775607', 03:28:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:19 INFO - '_': '/tools/buildbot/bin/python'} 03:28:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:19 INFO - Downloading/unpacking blobuploader==1.2.4 03:28: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:28: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:28: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:28: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:28: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:28: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:28:21 INFO - Downloading blobuploader-1.2.4.tar.gz 03:28:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:28:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:28: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:28: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:28: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:28: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:28: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:28: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:28:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:28:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:28: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:28: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:28: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:28: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:28: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:28: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:28:22 INFO - Downloading docopt-0.6.1.tar.gz 03:28:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:28:22 INFO - Installing collected packages: blobuploader, requests, docopt 03:28:22 INFO - Running setup.py install for blobuploader 03:28:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:28:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:28:22 INFO - Running setup.py install for requests 03:28:22 INFO - Running setup.py install for docopt 03:28:23 INFO - Successfully installed blobuploader requests docopt 03:28:23 INFO - Cleaning up... 03:28:23 INFO - Return code: 0 03:28:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28:23 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:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:23 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:28:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:23 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 0x7f4809f9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2965020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f72e0>, '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 0x2963140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29635d0>, '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-1465467267.419532-619775607', '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:28:23 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:28:23 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:28:23 INFO - Using env: {'DISPLAY': ':0', 03:28:23 INFO - 'HOME': '/home/cltbld', 03:28:23 INFO - 'LANG': 'en_US.UTF-8', 03:28:23 INFO - 'LANGUAGE': 'en_US:en', 03:28:23 INFO - 'LOGNAME': 'cltbld', 03:28:23 INFO - 'MAIL': '/var/mail/cltbld', 03:28:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:23 INFO - 'MOZ_NO_REMOTE': '1', 03:28:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:23 INFO - 'NO_EM_RESTART': '1', 03:28:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:23 INFO - 'PWD': '/builds/slave/test', 03:28:23 INFO - 'SHELL': '/bin/bash', 03:28:23 INFO - 'SHLVL': '1', 03:28:23 INFO - 'TERM': 'linux', 03:28:23 INFO - 'TMOUT': '86400', 03:28:23 INFO - 'USER': 'cltbld', 03:28:23 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1465467267.419532-619775607', 03:28:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:23 INFO - '_': '/tools/buildbot/bin/python'} 03:28:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:28:23 INFO - Running setup.py (path:/tmp/pip-2VOq05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:28:23 INFO - Running setup.py (path:/tmp/pip-2QsQBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:28:23 INFO - Running setup.py (path:/tmp/pip-WcQEdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:28:23 INFO - Running setup.py (path:/tmp/pip-PS9j6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:28:23 INFO - Running setup.py (path:/tmp/pip-n4fr9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:28:23 INFO - Running setup.py (path:/tmp/pip-WAB0K4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:28:23 INFO - Running setup.py (path:/tmp/pip-DHCeGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:28:23 INFO - Running setup.py (path:/tmp/pip-REtp7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:28:23 INFO - Running setup.py (path:/tmp/pip-ykzP10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:28:23 INFO - Running setup.py (path:/tmp/pip-c3n2z6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:28:24 INFO - Running setup.py (path:/tmp/pip-bvRJGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:28:24 INFO - Running setup.py (path:/tmp/pip-l1ZwqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:28:24 INFO - Running setup.py (path:/tmp/pip-b1Qwy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:28:24 INFO - Running setup.py (path:/tmp/pip-GGKGK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:24 INFO - Running setup.py (path:/tmp/pip-1sBG5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:28:24 INFO - Running setup.py (path:/tmp/pip-UUfV8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:28:24 INFO - Running setup.py (path:/tmp/pip-9y6sgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:28:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:28:24 INFO - Running setup.py install for manifestparser 03:28:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:28:24 INFO - Running setup.py install for mozcrash 03:28:24 INFO - Running setup.py install for mozdebug 03:28:24 INFO - Running setup.py install for mozdevice 03:28:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:28:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:28:24 INFO - Running setup.py install for mozfile 03:28:25 INFO - Running setup.py install for mozhttpd 03:28:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:28:25 INFO - Running setup.py install for mozinfo 03:28:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:28:25 INFO - Running setup.py install for mozInstall 03:28:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:28:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:28:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:28:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:28:25 INFO - Running setup.py install for mozleak 03:28:25 INFO - Running setup.py install for mozlog 03:28:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:28:25 INFO - Running setup.py install for moznetwork 03:28:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:28:25 INFO - Running setup.py install for mozprocess 03:28:25 INFO - Running setup.py install for mozprofile 03:28:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:28:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:28:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:28:25 INFO - Running setup.py install for mozrunner 03:28:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:28:26 INFO - Running setup.py install for mozscreenshot 03:28:26 INFO - Running setup.py install for moztest 03:28:26 INFO - Running setup.py install for mozversion 03:28:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:28:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:28:26 INFO - Cleaning up... 03:28:26 INFO - Return code: 0 03:28:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:28:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:26 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 0x7f4809f9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2965020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f72e0>, '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 0x2963140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29635d0>, '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-1465467267.419532-619775607', '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:28:26 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:28:26 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:28:26 INFO - Using env: {'DISPLAY': ':0', 03:28:26 INFO - 'HOME': '/home/cltbld', 03:28:26 INFO - 'LANG': 'en_US.UTF-8', 03:28:26 INFO - 'LANGUAGE': 'en_US:en', 03:28:26 INFO - 'LOGNAME': 'cltbld', 03:28:26 INFO - 'MAIL': '/var/mail/cltbld', 03:28:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:26 INFO - 'MOZ_NO_REMOTE': '1', 03:28:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:26 INFO - 'NO_EM_RESTART': '1', 03:28:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:26 INFO - 'PWD': '/builds/slave/test', 03:28:26 INFO - 'SHELL': '/bin/bash', 03:28:26 INFO - 'SHLVL': '1', 03:28:26 INFO - 'TERM': 'linux', 03:28:26 INFO - 'TMOUT': '86400', 03:28:26 INFO - 'USER': 'cltbld', 03:28:26 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1465467267.419532-619775607', 03:28:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:26 INFO - '_': '/tools/buildbot/bin/python'} 03:28:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:28:26 INFO - Running setup.py (path:/tmp/pip-DVlIYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:28:26 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:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:28:26 INFO - Running setup.py (path:/tmp/pip-AK1BhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:28:26 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:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:28:26 INFO - Running setup.py (path:/tmp/pip-7f_dBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:28:26 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:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:28:26 INFO - Running setup.py (path:/tmp/pip-ntpmBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:28:26 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:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:28:26 INFO - Running setup.py (path:/tmp/pip-WFFMzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:28:26 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:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:28:26 INFO - Running setup.py (path:/tmp/pip-4y9mJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:28:26 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:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:28:26 INFO - Running setup.py (path:/tmp/pip-yjNd_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:28:27 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:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:28:27 INFO - Running setup.py (path:/tmp/pip-ZzY_33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:28:27 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:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:28:27 INFO - Running setup.py (path:/tmp/pip-Ws1tMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:28:27 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:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:28:27 INFO - Running setup.py (path:/tmp/pip-pehwyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:28:27 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:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:28:27 INFO - Running setup.py (path:/tmp/pip-5ztuEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:28:27 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:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:28:27 INFO - Running setup.py (path:/tmp/pip-2gp3nt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:28:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:28:27 INFO - Running setup.py (path:/tmp/pip-E6OdMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:28:27 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:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:28:27 INFO - Running setup.py (path:/tmp/pip-tgeeSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:28:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:27 INFO - Running setup.py (path:/tmp/pip-YhsmHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:27 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:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:28:27 INFO - Running setup.py (path:/tmp/pip-9sLmr_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:28:27 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:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:28:27 INFO - Running setup.py (path:/tmp/pip-ZPHFQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:28:27 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:28:27 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:28:27 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:28:27 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:28:27 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:28:27 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:28:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:29 INFO - Downloading blessings-1.6.tar.gz 03:28:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:28:29 INFO - Installing collected packages: blessings 03:28:29 INFO - Running setup.py install for blessings 03:28:30 INFO - Successfully installed blessings 03:28:30 INFO - Cleaning up... 03:28:32 INFO - Return code: 0 03:28:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:28:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:28:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:28:32 INFO - Reading from file tmpfile_stdout 03:28:32 INFO - Current package versions: 03:28:32 INFO - argparse == 1.2.1 03:28:32 INFO - blessings == 1.6 03:28:32 INFO - blobuploader == 1.2.4 03:28:32 INFO - docopt == 0.6.1 03:28:32 INFO - functools32 == 3.2.3-2 03:28:32 INFO - jsonschema == 2.5.1 03:28:32 INFO - manifestparser == 1.1 03:28:32 INFO - mozInstall == 1.12 03:28:32 INFO - mozcrash == 0.17 03:28:32 INFO - mozdebug == 0.1 03:28:32 INFO - mozdevice == 0.48 03:28:32 INFO - mozfile == 1.2 03:28:32 INFO - mozhttpd == 0.7 03:28:32 INFO - mozinfo == 0.9 03:28:32 INFO - mozleak == 0.1 03:28:32 INFO - mozlog == 3.2 03:28:32 INFO - moznetwork == 0.27 03:28:32 INFO - mozprocess == 0.22 03:28:32 INFO - mozprofile == 0.28 03:28:32 INFO - mozrunner == 6.11 03:28:32 INFO - mozscreenshot == 0.1 03:28:32 INFO - mozsystemmonitor == 0.3 03:28:32 INFO - moztest == 0.7 03:28:32 INFO - mozversion == 1.4 03:28:32 INFO - psutil == 3.1.1 03:28:32 INFO - requests == 1.2.3 03:28:32 INFO - wsgiref == 0.1.2 03:28:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28: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:28:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28: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:28:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28: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 0x7f4809f9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2965020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f72e0>, '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 0x2963140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29635d0>, '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-1465467267.419532-619775607', '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:28: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:28: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:28:32 INFO - Using env: {'DISPLAY': ':0', 03:28:32 INFO - 'HOME': '/home/cltbld', 03:28:32 INFO - 'LANG': 'en_US.UTF-8', 03:28:32 INFO - 'LANGUAGE': 'en_US:en', 03:28:32 INFO - 'LOGNAME': 'cltbld', 03:28:32 INFO - 'MAIL': '/var/mail/cltbld', 03:28:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:32 INFO - 'MOZ_NO_REMOTE': '1', 03:28:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:32 INFO - 'NO_EM_RESTART': '1', 03:28:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:32 INFO - 'PWD': '/builds/slave/test', 03:28:32 INFO - 'SHELL': '/bin/bash', 03:28:32 INFO - 'SHLVL': '1', 03:28:32 INFO - 'TERM': 'linux', 03:28:32 INFO - 'TMOUT': '86400', 03:28:32 INFO - 'USER': 'cltbld', 03:28:32 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1465467267.419532-619775607', 03:28:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:32 INFO - '_': '/tools/buildbot/bin/python'} 03:28:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:33 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:28:33 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:28:33 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:28:33 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:28:33 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:28:33 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:28:33 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:28:33 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:28:33 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:28:33 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:28:33 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:28:33 INFO - Cleaning up... 03:28:33 INFO - Return code: 0 03:28:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:28: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:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28: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:28:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28: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 0x7f4809f9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2965020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f72e0>, '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 0x2963140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29635d0>, '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-1465467267.419532-619775607', '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:28: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:28: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:28:33 INFO - Using env: {'DISPLAY': ':0', 03:28:33 INFO - 'HOME': '/home/cltbld', 03:28:33 INFO - 'LANG': 'en_US.UTF-8', 03:28:33 INFO - 'LANGUAGE': 'en_US:en', 03:28:33 INFO - 'LOGNAME': 'cltbld', 03:28:33 INFO - 'MAIL': '/var/mail/cltbld', 03:28:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:33 INFO - 'MOZ_NO_REMOTE': '1', 03:28:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:33 INFO - 'NO_EM_RESTART': '1', 03:28:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:33 INFO - 'PWD': '/builds/slave/test', 03:28:33 INFO - 'SHELL': '/bin/bash', 03:28:33 INFO - 'SHLVL': '1', 03:28:33 INFO - 'TERM': 'linux', 03:28:33 INFO - 'TMOUT': '86400', 03:28:33 INFO - 'USER': 'cltbld', 03:28:33 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1465467267.419532-619775607', 03:28:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:33 INFO - '_': '/tools/buildbot/bin/python'} 03:28:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:28:33 INFO - Cleaning up... 03:28:33 INFO - Return code: 0 03:28:33 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:28: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:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28: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:28:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4809f9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2965020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f72e0>, '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 0x2963140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29635d0>, '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-1465467267.419532-619775607', '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:28: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', 'flake8'] in /builds/slave/test/build 03:28: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 flake8 03:28:33 INFO - Using env: {'DISPLAY': ':0', 03:28:33 INFO - 'HOME': '/home/cltbld', 03:28:33 INFO - 'LANG': 'en_US.UTF-8', 03:28:33 INFO - 'LANGUAGE': 'en_US:en', 03:28:33 INFO - 'LOGNAME': 'cltbld', 03:28:33 INFO - 'MAIL': '/var/mail/cltbld', 03:28:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:33 INFO - 'MOZ_NO_REMOTE': '1', 03:28:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:33 INFO - 'NO_EM_RESTART': '1', 03:28:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:33 INFO - 'PWD': '/builds/slave/test', 03:28:33 INFO - 'SHELL': '/bin/bash', 03:28:33 INFO - 'SHLVL': '1', 03:28:33 INFO - 'TERM': 'linux', 03:28:33 INFO - 'TMOUT': '86400', 03:28:33 INFO - 'USER': 'cltbld', 03:28:33 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1465467267.419532-619775607', 03:28:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:33 INFO - '_': '/tools/buildbot/bin/python'} 03:28:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:33 INFO - Downloading/unpacking flake8 03:28:33 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:28:33 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:28:33 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:28:33 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:28:33 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:28:33 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:28:35 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:28:35 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:28:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:35 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:28:35 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:28:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:28:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:28:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:28:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:28:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:28:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:28:36 INFO - no previously-included directories found matching 'docs/_build' 03:28:36 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:28:36 INFO - Running setup.py install for pep8 03:28:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:28:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:28:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:28:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:28:36 INFO - no previously-included directories found matching 'docs/_build' 03:28:36 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:28:36 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:28:36 INFO - Cleaning up... 03:28:37 INFO - Return code: 0 03:28:37 INFO - Running post-action listener: _resource_record_post_action 03:28:37 INFO - Running post-action listener: _start_resource_monitoring 03:28:37 INFO - Starting resource monitoring. 03:28:37 INFO - ##### 03:28:37 INFO - ##### Finished create-virtualenv step (success) 03:28:37 INFO - ##### 03:28:37 INFO - ##### 03:28:37 INFO - ##### Running install step. 03:28:37 INFO - ##### 03:28:37 INFO - Running pre-action listener: _resource_record_pre_action 03:28:37 INFO - Running main action method: install 03:28:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:28:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:28:38 INFO - Reading from file tmpfile_stdout 03:28:38 INFO - Detecting whether we're running mozinstall >=1.0... 03:28:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:28:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:28:38 INFO - Reading from file tmpfile_stdout 03:28:38 INFO - Output received: 03:28:38 INFO - Usage: mozinstall [options] installer 03:28:38 INFO - Options: 03:28:38 INFO - -h, --help show this help message and exit 03:28:38 INFO - -d DEST, --destination=DEST 03:28:38 INFO - Directory to install application into. [default: 03:28:38 INFO - "/builds/slave/test"] 03:28:38 INFO - --app=APP Application being installed. [default: firefox] 03:28:38 INFO - mkdir: /builds/slave/test/build/application 03:28:38 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:28:38 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:28:54 INFO - Reading from file tmpfile_stdout 03:28:54 INFO - Output received: 03:28:54 INFO - /builds/slave/test/build/application/firefox/firefox 03:28:54 INFO - Running post-action listener: _resource_record_post_action 03:28:54 INFO - ##### 03:28:54 INFO - ##### Finished install step (success) 03:28:54 INFO - ##### 03:28:54 INFO - ##### 03:28:54 INFO - ##### Running run-tests step. 03:28:54 INFO - ##### 03:28:54 INFO - Running pre-action listener: _resource_record_pre_action 03:28:54 INFO - Running main action method: run_tests 03:28:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:28:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:28:54 INFO - Python 2.7.3 03:28:54 INFO - Return code: 0 03:28:54 INFO - grabbing minidump binary from tooltool 03:28:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:28:54 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f72e0>, '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 0x2963140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29635d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:28:54 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:28:54 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:28:54 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:28:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:28:54 INFO - Return code: 0 03:28:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:28:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:28:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:28:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:28:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:28:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:28:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:28:55 INFO - Return code: 0 03:28:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bdTr2E_bRkeICnAHs--hnA/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_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:28:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bdTr2E_bRkeICnAHs--hnA/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_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:28:55 INFO - Using env: {'DISPLAY': ':0', 03:28:55 INFO - 'HOME': '/home/cltbld', 03:28:55 INFO - 'LANG': 'en_US.UTF-8', 03:28:55 INFO - 'LANGUAGE': 'en_US:en', 03:28:55 INFO - 'LOGNAME': 'cltbld', 03:28:55 INFO - 'MAIL': '/var/mail/cltbld', 03:28:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:28:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:28:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:55 INFO - 'MOZ_NO_REMOTE': '1', 03:28:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:28:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:55 INFO - 'NO_EM_RESTART': '1', 03:28:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:55 INFO - 'PWD': '/builds/slave/test', 03:28:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:28:55 INFO - 'SHELL': '/bin/bash', 03:28:55 INFO - 'SHLVL': '1', 03:28:55 INFO - 'TERM': 'linux', 03:28:55 INFO - 'TMOUT': '86400', 03:28:55 INFO - 'USER': 'cltbld', 03:28:55 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1465467267.419532-619775607', 03:28:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:55 INFO - '_': '/tools/buildbot/bin/python'} 03:28:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bdTr2E_bRkeICnAHs--hnA/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_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:28:55 INFO - mozversion application_buildid: 20160609025529 03:28:55 INFO - mozversion application_changeset: 5adb34ff698d8fc8eb2df3434eacef87b5b5d0b9 03:28:55 INFO - mozversion application_display_name: Nightly 03:28:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:28:55 INFO - mozversion application_name: Firefox 03:28:55 INFO - mozversion application_remotingname: firefox 03:28:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:28:55 INFO - mozversion application_vendor: Mozilla 03:28:55 INFO - mozversion application_version: 50.0a1 03:28:55 INFO - mozversion platform_buildid: 20160609025529 03:28:55 INFO - mozversion platform_changeset: 5adb34ff698d8fc8eb2df3434eacef87b5b5d0b9 03:28:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:28:55 INFO - mozversion platform_version: 50.0a1 03:28:55 INFO - using testdate: 1465468135 03:28:55 INFO - actual date: 1465468135 03:28:55 INFO - starting webserver on 'localhost:54017' 03:28:55 INFO - SUITE-START | Running 2 tests 03:28:55 INFO - TEST-START | dromaeo_css 03:28:55 INFO - operating with platform_type : linux_ 03:28:55 INFO - Initialising browser for dromaeo_css test... 03:28:55 INFO - TEST-INFO | started process 10946 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprPRhaH/profile http://localhost:54017/getInfo.html) 03:29:01 INFO - PROCESS | 10946 | __metrics Screen width/height:1600/1200 03:29:01 INFO - PROCESS | 10946 | colorDepth:24 03:29:01 INFO - PROCESS | 10946 | Browser inner width/height: 1024/697 03:29:01 INFO - PROCESS | 10946 | __metrics 03:29:02 ERROR - PROCESS | 10946 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:29:02 INFO - PROCESS | 10946 | console.error: PushService: 03:29:02 INFO - PROCESS | 10946 | stateChangeProcessEnqueue: Error transitioning state 03:29:02 INFO - PROCESS | 10946 | UnknownError 03:29:03 INFO - TEST-INFO | 10946: exit 0 03:29:03 INFO - Browser initialized. 03:29:03 INFO - Running cycle 1/1 for dromaeo_css test... 03:29:03 INFO - TEST-INFO | started process 11029 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprPRhaH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:29:15 INFO - PROCESS | 11029 | RSS: Main: 158117888 03:29:15 INFO - PROCESS | 11029 | 03:30:06 INFO - PROCESS | 11029 | 1465468206908 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:32:18 INFO - PROCESS | 11029 | Cycle 1(1): loaded http://localhost:54017/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54017/tests/dromaeo/cssquery-ext.html) 03:32:19 INFO - PROCESS | 11029 | RSS: Main: 235114496 03:32:19 INFO - PROCESS | 11029 | 03:35:22 INFO - PROCESS | 11029 | Cycle 1(1): loaded http://localhost:54017/tests/dromaeo/cssquery-ext.html (next: http://localhost:54017/tests/dromaeo/cssquery-jquery.html) 03:35:23 INFO - PROCESS | 11029 | RSS: Main: 244621312 03:35:23 INFO - PROCESS | 11029 | 03:38:25 INFO - PROCESS | 11029 | Cycle 1(1): loaded http://localhost:54017/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54017/tests/dromaeo/cssquery-mootools.html) 03:38:26 INFO - PROCESS | 11029 | RSS: Main: 248033280 03:38:26 INFO - PROCESS | 11029 | 03:41:28 INFO - PROCESS | 11029 | Cycle 1(1): loaded http://localhost:54017/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54017/tests/dromaeo/cssquery-prototype.html) 03:41:28 INFO - PROCESS | 11029 | RSS: Main: 243687424 03:41:28 INFO - PROCESS | 11029 | 03:44:31 INFO - PROCESS | 11029 | Cycle 1(1): loaded http://localhost:54017/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54017/tests/dromaeo/cssquery-yui.html) 03:44:32 INFO - PROCESS | 11029 | RSS: Main: 214847488 03:44:32 INFO - PROCESS | 11029 | 03:47:35 INFO - PROCESS | 11029 | Cycle 1(1): loaded http://localhost:54017/tests/dromaeo/cssquery-yui.html (next: http://localhost:54017/tests/dromaeo/cssquery-dojo.html) 03:47:35 INFO - PROCESS | 11029 | RSS: Main: 283148288 03:47:35 INFO - PROCESS | 11029 | 03:47:35 INFO - PROCESS | 11029 | __start_tp_report 03:47:35 INFO - PROCESS | 11029 | _x_x_mozilla_page_load 03:47:35 INFO - PROCESS | 11029 | _x_x_mozilla_page_load_details 03:47:35 INFO - PROCESS | 11029 | |i|pagename|runs| 03:47:35 INFO - PROCESS | 11029 | |0;dojo.html;2640.4983053219885;2662.41426886085;2687.1132526266333;2700.8109432339743;2708.3229192701824;4604.171249175156;4667.649926255532;4676.672632915697;4756;4814.1334559779225;4650.906981860361;4673.929891051628;4674.088552732219;4678.789454474549;4711.128441238373;4209.9579004209945;4285.142971405731;4336.783160841946;4364.563543645626;4489.753063581502;4389.978050109745;4421.159979603881;4422.97788511057;4453.376527286183;4466.754328511931;4234.957650423487;4286.057067445157;4289.335153051282;4317.395564620955;4322.913541729179;4291.098869237464;4297.312430011214;4302.720323178984;4345.50026746925;4349.043210493686;4316.417283666696;4333.848315308949;4347.413099231595;4366.541513141106;4373.475182978032;4483.3723278741;4531.116432295704;4608.285715714036;4646.4191976003;4659.534046595347;5140.3060586820675;5155.097857874857;5160.664556803833;5164.483551644843;5167.457416971239;5123.564497017758;5148;5191.143461328877;5199.194124910645;5201.323827902386;4584.106099310636;4666;4736.928946065812;4743.928841067387;4762.714237145782;5171.922421163686;5205.453427390145;5209.47905209476;5213.087709650796;5213.165893457104;4813.085513752376;4994.650374473825;5001.074801161797;5003.324551185616;5005.174146265826;5038.2190760432195;5075.695458272442;5085.923711144335;5095.286659867622;5113.207452844815;5059.696418214919;5063.772130254148;5070.036693028313;5071.873203169876;5118.925025744636;4828.130936431476;4850.369451971221;4989.725565093882;4990.101781679333;5032.798688052437;4247.915041699149;4267.274563324242;4273.059926816096;4297.290946993711;4314.61168494837;3719.925601487955;3736.645018723217;3746.550413950289;3778.792166430818;3779.074126838942;4240.597143271384;4249.936250956238;4287.828486860491;4336.02439451121;4342.826286948487;5032.798688052437;5069.847904562869;5082.110630639697;5099.311592934906;5112.539871411591;4313.654907607384;4315.741055536678;4338.804753786024;4358.912821743547;4361.6074553290355;4312.137572485452;4526.909461810746;4538.341940418621;4541.977290113528;4571.017231295221;4821.63837712166;4833.130036593307;4839.661223714376;4877.609791216694;4891.6575839692305;5104.69371837691;5111.488851114858;5112.667676601009;5116.181410974226;5118.590512759045;4640.535946405333;4679.532046795293;4689.648276379217;4730.952690473051;4866.197077482176;4936.8765780855765;4946.35697359341;4953.133201689762;4960.751962401793;5002.574781143498;5006.199008158823;5020.824271150492;5023.824166154167;5039.395272567315;5041;4721.763911804464;4838.177509823409;4875.3174555562955;4880.292357608198;4943.085529177114;4864.562189402971;4871.805127794849;4889.559939605452;4893.437254715754;4931.580815630711;4810.5670489656095;4826.686265392738;4830.927536086891;4859.927101093415;4866.124097662455;4797.112534181188;4928.457869634266;4972.154733695208;4975.253711943237;5002.599792016703;4871.269309603588;4882.487338829514;4896;4898.436679781871;4944.431390390151 03:47:35 INFO - PROCESS | 11029 | |1;ext.html;539.3455432524632;581.9447152520511;582.1093726598303;584.7105682687071;597.2951916738249;26925;39426.605733942684;39677.801610991904;39749.40375894364;40248.396274055915;41634.37548436768;41882;41968;42055.36916946241;42179;7507;7817.296443320086;7937.722179723682;7984.401169912251;10000.94999525005;10112.747181320488;10241.641542546013;10257.589696412171;10263.640772572962;10266.794664106714;10223.846642300372;10290.279680422373;10291.948540257326;10297.124744396735;10298.639547615834;7449.441291903102;7611.695532178706;9909.108180263811;10136.54385552652;10156.238282128834;10075.848862267;10159.33964292326;10171.949140254252;10173.59305627774;10180.287379883412;37618;37957;37998.43002354967;38055.42916856249;38121.23757524834;3110.797798143136;3159.4786860168274;3161.1780936956325;3171.1120886151916;3219.1791093271067;28822.135335939955;29108.41783164346;29480;29627.70372296271;30169.245768855733;3407.267437500949;3524.330377228344;3525.383057964846;3549.680528752425;3618.240169564395;259140;259583;260430;260952;261809;31960.200994975312;32942;56171.71914140403;56727.43272567304;56747.71626141843;34235;34421;34467.31065378729;34490.13774655654;34544.654553454646;13588.660283492794;13723.039387242998;13728.244946528037;13731.45074197021;13738.519151829638;9149.268058555299;11887.10846686502;12054.09594280415;12081.395930203455;12082.456289466994;7906.723264685708;7922.603869806487;7925.8811117833275;7991.8401631967035;8005.8398832024195;3089.335792804558;3094.9381012379627;3118.7037231462973;3123.5783169272313;3136.6236051673945;822.621594066724;893.1113542025596;916.1205242966694;921.7649499377616;944.8535477001076;26185.214443566725;27390.45219095647;27732.30669233245;28049.43901121966;28076.57885131725;966.3139171188535;989.218517371283;1003.287665757306;1068.1828401273033;1098.3135540287321;14648.194349310677;14690.55928322152;14824.481143160154;15187.544373668808;15255.771163432557;375611;377460;378974;379941;380740;49216.50783492191;49740.502594974314;49994;50098.749506252236;50117.49882501128;1092.956281748721;1114.0419239453902;1135;1245.9688507787378;1255.1465003797505;20472.897635511727;28031;28323.150305490868;30736.23159420943;30749.23126921845;45467;46117.30824037575;46120.769396152806;46191.538084618725;46248;329800;337638;339497;339901;340429;22833.31500055001;23519.41201469977;23541.764582353957;25199.244022679348;25620.23139305824;33808;35346.29307413786;41704;42701.145977079665;47153.52846471492;34831.82584087063;35880.282394352485;36755.81622091872;36887.26225475529;37010.8149459251;36050;36395.09012274714;36427.27145457023;36467.45298820467;36765.44851827171;35194;35573.28853422865;36236.09409764777;36293.09267268339;36428;30942.53586196254;32699.34601308008;32862.83568582142;32891;33047.834760826045;24614.630780537947;25379.492410152063;25475.490490190463;25547.744522554538;25858.612120817827 03:47:35 INFO - PROCESS | 11029 | |2;jquery.html;359.53440294818216;360.1105269983141;361.8190904547726;370.90356507308127;379.8499592660899;15884.523464296075;16647;17481.650366992653;17524.649507009854;17542.824571754278;14822.481213157542;15042.774358384633;15306.770398444032;15423.228838558056;15450.5364839055;4763.999999999991;4972.776225069862;4990.451050384455;4993.400791904976;5002.274670172823;3736.458213559032;3907.6483116519507;5098.821541246057;5759.913601295984;6151.477124444427;6162.938370616282;6165.1677023601915;6168.75324987;6175.50595952325;6197.969010154943;5985.670788106652;6087.086936959469;6157.076438534211;6188.659623720693;6193.504519638441;3319.3195394943978;4849.539293767087;5148.794048238066;5172.172452407597;5331.360236771612;20525.281615143398;20654.5869082619;20669.689954650694;21053.894730526248;21055;1836.706127019684;2011.688188330811;2102.1486298049313;2186.8031877130975;2555.565553855849;8467.195616416431;8694.478331300143;9066.501342426163;9132.81734365309;12842.101052926299;1734.66846012057;1794.7666803315617;1807.4939017075108;1819.0995457248746;1883.3991107558602;66457.3354266456;68471.65764171147;68578;68680.6565967167;69600.30399695989;9593.616255349847;9648.469334186688;9667.419954802734;9835.803283934425;9965.302428829913;13656.65858353549;13737.862621373859;13760.243186624832;13769.242691652054;13790.931045344709;7345.70617175307;7462.626868656545;7616.5810880401;7691.653875575613;7796;7293.343599076109;7380.704771809175;7444.553326800409;7534.849303013909;7535.73624923125;4186.670642612184;4191.098913733501;4204.873853784391;4271.829126834892;4331.675124365685;1627.9755803662954;1690.5689049292353;1709.333359989605;1728.0063963220946;1781.4946370317061;758.1236439811532;875.33911896519;915.2906497464518;940.6237504997919;940.9905900941039;15914.840851591567;16563.503094907173;16683.49949501517;16768.664626707643;17187;828.0394742099136;832.5837081459271;862.4135587800231;872.6727477196051;881.8976279650437;9476.241900648069;10438.135961516295;10451.738706532398;10461.372317660966;10513.211509136692;367293;369089;374414;376701;379518;79726;79880.20119798728;80939.59530202311;81497.18502815014;81906.18093819104;848.9830203395898;895.9283257339528;916.3493919317226;940.1022023967232;942.6794889737522;14008.649783755487;15714.371425143323;15924.68150637004;16360.34558617642;16415.83584164143;28907.988220412186;32506.83746581252;34963.82518087393;35263.3801067925;36887.077823054635;48445.27332089951;48449.75775121102;48606.27090593573;49211;49292.2606160915;7576.204498527795;7769.028871391076;7853.253940875607;7977.2022797719765;7979.72070977513;8642.740717778477;10993.395363255098;11740.41297935117;11866.584669536525;12094;10008.44953527563;10364.170866330525;10382.3251488653;10754.300970436896;10960.177986650873;9782.168515676247;9883;10092.24308176875;10284.434356110485;10598.31110977784;10108.292419530857;10120.089191972758;10144.137748291183;10245;10925.508352124014;7696.884546731915;7872.488288261245;7876.054873415227;7890.723824666109;7943;7467.327940485382;9311.627534898527;9946.751331216778;10014.449205293487;10019 03:47:35 INFO - PROCESS | 11029 | |3;mootools.html;1254.385351177923;1414.8443671196167;1455.6506438454771;1549.5196489088382;1743.3898135652523;6676.332366763321;7679.1552929177815;7898.960505197473;7919.604019799001;8078.555679437629;7869.80325491863;8008.9599552002155;8029.799255018627;8036.718714844981;8065.072516660586;1826.306003718585;2039.2250944641016;2114.513661857766;2143.742750869898;2171.6308227601344;2135.4661334666334;2151.4621344663833;2152.1283880028614;2156.644153714635;2157.2988778646923;2084.405944305873;2100.747910250772;2125.957480850382;2127.064091799611;2129.361191642501;1790.1496789025239;2022.2719820864477;2035.8880261585607;2074.388055523624;2074.3984244569056;2119.491322082689;2145.3885642591786;2145.603063433254;2148.054855863415;2151.87088774674;7682.731104411375;7738.148803631596;7747.225277472264;7748.6125693715085;7787.4938129022;4432.911341773147;4577.038821847416;4577.5193604671695;4577.5880170784785;4583.8166473341025;2708.4312294418196;2869.6126022987046;2871.267826704198;2883.351245969661;2888.3068063664778;835.6197929941862;844;850.4812064640564;854.1842540373927;870.2863651805523;10901.618443354524;10935.398553079578;10963;10996.505157267862;11046.668599942015;4004.0990777074926;4042.211768705133;4099.85650502231;4166.812493437803;4167.124903770182;9233.769155771159;9289.767755806024;9332.34673572857;9359.906400935903;9373.43759374426;4627.143978363946;4634.420697412824;4637.39713837199;4637.536246375403;4638.327442520816;3619.819009049537;4073.572274911151;4212.831486740557;4214.220369231702;4260.616544511009;3697.6672099511175;3709.4250391189407;3783.7729736215915;3814.294355544233;3834.69322454203;1183.3373310945897;1193.462941676249;1196.4316949448942;1203.9458224379923;1206.258151236983;745.2584678245181;860.3117505995178;901.7911678096353;903.0969030969031;907.1518130547959;5316.952973105383;5384;5503.9174412383045;5561.499465048165;5575.916361254584;855.7261676263661;878.2096113497903;909.4997751236793;915.3226612306845;924.7595625137512;3712.7029837612927;3718.3492888744363;3773.4905787718853;3774.358359078908;3871.864484743077;9526.571304291323;9800.607975681036;9982;9989.900100998897;10005.549750261256;9817.901820981699;9896.60413583463;9917.801643967081;9934.254930880214;9937.155341795884;7012.824679383056;7390.519616225036;7506.962465187639;7508.310630108291;7511.474196806281;5632.211490391431;5685.658860468385;5729.255196824386;5787.131930210502;5900.232969713909;9197.724068277963;9218.400803947721;9310.162085412345;9377.531123443665;9408.059194080537;9240.214581760625;9343.392679475812;9379.85930211061;9397.859032114387;9440.386374885611;6207.720652570555;6305;6320.778772742932;6795.082663840516;6931.514793964374;7029.753958611424;7117.572945623279;7215.278472152742;7439.92560074414;7466.25337466249;6805.523613347018;6912.619805910723;6925.68834402443;7004.684789184397;7016.894746578908;6737.966310168418;6780.932190678227;6880.449564034765;6960.443164546926;6993.790186294419;6004.849878753066;6185.041318595625;6488.12410324619;6562.376574225441;6564;4769.14155452022;4771.95228047715;4787.61699064067;4864.100141473838;4935.284383764406;4493.0789188216995;4530.456345238593;4569.908601828011;4632.536746325341;4708.081924024782 03:47:35 INFO - PROCESS | 11029 | |4;prototype.html;283.4147485442561;283.4642525626566;291.8555315119016;293.7092278644142;298.0982527853245;4751.596114330282;4824.022150918125;4829.309741590441;4842.612590992721;4889.804407823692;4827.251775974721;4836.613070954324;4841.3222148899185;4841.733704646252;4845.594777514517;3569.125564236759;3679;3709.332320182366;3771;3805.904852378685;3744.8314825832904;3786.7159963002887;3812.9809350953346;3819.178876541543;3820.923581528368;3743.1952130291984;3754.8498060077563;3756.605556416578;3761.2134236237707;3772.302124107049;3536.717062634983;3641.4173732202853;3741.7942013189263;3758.1544152565725;3763.153290509641;3282.4091663500562;3283.753718471124;3286.2441638423297;3301.752368572367;3321.368939901411;4541.84103556374;4584.129015487047;4589.128065667546;4594.402727645384;4602.516735742733;4039.939400908989;4238.745675259494;4261.509926358446;4271.825248056809;4276.358546218092;4972.5276098770555;4992.87517812054;5015.473375295578;5028.32117664118;5040.722760248185;3508.859645614172;3523.119220194951;3525.7531972761917;3528.2943411317838;3544.2557063016798;5029.899402011976;5234;5240.161574148118;5247.895042099175;5265.52610265078;3522.0490467573613;3541.575010998645;3542.2738338640515;3558.679718825318;3559.7330200235087;3600.837962291703;3602.6757591816863;3606.9819650901577;3611.1694310308776;3614.5120408744483;4122.103832237144;4149.605787450188;4155.646770024521;4159.542450330461;4167.687423443193;4900.066406035491;4930.827421040246;4996.650234483552;5004.674696144739;5023.196288593807;1262.1291308996763;1268.7208814060891;1268.7652784234947;1276.387334079647;1278.9872101278868;795.7374066558021;804.1958041958042;817.1420008990655;834.5159807311744;863.8445079885555;4445.955200527874;4456.777161141995;4461.286194208911;4473.865784026484;4474.955250447454;5107.770150343244;5148.665336753174;5159.819406320836;5183.922241166386;5197.648611361074;4242.130363275521;4401.757903315284;4402.977985110118;4430.601245887886;4457.821687132543;2774.500589893798;2779.5969584410145;2781.401998570317;2792.1623512946035;2795.5107856125096;4851.830185943475;4899.2896030075435;4942.579880710108;4973.005398920231;4973.278874563168;5087.669301495391;5351.759170837322;5358.4373640767935;5369.167778994184;5377.3816011159215;4930.186519224288;4973.303737476756;4980.277859710394;4999;5000.974995125001;5243.292155558951;5255.237990491434;5271.841844744664;5276.736163191902;5287.89424211506;4892.510748925079;5123.87190320245;5157.896842063063;5165.92251116226;5175.14610089331;4954.504549545017;4956.182229932021;4960.801567937242;4972.825951091694;4977.900441991213;3648.726345524043;3679.3193259247123;3680.0799800049986;3683.4106542953;3686.4838922551403;5084.923726144185;5213.218017297436;5222.3733152022005;5247.763850626655;5257.342832145981;5029.119904016856;5032.6411868794485;5066.240063990431;5070.298681962115;5086.3896332440345;4990.326305948651;5052.317937078447;5094.414142373526;5106.106431374569;5112.309838171799;4829.08114140113;4886.169351210374;4989.55094041538;5000.524950129732;5032.446430892672;4861;4986.750662466789;5110.386753589593;5130.6152038598;5165.560927321219;4985.75071246429;5000.199968005102;5040.269160971712;5046.394432668103;5051.004853082938 03:47:35 INFO - PROCESS | 11029 | |5;yui.html;625.3215261441337;697.7801992372403;715.9904534606203;744.4193529047345;774.5314084978589;12431.564895228668;13441.46234150634;13715.177089374632;14038.92980535096;14279.714405711906;13814.1020833646;13885.652858678539;13894;13996.790048149285;13998;633.7243299164855;767.2327672327673;792.2434075457952;798.8042929482256;800.0839039299983;795.9721409750659;797.8364435290752;800.4116974024088;800.7357572001225;800.7677773445694;834.2158371131147;834.7913021744564;835.064727505195;836.1304243586693;836.1346006882877;654.6988385342748;792.4690457393531;812.4312980913385;813.80061884838;815.2418251026543;594.8037147741235;594.9434803693642;595.6158277910766;596.3916804859062;596.472122171881;13114.60656180316;13178.472861085545;13190.208587484782;13205;13218.140820846711;11723.179377443583;11932.761344773142;12016.158868879182;12093;12282.877171228352;12020.819687704692;12127.21173123753;12213.572524961584;12255.571055013032;12466.563670271496;4121.62905338521;4150.875473735793;4183.748975061476;4240.9151816963795;4242.3212286034395;49174;51755;51988.74005629985;57924.84150317012;58711.41288587145;10473.109785668152;10493.317934334244;10518.368897866;10580.153587712965;10656;18812.24751009944;18840.717389239173;18855.151518181716;18887.622247554973;19012.904935475235;6504.284528701839;6562.704678289489;6677.298883617247;6692.397684208445;6702.463802895757;3554;3622.076370525499;3634.309481198564;3643.28955853606;3665.8533658653887;2806.7614252788335;2898.7970842041277;2899.3041669999047;2910.3451723362073;2910.563415487694;516.1277441124488;542.3410556174267;548.5364866687643;554.7919530176184;555.9499645031885;481.8554433669885;502.7205761337405;529.0318716748342;532.5233915645475;597.8087012156068;8374.49753014821;8566.27186689126;8639.179277968582;8762.003426704347;8867.379283450096;490.23278569039337;546.0416968220748;561.5732043646858;581.7411251992908;608.2184393054991;3786;3968.2857085724268;4076.4496792932573;4118.485189351331;4180.498340199196;55255;67622.9856552152;91067;96697;97220.51389743148;50556.747216263684;52032.73983630058;77833;81049;81996.18003820005;72384.63807681033;74897.62551187209;75279.62360188273;75444.24555754483;75673.62163189259;7448.553086814808;7761.185075566984;7798.922010780047;7802.414818888493;7895.921040789748;31216.687833121377;31578.842105789325;32234.83882580666;37815.62184378121;40716.592834072464;41339.7933010333;41429;46056.53943460523;60810;62594.68702656458;11207.66377008691;11247.66257012291;11387.829182562435;11497.310161390344;11743.823842642196;12362.134650574373;12580.622581322576;12702.36488175606;12727.681807954876;12778.68053298675;11517.424128793695;11882.584109556125;12330.753384932072;12341.62975110748;12434.129610927148;11972.56805653826;12353.814692779435;12373.267533604538;12424;12745.872541274839;10660.46697665129;11029.283096598696;11136.554537818396;11410.372429516456;11555.306681599131;10177.109423725977;10362.844557331797;10574.048335649828;10630.25588208849;10661.307015043998;9473.663216258812;9680.5643746033;9952.203823693942;10272.948635256776;10403.271770975958 03:47:35 INFO - PROCESS | 11029 | __end_tp_report 03:47:35 INFO - PROCESS | 11029 | __start_cc_report 03:47:35 INFO - PROCESS | 11029 | _x_x_mozilla_cycle_collect,1048 03:47:35 INFO - PROCESS | 11029 | __end_cc_report 03:47:35 INFO - PROCESS | 11029 | __startTimestamp1465469255448__endTimestamp 03:47:35 INFO - PROCESS | 11029 | 03:47:35 INFO - PROCESS | 11029 | ------- Summary: start ------- 03:47:35 INFO - PROCESS | 11029 | Number of tests: 6 03:47:35 INFO - PROCESS | 11029 | 03:47:35 INFO - PROCESS | 11029 | [#0] dojo.html Cycles:165 Average:4666.30 Median:4814.13 stddev:493.01 (10.2%) stddev-sans-first:468.21 03:47:35 INFO - PROCESS | 11029 | Values: 2640.5 2662.4 2687.1 2700.8 2708.3 4604.2 4667.6 4676.7 4756.0 4814.1 4650.9 4673.9 4674.1 4678.8 4711.1 4210.0 4285.1 4336.8 4364.6 4489.8 4390.0 4421.2 4423.0 4453.4 4466.8 4235.0 4286.1 4289.3 4317.4 4322.9 4291.1 4297.3 4302.7 4345.5 4349.0 4316.4 4333.8 4347.4 4366.5 4373.5 4483.4 4531.1 4608.3 4646.4 4659.5 5140.3 5155.1 5160.7 5164.5 5167.5 5123.6 5148.0 5191.1 5199.2 5201.3 4584.1 4666.0 4736.9 4743.9 4762.7 5171.9 5205.5 5209.5 5213.1 5213.2 4813.1 4994.7 5001.1 5003.3 5005.2 5038.2 5075.7 5085.9 5095.3 5113.2 5059.7 5063.8 5070.0 5071.9 5118.9 4828.1 4850.4 4989.7 4990.1 5032.8 4247.9 4267.3 4273.1 4297.3 4314.6 3719.9 3736.6 3746.6 3778.8 3779.1 4240.6 4249.9 4287.8 4336.0 4342.8 5032.8 5069.8 5082.1 5099.3 5112.5 4313.7 4315.7 4338.8 4358.9 4361.6 4312.1 4526.9 4538.3 4542.0 4571.0 4821.6 4833.1 4839.7 4877.6 4891.7 5104.7 5111.5 5112.7 5116.2 5118.6 4640.5 4679.5 4689.6 4731.0 4866.2 4936.9 4946.4 4953.1 4960.8 5002.6 5006.2 5020.8 5023.8 5039.4 5041.0 4721.8 4838.2 4875.3 4880.3 4943.1 4864.6 4871.8 4889.6 4893.4 4931.6 4810.6 4826.7 4830.9 4859.9 4866.1 4797.1 4928.5 4972.2 4975.3 5002.6 4871.3 4882.5 4896.0 4898.4 4944.4 03:47:35 INFO - PROCESS | 11029 | 03:47:35 INFO - PROCESS | 11029 | [#1] ext.html Cycles:180 Average:47097.88 Median:186652.50 stddev:86721.43 (46.5%) stddev-sans-first:86894.25 03:47:35 INFO - PROCESS | 11029 | Values: 539.3 581.9 582.1 584.7 597.3 26925.0 39426.6 39677.8 39749.4 40248.4 41634.4 41882.0 41968.0 42055.4 42179.0 7507.0 7817.3 7937.7 7984.4 10000.9 10112.7 10241.6 10257.6 10263.6 10266.8 10223.8 10290.3 10291.9 10297.1 10298.6 7449.4 7611.7 9909.1 10136.5 10156.2 10075.8 10159.3 10171.9 10173.6 10180.3 37618.0 37957.0 37998.4 38055.4 38121.2 3110.8 3159.5 3161.2 3171.1 3219.2 28822.1 29108.4 29480.0 29627.7 30169.2 3407.3 3524.3 3525.4 3549.7 3618.2 259140.0 259583.0 260430.0 260952.0 261809.0 31960.2 32942.0 56171.7 56727.4 56747.7 34235.0 34421.0 34467.3 34490.1 34544.7 13588.7 13723.0 13728.2 13731.5 13738.5 9149.3 11887.1 12054.1 12081.4 12082.5 7906.7 7922.6 7925.9 7991.8 8005.8 3089.3 3094.9 3118.7 3123.6 3136.6 822.6 893.1 916.1 921.8 944.9 26185.2 27390.5 27732.3 28049.4 28076.6 966.3 989.2 1003.3 1068.2 1098.3 14648.2 14690.6 14824.5 15187.5 15255.8 375611.0 377460.0 378974.0 379941.0 380740.0 49216.5 49740.5 49994.0 50098.7 50117.5 1093.0 1114.0 1135.0 1246.0 1255.1 20472.9 28031.0 28323.2 30736.2 30749.2 45467.0 46117.3 46120.8 46191.5 46248.0 329800.0 337638.0 339497.0 339901.0 340429.0 22833.3 23519.4 23541.8 25199.2 25620.2 33808.0 35346.3 41704.0 42701.1 47153.5 34831.8 35880.3 36755.8 36887.3 37010.8 36050.0 36395.1 36427.3 36467.5 36765.4 35194.0 35573.3 36236.1 36293.1 36428.0 30942.5 32699.3 32862.8 32891.0 33047.8 24614.6 25379.5 25475.5 25547.7 25858.6 03:47:35 INFO - PROCESS | 11029 | 03:47:35 INFO - PROCESS | 11029 | [#2] jquery.html Cycles:180 Average:23768.82 Median:4301.75 stddev:61804.54 (1436.7%) stddev-sans-first:61952.93 03:47:35 INFO - PROCESS | 11029 | Values: 359.5 360.1 361.8 370.9 379.8 15884.5 16647.0 17481.7 17524.6 17542.8 14822.5 15042.8 15306.8 15423.2 15450.5 4764.0 4972.8 4990.5 4993.4 5002.3 3736.5 3907.6 5098.8 5759.9 6151.5 6162.9 6165.2 6168.8 6175.5 6198.0 5985.7 6087.1 6157.1 6188.7 6193.5 3319.3 4849.5 5148.8 5172.2 5331.4 20525.3 20654.6 20669.7 21053.9 21055.0 1836.7 2011.7 2102.1 2186.8 2555.6 8467.2 8694.5 9066.5 9132.8 12842.1 1734.7 1794.8 1807.5 1819.1 1883.4 66457.3 68471.7 68578.0 68680.7 69600.3 9593.6 9648.5 9667.4 9835.8 9965.3 13656.7 13737.9 13760.2 13769.2 13790.9 7345.7 7462.6 7616.6 7691.7 7796.0 7293.3 7380.7 7444.6 7534.8 7535.7 4186.7 4191.1 4204.9 4271.8 4331.7 1628.0 1690.6 1709.3 1728.0 1781.5 758.1 875.3 915.3 940.6 941.0 15914.8 16563.5 16683.5 16768.7 17187.0 828.0 832.6 862.4 872.7 881.9 9476.2 10438.1 10451.7 10461.4 10513.2 367293.0 369089.0 374414.0 376701.0 379518.0 79726.0 79880.2 80939.6 81497.2 81906.2 849.0 895.9 916.3 940.1 942.7 14008.6 15714.4 15924.7 16360.3 16415.8 28908.0 32506.8 34963.8 35263.4 36887.1 48445.3 48449.8 48606.3 49211.0 49292.3 7576.2 7769.0 7853.3 7977.2 7979.7 8642.7 10993.4 11740.4 11866.6 12094.0 10008.4 10364.2 10382.3 10754.3 10960.2 9782.2 9883.0 10092.2 10284.4 10598.3 10108.3 10120.1 10144.1 10245.0 10925.5 7696.9 7872.5 7876.1 7890.7 7943.0 7467.3 9311.6 9946.8 10014.4 10019.0 03:47:35 INFO - PROCESS | 11029 | 03:47:35 INFO - PROCESS | 11029 | [#3] mootools.html Cycles:180 Average:5209.55 Median:5604.06 stddev:2967.10 (52.9%) stddev-sans-first:2960.54 03:47:35 INFO - PROCESS | 11029 | Values: 1254.4 1414.8 1455.7 1549.5 1743.4 6676.3 7679.2 7899.0 7919.6 8078.6 7869.8 8009.0 8029.8 8036.7 8065.1 1826.3 2039.2 2114.5 2143.7 2171.6 2135.5 2151.5 2152.1 2156.6 2157.3 2084.4 2100.7 2126.0 2127.1 2129.4 1790.1 2022.3 2035.9 2074.4 2074.4 2119.5 2145.4 2145.6 2148.1 2151.9 7682.7 7738.1 7747.2 7748.6 7787.5 4432.9 4577.0 4577.5 4577.6 4583.8 2708.4 2869.6 2871.3 2883.4 2888.3 835.6 844.0 850.5 854.2 870.3 10901.6 10935.4 10963.0 10996.5 11046.7 4004.1 4042.2 4099.9 4166.8 4167.1 9233.8 9289.8 9332.3 9359.9 9373.4 4627.1 4634.4 4637.4 4637.5 4638.3 3619.8 4073.6 4212.8 4214.2 4260.6 3697.7 3709.4 3783.8 3814.3 3834.7 1183.3 1193.5 1196.4 1203.9 1206.3 745.3 860.3 901.8 903.1 907.2 5317.0 5384.0 5503.9 5561.5 5575.9 855.7 878.2 909.5 915.3 924.8 3712.7 3718.3 3773.5 3774.4 3871.9 9526.6 9800.6 9982.0 9989.9 10005.5 9817.9 9896.6 9917.8 9934.3 9937.2 7012.8 7390.5 7507.0 7508.3 7511.5 5632.2 5685.7 5729.3 5787.1 5900.2 9197.7 9218.4 9310.2 9377.5 9408.1 9240.2 9343.4 9379.9 9397.9 9440.4 6207.7 6305.0 6320.8 6795.1 6931.5 7029.8 7117.6 7215.3 7439.9 7466.3 6805.5 6912.6 6925.7 7004.7 7016.9 6738.0 6780.9 6880.4 6960.4 6993.8 6004.8 6185.0 6488.1 6562.4 6564.0 4769.1 4772.0 4787.6 4864.1 4935.3 4493.1 4530.5 4569.9 4632.5 4708.1 03:47:35 INFO - PROCESS | 11029 | 03:47:35 INFO - PROCESS | 11029 | [#4] prototype.html Cycles:180 Average:4180.07 Median:4838.97 stddev:1229.85 (25.4%) stddev-sans-first:1198.02 03:47:35 INFO - PROCESS | 11029 | Values: 283.4 283.5 291.9 293.7 298.1 4751.6 4824.0 4829.3 4842.6 4889.8 4827.3 4836.6 4841.3 4841.7 4845.6 3569.1 3679.0 3709.3 3771.0 3805.9 3744.8 3786.7 3813.0 3819.2 3820.9 3743.2 3754.8 3756.6 3761.2 3772.3 3536.7 3641.4 3741.8 3758.2 3763.2 3282.4 3283.8 3286.2 3301.8 3321.4 4541.8 4584.1 4589.1 4594.4 4602.5 4039.9 4238.7 4261.5 4271.8 4276.4 4972.5 4992.9 5015.5 5028.3 5040.7 3508.9 3523.1 3525.8 3528.3 3544.3 5029.9 5234.0 5240.2 5247.9 5265.5 3522.0 3541.6 3542.3 3558.7 3559.7 3600.8 3602.7 3607.0 3611.2 3614.5 4122.1 4149.6 4155.6 4159.5 4167.7 4900.1 4930.8 4996.7 5004.7 5023.2 1262.1 1268.7 1268.8 1276.4 1279.0 795.7 804.2 817.1 834.5 863.8 4446.0 4456.8 4461.3 4473.9 4475.0 5107.8 5148.7 5159.8 5183.9 5197.6 4242.1 4401.8 4403.0 4430.6 4457.8 2774.5 2779.6 2781.4 2792.2 2795.5 4851.8 4899.3 4942.6 4973.0 4973.3 5087.7 5351.8 5358.4 5369.2 5377.4 4930.2 4973.3 4980.3 4999.0 5001.0 5243.3 5255.2 5271.8 5276.7 5287.9 4892.5 5123.9 5157.9 5165.9 5175.1 4954.5 4956.2 4960.8 4972.8 4977.9 3648.7 3679.3 3680.1 3683.4 3686.5 5084.9 5213.2 5222.4 5247.8 5257.3 5029.1 5032.6 5066.2 5070.3 5086.4 4990.3 5052.3 5094.4 5106.1 5112.3 4829.1 4886.2 4989.6 5000.5 5032.4 4861.0 4986.8 5110.4 5130.6 5165.6 4985.8 5000.2 5040.3 5046.4 5051.0 03:47:35 INFO - PROCESS | 11029 | 03:47:35 INFO - PROCESS | 11029 | [#5] yui.html Cycles:180 Average:16176.78 Median:4182.12 stddev:21970.53 (525.3%) stddev-sans-first:22001.13 03:47:35 INFO - PROCESS | 11029 | Values: 625.3 697.8 716.0 744.4 774.5 12431.6 13441.5 13715.2 14038.9 14279.7 13814.1 13885.7 13894.0 13996.8 13998.0 633.7 767.2 792.2 798.8 800.1 796.0 797.8 800.4 800.7 800.8 834.2 834.8 835.1 836.1 836.1 654.7 792.5 812.4 813.8 815.2 594.8 594.9 595.6 596.4 596.5 13114.6 13178.5 13190.2 13205.0 13218.1 11723.2 11932.8 12016.2 12093.0 12282.9 12020.8 12127.2 12213.6 12255.6 12466.6 4121.6 4150.9 4183.7 4240.9 4242.3 49174.0 51755.0 51988.7 57924.8 58711.4 10473.1 10493.3 10518.4 10580.2 10656.0 18812.2 18840.7 18855.2 18887.6 19012.9 6504.3 6562.7 6677.3 6692.4 6702.5 3554.0 3622.1 3634.3 3643.3 3665.9 2806.8 2898.8 2899.3 2910.3 2910.6 516.1 542.3 548.5 554.8 555.9 481.9 502.7 529.0 532.5 597.8 8374.5 8566.3 8639.2 8762.0 8867.4 490.2 546.0 561.6 581.7 608.2 3786.0 3968.3 4076.4 4118.5 4180.5 55255.0 67623.0 91067.0 96697.0 97220.5 50556.7 52032.7 77833.0 81049.0 81996.2 72384.6 74897.6 75279.6 75444.2 75673.6 7448.6 7761.2 7798.9 7802.4 7895.9 31216.7 31578.8 32234.8 37815.6 40716.6 41339.8 41429.0 46056.5 60810.0 62594.7 11207.7 11247.7 11387.8 11497.3 11743.8 12362.1 12580.6 12702.4 12727.7 12778.7 11517.4 11882.6 12330.8 12341.6 12434.1 11972.6 12353.8 12373.3 12424.0 12745.9 10660.5 11029.3 11136.6 11410.4 11555.3 10177.1 10362.8 10574.0 10630.3 10661.3 9473.7 9680.6 9952.2 10272.9 10403.3 03:47:35 INFO - PROCESS | 11029 | -------- Summary: end -------- 03:47:35 INFO - PROCESS | 11029 | 03:47:36 INFO - TEST-INFO | 11029: exit 0 03:47:36 INFO - TEST-OK | dromaeo_css | took 1120851ms 03:47:36 INFO - TEST-START | kraken 03:47:36 INFO - operating with platform_type : linux_ 03:47:36 INFO - Initialising browser for kraken test... 03:47:36 INFO - TEST-INFO | started process 11205 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgosjmU/profile http://localhost:54017/getInfo.html) 03:47:40 INFO - PROCESS | 11205 | __metrics Screen width/height:1600/1200 03:47:40 INFO - PROCESS | 11205 | colorDepth:24 03:47:40 INFO - PROCESS | 11205 | Browser inner width/height: 1024/697 03:47:40 INFO - PROCESS | 11205 | __metrics 03:47:42 ERROR - PROCESS | 11205 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:47:42 INFO - PROCESS | 11205 | console.error: PushService: 03:47:42 INFO - PROCESS | 11205 | stateChangeProcessEnqueue: Error transitioning state 03:47:42 INFO - PROCESS | 11205 | UnknownError 03:47:43 INFO - TEST-INFO | 11205: exit 0 03:47:43 INFO - Browser initialized. 03:47:43 INFO - Running cycle 1/1 for kraken test... 03:47:43 INFO - TEST-INFO | started process 11285 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgosjmU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:47:55 INFO - PROCESS | 11285 | RSS: Main: 161783808 03:47:55 INFO - PROCESS | 11285 | 03:47:57 INFO - PROCESS | 11285 | Cycle 1(1): loaded http://localhost:54017/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54017/tests/kraken/driver.html?testName=audio-beat-detection) 03:47:58 INFO - PROCESS | 11285 | RSS: Main: 219516928 03:47:58 INFO - PROCESS | 11285 | 03:48:01 INFO - PROCESS | 11285 | Cycle 1(1): loaded http://localhost:54017/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54017/tests/kraken/driver.html?testName=audio-dft) 03:48:02 INFO - PROCESS | 11285 | RSS: Main: 206577664 03:48:02 INFO - PROCESS | 11285 | 03:48:05 INFO - PROCESS | 11285 | Cycle 1(1): loaded http://localhost:54017/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54017/tests/kraken/driver.html?testName=audio-fft) 03:48:05 INFO - PROCESS | 11285 | RSS: Main: 274157568 03:48:05 INFO - PROCESS | 11285 | 03:48:08 INFO - PROCESS | 11285 | Cycle 1(1): loaded http://localhost:54017/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54017/tests/kraken/driver.html?testName=audio-oscillator) 03:48:08 INFO - PROCESS | 11285 | RSS: Main: 184487936 03:48:08 INFO - PROCESS | 11285 | 03:48:10 INFO - PROCESS | 11285 | Cycle 1(1): loaded http://localhost:54017/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54017/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:48:11 INFO - PROCESS | 11285 | RSS: Main: 188149760 03:48:11 INFO - PROCESS | 11285 | 03:48:14 INFO - PROCESS | 11285 | Cycle 1(1): loaded http://localhost:54017/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54017/tests/kraken/driver.html?testName=imaging-darkroom) 03:48:15 INFO - PROCESS | 11285 | RSS: Main: 224690176 03:48:15 INFO - PROCESS | 11285 | 03:48:18 INFO - PROCESS | 11285 | Cycle 1(1): loaded http://localhost:54017/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54017/tests/kraken/driver.html?testName=imaging-desaturate) 03:48:19 INFO - PROCESS | 11285 | RSS: Main: 220663808 03:48:19 INFO - PROCESS | 11285 | 03:48:22 INFO - PROCESS | 11285 | Cycle 1(1): loaded http://localhost:54017/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54017/tests/kraken/driver.html?testName=json-parse-financial) 03:48:22 INFO - PROCESS | 11285 | RSS: Main: 223342592 03:48:22 INFO - PROCESS | 11285 | 03:48:24 INFO - PROCESS | 11285 | Cycle 1(1): loaded http://localhost:54017/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54017/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:48:25 INFO - PROCESS | 11285 | RSS: Main: 211165184 03:48:25 INFO - PROCESS | 11285 | 03:48:27 INFO - PROCESS | 11285 | Cycle 1(1): loaded http://localhost:54017/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54017/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:48:27 INFO - PROCESS | 11285 | RSS: Main: 208760832 03:48:27 INFO - PROCESS | 11285 | 03:48:29 INFO - PROCESS | 11285 | Cycle 1(1): loaded http://localhost:54017/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54017/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:48:30 INFO - PROCESS | 11285 | RSS: Main: 216014848 03:48:30 INFO - PROCESS | 11285 | 03:48:33 INFO - PROCESS | 11285 | Cycle 1(1): loaded http://localhost:54017/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54017/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:48:33 INFO - PROCESS | 11285 | RSS: Main: 222429184 03:48:33 INFO - PROCESS | 11285 | 03:48:36 INFO - PROCESS | 11285 | Cycle 1(1): loaded http://localhost:54017/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54017/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:48:37 INFO - PROCESS | 11285 | RSS: Main: 219967488 03:48:37 INFO - PROCESS | 11285 | 03:48:39 INFO - PROCESS | 11285 | Cycle 1(1): loaded http://localhost:54017/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54017/tests/kraken/driver.html?testName=ai-astar) 03:48:39 INFO - PROCESS | 11285 | RSS: Main: 262131712 03:48:39 INFO - PROCESS | 11285 | 03:48:39 INFO - PROCESS | 11285 | __start_tp_report 03:48:39 INFO - PROCESS | 11285 | _x_x_mozilla_page_load 03:48:39 INFO - PROCESS | 11285 | _x_x_mozilla_page_load_details 03:48:39 INFO - PROCESS | 11285 | |i|pagename|runs| 03:48:39 INFO - PROCESS | 11285 | |0;ai-astar;113;109;115;113;113;114;114;113;114;112 03:48:39 INFO - PROCESS | 11285 | |1;audio-beat-detection;168;135;132;175;138;131;153;139;182;131 03:48:39 INFO - PROCESS | 11285 | |2;audio-dft;160;161;161;161;162;162;163;161;162;160 03:48:39 INFO - PROCESS | 11285 | |3;audio-fft;75;75;77;111;75;79;75;76;97;75 03:48:39 INFO - PROCESS | 11285 | |4;audio-oscillator;86;87;117;87;87;85;127;85;85;120 03:48:39 INFO - PROCESS | 11285 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;116;116;117 03:48:39 INFO - PROCESS | 11285 | |6;imaging-darkroom;146;146;146;146;146;146;147;146;146;146 03:48:39 INFO - PROCESS | 11285 | |7;imaging-desaturate;94;94;95;94;95;95;95;96;96;94 03:48:39 INFO - PROCESS | 11285 | |8;json-parse-financial;64;64;65;64;64;64;63;63;63;62 03:48:39 INFO - PROCESS | 11285 | |9;json-stringify-tinderbox;64;65;64;65;65;65;65;66;64;72 03:48:39 INFO - PROCESS | 11285 | |10;stanford-crypto-aes;88;82;83;84;85;88;85;86;118;86 03:48:39 INFO - PROCESS | 11285 | |11;stanford-crypto-ccm;146;146;130;129;135;131;143;134;143;134 03:48:39 INFO - PROCESS | 11285 | |12;stanford-crypto-pbkdf2;172;173;178;171;168;174;178;168;170;166 03:48:39 INFO - PROCESS | 11285 | |13;stanford-crypto-sha256-iterative;67;70;68;69;68;72;67;66;69;67 03:48:39 INFO - PROCESS | 11285 | __end_tp_report 03:48:39 INFO - PROCESS | 11285 | __start_cc_report 03:48:39 INFO - PROCESS | 11285 | _x_x_mozilla_cycle_collect,1871 03:48:39 INFO - PROCESS | 11285 | __end_cc_report 03:48:39 INFO - PROCESS | 11285 | __startTimestamp1465469319532__endTimestamp 03:48:39 INFO - PROCESS | 11285 | 03:48:39 INFO - PROCESS | 11285 | ------- Summary: start ------- 03:48:39 INFO - PROCESS | 11285 | Number of tests: 14 03:48:39 INFO - PROCESS | 11285 | 03:48:39 INFO - PROCESS | 11285 | [#0] ai-astar Cycles:10 Average:113.00 Median:113.50 stddev:1.63 (1.4%) stddev-sans-first:1.73 03:48:39 INFO - PROCESS | 11285 | Values: 113.0 109.0 115.0 113.0 113.0 114.0 114.0 113.0 114.0 112.0 03:48:39 INFO - PROCESS | 11285 | 03:48:39 INFO - PROCESS | 11285 | [#1] audio-beat-detection Cycles:10 Average:148.40 Median:146.00 stddev:19.70 (13.5%) stddev-sans-first:19.58 03:48:39 INFO - PROCESS | 11285 | Values: 168.0 135.0 132.0 175.0 138.0 131.0 153.0 139.0 182.0 131.0 03:48:39 INFO - PROCESS | 11285 | 03:48:39 INFO - PROCESS | 11285 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:0.88 03:48:39 INFO - PROCESS | 11285 | Values: 160.0 161.0 161.0 161.0 162.0 162.0 163.0 161.0 162.0 160.0 03:48:39 INFO - PROCESS | 11285 | 03:48:39 INFO - PROCESS | 11285 | [#3] audio-fft Cycles:10 Average:81.50 Median:75.50 stddev:12.38 (16.4%) stddev-sans-first:12.90 03:48:39 INFO - PROCESS | 11285 | Values: 75.0 75.0 77.0 111.0 75.0 79.0 75.0 76.0 97.0 75.0 03:48:39 INFO - PROCESS | 11285 | 03:48:39 INFO - PROCESS | 11285 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:85.50 stddev:17.26 (20.2%) stddev-sans-first:17.87 03:48:39 INFO - PROCESS | 11285 | Values: 86.0 87.0 117.0 87.0 87.0 85.0 127.0 85.0 85.0 120.0 03:48:39 INFO - PROCESS | 11285 | 03:48:39 INFO - PROCESS | 11285 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:48:39 INFO - PROCESS | 11285 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 03:48:39 INFO - PROCESS | 11285 | 03:48:39 INFO - PROCESS | 11285 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 03:48:39 INFO - PROCESS | 11285 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 03:48:39 INFO - PROCESS | 11285 | 03:48:39 INFO - PROCESS | 11285 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.79 (0.8%) stddev-sans-first:0.78 03:48:39 INFO - PROCESS | 11285 | Values: 94.0 94.0 95.0 94.0 95.0 95.0 95.0 96.0 96.0 94.0 03:48:39 INFO - PROCESS | 11285 | 03:48:39 INFO - PROCESS | 11285 | [#8] json-parse-financial Cycles:10 Average:63.60 Median:64.00 stddev:0.84 (1.3%) stddev-sans-first:0.88 03:48:39 INFO - PROCESS | 11285 | Values: 64.0 64.0 65.0 64.0 64.0 64.0 63.0 63.0 63.0 62.0 03:48:39 INFO - PROCESS | 11285 | 03:48:39 INFO - PROCESS | 11285 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:65.00 stddev:2.37 (3.6%) stddev-sans-first:2.45 03:48:39 INFO - PROCESS | 11285 | Values: 64.0 65.0 64.0 65.0 65.0 65.0 65.0 66.0 64.0 72.0 03:48:39 INFO - PROCESS | 11285 | 03:48:39 INFO - PROCESS | 11285 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:85.50 stddev:10.54 (12.3%) stddev-sans-first:11.18 03:48:39 INFO - PROCESS | 11285 | Values: 88.0 82.0 83.0 84.0 85.0 88.0 85.0 86.0 118.0 86.0 03:48:39 INFO - PROCESS | 11285 | 03:48:39 INFO - PROCESS | 11285 | [#11] stanford-crypto-ccm Cycles:10 Average:137.10 Median:139.00 stddev:6.71 (4.8%) stddev-sans-first:6.29 03:48:39 INFO - PROCESS | 11285 | Values: 146.0 146.0 130.0 129.0 135.0 131.0 143.0 134.0 143.0 134.0 03:48:39 INFO - PROCESS | 11285 | 03:48:39 INFO - PROCESS | 11285 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.80 Median:172.50 stddev:4.08 (2.4%) stddev-sans-first:4.32 03:48:39 INFO - PROCESS | 11285 | Values: 172.0 173.0 178.0 171.0 168.0 174.0 178.0 168.0 170.0 166.0 03:48:39 INFO - PROCESS | 11285 | 03:48:39 INFO - PROCESS | 11285 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:1.77 (2.6%) stddev-sans-first:1.81 03:48:39 INFO - PROCESS | 11285 | Values: 67.0 70.0 68.0 69.0 68.0 72.0 67.0 66.0 69.0 67.0 03:48:39 INFO - PROCESS | 11285 | -------- Summary: end -------- 03:48:39 INFO - PROCESS | 11285 | 03:48:40 INFO - TEST-INFO | 11285: exit 0 03:48:40 INFO - TEST-OK | kraken | took 64412ms 03:48:40 INFO - SUITE-END | took 1185s 03:48:40 INFO - Completed test suite (00:19:45) 03:48:40 INFO - javascript benchmark 03:48:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2640.4983053219885, 2662.41426886085, 2687.1132526266333, 2700.8109432339743, 2708.3229192701824, 4604.171249175156, 4667.649926255532, 4676.672632915697, 4756.0, 4814.1334559779225, 4650.906981860361, 4673.929891051628, 4674.088552732219, 4678.789454474549, 4711.128441238373, 4209.9579004209945, 4285.142971405731, 4336.783160841946, 4364.563543645626, 4489.753063581502, 4389.978050109745, 4421.159979603881, 4422.97788511057, 4453.376527286183, 4466.754328511931, 4234.957650423487, 4286.057067445157, 4289.335153051282, 4317.395564620955, 4322.913541729179, 4291.098869237464, 4297.312430011214, 4302.720323178984, 4345.50026746925, 4349.043210493686, 4316.417283666696, 4333.848315308949, 4347.413099231595, 4366.541513141106, 4373.475182978032, 4483.3723278741, 4531.116432295704, 4608.285715714036, 4646.4191976003, 4659.534046595347, 5140.3060586820675, 5155.097857874857, 5160.664556803833, 5164.483551644843, 5167.457416971239, 5123.564497017758, 5148.0, 5191.143461328877, 5199.194124910645, 5201.323827902386, 4584.106099310636, 4666.0, 4736.928946065812, 4743.928841067387, 4762.714237145782, 5171.922421163686, 5205.453427390145, 5209.47905209476, 5213.087709650796, 5213.165893457104, 4813.085513752376, 4994.650374473825, 5001.074801161797, 5003.324551185616, 5005.174146265826, 5038.2190760432195, 5075.695458272442, 5085.923711144335, 5095.286659867622, 5113.207452844815, 5059.696418214919, 5063.772130254148, 5070.036693028313, 5071.873203169876, 5118.925025744636, 4828.130936431476, 4850.369451971221, 4989.725565093882, 4990.101781679333, 5032.798688052437, 4247.915041699149, 4267.274563324242, 4273.059926816096, 4297.290946993711, 4314.61168494837, 3719.925601487955, 3736.645018723217, 3746.550413950289, 3778.792166430818, 3779.074126838942, 4240.597143271384, 4249.936250956238, 4287.828486860491, 4336.02439451121, 4342.826286948487, 5032.798688052437, 5069.847904562869, 5082.110630639697, 5099.311592934906, 5112.539871411591, 4313.654907607384, 4315.741055536678, 4338.804753786024, 4358.912821743547, 4361.6074553290355, 4312.137572485452, 4526.909461810746, 4538.341940418621, 4541.977290113528, 4571.017231295221, 4821.63837712166, 4833.130036593307, 4839.661223714376, 4877.609791216694, 4891.6575839692305, 5104.69371837691, 5111.488851114858, 5112.667676601009, 5116.181410974226, 5118.590512759045, 4640.535946405333, 4679.532046795293, 4689.648276379217, 4730.952690473051, 4866.197077482176, 4936.8765780855765, 4946.35697359341, 4953.133201689762, 4960.751962401793, 5002.574781143498, 5006.199008158823, 5020.824271150492, 5023.824166154167, 5039.395272567315, 5041.0, 4721.763911804464, 4838.177509823409, 4875.3174555562955, 4880.292357608198, 4943.085529177114, 4864.562189402971, 4871.805127794849, 4889.559939605452, 4893.437254715754, 4931.580815630711, 4810.5670489656095, 4826.686265392738, 4830.927536086891, 4859.927101093415, 4866.124097662455, 4797.112534181188, 4928.457869634266, 4972.154733695208, 4975.253711943237, 5002.599792016703, 4871.269309603588, 4882.487338829514, 4896.0, 4898.436679781871, 4944.431390390151], "value": 4635.161946309938, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.3455432524632, 581.9447152520511, 582.1093726598303, 584.7105682687071, 597.2951916738249, 26925.0, 39426.605733942684, 39677.801610991904, 39749.40375894364, 40248.396274055915, 41634.37548436768, 41882.0, 41968.0, 42055.36916946241, 42179.0, 7507.0, 7817.296443320086, 7937.722179723682, 7984.401169912251, 10000.94999525005, 10112.747181320488, 10241.641542546013, 10257.589696412171, 10263.640772572962, 10266.794664106714, 10223.846642300372, 10290.279680422373, 10291.948540257326, 10297.124744396735, 10298.639547615834, 7449.441291903102, 7611.695532178706, 9909.108180263811, 10136.54385552652, 10156.238282128834, 10075.848862267, 10159.33964292326, 10171.949140254252, 10173.59305627774, 10180.287379883412, 37618.0, 37957.0, 37998.43002354967, 38055.42916856249, 38121.23757524834, 3110.797798143136, 3159.4786860168274, 3161.1780936956325, 3171.1120886151916, 3219.1791093271067, 28822.135335939955, 29108.41783164346, 29480.0, 29627.70372296271, 30169.245768855733, 3407.267437500949, 3524.330377228344, 3525.383057964846, 3549.680528752425, 3618.240169564395, 259140.0, 259583.0, 260430.0, 260952.0, 261809.0, 31960.200994975312, 32942.0, 56171.71914140403, 56727.43272567304, 56747.71626141843, 34235.0, 34421.0, 34467.31065378729, 34490.13774655654, 34544.654553454646, 13588.660283492794, 13723.039387242998, 13728.244946528037, 13731.45074197021, 13738.519151829638, 9149.268058555299, 11887.10846686502, 12054.09594280415, 12081.395930203455, 12082.456289466994, 7906.723264685708, 7922.603869806487, 7925.8811117833275, 7991.8401631967035, 8005.8398832024195, 3089.335792804558, 3094.9381012379627, 3118.7037231462973, 3123.5783169272313, 3136.6236051673945, 822.621594066724, 893.1113542025596, 916.1205242966694, 921.7649499377616, 944.8535477001076, 26185.214443566725, 27390.45219095647, 27732.30669233245, 28049.43901121966, 28076.57885131725, 966.3139171188535, 989.218517371283, 1003.287665757306, 1068.1828401273033, 1098.3135540287321, 14648.194349310677, 14690.55928322152, 14824.481143160154, 15187.544373668808, 15255.771163432557, 375611.0, 377460.0, 378974.0, 379941.0, 380740.0, 49216.50783492191, 49740.502594974314, 49994.0, 50098.749506252236, 50117.49882501128, 1092.956281748721, 1114.0419239453902, 1135.0, 1245.9688507787378, 1255.1465003797505, 20472.897635511727, 28031.0, 28323.150305490868, 30736.23159420943, 30749.23126921845, 45467.0, 46117.30824037575, 46120.769396152806, 46191.538084618725, 46248.0, 329800.0, 337638.0, 339497.0, 339901.0, 340429.0, 22833.31500055001, 23519.41201469977, 23541.764582353957, 25199.244022679348, 25620.23139305824, 33808.0, 35346.29307413786, 41704.0, 42701.145977079665, 47153.52846471492, 34831.82584087063, 35880.282394352485, 36755.81622091872, 36887.26225475529, 37010.8149459251, 36050.0, 36395.09012274714, 36427.27145457023, 36467.45298820467, 36765.44851827171, 35194.0, 35573.28853422865, 36236.09409764777, 36293.09267268339, 36428.0, 30942.53586196254, 32699.34601308008, 32862.83568582142, 32891.0, 33047.834760826045, 24614.630780537947, 25379.492410152063, 25475.490490190463, 25547.744522554538, 25858.612120817827], "value": 17004.318095268423, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.53440294818216, 360.1105269983141, 361.8190904547726, 370.90356507308127, 379.8499592660899, 15884.523464296075, 16647.0, 17481.650366992653, 17524.649507009854, 17542.824571754278, 14822.481213157542, 15042.774358384633, 15306.770398444032, 15423.228838558056, 15450.5364839055, 4763.999999999991, 4972.776225069862, 4990.451050384455, 4993.400791904976, 5002.274670172823, 3736.458213559032, 3907.6483116519507, 5098.821541246057, 5759.913601295984, 6151.477124444427, 6162.938370616282, 6165.1677023601915, 6168.75324987, 6175.50595952325, 6197.969010154943, 5985.670788106652, 6087.086936959469, 6157.076438534211, 6188.659623720693, 6193.504519638441, 3319.3195394943978, 4849.539293767087, 5148.794048238066, 5172.172452407597, 5331.360236771612, 20525.281615143398, 20654.5869082619, 20669.689954650694, 21053.894730526248, 21055.0, 1836.706127019684, 2011.688188330811, 2102.1486298049313, 2186.8031877130975, 2555.565553855849, 8467.195616416431, 8694.478331300143, 9066.501342426163, 9132.81734365309, 12842.101052926299, 1734.66846012057, 1794.7666803315617, 1807.4939017075108, 1819.0995457248746, 1883.3991107558602, 66457.3354266456, 68471.65764171147, 68578.0, 68680.6565967167, 69600.30399695989, 9593.616255349847, 9648.469334186688, 9667.419954802734, 9835.803283934425, 9965.302428829913, 13656.65858353549, 13737.862621373859, 13760.243186624832, 13769.242691652054, 13790.931045344709, 7345.70617175307, 7462.626868656545, 7616.5810880401, 7691.653875575613, 7796.0, 7293.343599076109, 7380.704771809175, 7444.553326800409, 7534.849303013909, 7535.73624923125, 4186.670642612184, 4191.098913733501, 4204.873853784391, 4271.829126834892, 4331.675124365685, 1627.9755803662954, 1690.5689049292353, 1709.333359989605, 1728.0063963220946, 1781.4946370317061, 758.1236439811532, 875.33911896519, 915.2906497464518, 940.6237504997919, 940.9905900941039, 15914.840851591567, 16563.503094907173, 16683.49949501517, 16768.664626707643, 17187.0, 828.0394742099136, 832.5837081459271, 862.4135587800231, 872.6727477196051, 881.8976279650437, 9476.241900648069, 10438.135961516295, 10451.738706532398, 10461.372317660966, 10513.211509136692, 367293.0, 369089.0, 374414.0, 376701.0, 379518.0, 79726.0, 79880.20119798728, 80939.59530202311, 81497.18502815014, 81906.18093819104, 848.9830203395898, 895.9283257339528, 916.3493919317226, 940.1022023967232, 942.6794889737522, 14008.649783755487, 15714.371425143323, 15924.68150637004, 16360.34558617642, 16415.83584164143, 28907.988220412186, 32506.83746581252, 34963.82518087393, 35263.3801067925, 36887.077823054635, 48445.27332089951, 48449.75775121102, 48606.27090593573, 49211.0, 49292.2606160915, 7576.204498527795, 7769.028871391076, 7853.253940875607, 7977.2022797719765, 7979.72070977513, 8642.740717778477, 10993.395363255098, 11740.41297935117, 11866.584669536525, 12094.0, 10008.44953527563, 10364.170866330525, 10382.3251488653, 10754.300970436896, 10960.177986650873, 9782.168515676247, 9883.0, 10092.24308176875, 10284.434356110485, 10598.31110977784, 10108.292419530857, 10120.089191972758, 10144.137748291183, 10245.0, 10925.508352124014, 7696.884546731915, 7872.488288261245, 7876.054873415227, 7890.723824666109, 7943.0, 7467.327940485382, 9311.627534898527, 9946.751331216778, 10014.449205293487, 10019.0], "value": 8195.594841183063, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1254.385351177923, 1414.8443671196167, 1455.6506438454771, 1549.5196489088382, 1743.3898135652523, 6676.332366763321, 7679.1552929177815, 7898.960505197473, 7919.604019799001, 8078.555679437629, 7869.80325491863, 8008.9599552002155, 8029.799255018627, 8036.718714844981, 8065.072516660586, 1826.306003718585, 2039.2250944641016, 2114.513661857766, 2143.742750869898, 2171.6308227601344, 2135.4661334666334, 2151.4621344663833, 2152.1283880028614, 2156.644153714635, 2157.2988778646923, 2084.405944305873, 2100.747910250772, 2125.957480850382, 2127.064091799611, 2129.361191642501, 1790.1496789025239, 2022.2719820864477, 2035.8880261585607, 2074.388055523624, 2074.3984244569056, 2119.491322082689, 2145.3885642591786, 2145.603063433254, 2148.054855863415, 2151.87088774674, 7682.731104411375, 7738.148803631596, 7747.225277472264, 7748.6125693715085, 7787.4938129022, 4432.911341773147, 4577.038821847416, 4577.5193604671695, 4577.5880170784785, 4583.8166473341025, 2708.4312294418196, 2869.6126022987046, 2871.267826704198, 2883.351245969661, 2888.3068063664778, 835.6197929941862, 844.0, 850.4812064640564, 854.1842540373927, 870.2863651805523, 10901.618443354524, 10935.398553079578, 10963.0, 10996.505157267862, 11046.668599942015, 4004.0990777074926, 4042.211768705133, 4099.85650502231, 4166.812493437803, 4167.124903770182, 9233.769155771159, 9289.767755806024, 9332.34673572857, 9359.906400935903, 9373.43759374426, 4627.143978363946, 4634.420697412824, 4637.39713837199, 4637.536246375403, 4638.327442520816, 3619.819009049537, 4073.572274911151, 4212.831486740557, 4214.220369231702, 4260.616544511009, 3697.6672099511175, 3709.4250391189407, 3783.7729736215915, 3814.294355544233, 3834.69322454203, 1183.3373310945897, 1193.462941676249, 1196.4316949448942, 1203.9458224379923, 1206.258151236983, 745.2584678245181, 860.3117505995178, 901.7911678096353, 903.0969030969031, 907.1518130547959, 5316.952973105383, 5384.0, 5503.9174412383045, 5561.499465048165, 5575.916361254584, 855.7261676263661, 878.2096113497903, 909.4997751236793, 915.3226612306845, 924.7595625137512, 3712.7029837612927, 3718.3492888744363, 3773.4905787718853, 3774.358359078908, 3871.864484743077, 9526.571304291323, 9800.607975681036, 9982.0, 9989.900100998897, 10005.549750261256, 9817.901820981699, 9896.60413583463, 9917.801643967081, 9934.254930880214, 9937.155341795884, 7012.824679383056, 7390.519616225036, 7506.962465187639, 7508.310630108291, 7511.474196806281, 5632.211490391431, 5685.658860468385, 5729.255196824386, 5787.131930210502, 5900.232969713909, 9197.724068277963, 9218.400803947721, 9310.162085412345, 9377.531123443665, 9408.059194080537, 9240.214581760625, 9343.392679475812, 9379.85930211061, 9397.859032114387, 9440.386374885611, 6207.720652570555, 6305.0, 6320.778772742932, 6795.082663840516, 6931.514793964374, 7029.753958611424, 7117.572945623279, 7215.278472152742, 7439.92560074414, 7466.25337466249, 6805.523613347018, 6912.619805910723, 6925.68834402443, 7004.684789184397, 7016.894746578908, 6737.966310168418, 6780.932190678227, 6880.449564034765, 6960.443164546926, 6993.790186294419, 6004.849878753066, 6185.041318595625, 6488.12410324619, 6562.376574225441, 6564.0, 4769.14155452022, 4771.95228047715, 4787.61699064067, 4864.100141473838, 4935.284383764406, 4493.0789188216995, 4530.456345238593, 4569.908601828011, 4632.536746325341, 4708.081924024782], "value": 4165.134369446503, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.4147485442561, 283.4642525626566, 291.8555315119016, 293.7092278644142, 298.0982527853245, 4751.596114330282, 4824.022150918125, 4829.309741590441, 4842.612590992721, 4889.804407823692, 4827.251775974721, 4836.613070954324, 4841.3222148899185, 4841.733704646252, 4845.594777514517, 3569.125564236759, 3679.0, 3709.332320182366, 3771.0, 3805.904852378685, 3744.8314825832904, 3786.7159963002887, 3812.9809350953346, 3819.178876541543, 3820.923581528368, 3743.1952130291984, 3754.8498060077563, 3756.605556416578, 3761.2134236237707, 3772.302124107049, 3536.717062634983, 3641.4173732202853, 3741.7942013189263, 3758.1544152565725, 3763.153290509641, 3282.4091663500562, 3283.753718471124, 3286.2441638423297, 3301.752368572367, 3321.368939901411, 4541.84103556374, 4584.129015487047, 4589.128065667546, 4594.402727645384, 4602.516735742733, 4039.939400908989, 4238.745675259494, 4261.509926358446, 4271.825248056809, 4276.358546218092, 4972.5276098770555, 4992.87517812054, 5015.473375295578, 5028.32117664118, 5040.722760248185, 3508.859645614172, 3523.119220194951, 3525.7531972761917, 3528.2943411317838, 3544.2557063016798, 5029.899402011976, 5234.0, 5240.161574148118, 5247.895042099175, 5265.52610265078, 3522.0490467573613, 3541.575010998645, 3542.2738338640515, 3558.679718825318, 3559.7330200235087, 3600.837962291703, 3602.6757591816863, 3606.9819650901577, 3611.1694310308776, 3614.5120408744483, 4122.103832237144, 4149.605787450188, 4155.646770024521, 4159.542450330461, 4167.687423443193, 4900.066406035491, 4930.827421040246, 4996.650234483552, 5004.674696144739, 5023.196288593807, 1262.1291308996763, 1268.7208814060891, 1268.7652784234947, 1276.387334079647, 1278.9872101278868, 795.7374066558021, 804.1958041958042, 817.1420008990655, 834.5159807311744, 863.8445079885555, 4445.955200527874, 4456.777161141995, 4461.286194208911, 4473.865784026484, 4474.955250447454, 5107.770150343244, 5148.665336753174, 5159.819406320836, 5183.922241166386, 5197.648611361074, 4242.130363275521, 4401.757903315284, 4402.977985110118, 4430.601245887886, 4457.821687132543, 2774.500589893798, 2779.5969584410145, 2781.401998570317, 2792.1623512946035, 2795.5107856125096, 4851.830185943475, 4899.2896030075435, 4942.579880710108, 4973.005398920231, 4973.278874563168, 5087.669301495391, 5351.759170837322, 5358.4373640767935, 5369.167778994184, 5377.3816011159215, 4930.186519224288, 4973.303737476756, 4980.277859710394, 4999.0, 5000.974995125001, 5243.292155558951, 5255.237990491434, 5271.841844744664, 5276.736163191902, 5287.89424211506, 4892.510748925079, 5123.87190320245, 5157.896842063063, 5165.92251116226, 5175.14610089331, 4954.504549545017, 4956.182229932021, 4960.801567937242, 4972.825951091694, 4977.900441991213, 3648.726345524043, 3679.3193259247123, 3680.0799800049986, 3683.4106542953, 3686.4838922551403, 5084.923726144185, 5213.218017297436, 5222.3733152022005, 5247.763850626655, 5257.342832145981, 5029.119904016856, 5032.6411868794485, 5066.240063990431, 5070.298681962115, 5086.3896332440345, 4990.326305948651, 5052.317937078447, 5094.414142373526, 5106.106431374569, 5112.309838171799, 4829.08114140113, 4886.169351210374, 4989.55094041538, 5000.524950129732, 5032.446430892672, 4861.0, 4986.750662466789, 5110.386753589593, 5130.6152038598, 5165.560927321219, 4985.75071246429, 5000.199968005102, 5040.269160971712, 5046.394432668103, 5051.004853082938], "value": 3784.847057689061, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [625.3215261441337, 697.7801992372403, 715.9904534606203, 744.4193529047345, 774.5314084978589, 12431.564895228668, 13441.46234150634, 13715.177089374632, 14038.92980535096, 14279.714405711906, 13814.1020833646, 13885.652858678539, 13894.0, 13996.790048149285, 13998.0, 633.7243299164855, 767.2327672327673, 792.2434075457952, 798.8042929482256, 800.0839039299983, 795.9721409750659, 797.8364435290752, 800.4116974024088, 800.7357572001225, 800.7677773445694, 834.2158371131147, 834.7913021744564, 835.064727505195, 836.1304243586693, 836.1346006882877, 654.6988385342748, 792.4690457393531, 812.4312980913385, 813.80061884838, 815.2418251026543, 594.8037147741235, 594.9434803693642, 595.6158277910766, 596.3916804859062, 596.472122171881, 13114.60656180316, 13178.472861085545, 13190.208587484782, 13205.0, 13218.140820846711, 11723.179377443583, 11932.761344773142, 12016.158868879182, 12093.0, 12282.877171228352, 12020.819687704692, 12127.21173123753, 12213.572524961584, 12255.571055013032, 12466.563670271496, 4121.62905338521, 4150.875473735793, 4183.748975061476, 4240.9151816963795, 4242.3212286034395, 49174.0, 51755.0, 51988.74005629985, 57924.84150317012, 58711.41288587145, 10473.109785668152, 10493.317934334244, 10518.368897866, 10580.153587712965, 10656.0, 18812.24751009944, 18840.717389239173, 18855.151518181716, 18887.622247554973, 19012.904935475235, 6504.284528701839, 6562.704678289489, 6677.298883617247, 6692.397684208445, 6702.463802895757, 3554.0, 3622.076370525499, 3634.309481198564, 3643.28955853606, 3665.8533658653887, 2806.7614252788335, 2898.7970842041277, 2899.3041669999047, 2910.3451723362073, 2910.563415487694, 516.1277441124488, 542.3410556174267, 548.5364866687643, 554.7919530176184, 555.9499645031885, 481.8554433669885, 502.7205761337405, 529.0318716748342, 532.5233915645475, 597.8087012156068, 8374.49753014821, 8566.27186689126, 8639.179277968582, 8762.003426704347, 8867.379283450096, 490.23278569039337, 546.0416968220748, 561.5732043646858, 581.7411251992908, 608.2184393054991, 3786.0, 3968.2857085724268, 4076.4496792932573, 4118.485189351331, 4180.498340199196, 55255.0, 67622.9856552152, 91067.0, 96697.0, 97220.51389743148, 50556.747216263684, 52032.73983630058, 77833.0, 81049.0, 81996.18003820005, 72384.63807681033, 74897.62551187209, 75279.62360188273, 75444.24555754483, 75673.62163189259, 7448.553086814808, 7761.185075566984, 7798.922010780047, 7802.414818888493, 7895.921040789748, 31216.687833121377, 31578.842105789325, 32234.83882580666, 37815.62184378121, 40716.592834072464, 41339.7933010333, 41429.0, 46056.53943460523, 60810.0, 62594.68702656458, 11207.66377008691, 11247.66257012291, 11387.829182562435, 11497.310161390344, 11743.823842642196, 12362.134650574373, 12580.622581322576, 12702.36488175606, 12727.681807954876, 12778.68053298675, 11517.424128793695, 11882.584109556125, 12330.753384932072, 12341.62975110748, 12434.129610927148, 11972.56805653826, 12353.814692779435, 12373.267533604538, 12424.0, 12745.872541274839, 10660.46697665129, 11029.283096598696, 11136.554537818396, 11410.372429516456, 11555.306681599131, 10177.109423725977, 10362.844557331797, 10574.048335649828, 10630.25588208849, 10661.307015043998, 9473.663216258812, 9680.5643746033, 9952.203823693942, 10272.948635256776, 10403.271770975958], "value": 6466.60609727043, "unit": "score"}], "name": "dromaeo_css", "value": 6354.788756674716, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 109.0, 115.0, 113.0, 113.0, 114.0, 114.0, 113.0, 114.0, 112.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 135.0, 132.0, 175.0, 138.0, 131.0, 153.0, 139.0, 182.0, 131.0], "value": 148.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 161.0, 162.0, 162.0, 163.0, 161.0, 162.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 111.0, 75.0, 79.0, 75.0, 76.0, 97.0, 75.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 117.0, 87.0, 87.0, 85.0, 127.0, 85.0, 85.0, 120.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 96.0, 96.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 64.0, 64.0, 64.0, 63.0, 63.0, 63.0, 62.0], "value": 63.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0, 66.0, 64.0, 72.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 82.0, 83.0, 84.0, 85.0, 88.0, 85.0, 86.0, 118.0, 86.0], "value": 88.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 130.0, 129.0, 135.0, 131.0, 143.0, 134.0, 143.0, 134.0], "value": 137.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 173.0, 178.0, 171.0, 168.0, 174.0, 178.0, 168.0, 170.0, 166.0], "value": 171.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 68.0, 69.0, 68.0, 72.0, 67.0, 66.0, 69.0, 67.0], "value": 68.3, "unit": "score"}], "name": "kraken", "value": 1553.2999999999997, "alertThreshold": 2.0}]} 03:48:40 INFO - Return code: 0 03:48:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:48:40 ERROR - # TBPL SUCCESS # 03:48:40 INFO - Running post-action listener: _resource_record_post_action 03:48:40 INFO - ##### 03:48:40 INFO - ##### Finished run-tests step (success) 03:48:40 INFO - ##### 03:48:40 INFO - Running post-run listener: _resource_record_post_run 03:48:40 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 8192; Write bytes: 301215744; Read time: 20; Write time: 470128 03:48:40 INFO - TinderboxPrint: CPU usage
13.1% 03:48:40 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 03:48:40 INFO - TinderboxPrint: I/O write bytes / time
301,215,744 / 470,128 03:48:40 INFO - TinderboxPrint: CPU idle
8,336.6 (86.9%) 03:48:40 INFO - TinderboxPrint: CPU user
1,209.3 (12.6%) 03:48:40 INFO - TinderboxPrint: Swap in / out
0 / 0 03:48:40 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 14458880; Read time: 0; Write time: 7432 03:48:40 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 8192; Write bytes: 286752768; Read time: 20; Write time: 462472 03:48:41 INFO - Running post-run listener: _upload_blobber_files 03:48:41 INFO - Blob upload gear active. 03:48:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:48:41 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:48:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:48:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:48:41 INFO - (blobuploader) - INFO - Open directory for files ... 03:48:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:48:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:48:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:48:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:48:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:48:45 INFO - (blobuploader) - INFO - Done attempting. 03:48:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:48:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:48:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:48:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:48:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:48:46 INFO - (blobuploader) - INFO - Done attempting. 03:48:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:48:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:48:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:48:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:48:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:48:46 INFO - (blobuploader) - INFO - Done attempting. 03:48:46 INFO - (blobuploader) - INFO - Iteration through files over. 03:48:47 INFO - Return code: 0 03:48:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:48:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:48:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7abe89ca95b2776eaadc30310fd72553d2e932432a0a0c1e4bf8ec1a95c280f2da844a7655b3b02d5ba683f88535fb6e497f5f087e87f123ced267f793b2ac57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2fc33e4100575f2e47d5d9224c76b11d3438cfbb042b7fa2c8c10486c1a2ee986c4f22634cb42bd4bc92612300c241a328f9085f194467e4c467d5ddd722f12a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7f085277e1d3e2de722e42e3e3a5fae26fc985f792a4d52a5f6a69cf2671592db6deecc1ea58359ec993f2309b79f5f1774e5b288c454129032bcaef9bf4f584"} 03:48:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:48:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:48:47 INFO - Contents: 03:48:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7abe89ca95b2776eaadc30310fd72553d2e932432a0a0c1e4bf8ec1a95c280f2da844a7655b3b02d5ba683f88535fb6e497f5f087e87f123ced267f793b2ac57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2fc33e4100575f2e47d5d9224c76b11d3438cfbb042b7fa2c8c10486c1a2ee986c4f22634cb42bd4bc92612300c241a328f9085f194467e4c467d5ddd722f12a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7f085277e1d3e2de722e42e3e3a5fae26fc985f792a4d52a5f6a69cf2671592db6deecc1ea58359ec993f2309b79f5f1774e5b288c454129032bcaef9bf4f584"} 03:48:47 INFO - Running post-run listener: copy_logs_to_upload_dir 03:48:47 INFO - Copying logs to upload dir... 03:48:47 INFO - mkdir: /builds/slave/test/build/upload/logs 03:48:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.988772 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-06-09 03:48:46.997295) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 03:48:47.000936) ========= 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-1465467267.419532-619775607 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7abe89ca95b2776eaadc30310fd72553d2e932432a0a0c1e4bf8ec1a95c280f2da844a7655b3b02d5ba683f88535fb6e497f5f087e87f123ced267f793b2ac57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2fc33e4100575f2e47d5d9224c76b11d3438cfbb042b7fa2c8c10486c1a2ee986c4f22634cb42bd4bc92612300c241a328f9085f194467e4c467d5ddd722f12a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7f085277e1d3e2de722e42e3e3a5fae26fc985f792a4d52a5f6a69cf2671592db6deecc1ea58359ec993f2309b79f5f1774e5b288c454129032bcaef9bf4f584"} build_url:https://queue.taskcluster.net/v1/task/bdTr2E_bRkeICnAHs--hnA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011342 build_url: 'https://queue.taskcluster.net/v1/task/bdTr2E_bRkeICnAHs--hnA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7abe89ca95b2776eaadc30310fd72553d2e932432a0a0c1e4bf8ec1a95c280f2da844a7655b3b02d5ba683f88535fb6e497f5f087e87f123ced267f793b2ac57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2fc33e4100575f2e47d5d9224c76b11d3438cfbb042b7fa2c8c10486c1a2ee986c4f22634cb42bd4bc92612300c241a328f9085f194467e4c467d5ddd722f12a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7f085277e1d3e2de722e42e3e3a5fae26fc985f792a4d52a5f6a69cf2671592db6deecc1ea58359ec993f2309b79f5f1774e5b288c454129032bcaef9bf4f584"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 03:48:47.026800) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 03:48:47.027133) ========= 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-1465467267.419532-619775607 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004553 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 03:48:47.110328) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 03:48:47.110661) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 03:48:47.110963) ========= ========= Total master_lag: 0.18 =========