builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-054 starttime: 1467015304.51 results: success (0) buildid: 20160627003524 builduid: c8792aa359c54ce0b6dc0a6ebc3b901a revision: 8f48d2f1fa58dbb978abc28051f3550724800b2f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 01:15:04.514745) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 01:15:04.515267) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 01:15:04.515590) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 01:15:04.554123) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 01:15:04.554442) ========= 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=cbe409c6de289db6ac707de3000001d4-1467005458.683549-2082024030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 01:15:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-06-27 01:15:05 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100155 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 01:15:04.670751) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 01:15:04.671055) ========= 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=cbe409c6de289db6ac707de3000001d4-1467005458.683549-2082024030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017669 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 01:15:04.726143) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 01:15:04.726498) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8f48d2f1fa58dbb978abc28051f3550724800b2f --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 8f48d2f1fa58dbb978abc28051f3550724800b2f --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=cbe409c6de289db6ac707de3000001d4-1467005458.683549-2082024030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 01:15:05,427 truncating revision to first 12 chars 2016-06-27 01:15:05,427 Setting DEBUG logging. 2016-06-27 01:15:05,427 attempt 1/10 2016-06-27 01:15:05,427 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8f48d2f1fa58?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 01:15:06,101 unpacking tar archive at: fx-team-8f48d2f1fa58/testing/mozharness/ program finished with exit code 0 elapsedTime=1.023132 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 01:15:05.763583) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 01:15:05.763868) ========= script_repo_revision: 8f48d2f1fa58dbb978abc28051f3550724800b2f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 01:15:05.764298) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 01:15:05.764581) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 01:15:05.774745) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-06-27 01:15:05.775019) ========= /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=cbe409c6de289db6ac707de3000001d4-1467005458.683549-2082024030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:15:06 INFO - MultiFileLogger online at 20160627 01:15:06 in /builds/slave/test 01:15:06 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 01:15:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:15:06 INFO - {'append_to_log': False, 01:15:06 INFO - 'base_work_dir': '/builds/slave/test', 01:15:06 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 01:15:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:15:06 INFO - 'branch': 'Fx-Team-Non-PGO', 01:15:06 INFO - 'buildbot_json_path': 'buildprops.json', 01:15:06 INFO - 'config_files': ('talos/linux_config.py',), 01:15:06 INFO - 'default_actions': ('clobber', 01:15:06 INFO - 'read-buildbot-config', 01:15:06 INFO - 'download-and-extract', 01:15:06 INFO - 'populate-webroot', 01:15:06 INFO - 'create-virtualenv', 01:15:06 INFO - 'install', 01:15:06 INFO - 'run-tests'), 01:15:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:15:06 INFO - 'download_minidump_stackwalk': True, 01:15:06 INFO - 'download_symbols': 'ondemand', 01:15:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:15:06 INFO - 'tooltool.py': '/tools/tooltool.py', 01:15:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:15:06 INFO - '/tools/misc-python/virtualenv.py')}, 01:15:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:15:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:15:06 INFO - 'installer_path': 'installer.exe', 01:15:06 INFO - 'log_level': 'info', 01:15:06 INFO - 'log_name': 'talos', 01:15:06 INFO - 'log_to_console': True, 01:15:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:15:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:15:06 INFO - 'opt_config_files': (), 01:15:06 INFO - 'pip_index': False, 01:15:06 INFO - 'sps_profile': False, 01:15:06 INFO - 'sps_profile_interval': 0, 01:15:06 INFO - 'suite': 'dromaeojs', 01:15:06 INFO - 'system_bits': '32', 01:15:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:15:06 INFO - 'title': 'talos-linux64-ix-054', 01:15:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:15:06 INFO - 'use_talos_json': True, 01:15:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:15:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:15:06 INFO - 'work_dir': 'build'} 01:15:06 INFO - ##### 01:15:06 INFO - ##### Running clobber step. 01:15:06 INFO - ##### 01:15:06 INFO - Running pre-action listener: _resource_record_pre_action 01:15:06 INFO - Running main action method: clobber 01:15:06 INFO - rmtree: /builds/slave/test/build 01:15:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:15:07 INFO - Running post-action listener: _resource_record_post_action 01:15:07 INFO - ##### 01:15:07 INFO - ##### Finished clobber step (success) 01:15:07 INFO - ##### 01:15:07 INFO - ##### 01:15:07 INFO - ##### Running read-buildbot-config step. 01:15:07 INFO - ##### 01:15:07 INFO - Running pre-action listener: _resource_record_pre_action 01:15:07 INFO - Running main action method: read_buildbot_config 01:15:07 INFO - Using buildbot properties: 01:15:07 INFO - { 01:15:07 INFO - "project": "", 01:15:07 INFO - "product": "firefox", 01:15:07 INFO - "script_repo_revision": "production", 01:15:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 01:15:07 INFO - "repository": "", 01:15:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 01:15:07 INFO - "buildid": "20160627003524", 01:15:07 INFO - "pgo_build": "False", 01:15:07 INFO - "basedir": "/builds/slave/test", 01:15:07 INFO - "buildnumber": 1775, 01:15:07 INFO - "slavename": "talos-linux64-ix-054", 01:15:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:15:07 INFO - "platform": "ubuntu64_hw", 01:15:07 INFO - "scheduler": "tests-fx-team-linux64-talos", 01:15:07 INFO - "branch": "fx-team", 01:15:07 INFO - "repo_path": "integration/fx-team", 01:15:07 INFO - "revision": "8f48d2f1fa58dbb978abc28051f3550724800b2f", 01:15:07 INFO - "stage_platform": "linux64", 01:15:07 INFO - "builduid": "c8792aa359c54ce0b6dc0a6ebc3b901a", 01:15:07 INFO - "slavebuilddir": "test" 01:15:07 INFO - } 01:15:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 01:15:07 INFO - Running post-action listener: _resource_record_post_action 01:15:07 INFO - ##### 01:15:07 INFO - ##### Finished read-buildbot-config step (success) 01:15:07 INFO - ##### 01:15:07 INFO - ##### 01:15:07 INFO - ##### Running download-and-extract step. 01:15:07 INFO - ##### 01:15:07 INFO - Running pre-action listener: _resource_record_pre_action 01:15:07 INFO - Running main action method: download_and_extract 01:15:07 INFO - mkdir: /builds/slave/test/build/tests 01:15:07 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')]} 01:15:07 INFO - https://queue.taskcluster.net/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:15:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:15:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:15:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/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 01:15:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/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 01:15:11 INFO - Downloaded 1361 bytes. 01:15:11 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:15:11 INFO - Using the following test package requirements: 01:15:11 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:15:11 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:15:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:15:11 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:15:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:15:11 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:15:11 INFO - u'jsshell-linux-x86_64.zip'], 01:15:11 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:15:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:15:11 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:15:11 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:15:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:15:11 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:15:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:15:11 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:15:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:15:11 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:15:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:15:11 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:15:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:15:11 INFO - https://queue.taskcluster.net/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:15:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:15:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:15:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/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 01:15:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/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 01:15:18 INFO - Downloaded 22712973 bytes. 01:15:18 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'] 01:15:18 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 01:15:19 INFO - Return code: 0 01:15:19 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 01:15:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:15:19 INFO - https://queue.taskcluster.net/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:15:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:15:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:15:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/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 01:15:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/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 01:15:21 INFO - Downloaded 22712973 bytes. 01:15:21 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'] 01:15:21 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 01:15:22 INFO - Return code: 0 01:15:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:15:22 INFO - https://queue.taskcluster.net/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:15:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:15:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:15:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/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 01:15:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/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 01:15:24 INFO - Downloaded 14405240 bytes. 01:15:24 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'] 01:15:24 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 01:15:24 INFO - Return code: 0 01:15:24 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')]} 01:15:24 INFO - https://queue.taskcluster.net/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:15:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:15:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:15:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/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 01:15:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/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 01:15:26 INFO - Downloaded 56273143 bytes. 01:15:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:15:26 INFO - mkdir: /builds/slave/test/properties 01:15:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:15:26 INFO - Writing to file /builds/slave/test/properties/build_url 01:15:26 INFO - Contents: 01:15:26 INFO - build_url:https://queue.taskcluster.net/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:15:27 INFO - Running post-action listener: _resource_record_post_action 01:15:27 INFO - Running post-action listener: set_extra_try_arguments 01:15:27 INFO - ##### 01:15:27 INFO - ##### Finished download-and-extract step (success) 01:15:27 INFO - ##### 01:15:27 INFO - ##### 01:15:27 INFO - ##### Running populate-webroot step. 01:15:27 INFO - ##### 01:15:27 INFO - Running pre-action listener: _resource_record_pre_action 01:15:27 INFO - Running main action method: populate_webroot 01:15:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:15:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:15:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:15:27 INFO - '--tppagecycles', 01:15:27 INFO - '7'], 01:15:27 INFO - 'tests': ['tsvgm']}}, 01:15:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:15:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:15:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:15:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:15:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:15:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:15:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:15:27 INFO - 'talos_options': ['--disable-e10s'], 01:15:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:15:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:15:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:15:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:15:27 INFO - 'talos_options': ['--disable-e10s'], 01:15:27 INFO - 'tests': ['damp', 'tps']}, 01:15:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:15:27 INFO - 'tests': ['damp', 'tps']}, 01:15:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:15:27 INFO - 'tests': ['dromaeo_dom']}, 01:15:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:15:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:15:27 INFO - 'tests': ['basic_compositor_video']}, 01:15:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:15:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:15:27 INFO - 'tests': ['a11yr', 01:15:27 INFO - 'ts_paint', 01:15:27 INFO - 'tpaint', 01:15:27 INFO - 'sessionrestore', 01:15:27 INFO - 'sessionrestore_no_auto_restore', 01:15:27 INFO - 'tabpaint']}, 01:15:27 INFO - 'other-e10s': {'tests': ['a11yr', 01:15:27 INFO - 'ts_paint', 01:15:27 INFO - 'tpaint', 01:15:27 INFO - 'sessionrestore', 01:15:27 INFO - 'sessionrestore_no_auto_restore', 01:15:27 INFO - 'tabpaint']}, 01:15:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:15:27 INFO - 'ts_paint', 01:15:27 INFO - 'tpaint', 01:15:27 INFO - 'sessionrestore', 01:15:27 INFO - 'sessionrestore_no_auto_restore', 01:15:27 INFO - 'tabpaint']}, 01:15:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:15:27 INFO - 'ts_paint', 01:15:27 INFO - 'tpaint', 01:15:27 INFO - 'sessionrestore', 01:15:27 INFO - 'sessionrestore_no_auto_restore', 01:15:27 INFO - 'tabpaint']}, 01:15:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:15:27 INFO - 'tests': ['a11yr', 01:15:27 INFO - 'ts_paint', 01:15:27 INFO - 'tpaint', 01:15:27 INFO - 'sessionrestore', 01:15:27 INFO - 'sessionrestore_no_auto_restore', 01:15:27 INFO - 'tabpaint']}, 01:15:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:15:27 INFO - 'tests': ['a11yr', 01:15:27 INFO - 'ts_paint', 01:15:27 INFO - 'tpaint', 01:15:27 INFO - 'sessionrestore', 01:15:27 INFO - 'sessionrestore_no_auto_restore', 01:15:27 INFO - 'tabpaint']}, 01:15:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:15:27 INFO - 'tests': ['tsvgx', 01:15:27 INFO - 'tsvgr_opacity', 01:15:27 INFO - 'tart', 01:15:27 INFO - 'tscrollx', 01:15:27 INFO - 'cart']}, 01:15:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:15:27 INFO - 'tsvgr_opacity', 01:15:27 INFO - 'tart', 01:15:27 INFO - 'tscrollx', 01:15:27 INFO - 'cart']}, 01:15:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:15:27 INFO - 'talos_options': ['--disable-e10s'], 01:15:27 INFO - 'tests': ['tp5o']}, 01:15:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:15:27 INFO - 'tests': ['tp5o']}, 01:15:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:15:27 INFO - 'talos_options': ['--disable-e10s', 01:15:27 INFO - '--xperf_path', 01:15:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:15:27 INFO - 'tests': ['tp5n']}, 01:15:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:15:27 INFO - 'talos_options': ['--xperf_path', 01:15:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:15:27 INFO - 'tests': ['tp5n']}}, 01:15:27 INFO - 'talos.zip': {'path': '', 01:15:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:15:27 INFO - Running post-action listener: _resource_record_post_action 01:15:27 INFO - ##### 01:15:27 INFO - ##### Finished populate-webroot step (success) 01:15:27 INFO - ##### 01:15:27 INFO - ##### 01:15:27 INFO - ##### Running create-virtualenv step. 01:15:27 INFO - ##### 01:15:27 INFO - Running pre-action listener: _resource_record_pre_action 01:15:27 INFO - Running main action method: create_virtualenv 01:15:27 INFO - Creating virtualenv /builds/slave/test/build/venv 01:15:27 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 01:15:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:15:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:15:27 INFO - Using real prefix '/usr' 01:15:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:15:28 INFO - Installing distribute.............................................................................................................................................................................................done. 01:15:30 INFO - Installing pip.................done. 01:15:30 INFO - Return code: 0 01:15:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:15:30 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')]} 01:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:15:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:30 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')]} 01:15:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:15:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:30 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 0x7f5b6c1fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x248c480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251b6f0>, '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 0x251c5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251caa0>, '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': 'cbe409c6de289db6ac707de3000001d4-1467005458.683549-2082024030', '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 01:15:30 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 01:15:30 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 01:15:30 INFO - Using env: {'DISPLAY': ':0', 01:15:30 INFO - 'HOME': '/home/cltbld', 01:15:30 INFO - 'LANG': 'en_US.UTF-8', 01:15:30 INFO - 'LANGUAGE': 'en_US:en', 01:15:30 INFO - 'LOGNAME': 'cltbld', 01:15:30 INFO - 'MAIL': '/var/mail/cltbld', 01:15:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:15:30 INFO - 'MOZ_NO_REMOTE': '1', 01:15:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:15:30 INFO - 'NO_EM_RESTART': '1', 01:15:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:15:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:15:30 INFO - 'PWD': '/builds/slave/test', 01:15:30 INFO - 'SHELL': '/bin/bash', 01:15:30 INFO - 'SHLVL': '1', 01:15:30 INFO - 'TERM': 'linux', 01:15:30 INFO - 'TMOUT': '86400', 01:15:30 INFO - 'USER': 'cltbld', 01:15:30 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467005458.683549-2082024030', 01:15:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:15:30 INFO - '_': '/tools/buildbot/bin/python'} 01:15:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:15:30 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 01:15:30 INFO - Cleaning up... 01:15:30 INFO - Return code: 0 01:15:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:15:30 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')]} 01:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:15:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:30 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')]} 01:15:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:15:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:30 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 0x7f5b6c1fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x248c480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251b6f0>, '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 0x251c5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251caa0>, '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': 'cbe409c6de289db6ac707de3000001d4-1467005458.683549-2082024030', '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 01:15:30 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 01:15:30 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 01:15:30 INFO - Using env: {'DISPLAY': ':0', 01:15:30 INFO - 'HOME': '/home/cltbld', 01:15:30 INFO - 'LANG': 'en_US.UTF-8', 01:15:30 INFO - 'LANGUAGE': 'en_US:en', 01:15:30 INFO - 'LOGNAME': 'cltbld', 01:15:30 INFO - 'MAIL': '/var/mail/cltbld', 01:15:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:15:30 INFO - 'MOZ_NO_REMOTE': '1', 01:15:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:15:30 INFO - 'NO_EM_RESTART': '1', 01:15:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:15:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:15:30 INFO - 'PWD': '/builds/slave/test', 01:15:30 INFO - 'SHELL': '/bin/bash', 01:15:30 INFO - 'SHLVL': '1', 01:15:30 INFO - 'TERM': 'linux', 01:15:30 INFO - 'TMOUT': '86400', 01:15:30 INFO - 'USER': 'cltbld', 01:15:30 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467005458.683549-2082024030', 01:15:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:15:30 INFO - '_': '/tools/buildbot/bin/python'} 01:15:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:15:30 INFO - Downloading/unpacking psutil>=3.1.1 01:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:15:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:15:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:15:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:15:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:15:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:15:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:15:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:15:32 INFO - Installing collected packages: psutil 01:15:32 INFO - Running setup.py install for psutil 01:15:32 INFO - building 'psutil._psutil_linux' extension 01:15:32 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 01:15:32 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 01:15:32 INFO - building 'psutil._psutil_posix' extension 01:15:32 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 01:15:32 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 01:15:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:15:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:15:33 INFO - Successfully installed psutil 01:15:33 INFO - Cleaning up... 01:15:33 INFO - Return code: 0 01:15:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:15: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')]} 01:15:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:15:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15: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')]} 01:15:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:15:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5b6c1fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x248c480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251b6f0>, '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 0x251c5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251caa0>, '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': 'cbe409c6de289db6ac707de3000001d4-1467005458.683549-2082024030', '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 01:15:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:15:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:15:33 INFO - Using env: {'DISPLAY': ':0', 01:15:33 INFO - 'HOME': '/home/cltbld', 01:15:33 INFO - 'LANG': 'en_US.UTF-8', 01:15:33 INFO - 'LANGUAGE': 'en_US:en', 01:15:33 INFO - 'LOGNAME': 'cltbld', 01:15:33 INFO - 'MAIL': '/var/mail/cltbld', 01:15:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:15:33 INFO - 'MOZ_NO_REMOTE': '1', 01:15:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:15:33 INFO - 'NO_EM_RESTART': '1', 01:15:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:15:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:15:33 INFO - 'PWD': '/builds/slave/test', 01:15:33 INFO - 'SHELL': '/bin/bash', 01:15:33 INFO - 'SHLVL': '1', 01:15:33 INFO - 'TERM': 'linux', 01:15:33 INFO - 'TMOUT': '86400', 01:15:33 INFO - 'USER': 'cltbld', 01:15:33 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467005458.683549-2082024030', 01:15:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:15:33 INFO - '_': '/tools/buildbot/bin/python'} 01:15:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:15:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:15:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:15:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:15:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:15:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:15:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:15:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:15:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:15:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:15:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:15:35 INFO - Installing collected packages: mozsystemmonitor 01:15:35 INFO - Running setup.py install for mozsystemmonitor 01:15:35 INFO - Successfully installed mozsystemmonitor 01:15:35 INFO - Cleaning up... 01:15:35 INFO - Return code: 0 01:15:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:15: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')]} 01:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:15:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15: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')]} 01:15:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:15:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:35 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 0x7f5b6c1fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x248c480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251b6f0>, '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 0x251c5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251caa0>, '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': 'cbe409c6de289db6ac707de3000001d4-1467005458.683549-2082024030', '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 01:15:35 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 01:15:35 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 01:15:35 INFO - Using env: {'DISPLAY': ':0', 01:15:35 INFO - 'HOME': '/home/cltbld', 01:15:35 INFO - 'LANG': 'en_US.UTF-8', 01:15:35 INFO - 'LANGUAGE': 'en_US:en', 01:15:35 INFO - 'LOGNAME': 'cltbld', 01:15:35 INFO - 'MAIL': '/var/mail/cltbld', 01:15:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:15:35 INFO - 'MOZ_NO_REMOTE': '1', 01:15:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:15:35 INFO - 'NO_EM_RESTART': '1', 01:15:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:15:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:15:35 INFO - 'PWD': '/builds/slave/test', 01:15:35 INFO - 'SHELL': '/bin/bash', 01:15:35 INFO - 'SHLVL': '1', 01:15:35 INFO - 'TERM': 'linux', 01:15:35 INFO - 'TMOUT': '86400', 01:15:35 INFO - 'USER': 'cltbld', 01:15:35 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467005458.683549-2082024030', 01:15:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:15:35 INFO - '_': '/tools/buildbot/bin/python'} 01:15:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:15:35 INFO - Downloading/unpacking jsonschema==2.5.1 01:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:15:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:15:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:15:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:15:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:15:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:15:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:15:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:15:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:15:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:15:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:15:37 INFO - Downloading functools32-3.2.3-2.tar.gz 01:15:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:15:37 INFO - warning: no files found matching '*.txt' 01:15:37 INFO - no previously-included directories found matching 'build' 01:15:37 INFO - no previously-included directories found matching 'dist' 01:15:37 INFO - no previously-included directories found matching '.git*' 01:15:37 INFO - Installing collected packages: jsonschema, functools32 01:15:37 INFO - Running setup.py install for functools32 01:15:37 INFO - warning: no files found matching '*.txt' 01:15:37 INFO - no previously-included directories found matching 'build' 01:15:37 INFO - no previously-included directories found matching 'dist' 01:15:37 INFO - no previously-included directories found matching '.git*' 01:15:37 INFO - Successfully installed jsonschema functools32 01:15:37 INFO - Cleaning up... 01:15:37 INFO - Return code: 0 01:15:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:15:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:15:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:15:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:15:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5b6c1fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x248c480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251b6f0>, '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 0x251c5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251caa0>, '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': 'cbe409c6de289db6ac707de3000001d4-1467005458.683549-2082024030', '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 01:15:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:15:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:15:37 INFO - Using env: {'DISPLAY': ':0', 01:15:37 INFO - 'HOME': '/home/cltbld', 01:15:37 INFO - 'LANG': 'en_US.UTF-8', 01:15:37 INFO - 'LANGUAGE': 'en_US:en', 01:15:37 INFO - 'LOGNAME': 'cltbld', 01:15:37 INFO - 'MAIL': '/var/mail/cltbld', 01:15:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:15:37 INFO - 'MOZ_NO_REMOTE': '1', 01:15:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:15:37 INFO - 'NO_EM_RESTART': '1', 01:15:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:15:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:15:37 INFO - 'PWD': '/builds/slave/test', 01:15:37 INFO - 'SHELL': '/bin/bash', 01:15:37 INFO - 'SHLVL': '1', 01:15:37 INFO - 'TERM': 'linux', 01:15:37 INFO - 'TMOUT': '86400', 01:15:37 INFO - 'USER': 'cltbld', 01:15:37 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467005458.683549-2082024030', 01:15:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:15:37 INFO - '_': '/tools/buildbot/bin/python'} 01:15:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:15:38 INFO - Downloading/unpacking blobuploader==1.2.4 01:15:38 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 01:15:38 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 01:15:38 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 01:15:38 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 01:15:38 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 01:15:38 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 01:15:40 INFO - Downloading blobuploader-1.2.4.tar.gz 01:15:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:15:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:15:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:15:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:15:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:15:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:15:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:15:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:15:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:15:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:15:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:15:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:15:40 INFO - Downloading docopt-0.6.1.tar.gz 01:15:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:15:40 INFO - Installing collected packages: blobuploader, requests, docopt 01:15:40 INFO - Running setup.py install for blobuploader 01:15:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:15:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:15:40 INFO - Running setup.py install for requests 01:15:41 INFO - Running setup.py install for docopt 01:15:41 INFO - Successfully installed blobuploader requests docopt 01:15:41 INFO - Cleaning up... 01:15:41 INFO - Return code: 0 01:15:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:15: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')]} 01:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:15:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15: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')]} 01:15:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:15:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:41 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 0x7f5b6c1fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x248c480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251b6f0>, '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 0x251c5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251caa0>, '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': 'cbe409c6de289db6ac707de3000001d4-1467005458.683549-2082024030', '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 01:15:41 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 01:15:41 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 01:15:41 INFO - Using env: {'DISPLAY': ':0', 01:15:41 INFO - 'HOME': '/home/cltbld', 01:15:41 INFO - 'LANG': 'en_US.UTF-8', 01:15:41 INFO - 'LANGUAGE': 'en_US:en', 01:15:41 INFO - 'LOGNAME': 'cltbld', 01:15:41 INFO - 'MAIL': '/var/mail/cltbld', 01:15:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:15:41 INFO - 'MOZ_NO_REMOTE': '1', 01:15:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:15:41 INFO - 'NO_EM_RESTART': '1', 01:15:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:15:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:15:41 INFO - 'PWD': '/builds/slave/test', 01:15:41 INFO - 'SHELL': '/bin/bash', 01:15:41 INFO - 'SHLVL': '1', 01:15:41 INFO - 'TERM': 'linux', 01:15:41 INFO - 'TMOUT': '86400', 01:15:41 INFO - 'USER': 'cltbld', 01:15:41 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467005458.683549-2082024030', 01:15:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:15:41 INFO - '_': '/tools/buildbot/bin/python'} 01:15:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:15:41 INFO - Running setup.py (path:/tmp/pip-IiNbka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:15:41 INFO - Running setup.py (path:/tmp/pip-qSxmGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:15:41 INFO - Running setup.py (path:/tmp/pip-H3lYfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:15:41 INFO - Running setup.py (path:/tmp/pip-TE3Po8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:15:41 INFO - Running setup.py (path:/tmp/pip-X6kk_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:15:41 INFO - Running setup.py (path:/tmp/pip-gE6qOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:15:42 INFO - Running setup.py (path:/tmp/pip-0lGn1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:15:42 INFO - Running setup.py (path:/tmp/pip-PcVBYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:15:42 INFO - Running setup.py (path:/tmp/pip-hiqC5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:15:42 INFO - Running setup.py (path:/tmp/pip-nn2JO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:15:42 INFO - Running setup.py (path:/tmp/pip-il0RSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:15:42 INFO - Running setup.py (path:/tmp/pip-Q6UMuB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:15:42 INFO - Running setup.py (path:/tmp/pip-TLC2gC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:15:42 INFO - Running setup.py (path:/tmp/pip-2ywLXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:15:42 INFO - Running setup.py (path:/tmp/pip-R8MPyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:15:42 INFO - Running setup.py (path:/tmp/pip-UXc8a3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:15:42 INFO - Running setup.py (path:/tmp/pip-caq4jd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:15:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:15:42 INFO - Running setup.py install for manifestparser 01:15:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:15:42 INFO - Running setup.py install for mozcrash 01:15:43 INFO - Running setup.py install for mozdebug 01:15:43 INFO - Running setup.py install for mozdevice 01:15:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:15:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:15:43 INFO - Running setup.py install for mozfile 01:15:43 INFO - Running setup.py install for mozhttpd 01:15:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:15:43 INFO - Running setup.py install for mozinfo 01:15:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:15:43 INFO - Running setup.py install for mozInstall 01:15:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:15:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:15:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:15:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:15:43 INFO - Running setup.py install for mozleak 01:15:43 INFO - Running setup.py install for mozlog 01:15:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:15:43 INFO - Running setup.py install for moznetwork 01:15:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:15:43 INFO - Running setup.py install for mozprocess 01:15:44 INFO - Running setup.py install for mozprofile 01:15:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:15:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:15:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:15:44 INFO - Running setup.py install for mozrunner 01:15:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:15:44 INFO - Running setup.py install for mozscreenshot 01:15:44 INFO - Running setup.py install for moztest 01:15:44 INFO - Running setup.py install for mozversion 01:15:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:15:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:15:44 INFO - Cleaning up... 01:15:44 INFO - Return code: 0 01:15:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:15:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:15:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:15:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:15:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:44 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 0x7f5b6c1fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x248c480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251b6f0>, '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 0x251c5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251caa0>, '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': 'cbe409c6de289db6ac707de3000001d4-1467005458.683549-2082024030', '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 01:15:44 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 01:15:44 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 01:15:44 INFO - Using env: {'DISPLAY': ':0', 01:15:44 INFO - 'HOME': '/home/cltbld', 01:15:44 INFO - 'LANG': 'en_US.UTF-8', 01:15:44 INFO - 'LANGUAGE': 'en_US:en', 01:15:44 INFO - 'LOGNAME': 'cltbld', 01:15:44 INFO - 'MAIL': '/var/mail/cltbld', 01:15:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:15:44 INFO - 'MOZ_NO_REMOTE': '1', 01:15:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:15:44 INFO - 'NO_EM_RESTART': '1', 01:15:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:15:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:15:44 INFO - 'PWD': '/builds/slave/test', 01:15:44 INFO - 'SHELL': '/bin/bash', 01:15:44 INFO - 'SHLVL': '1', 01:15:44 INFO - 'TERM': 'linux', 01:15:44 INFO - 'TMOUT': '86400', 01:15:44 INFO - 'USER': 'cltbld', 01:15:44 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467005458.683549-2082024030', 01:15:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:15:44 INFO - '_': '/tools/buildbot/bin/python'} 01:15:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:15:44 INFO - Running setup.py (path:/tmp/pip-Od2T90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:15:44 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)) 01:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:15:44 INFO - Running setup.py (path:/tmp/pip-Kq_3XZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:15:45 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)) 01:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:15:45 INFO - Running setup.py (path:/tmp/pip-hwNPSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:15:45 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)) 01:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:15:45 INFO - Running setup.py (path:/tmp/pip-mE07G3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:15:45 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)) 01:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:15:45 INFO - Running setup.py (path:/tmp/pip-emrAEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:15:45 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)) 01:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:15:45 INFO - Running setup.py (path:/tmp/pip-nJ4QAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:15:45 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)) 01:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:15:45 INFO - Running setup.py (path:/tmp/pip-bfLfrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:15:45 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)) 01:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:15:45 INFO - Running setup.py (path:/tmp/pip-KvueKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:15:45 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)) 01:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:15:45 INFO - Running setup.py (path:/tmp/pip-l2mvPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:15:45 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)) 01:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:15:45 INFO - Running setup.py (path:/tmp/pip-3QfEsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:15:45 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)) 01:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:15:45 INFO - Running setup.py (path:/tmp/pip-YLCSba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:15:45 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)) 01:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:15:45 INFO - Running setup.py (path:/tmp/pip-0tjp2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:15:45 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)) 01:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:15:45 INFO - Running setup.py (path:/tmp/pip-dLvlo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:15:45 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)) 01:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:15:45 INFO - Running setup.py (path:/tmp/pip-oGLPxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:15:45 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)) 01:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:15:45 INFO - Running setup.py (path:/tmp/pip-s7YHpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:15:46 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)) 01:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:15:46 INFO - Running setup.py (path:/tmp/pip-wWH8RZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:15:46 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)) 01:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:15:46 INFO - Running setup.py (path:/tmp/pip-aeTnOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:15:46 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)) 01:15:46 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)) 01:15:46 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)) 01:15:46 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)) 01:15:46 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)) 01:15:46 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)) 01:15:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:15:46 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 01:15:46 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 01:15:46 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 01:15:46 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 01:15:46 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 01:15:46 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 01:15:48 INFO - Downloading blessings-1.6.tar.gz 01:15:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:15:48 INFO - Installing collected packages: blessings 01:15:48 INFO - Running setup.py install for blessings 01:15:48 INFO - Successfully installed blessings 01:15:48 INFO - Cleaning up... 01:15:48 INFO - Return code: 0 01:15:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:15:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:15:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:15:48 INFO - Reading from file tmpfile_stdout 01:15:48 INFO - Current package versions: 01:15:48 INFO - argparse == 1.2.1 01:15:48 INFO - blessings == 1.6 01:15:48 INFO - blobuploader == 1.2.4 01:15:48 INFO - docopt == 0.6.1 01:15:48 INFO - functools32 == 3.2.3-2 01:15:48 INFO - jsonschema == 2.5.1 01:15:48 INFO - manifestparser == 1.1 01:15:48 INFO - mozInstall == 1.12 01:15:48 INFO - mozcrash == 0.17 01:15:48 INFO - mozdebug == 0.1 01:15:48 INFO - mozdevice == 0.48 01:15:48 INFO - mozfile == 1.2 01:15:48 INFO - mozhttpd == 0.7 01:15:48 INFO - mozinfo == 0.9 01:15:48 INFO - mozleak == 0.1 01:15:48 INFO - mozlog == 3.2 01:15:48 INFO - moznetwork == 0.27 01:15:48 INFO - mozprocess == 0.22 01:15:48 INFO - mozprofile == 0.28 01:15:48 INFO - mozrunner == 6.11 01:15:48 INFO - mozscreenshot == 0.1 01:15:48 INFO - mozsystemmonitor == 0.3 01:15:48 INFO - moztest == 0.7 01:15:48 INFO - mozversion == 1.4 01:15:48 INFO - psutil == 3.1.1 01:15:48 INFO - requests == 1.2.3 01:15:48 INFO - wsgiref == 0.1.2 01:15:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:15:48 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')]} 01:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:15:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:48 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')]} 01:15:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:15:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:48 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 0x7f5b6c1fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x248c480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251b6f0>, '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 0x251c5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251caa0>, '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': 'cbe409c6de289db6ac707de3000001d4-1467005458.683549-2082024030', '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 01:15:48 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 01:15:48 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 01:15:48 INFO - Using env: {'DISPLAY': ':0', 01:15:48 INFO - 'HOME': '/home/cltbld', 01:15:48 INFO - 'LANG': 'en_US.UTF-8', 01:15:48 INFO - 'LANGUAGE': 'en_US:en', 01:15:48 INFO - 'LOGNAME': 'cltbld', 01:15:48 INFO - 'MAIL': '/var/mail/cltbld', 01:15:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:15:48 INFO - 'MOZ_NO_REMOTE': '1', 01:15:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:15:48 INFO - 'NO_EM_RESTART': '1', 01:15:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:15:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:15:48 INFO - 'PWD': '/builds/slave/test', 01:15:48 INFO - 'SHELL': '/bin/bash', 01:15:48 INFO - 'SHLVL': '1', 01:15:48 INFO - 'TERM': 'linux', 01:15:48 INFO - 'TMOUT': '86400', 01:15:48 INFO - 'USER': 'cltbld', 01:15:48 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467005458.683549-2082024030', 01:15:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:15:48 INFO - '_': '/tools/buildbot/bin/python'} 01:15:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:15:48 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)) 01:15:48 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)) 01:15:48 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)) 01:15:48 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)) 01:15:48 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)) 01:15:48 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)) 01:15:48 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)) 01:15:48 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)) 01:15:48 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)) 01:15:48 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)) 01:15:48 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)) 01:15:48 INFO - Cleaning up... 01:15:48 INFO - Return code: 0 01:15:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:15:48 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')]} 01:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:15:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:48 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')]} 01:15:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:15:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:48 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 0x7f5b6c1fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x248c480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251b6f0>, '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 0x251c5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251caa0>, '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': 'cbe409c6de289db6ac707de3000001d4-1467005458.683549-2082024030', '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 01:15:48 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 01:15:48 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 01:15:48 INFO - Using env: {'DISPLAY': ':0', 01:15:48 INFO - 'HOME': '/home/cltbld', 01:15:48 INFO - 'LANG': 'en_US.UTF-8', 01:15:48 INFO - 'LANGUAGE': 'en_US:en', 01:15:48 INFO - 'LOGNAME': 'cltbld', 01:15:48 INFO - 'MAIL': '/var/mail/cltbld', 01:15:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:15:48 INFO - 'MOZ_NO_REMOTE': '1', 01:15:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:15:48 INFO - 'NO_EM_RESTART': '1', 01:15:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:15:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:15:48 INFO - 'PWD': '/builds/slave/test', 01:15:48 INFO - 'SHELL': '/bin/bash', 01:15:48 INFO - 'SHLVL': '1', 01:15:48 INFO - 'TERM': 'linux', 01:15:48 INFO - 'TMOUT': '86400', 01:15:48 INFO - 'USER': 'cltbld', 01:15:48 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467005458.683549-2082024030', 01:15:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:15:48 INFO - '_': '/tools/buildbot/bin/python'} 01:15:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:15:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:15:48 INFO - Cleaning up... 01:15:48 INFO - Return code: 0 01:15:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:15:48 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')]} 01:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:15:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:48 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')]} 01:15:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:15:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:48 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 0x7f5b6c1fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x248c480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251b6f0>, '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 0x251c5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251caa0>, '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': 'cbe409c6de289db6ac707de3000001d4-1467005458.683549-2082024030', '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 01:15:48 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 01:15:48 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 01:15:48 INFO - Using env: {'DISPLAY': ':0', 01:15:48 INFO - 'HOME': '/home/cltbld', 01:15:48 INFO - 'LANG': 'en_US.UTF-8', 01:15:48 INFO - 'LANGUAGE': 'en_US:en', 01:15:48 INFO - 'LOGNAME': 'cltbld', 01:15:48 INFO - 'MAIL': '/var/mail/cltbld', 01:15:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:15:48 INFO - 'MOZ_NO_REMOTE': '1', 01:15:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:15:48 INFO - 'NO_EM_RESTART': '1', 01:15:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:15:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:15:48 INFO - 'PWD': '/builds/slave/test', 01:15:48 INFO - 'SHELL': '/bin/bash', 01:15:48 INFO - 'SHLVL': '1', 01:15:48 INFO - 'TERM': 'linux', 01:15:48 INFO - 'TMOUT': '86400', 01:15:48 INFO - 'USER': 'cltbld', 01:15:48 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467005458.683549-2082024030', 01:15:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:15:48 INFO - '_': '/tools/buildbot/bin/python'} 01:15:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:15:49 INFO - Downloading/unpacking flake8 01:15:49 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 01:15:49 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 01:15:49 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 01:15:49 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 01:15:49 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 01:15:49 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 01:15:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:15:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:15: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 01:15: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 01:15: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 01:15: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 01:15: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 01:15: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 01:15:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:15:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:15: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 01:15: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 01:15: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 01:15: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 01:15: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 01:15: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 01:15:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:15: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 01:15: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 01:15: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 01:15: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 01:15: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 01:15: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 01:15:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:15:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:15:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:15:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:15:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:15:51 INFO - no previously-included directories found matching 'docs/_build' 01:15:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:15:51 INFO - Running setup.py install for pep8 01:15:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:15:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:15:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:15:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:15:51 INFO - no previously-included directories found matching 'docs/_build' 01:15:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:15:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:15:51 INFO - Cleaning up... 01:15:52 INFO - Return code: 0 01:15:52 INFO - Running post-action listener: _resource_record_post_action 01:15:52 INFO - Running post-action listener: _start_resource_monitoring 01:15:52 INFO - Starting resource monitoring. 01:15:52 INFO - ##### 01:15:52 INFO - ##### Finished create-virtualenv step (success) 01:15:52 INFO - ##### 01:15:52 INFO - ##### 01:15:52 INFO - ##### Running install step. 01:15:52 INFO - ##### 01:15:52 INFO - Running pre-action listener: _resource_record_pre_action 01:15:52 INFO - Running main action method: install 01:15:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:15:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:15:52 INFO - Reading from file tmpfile_stdout 01:15:52 INFO - Detecting whether we're running mozinstall >=1.0... 01:15:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:15:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:15:52 INFO - Reading from file tmpfile_stdout 01:15:52 INFO - Output received: 01:15:52 INFO - Usage: mozinstall [options] installer 01:15:52 INFO - Options: 01:15:52 INFO - -h, --help show this help message and exit 01:15:52 INFO - -d DEST, --destination=DEST 01:15:52 INFO - Directory to install application into. [default: 01:15:52 INFO - "/builds/slave/test"] 01:15:52 INFO - --app=APP Application being installed. [default: firefox] 01:15:52 INFO - mkdir: /builds/slave/test/build/application 01:15:52 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'] 01:15:52 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 01:16:08 INFO - Reading from file tmpfile_stdout 01:16:08 INFO - Output received: 01:16:08 INFO - /builds/slave/test/build/application/firefox/firefox 01:16:08 INFO - Running post-action listener: _resource_record_post_action 01:16:08 INFO - ##### 01:16:08 INFO - ##### Finished install step (success) 01:16:08 INFO - ##### 01:16:08 INFO - ##### 01:16:08 INFO - ##### Running run-tests step. 01:16:08 INFO - ##### 01:16:08 INFO - Running pre-action listener: _resource_record_pre_action 01:16:08 INFO - Running main action method: run_tests 01:16:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:16:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:16:08 INFO - Python 2.7.3 01:16:08 INFO - Return code: 0 01:16:08 INFO - grabbing minidump binary from tooltool 01:16:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:08 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 0x251b6f0>, '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 0x251c5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251caa0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:16:08 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 01:16:08 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 01:16:08 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 01:16:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:16:08 INFO - Return code: 0 01:16:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:16:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:16:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:16:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:16:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:16:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:16:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:16:09 INFO - Return code: 0 01:16:09 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/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 01:16:09 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/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 01:16:09 INFO - Using env: {'DISPLAY': ':0', 01:16:09 INFO - 'HOME': '/home/cltbld', 01:16:09 INFO - 'LANG': 'en_US.UTF-8', 01:16:09 INFO - 'LANGUAGE': 'en_US:en', 01:16:09 INFO - 'LOGNAME': 'cltbld', 01:16:09 INFO - 'MAIL': '/var/mail/cltbld', 01:16:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:16:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:16:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:16:09 INFO - 'MOZ_NO_REMOTE': '1', 01:16:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:16:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:16:09 INFO - 'NO_EM_RESTART': '1', 01:16:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:16:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:16:09 INFO - 'PWD': '/builds/slave/test', 01:16:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:16:09 INFO - 'SHELL': '/bin/bash', 01:16:09 INFO - 'SHLVL': '1', 01:16:09 INFO - 'TERM': 'linux', 01:16:09 INFO - 'TMOUT': '86400', 01:16:09 INFO - 'USER': 'cltbld', 01:16:09 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467005458.683549-2082024030', 01:16:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:16:09 INFO - '_': '/tools/buildbot/bin/python'} 01:16:09 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/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 01:16:09 INFO - mozversion application_buildid: 20160627003524 01:16:09 INFO - mozversion application_changeset: 8f48d2f1fa58dbb978abc28051f3550724800b2f 01:16:09 INFO - mozversion application_display_name: Nightly 01:16:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:16:09 INFO - mozversion application_name: Firefox 01:16:09 INFO - mozversion application_remotingname: firefox 01:16:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:16:09 INFO - mozversion application_vendor: Mozilla 01:16:09 INFO - mozversion application_version: 50.0a1 01:16:09 INFO - mozversion platform_buildid: 20160627003524 01:16:09 INFO - mozversion platform_changeset: 8f48d2f1fa58dbb978abc28051f3550724800b2f 01:16:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:16:09 INFO - mozversion platform_version: 50.0a1 01:16:09 INFO - using testdate: 1467015369 01:16:09 INFO - actual date: 1467015369 01:16:09 INFO - starting webserver on 'localhost:32935' 01:16:09 INFO - SUITE-START | Running 2 tests 01:16:09 INFO - TEST-START | dromaeo_css 01:16:09 INFO - operating with platform_type : linux_ 01:16:09 INFO - Initialising browser for dromaeo_css test... 01:16:09 INFO - TEST-INFO | started process 18999 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp211J3F/profile http://localhost:32935/getInfo.html) 01:16:13 INFO - PROCESS | 18999 | __metrics Screen width/height:1600/1200 01:16:13 INFO - PROCESS | 18999 | colorDepth:24 01:16:13 INFO - PROCESS | 18999 | Browser inner width/height: 1024/697 01:16:13 INFO - PROCESS | 18999 | __metrics 01:16:15 INFO - PROCESS | 18999 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:16:16 INFO - TEST-INFO | 18999: exit 0 01:16:16 INFO - Browser initialized. 01:16:16 INFO - Running cycle 1/1 for dromaeo_css test... 01:16:16 INFO - TEST-INFO | started process 19080 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp211J3F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:16:28 INFO - PROCESS | 19080 | RSS: Main: 176402432 01:16:28 INFO - PROCESS | 19080 | 01:17:19 INFO - PROCESS | 19080 | 1467015439192 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] 01:19:32 INFO - PROCESS | 19080 | Cycle 1(1): loaded http://localhost:32935/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32935/tests/dromaeo/cssquery-ext.html) 01:19:33 INFO - PROCESS | 19080 | RSS: Main: 290119680 01:19:33 INFO - PROCESS | 19080 | 01:22:36 INFO - PROCESS | 19080 | Cycle 1(1): loaded http://localhost:32935/tests/dromaeo/cssquery-ext.html (next: http://localhost:32935/tests/dromaeo/cssquery-jquery.html) 01:22:36 INFO - PROCESS | 19080 | RSS: Main: 261353472 01:22:36 INFO - PROCESS | 19080 | 01:25:38 INFO - PROCESS | 19080 | Cycle 1(1): loaded http://localhost:32935/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32935/tests/dromaeo/cssquery-mootools.html) 01:25:39 INFO - PROCESS | 19080 | RSS: Main: 254070784 01:25:39 INFO - PROCESS | 19080 | 01:28:41 INFO - PROCESS | 19080 | Cycle 1(1): loaded http://localhost:32935/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32935/tests/dromaeo/cssquery-prototype.html) 01:28:42 INFO - PROCESS | 19080 | RSS: Main: 255270912 01:28:42 INFO - PROCESS | 19080 | 01:31:45 INFO - PROCESS | 19080 | Cycle 1(1): loaded http://localhost:32935/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32935/tests/dromaeo/cssquery-yui.html) 01:31:45 INFO - PROCESS | 19080 | RSS: Main: 239910912 01:31:45 INFO - PROCESS | 19080 | 01:34:48 INFO - PROCESS | 19080 | Cycle 1(1): loaded http://localhost:32935/tests/dromaeo/cssquery-yui.html (next: http://localhost:32935/tests/dromaeo/cssquery-dojo.html) 01:34:48 INFO - PROCESS | 19080 | RSS: Main: 294952960 01:34:48 INFO - PROCESS | 19080 | 01:34:48 INFO - PROCESS | 19080 | __start_tp_report 01:34:48 INFO - PROCESS | 19080 | _x_x_mozilla_page_load 01:34:48 INFO - PROCESS | 19080 | _x_x_mozilla_page_load_details 01:34:48 INFO - PROCESS | 19080 | |i|pagename|runs| 01:34:48 INFO - PROCESS | 19080 | |0;dojo.html;2568.5505036618592;2581.5095131924945;2612.425266441382;2623.304824221582;2626.868656567171;4611.262198048313;4667.235963584974;4672.602828759559;4693.8591842244705;4760.69055511392;4704.576588107069;4718.9292160617615;4732.550407711271;4751.287306903966;4802.855914322576;4147.585241475844;4319.7192182508115;4400.845970391037;4428.136513379876;4519.3446950192365;4443.511213766499;4482.305242687373;4492.955070449303;4501.279795232764;4523.140603285382;4315.180115777992;4368.257396242647;4378.5183629800695;4430.6676999224865;4441.333799930004;4365.585269399402;4375.562443755631;4384.12317536494;4435.889102772424;4439.955600443986;4372.256716358227;4379.540148284448;4386.8025938832825;4390.100029493978;4422.84520041797;4677.298405239208;4693.624510039189;4716.575508204278;4726.456457507396;4773.093112308685;5047.318611987372;5050.343455350818;5077.035363280965;5091.312672789163;5100.515451032146;5102.770375333119;5137.383513978347;5141.38303403594;5145.76844042019;5147.22791581262;4611.423572053493;4665.6734028617675;4733.881652958635;4751.881202969884;4758.952410475851;5170.948290517047;5188.662736922088;5251.632385733038;5252.080885844962;5261.815836445782;4892.339534162914;4952.826651067267;5016.398032236082;5017.071841709296;5021.49785021495;5069.5690866276045;5109.182530795129;5109.770060347293;5123.590112790967;5192.636515443958;5089.389273287229;5093.18509038552;5104.515071068243;5108.597578301425;5149.382074151126;4969.130402179604;5081.745912704424;5089.821856235014;5094.719790411489;5096.796128154906;4326.480822301344;4332.870013899588;4336.544662810423;4341.761203133795;4431.977840110843;3803.7907915064384;3812.942805857914;3813.065798879237;3854.69162467002;3862.8454861805776;4412.889677758082;4415.66882483815;4416.580424859633;4417.977910110493;4463.085067561142;4974.253861920741;5027.748612569357;5029.220470827027;5044.041632089891;5102.770375333044;4352.064306174188;4365.497967733688;4370.8907277317685;4375.124975005012;4416.205083085076;4540.72755634663;4618.330342100377;4619.676622636383;4620.468646105741;4649.511801260886;4783.784729687103;4814.927776083291;4833.10587541306;4834.371531700856;4881.414230292387;5106.642535022513;5134.075866344094;5137.6660517066275;5138.229265610188;5190.247414124855;4678.274867395559;4783.04339132168;4827.179379505563;4832.492588278321;4879.536444037811;5058.342415485963;5083.262926875656;5097.974510127426;5098.872528186825;5124.385073791169;5183.300254465599;5183.455737147545;5188.870278243074;5193.92209116856;5240.947590524046;4883.60931125502;4886.584640305472;5034.974825125851;5040.168372218543;5047.116754567863;4899.461059283547;4955.702657840541;4966.130927087673;4968.527989840959;5016.072026675077;4880.170371036861;4933.506649335038;4935.531124543163;4936.308916751729;4940.629452791127;4870.05034018363;4957.876053098557;5019.422766381913;5022.84931452057;5035.29505869186;4869.732164730974;4888.633352498506;4895.04546613407;4925.261210818406;4945.060438516671 01:34:48 INFO - PROCESS | 19080 | |1;ext.html;548.8300212002935;586.4282324733384;587.8354060862955;588.1266319515521;603.6438501284243;27278;27883.30291742705;30131.24671883201;40149;40333.39499907496;37385.62614373862;37789.24421511568;37805.81097094511;41094.17811643765;41187.79406102973;7863.92136078639;8010.39922005849;8018.719344822933;8021.077576078738;8022.638981245858;7515.849683006337;7873.330766884793;9776.217902567812;10316.329438586468;10333.844992325121;10409.947950260239;10447.16422686187;10495.842562361571;10504.527296271648;10529.105026072793;10243.282970192053;10295.897041029568;10300.536475858604;10302.175825933908;10303.27877048607;10095.596176153018;10141.797164056752;10173.389596624227;10217.438040907748;10287.228457865614;39690.801545992086;39925.60074399248;39991.40012899809;40065.59934400648;40071.39892901609;2956.659984101834;2977.374751302229;2998.5502174673757;3287.7698561100733;3685.5577330720216;29672.40655186884;30346.848265758752;30423;30721;31044.53433198504;3247.772655914087;3259.7392208623255;3302.108430723691;3347.029361485166;3372.915677108092;258517.9999999981;258734;259134;259268;259357;54896.45103548913;55434.445655543735;55467;55521.44478555163;55552.44447555554;58226;58231;58330;58333;58359.70820145872;14294.857051429353;14390.856091439162;14429.206393648241;14510.927445362917;14603.634909127357;9792.314537982415;10125.392476451436;11134.331940083459;11222.607208747655;11226.719332016764;14850.331735071948;14917.776233356508;14999.775003374958;16310.266038028318;16882.409115680894;5480.561555075585;5932.911006334908;5972.862429396916;6089.451949324582;6243.219597550306;835.6406745099665;891.6968230801558;902.0258121229057;943.2312665177858;981.8625392445064;28094.578581321297;28288.858555707502;28456.61735305853;28500.714992850222;29101.708982910324;949.3544389814854;952.4475804033644;957.698325027614;996.4818294486827;1015.4110615842793;14735.55793326202;14985;15035.774463383059;15144.697106057818;15432.84567154314;397660.01169993967;398859;400481;401014.9898501036;403551;49819.25271120936;49955.25067123996;50079;50081.74959125181;50148.49851501511;1180.5454899863614;1191.4876603060768;1206.3968015992004;1210.9697257568455;1218.1716432825763;26144.60783088293;27422.725772742815;28189.154325370273;28199.577006344512;28463.146105616866;43793.56206437895;43845.342319865864;44076.11847762963;44124.11751765011;44186.337204942596;330584;333831;335391;335920;336540;24939;26014.479710406064;26379.076732314275;37534.43698344582;37765.4335184967;34426.48360274548;35824;43032;44418;44507.55492445034;36699;36811;37582;38002.42996355112;38307;37138.44292335671;37170.62829371672;37549.24901502009;37721;37786.24427511489;36340;36851.44722829106;37731.43402849014;37756.62243377531;37930.81034594809;30936.69063309338;33251.33497330088;33277;33613.327733444705;33802.661973380935;25123.623145652466;25606.871965640054;25862.61206081948;25906.61140082938;26222.213333600022 01:34:48 INFO - PROCESS | 19080 | |2;jquery.html;367.80873945548313;373.15666593498685;376.6252578684209;387.471101945844;388.94749208856797;15670.294836732346;16422.75365869513;17047.48857534273;17244.913775431138;17265.30938762448;16199.271032803523;16576;17388.913055434736;17424.56438589036;17436.912815435906;4938.6542941993985;5120.743962801845;5146.40816306124;5156.046131465672;5156.097682905495;3753.8738378486482;3945.2109578084355;5049.3435853339015;5596.4123767004285;5899.941000589982;5921.141434491996;5921.171036054934;5947.762089516415;5950.494207992326;5963.254593175853;5761.251037365158;5860.384659610765;5948.643081415107;5960.91058634123;6066.636001839904;3318.983405082959;5021.14640511114;5324.1747529133045;5327.254184414185;5332;20072.79927200724;20616.587668246702;20658;21260.14959401622;21296.787032129636;1659.8921070130523;1949.3679667408326;1954.2378472395776;1984.9404517864486;2004.4287378097172;9662.661806836726;9926.751831204278;10353.844692329621;12060.495803859547;12987.61037168877;1653.8346165383487;1703.735920932245;1726.9395571154948;1741.2860727101954;1748.7551742756025;66377.66811165962;69684.3031569683;69922.65038674825;69959.99999999949;70946.64526677334;9512.429254244767;9594.66418675343;9790.755231119136;10347.844782328271;10413.062824345694;12814.80777788334;12870.613881583567;12938.547150849676;12953.417096230693;12979;6450.2259728831905;6501.187351581052;6620.966895165493;6718.361755633207;6970.128733908262;5966.582339236299;5972.25346831646;6122.448979591769;6625.536212465081;6764.458843292525;4193.559676233952;4235;4246;4252.192083504125;4320.762358070274;1709.538424625344;1793.7219730941724;1794.0493631270715;1811.2483319422292;1837;847.8346722389198;951.6811868024151;952.8713623660856;961.5192403798101;971.7764914069803;16972.915135424242;17404;17846.5538361542;18037.278508859497;18242.908785455988;818.8321394114192;823.8022874510075;849.8130411309502;863.9870401943975;940.1632547033146;9760.560774765152;9814.116729494379;10102.949485252673;10109.443980581138;10146.898531014744;392818;393154;403385;404229;404236;80381;82650.58674706588;83118;83147.58426207831;83463.5826820862;878.1964502480287;896.9910300897038;909.6907051602487;912.2382810353297;938.1322276893845;15341.6164595886;15816.683666326839;15833.762493562375;15910.7613385797;16329.510114696579;34195.82902085473;35184.824075879456;36162.8191859039;36340;37510.24979500449;50645;51397.22904156366;51918.22122668087;52076.47923520716;52210.47789522056;7226.89159662616;7937.2459616336355;7993.320567751806;8011.319037881845;8087.069986951341;8901.154390332907;11390.544378224778;11839.93337992788;11957.521699131938;12321.07591930591;4502.3471596618965;9884.11043006133;10553.841692374774;10645.095166910589;10715.35707857531;10181.236407269633;10230.335028223142;10453.895461045293;10593.417362045162;10704.250702451065;10313.845292320471;10435.060844524029;10646.787064258826;10651.733706657396;10845.240833141605;7792.922070779447;7810.726624568113;7822.4524283299625;7919.84160316802;8075.676972921252;9464.858027129736;9684.806303874024;10272.640457583948;10750.354978701303;10957.56169753201 01:34:48 INFO - PROCESS | 19080 | |3;mootools.html;1204.0367705835329;1387.8681525255101;1408.3521580073166;1503.932323045463;1702.9744553831695;6684.7326106955725;7695.5767432791245;8032.598370081487;8034.5982700865015;8041.638126284317;7709.498882572629;7884.448088633783;7889.5266284023;7895.8026049348655;7896.368290536758;2222.4554984028937;2237.7874101960288;2255.751867294596;2263.422827179067;2263.569921714869;2214.3799736073925;2237.6196046672103;2261.412032871449;2263.694401255826;2268.5349503351854;2232.1294695068937;2234.1733558583346;2239.4401399650087;2242.1816037146405;2242.7532971373134;2205.228170140454;2206.415299945516;2219.079082180893;2234.452559123009;2235.3517479930883;2207.404000919759;2209.712737344135;2211.635080211763;2219.4451387153213;2220.0231897964845;7456.664450099758;7631.465797394185;7850.293473587348;7944.642491087915;7947.324477419368;4484.2376795944765;4643.2802915548145;4649.558291962258;4651.511591282901;4655.25515917455;2771.251762024242;2971.004713420985;3049.35963447674;3052.206426329148;3070.2324418895278;906.1243226521104;908.3823000359753;925.2228128372133;927.633584734033;935.7473482159846;10417.739556511073;10680.519376627994;10700.357978521235;10713.83929241062;10738.677839664744;4247.086876321606;4345.608895199384;4391.8682439526865;4393.956060439418;4437.445319335083;9027.368084234173;9131.223845973167;9134.132257435533;9135.588898499584;9138.680146194984;4734.19518681825;4737.407824021997;4769.475357710649;4779.832705855348;4798.760061996886;3610.4042832932796;3732.757370770891;4051.210014047291;4271.9786401067795;4337.392765012901;3639.454081887738;3704.629537046274;3732.328180927459;3820.465134881119;3926.234384295035;1196.4675719304826;1200.8919197272287;1201.7956947318976;1214.2107630040368;1215.7021529725098;701.8666453373945;738.903942487484;774.8798936164903;784.9646765895549;840.9579521023925;5070.391553013662;5201.817936372209;5233.685978841282;5295.735213239323;5363.544098751572;839.8194388206565;866.4108406283788;870.6125774030622;886.3618194899661;910.0990019880271;3536.487209354629;3581.6776490116013;3621.1128273572617;3700.3524383232825;3771.6039815819495;9474.715758527254;9655.903440965641;9740.853887191697;9752.463614501128;9855.162311203485;9715.222782177409;9735.610575577039;9739.220862330996;9740.951295243478;9741.220702343937;6885.380315771505;7228.602426866572;7245.166805817293;7412.7776166714;7418.035655364768;5120.308758317579;5389.353277606556;5517.806876759294;5526.50261476469;5581.888362232814;8698.260647845003;8856.557172141496;8884.555772211494;8899.599518021576;8996.775080623036;8969.775755606162;9007.909920900707;9084.273258139465;9097.590608422504;9126.954365228132;6040.577159598786;6266.561340706106;6274.466670333073;6447.6453795041725;6481.125048118633;7431.591262480615;7520.661570229244;7551.886721699069;7560.735374261874;7566.167721550735;6518.315576864361;6679.1984961802955;6762.459003279628;6821.658917054227;6822;6804.353586409283;6825.283345248876;6870.965645171742;6930.5148639594745;6980.092587963532;5925.140854575976;6142.57002009855;6159.414855588891;6168.19813424252;6243.875122497434;4521.412216411977;4528.162289976365;4535.97732011351;4599.333096700892;4603.907921841612;4426.690131690751;4474.395956545824;4496.2755402212315;4544.568266014723;4548.499665036909 01:34:48 INFO - PROCESS | 19080 | |4;prototype.html;304.3775479145148;308.19407250041144;314.7702177410492;319.76497274503237;323.18396049973813;4905.901881962363;4954.7274899880495;4959.925601115986;4972.975135124319;4994.1260279451135;4511.345854851044;4713.835015774449;4751.738654374008;4780.354652121962;4849.199882019462;3891.319019171641;3898.434726964588;3905.5899130591306;3907.9448548891783;3926.6073392660646;3916.7649941003488;3918.4318273850417;3920.3531417316253;3923.3526468132723;3945.506811648544;3691.3724666806575;3742.2889650966367;3878.7478813877005;3900.4734360861203;3918.2555314490296;3871.2257548490416;3880.5149356330458;3898.0449789801396;3904.1606054698377;3934.6065393460713;3473.895783126485;3481.756277060607;3496.160921378876;3500.527428797105;3501.9824900875587;4730;4770.212914869043;4824.831130910401;4850.927236091461;4851.902961940777;4409.272470042439;4429.320261241966;4450.977745111286;4463.464384273875;4476.4180656514445;5073.619478539087;5094.821681241176;5096.108181068335;5109.693418394908;5124.309737387864;3543.326767914088;3788.882279727487;3798.3542797724454;3814.771113733185;3829.8468061277795;5301.761420736076;5324.361076670785;5351.411344752035;5352.866178345573;5364.22218778275;3738.6261373862394;3753.7935413551972;3772.5850156482766;3779.848806047727;3796.7911764853197;3805.1628641699335;3840.4815349927403;3865.9420108697827;3871.9612803872164;3881.184951160288;4126.711130220856;4329.458817647794;4346.6088052075465;4370.278903980871;4404.273294906305;5111.514406131411;5111.897762044739;5120.820771272987;5136.280920671109;5139.922901156486;1282.4421376701164;1331.7469680760626;1360.8775210230929;1364.1405914273944;1375.931203439824;861.4529773593813;890.3589415620743;903.8430808565047;917.2663665671886;921.6820197032014;4047.352423612208;4065.4918135233097;4075.2053349596545;4077;4088.509378874554;4657.85882458793;4675.111728771522;4692.835750748775;4699.637105239511;4735.786889589976;4024.8869343594847;4074.4517083508076;4107.281225785476;4107.568705285962;4110.807865718968;2338.97661023391;2519.596864501671;2520.407704189514;2521.6217567365043;2531.4304281536506;4356.782160891943;4401.273789824707;4408.412971330318;4410.448693913261;4444.755538445352;4755.785989630475;4781.95218047822;4828.179209534387;4833.347498087714;4844.32179494871;4394.692371533962;4534.523874993144;4592.749552719143;5040.420351659606;5042.9243561345875;5288.101022826052;5313.582320044293;5317.494837990384;5354.196870469461;5375.435579264121;5247.449017853223;5263.578913686973;5279.973600131974;5285.260063591178;5319.494648008433;4817.349657796152;4936.4683822259785;4964.131277026434;4993.700377977333;5001.374828146481;3719.888403347904;3743.7753734776;3762.774233545996;3799.943000854934;3800.2969450651717;5125.744672344156;5278.788848446019;5302.257683924331;5334.893302133858;5336.493033161843;4947.381577302837;5147.532953108496;5151.459096794782;5165.354330708661;5199.610029247897;5125.4362020177;5147.330846990018;5173.671847668489;5190.195519694454;5190.6107041971245;4862.610991120631;5057.620678449204;5075.2387141929;5098.643094983316;5116.334876466036;5143.331366922276;5171.431142574239;5175;5180.145276029413;5214.608904332266;5057.443681195139;5073.797048118034;5125.128728116155;5133.6919784813035;5143.3056537368475 01:34:48 INFO - PROCESS | 19080 | |5;yui.html;624.2914292278268;629.8992161254197;641.740095261419;642.4250295985094;725.1117381208021;12025.21836080654;13032.478700851954;13039.608811735652;13052.282124483161;13095.934520327384;12125.393730313494;12353.567625133122;12841.42213600388;12880.67798305043;12889.742205155891;629.31404768802;641.3938827807724;776.1694986364593;786.0959896119451;805.5408417202198;793.8848866914294;802.1336956087412;804.4770898915722;804.5977011494252;806.8305655812286;848.5841937450666;850.6809946270149;851.2891735400948;851.6040041380757;851.8849955256023;655.9278479367242;672.8385187555001;674.7267356720536;675.8040168351172;847.4957400346784;578.4735890339771;603.405645439242;604.8911195984721;606.130203158469;606.7330374635146;11637.12721545879;11648.59229926957;11652.475638596283;11658.941705291503;11679.240849344851;11977.760444791142;12038.939805300917;12326.5069397224;12355;12406.19359741623;9840.507974601242;9985.350952188084;10103.949480252626;10862.78274434507;11017.173711971634;4210.305299625558;4227.239096962546;4265.509466411371;4332.176886391576;4421.159979603865;59691;59817;60738.69630651863;61576.68963172535;62217.68891155515;9775.560099795526;10271.435071071013;10292.228082893813;10433.2696711231;10467.738306542245;18944.81055189458;19098.2360705573;19267.132979015976;19292.517687057934;19328.4201473956;6629.966850165815;6750.932490675031;6786.626735529593;6843.213030501556;7053.92946070543;3517.4185103281284;3541.964580354215;3611.819409029538;3703.6481534254203;3711;2970.910872673823;3084.383123375289;3085.382923415326;3086.52158915364;3088.042706760911;507.75120191106095;517.6376536424518;539.8488423241498;540.8837100023513;547.843864498616;488.697007855125;530.771768139696;584.9444302791313;589.775885163635;598.4793229890023;7482.139553951257;7586.506877052974;7608.174038230784;7732.768016959388;8468.576571171418;560.2324815003471;580.2447596022067;581.9912701309484;592.8191901470007;606.8755905039457;3794.8102594870147;3981.064449854282;4370.169667763115;4593.598952319575;4725.1967165581245;99242.5037874806;101733;102701.48649256855;103093.48453257685;103437.48281258545;50926.49073509217;51365.486345136815;53392.199117013275;84962;87509.5624521886;50503.74748126309;74010;76324;76527;76627.23372766201;8472;8553.486790792573;8621.310295176245;8659;8815.250703690259;45759.77120114378;46005.76997115127;46233.30650040185;46585.534144659476;47760;63302;69719.65140174267;71910.77516822258;72735.27264727496;72834.27165728275;10458.581656733646;11632.767344653228;11680.824787628022;11786.941065294961;11961.342126182795;11518.884811151782;11670.299782013106;11756.82364764512;12953.481860725466;13409.864579450863;7776.92223077762;9566.856497152687;10782.299150555189;12829.23024618526;13026.804597931228;11170.832437513282;11568.24806387582;11609.3614851184;11725.296482211095;11733.120015998664;11046.723831904266;11101.278416902875;11312.660620181408;11553.306801591596;12175.939120304341;9107.271418286653;9282.535873206178;9382.960232551104;9726.465044422624;9877.456739879375;9830.655927042519;10112.443815589919;10193.949030254802;10194.235432342455;10200 01:34:48 INFO - PROCESS | 19080 | __end_tp_report 01:34:48 INFO - PROCESS | 19080 | __start_cc_report 01:34:48 INFO - PROCESS | 19080 | _x_x_mozilla_cycle_collect,1096 01:34:48 INFO - PROCESS | 19080 | __end_cc_report 01:34:48 INFO - PROCESS | 19080 | __startTimestamp1467016488922__endTimestamp 01:34:48 INFO - PROCESS | 19080 | 01:34:48 INFO - PROCESS | 19080 | ------- Summary: start ------- 01:34:48 INFO - PROCESS | 19080 | Number of tests: 6 01:34:48 INFO - PROCESS | 19080 | 01:34:48 INFO - PROCESS | 19080 | [#0] dojo.html Cycles:165 Average:4716.02 Median:4834.37 stddev:499.38 (10.3%) stddev-sans-first:471.64 01:34:48 INFO - PROCESS | 19080 | Values: 2568.6 2581.5 2612.4 2623.3 2626.9 4611.3 4667.2 4672.6 4693.9 4760.7 4704.6 4718.9 4732.6 4751.3 4802.9 4147.6 4319.7 4400.8 4428.1 4519.3 4443.5 4482.3 4493.0 4501.3 4523.1 4315.2 4368.3 4378.5 4430.7 4441.3 4365.6 4375.6 4384.1 4435.9 4440.0 4372.3 4379.5 4386.8 4390.1 4422.8 4677.3 4693.6 4716.6 4726.5 4773.1 5047.3 5050.3 5077.0 5091.3 5100.5 5102.8 5137.4 5141.4 5145.8 5147.2 4611.4 4665.7 4733.9 4751.9 4759.0 5170.9 5188.7 5251.6 5252.1 5261.8 4892.3 4952.8 5016.4 5017.1 5021.5 5069.6 5109.2 5109.8 5123.6 5192.6 5089.4 5093.2 5104.5 5108.6 5149.4 4969.1 5081.7 5089.8 5094.7 5096.8 4326.5 4332.9 4336.5 4341.8 4432.0 3803.8 3812.9 3813.1 3854.7 3862.8 4412.9 4415.7 4416.6 4418.0 4463.1 4974.3 5027.7 5029.2 5044.0 5102.8 4352.1 4365.5 4370.9 4375.1 4416.2 4540.7 4618.3 4619.7 4620.5 4649.5 4783.8 4814.9 4833.1 4834.4 4881.4 5106.6 5134.1 5137.7 5138.2 5190.2 4678.3 4783.0 4827.2 4832.5 4879.5 5058.3 5083.3 5098.0 5098.9 5124.4 5183.3 5183.5 5188.9 5193.9 5240.9 4883.6 4886.6 5035.0 5040.2 5047.1 4899.5 4955.7 4966.1 4968.5 5016.1 4880.2 4933.5 4935.5 4936.3 4940.6 4870.1 4957.9 5019.4 5022.8 5035.3 4869.7 4888.6 4895.0 4925.3 4945.1 01:34:48 INFO - PROCESS | 19080 | 01:34:48 INFO - PROCESS | 19080 | [#1] ext.html Cycles:180 Average:48950.02 Median:18587.79 stddev:88517.44 (476.2%) stddev-sans-first:88691.16 01:34:48 INFO - PROCESS | 19080 | Values: 548.8 586.4 587.8 588.1 603.6 27278.0 27883.3 30131.2 40149.0 40333.4 37385.6 37789.2 37805.8 41094.2 41187.8 7863.9 8010.4 8018.7 8021.1 8022.6 7515.8 7873.3 9776.2 10316.3 10333.8 10409.9 10447.2 10495.8 10504.5 10529.1 10243.3 10295.9 10300.5 10302.2 10303.3 10095.6 10141.8 10173.4 10217.4 10287.2 39690.8 39925.6 39991.4 40065.6 40071.4 2956.7 2977.4 2998.6 3287.8 3685.6 29672.4 30346.8 30423.0 30721.0 31044.5 3247.8 3259.7 3302.1 3347.0 3372.9 258518.0 258734.0 259134.0 259268.0 259357.0 54896.5 55434.4 55467.0 55521.4 55552.4 58226.0 58231.0 58330.0 58333.0 58359.7 14294.9 14390.9 14429.2 14510.9 14603.6 9792.3 10125.4 11134.3 11222.6 11226.7 14850.3 14917.8 14999.8 16310.3 16882.4 5480.6 5932.9 5972.9 6089.5 6243.2 835.6 891.7 902.0 943.2 981.9 28094.6 28288.9 28456.6 28500.7 29101.7 949.4 952.4 957.7 996.5 1015.4 14735.6 14985.0 15035.8 15144.7 15432.8 397660.0 398859.0 400481.0 401015.0 403551.0 49819.3 49955.3 50079.0 50081.7 50148.5 1180.5 1191.5 1206.4 1211.0 1218.2 26144.6 27422.7 28189.2 28199.6 28463.1 43793.6 43845.3 44076.1 44124.1 44186.3 330584.0 333831.0 335391.0 335920.0 336540.0 24939.0 26014.5 26379.1 37534.4 37765.4 34426.5 35824.0 43032.0 44418.0 44507.6 36699.0 36811.0 37582.0 38002.4 38307.0 37138.4 37170.6 37549.2 37721.0 37786.2 36340.0 36851.4 37731.4 37756.6 37930.8 30936.7 33251.3 33277.0 33613.3 33802.7 25123.6 25606.9 25862.6 25906.6 26222.2 01:34:48 INFO - PROCESS | 19080 | 01:34:48 INFO - PROCESS | 19080 | [#2] jquery.html Cycles:180 Average:24744.33 Median:204214.78 stddev:66056.23 (32.3%) stddev-sans-first:66216.18 01:34:48 INFO - PROCESS | 19080 | Values: 367.8 373.2 376.6 387.5 388.9 15670.3 16422.8 17047.5 17244.9 17265.3 16199.3 16576.0 17388.9 17424.6 17436.9 4938.7 5120.7 5146.4 5156.0 5156.1 3753.9 3945.2 5049.3 5596.4 5899.9 5921.1 5921.2 5947.8 5950.5 5963.3 5761.3 5860.4 5948.6 5960.9 6066.6 3319.0 5021.1 5324.2 5327.3 5332.0 20072.8 20616.6 20658.0 21260.1 21296.8 1659.9 1949.4 1954.2 1984.9 2004.4 9662.7 9926.8 10353.8 12060.5 12987.6 1653.8 1703.7 1726.9 1741.3 1748.8 66377.7 69684.3 69922.7 69960.0 70946.6 9512.4 9594.7 9790.8 10347.8 10413.1 12814.8 12870.6 12938.5 12953.4 12979.0 6450.2 6501.2 6621.0 6718.4 6970.1 5966.6 5972.3 6122.4 6625.5 6764.5 4193.6 4235.0 4246.0 4252.2 4320.8 1709.5 1793.7 1794.0 1811.2 1837.0 847.8 951.7 952.9 961.5 971.8 16972.9 17404.0 17846.6 18037.3 18242.9 818.8 823.8 849.8 864.0 940.2 9760.6 9814.1 10102.9 10109.4 10146.9 392818.0 393154.0 403385.0 404229.0 404236.0 80381.0 82650.6 83118.0 83147.6 83463.6 878.2 897.0 909.7 912.2 938.1 15341.6 15816.7 15833.8 15910.8 16329.5 34195.8 35184.8 36162.8 36340.0 37510.2 50645.0 51397.2 51918.2 52076.5 52210.5 7226.9 7937.2 7993.3 8011.3 8087.1 8901.2 11390.5 11839.9 11957.5 12321.1 4502.3 9884.1 10553.8 10645.1 10715.4 10181.2 10230.3 10453.9 10593.4 10704.3 10313.8 10435.1 10646.8 10651.7 10845.2 7792.9 7810.7 7822.5 7919.8 8075.7 9464.9 9684.8 10272.6 10750.4 10957.6 01:34:48 INFO - PROCESS | 19080 | 01:34:48 INFO - PROCESS | 19080 | [#3] mootools.html Cycles:180 Average:5151.81 Median:5376.45 stddev:2871.07 (53.4%) stddev-sans-first:2863.79 01:34:48 INFO - PROCESS | 19080 | Values: 1204.0 1387.9 1408.4 1503.9 1703.0 6684.7 7695.6 8032.6 8034.6 8041.6 7709.5 7884.4 7889.5 7895.8 7896.4 2222.5 2237.8 2255.8 2263.4 2263.6 2214.4 2237.6 2261.4 2263.7 2268.5 2232.1 2234.2 2239.4 2242.2 2242.8 2205.2 2206.4 2219.1 2234.5 2235.4 2207.4 2209.7 2211.6 2219.4 2220.0 7456.7 7631.5 7850.3 7944.6 7947.3 4484.2 4643.3 4649.6 4651.5 4655.3 2771.3 2971.0 3049.4 3052.2 3070.2 906.1 908.4 925.2 927.6 935.7 10417.7 10680.5 10700.4 10713.8 10738.7 4247.1 4345.6 4391.9 4394.0 4437.4 9027.4 9131.2 9134.1 9135.6 9138.7 4734.2 4737.4 4769.5 4779.8 4798.8 3610.4 3732.8 4051.2 4272.0 4337.4 3639.5 3704.6 3732.3 3820.5 3926.2 1196.5 1200.9 1201.8 1214.2 1215.7 701.9 738.9 774.9 785.0 841.0 5070.4 5201.8 5233.7 5295.7 5363.5 839.8 866.4 870.6 886.4 910.1 3536.5 3581.7 3621.1 3700.4 3771.6 9474.7 9655.9 9740.9 9752.5 9855.2 9715.2 9735.6 9739.2 9741.0 9741.2 6885.4 7228.6 7245.2 7412.8 7418.0 5120.3 5389.4 5517.8 5526.5 5581.9 8698.3 8856.6 8884.6 8899.6 8996.8 8969.8 9007.9 9084.3 9097.6 9127.0 6040.6 6266.6 6274.5 6447.6 6481.1 7431.6 7520.7 7551.9 7560.7 7566.2 6518.3 6679.2 6762.5 6821.7 6822.0 6804.4 6825.3 6871.0 6930.5 6980.1 5925.1 6142.6 6159.4 6168.2 6243.9 4521.4 4528.2 4536.0 4599.3 4603.9 4426.7 4474.4 4496.3 4544.6 4548.5 01:34:48 INFO - PROCESS | 19080 | 01:34:48 INFO - PROCESS | 19080 | [#4] prototype.html Cycles:180 Average:4201.69 Median:4683.97 stddev:1210.65 (25.8%) stddev-sans-first:1178.17 01:34:48 INFO - PROCESS | 19080 | Values: 304.4 308.2 314.8 319.8 323.2 4905.9 4954.7 4959.9 4973.0 4994.1 4511.3 4713.8 4751.7 4780.4 4849.2 3891.3 3898.4 3905.6 3907.9 3926.6 3916.8 3918.4 3920.4 3923.4 3945.5 3691.4 3742.3 3878.7 3900.5 3918.3 3871.2 3880.5 3898.0 3904.2 3934.6 3473.9 3481.8 3496.2 3500.5 3502.0 4730.0 4770.2 4824.8 4850.9 4851.9 4409.3 4429.3 4451.0 4463.5 4476.4 5073.6 5094.8 5096.1 5109.7 5124.3 3543.3 3788.9 3798.4 3814.8 3829.8 5301.8 5324.4 5351.4 5352.9 5364.2 3738.6 3753.8 3772.6 3779.8 3796.8 3805.2 3840.5 3865.9 3872.0 3881.2 4126.7 4329.5 4346.6 4370.3 4404.3 5111.5 5111.9 5120.8 5136.3 5139.9 1282.4 1331.7 1360.9 1364.1 1375.9 861.5 890.4 903.8 917.3 921.7 4047.4 4065.5 4075.2 4077.0 4088.5 4657.9 4675.1 4692.8 4699.6 4735.8 4024.9 4074.5 4107.3 4107.6 4110.8 2339.0 2519.6 2520.4 2521.6 2531.4 4356.8 4401.3 4408.4 4410.4 4444.8 4755.8 4782.0 4828.2 4833.3 4844.3 4394.7 4534.5 4592.7 5040.4 5042.9 5288.1 5313.6 5317.5 5354.2 5375.4 5247.4 5263.6 5280.0 5285.3 5319.5 4817.3 4936.5 4964.1 4993.7 5001.4 3719.9 3743.8 3762.8 3799.9 3800.3 5125.7 5278.8 5302.3 5334.9 5336.5 4947.4 5147.5 5151.5 5165.4 5199.6 5125.4 5147.3 5173.7 5190.2 5190.6 4862.6 5057.6 5075.2 5098.6 5116.3 5143.3 5171.4 5175.0 5180.1 5214.6 5057.4 5073.8 5125.1 5133.7 5143.3 01:34:48 INFO - PROCESS | 19080 | 01:34:48 INFO - PROCESS | 19080 | [#5] yui.html Cycles:180 Average:17406.15 Median:25717.12 stddev:24956.72 (97.0%) stddev-sans-first:24994.92 01:34:48 INFO - PROCESS | 19080 | Values: 624.3 629.9 641.7 642.4 725.1 12025.2 13032.5 13039.6 13052.3 13095.9 12125.4 12353.6 12841.4 12880.7 12889.7 629.3 641.4 776.2 786.1 805.5 793.9 802.1 804.5 804.6 806.8 848.6 850.7 851.3 851.6 851.9 655.9 672.8 674.7 675.8 847.5 578.5 603.4 604.9 606.1 606.7 11637.1 11648.6 11652.5 11658.9 11679.2 11977.8 12038.9 12326.5 12355.0 12406.2 9840.5 9985.4 10103.9 10862.8 11017.2 4210.3 4227.2 4265.5 4332.2 4421.2 59691.0 59817.0 60738.7 61576.7 62217.7 9775.6 10271.4 10292.2 10433.3 10467.7 18944.8 19098.2 19267.1 19292.5 19328.4 6630.0 6750.9 6786.6 6843.2 7053.9 3517.4 3542.0 3611.8 3703.6 3711.0 2970.9 3084.4 3085.4 3086.5 3088.0 507.8 517.6 539.8 540.9 547.8 488.7 530.8 584.9 589.8 598.5 7482.1 7586.5 7608.2 7732.8 8468.6 560.2 580.2 582.0 592.8 606.9 3794.8 3981.1 4370.2 4593.6 4725.2 99242.5 101733.0 102701.5 103093.5 103437.5 50926.5 51365.5 53392.2 84962.0 87509.6 50503.7 74010.0 76324.0 76527.0 76627.2 8472.0 8553.5 8621.3 8659.0 8815.3 45759.8 46005.8 46233.3 46585.5 47760.0 63302.0 69719.7 71910.8 72735.3 72834.3 10458.6 11632.8 11680.8 11786.9 11961.3 11518.9 11670.3 11756.8 12953.5 13409.9 7776.9 9566.9 10782.3 12829.2 13026.8 11170.8 11568.2 11609.4 11725.3 11733.1 11046.7 11101.3 11312.7 11553.3 12175.9 9107.3 9282.5 9383.0 9726.5 9877.5 9830.7 10112.4 10193.9 10194.2 10200.0 01:34:48 INFO - PROCESS | 19080 | -------- Summary: end -------- 01:34:48 INFO - PROCESS | 19080 | 01:34:49 INFO - TEST-INFO | 19080: exit 0 01:34:49 INFO - TEST-OK | dromaeo_css | took 1120031ms 01:34:49 INFO - TEST-START | kraken 01:34:49 INFO - operating with platform_type : linux_ 01:34:49 INFO - Initialising browser for kraken test... 01:34:49 INFO - TEST-INFO | started process 19262 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBZ7iFM/profile http://localhost:32935/getInfo.html) 01:34:54 INFO - PROCESS | 19262 | __metrics Screen width/height:1600/1200 01:34:54 INFO - PROCESS | 19262 | colorDepth:24 01:34:54 INFO - PROCESS | 19262 | Browser inner width/height: 1024/697 01:34:54 INFO - PROCESS | 19262 | __metrics 01:34:55 INFO - PROCESS | 19262 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:34:56 INFO - TEST-INFO | 19262: exit 0 01:34:56 INFO - Browser initialized. 01:34:56 INFO - Running cycle 1/1 for kraken test... 01:34:56 INFO - TEST-INFO | started process 19343 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBZ7iFM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:35:08 INFO - PROCESS | 19343 | RSS: Main: 176013312 01:35:08 INFO - PROCESS | 19343 | 01:35:10 INFO - PROCESS | 19343 | Cycle 1(1): loaded http://localhost:32935/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32935/tests/kraken/driver.html?testName=audio-beat-detection) 01:35:11 INFO - PROCESS | 19343 | RSS: Main: 233795584 01:35:11 INFO - PROCESS | 19343 | 01:35:14 INFO - PROCESS | 19343 | Cycle 1(1): loaded http://localhost:32935/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32935/tests/kraken/driver.html?testName=audio-dft) 01:35:15 INFO - PROCESS | 19343 | RSS: Main: 221642752 01:35:15 INFO - PROCESS | 19343 | 01:35:18 INFO - PROCESS | 19343 | Cycle 1(1): loaded http://localhost:32935/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32935/tests/kraken/driver.html?testName=audio-fft) 01:35:19 INFO - PROCESS | 19343 | RSS: Main: 287584256 01:35:19 INFO - PROCESS | 19343 | 01:35:21 INFO - PROCESS | 19343 | Cycle 1(1): loaded http://localhost:32935/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32935/tests/kraken/driver.html?testName=audio-oscillator) 01:35:21 INFO - PROCESS | 19343 | RSS: Main: 197722112 01:35:21 INFO - PROCESS | 19343 | 01:35:24 INFO - PROCESS | 19343 | Cycle 1(1): loaded http://localhost:32935/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32935/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:35:24 INFO - PROCESS | 19343 | RSS: Main: 201863168 01:35:24 INFO - PROCESS | 19343 | 01:35:27 INFO - PROCESS | 19343 | Cycle 1(1): loaded http://localhost:32935/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32935/tests/kraken/driver.html?testName=imaging-darkroom) 01:35:28 INFO - PROCESS | 19343 | RSS: Main: 238116864 01:35:28 INFO - PROCESS | 19343 | 01:35:31 INFO - PROCESS | 19343 | Cycle 1(1): loaded http://localhost:32935/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32935/tests/kraken/driver.html?testName=imaging-desaturate) 01:35:32 INFO - PROCESS | 19343 | RSS: Main: 233680896 01:35:32 INFO - PROCESS | 19343 | 01:35:35 INFO - PROCESS | 19343 | Cycle 1(1): loaded http://localhost:32935/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32935/tests/kraken/driver.html?testName=json-parse-financial) 01:35:36 INFO - PROCESS | 19343 | RSS: Main: 236802048 01:35:36 INFO - PROCESS | 19343 | 01:35:37 INFO - PROCESS | 19343 | Cycle 1(1): loaded http://localhost:32935/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32935/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:35:38 INFO - PROCESS | 19343 | RSS: Main: 222539776 01:35:38 INFO - PROCESS | 19343 | 01:35:40 INFO - PROCESS | 19343 | Cycle 1(1): loaded http://localhost:32935/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32935/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:35:40 INFO - PROCESS | 19343 | RSS: Main: 229179392 01:35:40 INFO - PROCESS | 19343 | 01:35:43 INFO - PROCESS | 19343 | Cycle 1(1): loaded http://localhost:32935/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32935/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:35:43 INFO - PROCESS | 19343 | RSS: Main: 235331584 01:35:43 INFO - PROCESS | 19343 | 01:35:46 INFO - PROCESS | 19343 | Cycle 1(1): loaded http://localhost:32935/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32935/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:35:47 INFO - PROCESS | 19343 | RSS: Main: 252321792 01:35:47 INFO - PROCESS | 19343 | 01:35:50 INFO - PROCESS | 19343 | Cycle 1(1): loaded http://localhost:32935/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32935/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:35:50 INFO - PROCESS | 19343 | RSS: Main: 245030912 01:35:50 INFO - PROCESS | 19343 | 01:35:52 INFO - PROCESS | 19343 | Cycle 1(1): loaded http://localhost:32935/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32935/tests/kraken/driver.html?testName=ai-astar) 01:35:52 INFO - PROCESS | 19343 | RSS: Main: 288284672 01:35:52 INFO - PROCESS | 19343 | 01:35:52 INFO - PROCESS | 19343 | __start_tp_report 01:35:52 INFO - PROCESS | 19343 | _x_x_mozilla_page_load 01:35:52 INFO - PROCESS | 19343 | _x_x_mozilla_page_load_details 01:35:52 INFO - PROCESS | 19343 | |i|pagename|runs| 01:35:52 INFO - PROCESS | 19343 | |0;ai-astar;105;114;114;114;115;113;113;111;112;114 01:35:52 INFO - PROCESS | 19343 | |1;audio-beat-detection;167;130;132;191;135;135;151;130;203;138 01:35:52 INFO - PROCESS | 19343 | |2;audio-dft;162;163;160;162;163;160;160;162;163;162 01:35:52 INFO - PROCESS | 19343 | |3;audio-fft;75;77;76;115;76;77;76;75;101;75 01:35:52 INFO - PROCESS | 19343 | |4;audio-oscillator;85;88;116;87;88;87;124;86;86;131 01:35:52 INFO - PROCESS | 19343 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;117;117;117 01:35:52 INFO - PROCESS | 19343 | |6;imaging-darkroom;146;146;147;147;147;147;147;147;147;146 01:35:52 INFO - PROCESS | 19343 | |7;imaging-desaturate;95;95;95;95;95;95;95;96;95;96 01:35:52 INFO - PROCESS | 19343 | |8;json-parse-financial;63;64;64;63;63;64;63;63;63;62 01:35:52 INFO - PROCESS | 19343 | |9;json-stringify-tinderbox;64;64;64;64;64;65;64;65;64;65 01:35:52 INFO - PROCESS | 19343 | |10;stanford-crypto-aes;81;84;81;81;87;83;87;89;142;87 01:35:52 INFO - PROCESS | 19343 | |11;stanford-crypto-ccm;131;134;127;141;134;127;127;128;130;133 01:35:52 INFO - PROCESS | 19343 | |12;stanford-crypto-pbkdf2;165;164;164;172;168;164;163;165;167;168 01:35:52 INFO - PROCESS | 19343 | |13;stanford-crypto-sha256-iterative;67;67;67;66;66;66;65;65;65;68 01:35:52 INFO - PROCESS | 19343 | __end_tp_report 01:35:52 INFO - PROCESS | 19343 | __start_cc_report 01:35:52 INFO - PROCESS | 19343 | _x_x_mozilla_cycle_collect,1904 01:35:52 INFO - PROCESS | 19343 | __end_cc_report 01:35:52 INFO - PROCESS | 19343 | __startTimestamp1467016552619__endTimestamp 01:35:52 INFO - PROCESS | 19343 | 01:35:52 INFO - PROCESS | 19343 | ------- Summary: start ------- 01:35:52 INFO - PROCESS | 19343 | Number of tests: 14 01:35:52 INFO - PROCESS | 19343 | 01:35:52 INFO - PROCESS | 19343 | [#0] ai-astar Cycles:10 Average:112.50 Median:114.00 stddev:2.88 (2.5%) stddev-sans-first:1.22 01:35:52 INFO - PROCESS | 19343 | Values: 105.0 114.0 114.0 114.0 115.0 113.0 113.0 111.0 112.0 114.0 01:35:52 INFO - PROCESS | 19343 | 01:35:52 INFO - PROCESS | 19343 | [#1] audio-beat-detection Cycles:10 Average:151.20 Median:144.50 stddev:26.84 (18.6%) stddev-sans-first:27.85 01:35:52 INFO - PROCESS | 19343 | Values: 167.0 130.0 132.0 191.0 135.0 135.0 151.0 130.0 203.0 138.0 01:35:52 INFO - PROCESS | 19343 | 01:35:52 INFO - PROCESS | 19343 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.25 (0.8%) stddev-sans-first:1.32 01:35:52 INFO - PROCESS | 19343 | Values: 162.0 163.0 160.0 162.0 163.0 160.0 160.0 162.0 163.0 162.0 01:35:52 INFO - PROCESS | 19343 | 01:35:52 INFO - PROCESS | 19343 | [#3] audio-fft Cycles:10 Average:82.30 Median:76.00 stddev:13.96 (18.4%) stddev-sans-first:14.56 01:35:52 INFO - PROCESS | 19343 | Values: 75.0 77.0 76.0 115.0 76.0 77.0 76.0 75.0 101.0 75.0 01:35:52 INFO - PROCESS | 19343 | 01:35:52 INFO - PROCESS | 19343 | [#4] audio-oscillator Cycles:10 Average:97.80 Median:86.50 stddev:18.22 (21.1%) stddev-sans-first:18.73 01:35:52 INFO - PROCESS | 19343 | Values: 85.0 88.0 116.0 87.0 88.0 87.0 124.0 86.0 86.0 131.0 01:35:52 INFO - PROCESS | 19343 | 01:35:52 INFO - PROCESS | 19343 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 01:35:52 INFO - PROCESS | 19343 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 01:35:52 INFO - PROCESS | 19343 | 01:35:52 INFO - PROCESS | 19343 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 01:35:52 INFO - PROCESS | 19343 | Values: 146.0 146.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 146.0 01:35:52 INFO - PROCESS | 19343 | 01:35:52 INFO - PROCESS | 19343 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 01:35:52 INFO - PROCESS | 19343 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 01:35:52 INFO - PROCESS | 19343 | 01:35:52 INFO - PROCESS | 19343 | [#8] json-parse-financial Cycles:10 Average:63.20 Median:63.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 01:35:52 INFO - PROCESS | 19343 | Values: 63.0 64.0 64.0 63.0 63.0 64.0 63.0 63.0 63.0 62.0 01:35:52 INFO - PROCESS | 19343 | 01:35:52 INFO - PROCESS | 19343 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 01:35:52 INFO - PROCESS | 19343 | Values: 64.0 64.0 64.0 64.0 64.0 65.0 64.0 65.0 64.0 65.0 01:35:52 INFO - PROCESS | 19343 | 01:35:52 INFO - PROCESS | 19343 | [#10] stanford-crypto-aes Cycles:10 Average:90.20 Median:85.50 stddev:18.44 (21.6%) stddev-sans-first:19.25 01:35:52 INFO - PROCESS | 19343 | Values: 81.0 84.0 81.0 81.0 87.0 83.0 87.0 89.0 142.0 87.0 01:35:52 INFO - PROCESS | 19343 | 01:35:52 INFO - PROCESS | 19343 | [#11] stanford-crypto-ccm Cycles:10 Average:131.20 Median:132.00 stddev:4.47 (3.4%) stddev-sans-first:4.74 01:35:52 INFO - PROCESS | 19343 | Values: 131.0 134.0 127.0 141.0 134.0 127.0 127.0 128.0 130.0 133.0 01:35:52 INFO - PROCESS | 19343 | 01:35:52 INFO - PROCESS | 19343 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.00 Median:166.00 stddev:2.75 (1.7%) stddev-sans-first:2.89 01:35:52 INFO - PROCESS | 19343 | Values: 165.0 164.0 164.0 172.0 168.0 164.0 163.0 165.0 167.0 168.0 01:35:52 INFO - PROCESS | 19343 | 01:35:52 INFO - PROCESS | 19343 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.50 stddev:1.03 (1.6%) stddev-sans-first:1.05 01:35:52 INFO - PROCESS | 19343 | Values: 67.0 67.0 67.0 66.0 66.0 66.0 65.0 65.0 65.0 68.0 01:35:52 INFO - PROCESS | 19343 | -------- Summary: end -------- 01:35:52 INFO - PROCESS | 19343 | 01:35:53 INFO - TEST-INFO | 19343: exit 0 01:35:53 INFO - TEST-OK | kraken | took 63933ms 01:35:53 INFO - SUITE-END | took 1183s 01:35:53 INFO - Completed test suite (00:19:44) 01:35:53 INFO - javascript benchmark 01:35:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2568.5505036618592, 2581.5095131924945, 2612.425266441382, 2623.304824221582, 2626.868656567171, 4611.262198048313, 4667.235963584974, 4672.602828759559, 4693.8591842244705, 4760.69055511392, 4704.576588107069, 4718.9292160617615, 4732.550407711271, 4751.287306903966, 4802.855914322576, 4147.585241475844, 4319.7192182508115, 4400.845970391037, 4428.136513379876, 4519.3446950192365, 4443.511213766499, 4482.305242687373, 4492.955070449303, 4501.279795232764, 4523.140603285382, 4315.180115777992, 4368.257396242647, 4378.5183629800695, 4430.6676999224865, 4441.333799930004, 4365.585269399402, 4375.562443755631, 4384.12317536494, 4435.889102772424, 4439.955600443986, 4372.256716358227, 4379.540148284448, 4386.8025938832825, 4390.100029493978, 4422.84520041797, 4677.298405239208, 4693.624510039189, 4716.575508204278, 4726.456457507396, 4773.093112308685, 5047.318611987372, 5050.343455350818, 5077.035363280965, 5091.312672789163, 5100.515451032146, 5102.770375333119, 5137.383513978347, 5141.38303403594, 5145.76844042019, 5147.22791581262, 4611.423572053493, 4665.6734028617675, 4733.881652958635, 4751.881202969884, 4758.952410475851, 5170.948290517047, 5188.662736922088, 5251.632385733038, 5252.080885844962, 5261.815836445782, 4892.339534162914, 4952.826651067267, 5016.398032236082, 5017.071841709296, 5021.49785021495, 5069.5690866276045, 5109.182530795129, 5109.770060347293, 5123.590112790967, 5192.636515443958, 5089.389273287229, 5093.18509038552, 5104.515071068243, 5108.597578301425, 5149.382074151126, 4969.130402179604, 5081.745912704424, 5089.821856235014, 5094.719790411489, 5096.796128154906, 4326.480822301344, 4332.870013899588, 4336.544662810423, 4341.761203133795, 4431.977840110843, 3803.7907915064384, 3812.942805857914, 3813.065798879237, 3854.69162467002, 3862.8454861805776, 4412.889677758082, 4415.66882483815, 4416.580424859633, 4417.977910110493, 4463.085067561142, 4974.253861920741, 5027.748612569357, 5029.220470827027, 5044.041632089891, 5102.770375333044, 4352.064306174188, 4365.497967733688, 4370.8907277317685, 4375.124975005012, 4416.205083085076, 4540.72755634663, 4618.330342100377, 4619.676622636383, 4620.468646105741, 4649.511801260886, 4783.784729687103, 4814.927776083291, 4833.10587541306, 4834.371531700856, 4881.414230292387, 5106.642535022513, 5134.075866344094, 5137.6660517066275, 5138.229265610188, 5190.247414124855, 4678.274867395559, 4783.04339132168, 4827.179379505563, 4832.492588278321, 4879.536444037811, 5058.342415485963, 5083.262926875656, 5097.974510127426, 5098.872528186825, 5124.385073791169, 5183.300254465599, 5183.455737147545, 5188.870278243074, 5193.92209116856, 5240.947590524046, 4883.60931125502, 4886.584640305472, 5034.974825125851, 5040.168372218543, 5047.116754567863, 4899.461059283547, 4955.702657840541, 4966.130927087673, 4968.527989840959, 5016.072026675077, 4880.170371036861, 4933.506649335038, 4935.531124543163, 4936.308916751729, 4940.629452791127, 4870.05034018363, 4957.876053098557, 5019.422766381913, 5022.84931452057, 5035.29505869186, 4869.732164730974, 4888.633352498506, 4895.04546613407, 4925.261210818406, 4945.060438516671], "value": 4683.33805437238, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.8300212002935, 586.4282324733384, 587.8354060862955, 588.1266319515521, 603.6438501284243, 27278.0, 27883.30291742705, 30131.24671883201, 40149.0, 40333.39499907496, 37385.62614373862, 37789.24421511568, 37805.81097094511, 41094.17811643765, 41187.79406102973, 7863.92136078639, 8010.39922005849, 8018.719344822933, 8021.077576078738, 8022.638981245858, 7515.849683006337, 7873.330766884793, 9776.217902567812, 10316.329438586468, 10333.844992325121, 10409.947950260239, 10447.16422686187, 10495.842562361571, 10504.527296271648, 10529.105026072793, 10243.282970192053, 10295.897041029568, 10300.536475858604, 10302.175825933908, 10303.27877048607, 10095.596176153018, 10141.797164056752, 10173.389596624227, 10217.438040907748, 10287.228457865614, 39690.801545992086, 39925.60074399248, 39991.40012899809, 40065.59934400648, 40071.39892901609, 2956.659984101834, 2977.374751302229, 2998.5502174673757, 3287.7698561100733, 3685.5577330720216, 29672.40655186884, 30346.848265758752, 30423.0, 30721.0, 31044.53433198504, 3247.772655914087, 3259.7392208623255, 3302.108430723691, 3347.029361485166, 3372.915677108092, 258517.9999999981, 258734.0, 259134.0, 259268.0, 259357.0, 54896.45103548913, 55434.445655543735, 55467.0, 55521.44478555163, 55552.44447555554, 58226.0, 58231.0, 58330.0, 58333.0, 58359.70820145872, 14294.857051429353, 14390.856091439162, 14429.206393648241, 14510.927445362917, 14603.634909127357, 9792.314537982415, 10125.392476451436, 11134.331940083459, 11222.607208747655, 11226.719332016764, 14850.331735071948, 14917.776233356508, 14999.775003374958, 16310.266038028318, 16882.409115680894, 5480.561555075585, 5932.911006334908, 5972.862429396916, 6089.451949324582, 6243.219597550306, 835.6406745099665, 891.6968230801558, 902.0258121229057, 943.2312665177858, 981.8625392445064, 28094.578581321297, 28288.858555707502, 28456.61735305853, 28500.714992850222, 29101.708982910324, 949.3544389814854, 952.4475804033644, 957.698325027614, 996.4818294486827, 1015.4110615842793, 14735.55793326202, 14985.0, 15035.774463383059, 15144.697106057818, 15432.84567154314, 397660.01169993967, 398859.0, 400481.0, 401014.9898501036, 403551.0, 49819.25271120936, 49955.25067123996, 50079.0, 50081.74959125181, 50148.49851501511, 1180.5454899863614, 1191.4876603060768, 1206.3968015992004, 1210.9697257568455, 1218.1716432825763, 26144.60783088293, 27422.725772742815, 28189.154325370273, 28199.577006344512, 28463.146105616866, 43793.56206437895, 43845.342319865864, 44076.11847762963, 44124.11751765011, 44186.337204942596, 330584.0, 333831.0, 335391.0, 335920.0, 336540.0, 24939.0, 26014.479710406064, 26379.076732314275, 37534.43698344582, 37765.4335184967, 34426.48360274548, 35824.0, 43032.0, 44418.0, 44507.55492445034, 36699.0, 36811.0, 37582.0, 38002.42996355112, 38307.0, 37138.44292335671, 37170.62829371672, 37549.24901502009, 37721.0, 37786.24427511489, 36340.0, 36851.44722829106, 37731.43402849014, 37756.62243377531, 37930.81034594809, 30936.69063309338, 33251.33497330088, 33277.0, 33613.327733444705, 33802.661973380935, 25123.623145652466, 25606.871965640054, 25862.61206081948, 25906.61140082938, 26222.213333600022], "value": 18106.568958164007, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.80873945548313, 373.15666593498685, 376.6252578684209, 387.471101945844, 388.94749208856797, 15670.294836732346, 16422.75365869513, 17047.48857534273, 17244.913775431138, 17265.30938762448, 16199.271032803523, 16576.0, 17388.913055434736, 17424.56438589036, 17436.912815435906, 4938.6542941993985, 5120.743962801845, 5146.40816306124, 5156.046131465672, 5156.097682905495, 3753.8738378486482, 3945.2109578084355, 5049.3435853339015, 5596.4123767004285, 5899.941000589982, 5921.141434491996, 5921.171036054934, 5947.762089516415, 5950.494207992326, 5963.254593175853, 5761.251037365158, 5860.384659610765, 5948.643081415107, 5960.91058634123, 6066.636001839904, 3318.983405082959, 5021.14640511114, 5324.1747529133045, 5327.254184414185, 5332.0, 20072.79927200724, 20616.587668246702, 20658.0, 21260.14959401622, 21296.787032129636, 1659.8921070130523, 1949.3679667408326, 1954.2378472395776, 1984.9404517864486, 2004.4287378097172, 9662.661806836726, 9926.751831204278, 10353.844692329621, 12060.495803859547, 12987.61037168877, 1653.8346165383487, 1703.735920932245, 1726.9395571154948, 1741.2860727101954, 1748.7551742756025, 66377.66811165962, 69684.3031569683, 69922.65038674825, 69959.99999999949, 70946.64526677334, 9512.429254244767, 9594.66418675343, 9790.755231119136, 10347.844782328271, 10413.062824345694, 12814.80777788334, 12870.613881583567, 12938.547150849676, 12953.417096230693, 12979.0, 6450.2259728831905, 6501.187351581052, 6620.966895165493, 6718.361755633207, 6970.128733908262, 5966.582339236299, 5972.25346831646, 6122.448979591769, 6625.536212465081, 6764.458843292525, 4193.559676233952, 4235.0, 4246.0, 4252.192083504125, 4320.762358070274, 1709.538424625344, 1793.7219730941724, 1794.0493631270715, 1811.2483319422292, 1837.0, 847.8346722389198, 951.6811868024151, 952.8713623660856, 961.5192403798101, 971.7764914069803, 16972.915135424242, 17404.0, 17846.5538361542, 18037.278508859497, 18242.908785455988, 818.8321394114192, 823.8022874510075, 849.8130411309502, 863.9870401943975, 940.1632547033146, 9760.560774765152, 9814.116729494379, 10102.949485252673, 10109.443980581138, 10146.898531014744, 392818.0, 393154.0, 403385.0, 404229.0, 404236.0, 80381.0, 82650.58674706588, 83118.0, 83147.58426207831, 83463.5826820862, 878.1964502480287, 896.9910300897038, 909.6907051602487, 912.2382810353297, 938.1322276893845, 15341.6164595886, 15816.683666326839, 15833.762493562375, 15910.7613385797, 16329.510114696579, 34195.82902085473, 35184.824075879456, 36162.8191859039, 36340.0, 37510.24979500449, 50645.0, 51397.22904156366, 51918.22122668087, 52076.47923520716, 52210.47789522056, 7226.89159662616, 7937.2459616336355, 7993.320567751806, 8011.319037881845, 8087.069986951341, 8901.154390332907, 11390.544378224778, 11839.93337992788, 11957.521699131938, 12321.07591930591, 4502.3471596618965, 9884.11043006133, 10553.841692374774, 10645.095166910589, 10715.35707857531, 10181.236407269633, 10230.335028223142, 10453.895461045293, 10593.417362045162, 10704.250702451065, 10313.845292320471, 10435.060844524029, 10646.787064258826, 10651.733706657396, 10845.240833141605, 7792.922070779447, 7810.726624568113, 7822.4524283299625, 7919.84160316802, 8075.676972921252, 9464.858027129736, 9684.806303874024, 10272.640457583948, 10750.354978701303, 10957.56169753201], "value": 8226.904785293596, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1204.0367705835329, 1387.8681525255101, 1408.3521580073166, 1503.932323045463, 1702.9744553831695, 6684.7326106955725, 7695.5767432791245, 8032.598370081487, 8034.5982700865015, 8041.638126284317, 7709.498882572629, 7884.448088633783, 7889.5266284023, 7895.8026049348655, 7896.368290536758, 2222.4554984028937, 2237.7874101960288, 2255.751867294596, 2263.422827179067, 2263.569921714869, 2214.3799736073925, 2237.6196046672103, 2261.412032871449, 2263.694401255826, 2268.5349503351854, 2232.1294695068937, 2234.1733558583346, 2239.4401399650087, 2242.1816037146405, 2242.7532971373134, 2205.228170140454, 2206.415299945516, 2219.079082180893, 2234.452559123009, 2235.3517479930883, 2207.404000919759, 2209.712737344135, 2211.635080211763, 2219.4451387153213, 2220.0231897964845, 7456.664450099758, 7631.465797394185, 7850.293473587348, 7944.642491087915, 7947.324477419368, 4484.2376795944765, 4643.2802915548145, 4649.558291962258, 4651.511591282901, 4655.25515917455, 2771.251762024242, 2971.004713420985, 3049.35963447674, 3052.206426329148, 3070.2324418895278, 906.1243226521104, 908.3823000359753, 925.2228128372133, 927.633584734033, 935.7473482159846, 10417.739556511073, 10680.519376627994, 10700.357978521235, 10713.83929241062, 10738.677839664744, 4247.086876321606, 4345.608895199384, 4391.8682439526865, 4393.956060439418, 4437.445319335083, 9027.368084234173, 9131.223845973167, 9134.132257435533, 9135.588898499584, 9138.680146194984, 4734.19518681825, 4737.407824021997, 4769.475357710649, 4779.832705855348, 4798.760061996886, 3610.4042832932796, 3732.757370770891, 4051.210014047291, 4271.9786401067795, 4337.392765012901, 3639.454081887738, 3704.629537046274, 3732.328180927459, 3820.465134881119, 3926.234384295035, 1196.4675719304826, 1200.8919197272287, 1201.7956947318976, 1214.2107630040368, 1215.7021529725098, 701.8666453373945, 738.903942487484, 774.8798936164903, 784.9646765895549, 840.9579521023925, 5070.391553013662, 5201.817936372209, 5233.685978841282, 5295.735213239323, 5363.544098751572, 839.8194388206565, 866.4108406283788, 870.6125774030622, 886.3618194899661, 910.0990019880271, 3536.487209354629, 3581.6776490116013, 3621.1128273572617, 3700.3524383232825, 3771.6039815819495, 9474.715758527254, 9655.903440965641, 9740.853887191697, 9752.463614501128, 9855.162311203485, 9715.222782177409, 9735.610575577039, 9739.220862330996, 9740.951295243478, 9741.220702343937, 6885.380315771505, 7228.602426866572, 7245.166805817293, 7412.7776166714, 7418.035655364768, 5120.308758317579, 5389.353277606556, 5517.806876759294, 5526.50261476469, 5581.888362232814, 8698.260647845003, 8856.557172141496, 8884.555772211494, 8899.599518021576, 8996.775080623036, 8969.775755606162, 9007.909920900707, 9084.273258139465, 9097.590608422504, 9126.954365228132, 6040.577159598786, 6266.561340706106, 6274.466670333073, 6447.6453795041725, 6481.125048118633, 7431.591262480615, 7520.661570229244, 7551.886721699069, 7560.735374261874, 7566.167721550735, 6518.315576864361, 6679.1984961802955, 6762.459003279628, 6821.658917054227, 6822.0, 6804.353586409283, 6825.283345248876, 6870.965645171742, 6930.5148639594745, 6980.092587963532, 5925.140854575976, 6142.57002009855, 6159.414855588891, 6168.19813424252, 6243.875122497434, 4521.412216411977, 4528.162289976365, 4535.97732011351, 4599.333096700892, 4603.907921841612, 4426.690131690751, 4474.395956545824, 4496.2755402212315, 4544.568266014723, 4548.499665036909], "value": 4154.275823048888, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.3775479145148, 308.19407250041144, 314.7702177410492, 319.76497274503237, 323.18396049973813, 4905.901881962363, 4954.7274899880495, 4959.925601115986, 4972.975135124319, 4994.1260279451135, 4511.345854851044, 4713.835015774449, 4751.738654374008, 4780.354652121962, 4849.199882019462, 3891.319019171641, 3898.434726964588, 3905.5899130591306, 3907.9448548891783, 3926.6073392660646, 3916.7649941003488, 3918.4318273850417, 3920.3531417316253, 3923.3526468132723, 3945.506811648544, 3691.3724666806575, 3742.2889650966367, 3878.7478813877005, 3900.4734360861203, 3918.2555314490296, 3871.2257548490416, 3880.5149356330458, 3898.0449789801396, 3904.1606054698377, 3934.6065393460713, 3473.895783126485, 3481.756277060607, 3496.160921378876, 3500.527428797105, 3501.9824900875587, 4730.0, 4770.212914869043, 4824.831130910401, 4850.927236091461, 4851.902961940777, 4409.272470042439, 4429.320261241966, 4450.977745111286, 4463.464384273875, 4476.4180656514445, 5073.619478539087, 5094.821681241176, 5096.108181068335, 5109.693418394908, 5124.309737387864, 3543.326767914088, 3788.882279727487, 3798.3542797724454, 3814.771113733185, 3829.8468061277795, 5301.761420736076, 5324.361076670785, 5351.411344752035, 5352.866178345573, 5364.22218778275, 3738.6261373862394, 3753.7935413551972, 3772.5850156482766, 3779.848806047727, 3796.7911764853197, 3805.1628641699335, 3840.4815349927403, 3865.9420108697827, 3871.9612803872164, 3881.184951160288, 4126.711130220856, 4329.458817647794, 4346.6088052075465, 4370.278903980871, 4404.273294906305, 5111.514406131411, 5111.897762044739, 5120.820771272987, 5136.280920671109, 5139.922901156486, 1282.4421376701164, 1331.7469680760626, 1360.8775210230929, 1364.1405914273944, 1375.931203439824, 861.4529773593813, 890.3589415620743, 903.8430808565047, 917.2663665671886, 921.6820197032014, 4047.352423612208, 4065.4918135233097, 4075.2053349596545, 4077.0, 4088.509378874554, 4657.85882458793, 4675.111728771522, 4692.835750748775, 4699.637105239511, 4735.786889589976, 4024.8869343594847, 4074.4517083508076, 4107.281225785476, 4107.568705285962, 4110.807865718968, 2338.97661023391, 2519.596864501671, 2520.407704189514, 2521.6217567365043, 2531.4304281536506, 4356.782160891943, 4401.273789824707, 4408.412971330318, 4410.448693913261, 4444.755538445352, 4755.785989630475, 4781.95218047822, 4828.179209534387, 4833.347498087714, 4844.32179494871, 4394.692371533962, 4534.523874993144, 4592.749552719143, 5040.420351659606, 5042.9243561345875, 5288.101022826052, 5313.582320044293, 5317.494837990384, 5354.196870469461, 5375.435579264121, 5247.449017853223, 5263.578913686973, 5279.973600131974, 5285.260063591178, 5319.494648008433, 4817.349657796152, 4936.4683822259785, 4964.131277026434, 4993.700377977333, 5001.374828146481, 3719.888403347904, 3743.7753734776, 3762.774233545996, 3799.943000854934, 3800.2969450651717, 5125.744672344156, 5278.788848446019, 5302.257683924331, 5334.893302133858, 5336.493033161843, 4947.381577302837, 5147.532953108496, 5151.459096794782, 5165.354330708661, 5199.610029247897, 5125.4362020177, 5147.330846990018, 5173.671847668489, 5190.195519694454, 5190.6107041971245, 4862.610991120631, 5057.620678449204, 5075.2387141929, 5098.643094983316, 5116.334876466036, 5143.331366922276, 5171.431142574239, 5175.0, 5180.145276029413, 5214.608904332266, 5057.443681195139, 5073.797048118034, 5125.128728116155, 5133.6919784813035, 5143.3056537368475], "value": 3824.807335208927, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [624.2914292278268, 629.8992161254197, 641.740095261419, 642.4250295985094, 725.1117381208021, 12025.21836080654, 13032.478700851954, 13039.608811735652, 13052.282124483161, 13095.934520327384, 12125.393730313494, 12353.567625133122, 12841.42213600388, 12880.67798305043, 12889.742205155891, 629.31404768802, 641.3938827807724, 776.1694986364593, 786.0959896119451, 805.5408417202198, 793.8848866914294, 802.1336956087412, 804.4770898915722, 804.5977011494252, 806.8305655812286, 848.5841937450666, 850.6809946270149, 851.2891735400948, 851.6040041380757, 851.8849955256023, 655.9278479367242, 672.8385187555001, 674.7267356720536, 675.8040168351172, 847.4957400346784, 578.4735890339771, 603.405645439242, 604.8911195984721, 606.130203158469, 606.7330374635146, 11637.12721545879, 11648.59229926957, 11652.475638596283, 11658.941705291503, 11679.240849344851, 11977.760444791142, 12038.939805300917, 12326.5069397224, 12355.0, 12406.19359741623, 9840.507974601242, 9985.350952188084, 10103.949480252626, 10862.78274434507, 11017.173711971634, 4210.305299625558, 4227.239096962546, 4265.509466411371, 4332.176886391576, 4421.159979603865, 59691.0, 59817.0, 60738.69630651863, 61576.68963172535, 62217.68891155515, 9775.560099795526, 10271.435071071013, 10292.228082893813, 10433.2696711231, 10467.738306542245, 18944.81055189458, 19098.2360705573, 19267.132979015976, 19292.517687057934, 19328.4201473956, 6629.966850165815, 6750.932490675031, 6786.626735529593, 6843.213030501556, 7053.92946070543, 3517.4185103281284, 3541.964580354215, 3611.819409029538, 3703.6481534254203, 3711.0, 2970.910872673823, 3084.383123375289, 3085.382923415326, 3086.52158915364, 3088.042706760911, 507.75120191106095, 517.6376536424518, 539.8488423241498, 540.8837100023513, 547.843864498616, 488.697007855125, 530.771768139696, 584.9444302791313, 589.775885163635, 598.4793229890023, 7482.139553951257, 7586.506877052974, 7608.174038230784, 7732.768016959388, 8468.576571171418, 560.2324815003471, 580.2447596022067, 581.9912701309484, 592.8191901470007, 606.8755905039457, 3794.8102594870147, 3981.064449854282, 4370.169667763115, 4593.598952319575, 4725.1967165581245, 99242.5037874806, 101733.0, 102701.48649256855, 103093.48453257685, 103437.48281258545, 50926.49073509217, 51365.486345136815, 53392.199117013275, 84962.0, 87509.5624521886, 50503.74748126309, 74010.0, 76324.0, 76527.0, 76627.23372766201, 8472.0, 8553.486790792573, 8621.310295176245, 8659.0, 8815.250703690259, 45759.77120114378, 46005.76997115127, 46233.30650040185, 46585.534144659476, 47760.0, 63302.0, 69719.65140174267, 71910.77516822258, 72735.27264727496, 72834.27165728275, 10458.581656733646, 11632.767344653228, 11680.824787628022, 11786.941065294961, 11961.342126182795, 11518.884811151782, 11670.299782013106, 11756.82364764512, 12953.481860725466, 13409.864579450863, 7776.92223077762, 9566.856497152687, 10782.299150555189, 12829.23024618526, 13026.804597931228, 11170.832437513282, 11568.24806387582, 11609.3614851184, 11725.296482211095, 11733.120015998664, 11046.723831904266, 11101.278416902875, 11312.660620181408, 11553.306801591596, 12175.939120304341, 9107.271418286653, 9282.535873206178, 9382.960232551104, 9726.465044422624, 9877.456739879375, 9830.655927042519, 10112.443815589919, 10193.949030254802, 10194.235432342455, 10200.0], "value": 6506.742526303267, "unit": "score"}], "name": "dromaeo_css", "value": 6451.952844950962, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 114.0, 114.0, 115.0, 113.0, 113.0, 111.0, 112.0, 114.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 130.0, 132.0, 191.0, 135.0, 135.0, 151.0, 130.0, 203.0, 138.0], "value": 151.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 160.0, 162.0, 163.0, 160.0, 160.0, 162.0, 163.0, 162.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 115.0, 76.0, 77.0, 76.0, 75.0, 101.0, 75.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 88.0, 116.0, 87.0, 88.0, 87.0, 124.0, 86.0, 86.0, 131.0], "value": 97.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 63.0, 63.0, 64.0, 63.0, 63.0, 63.0, 62.0], "value": 63.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 65.0, 64.0, 65.0], "value": 64.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 84.0, 81.0, 81.0, 87.0, 83.0, 87.0, 89.0, 142.0, 87.0], "value": 90.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 134.0, 127.0, 141.0, 134.0, 127.0, 127.0, 128.0, 130.0, 133.0], "value": 131.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 164.0, 172.0, 168.0, 164.0, 163.0, 165.0, 167.0, 168.0], "value": 166.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 66.0, 66.0, 66.0, 65.0, 65.0, 65.0, 68.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1545.4, "alertThreshold": 2.0}]} 01:35:53 INFO - Return code: 0 01:35:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:35:53 INFO - # TBPL SUCCESS # 01:35:53 INFO - Running post-action listener: _resource_record_post_action 01:35:53 INFO - ##### 01:35:53 INFO - ##### Finished run-tests step (success) 01:35:53 INFO - ##### 01:35:53 INFO - Running post-run listener: _resource_record_post_run 01:35:53 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 534716416; Read time: 20; Write time: 520300 01:35:53 INFO - TinderboxPrint: CPU usage
13.2% 01:35:53 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 01:35:53 INFO - TinderboxPrint: I/O write bytes / time
534,716,416 / 520,300 01:35:53 INFO - TinderboxPrint: CPU idle
8,317.2 (86.8%) 01:35:53 INFO - TinderboxPrint: CPU user
1,218.2 (12.7%) 01:35:53 INFO - TinderboxPrint: Swap in / out
0 / 0 01:35:53 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 246026240; Read time: 0; Write time: 369288 01:35:54 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288690176; Read time: 20; Write time: 151012 01:35:54 INFO - Running post-run listener: _upload_blobber_files 01:35:54 INFO - Blob upload gear active. 01:35:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:35:54 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 01:35:54 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'] 01:35:54 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 01:35:54 INFO - (blobuploader) - INFO - Open directory for files ... 01:35:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:35:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:35:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:35:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:35:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:35:56 INFO - (blobuploader) - INFO - Done attempting. 01:35:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:35:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:35:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:36:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:36:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:36:00 INFO - (blobuploader) - INFO - Done attempting. 01:36:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:36:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:36:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:36:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:36:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:36:01 INFO - (blobuploader) - INFO - Done attempting. 01:36:01 INFO - (blobuploader) - INFO - Iteration through files over. 01:36:01 INFO - Return code: 0 01:36:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:36:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:36:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0461c3524c3b68883a549cf7362e794838a05f12d8fded44f39e3c376782cc564740a10f3147502c18e9fe1024454b13ba9845491c3b54c1cbb921be90f14053", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/60898e7a54162ece71fad0e120c69a82149fdf606e0d0f8a5b587bcf9690e7abf73ed4e1a322b8ab87beb826af4f0052fee1076a27e189da380e0c645a2dd399", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e80b3f3955d0a531e2057b676879e9cf4c282bf2622f97af723c23084e7241e07cacb824a3997f9aabc9229928a8e3bfa8a783b7fb2fc99e93baef0cac0663f4"} 01:36:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:36:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:36:01 INFO - Contents: 01:36:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0461c3524c3b68883a549cf7362e794838a05f12d8fded44f39e3c376782cc564740a10f3147502c18e9fe1024454b13ba9845491c3b54c1cbb921be90f14053", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/60898e7a54162ece71fad0e120c69a82149fdf606e0d0f8a5b587bcf9690e7abf73ed4e1a322b8ab87beb826af4f0052fee1076a27e189da380e0c645a2dd399", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e80b3f3955d0a531e2057b676879e9cf4c282bf2622f97af723c23084e7241e07cacb824a3997f9aabc9229928a8e3bfa8a783b7fb2fc99e93baef0cac0663f4"} 01:36:01 INFO - Running post-run listener: copy_logs_to_upload_dir 01:36:01 INFO - Copying logs to upload dir... 01:36:01 INFO - mkdir: /builds/slave/test/build/upload/logs 01:36:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.277518 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-06-27 01:36:01.071571) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 01:36:01.074667) ========= 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=cbe409c6de289db6ac707de3000001d4-1467005458.683549-2082024030 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/0461c3524c3b68883a549cf7362e794838a05f12d8fded44f39e3c376782cc564740a10f3147502c18e9fe1024454b13ba9845491c3b54c1cbb921be90f14053", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/60898e7a54162ece71fad0e120c69a82149fdf606e0d0f8a5b587bcf9690e7abf73ed4e1a322b8ab87beb826af4f0052fee1076a27e189da380e0c645a2dd399", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e80b3f3955d0a531e2057b676879e9cf4c282bf2622f97af723c23084e7241e07cacb824a3997f9aabc9229928a8e3bfa8a783b7fb2fc99e93baef0cac0663f4"} build_url:https://queue.taskcluster.net/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011306 build_url: 'https://queue.taskcluster.net/v1/task/Ugx9dUH5Qu-3aJR2Ul1Grw/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/0461c3524c3b68883a549cf7362e794838a05f12d8fded44f39e3c376782cc564740a10f3147502c18e9fe1024454b13ba9845491c3b54c1cbb921be90f14053", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/60898e7a54162ece71fad0e120c69a82149fdf606e0d0f8a5b587bcf9690e7abf73ed4e1a322b8ab87beb826af4f0052fee1076a27e189da380e0c645a2dd399", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e80b3f3955d0a531e2057b676879e9cf4c282bf2622f97af723c23084e7241e07cacb824a3997f9aabc9229928a8e3bfa8a783b7fb2fc99e93baef0cac0663f4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 01:36:01.103692) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 01:36:01.104258) ========= 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=cbe409c6de289db6ac707de3000001d4-1467005458.683549-2082024030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004529 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 01:36:01.186994) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 01:36:01.187721) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 01:36:01.188343) ========= ========= Total master_lag: 0.18 =========