builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-063 starttime: 1465483585.46 results: success (0) buildid: 20160609064728 builduid: ee3d20bbda5f4fabbba762c11761cc14 revision: 4678ba5309817e01839b86f14cbc9469e78c8ae8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 07:46:25.457966) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 07:46:25.458426) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 07:46:25.458772) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 07:46:25.474187) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 07:46:25.474530) ========= 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=33d5923976266a1c518c4bf7000001ab-1465483555.173147-1124489517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 07:46:25-- 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% 225M=0s 2016-06-09 07:46:25 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121101 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 07:46:25.611102) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 07:46:25.611431) ========= 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=33d5923976266a1c518c4bf7000001ab-1465483555.173147-1124489517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022825 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 07:46:25.664473) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 07:46:25.665390) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4678ba5309817e01839b86f14cbc9469e78c8ae8 --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 4678ba5309817e01839b86f14cbc9469e78c8ae8 --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=33d5923976266a1c518c4bf7000001ab-1465483555.173147-1124489517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 07:46:25,976 truncating revision to first 12 chars 2016-06-09 07:46:25,977 Setting DEBUG logging. 2016-06-09 07:46:25,977 attempt 1/10 2016-06-09 07:46:25,977 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4678ba530981?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 07:46:26,309 unpacking tar archive at: fx-team-4678ba530981/testing/mozharness/ program finished with exit code 0 elapsedTime=0.678895 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 07:46:26.359259) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 07:46:26.359596) ========= script_repo_revision: 4678ba5309817e01839b86f14cbc9469e78c8ae8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 07:46:26.360041) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 07:46:26.360530) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 07:46:26.372361) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-06-09 07:46:26.372807) ========= /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=33d5923976266a1c518c4bf7000001ab-1465483555.173147-1124489517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:46:26 INFO - MultiFileLogger online at 20160609 07:46:26 in /builds/slave/test 07:46:26 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 07:46:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:46:26 INFO - {'append_to_log': False, 07:46:26 INFO - 'base_work_dir': '/builds/slave/test', 07:46:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:46:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:46:26 INFO - 'branch': 'Fx-Team-Non-PGO', 07:46:26 INFO - 'buildbot_json_path': 'buildprops.json', 07:46:26 INFO - 'config_files': ('talos/linux_config.py',), 07:46:26 INFO - 'default_actions': ('clobber', 07:46:26 INFO - 'read-buildbot-config', 07:46:26 INFO - 'download-and-extract', 07:46:26 INFO - 'populate-webroot', 07:46:26 INFO - 'create-virtualenv', 07:46:26 INFO - 'install', 07:46:26 INFO - 'run-tests'), 07:46:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:46:26 INFO - 'download_minidump_stackwalk': True, 07:46:26 INFO - 'download_symbols': 'ondemand', 07:46:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:46:26 INFO - 'tooltool.py': '/tools/tooltool.py', 07:46:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:46:26 INFO - '/tools/misc-python/virtualenv.py')}, 07:46:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:46:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:46:26 INFO - 'installer_path': 'installer.exe', 07:46:26 INFO - 'log_level': 'info', 07:46:26 INFO - 'log_name': 'talos', 07:46:26 INFO - 'log_to_console': True, 07:46:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:46:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:46:26 INFO - 'opt_config_files': (), 07:46:26 INFO - 'pip_index': False, 07:46:26 INFO - 'sps_profile': False, 07:46:26 INFO - 'sps_profile_interval': 0, 07:46:26 INFO - 'suite': 'dromaeojs', 07:46:26 INFO - 'system_bits': '32', 07:46:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:46:26 INFO - 'title': 'talos-linux64-ix-063', 07:46:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:46:26 INFO - 'use_talos_json': True, 07:46:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:46:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:46:26 INFO - 'work_dir': 'build'} 07:46:26 INFO - ##### 07:46:26 INFO - ##### Running clobber step. 07:46:26 INFO - ##### 07:46:26 INFO - Running pre-action listener: _resource_record_pre_action 07:46:26 INFO - Running main action method: clobber 07:46:26 INFO - rmtree: /builds/slave/test/build 07:46:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:46:27 INFO - Running post-action listener: _resource_record_post_action 07:46:27 INFO - ##### 07:46:27 INFO - ##### Finished clobber step (success) 07:46:27 INFO - ##### 07:46:27 INFO - ##### 07:46:27 INFO - ##### Running read-buildbot-config step. 07:46:27 INFO - ##### 07:46:27 INFO - Running pre-action listener: _resource_record_pre_action 07:46:27 INFO - Running main action method: read_buildbot_config 07:46:27 INFO - Using buildbot properties: 07:46:27 INFO - { 07:46:27 INFO - "project": "", 07:46:27 INFO - "product": "firefox", 07:46:27 INFO - "script_repo_revision": "production", 07:46:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:46:27 INFO - "repository": "", 07:46:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 07:46:27 INFO - "buildid": "20160609064728", 07:46:27 INFO - "pgo_build": "False", 07:46:27 INFO - "basedir": "/builds/slave/test", 07:46:27 INFO - "buildnumber": 1835, 07:46:27 INFO - "slavename": "talos-linux64-ix-063", 07:46:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:46:27 INFO - "platform": "ubuntu64_hw", 07:46:27 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:46:27 INFO - "branch": "fx-team", 07:46:27 INFO - "repo_path": "integration/fx-team", 07:46:27 INFO - "revision": "4678ba5309817e01839b86f14cbc9469e78c8ae8", 07:46:27 INFO - "stage_platform": "linux64", 07:46:27 INFO - "builduid": "ee3d20bbda5f4fabbba762c11761cc14", 07:46:27 INFO - "slavebuilddir": "test" 07:46:27 INFO - } 07:46:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ry5ML7fKRCWp1OOUbD_iMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:46:27 INFO - Running post-action listener: _resource_record_post_action 07:46:27 INFO - ##### 07:46:27 INFO - ##### Finished read-buildbot-config step (success) 07:46:27 INFO - ##### 07:46:27 INFO - ##### 07:46:27 INFO - ##### Running download-and-extract step. 07:46:27 INFO - ##### 07:46:27 INFO - Running pre-action listener: _resource_record_pre_action 07:46:27 INFO - Running main action method: download_and_extract 07:46:27 INFO - mkdir: /builds/slave/test/build/tests 07:46:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:46:27 INFO - https://queue.taskcluster.net/v1/task/Ry5ML7fKRCWp1OOUbD_iMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:46:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ry5ML7fKRCWp1OOUbD_iMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:46:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ry5ML7fKRCWp1OOUbD_iMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:46:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ry5ML7fKRCWp1OOUbD_iMQ/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 07:46:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ry5ML7fKRCWp1OOUbD_iMQ/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 07:46:30 INFO - Downloaded 1361 bytes. 07:46:31 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:46:31 INFO - Using the following test package requirements: 07:46:31 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:46:31 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:46:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:46:31 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:46:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:46:31 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:46:31 INFO - u'jsshell-linux-x86_64.zip'], 07:46:31 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:46:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:46:31 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:46:31 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:46:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:46:31 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:46:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:46:31 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:46:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:46:31 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:46:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:46:31 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:46:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:46:31 INFO - https://queue.taskcluster.net/v1/task/Ry5ML7fKRCWp1OOUbD_iMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:46:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ry5ML7fKRCWp1OOUbD_iMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:46:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ry5ML7fKRCWp1OOUbD_iMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:46:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ry5ML7fKRCWp1OOUbD_iMQ/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 07:46:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ry5ML7fKRCWp1OOUbD_iMQ/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 07:46:32 INFO - Downloaded 22879604 bytes. 07:46:32 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'] 07:46:32 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 07:46:33 INFO - Return code: 0 07:46:33 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 07:46: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')]} 07:46:33 INFO - https://queue.taskcluster.net/v1/task/Ry5ML7fKRCWp1OOUbD_iMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:46:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ry5ML7fKRCWp1OOUbD_iMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:46:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ry5ML7fKRCWp1OOUbD_iMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:46:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ry5ML7fKRCWp1OOUbD_iMQ/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 07:46:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ry5ML7fKRCWp1OOUbD_iMQ/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 07:46:38 INFO - Downloaded 22879604 bytes. 07:46:38 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'] 07:46:38 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 07:46:40 INFO - Return code: 0 07:46:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:46:40 INFO - https://queue.taskcluster.net/v1/task/Ry5ML7fKRCWp1OOUbD_iMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:46:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ry5ML7fKRCWp1OOUbD_iMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:46:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ry5ML7fKRCWp1OOUbD_iMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:46:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ry5ML7fKRCWp1OOUbD_iMQ/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 07:46:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ry5ML7fKRCWp1OOUbD_iMQ/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 07:46:41 INFO - Downloaded 10833377 bytes. 07:46:41 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'] 07:46:41 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 07:46:41 INFO - Return code: 0 07:46:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:46:41 INFO - https://queue.taskcluster.net/v1/task/Ry5ML7fKRCWp1OOUbD_iMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:46:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ry5ML7fKRCWp1OOUbD_iMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:46:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ry5ML7fKRCWp1OOUbD_iMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:46:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ry5ML7fKRCWp1OOUbD_iMQ/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 07:46:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ry5ML7fKRCWp1OOUbD_iMQ/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 07:46:47 INFO - Downloaded 55364165 bytes. 07:46:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ry5ML7fKRCWp1OOUbD_iMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:46:47 INFO - mkdir: /builds/slave/test/properties 07:46:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:46:47 INFO - Writing to file /builds/slave/test/properties/build_url 07:46:47 INFO - Contents: 07:46:47 INFO - build_url:https://queue.taskcluster.net/v1/task/Ry5ML7fKRCWp1OOUbD_iMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:46:48 INFO - Running post-action listener: _resource_record_post_action 07:46:48 INFO - Running post-action listener: set_extra_try_arguments 07:46:48 INFO - ##### 07:46:48 INFO - ##### Finished download-and-extract step (success) 07:46:48 INFO - ##### 07:46:48 INFO - ##### 07:46:48 INFO - ##### Running populate-webroot step. 07:46:48 INFO - ##### 07:46:48 INFO - Running pre-action listener: _resource_record_pre_action 07:46:48 INFO - Running main action method: populate_webroot 07:46:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:46:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:46:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:46:48 INFO - '--tppagecycles', 07:46:48 INFO - '7'], 07:46:48 INFO - 'tests': ['tsvgm']}}, 07:46:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:46:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:46:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:46:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:46:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:46:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:46:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:48 INFO - 'talos_options': ['--disable-e10s'], 07:46:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:46:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:46:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:48 INFO - 'talos_options': ['--disable-e10s'], 07:46:48 INFO - 'tests': ['damp', 'tps']}, 07:46:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:48 INFO - 'tests': ['damp', 'tps']}, 07:46:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:46:48 INFO - 'tests': ['dromaeo_dom']}, 07:46:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:46:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:46:48 INFO - 'tests': ['a11yr', 07:46:48 INFO - 'ts_paint', 07:46:48 INFO - 'tpaint', 07:46:48 INFO - 'sessionrestore', 07:46:48 INFO - 'sessionrestore_no_auto_restore', 07:46:48 INFO - 'tabpaint']}, 07:46:48 INFO - 'other-e10s': {'tests': ['a11yr', 07:46:48 INFO - 'ts_paint', 07:46:48 INFO - 'tpaint', 07:46:48 INFO - 'sessionrestore', 07:46:48 INFO - 'sessionrestore_no_auto_restore', 07:46:48 INFO - 'tabpaint']}, 07:46:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:46:48 INFO - 'ts_paint', 07:46:48 INFO - 'tpaint', 07:46:48 INFO - 'sessionrestore', 07:46:48 INFO - 'sessionrestore_no_auto_restore', 07:46:48 INFO - 'tabpaint']}, 07:46:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:46:48 INFO - 'ts_paint', 07:46:48 INFO - 'tpaint', 07:46:48 INFO - 'sessionrestore', 07:46:48 INFO - 'sessionrestore_no_auto_restore', 07:46:48 INFO - 'tabpaint']}, 07:46:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:46:48 INFO - 'tests': ['a11yr', 07:46:48 INFO - 'ts_paint', 07:46:48 INFO - 'tpaint', 07:46:48 INFO - 'sessionrestore', 07:46:48 INFO - 'sessionrestore_no_auto_restore', 07:46:48 INFO - 'tabpaint']}, 07:46:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:46:48 INFO - 'tests': ['a11yr', 07:46:48 INFO - 'ts_paint', 07:46:48 INFO - 'tpaint', 07:46:48 INFO - 'sessionrestore', 07:46:48 INFO - 'sessionrestore_no_auto_restore', 07:46:48 INFO - 'tabpaint']}, 07:46:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:46:48 INFO - 'tests': ['tsvgx', 07:46:48 INFO - 'tsvgr_opacity', 07:46:48 INFO - 'tart', 07:46:48 INFO - 'tscrollx', 07:46:48 INFO - 'cart']}, 07:46:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:46:48 INFO - 'tsvgr_opacity', 07:46:48 INFO - 'tart', 07:46:48 INFO - 'tscrollx', 07:46:48 INFO - 'cart']}, 07:46:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:48 INFO - 'talos_options': ['--disable-e10s'], 07:46:48 INFO - 'tests': ['tp5o']}, 07:46:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:48 INFO - 'tests': ['tp5o']}, 07:46:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:48 INFO - 'talos_options': ['--disable-e10s', 07:46:48 INFO - '--xperf_path', 07:46:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:46:48 INFO - 'tests': ['tp5n']}, 07:46:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:48 INFO - 'talos_options': ['--xperf_path', 07:46:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:46:48 INFO - 'tests': ['tp5n']}}, 07:46:48 INFO - 'talos.zip': {'path': '', 07:46:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:46:48 INFO - Running post-action listener: _resource_record_post_action 07:46:48 INFO - ##### 07:46:48 INFO - ##### Finished populate-webroot step (success) 07:46:48 INFO - ##### 07:46:48 INFO - ##### 07:46:48 INFO - ##### Running create-virtualenv step. 07:46:48 INFO - ##### 07:46:48 INFO - Running pre-action listener: _resource_record_pre_action 07:46:48 INFO - Running main action method: create_virtualenv 07:46:48 INFO - Creating virtualenv /builds/slave/test/build/venv 07:46:48 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 07:46:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:46:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:46:48 INFO - Using real prefix '/usr' 07:46:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:46:48 INFO - Installing distribute.............................................................................................................................................................................................done. 07:46:50 INFO - Installing pip.................done. 07:46:50 INFO - Return code: 0 07:46:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:46:50 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')]} 07:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:50 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')]} 07:46:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:50 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 0x7fe3c000ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe731c0>, '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 0xe740c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe74550>, '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': '33d5923976266a1c518c4bf7000001ab-1465483555.173147-1124489517', '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 07:46:50 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 07:46:50 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 07:46:50 INFO - Using env: {'DISPLAY': ':0', 07:46:50 INFO - 'HOME': '/home/cltbld', 07:46:50 INFO - 'LANG': 'en_US.UTF-8', 07:46:50 INFO - 'LANGUAGE': 'en_US:en', 07:46:50 INFO - 'LOGNAME': 'cltbld', 07:46:50 INFO - 'MAIL': '/var/mail/cltbld', 07:46:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:50 INFO - 'MOZ_NO_REMOTE': '1', 07:46:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:50 INFO - 'NO_EM_RESTART': '1', 07:46:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:50 INFO - 'PWD': '/builds/slave/test', 07:46:50 INFO - 'SHELL': '/bin/bash', 07:46:50 INFO - 'SHLVL': '1', 07:46:50 INFO - 'TERM': 'linux', 07:46:50 INFO - 'TMOUT': '86400', 07:46:50 INFO - 'USER': 'cltbld', 07:46:50 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465483555.173147-1124489517', 07:46:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:50 INFO - '_': '/tools/buildbot/bin/python'} 07:46:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:51 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 07:46:51 INFO - Cleaning up... 07:46:51 INFO - Return code: 0 07:46:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:46:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:51 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 0x7fe3c000ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe731c0>, '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 0xe740c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe74550>, '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': '33d5923976266a1c518c4bf7000001ab-1465483555.173147-1124489517', '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 07:46:51 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 07:46:51 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 07:46:51 INFO - Using env: {'DISPLAY': ':0', 07:46:51 INFO - 'HOME': '/home/cltbld', 07:46:51 INFO - 'LANG': 'en_US.UTF-8', 07:46:51 INFO - 'LANGUAGE': 'en_US:en', 07:46:51 INFO - 'LOGNAME': 'cltbld', 07:46:51 INFO - 'MAIL': '/var/mail/cltbld', 07:46:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:51 INFO - 'MOZ_NO_REMOTE': '1', 07:46:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:51 INFO - 'NO_EM_RESTART': '1', 07:46:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:51 INFO - 'PWD': '/builds/slave/test', 07:46:51 INFO - 'SHELL': '/bin/bash', 07:46:51 INFO - 'SHLVL': '1', 07:46:51 INFO - 'TERM': 'linux', 07:46:51 INFO - 'TMOUT': '86400', 07:46:51 INFO - 'USER': 'cltbld', 07:46:51 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465483555.173147-1124489517', 07:46:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:51 INFO - '_': '/tools/buildbot/bin/python'} 07:46:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:51 INFO - Downloading/unpacking psutil>=3.1.1 07:46:51 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 07:46:51 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 07:46:51 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 07:46:51 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 07:46:51 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 07:46:51 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 07:46:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:46:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:46:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:46:53 INFO - Installing collected packages: psutil 07:46:53 INFO - Running setup.py install for psutil 07:46:53 INFO - building 'psutil._psutil_linux' extension 07:46:53 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 07:46:53 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 07:46:53 INFO - building 'psutil._psutil_posix' extension 07:46:53 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 07:46:53 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 07:46:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:46:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:46:53 INFO - Successfully installed psutil 07:46:53 INFO - Cleaning up... 07:46:53 INFO - Return code: 0 07:46:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:46:53 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')]} 07:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:53 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')]} 07:46:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:53 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 0x7fe3c000ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe731c0>, '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 0xe740c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe74550>, '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': '33d5923976266a1c518c4bf7000001ab-1465483555.173147-1124489517', '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 07:46:53 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 07:46:53 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 07:46:53 INFO - Using env: {'DISPLAY': ':0', 07:46:53 INFO - 'HOME': '/home/cltbld', 07:46:53 INFO - 'LANG': 'en_US.UTF-8', 07:46:53 INFO - 'LANGUAGE': 'en_US:en', 07:46:53 INFO - 'LOGNAME': 'cltbld', 07:46:53 INFO - 'MAIL': '/var/mail/cltbld', 07:46:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:53 INFO - 'MOZ_NO_REMOTE': '1', 07:46:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:53 INFO - 'NO_EM_RESTART': '1', 07:46:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:53 INFO - 'PWD': '/builds/slave/test', 07:46:53 INFO - 'SHELL': '/bin/bash', 07:46:53 INFO - 'SHLVL': '1', 07:46:53 INFO - 'TERM': 'linux', 07:46:53 INFO - 'TMOUT': '86400', 07:46:53 INFO - 'USER': 'cltbld', 07:46:53 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465483555.173147-1124489517', 07:46:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:53 INFO - '_': '/tools/buildbot/bin/python'} 07:46:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:46:54 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 07:46:54 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 07:46:54 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 07:46:54 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 07:46:54 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 07:46:54 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 07:46:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:46:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:46:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:46:55 INFO - Installing collected packages: mozsystemmonitor 07:46:55 INFO - Running setup.py install for mozsystemmonitor 07:46:56 INFO - Successfully installed mozsystemmonitor 07:46:56 INFO - Cleaning up... 07:46:56 INFO - Return code: 0 07:46:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:46:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3c000ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe731c0>, '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 0xe740c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe74550>, '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': '33d5923976266a1c518c4bf7000001ab-1465483555.173147-1124489517', '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 07:46:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:46:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:46:56 INFO - Using env: {'DISPLAY': ':0', 07:46:56 INFO - 'HOME': '/home/cltbld', 07:46:56 INFO - 'LANG': 'en_US.UTF-8', 07:46:56 INFO - 'LANGUAGE': 'en_US:en', 07:46:56 INFO - 'LOGNAME': 'cltbld', 07:46:56 INFO - 'MAIL': '/var/mail/cltbld', 07:46:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:56 INFO - 'MOZ_NO_REMOTE': '1', 07:46:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:56 INFO - 'NO_EM_RESTART': '1', 07:46:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:56 INFO - 'PWD': '/builds/slave/test', 07:46:56 INFO - 'SHELL': '/bin/bash', 07:46:56 INFO - 'SHLVL': '1', 07:46:56 INFO - 'TERM': 'linux', 07:46:56 INFO - 'TMOUT': '86400', 07:46:56 INFO - 'USER': 'cltbld', 07:46:56 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465483555.173147-1124489517', 07:46:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:56 INFO - '_': '/tools/buildbot/bin/python'} 07:46:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:56 INFO - Downloading/unpacking jsonschema==2.5.1 07:46:56 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 07:46:56 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 07:46:56 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 07:46:56 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 07:46:56 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 07:46:56 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 07:46:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:46:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:46:58 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 07:46:58 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 07:46:58 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 07:46:58 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 07:46:58 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 07:46:58 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 07:46:58 INFO - Downloading functools32-3.2.3-2.tar.gz 07:46:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:46:58 INFO - warning: no files found matching '*.txt' 07:46:58 INFO - no previously-included directories found matching 'build' 07:46:58 INFO - no previously-included directories found matching 'dist' 07:46:58 INFO - no previously-included directories found matching '.git*' 07:46:58 INFO - Installing collected packages: jsonschema, functools32 07:46:58 INFO - Running setup.py install for functools32 07:46:58 INFO - warning: no files found matching '*.txt' 07:46:58 INFO - no previously-included directories found matching 'build' 07:46:58 INFO - no previously-included directories found matching 'dist' 07:46:58 INFO - no previously-included directories found matching '.git*' 07:46:58 INFO - Successfully installed jsonschema functools32 07:46:58 INFO - Cleaning up... 07:46:58 INFO - Return code: 0 07:46:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:46:58 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')]} 07:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:58 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')]} 07:46:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:58 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 0x7fe3c000ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe731c0>, '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 0xe740c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe74550>, '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': '33d5923976266a1c518c4bf7000001ab-1465483555.173147-1124489517', '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 07:46:58 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 07:46:58 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 07:46:58 INFO - Using env: {'DISPLAY': ':0', 07:46:58 INFO - 'HOME': '/home/cltbld', 07:46:58 INFO - 'LANG': 'en_US.UTF-8', 07:46:58 INFO - 'LANGUAGE': 'en_US:en', 07:46:58 INFO - 'LOGNAME': 'cltbld', 07:46:58 INFO - 'MAIL': '/var/mail/cltbld', 07:46:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:58 INFO - 'MOZ_NO_REMOTE': '1', 07:46:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:58 INFO - 'NO_EM_RESTART': '1', 07:46:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:58 INFO - 'PWD': '/builds/slave/test', 07:46:58 INFO - 'SHELL': '/bin/bash', 07:46:58 INFO - 'SHLVL': '1', 07:46:58 INFO - 'TERM': 'linux', 07:46:58 INFO - 'TMOUT': '86400', 07:46:58 INFO - 'USER': 'cltbld', 07:46:58 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465483555.173147-1124489517', 07:46:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:58 INFO - '_': '/tools/buildbot/bin/python'} 07:46:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:58 INFO - Downloading/unpacking blobuploader==1.2.4 07:46:58 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 07:46:58 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 07:46:58 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 07:46:58 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 07:46:58 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 07:46:58 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 07:47:00 INFO - Downloading blobuploader-1.2.4.tar.gz 07:47:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:47:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:47:00 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 07:47:00 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 07:47:00 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 07:47:00 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 07:47:00 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 07:47:00 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 07:47:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:47:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:47:01 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 07:47:01 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 07:47:01 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 07:47:01 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 07:47:01 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 07:47:01 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 07:47:01 INFO - Downloading docopt-0.6.1.tar.gz 07:47:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:47:01 INFO - Installing collected packages: blobuploader, requests, docopt 07:47:01 INFO - Running setup.py install for blobuploader 07:47:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:47:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:47:01 INFO - Running setup.py install for requests 07:47:02 INFO - Running setup.py install for docopt 07:47:02 INFO - Successfully installed blobuploader requests docopt 07:47:02 INFO - Cleaning up... 07:47:02 INFO - Return code: 0 07:47:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:02 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 0x7fe3c000ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe731c0>, '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 0xe740c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe74550>, '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': '33d5923976266a1c518c4bf7000001ab-1465483555.173147-1124489517', '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 07:47:02 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 07:47:02 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 07:47:02 INFO - Using env: {'DISPLAY': ':0', 07:47:02 INFO - 'HOME': '/home/cltbld', 07:47:02 INFO - 'LANG': 'en_US.UTF-8', 07:47:02 INFO - 'LANGUAGE': 'en_US:en', 07:47:02 INFO - 'LOGNAME': 'cltbld', 07:47:02 INFO - 'MAIL': '/var/mail/cltbld', 07:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:02 INFO - 'MOZ_NO_REMOTE': '1', 07:47:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:02 INFO - 'NO_EM_RESTART': '1', 07:47:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:02 INFO - 'PWD': '/builds/slave/test', 07:47:02 INFO - 'SHELL': '/bin/bash', 07:47:02 INFO - 'SHLVL': '1', 07:47:02 INFO - 'TERM': 'linux', 07:47:02 INFO - 'TMOUT': '86400', 07:47:02 INFO - 'USER': 'cltbld', 07:47:02 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465483555.173147-1124489517', 07:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:02 INFO - '_': '/tools/buildbot/bin/python'} 07:47:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:47:02 INFO - Running setup.py (path:/tmp/pip-dPFx56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:47:02 INFO - Running setup.py (path:/tmp/pip-vqthlb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:47:02 INFO - Running setup.py (path:/tmp/pip-oBtvvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:47:02 INFO - Running setup.py (path:/tmp/pip-cxcrB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:47:02 INFO - Running setup.py (path:/tmp/pip-SfXcqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:47:02 INFO - Running setup.py (path:/tmp/pip-NFEOpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:47:02 INFO - Running setup.py (path:/tmp/pip-RJx566-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:47:02 INFO - Running setup.py (path:/tmp/pip-N6un9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:47:02 INFO - Running setup.py (path:/tmp/pip-jQr4hI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:47:03 INFO - Running setup.py (path:/tmp/pip-c0pCHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:47:03 INFO - Running setup.py (path:/tmp/pip-szP9RF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:47:03 INFO - Running setup.py (path:/tmp/pip-vBmMAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:47:03 INFO - Running setup.py (path:/tmp/pip-yGmKGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:47:03 INFO - Running setup.py (path:/tmp/pip-1NXfZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:47:03 INFO - Running setup.py (path:/tmp/pip-gIroCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:47:03 INFO - Running setup.py (path:/tmp/pip-7WIj4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:47:03 INFO - Running setup.py (path:/tmp/pip-a1fi9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:47:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:47:03 INFO - Running setup.py install for manifestparser 07:47:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:47:03 INFO - Running setup.py install for mozcrash 07:47:03 INFO - Running setup.py install for mozdebug 07:47:03 INFO - Running setup.py install for mozdevice 07:47:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:47:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:47:04 INFO - Running setup.py install for mozfile 07:47:04 INFO - Running setup.py install for mozhttpd 07:47:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:47:04 INFO - Running setup.py install for mozinfo 07:47:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:47:04 INFO - Running setup.py install for mozInstall 07:47:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:47:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:47:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:47:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:47:04 INFO - Running setup.py install for mozleak 07:47:04 INFO - Running setup.py install for mozlog 07:47:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:47:04 INFO - Running setup.py install for moznetwork 07:47:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:47:04 INFO - Running setup.py install for mozprocess 07:47:04 INFO - Running setup.py install for mozprofile 07:47:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:47:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:47:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:47:04 INFO - Running setup.py install for mozrunner 07:47:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:47:05 INFO - Running setup.py install for mozscreenshot 07:47:05 INFO - Running setup.py install for moztest 07:47:05 INFO - Running setup.py install for mozversion 07:47:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:47:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:47:05 INFO - Cleaning up... 07:47:05 INFO - Return code: 0 07:47:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:47:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:05 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 0x7fe3c000ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe731c0>, '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 0xe740c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe74550>, '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': '33d5923976266a1c518c4bf7000001ab-1465483555.173147-1124489517', '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 07:47:05 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 07:47:05 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 07:47:05 INFO - Using env: {'DISPLAY': ':0', 07:47:05 INFO - 'HOME': '/home/cltbld', 07:47:05 INFO - 'LANG': 'en_US.UTF-8', 07:47:05 INFO - 'LANGUAGE': 'en_US:en', 07:47:05 INFO - 'LOGNAME': 'cltbld', 07:47:05 INFO - 'MAIL': '/var/mail/cltbld', 07:47:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:05 INFO - 'MOZ_NO_REMOTE': '1', 07:47:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:05 INFO - 'NO_EM_RESTART': '1', 07:47:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:05 INFO - 'PWD': '/builds/slave/test', 07:47:05 INFO - 'SHELL': '/bin/bash', 07:47:05 INFO - 'SHLVL': '1', 07:47:05 INFO - 'TERM': 'linux', 07:47:05 INFO - 'TMOUT': '86400', 07:47:05 INFO - 'USER': 'cltbld', 07:47:05 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465483555.173147-1124489517', 07:47:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:05 INFO - '_': '/tools/buildbot/bin/python'} 07:47:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:47:05 INFO - Running setup.py (path:/tmp/pip-Bc2scL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:47:05 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)) 07:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:47:05 INFO - Running setup.py (path:/tmp/pip-1oeK1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:47:05 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)) 07:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:47:05 INFO - Running setup.py (path:/tmp/pip-crhDct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:47:05 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)) 07:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:47:05 INFO - Running setup.py (path:/tmp/pip-Bv6egs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:47:05 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)) 07:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:47:05 INFO - Running setup.py (path:/tmp/pip-KvcUU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:47:06 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)) 07:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:47:06 INFO - Running setup.py (path:/tmp/pip-IStpLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:47:06 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)) 07:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:47:06 INFO - Running setup.py (path:/tmp/pip-J_B2YP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:47:06 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)) 07:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:47:06 INFO - Running setup.py (path:/tmp/pip-fcay7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:47:06 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)) 07:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:47:06 INFO - Running setup.py (path:/tmp/pip-Yh9p02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:47:06 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)) 07:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:47:06 INFO - Running setup.py (path:/tmp/pip-H71DKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:47:06 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)) 07:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:47:06 INFO - Running setup.py (path:/tmp/pip-Jeq1dG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:47:06 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)) 07:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:47:06 INFO - Running setup.py (path:/tmp/pip-Id64iO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:47:06 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)) 07:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:47:06 INFO - Running setup.py (path:/tmp/pip-4Hqoaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:47:06 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)) 07:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:47:06 INFO - Running setup.py (path:/tmp/pip-3kgaqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:47:06 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)) 07:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:47:06 INFO - Running setup.py (path:/tmp/pip-WV1NK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:47:06 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)) 07:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:47:06 INFO - Running setup.py (path:/tmp/pip-nnG12_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:47:06 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)) 07:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:47:06 INFO - Running setup.py (path:/tmp/pip-ffT9M0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:47:06 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)) 07:47:06 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)) 07:47:06 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)) 07:47:06 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)) 07:47:06 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)) 07:47:06 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)) 07:47:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:47:06 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 07:47:06 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 07:47:06 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 07:47:06 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 07:47:06 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 07:47:06 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 07:47:08 INFO - Downloading blessings-1.6.tar.gz 07:47:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:47:08 INFO - Installing collected packages: blessings 07:47:08 INFO - Running setup.py install for blessings 07:47:08 INFO - Successfully installed blessings 07:47:08 INFO - Cleaning up... 07:47:09 INFO - Return code: 0 07:47:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:47:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:47:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:47:09 INFO - Reading from file tmpfile_stdout 07:47:09 INFO - Current package versions: 07:47:09 INFO - argparse == 1.2.1 07:47:09 INFO - blessings == 1.6 07:47:09 INFO - blobuploader == 1.2.4 07:47:09 INFO - docopt == 0.6.1 07:47:09 INFO - functools32 == 3.2.3-2 07:47:09 INFO - jsonschema == 2.5.1 07:47:09 INFO - manifestparser == 1.1 07:47:09 INFO - mozInstall == 1.12 07:47:09 INFO - mozcrash == 0.17 07:47:09 INFO - mozdebug == 0.1 07:47:09 INFO - mozdevice == 0.48 07:47:09 INFO - mozfile == 1.2 07:47:09 INFO - mozhttpd == 0.7 07:47:09 INFO - mozinfo == 0.9 07:47:09 INFO - mozleak == 0.1 07:47:09 INFO - mozlog == 3.2 07:47:09 INFO - moznetwork == 0.27 07:47:09 INFO - mozprocess == 0.22 07:47:09 INFO - mozprofile == 0.28 07:47:09 INFO - mozrunner == 6.11 07:47:09 INFO - mozscreenshot == 0.1 07:47:09 INFO - mozsystemmonitor == 0.3 07:47:09 INFO - moztest == 0.7 07:47:09 INFO - mozversion == 1.4 07:47:09 INFO - psutil == 3.1.1 07:47:09 INFO - requests == 1.2.3 07:47:09 INFO - wsgiref == 0.1.2 07:47:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:47:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:47:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:09 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 0x7fe3c000ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe731c0>, '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 0xe740c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe74550>, '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': '33d5923976266a1c518c4bf7000001ab-1465483555.173147-1124489517', '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 07:47:09 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 07:47:09 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 07:47:09 INFO - Using env: {'DISPLAY': ':0', 07:47:09 INFO - 'HOME': '/home/cltbld', 07:47:09 INFO - 'LANG': 'en_US.UTF-8', 07:47:09 INFO - 'LANGUAGE': 'en_US:en', 07:47:09 INFO - 'LOGNAME': 'cltbld', 07:47:09 INFO - 'MAIL': '/var/mail/cltbld', 07:47:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:09 INFO - 'MOZ_NO_REMOTE': '1', 07:47:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:09 INFO - 'NO_EM_RESTART': '1', 07:47:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:09 INFO - 'PWD': '/builds/slave/test', 07:47:09 INFO - 'SHELL': '/bin/bash', 07:47:09 INFO - 'SHLVL': '1', 07:47:09 INFO - 'TERM': 'linux', 07:47:09 INFO - 'TMOUT': '86400', 07:47:09 INFO - 'USER': 'cltbld', 07:47:09 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465483555.173147-1124489517', 07:47:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:09 INFO - '_': '/tools/buildbot/bin/python'} 07:47:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:09 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)) 07:47:09 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)) 07:47:09 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)) 07:47:09 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)) 07:47:09 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)) 07:47:09 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)) 07:47:09 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)) 07:47:09 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)) 07:47:09 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)) 07:47:09 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)) 07:47:09 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)) 07:47:09 INFO - Cleaning up... 07:47:09 INFO - Return code: 0 07:47:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:47:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:47:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:09 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 0x7fe3c000ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe731c0>, '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 0xe740c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe74550>, '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': '33d5923976266a1c518c4bf7000001ab-1465483555.173147-1124489517', '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 07:47:09 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 07:47:09 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 07:47:09 INFO - Using env: {'DISPLAY': ':0', 07:47:09 INFO - 'HOME': '/home/cltbld', 07:47:09 INFO - 'LANG': 'en_US.UTF-8', 07:47:09 INFO - 'LANGUAGE': 'en_US:en', 07:47:09 INFO - 'LOGNAME': 'cltbld', 07:47:09 INFO - 'MAIL': '/var/mail/cltbld', 07:47:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:09 INFO - 'MOZ_NO_REMOTE': '1', 07:47:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:09 INFO - 'NO_EM_RESTART': '1', 07:47:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:09 INFO - 'PWD': '/builds/slave/test', 07:47:09 INFO - 'SHELL': '/bin/bash', 07:47:09 INFO - 'SHLVL': '1', 07:47:09 INFO - 'TERM': 'linux', 07:47:09 INFO - 'TMOUT': '86400', 07:47:09 INFO - 'USER': 'cltbld', 07:47:09 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465483555.173147-1124489517', 07:47:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:09 INFO - '_': '/tools/buildbot/bin/python'} 07:47:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:47:09 INFO - Cleaning up... 07:47:09 INFO - Return code: 0 07:47:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:47:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:47:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:09 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 0x7fe3c000ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe731c0>, '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 0xe740c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe74550>, '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': '33d5923976266a1c518c4bf7000001ab-1465483555.173147-1124489517', '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 07:47:09 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 07:47:09 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 07:47:09 INFO - Using env: {'DISPLAY': ':0', 07:47:09 INFO - 'HOME': '/home/cltbld', 07:47:09 INFO - 'LANG': 'en_US.UTF-8', 07:47:09 INFO - 'LANGUAGE': 'en_US:en', 07:47:09 INFO - 'LOGNAME': 'cltbld', 07:47:09 INFO - 'MAIL': '/var/mail/cltbld', 07:47:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:09 INFO - 'MOZ_NO_REMOTE': '1', 07:47:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:09 INFO - 'NO_EM_RESTART': '1', 07:47:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:09 INFO - 'PWD': '/builds/slave/test', 07:47:09 INFO - 'SHELL': '/bin/bash', 07:47:09 INFO - 'SHLVL': '1', 07:47:09 INFO - 'TERM': 'linux', 07:47:09 INFO - 'TMOUT': '86400', 07:47:09 INFO - 'USER': 'cltbld', 07:47:09 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465483555.173147-1124489517', 07:47:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:09 INFO - '_': '/tools/buildbot/bin/python'} 07:47:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:09 INFO - Downloading/unpacking flake8 07:47:09 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 07:47:09 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 07:47:09 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 07:47:09 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 07:47:09 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 07:47:09 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 07:47:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:47:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:47: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 07:47: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 07:47: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 07:47: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 07:47: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 07:47: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 07:47:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:47:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:47:12 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 07:47:12 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 07:47:12 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 07:47:12 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 07:47:12 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 07:47:12 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 07:47:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:47:12 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 07:47:12 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 07:47:12 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 07:47:12 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 07:47:12 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 07:47:12 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 07:47:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:47:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:47:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:47:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:47:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:47:12 INFO - no previously-included directories found matching 'docs/_build' 07:47:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:47:12 INFO - Running setup.py install for pep8 07:47:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:47:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:47:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:47:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:47:12 INFO - no previously-included directories found matching 'docs/_build' 07:47:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:47:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:47:12 INFO - Cleaning up... 07:47:12 INFO - Return code: 0 07:47:12 INFO - Running post-action listener: _resource_record_post_action 07:47:12 INFO - Running post-action listener: _start_resource_monitoring 07:47:12 INFO - Starting resource monitoring. 07:47:12 INFO - ##### 07:47:12 INFO - ##### Finished create-virtualenv step (success) 07:47:12 INFO - ##### 07:47:12 INFO - ##### 07:47:12 INFO - ##### Running install step. 07:47:12 INFO - ##### 07:47:12 INFO - Running pre-action listener: _resource_record_pre_action 07:47:12 INFO - Running main action method: install 07:47:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:47:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:47:13 INFO - Reading from file tmpfile_stdout 07:47:13 INFO - Detecting whether we're running mozinstall >=1.0... 07:47:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:47:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:47:13 INFO - Reading from file tmpfile_stdout 07:47:13 INFO - Output received: 07:47:13 INFO - Usage: mozinstall [options] installer 07:47:13 INFO - Options: 07:47:13 INFO - -h, --help show this help message and exit 07:47:13 INFO - -d DEST, --destination=DEST 07:47:13 INFO - Directory to install application into. [default: 07:47:13 INFO - "/builds/slave/test"] 07:47:13 INFO - --app=APP Application being installed. [default: firefox] 07:47:13 INFO - mkdir: /builds/slave/test/build/application 07:47:13 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'] 07:47:13 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 07:47:32 INFO - Reading from file tmpfile_stdout 07:47:33 INFO - Output received: 07:47:33 INFO - /builds/slave/test/build/application/firefox/firefox 07:47:35 INFO - Running post-action listener: _resource_record_post_action 07:47:35 INFO - ##### 07:47:35 INFO - ##### Finished install step (success) 07:47:35 INFO - ##### 07:47:35 INFO - ##### 07:47:35 INFO - ##### Running run-tests step. 07:47:35 INFO - ##### 07:47:35 INFO - Running pre-action listener: _resource_record_pre_action 07:47:35 INFO - Running main action method: run_tests 07:47:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:47:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:47:35 INFO - Python 2.7.3 07:47:35 INFO - Return code: 0 07:47:35 INFO - grabbing minidump binary from tooltool 07:47:35 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')]} 07:47:35 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 0xe731c0>, '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 0xe740c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe74550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:47:35 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 07:47:35 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 07:47:35 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 07:47:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:47:35 INFO - Return code: 0 07:47:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:47:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:47:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:47:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:47:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:47:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:47:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:47:36 INFO - Return code: 0 07:47:36 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/Ry5ML7fKRCWp1OOUbD_iMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 07:47:36 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/Ry5ML7fKRCWp1OOUbD_iMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 07:47:36 INFO - Using env: {'DISPLAY': ':0', 07:47:36 INFO - 'HOME': '/home/cltbld', 07:47:36 INFO - 'LANG': 'en_US.UTF-8', 07:47:36 INFO - 'LANGUAGE': 'en_US:en', 07:47:36 INFO - 'LOGNAME': 'cltbld', 07:47:36 INFO - 'MAIL': '/var/mail/cltbld', 07:47:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:47:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:47:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:36 INFO - 'MOZ_NO_REMOTE': '1', 07:47:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:47:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:36 INFO - 'NO_EM_RESTART': '1', 07:47:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:36 INFO - 'PWD': '/builds/slave/test', 07:47:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:47:36 INFO - 'SHELL': '/bin/bash', 07:47:36 INFO - 'SHLVL': '1', 07:47:36 INFO - 'TERM': 'linux', 07:47:36 INFO - 'TMOUT': '86400', 07:47:36 INFO - 'USER': 'cltbld', 07:47:36 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465483555.173147-1124489517', 07:47:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:36 INFO - '_': '/tools/buildbot/bin/python'} 07:47:36 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/Ry5ML7fKRCWp1OOUbD_iMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 07:47:36 INFO - mozversion application_buildid: 20160609064728 07:47:36 INFO - mozversion application_changeset: 4678ba5309817e01839b86f14cbc9469e78c8ae8 07:47:36 INFO - mozversion application_display_name: Nightly 07:47:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:47:36 INFO - mozversion application_name: Firefox 07:47:36 INFO - mozversion application_remotingname: firefox 07:47:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:47:36 INFO - mozversion application_vendor: Mozilla 07:47:36 INFO - mozversion application_version: 50.0a1 07:47:36 INFO - mozversion platform_buildid: 20160609064728 07:47:36 INFO - mozversion platform_changeset: 4678ba5309817e01839b86f14cbc9469e78c8ae8 07:47:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:47:36 INFO - mozversion platform_version: 50.0a1 07:47:36 INFO - using testdate: 1465483656 07:47:36 INFO - actual date: 1465483656 07:47:36 INFO - starting webserver on 'localhost:33942' 07:47:36 INFO - SUITE-START | Running 2 tests 07:47:36 INFO - TEST-START | dromaeo_css 07:47:36 INFO - operating with platform_type : linux_ 07:47:36 INFO - Initialising browser for dromaeo_css test... 07:47:36 INFO - TEST-INFO | started process 4823 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG5cJxx/profile http://localhost:33942/getInfo.html) 07:47:43 INFO - PROCESS | 4823 | __metrics Screen width/height:1600/1200 07:47:43 INFO - PROCESS | 4823 | colorDepth:24 07:47:43 INFO - PROCESS | 4823 | Browser inner width/height: 1024/697 07:47:43 INFO - PROCESS | 4823 | __metrics 07:47:46 ERROR - PROCESS | 4823 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:47:46 INFO - PROCESS | 4823 | console.error: PushService: 07:47:46 INFO - PROCESS | 4823 | stateChangeProcessEnqueue: Error transitioning state 07:47:46 INFO - PROCESS | 4823 | UnknownError 07:47:47 INFO - TEST-INFO | 4823: exit 0 07:47:47 INFO - Browser initialized. 07:47:47 INFO - Running cycle 1/1 for dromaeo_css test... 07:47:47 INFO - TEST-INFO | started process 4905 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG5cJxx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:47:59 INFO - PROCESS | 4905 | RSS: Main: 174809088 07:47:59 INFO - PROCESS | 4905 | 07:48:51 INFO - PROCESS | 4905 | 1465483731161 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] 07:51:04 INFO - PROCESS | 4905 | Cycle 1(1): loaded http://localhost:33942/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33942/tests/dromaeo/cssquery-ext.html) 07:51:05 INFO - PROCESS | 4905 | RSS: Main: 307912704 07:51:05 INFO - PROCESS | 4905 | 07:54:08 INFO - PROCESS | 4905 | Cycle 1(1): loaded http://localhost:33942/tests/dromaeo/cssquery-ext.html (next: http://localhost:33942/tests/dromaeo/cssquery-jquery.html) 07:54:09 INFO - PROCESS | 4905 | RSS: Main: 266825728 07:54:09 INFO - PROCESS | 4905 | 07:57:11 INFO - PROCESS | 4905 | Cycle 1(1): loaded http://localhost:33942/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33942/tests/dromaeo/cssquery-mootools.html) 07:57:11 INFO - PROCESS | 4905 | RSS: Main: 265936896 07:57:11 INFO - PROCESS | 4905 | 08:00:14 INFO - PROCESS | 4905 | Cycle 1(1): loaded http://localhost:33942/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33942/tests/dromaeo/cssquery-prototype.html) 08:00:14 INFO - PROCESS | 4905 | RSS: Main: 260161536 08:00:14 INFO - PROCESS | 4905 | 08:03:17 INFO - PROCESS | 4905 | Cycle 1(1): loaded http://localhost:33942/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33942/tests/dromaeo/cssquery-yui.html) 08:03:18 INFO - PROCESS | 4905 | RSS: Main: 232812544 08:03:18 INFO - PROCESS | 4905 | 08:06:20 INFO - PROCESS | 4905 | Cycle 1(1): loaded http://localhost:33942/tests/dromaeo/cssquery-yui.html (next: http://localhost:33942/tests/dromaeo/cssquery-dojo.html) 08:06:21 INFO - PROCESS | 4905 | RSS: Main: 298024960 08:06:21 INFO - PROCESS | 4905 | 08:06:21 INFO - PROCESS | 4905 | __start_tp_report 08:06:21 INFO - PROCESS | 4905 | _x_x_mozilla_page_load 08:06:21 INFO - PROCESS | 4905 | _x_x_mozilla_page_load_details 08:06:21 INFO - PROCESS | 4905 | |i|pagename|runs| 08:06:21 INFO - PROCESS | 4905 | |0;dojo.html;2565.140677872912;2606.2832721001732;2640.907568235112;2642.1677171690917;2648.642433271509;4477.865664030076;4556.8860778480475;4602.148602508539;4612.792424340904;4759.09577180336;4629.953700462995;4646.186917289469;4727.149113159629;4729.172394830899;4763.428388593374;4224.598663126998;4265.488141423018;4391.165678521071;4423.712458690175;4424.336349547578;4347.869563913087;4365.105153443536;4409.559044095581;4419.977900110511;4449.621782148522;4124.835006599732;4157.833686652531;4161.771102589357;4222.239996800575;4323.265044942367;4267.573242675739;4278.016056307036;4287.528371879091;4321.178975994582;4328.653707703407;4299.720518166309;4309.892252693677;4325.675574331937;4343.739375637472;4353.608175264241;4532.86401407955;4641;4693.155232058228;4715.386999690053;4753.928691069636;5061.746912654353;5067.2145817397995;5076.086304465195;5079.644424890259;5081.974590127063;5083.288339632454;5087.9745601272125;5099.923501147486;5115.335006449175;5117.7185254810975;4358.5205627380965;4644.396228490275;4700.835470758507;4703.012367402884;4715.316279139505;5149.150390185652;5155.793768249228;5197.454267301954;5205.323307969939;5209.739513024334;4664.930026049612;4946.901061978812;4991.575716064102;4996.375453068366;5002.09962206799;4867.58625516835;4891.975540122347;4893.412790465167;4944.134776414113;4979.278004689299;4850.6362022847725;4867.659263851568;4869.464358920516;4877.244027175793;4920.606351491943;4835.8065677373215;4842.951570484321;4845.53967373099;4845.6608037437745;4892.804287828447;3954.62431069048;3987.043109653662;3991.820368083443;4018.4976877890263;4021.7989100544855;3573.19603089308;3590.3537363274863;3600.945985810215;3609.9278014439565;3612.313660404567;4204.558521355275;4228.386883901879;4253.3194688849635;4370.060437006059;4425.75658338788;5075.771590278372;5096.61775366849;5099.184130539096;5103.846884593394;5143.948560514347;4394;4424.33634954753;4427.468703755506;4462.196804575143;4470.754108524063;4277.144571085795;4415.40392047076;4483.730976141442;4484.170428470743;4511.345854851028;4738.786754596052;4751.429828420542;4764.9047019058735;4791.065742180242;4799.3760811094335;4987.576056035277;4993.201087825931;5040.067587496325;5042.596592272683;5088.236764485357;4550.522195169459;4700.059988002345;4732.787024583971;4744.976275118603;4749.928751068667;4893.877653058702;4903.387076615423;4917.729524876023;4924.310596516562;4968.552830245295;4734.100520901018;4982.352294201731;4993.350864387607;4998.950010499849;5055.898882022412;4784.832530861403;4860.78126484302;4874.268859671078;4903.4606193317995;4941.555260026615;4845.685030473008;4875.293082502946;4886.804527818989;4887.951120488749;4928.088303663833;4531.909361812811;4579.313103034438;4820.108279968217;4833.854984350475;4869.147899117711;4695.9530404695515;4697.953020469751;4704.882377940579;4728.929066063943;4739.241721324572;4710.26990816424;4721.173794586002;4728.243481043017;4768.833090841804;4773.236282194971 08:06:21 INFO - PROCESS | 4905 | |1;ext.html;568.573569822633;580.1182203051364;581.953443724502;584.8771757930832;589.1722130406778;27818;39108.60891391085;40471.797641011755;40571.18857622853;44298.55701442993;42054.78972605133;42509.57490425095;42515;42557.36163957543;42628.78685606575;7452.180260171377;7604.657790399446;7752.030996125484;7756.457048006613;7758.069031716173;7418.591977441239;7712.6914923403;7712.922870771305;9988.500574971258;10244.74388140295;10340.793184136313;10389.220808439359;10402.115820155295;10404.68785936423;10404.947975260113;10236.488175591228;10293.228007899437;10314.278000539965;10318.1745460363;10322.79354412915;7429.257074292582;9825.803483930353;10175.694729158136;10183.745406364826;10543.578256869792;38152.618473815186;38612.61387386146;38646.61353386487;38729;38754.80622596869;2684.5436275833154;2748.931276718078;2787.2613757354316;2791.595218693278;2847.5870998705072;29011.854940725163;29508.40983180346;29627.851860740775;29723.702762972527;30100.397992040038;3494.860205591773;3500.527428797105;3563.625819288989;3579;3629.4737263096968;242759;244471;244501;245524;246420;52270.47729522656;52817.7359113202;52842.207366889525;52886;52900.561463504746;32901.3419731604;33224.335513289596;33265.66734332674;35470.11324716851;54722;14939.477118300807;15043.924780376028;15052.32264548098;15071.54785356441;15073.698526029419;10303.433311167957;11622.186446948632;11700.88299117015;11709.765804683859;11715.589954351557;17986.19062142207;18354.541136471427;18493.352732654294;18931.621367572847;19013.714794278098;6710.865782684319;6816.591004539743;6822.965885170543;7013.89479157813;7038.577685338896;781.8983532140899;854.1970547685156;862.4135587800231;891.0866361979023;952.3571589177278;27287.727122728917;27919.30201744932;28561;28630.570541441895;28674.713252867205;948.5826236455937;1004.9949750251202;1021.5096753558333;1054.3515737821185;1070.4576630502556;14355.425782968774;14806.259687015607;14853;15081.849181508045;15140.167290798892;365159;372257;372288;373115;373482;48573;49281.50718492841;49284.75357623189;49295.75352123217;49317.50682493201;1061.6868023932805;1161.3960740414936;1168.9473973671206;1179.8260730572963;1194.814803705427;27825.304367390978;28931.855340724003;28962.855185723936;29047.56428653614;29383.55924661089;40960.38559421671;47173.528264716915;48205;48285.27572086492;52592.47407526029;341018;345765;351945;352962;354058;33971.83014084914;34415.311693765485;35286.117847053;35351.646483535864;35361.29277414386;31897;40724.59275407208;40995.79502102471;42212.15575688407;42639.147217054866;34649.82675086609;36126.458103129;36529.452058218616;36765.63234367622;36839.26321473609;35746.64253357433;35831.641683583875;35992.28015439624;36063.63936360603;36134.4579831308;34694.82652586721;35070.12324691903;35303.293934121684;35689.64310356863;35851.10372240715;31615.893443729357;32165.839170803996;32273.896812767005;32324.191895202806;32692.182695432806;24437.266881993568;24704.382390439663;24932.376690582154;25261.873690632165;25320.873395632905 08:06:21 INFO - PROCESS | 4905 | |2;jquery.html;352.2685998318266;352.95235143255655;353.31809607457603;363.28070420567275;364.5079143156737;16446.588835279123;16484.42304519342;17180;17402.47792566222;17402.912985435087;16304.184790760473;16611.91694041531;16841.326346946138;16947.91526042368;16958;4781.354517140185;4958.454569997298;5005.249212618118;5009.824656137036;5017.724025178613;3032.6815684353155;3177.253345463814;4926.729029903354;5615.382307946143;5909.674967876765;5883;5898.380670029649;5929.614575052629;5959.731812068446;5968.67172305523;5642.746076426571;5796.565257605696;5844.795432159896;5909.8227053188475;5921.851953701149;2745.341118131634;4733.573978341931;5064.34163558735;5066.265391518246;5090.9745451272875;20333.288334908357;20500.282490112924;20558.69161962572;20654.58690826175;20814.16743330265;1866.2721538599958;1897.6679081160742;1947.0167565379534;1950.4733721895009;1964.5186929202293;12839.614811555575;12869.485220591165;12906.096573239876;13029.674258143528;13354.599362019155;1572.119613016703;1915.5689969756831;1953.4432686684227;1986.9801301987084;2048.09883651193;78611.6069419655;79835.60082199551;80814;83093.58453207756;84216.49192405786;15974.201289935689;16114.75827862583;16166.515004549883;16191.838081619033;16659.833401665826;28930.27674308159;29410.558841617392;29515.409691806042;29653.110406687403;29725.55411668827;8576.785580360542;9281.164695177466;9311;9364.25085993119;9455.810883782424;7664.11862635804;7704.383649308042;7708.113566939762;7770.10643775973;7879.2120787921895;8125.9187408126345;8250.958745206235;8400.849681369486;8449.873251901226;8541.743747687578;2482.553140434739;3216.533602627606;3322.734181265493;3342.131045928076;3490.2321489272317;748.7903387051634;813.4996976859189;813.6175997281268;852.8123812761182;937.3766445313926;15195.772063419057;15687.529374118794;16254.349826006828;16303.59241018984;16663.416780412626;846.9576521173917;856.195176534056;864.6973559254336;869.3783944479727;922.9123233292827;9026.277897768163;9122.543872806333;9355.391899526508;9590.616375344907;9658.855117173249;398504;400643;427064;432628;436840.34218460246;80751;86367;87091.56454217815;88067;88227;947.5120313038791;947.9478628675352;958.0084612425966;982.2731178927685;992.831218692824;15537;15705.528834134995;15806.68386632284;15980.280887359864;16162.595935101717;37175.25649487049;37853.621463785006;37968;38662.613373867025;38825.805870970464;51944;53185.734071329396;53979.460205397445;54521;55021.724891375285;7140.750073747394;7456.850862982601;7477.513961592479;7486;7625.8856117157175;7179.964100179465;7862.52824830512;10362.948185259025;11638.88361116378;11646.185764443053;9297.581608827484;9858.11276985046;10034.899651003396;10128.898711013091;10160.695179144637;9735.70792876215;10137.746556336151;10161.745956351151;10397.428141452292;10404.947975260075;9833.557489913113;9949.253805964727;10330.225233107396;10505.737356566147;10801.891981080404;6972.302769722987;7230.855382892418;7241.782746517613;7322.121345438582;7369.668364923484;9157.130072643089;9740.220782337537;9744.07431294026;9892.208623310262;9901.108900199017 08:06:21 INFO - PROCESS | 4905 | |3;mootools.html;1218.262950914696;1343.3283358320843;1414.837293711223;1423.7721964485684;1650.9834901650988;6597.967010164954;7521.435892308072;7787.4938129021575;7819.2571705688015;7965.681372745098;7704.6918123275;7840.882386764189;7851.332636725885;7869.645865936032;7885.1326354101;2156.180651352488;2179.553191595727;2179.6621523663857;2184.5194057307367;2185.9890700546475;2135.6049130910833;2168.7072245246927;2175.3473957812594;2175.651895696689;2188.518525924294;2090.435582392753;2095.4866057815857;2099.3806826986074;2102.9474263143466;2161.049138379116;2070.4720296324417;2077.0653206057336;2079.0540304161646;2081.6565266730972;2085.4577809769416;2019.919203231869;2088.592724418739;2088.7702352741185;2089.5194105355854;2095.518030852897;7723.11184213817;7745.1867553906595;7796.376289896794;7819.491733037335;7984.8403031939615;4467.352233926095;4557.179707652621;4578.908421831545;4586.151561961048;4586.908261834778;2698.190542837141;2801.355688191707;2846.1461561531664;2849.672287686901;2873.583330417078;873.8470767615705;888.6667499687617;898.0570401078841;899.3434792601438;903.5708038681639;10583.62957296491;10682.252242343038;10728.302660327054;10740.140788736882;10742.516586753614;3907.4724912137067;4020.2361551305157;4087.325591277406;4087.5912408758886;4099.8360065597635;8305;8333.208345207195;8380.287675547524;8395.076541580422;8404.873926891101;4425.977870110629;4441.733495990251;4458.019235768126;4463.062756821104;4466.865994020184;3444.913877153091;3881.7476864003747;4085.733422638991;4218;4246.278132717383;3299.5710557627835;3336.5495658085847;3397.8301084946147;3466.982665086709;3507.5615548056494;949.586929685589;993.9701808945744;1000.8999100090078;1004.1364426593124;1016.5730393234859;615.9568830181844;641.2753588445028;691.1602403080282;746.910370755502;753.7512620835112;4889.535494128052;5029.5221953914315;5052.69683818972;5276.314079169683;5276.577873770089;401.0967957043846;405.1249301508727;408.2182620282186;410.8459327752093;415.20281060364175;3377.6453472385047;3393.100828280508;3418.5555877735737;3445.0353900907785;3486.651334866493;9273.907260927304;9369.484678342757;9575.712728618153;9665.516724163905;9671.758206044906;9484.90515094854;9525.809483810284;9582.856257156009;9665.806683866283;9673.661421850202;7049.3303136203;7255.709771609077;7375.04124463827;7448.739294124788;7456.142543607554;4741.668083234141;4794.640401969936;4842.249451335048;4914.926276105933;4943;8850.159234872677;8871.157240062184;8902.465852048897;8904.19862212404;8922.197002269826;8850.73447796567;8950.955245223733;9095.590698418719;9120.133587309196;9124.543772811465;5145.536901678867;5767.769289228384;6225.875482490234;6264.59280146789;6270.216222972129;7071.752488662872;7295.416366690758;7339.339459448675;7346.228645992094;7352;6377.681115944277;6497.837554061186;6517.055027020961;6590.143281373391;6661.1007513985;5891.705414729332;5908.645481271137;5997.16039754426;6053.152558641882;6157.076438534255;5386.649867758583;5479.671219726829;5499.807506737245;5523.834284971457;5528;3940.2513522430645;3985;4007.939880901847;4087.7956102195367;4115.42384066237;4044.7977601119237;4091.324931386288;4136.793160342031;4148.377743338523;4187.434696316081 08:06:21 INFO - PROCESS | 4905 | |4;prototype.html;290.64686406016693;291.56411165307867;297.1531136261654;298.40914988323135;300.43368250847175;4802.135615589193;4817.325574419584;4821.3491178690865;4836.322914791927;4837.129316722984;4749.548792864681;4753.952460475394;4769.141554520185;4774.880627984302;4776;3523.964760352396;3582.6059133495296;3614.6746792788645;3720.330340538702;3748.850045998157;3707.6292370762976;3719.7396182267253;3741.7567858089274;3745.906352341186;3746.662800347968;3470.9305813883707;3705.221903400289;3710.2950439416422;3727.0868637183794;3730.048837546422;3471.3057388522143;3585.1933315004176;3585.94621080684;3592.1378869071496;3677.3564626190578;3225.4194245035883;3238.9676103238903;3258.902232933016;3264.2981758921946;3267.1015470745497;4622.884427889296;4669.1128685549975;4672.462666793328;4677;4706.74112923789;3992.281389349916;4193.853215137456;4195.265828480004;4217.472815898012;4221.957780422218;4967.3542439483;4981.427135879348;4984.87537811554;4998.6750861193905;5005.47442518534;3472.49648800925;3477.9130521736906;3499.002784206514;3515.3320869035056;3524.753267271292;5128.692278463267;5226.817061402832;5239.921401178985;5250.894982100336;5307.6019298552765;3514.7012503937453;3539.911502212465;3540;3544.131687736521;3567.340042092221;3602.747807653439;3608.566971963381;3619.2761447710564;3627.474016267626;3628.602987849697;4140.523839758406;4176.164767046603;4182.163567286555;4182.351735481006;4186.016286172747;4891.828785992473;4952.727599981963;5030.773615187325;5048.192289233705;5057.696538207646;1223.1315765806378;1226.337777600104;1226.8282440458343;1242.186367929008;1257.3838818978818;759.9285008138498;771.9578568931897;783.310686595792;793.9682412703543;802.3340627279345;4387.122575484916;4533.320001999727;4534.77326133692;4536.729715679615;4590.678652494294;5131.794728210904;5181.222816577543;5207.2141404348495;5223.738813059408;5247.081760691864;4405;4482.27432438507;4517.525659805673;4534.727916325031;4546.363509108727;2676.90630827924;2747.4230411613385;2757.2555410039176;2773.4453109378205;2781.1239459570575;4919.729414882216;4920.917398172396;4938.209886418228;4953.950460495421;4961.950380496221;5210.426853046162;5322.2548843161985;5352.795620985247;5379.569634429236;5395.271638328853;4860.9513904861205;4863.076015557032;4924.482929292444;4965.230389289666;4965.510346895989;5154.587632989277;5170.71561064145;5182.948170518246;5186.351706036746;5195.7142357170715;4806.7836947338155;5026.371703537058;5055.6713813602;5057.620678449058;5065.974670126626;4924.63065270099;4930.334404855299;4940.604751619933;4971.154903666457;4979.800807967641;3567.911786904915;3576.284743051348;3594.353016457063;3596.262766132989;3596.777095787445;5141.974290128525;5206.401263854706;5253.317068781187;5258.6581872178185;5296;5013.646315494869;5025.246213068069;5055.646104772631;5061.670991385548;5069.847904562869;5029.170186919264;5036.798528058836;5045.344105266292;5054.2923990642075;5067.873303167303;4782.856514304576;4929.285253638131;4959.13215187348;4972.5027497249985;4997.800087996585;4814.301926220748;4919.729414882073;5041.621878359065;5096.949030509648;5122.743862806919;4947.752612369295;4970.080535101018;5012.3233363495465;5014.34813474246;5016.974915125401 08:06:21 INFO - PROCESS | 4905 | |5;yui.html;547.4744245524297;560.0535095688286;570.7374607680467;574.5604612471458;600.5435868739756;9837.803243935117;10237.744056398593;10624.946875265632;10632.3620582765;10646.095081918036;11719;11764;11767.941160294207;11773;11791.882081179207;618.628822706377;745.4334705623738;747.2452822649136;759.2786852490129;762.3101093510354;767.3745897093878;774.9806254843646;775.7517594369804;777.5567926282022;777.6150805351359;814.5682788122305;815.1318845429598;816.5549775372407;816.8121332093622;817.0685418622745;629.7543957856417;774.9961250193769;798.022422532399;802.257911431926;805.0098378993841;588.4527389527738;588.5556404914305;588.7056471764118;592.4490224091593;597.1073245497965;10497.055265026183;10498.422586757726;10512.894871051345;10520.421376824272;10522.473876306154;11630.127740419417;11916.880831191664;12068.939655301667;12281.201721888048;12468.625941221779;10279.845802312972;10490.318129321646;10496.895031049668;10631.149508039338;10638.946805266001;4061.1065565575527;4111.732737372061;4118.320477121271;4134.524529679095;4154.086101057763;55298.9999999996;55832.720836395965;56143.71928140374;56375.15437268444;56564.71717641427;9396.765080873032;9498.95250523743;9619.230461563058;9649.807003859883;9987.30088893785;16864.325426982785;16867.240974155946;16877.40929067477;16884.155792210342;16897.15514224284;6587.374199451045;6623.4701223901975;6675.966620166868;6734.831629209211;6852.725890964405;3388.8644454221553;3409.897703068912;3452.2750222453064;3466.0814884055744;3561.8397172127316;2456.2508434927518;2551.8468891866546;2553.1191738850066;2606.9869650651626;2699.0958029060093;450.0459026863071;456.1037561192273;457.77568991194073;465.4159030416805;467.0402323225804;413.5616246778425;427.8930267433142;484.66800241834454;515.3969855269344;531.7181893596401;6629.701663425158;6731.515960094851;6761.053452516651;6819.795406137824;6878.105846239957;494.77240469383764;498.8478514053176;499.6976829018464;534.74599565207;541.2963147907705;3153.6530981592005;3167.984160079231;3285.3593549258144;3298.950515742266;3372.0558243691808;79679.20320796718;87408.56295718481;87794.12205877987;92739.53630231941;92981;51546.22680659793;56239.43760562424;79861.60069199733;80287;82141;55478.72260638671;71332;71822;71901.64049179721;72555.63722181355;6413.973764197706;6475.384838440341;6488.513361498001;6565.835854103686;6685.364890335411;44400.555994439645;44692.77653611711;45051.774741126086;45799;46419;61256;62054;62540;64260;64372.678136609014;8633.43882647651;8741.956290218508;8939.106089391009;9000.819983600422;9085.046070162802;9585.856212156683;9744.17174540172;9748.073932976356;9762.17021553176;9847.950760246153;8647.092055334351;9047.411918225294;9142.771430714285;9341.57962891658;9370.67202647904;8764.737057888273;8845.955770221108;8863.64545418176;9230.35387522867;9306.395084319498;8427.705030323908;8804.427712198687;8969.730908072768;8981.461112333282;9048.366614337196;7073.575585464889;7229.457790665616;7329.157146928172;7482.588457634883;7604.353629941517;7667.846643067219;7941.523508589503;7961.8407631848195;8083.151269116894;8206.917930820615 08:06:21 INFO - PROCESS | 4905 | __end_tp_report 08:06:21 INFO - PROCESS | 4905 | __start_cc_report 08:06:21 INFO - PROCESS | 4905 | _x_x_mozilla_cycle_collect,1200 08:06:21 INFO - PROCESS | 4905 | __end_cc_report 08:06:21 INFO - PROCESS | 4905 | __startTimestamp1465484781112__endTimestamp 08:06:21 INFO - PROCESS | 4905 | 08:06:21 INFO - PROCESS | 4905 | ------- Summary: start ------- 08:06:21 INFO - PROCESS | 4905 | Number of tests: 6 08:06:21 INFO - PROCESS | 4905 | 08:06:21 INFO - PROCESS | 4905 | [#0] dojo.html Cycles:165 Average:4602.19 Median:4728.93 stddev:496.46 (10.5%) stddev-sans-first:471.56 08:06:21 INFO - PROCESS | 4905 | Values: 2565.1 2606.3 2640.9 2642.2 2648.6 4477.9 4556.9 4602.1 4612.8 4759.1 4630.0 4646.2 4727.1 4729.2 4763.4 4224.6 4265.5 4391.2 4423.7 4424.3 4347.9 4365.1 4409.6 4420.0 4449.6 4124.8 4157.8 4161.8 4222.2 4323.3 4267.6 4278.0 4287.5 4321.2 4328.7 4299.7 4309.9 4325.7 4343.7 4353.6 4532.9 4641.0 4693.2 4715.4 4753.9 5061.7 5067.2 5076.1 5079.6 5082.0 5083.3 5088.0 5099.9 5115.3 5117.7 4358.5 4644.4 4700.8 4703.0 4715.3 5149.2 5155.8 5197.5 5205.3 5209.7 4664.9 4946.9 4991.6 4996.4 5002.1 4867.6 4892.0 4893.4 4944.1 4979.3 4850.6 4867.7 4869.5 4877.2 4920.6 4835.8 4843.0 4845.5 4845.7 4892.8 3954.6 3987.0 3991.8 4018.5 4021.8 3573.2 3590.4 3600.9 3609.9 3612.3 4204.6 4228.4 4253.3 4370.1 4425.8 5075.8 5096.6 5099.2 5103.8 5143.9 4394.0 4424.3 4427.5 4462.2 4470.8 4277.1 4415.4 4483.7 4484.2 4511.3 4738.8 4751.4 4764.9 4791.1 4799.4 4987.6 4993.2 5040.1 5042.6 5088.2 4550.5 4700.1 4732.8 4745.0 4749.9 4893.9 4903.4 4917.7 4924.3 4968.6 4734.1 4982.4 4993.4 4999.0 5055.9 4784.8 4860.8 4874.3 4903.5 4941.6 4845.7 4875.3 4886.8 4888.0 4928.1 4531.9 4579.3 4820.1 4833.9 4869.1 4696.0 4698.0 4704.9 4728.9 4739.2 4710.3 4721.2 4728.2 4768.8 4773.2 08:06:21 INFO - PROCESS | 4905 | 08:06:21 INFO - PROCESS | 4905 | [#1] ext.html Cycles:180 Average:47804.83 Median:19285.33 stddev:85780.85 (444.8%) stddev-sans-first:85948.17 08:06:21 INFO - PROCESS | 4905 | Values: 568.6 580.1 582.0 584.9 589.2 27818.0 39108.6 40471.8 40571.2 44298.6 42054.8 42509.6 42515.0 42557.4 42628.8 7452.2 7604.7 7752.0 7756.5 7758.1 7418.6 7712.7 7712.9 9988.5 10244.7 10340.8 10389.2 10402.1 10404.7 10404.9 10236.5 10293.2 10314.3 10318.2 10322.8 7429.3 9825.8 10175.7 10183.7 10543.6 38152.6 38612.6 38646.6 38729.0 38754.8 2684.5 2748.9 2787.3 2791.6 2847.6 29011.9 29508.4 29627.9 29723.7 30100.4 3494.9 3500.5 3563.6 3579.0 3629.5 242759.0 244471.0 244501.0 245524.0 246420.0 52270.5 52817.7 52842.2 52886.0 52900.6 32901.3 33224.3 33265.7 35470.1 54722.0 14939.5 15043.9 15052.3 15071.5 15073.7 10303.4 11622.2 11700.9 11709.8 11715.6 17986.2 18354.5 18493.4 18931.6 19013.7 6710.9 6816.6 6823.0 7013.9 7038.6 781.9 854.2 862.4 891.1 952.4 27287.7 27919.3 28561.0 28630.6 28674.7 948.6 1005.0 1021.5 1054.4 1070.5 14355.4 14806.3 14853.0 15081.8 15140.2 365159.0 372257.0 372288.0 373115.0 373482.0 48573.0 49281.5 49284.8 49295.8 49317.5 1061.7 1161.4 1168.9 1179.8 1194.8 27825.3 28931.9 28962.9 29047.6 29383.6 40960.4 47173.5 48205.0 48285.3 52592.5 341018.0 345765.0 351945.0 352962.0 354058.0 33971.8 34415.3 35286.1 35351.6 35361.3 31897.0 40724.6 40995.8 42212.2 42639.1 34649.8 36126.5 36529.5 36765.6 36839.3 35746.6 35831.6 35992.3 36063.6 36134.5 34694.8 35070.1 35303.3 35689.6 35851.1 31615.9 32165.8 32273.9 32324.2 32692.2 24437.3 24704.4 24932.4 25261.9 25320.9 08:06:21 INFO - PROCESS | 4905 | 08:06:21 INFO - PROCESS | 4905 | [#2] jquery.html Cycles:180 Average:26613.24 Median:5007.54 stddev:69452.19 (1387.0%) stddev-sans-first:69619.03 08:06:21 INFO - PROCESS | 4905 | Values: 352.3 353.0 353.3 363.3 364.5 16446.6 16484.4 17180.0 17402.5 17402.9 16304.2 16611.9 16841.3 16947.9 16958.0 4781.4 4958.5 5005.2 5009.8 5017.7 3032.7 3177.3 4926.7 5615.4 5909.7 5883.0 5898.4 5929.6 5959.7 5968.7 5642.7 5796.6 5844.8 5909.8 5921.9 2745.3 4733.6 5064.3 5066.3 5091.0 20333.3 20500.3 20558.7 20654.6 20814.2 1866.3 1897.7 1947.0 1950.5 1964.5 12839.6 12869.5 12906.1 13029.7 13354.6 1572.1 1915.6 1953.4 1987.0 2048.1 78611.6 79835.6 80814.0 83093.6 84216.5 15974.2 16114.8 16166.5 16191.8 16659.8 28930.3 29410.6 29515.4 29653.1 29725.6 8576.8 9281.2 9311.0 9364.3 9455.8 7664.1 7704.4 7708.1 7770.1 7879.2 8125.9 8251.0 8400.8 8449.9 8541.7 2482.6 3216.5 3322.7 3342.1 3490.2 748.8 813.5 813.6 852.8 937.4 15195.8 15687.5 16254.3 16303.6 16663.4 847.0 856.2 864.7 869.4 922.9 9026.3 9122.5 9355.4 9590.6 9658.9 398504.0 400643.0 427064.0 432628.0 436840.3 80751.0 86367.0 87091.6 88067.0 88227.0 947.5 947.9 958.0 982.3 992.8 15537.0 15705.5 15806.7 15980.3 16162.6 37175.3 37853.6 37968.0 38662.6 38825.8 51944.0 53185.7 53979.5 54521.0 55021.7 7140.8 7456.9 7477.5 7486.0 7625.9 7180.0 7862.5 10362.9 11638.9 11646.2 9297.6 9858.1 10034.9 10128.9 10160.7 9735.7 10137.7 10161.7 10397.4 10404.9 9833.6 9949.3 10330.2 10505.7 10801.9 6972.3 7230.9 7241.8 7322.1 7369.7 9157.1 9740.2 9744.1 9892.2 9901.1 08:06:21 INFO - PROCESS | 4905 | 08:06:21 INFO - PROCESS | 4905 | [#3] mootools.html Cycles:180 Average:4932.57 Median:4865.89 stddev:2872.41 (59.0%) stddev-sans-first:2866.91 08:06:21 INFO - PROCESS | 4905 | Values: 1218.3 1343.3 1414.8 1423.8 1651.0 6598.0 7521.4 7787.5 7819.3 7965.7 7704.7 7840.9 7851.3 7869.6 7885.1 2156.2 2179.6 2179.7 2184.5 2186.0 2135.6 2168.7 2175.3 2175.7 2188.5 2090.4 2095.5 2099.4 2102.9 2161.0 2070.5 2077.1 2079.1 2081.7 2085.5 2019.9 2088.6 2088.8 2089.5 2095.5 7723.1 7745.2 7796.4 7819.5 7984.8 4467.4 4557.2 4578.9 4586.2 4586.9 2698.2 2801.4 2846.1 2849.7 2873.6 873.8 888.7 898.1 899.3 903.6 10583.6 10682.3 10728.3 10740.1 10742.5 3907.5 4020.2 4087.3 4087.6 4099.8 8305.0 8333.2 8380.3 8395.1 8404.9 4426.0 4441.7 4458.0 4463.1 4466.9 3444.9 3881.7 4085.7 4218.0 4246.3 3299.6 3336.5 3397.8 3467.0 3507.6 949.6 994.0 1000.9 1004.1 1016.6 616.0 641.3 691.2 746.9 753.8 4889.5 5029.5 5052.7 5276.3 5276.6 401.1 405.1 408.2 410.8 415.2 3377.6 3393.1 3418.6 3445.0 3486.7 9273.9 9369.5 9575.7 9665.5 9671.8 9484.9 9525.8 9582.9 9665.8 9673.7 7049.3 7255.7 7375.0 7448.7 7456.1 4741.7 4794.6 4842.2 4914.9 4943.0 8850.2 8871.2 8902.5 8904.2 8922.2 8850.7 8951.0 9095.6 9120.1 9124.5 5145.5 5767.8 6225.9 6264.6 6270.2 7071.8 7295.4 7339.3 7346.2 7352.0 6377.7 6497.8 6517.1 6590.1 6661.1 5891.7 5908.6 5997.2 6053.2 6157.1 5386.6 5479.7 5499.8 5523.8 5528.0 3940.3 3985.0 4007.9 4087.8 4115.4 4044.8 4091.3 4136.8 4148.4 4187.4 08:06:21 INFO - PROCESS | 4905 | 08:06:21 INFO - PROCESS | 4905 | [#4] prototype.html Cycles:180 Average:4159.90 Median:4792.50 stddev:1237.50 (25.8%) stddev-sans-first:1206.42 08:06:21 INFO - PROCESS | 4905 | Values: 290.6 291.6 297.2 298.4 300.4 4802.1 4817.3 4821.3 4836.3 4837.1 4749.5 4754.0 4769.1 4774.9 4776.0 3524.0 3582.6 3614.7 3720.3 3748.9 3707.6 3719.7 3741.8 3745.9 3746.7 3470.9 3705.2 3710.3 3727.1 3730.0 3471.3 3585.2 3585.9 3592.1 3677.4 3225.4 3239.0 3258.9 3264.3 3267.1 4622.9 4669.1 4672.5 4677.0 4706.7 3992.3 4193.9 4195.3 4217.5 4222.0 4967.4 4981.4 4984.9 4998.7 5005.5 3472.5 3477.9 3499.0 3515.3 3524.8 5128.7 5226.8 5239.9 5250.9 5307.6 3514.7 3539.9 3540.0 3544.1 3567.3 3602.7 3608.6 3619.3 3627.5 3628.6 4140.5 4176.2 4182.2 4182.4 4186.0 4891.8 4952.7 5030.8 5048.2 5057.7 1223.1 1226.3 1226.8 1242.2 1257.4 759.9 772.0 783.3 794.0 802.3 4387.1 4533.3 4534.8 4536.7 4590.7 5131.8 5181.2 5207.2 5223.7 5247.1 4405.0 4482.3 4517.5 4534.7 4546.4 2676.9 2747.4 2757.3 2773.4 2781.1 4919.7 4920.9 4938.2 4954.0 4962.0 5210.4 5322.3 5352.8 5379.6 5395.3 4861.0 4863.1 4924.5 4965.2 4965.5 5154.6 5170.7 5182.9 5186.4 5195.7 4806.8 5026.4 5055.7 5057.6 5066.0 4924.6 4930.3 4940.6 4971.2 4979.8 3567.9 3576.3 3594.4 3596.3 3596.8 5142.0 5206.4 5253.3 5258.7 5296.0 5013.6 5025.2 5055.6 5061.7 5069.8 5029.2 5036.8 5045.3 5054.3 5067.9 4782.9 4929.3 4959.1 4972.5 4997.8 4814.3 4919.7 5041.6 5096.9 5122.7 4947.8 4970.1 5012.3 5014.3 5017.0 08:06:21 INFO - PROCESS | 4905 | 08:06:21 INFO - PROCESS | 4905 | [#5] yui.html Cycles:180 Average:15908.07 Median:31584.88 stddev:23257.42 (73.6%) stddev-sans-first:23294.07 08:06:21 INFO - PROCESS | 4905 | Values: 547.5 560.1 570.7 574.6 600.5 9837.8 10237.7 10624.9 10632.4 10646.1 11719.0 11764.0 11767.9 11773.0 11791.9 618.6 745.4 747.2 759.3 762.3 767.4 775.0 775.8 777.6 777.6 814.6 815.1 816.6 816.8 817.1 629.8 775.0 798.0 802.3 805.0 588.5 588.6 588.7 592.4 597.1 10497.1 10498.4 10512.9 10520.4 10522.5 11630.1 11916.9 12068.9 12281.2 12468.6 10279.8 10490.3 10496.9 10631.1 10638.9 4061.1 4111.7 4118.3 4134.5 4154.1 55299.0 55832.7 56143.7 56375.2 56564.7 9396.8 9499.0 9619.2 9649.8 9987.3 16864.3 16867.2 16877.4 16884.2 16897.2 6587.4 6623.5 6676.0 6734.8 6852.7 3388.9 3409.9 3452.3 3466.1 3561.8 2456.3 2551.8 2553.1 2607.0 2699.1 450.0 456.1 457.8 465.4 467.0 413.6 427.9 484.7 515.4 531.7 6629.7 6731.5 6761.1 6819.8 6878.1 494.8 498.8 499.7 534.7 541.3 3153.7 3168.0 3285.4 3299.0 3372.1 79679.2 87408.6 87794.1 92739.5 92981.0 51546.2 56239.4 79861.6 80287.0 82141.0 55478.7 71332.0 71822.0 71901.6 72555.6 6414.0 6475.4 6488.5 6565.8 6685.4 44400.6 44692.8 45051.8 45799.0 46419.0 61256.0 62054.0 62540.0 64260.0 64372.7 8633.4 8742.0 8939.1 9000.8 9085.0 9585.9 9744.2 9748.1 9762.2 9848.0 8647.1 9047.4 9142.8 9341.6 9370.7 8764.7 8846.0 8863.6 9230.4 9306.4 8427.7 8804.4 8969.7 8981.5 9048.4 7073.6 7229.5 7329.2 7482.6 7604.4 7667.8 7941.5 7961.8 8083.2 8206.9 08:06:21 INFO - PROCESS | 4905 | -------- Summary: end -------- 08:06:21 INFO - PROCESS | 4905 | 08:06:22 INFO - TEST-INFO | 4905: exit 0 08:06:22 INFO - TEST-OK | dromaeo_css | took 1125630ms 08:06:22 INFO - TEST-START | kraken 08:06:22 INFO - operating with platform_type : linux_ 08:06:22 INFO - Initialising browser for kraken test... 08:06:22 INFO - TEST-INFO | started process 5084 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0oqak7/profile http://localhost:33942/getInfo.html) 08:06:28 INFO - PROCESS | 5084 | __metrics Screen width/height:1600/1200 08:06:28 INFO - PROCESS | 5084 | colorDepth:24 08:06:28 INFO - PROCESS | 5084 | Browser inner width/height: 1024/697 08:06:28 INFO - PROCESS | 5084 | __metrics 08:06:30 ERROR - PROCESS | 5084 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:06:30 INFO - PROCESS | 5084 | console.error: PushService: 08:06:30 INFO - PROCESS | 5084 | stateChangeProcessEnqueue: Error transitioning state 08:06:30 INFO - PROCESS | 5084 | UnknownError 08:06:31 INFO - TEST-INFO | 5084: exit 0 08:06:31 INFO - Browser initialized. 08:06:31 INFO - Running cycle 1/1 for kraken test... 08:06:31 INFO - TEST-INFO | started process 5164 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0oqak7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:06:43 INFO - PROCESS | 5164 | RSS: Main: 179159040 08:06:43 INFO - PROCESS | 5164 | 08:06:46 INFO - PROCESS | 5164 | Cycle 1(1): loaded http://localhost:33942/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33942/tests/kraken/driver.html?testName=audio-beat-detection) 08:06:47 INFO - PROCESS | 5164 | RSS: Main: 236326912 08:06:47 INFO - PROCESS | 5164 | 08:06:50 INFO - PROCESS | 5164 | Cycle 1(1): loaded http://localhost:33942/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33942/tests/kraken/driver.html?testName=audio-dft) 08:06:51 INFO - PROCESS | 5164 | RSS: Main: 223051776 08:06:51 INFO - PROCESS | 5164 | 08:06:54 INFO - PROCESS | 5164 | Cycle 1(1): loaded http://localhost:33942/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33942/tests/kraken/driver.html?testName=audio-fft) 08:06:54 INFO - PROCESS | 5164 | RSS: Main: 292020224 08:06:54 INFO - PROCESS | 5164 | 08:06:57 INFO - PROCESS | 5164 | Cycle 1(1): loaded http://localhost:33942/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33942/tests/kraken/driver.html?testName=audio-oscillator) 08:06:57 INFO - PROCESS | 5164 | RSS: Main: 201494528 08:06:57 INFO - PROCESS | 5164 | 08:06:59 INFO - PROCESS | 5164 | Cycle 1(1): loaded http://localhost:33942/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33942/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:07:00 INFO - PROCESS | 5164 | RSS: Main: 205746176 08:07:00 INFO - PROCESS | 5164 | 08:07:03 INFO - PROCESS | 5164 | Cycle 1(1): loaded http://localhost:33942/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33942/tests/kraken/driver.html?testName=imaging-darkroom) 08:07:04 INFO - PROCESS | 5164 | RSS: Main: 241815552 08:07:04 INFO - PROCESS | 5164 | 08:07:07 INFO - PROCESS | 5164 | Cycle 1(1): loaded http://localhost:33942/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33942/tests/kraken/driver.html?testName=imaging-desaturate) 08:07:08 INFO - PROCESS | 5164 | RSS: Main: 237035520 08:07:08 INFO - PROCESS | 5164 | 08:07:11 INFO - PROCESS | 5164 | Cycle 1(1): loaded http://localhost:33942/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33942/tests/kraken/driver.html?testName=json-parse-financial) 08:07:12 INFO - PROCESS | 5164 | RSS: Main: 239398912 08:07:12 INFO - PROCESS | 5164 | 08:07:13 INFO - PROCESS | 5164 | Cycle 1(1): loaded http://localhost:33942/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33942/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:07:14 INFO - PROCESS | 5164 | RSS: Main: 225660928 08:07:14 INFO - PROCESS | 5164 | 08:07:16 INFO - PROCESS | 5164 | Cycle 1(1): loaded http://localhost:33942/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33942/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:07:16 INFO - PROCESS | 5164 | RSS: Main: 224714752 08:07:16 INFO - PROCESS | 5164 | 08:07:19 INFO - PROCESS | 5164 | Cycle 1(1): loaded http://localhost:33942/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33942/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:07:19 INFO - PROCESS | 5164 | RSS: Main: 236089344 08:07:19 INFO - PROCESS | 5164 | 08:07:22 INFO - PROCESS | 5164 | Cycle 1(1): loaded http://localhost:33942/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33942/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:07:23 INFO - PROCESS | 5164 | RSS: Main: 241082368 08:07:23 INFO - PROCESS | 5164 | 08:07:26 INFO - PROCESS | 5164 | Cycle 1(1): loaded http://localhost:33942/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33942/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:07:26 INFO - PROCESS | 5164 | RSS: Main: 241369088 08:07:26 INFO - PROCESS | 5164 | 08:07:28 INFO - PROCESS | 5164 | Cycle 1(1): loaded http://localhost:33942/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33942/tests/kraken/driver.html?testName=ai-astar) 08:07:28 INFO - PROCESS | 5164 | RSS: Main: 283660288 08:07:28 INFO - PROCESS | 5164 | 08:07:28 INFO - PROCESS | 5164 | __start_tp_report 08:07:28 INFO - PROCESS | 5164 | _x_x_mozilla_page_load 08:07:28 INFO - PROCESS | 5164 | _x_x_mozilla_page_load_details 08:07:28 INFO - PROCESS | 5164 | |i|pagename|runs| 08:07:28 INFO - PROCESS | 5164 | |0;ai-astar;116;107;113;116;113;114;114;113;114;113 08:07:28 INFO - PROCESS | 5164 | |1;audio-beat-detection;156;130;136;194;130;131;157;130;189;130 08:07:28 INFO - PROCESS | 5164 | |2;audio-dft;163;162;161;163;164;164;164;164;162;163 08:07:28 INFO - PROCESS | 5164 | |3;audio-fft;75;77;77;122;77;78;76;76;104;77 08:07:28 INFO - PROCESS | 5164 | |4;audio-oscillator;87;88;125;87;88;87;118;86;87;126 08:07:28 INFO - PROCESS | 5164 | |5;imaging-gaussian-blur;116;117;117;117;118;117;117;117;117;117 08:07:28 INFO - PROCESS | 5164 | |6;imaging-darkroom;146;147;147;146;146;147;146;146;147;146 08:07:28 INFO - PROCESS | 5164 | |7;imaging-desaturate;94;96;95;96;95;96;95;95;95;95 08:07:28 INFO - PROCESS | 5164 | |8;json-parse-financial;64;66;63;65;64;63;64;64;64;64 08:07:28 INFO - PROCESS | 5164 | |9;json-stringify-tinderbox;65;65;64;66;64;65;65;64;65;64 08:07:28 INFO - PROCESS | 5164 | |10;stanford-crypto-aes;83;90;84;83;86;85;85;86;121;85 08:07:28 INFO - PROCESS | 5164 | |11;stanford-crypto-ccm;134;133;139;147;130;139;141;129;157;136 08:07:28 INFO - PROCESS | 5164 | |12;stanford-crypto-pbkdf2;167;167;168;171;171;171;169;171;169;166 08:07:28 INFO - PROCESS | 5164 | |13;stanford-crypto-sha256-iterative;68;67;67;69;69;67;69;78;69;65 08:07:28 INFO - PROCESS | 5164 | __end_tp_report 08:07:28 INFO - PROCESS | 5164 | __start_cc_report 08:07:28 INFO - PROCESS | 5164 | _x_x_mozilla_cycle_collect,1894 08:07:28 INFO - PROCESS | 5164 | __end_cc_report 08:07:28 INFO - PROCESS | 5164 | __startTimestamp1465484848840__endTimestamp 08:07:28 INFO - PROCESS | 5164 | 08:07:28 INFO - PROCESS | 5164 | ------- Summary: start ------- 08:07:28 INFO - PROCESS | 5164 | Number of tests: 14 08:07:28 INFO - PROCESS | 5164 | 08:07:28 INFO - PROCESS | 5164 | [#0] ai-astar Cycles:10 Average:113.30 Median:114.00 stddev:2.50 (2.2%) stddev-sans-first:2.45 08:07:28 INFO - PROCESS | 5164 | Values: 116.0 107.0 113.0 116.0 113.0 114.0 114.0 113.0 114.0 113.0 08:07:28 INFO - PROCESS | 5164 | 08:07:28 INFO - PROCESS | 5164 | [#1] audio-beat-detection Cycles:10 Average:148.30 Median:146.00 stddev:25.10 (17.2%) stddev-sans-first:26.47 08:07:28 INFO - PROCESS | 5164 | Values: 156.0 130.0 136.0 194.0 130.0 131.0 157.0 130.0 189.0 130.0 08:07:28 INFO - PROCESS | 5164 | 08:07:28 INFO - PROCESS | 5164 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.50 stddev:1.05 (0.6%) stddev-sans-first:1.12 08:07:28 INFO - PROCESS | 5164 | Values: 163.0 162.0 161.0 163.0 164.0 164.0 164.0 164.0 162.0 163.0 08:07:28 INFO - PROCESS | 5164 | 08:07:28 INFO - PROCESS | 5164 | [#3] audio-fft Cycles:10 Average:83.90 Median:77.00 stddev:15.93 (20.7%) stddev-sans-first:16.57 08:07:28 INFO - PROCESS | 5164 | Values: 75.0 77.0 77.0 122.0 77.0 78.0 76.0 76.0 104.0 77.0 08:07:28 INFO - PROCESS | 5164 | 08:07:28 INFO - PROCESS | 5164 | [#4] audio-oscillator Cycles:10 Average:97.90 Median:87.00 stddev:17.45 (20.1%) stddev-sans-first:18.06 08:07:28 INFO - PROCESS | 5164 | Values: 87.0 88.0 125.0 87.0 88.0 87.0 118.0 86.0 87.0 126.0 08:07:28 INFO - PROCESS | 5164 | 08:07:28 INFO - PROCESS | 5164 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 08:07:28 INFO - PROCESS | 5164 | Values: 116.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 08:07:28 INFO - PROCESS | 5164 | 08:07:28 INFO - PROCESS | 5164 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 08:07:28 INFO - PROCESS | 5164 | Values: 146.0 147.0 147.0 146.0 146.0 147.0 146.0 146.0 147.0 146.0 08:07:28 INFO - PROCESS | 5164 | 08:07:28 INFO - PROCESS | 5164 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 08:07:28 INFO - PROCESS | 5164 | Values: 94.0 96.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 08:07:28 INFO - PROCESS | 5164 | 08:07:28 INFO - PROCESS | 5164 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:64.00 stddev:0.88 (1.4%) stddev-sans-first:0.93 08:07:28 INFO - PROCESS | 5164 | Values: 64.0 66.0 63.0 65.0 64.0 63.0 64.0 64.0 64.0 64.0 08:07:28 INFO - PROCESS | 5164 | 08:07:28 INFO - PROCESS | 5164 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 08:07:28 INFO - PROCESS | 5164 | Values: 65.0 65.0 64.0 66.0 64.0 65.0 65.0 64.0 65.0 64.0 08:07:28 INFO - PROCESS | 5164 | 08:07:28 INFO - PROCESS | 5164 | [#10] stanford-crypto-aes Cycles:10 Average:88.80 Median:85.00 stddev:11.49 (13.5%) stddev-sans-first:11.99 08:07:28 INFO - PROCESS | 5164 | Values: 83.0 90.0 84.0 83.0 86.0 85.0 85.0 86.0 121.0 85.0 08:07:28 INFO - PROCESS | 5164 | 08:07:28 INFO - PROCESS | 5164 | [#11] stanford-crypto-ccm Cycles:10 Average:138.50 Median:139.00 stddev:8.44 (6.1%) stddev-sans-first:8.79 08:07:28 INFO - PROCESS | 5164 | Values: 134.0 133.0 139.0 147.0 130.0 139.0 141.0 129.0 157.0 136.0 08:07:28 INFO - PROCESS | 5164 | 08:07:28 INFO - PROCESS | 5164 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.00 Median:170.00 stddev:1.94 (1.1%) stddev-sans-first:1.92 08:07:28 INFO - PROCESS | 5164 | Values: 167.0 167.0 168.0 171.0 171.0 171.0 169.0 171.0 169.0 166.0 08:07:28 INFO - PROCESS | 5164 | 08:07:28 INFO - PROCESS | 5164 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:3.49 (5.1%) stddev-sans-first:3.69 08:07:28 INFO - PROCESS | 5164 | Values: 68.0 67.0 67.0 69.0 69.0 67.0 69.0 78.0 69.0 65.0 08:07:28 INFO - PROCESS | 5164 | -------- Summary: end -------- 08:07:28 INFO - PROCESS | 5164 | 08:07:29 INFO - TEST-INFO | 5164: exit 0 08:07:30 INFO - TEST-OK | kraken | took 68012ms 08:07:30 INFO - SUITE-END | took 1193s 08:07:30 INFO - Completed test suite (00:19:54) 08:07:30 INFO - javascript benchmark 08:07:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2565.140677872912, 2606.2832721001732, 2640.907568235112, 2642.1677171690917, 2648.642433271509, 4477.865664030076, 4556.8860778480475, 4602.148602508539, 4612.792424340904, 4759.09577180336, 4629.953700462995, 4646.186917289469, 4727.149113159629, 4729.172394830899, 4763.428388593374, 4224.598663126998, 4265.488141423018, 4391.165678521071, 4423.712458690175, 4424.336349547578, 4347.869563913087, 4365.105153443536, 4409.559044095581, 4419.977900110511, 4449.621782148522, 4124.835006599732, 4157.833686652531, 4161.771102589357, 4222.239996800575, 4323.265044942367, 4267.573242675739, 4278.016056307036, 4287.528371879091, 4321.178975994582, 4328.653707703407, 4299.720518166309, 4309.892252693677, 4325.675574331937, 4343.739375637472, 4353.608175264241, 4532.86401407955, 4641.0, 4693.155232058228, 4715.386999690053, 4753.928691069636, 5061.746912654353, 5067.2145817397995, 5076.086304465195, 5079.644424890259, 5081.974590127063, 5083.288339632454, 5087.9745601272125, 5099.923501147486, 5115.335006449175, 5117.7185254810975, 4358.5205627380965, 4644.396228490275, 4700.835470758507, 4703.012367402884, 4715.316279139505, 5149.150390185652, 5155.793768249228, 5197.454267301954, 5205.323307969939, 5209.739513024334, 4664.930026049612, 4946.901061978812, 4991.575716064102, 4996.375453068366, 5002.09962206799, 4867.58625516835, 4891.975540122347, 4893.412790465167, 4944.134776414113, 4979.278004689299, 4850.6362022847725, 4867.659263851568, 4869.464358920516, 4877.244027175793, 4920.606351491943, 4835.8065677373215, 4842.951570484321, 4845.53967373099, 4845.6608037437745, 4892.804287828447, 3954.62431069048, 3987.043109653662, 3991.820368083443, 4018.4976877890263, 4021.7989100544855, 3573.19603089308, 3590.3537363274863, 3600.945985810215, 3609.9278014439565, 3612.313660404567, 4204.558521355275, 4228.386883901879, 4253.3194688849635, 4370.060437006059, 4425.75658338788, 5075.771590278372, 5096.61775366849, 5099.184130539096, 5103.846884593394, 5143.948560514347, 4394.0, 4424.33634954753, 4427.468703755506, 4462.196804575143, 4470.754108524063, 4277.144571085795, 4415.40392047076, 4483.730976141442, 4484.170428470743, 4511.345854851028, 4738.786754596052, 4751.429828420542, 4764.9047019058735, 4791.065742180242, 4799.3760811094335, 4987.576056035277, 4993.201087825931, 5040.067587496325, 5042.596592272683, 5088.236764485357, 4550.522195169459, 4700.059988002345, 4732.787024583971, 4744.976275118603, 4749.928751068667, 4893.877653058702, 4903.387076615423, 4917.729524876023, 4924.310596516562, 4968.552830245295, 4734.100520901018, 4982.352294201731, 4993.350864387607, 4998.950010499849, 5055.898882022412, 4784.832530861403, 4860.78126484302, 4874.268859671078, 4903.4606193317995, 4941.555260026615, 4845.685030473008, 4875.293082502946, 4886.804527818989, 4887.951120488749, 4928.088303663833, 4531.909361812811, 4579.313103034438, 4820.108279968217, 4833.854984350475, 4869.147899117711, 4695.9530404695515, 4697.953020469751, 4704.882377940579, 4728.929066063943, 4739.241721324572, 4710.26990816424, 4721.173794586002, 4728.243481043017, 4768.833090841804, 4773.236282194971], "value": 4570.162471167906, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.573569822633, 580.1182203051364, 581.953443724502, 584.8771757930832, 589.1722130406778, 27818.0, 39108.60891391085, 40471.797641011755, 40571.18857622853, 44298.55701442993, 42054.78972605133, 42509.57490425095, 42515.0, 42557.36163957543, 42628.78685606575, 7452.180260171377, 7604.657790399446, 7752.030996125484, 7756.457048006613, 7758.069031716173, 7418.591977441239, 7712.6914923403, 7712.922870771305, 9988.500574971258, 10244.74388140295, 10340.793184136313, 10389.220808439359, 10402.115820155295, 10404.68785936423, 10404.947975260113, 10236.488175591228, 10293.228007899437, 10314.278000539965, 10318.1745460363, 10322.79354412915, 7429.257074292582, 9825.803483930353, 10175.694729158136, 10183.745406364826, 10543.578256869792, 38152.618473815186, 38612.61387386146, 38646.61353386487, 38729.0, 38754.80622596869, 2684.5436275833154, 2748.931276718078, 2787.2613757354316, 2791.595218693278, 2847.5870998705072, 29011.854940725163, 29508.40983180346, 29627.851860740775, 29723.702762972527, 30100.397992040038, 3494.860205591773, 3500.527428797105, 3563.625819288989, 3579.0, 3629.4737263096968, 242759.0, 244471.0, 244501.0, 245524.0, 246420.0, 52270.47729522656, 52817.7359113202, 52842.207366889525, 52886.0, 52900.561463504746, 32901.3419731604, 33224.335513289596, 33265.66734332674, 35470.11324716851, 54722.0, 14939.477118300807, 15043.924780376028, 15052.32264548098, 15071.54785356441, 15073.698526029419, 10303.433311167957, 11622.186446948632, 11700.88299117015, 11709.765804683859, 11715.589954351557, 17986.19062142207, 18354.541136471427, 18493.352732654294, 18931.621367572847, 19013.714794278098, 6710.865782684319, 6816.591004539743, 6822.965885170543, 7013.89479157813, 7038.577685338896, 781.8983532140899, 854.1970547685156, 862.4135587800231, 891.0866361979023, 952.3571589177278, 27287.727122728917, 27919.30201744932, 28561.0, 28630.570541441895, 28674.713252867205, 948.5826236455937, 1004.9949750251202, 1021.5096753558333, 1054.3515737821185, 1070.4576630502556, 14355.425782968774, 14806.259687015607, 14853.0, 15081.849181508045, 15140.167290798892, 365159.0, 372257.0, 372288.0, 373115.0, 373482.0, 48573.0, 49281.50718492841, 49284.75357623189, 49295.75352123217, 49317.50682493201, 1061.6868023932805, 1161.3960740414936, 1168.9473973671206, 1179.8260730572963, 1194.814803705427, 27825.304367390978, 28931.855340724003, 28962.855185723936, 29047.56428653614, 29383.55924661089, 40960.38559421671, 47173.528264716915, 48205.0, 48285.27572086492, 52592.47407526029, 341018.0, 345765.0, 351945.0, 352962.0, 354058.0, 33971.83014084914, 34415.311693765485, 35286.117847053, 35351.646483535864, 35361.29277414386, 31897.0, 40724.59275407208, 40995.79502102471, 42212.15575688407, 42639.147217054866, 34649.82675086609, 36126.458103129, 36529.452058218616, 36765.63234367622, 36839.26321473609, 35746.64253357433, 35831.641683583875, 35992.28015439624, 36063.63936360603, 36134.4579831308, 34694.82652586721, 35070.12324691903, 35303.293934121684, 35689.64310356863, 35851.10372240715, 31615.893443729357, 32165.839170803996, 32273.896812767005, 32324.191895202806, 32692.182695432806, 24437.266881993568, 24704.382390439663, 24932.376690582154, 25261.873690632165, 25320.873395632905], "value": 17980.668863498824, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.2685998318266, 352.95235143255655, 353.31809607457603, 363.28070420567275, 364.5079143156737, 16446.588835279123, 16484.42304519342, 17180.0, 17402.47792566222, 17402.912985435087, 16304.184790760473, 16611.91694041531, 16841.326346946138, 16947.91526042368, 16958.0, 4781.354517140185, 4958.454569997298, 5005.249212618118, 5009.824656137036, 5017.724025178613, 3032.6815684353155, 3177.253345463814, 4926.729029903354, 5615.382307946143, 5909.674967876765, 5883.0, 5898.380670029649, 5929.614575052629, 5959.731812068446, 5968.67172305523, 5642.746076426571, 5796.565257605696, 5844.795432159896, 5909.8227053188475, 5921.851953701149, 2745.341118131634, 4733.573978341931, 5064.34163558735, 5066.265391518246, 5090.9745451272875, 20333.288334908357, 20500.282490112924, 20558.69161962572, 20654.58690826175, 20814.16743330265, 1866.2721538599958, 1897.6679081160742, 1947.0167565379534, 1950.4733721895009, 1964.5186929202293, 12839.614811555575, 12869.485220591165, 12906.096573239876, 13029.674258143528, 13354.599362019155, 1572.119613016703, 1915.5689969756831, 1953.4432686684227, 1986.9801301987084, 2048.09883651193, 78611.6069419655, 79835.60082199551, 80814.0, 83093.58453207756, 84216.49192405786, 15974.201289935689, 16114.75827862583, 16166.515004549883, 16191.838081619033, 16659.833401665826, 28930.27674308159, 29410.558841617392, 29515.409691806042, 29653.110406687403, 29725.55411668827, 8576.785580360542, 9281.164695177466, 9311.0, 9364.25085993119, 9455.810883782424, 7664.11862635804, 7704.383649308042, 7708.113566939762, 7770.10643775973, 7879.2120787921895, 8125.9187408126345, 8250.958745206235, 8400.849681369486, 8449.873251901226, 8541.743747687578, 2482.553140434739, 3216.533602627606, 3322.734181265493, 3342.131045928076, 3490.2321489272317, 748.7903387051634, 813.4996976859189, 813.6175997281268, 852.8123812761182, 937.3766445313926, 15195.772063419057, 15687.529374118794, 16254.349826006828, 16303.59241018984, 16663.416780412626, 846.9576521173917, 856.195176534056, 864.6973559254336, 869.3783944479727, 922.9123233292827, 9026.277897768163, 9122.543872806333, 9355.391899526508, 9590.616375344907, 9658.855117173249, 398504.0, 400643.0, 427064.0, 432628.0, 436840.34218460246, 80751.0, 86367.0, 87091.56454217815, 88067.0, 88227.0, 947.5120313038791, 947.9478628675352, 958.0084612425966, 982.2731178927685, 992.831218692824, 15537.0, 15705.528834134995, 15806.68386632284, 15980.280887359864, 16162.595935101717, 37175.25649487049, 37853.621463785006, 37968.0, 38662.613373867025, 38825.805870970464, 51944.0, 53185.734071329396, 53979.460205397445, 54521.0, 55021.724891375285, 7140.750073747394, 7456.850862982601, 7477.513961592479, 7486.0, 7625.8856117157175, 7179.964100179465, 7862.52824830512, 10362.948185259025, 11638.88361116378, 11646.185764443053, 9297.581608827484, 9858.11276985046, 10034.899651003396, 10128.898711013091, 10160.695179144637, 9735.70792876215, 10137.746556336151, 10161.745956351151, 10397.428141452292, 10404.947975260075, 9833.557489913113, 9949.253805964727, 10330.225233107396, 10505.737356566147, 10801.891981080404, 6972.302769722987, 7230.855382892418, 7241.782746517613, 7322.121345438582, 7369.668364923484, 9157.130072643089, 9740.220782337537, 9744.07431294026, 9892.208623310262, 9901.108900199017], "value": 8923.883988196918, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1218.262950914696, 1343.3283358320843, 1414.837293711223, 1423.7721964485684, 1650.9834901650988, 6597.967010164954, 7521.435892308072, 7787.4938129021575, 7819.2571705688015, 7965.681372745098, 7704.6918123275, 7840.882386764189, 7851.332636725885, 7869.645865936032, 7885.1326354101, 2156.180651352488, 2179.553191595727, 2179.6621523663857, 2184.5194057307367, 2185.9890700546475, 2135.6049130910833, 2168.7072245246927, 2175.3473957812594, 2175.651895696689, 2188.518525924294, 2090.435582392753, 2095.4866057815857, 2099.3806826986074, 2102.9474263143466, 2161.049138379116, 2070.4720296324417, 2077.0653206057336, 2079.0540304161646, 2081.6565266730972, 2085.4577809769416, 2019.919203231869, 2088.592724418739, 2088.7702352741185, 2089.5194105355854, 2095.518030852897, 7723.11184213817, 7745.1867553906595, 7796.376289896794, 7819.491733037335, 7984.8403031939615, 4467.352233926095, 4557.179707652621, 4578.908421831545, 4586.151561961048, 4586.908261834778, 2698.190542837141, 2801.355688191707, 2846.1461561531664, 2849.672287686901, 2873.583330417078, 873.8470767615705, 888.6667499687617, 898.0570401078841, 899.3434792601438, 903.5708038681639, 10583.62957296491, 10682.252242343038, 10728.302660327054, 10740.140788736882, 10742.516586753614, 3907.4724912137067, 4020.2361551305157, 4087.325591277406, 4087.5912408758886, 4099.8360065597635, 8305.0, 8333.208345207195, 8380.287675547524, 8395.076541580422, 8404.873926891101, 4425.977870110629, 4441.733495990251, 4458.019235768126, 4463.062756821104, 4466.865994020184, 3444.913877153091, 3881.7476864003747, 4085.733422638991, 4218.0, 4246.278132717383, 3299.5710557627835, 3336.5495658085847, 3397.8301084946147, 3466.982665086709, 3507.5615548056494, 949.586929685589, 993.9701808945744, 1000.8999100090078, 1004.1364426593124, 1016.5730393234859, 615.9568830181844, 641.2753588445028, 691.1602403080282, 746.910370755502, 753.7512620835112, 4889.535494128052, 5029.5221953914315, 5052.69683818972, 5276.314079169683, 5276.577873770089, 401.0967957043846, 405.1249301508727, 408.2182620282186, 410.8459327752093, 415.20281060364175, 3377.6453472385047, 3393.100828280508, 3418.5555877735737, 3445.0353900907785, 3486.651334866493, 9273.907260927304, 9369.484678342757, 9575.712728618153, 9665.516724163905, 9671.758206044906, 9484.90515094854, 9525.809483810284, 9582.856257156009, 9665.806683866283, 9673.661421850202, 7049.3303136203, 7255.709771609077, 7375.04124463827, 7448.739294124788, 7456.142543607554, 4741.668083234141, 4794.640401969936, 4842.249451335048, 4914.926276105933, 4943.0, 8850.159234872677, 8871.157240062184, 8902.465852048897, 8904.19862212404, 8922.197002269826, 8850.73447796567, 8950.955245223733, 9095.590698418719, 9120.133587309196, 9124.543772811465, 5145.536901678867, 5767.769289228384, 6225.875482490234, 6264.59280146789, 6270.216222972129, 7071.752488662872, 7295.416366690758, 7339.339459448675, 7346.228645992094, 7352.0, 6377.681115944277, 6497.837554061186, 6517.055027020961, 6590.143281373391, 6661.1007513985, 5891.705414729332, 5908.645481271137, 5997.16039754426, 6053.152558641882, 6157.076438534255, 5386.649867758583, 5479.671219726829, 5499.807506737245, 5523.834284971457, 5528.0, 3940.2513522430645, 3985.0, 4007.939880901847, 4087.7956102195367, 4115.42384066237, 4044.7977601119237, 4091.324931386288, 4136.793160342031, 4148.377743338523, 4187.434696316081], "value": 3864.6209282565515, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.64686406016693, 291.56411165307867, 297.1531136261654, 298.40914988323135, 300.43368250847175, 4802.135615589193, 4817.325574419584, 4821.3491178690865, 4836.322914791927, 4837.129316722984, 4749.548792864681, 4753.952460475394, 4769.141554520185, 4774.880627984302, 4776.0, 3523.964760352396, 3582.6059133495296, 3614.6746792788645, 3720.330340538702, 3748.850045998157, 3707.6292370762976, 3719.7396182267253, 3741.7567858089274, 3745.906352341186, 3746.662800347968, 3470.9305813883707, 3705.221903400289, 3710.2950439416422, 3727.0868637183794, 3730.048837546422, 3471.3057388522143, 3585.1933315004176, 3585.94621080684, 3592.1378869071496, 3677.3564626190578, 3225.4194245035883, 3238.9676103238903, 3258.902232933016, 3264.2981758921946, 3267.1015470745497, 4622.884427889296, 4669.1128685549975, 4672.462666793328, 4677.0, 4706.74112923789, 3992.281389349916, 4193.853215137456, 4195.265828480004, 4217.472815898012, 4221.957780422218, 4967.3542439483, 4981.427135879348, 4984.87537811554, 4998.6750861193905, 5005.47442518534, 3472.49648800925, 3477.9130521736906, 3499.002784206514, 3515.3320869035056, 3524.753267271292, 5128.692278463267, 5226.817061402832, 5239.921401178985, 5250.894982100336, 5307.6019298552765, 3514.7012503937453, 3539.911502212465, 3540.0, 3544.131687736521, 3567.340042092221, 3602.747807653439, 3608.566971963381, 3619.2761447710564, 3627.474016267626, 3628.602987849697, 4140.523839758406, 4176.164767046603, 4182.163567286555, 4182.351735481006, 4186.016286172747, 4891.828785992473, 4952.727599981963, 5030.773615187325, 5048.192289233705, 5057.696538207646, 1223.1315765806378, 1226.337777600104, 1226.8282440458343, 1242.186367929008, 1257.3838818978818, 759.9285008138498, 771.9578568931897, 783.310686595792, 793.9682412703543, 802.3340627279345, 4387.122575484916, 4533.320001999727, 4534.77326133692, 4536.729715679615, 4590.678652494294, 5131.794728210904, 5181.222816577543, 5207.2141404348495, 5223.738813059408, 5247.081760691864, 4405.0, 4482.27432438507, 4517.525659805673, 4534.727916325031, 4546.363509108727, 2676.90630827924, 2747.4230411613385, 2757.2555410039176, 2773.4453109378205, 2781.1239459570575, 4919.729414882216, 4920.917398172396, 4938.209886418228, 4953.950460495421, 4961.950380496221, 5210.426853046162, 5322.2548843161985, 5352.795620985247, 5379.569634429236, 5395.271638328853, 4860.9513904861205, 4863.076015557032, 4924.482929292444, 4965.230389289666, 4965.510346895989, 5154.587632989277, 5170.71561064145, 5182.948170518246, 5186.351706036746, 5195.7142357170715, 4806.7836947338155, 5026.371703537058, 5055.6713813602, 5057.620678449058, 5065.974670126626, 4924.63065270099, 4930.334404855299, 4940.604751619933, 4971.154903666457, 4979.800807967641, 3567.911786904915, 3576.284743051348, 3594.353016457063, 3596.262766132989, 3596.777095787445, 5141.974290128525, 5206.401263854706, 5253.317068781187, 5258.6581872178185, 5296.0, 5013.646315494869, 5025.246213068069, 5055.646104772631, 5061.670991385548, 5069.847904562869, 5029.170186919264, 5036.798528058836, 5045.344105266292, 5054.2923990642075, 5067.873303167303, 4782.856514304576, 4929.285253638131, 4959.13215187348, 4972.5027497249985, 4997.800087996585, 4814.301926220748, 4919.729414882073, 5041.621878359065, 5096.949030509648, 5122.743862806919, 4947.752612369295, 4970.080535101018, 5012.3233363495465, 5014.34813474246, 5016.974915125401], "value": 3760.6773675257355, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.4744245524297, 560.0535095688286, 570.7374607680467, 574.5604612471458, 600.5435868739756, 9837.803243935117, 10237.744056398593, 10624.946875265632, 10632.3620582765, 10646.095081918036, 11719.0, 11764.0, 11767.941160294207, 11773.0, 11791.882081179207, 618.628822706377, 745.4334705623738, 747.2452822649136, 759.2786852490129, 762.3101093510354, 767.3745897093878, 774.9806254843646, 775.7517594369804, 777.5567926282022, 777.6150805351359, 814.5682788122305, 815.1318845429598, 816.5549775372407, 816.8121332093622, 817.0685418622745, 629.7543957856417, 774.9961250193769, 798.022422532399, 802.257911431926, 805.0098378993841, 588.4527389527738, 588.5556404914305, 588.7056471764118, 592.4490224091593, 597.1073245497965, 10497.055265026183, 10498.422586757726, 10512.894871051345, 10520.421376824272, 10522.473876306154, 11630.127740419417, 11916.880831191664, 12068.939655301667, 12281.201721888048, 12468.625941221779, 10279.845802312972, 10490.318129321646, 10496.895031049668, 10631.149508039338, 10638.946805266001, 4061.1065565575527, 4111.732737372061, 4118.320477121271, 4134.524529679095, 4154.086101057763, 55298.9999999996, 55832.720836395965, 56143.71928140374, 56375.15437268444, 56564.71717641427, 9396.765080873032, 9498.95250523743, 9619.230461563058, 9649.807003859883, 9987.30088893785, 16864.325426982785, 16867.240974155946, 16877.40929067477, 16884.155792210342, 16897.15514224284, 6587.374199451045, 6623.4701223901975, 6675.966620166868, 6734.831629209211, 6852.725890964405, 3388.8644454221553, 3409.897703068912, 3452.2750222453064, 3466.0814884055744, 3561.8397172127316, 2456.2508434927518, 2551.8468891866546, 2553.1191738850066, 2606.9869650651626, 2699.0958029060093, 450.0459026863071, 456.1037561192273, 457.77568991194073, 465.4159030416805, 467.0402323225804, 413.5616246778425, 427.8930267433142, 484.66800241834454, 515.3969855269344, 531.7181893596401, 6629.701663425158, 6731.515960094851, 6761.053452516651, 6819.795406137824, 6878.105846239957, 494.77240469383764, 498.8478514053176, 499.6976829018464, 534.74599565207, 541.2963147907705, 3153.6530981592005, 3167.984160079231, 3285.3593549258144, 3298.950515742266, 3372.0558243691808, 79679.20320796718, 87408.56295718481, 87794.12205877987, 92739.53630231941, 92981.0, 51546.22680659793, 56239.43760562424, 79861.60069199733, 80287.0, 82141.0, 55478.72260638671, 71332.0, 71822.0, 71901.64049179721, 72555.63722181355, 6413.973764197706, 6475.384838440341, 6488.513361498001, 6565.835854103686, 6685.364890335411, 44400.555994439645, 44692.77653611711, 45051.774741126086, 45799.0, 46419.0, 61256.0, 62054.0, 62540.0, 64260.0, 64372.678136609014, 8633.43882647651, 8741.956290218508, 8939.106089391009, 9000.819983600422, 9085.046070162802, 9585.856212156683, 9744.17174540172, 9748.073932976356, 9762.17021553176, 9847.950760246153, 8647.092055334351, 9047.411918225294, 9142.771430714285, 9341.57962891658, 9370.67202647904, 8764.737057888273, 8845.955770221108, 8863.64545418176, 9230.35387522867, 9306.395084319498, 8427.705030323908, 8804.427712198687, 8969.730908072768, 8981.461112333282, 9048.366614337196, 7073.575585464889, 7229.457790665616, 7329.157146928172, 7482.588457634883, 7604.353629941517, 7667.846643067219, 7941.523508589503, 7961.8407631848195, 8083.151269116894, 8206.917930820615], "value": 5802.9082635395025, "unit": "score"}], "name": "dromaeo_css", "value": 6288.702394289119, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 107.0, 113.0, 116.0, 113.0, 114.0, 114.0, 113.0, 114.0, 113.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 130.0, 136.0, 194.0, 130.0, 131.0, 157.0, 130.0, 189.0, 130.0], "value": 148.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 161.0, 163.0, 164.0, 164.0, 164.0, 164.0, 162.0, 163.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 122.0, 77.0, 78.0, 76.0, 76.0, 104.0, 77.0], "value": 83.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 125.0, 87.0, 88.0, 87.0, 118.0, 86.0, 87.0, 126.0], "value": 97.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 63.0, 65.0, 64.0, 63.0, 64.0, 64.0, 64.0, 64.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 66.0, 64.0, 65.0, 65.0, 64.0, 65.0, 64.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 90.0, 84.0, 83.0, 86.0, 85.0, 85.0, 86.0, 121.0, 85.0], "value": 88.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 133.0, 139.0, 147.0, 130.0, 139.0, 141.0, 129.0, 157.0, 136.0], "value": 138.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 167.0, 168.0, 171.0, 171.0, 171.0, 169.0, 171.0, 169.0, 166.0], "value": 169.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 69.0, 69.0, 67.0, 69.0, 78.0, 69.0, 65.0], "value": 68.8, "unit": "score"}], "name": "kraken", "value": 1558.8999999999999, "alertThreshold": 2.0}]} 08:07:30 INFO - Return code: 0 08:07:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:07:30 ERROR - # TBPL SUCCESS # 08:07:30 INFO - Running post-action listener: _resource_record_post_action 08:07:30 INFO - ##### 08:07:30 INFO - ##### Finished run-tests step (success) 08:07:30 INFO - ##### 08:07:30 INFO - Running post-run listener: _resource_record_post_run 08:07:30 INFO - Total resource usage - Wall time: 1217s; CPU: 14.0%; Read bytes: 8192; Write bytes: 508813312; Read time: 1508; Write time: 3970584 08:07:30 INFO - TinderboxPrint: CPU usage
13.6% 08:07:30 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 1,508 08:07:30 INFO - TinderboxPrint: I/O write bytes / time
508,813,312 / 3,970,584 08:07:30 INFO - TinderboxPrint: CPU idle
8,391.8 (86.4%) 08:07:30 INFO - TinderboxPrint: CPU user
1,212.9 (12.5%) 08:07:30 INFO - TinderboxPrint: Swap in / out
0 / 0 08:07:30 INFO - install - Wall time: 22s; CPU: 27.0%; Read bytes: 4096; Write bytes: 223141888; Read time: 1504; Write time: 2251336 08:07:30 INFO - run-tests - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 280342528; Read time: 4; Write time: 1462716 08:07:31 INFO - Running post-run listener: _upload_blobber_files 08:07:31 INFO - Blob upload gear active. 08:07:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:07:31 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 08:07:31 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'] 08:07:31 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 08:07:31 INFO - (blobuploader) - INFO - Open directory for files ... 08:07:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:07:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:07:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:32 INFO - (blobuploader) - INFO - Done attempting. 08:07:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:07:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:07:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:35 INFO - (blobuploader) - INFO - Done attempting. 08:07:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:07:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:07:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:36 INFO - (blobuploader) - INFO - Done attempting. 08:07:36 INFO - (blobuploader) - INFO - Iteration through files over. 08:07:36 INFO - Return code: 0 08:07:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:07:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:07:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2f109967f5bd2bc6828834341f46fe97b03f512ddeca44901187a22f87e815ab951fb11f108cdf83996ae98fb3fa35b40611b656a68b3df9262f5bd9f581107f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/81172a29d6fe0430f05dcc7348a6f500e978adcd3bc96d829454433f1dd1f635034ce53c6ebfabe8fc80fac665b571f1ed421df8b33592401e2a09b2cf5c74f8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3eda92f1bc1c565c0246ab7257614601d3b69a9a6f3a706c61cf0197a686f257be95bd99e7c1f16cfce34e283e8106f7f1c956f99be436efdeb5c2db98853337"} 08:07:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:07:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:07:36 INFO - Contents: 08:07:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2f109967f5bd2bc6828834341f46fe97b03f512ddeca44901187a22f87e815ab951fb11f108cdf83996ae98fb3fa35b40611b656a68b3df9262f5bd9f581107f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/81172a29d6fe0430f05dcc7348a6f500e978adcd3bc96d829454433f1dd1f635034ce53c6ebfabe8fc80fac665b571f1ed421df8b33592401e2a09b2cf5c74f8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3eda92f1bc1c565c0246ab7257614601d3b69a9a6f3a706c61cf0197a686f257be95bd99e7c1f16cfce34e283e8106f7f1c956f99be436efdeb5c2db98853337"} 08:07:36 INFO - Running post-run listener: copy_logs_to_upload_dir 08:07:36 INFO - Copying logs to upload dir... 08:07:36 INFO - mkdir: /builds/slave/test/build/upload/logs 08:07:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.039495 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-06-09 08:07:36.418407) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 08:07:36.421983) ========= 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=33d5923976266a1c518c4bf7000001ab-1465483555.173147-1124489517 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/2f109967f5bd2bc6828834341f46fe97b03f512ddeca44901187a22f87e815ab951fb11f108cdf83996ae98fb3fa35b40611b656a68b3df9262f5bd9f581107f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/81172a29d6fe0430f05dcc7348a6f500e978adcd3bc96d829454433f1dd1f635034ce53c6ebfabe8fc80fac665b571f1ed421df8b33592401e2a09b2cf5c74f8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3eda92f1bc1c565c0246ab7257614601d3b69a9a6f3a706c61cf0197a686f257be95bd99e7c1f16cfce34e283e8106f7f1c956f99be436efdeb5c2db98853337"} build_url:https://queue.taskcluster.net/v1/task/Ry5ML7fKRCWp1OOUbD_iMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011462 build_url: 'https://queue.taskcluster.net/v1/task/Ry5ML7fKRCWp1OOUbD_iMQ/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/2f109967f5bd2bc6828834341f46fe97b03f512ddeca44901187a22f87e815ab951fb11f108cdf83996ae98fb3fa35b40611b656a68b3df9262f5bd9f581107f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/81172a29d6fe0430f05dcc7348a6f500e978adcd3bc96d829454433f1dd1f635034ce53c6ebfabe8fc80fac665b571f1ed421df8b33592401e2a09b2cf5c74f8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3eda92f1bc1c565c0246ab7257614601d3b69a9a6f3a706c61cf0197a686f257be95bd99e7c1f16cfce34e283e8106f7f1c956f99be436efdeb5c2db98853337"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 08:07:36.447471) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 08:07:36.447819) ========= 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=33d5923976266a1c518c4bf7000001ab-1465483555.173147-1124489517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004541 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 08:07:36.531427) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 08:07:36.531759) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 08:07:36.532082) ========= ========= Total master_lag: 0.16 =========