builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-061 starttime: 1465837100.58 results: success (0) buildid: 20160613092325 builduid: f57264c95e704d569c2fe96878ceaf82 revision: ea5833a015a141c08d9d63b768841af97287033f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-13 09:58:20.584499) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-13 09:58:20.584988) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-13 09:58:20.585312) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-13 09:58:20.619725) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 09:58:20.620021) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1465836397.985122-1928431301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-13 09:58:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.9M=0s 2016-06-13 09:58:21 (42.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120189 ========= master_lag: 0.23 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 09:58:20.966890) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 09:58:20.967230) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1465836397.985122-1928431301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019055 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 09:58:21.022958) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 09:58:21.023312) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ea5833a015a141c08d9d63b768841af97287033f --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 ea5833a015a141c08d9d63b768841af97287033f --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=516f8d7ca085b4d087ab0a71000001a4-1465836397.985122-1928431301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-13 09:58:21,686 truncating revision to first 12 chars 2016-06-13 09:58:21,686 Setting DEBUG logging. 2016-06-13 09:58:21,686 attempt 1/10 2016-06-13 09:58:21,686 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ea5833a015a1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-13 09:58:22,039 unpacking tar archive at: fx-team-ea5833a015a1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.690788 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 09:58:21.730321) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-13 09:58:21.730637) ========= script_repo_revision: ea5833a015a141c08d9d63b768841af97287033f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-13 09:58:21.731032) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-13 09:58:21.731304) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-13 09:58:21.741919) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-06-13 09:58:21.742203) ========= /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=516f8d7ca085b4d087ab0a71000001a4-1465836397.985122-1928431301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:58:22 INFO - MultiFileLogger online at 20160613 09:58:22 in /builds/slave/test 09:58:22 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 09:58:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:58:22 INFO - {'append_to_log': False, 09:58:22 INFO - 'base_work_dir': '/builds/slave/test', 09:58:22 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:58:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:58:22 INFO - 'branch': 'Fx-Team-Non-PGO', 09:58:22 INFO - 'buildbot_json_path': 'buildprops.json', 09:58:22 INFO - 'config_files': ('talos/linux_config.py',), 09:58:22 INFO - 'default_actions': ('clobber', 09:58:22 INFO - 'read-buildbot-config', 09:58:22 INFO - 'download-and-extract', 09:58:22 INFO - 'populate-webroot', 09:58:22 INFO - 'create-virtualenv', 09:58:22 INFO - 'install', 09:58:22 INFO - 'run-tests'), 09:58:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:58:22 INFO - 'download_minidump_stackwalk': True, 09:58:22 INFO - 'download_symbols': 'ondemand', 09:58:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:58:22 INFO - 'tooltool.py': '/tools/tooltool.py', 09:58:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:58:22 INFO - '/tools/misc-python/virtualenv.py')}, 09:58:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:58:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:58:22 INFO - 'installer_path': 'installer.exe', 09:58:22 INFO - 'log_level': 'info', 09:58:22 INFO - 'log_name': 'talos', 09:58:22 INFO - 'log_to_console': True, 09:58:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:58:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:58:22 INFO - 'opt_config_files': (), 09:58:22 INFO - 'pip_index': False, 09:58:22 INFO - 'sps_profile': False, 09:58:22 INFO - 'sps_profile_interval': 0, 09:58:22 INFO - 'suite': 'dromaeojs', 09:58:22 INFO - 'system_bits': '32', 09:58:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:58:22 INFO - 'title': 'talos-linux64-ix-061', 09:58:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:58:22 INFO - 'use_talos_json': True, 09:58:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:58:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:58:22 INFO - 'work_dir': 'build'} 09:58:22 INFO - ##### 09:58:22 INFO - ##### Running clobber step. 09:58:22 INFO - ##### 09:58:22 INFO - Running pre-action listener: _resource_record_pre_action 09:58:22 INFO - Running main action method: clobber 09:58:22 INFO - rmtree: /builds/slave/test/build 09:58:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:58:23 INFO - Running post-action listener: _resource_record_post_action 09:58:23 INFO - ##### 09:58:23 INFO - ##### Finished clobber step (success) 09:58:23 INFO - ##### 09:58:23 INFO - ##### 09:58:23 INFO - ##### Running read-buildbot-config step. 09:58:23 INFO - ##### 09:58:23 INFO - Running pre-action listener: _resource_record_pre_action 09:58:23 INFO - Running main action method: read_buildbot_config 09:58:23 INFO - Using buildbot properties: 09:58:23 INFO - { 09:58:23 INFO - "project": "", 09:58:23 INFO - "product": "firefox", 09:58:23 INFO - "script_repo_revision": "production", 09:58:23 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:58:23 INFO - "repository": "", 09:58:23 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:58:23 INFO - "buildid": "20160613092325", 09:58:23 INFO - "pgo_build": "False", 09:58:23 INFO - "basedir": "/builds/slave/test", 09:58:23 INFO - "buildnumber": 1854, 09:58:23 INFO - "slavename": "talos-linux64-ix-061", 09:58:23 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:58:23 INFO - "platform": "ubuntu64_hw", 09:58:23 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:58:23 INFO - "branch": "fx-team", 09:58:23 INFO - "repo_path": "integration/fx-team", 09:58:23 INFO - "revision": "ea5833a015a141c08d9d63b768841af97287033f", 09:58:23 INFO - "stage_platform": "linux64", 09:58:23 INFO - "builduid": "f57264c95e704d569c2fe96878ceaf82", 09:58:23 INFO - "slavebuilddir": "test" 09:58:23 INFO - } 09:58:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/Zp2JaXMLSJCJjW-t0X0tKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 09:58:23 INFO - Running post-action listener: _resource_record_post_action 09:58:23 INFO - ##### 09:58:23 INFO - ##### Finished read-buildbot-config step (success) 09:58:23 INFO - ##### 09:58:23 INFO - ##### 09:58:23 INFO - ##### Running download-and-extract step. 09:58:23 INFO - ##### 09:58:23 INFO - Running pre-action listener: _resource_record_pre_action 09:58:23 INFO - Running main action method: download_and_extract 09:58:23 INFO - mkdir: /builds/slave/test/build/tests 09:58:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:23 INFO - https://queue.taskcluster.net/v1/task/Zp2JaXMLSJCJjW-t0X0tKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:58:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zp2JaXMLSJCJjW-t0X0tKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:58:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zp2JaXMLSJCJjW-t0X0tKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:58:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zp2JaXMLSJCJjW-t0X0tKg/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 09:58:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zp2JaXMLSJCJjW-t0X0tKg/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 09:58:35 INFO - Downloaded 1361 bytes. 09:58:35 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:58:35 INFO - Using the following test package requirements: 09:58:35 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:58:35 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:58:35 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:58:35 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:35 INFO - u'jsshell-linux-x86_64.zip'], 09:58:35 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:58:35 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:58:35 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:58:35 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:58:35 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:58:35 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:58:35 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:58: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')]} 09:58:35 INFO - https://queue.taskcluster.net/v1/task/Zp2JaXMLSJCJjW-t0X0tKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:58:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zp2JaXMLSJCJjW-t0X0tKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:58:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zp2JaXMLSJCJjW-t0X0tKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:58:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zp2JaXMLSJCJjW-t0X0tKg/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 09:58:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zp2JaXMLSJCJjW-t0X0tKg/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 09:58:37 INFO - Downloaded 22651503 bytes. 09:58:37 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'] 09:58:37 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 09:58:38 INFO - Return code: 0 09:58:38 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 09:58:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:58:38 INFO - https://queue.taskcluster.net/v1/task/Zp2JaXMLSJCJjW-t0X0tKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:58:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zp2JaXMLSJCJjW-t0X0tKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:58:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zp2JaXMLSJCJjW-t0X0tKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:58:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zp2JaXMLSJCJjW-t0X0tKg/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 09:58:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zp2JaXMLSJCJjW-t0X0tKg/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 09:58:39 INFO - Downloaded 22651503 bytes. 09:58:39 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'] 09:58:39 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 09:58:41 INFO - Return code: 0 09:58: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')]} 09:58:41 INFO - https://queue.taskcluster.net/v1/task/Zp2JaXMLSJCJjW-t0X0tKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:58:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zp2JaXMLSJCJjW-t0X0tKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:58:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zp2JaXMLSJCJjW-t0X0tKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:58:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zp2JaXMLSJCJjW-t0X0tKg/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 09:58:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zp2JaXMLSJCJjW-t0X0tKg/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 09:58:42 INFO - Downloaded 14405384 bytes. 09:58:42 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'] 09:58:42 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 09:58:42 INFO - Return code: 0 09:58:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:42 INFO - https://queue.taskcluster.net/v1/task/Zp2JaXMLSJCJjW-t0X0tKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:58:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zp2JaXMLSJCJjW-t0X0tKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:58:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zp2JaXMLSJCJjW-t0X0tKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:58:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zp2JaXMLSJCJjW-t0X0tKg/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 09:58:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zp2JaXMLSJCJjW-t0X0tKg/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 09:58:44 INFO - Downloaded 55399960 bytes. 09:58:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Zp2JaXMLSJCJjW-t0X0tKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:58:44 INFO - mkdir: /builds/slave/test/properties 09:58:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:58:44 INFO - Writing to file /builds/slave/test/properties/build_url 09:58:44 INFO - Contents: 09:58:44 INFO - build_url:https://queue.taskcluster.net/v1/task/Zp2JaXMLSJCJjW-t0X0tKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:58:44 INFO - Running post-action listener: _resource_record_post_action 09:58:44 INFO - Running post-action listener: set_extra_try_arguments 09:58:44 INFO - ##### 09:58:44 INFO - ##### Finished download-and-extract step (success) 09:58:44 INFO - ##### 09:58:44 INFO - ##### 09:58:44 INFO - ##### Running populate-webroot step. 09:58:44 INFO - ##### 09:58:44 INFO - Running pre-action listener: _resource_record_pre_action 09:58:44 INFO - Running main action method: populate_webroot 09:58:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:58:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:58:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:58:44 INFO - '--tppagecycles', 09:58:44 INFO - '7'], 09:58:44 INFO - 'tests': ['tsvgm']}}, 09:58:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:58:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:58:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:58:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:58:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:58:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:58:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:44 INFO - 'talos_options': ['--disable-e10s'], 09:58:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:58:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:58:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:44 INFO - 'talos_options': ['--disable-e10s'], 09:58:44 INFO - 'tests': ['damp', 'tps']}, 09:58:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:44 INFO - 'tests': ['damp', 'tps']}, 09:58:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:58:44 INFO - 'tests': ['dromaeo_dom']}, 09:58:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:58:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:58:44 INFO - 'tests': ['basic_compositor_video']}, 09:58:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:58:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:58:44 INFO - 'tests': ['a11yr', 09:58:44 INFO - 'ts_paint', 09:58:44 INFO - 'tpaint', 09:58:44 INFO - 'sessionrestore', 09:58:44 INFO - 'sessionrestore_no_auto_restore', 09:58:44 INFO - 'tabpaint']}, 09:58:44 INFO - 'other-e10s': {'tests': ['a11yr', 09:58:44 INFO - 'ts_paint', 09:58:44 INFO - 'tpaint', 09:58:44 INFO - 'sessionrestore', 09:58:44 INFO - 'sessionrestore_no_auto_restore', 09:58:44 INFO - 'tabpaint']}, 09:58:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:58:44 INFO - 'ts_paint', 09:58:44 INFO - 'tpaint', 09:58:44 INFO - 'sessionrestore', 09:58:44 INFO - 'sessionrestore_no_auto_restore', 09:58:44 INFO - 'tabpaint']}, 09:58:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:58:44 INFO - 'ts_paint', 09:58:44 INFO - 'tpaint', 09:58:44 INFO - 'sessionrestore', 09:58:44 INFO - 'sessionrestore_no_auto_restore', 09:58:44 INFO - 'tabpaint']}, 09:58:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:58:44 INFO - 'tests': ['a11yr', 09:58:44 INFO - 'ts_paint', 09:58:44 INFO - 'tpaint', 09:58:44 INFO - 'sessionrestore', 09:58:44 INFO - 'sessionrestore_no_auto_restore', 09:58:44 INFO - 'tabpaint']}, 09:58:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:58:44 INFO - 'tests': ['a11yr', 09:58:44 INFO - 'ts_paint', 09:58:44 INFO - 'tpaint', 09:58:44 INFO - 'sessionrestore', 09:58:44 INFO - 'sessionrestore_no_auto_restore', 09:58:44 INFO - 'tabpaint']}, 09:58:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:58:44 INFO - 'tests': ['tsvgx', 09:58:44 INFO - 'tsvgr_opacity', 09:58:44 INFO - 'tart', 09:58:44 INFO - 'tscrollx', 09:58:44 INFO - 'cart']}, 09:58:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:58:44 INFO - 'tsvgr_opacity', 09:58:44 INFO - 'tart', 09:58:44 INFO - 'tscrollx', 09:58:44 INFO - 'cart']}, 09:58:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:44 INFO - 'talos_options': ['--disable-e10s'], 09:58:44 INFO - 'tests': ['tp5o']}, 09:58:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:44 INFO - 'tests': ['tp5o']}, 09:58:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:44 INFO - 'talos_options': ['--disable-e10s', 09:58:44 INFO - '--xperf_path', 09:58:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:58:44 INFO - 'tests': ['tp5n']}, 09:58:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:44 INFO - 'talos_options': ['--xperf_path', 09:58:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:58:44 INFO - 'tests': ['tp5n']}}, 09:58:44 INFO - 'talos.zip': {'path': '', 09:58:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:58:44 INFO - Running post-action listener: _resource_record_post_action 09:58:44 INFO - ##### 09:58:44 INFO - ##### Finished populate-webroot step (success) 09:58:44 INFO - ##### 09:58:44 INFO - ##### 09:58:44 INFO - ##### Running create-virtualenv step. 09:58:44 INFO - ##### 09:58:44 INFO - Running pre-action listener: _resource_record_pre_action 09:58:44 INFO - Running main action method: create_virtualenv 09:58:44 INFO - Creating virtualenv /builds/slave/test/build/venv 09:58:44 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 09:58:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:58:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:58:44 INFO - Using real prefix '/usr' 09:58:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:58:45 INFO - Installing distribute.............................................................................................................................................................................................done. 09:58:47 INFO - Installing pip.................done. 09:58:47 INFO - Return code: 0 09:58:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:58:47 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')]} 09:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:47 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')]} 09:58:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:47 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 0x7fa688a4cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fe1c0>, '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 0x25ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ff550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465836397.985122-1928431301', '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 09:58:47 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 09:58:47 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 09:58:47 INFO - Using env: {'DISPLAY': ':0', 09:58:47 INFO - 'HOME': '/home/cltbld', 09:58:47 INFO - 'LANG': 'en_US.UTF-8', 09:58:47 INFO - 'LANGUAGE': 'en_US:en', 09:58:47 INFO - 'LOGNAME': 'cltbld', 09:58:47 INFO - 'MAIL': '/var/mail/cltbld', 09:58:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:47 INFO - 'MOZ_NO_REMOTE': '1', 09:58:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:47 INFO - 'NO_EM_RESTART': '1', 09:58:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:47 INFO - 'PWD': '/builds/slave/test', 09:58:47 INFO - 'SHELL': '/bin/bash', 09:58:47 INFO - 'SHLVL': '1', 09:58:47 INFO - 'TERM': 'linux', 09:58:47 INFO - 'TMOUT': '86400', 09:58:47 INFO - 'USER': 'cltbld', 09:58:47 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465836397.985122-1928431301', 09:58:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:47 INFO - '_': '/tools/buildbot/bin/python'} 09:58:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:47 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 09:58:47 INFO - Cleaning up... 09:58:47 INFO - Return code: 0 09:58:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:58:47 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')]} 09:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:47 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')]} 09:58:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:47 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 0x7fa688a4cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fe1c0>, '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 0x25ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ff550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465836397.985122-1928431301', '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 09:58:47 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 09:58:47 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 09:58:47 INFO - Using env: {'DISPLAY': ':0', 09:58:47 INFO - 'HOME': '/home/cltbld', 09:58:47 INFO - 'LANG': 'en_US.UTF-8', 09:58:47 INFO - 'LANGUAGE': 'en_US:en', 09:58:47 INFO - 'LOGNAME': 'cltbld', 09:58:47 INFO - 'MAIL': '/var/mail/cltbld', 09:58:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:47 INFO - 'MOZ_NO_REMOTE': '1', 09:58:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:47 INFO - 'NO_EM_RESTART': '1', 09:58:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:47 INFO - 'PWD': '/builds/slave/test', 09:58:47 INFO - 'SHELL': '/bin/bash', 09:58:47 INFO - 'SHLVL': '1', 09:58:47 INFO - 'TERM': 'linux', 09:58:47 INFO - 'TMOUT': '86400', 09:58:47 INFO - 'USER': 'cltbld', 09:58:47 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465836397.985122-1928431301', 09:58:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:47 INFO - '_': '/tools/buildbot/bin/python'} 09:58:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:47 INFO - Downloading/unpacking psutil>=3.1.1 09:58:47 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 09:58:47 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 09:58:47 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 09:58:47 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 09:58:47 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 09:58:47 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 09:58:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:58:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:58:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:58:49 INFO - Installing collected packages: psutil 09:58:49 INFO - Running setup.py install for psutil 09:58:49 INFO - building 'psutil._psutil_linux' extension 09:58:49 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 09:58:50 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 09:58:50 INFO - building 'psutil._psutil_posix' extension 09:58:50 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 09:58:50 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 09:58:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:58:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:58:50 INFO - Successfully installed psutil 09:58:50 INFO - Cleaning up... 09:58:50 INFO - Return code: 0 09:58:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:58:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa688a4cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fe1c0>, '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 0x25ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ff550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465836397.985122-1928431301', '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 09:58:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:58:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:58:50 INFO - Using env: {'DISPLAY': ':0', 09:58:50 INFO - 'HOME': '/home/cltbld', 09:58:50 INFO - 'LANG': 'en_US.UTF-8', 09:58:50 INFO - 'LANGUAGE': 'en_US:en', 09:58:50 INFO - 'LOGNAME': 'cltbld', 09:58:50 INFO - 'MAIL': '/var/mail/cltbld', 09:58:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:50 INFO - 'MOZ_NO_REMOTE': '1', 09:58:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:50 INFO - 'NO_EM_RESTART': '1', 09:58:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:50 INFO - 'PWD': '/builds/slave/test', 09:58:50 INFO - 'SHELL': '/bin/bash', 09:58:50 INFO - 'SHLVL': '1', 09:58:50 INFO - 'TERM': 'linux', 09:58:50 INFO - 'TMOUT': '86400', 09:58:50 INFO - 'USER': 'cltbld', 09:58:50 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465836397.985122-1928431301', 09:58:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:50 INFO - '_': '/tools/buildbot/bin/python'} 09:58:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:58:50 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 09:58:50 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 09:58:50 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 09:58:50 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 09:58:50 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 09:58:50 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 09:58:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:58:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:58:52 INFO - Installing collected packages: mozsystemmonitor 09:58:52 INFO - Running setup.py install for mozsystemmonitor 09:58:52 INFO - Successfully installed mozsystemmonitor 09:58:52 INFO - Cleaning up... 09:58:52 INFO - Return code: 0 09:58:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:58:52 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')]} 09:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:52 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')]} 09:58:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:52 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 0x7fa688a4cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fe1c0>, '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 0x25ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ff550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465836397.985122-1928431301', '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 09:58:52 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 09:58:52 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 09:58:52 INFO - Using env: {'DISPLAY': ':0', 09:58:52 INFO - 'HOME': '/home/cltbld', 09:58:52 INFO - 'LANG': 'en_US.UTF-8', 09:58:52 INFO - 'LANGUAGE': 'en_US:en', 09:58:52 INFO - 'LOGNAME': 'cltbld', 09:58:52 INFO - 'MAIL': '/var/mail/cltbld', 09:58:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:52 INFO - 'MOZ_NO_REMOTE': '1', 09:58:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:52 INFO - 'NO_EM_RESTART': '1', 09:58:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:52 INFO - 'PWD': '/builds/slave/test', 09:58:52 INFO - 'SHELL': '/bin/bash', 09:58:52 INFO - 'SHLVL': '1', 09:58:52 INFO - 'TERM': 'linux', 09:58:52 INFO - 'TMOUT': '86400', 09:58:52 INFO - 'USER': 'cltbld', 09:58:52 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465836397.985122-1928431301', 09:58:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:52 INFO - '_': '/tools/buildbot/bin/python'} 09:58:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:52 INFO - Downloading/unpacking jsonschema==2.5.1 09:58:52 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 09:58:52 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 09:58:52 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 09:58:52 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 09:58:52 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 09:58:52 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 09:58:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:58:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:54 INFO - Downloading functools32-3.2.3-2.tar.gz 09:58:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:58:54 INFO - warning: no files found matching '*.txt' 09:58:54 INFO - no previously-included directories found matching 'build' 09:58:54 INFO - no previously-included directories found matching 'dist' 09:58:54 INFO - no previously-included directories found matching '.git*' 09:58:55 INFO - Installing collected packages: jsonschema, functools32 09:58:55 INFO - Running setup.py install for functools32 09:58:55 INFO - warning: no files found matching '*.txt' 09:58:55 INFO - no previously-included directories found matching 'build' 09:58:55 INFO - no previously-included directories found matching 'dist' 09:58:55 INFO - no previously-included directories found matching '.git*' 09:58:55 INFO - Successfully installed jsonschema functools32 09:58:55 INFO - Cleaning up... 09:58:55 INFO - Return code: 0 09:58:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:58:55 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')]} 09:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:55 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')]} 09:58:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:55 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 0x7fa688a4cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fe1c0>, '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 0x25ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ff550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465836397.985122-1928431301', '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 09:58:55 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 09:58:55 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 09:58:55 INFO - Using env: {'DISPLAY': ':0', 09:58:55 INFO - 'HOME': '/home/cltbld', 09:58:55 INFO - 'LANG': 'en_US.UTF-8', 09:58:55 INFO - 'LANGUAGE': 'en_US:en', 09:58:55 INFO - 'LOGNAME': 'cltbld', 09:58:55 INFO - 'MAIL': '/var/mail/cltbld', 09:58:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:55 INFO - 'MOZ_NO_REMOTE': '1', 09:58:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:55 INFO - 'NO_EM_RESTART': '1', 09:58:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:55 INFO - 'PWD': '/builds/slave/test', 09:58:55 INFO - 'SHELL': '/bin/bash', 09:58:55 INFO - 'SHLVL': '1', 09:58:55 INFO - 'TERM': 'linux', 09:58:55 INFO - 'TMOUT': '86400', 09:58:55 INFO - 'USER': 'cltbld', 09:58:55 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465836397.985122-1928431301', 09:58:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:55 INFO - '_': '/tools/buildbot/bin/python'} 09:58:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:55 INFO - Downloading/unpacking blobuploader==1.2.4 09:58:55 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 09:58:55 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 09:58:55 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 09:58:55 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 09:58:55 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 09:58:55 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 09:58:57 INFO - Downloading blobuploader-1.2.4.tar.gz 09:58:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:58:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:58:57 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 09:58:57 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 09:58:57 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 09:58:57 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 09:58:57 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 09:58:57 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 09:58:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:58:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:58:57 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 09:58:57 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 09:58:57 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 09:58:57 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 09:58:57 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 09:58:57 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 09:58:57 INFO - Downloading docopt-0.6.1.tar.gz 09:58:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:58:58 INFO - Installing collected packages: blobuploader, requests, docopt 09:58:58 INFO - Running setup.py install for blobuploader 09:58:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:58:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:58:58 INFO - Running setup.py install for requests 09:58:58 INFO - Running setup.py install for docopt 09:58:58 INFO - Successfully installed blobuploader requests docopt 09:58:58 INFO - Cleaning up... 09:58:58 INFO - Return code: 0 09:58:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:58 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 0x7fa688a4cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fe1c0>, '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 0x25ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ff550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465836397.985122-1928431301', '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 09:58:58 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 09:58:58 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 09:58:58 INFO - Using env: {'DISPLAY': ':0', 09:58:58 INFO - 'HOME': '/home/cltbld', 09:58:58 INFO - 'LANG': 'en_US.UTF-8', 09:58:58 INFO - 'LANGUAGE': 'en_US:en', 09:58:58 INFO - 'LOGNAME': 'cltbld', 09:58:58 INFO - 'MAIL': '/var/mail/cltbld', 09:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:58 INFO - 'MOZ_NO_REMOTE': '1', 09:58:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:58 INFO - 'NO_EM_RESTART': '1', 09:58:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:58 INFO - 'PWD': '/builds/slave/test', 09:58:58 INFO - 'SHELL': '/bin/bash', 09:58:58 INFO - 'SHLVL': '1', 09:58:58 INFO - 'TERM': 'linux', 09:58:58 INFO - 'TMOUT': '86400', 09:58:58 INFO - 'USER': 'cltbld', 09:58:58 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465836397.985122-1928431301', 09:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:58 INFO - '_': '/tools/buildbot/bin/python'} 09:58:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:58:58 INFO - Running setup.py (path:/tmp/pip-H1zSUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:58:58 INFO - Running setup.py (path:/tmp/pip-PtcuZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:58:59 INFO - Running setup.py (path:/tmp/pip-JOt4E3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:58:59 INFO - Running setup.py (path:/tmp/pip-6IvNIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:58:59 INFO - Running setup.py (path:/tmp/pip-oPEmZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:58:59 INFO - Running setup.py (path:/tmp/pip-f4Qqlc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:58:59 INFO - Running setup.py (path:/tmp/pip-SYrl35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:58:59 INFO - Running setup.py (path:/tmp/pip-9mjSku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:58:59 INFO - Running setup.py (path:/tmp/pip-xk_K7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:58:59 INFO - Running setup.py (path:/tmp/pip-BFI1Jv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:58:59 INFO - Running setup.py (path:/tmp/pip-pUBKxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:58:59 INFO - Running setup.py (path:/tmp/pip-wOyD7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:58:59 INFO - Running setup.py (path:/tmp/pip-bnRMwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:58:59 INFO - Running setup.py (path:/tmp/pip-gqjGiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:59 INFO - Running setup.py (path:/tmp/pip-28UsnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:58:59 INFO - Running setup.py (path:/tmp/pip-YMaHOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:59:00 INFO - Running setup.py (path:/tmp/pip-CyUnSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:59:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:59:00 INFO - Running setup.py install for manifestparser 09:59:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:59:00 INFO - Running setup.py install for mozcrash 09:59:00 INFO - Running setup.py install for mozdebug 09:59:00 INFO - Running setup.py install for mozdevice 09:59:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:59:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:59:00 INFO - Running setup.py install for mozfile 09:59:00 INFO - Running setup.py install for mozhttpd 09:59:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:59:00 INFO - Running setup.py install for mozinfo 09:59:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:59:00 INFO - Running setup.py install for mozInstall 09:59:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:59:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:59:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:59:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:59:00 INFO - Running setup.py install for mozleak 09:59:01 INFO - Running setup.py install for mozlog 09:59:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:59:01 INFO - Running setup.py install for moznetwork 09:59:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:59:01 INFO - Running setup.py install for mozprocess 09:59:01 INFO - Running setup.py install for mozprofile 09:59:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:59:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:59:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:59:01 INFO - Running setup.py install for mozrunner 09:59:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:59:01 INFO - Running setup.py install for mozscreenshot 09:59:01 INFO - Running setup.py install for moztest 09:59:01 INFO - Running setup.py install for mozversion 09:59:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:59:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:59:01 INFO - Cleaning up... 09:59:01 INFO - Return code: 0 09:59:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:01 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 0x7fa688a4cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fe1c0>, '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 0x25ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ff550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465836397.985122-1928431301', '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 09:59:01 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 09:59:01 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 09:59:01 INFO - Using env: {'DISPLAY': ':0', 09:59:01 INFO - 'HOME': '/home/cltbld', 09:59:01 INFO - 'LANG': 'en_US.UTF-8', 09:59:01 INFO - 'LANGUAGE': 'en_US:en', 09:59:01 INFO - 'LOGNAME': 'cltbld', 09:59:01 INFO - 'MAIL': '/var/mail/cltbld', 09:59:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:01 INFO - 'MOZ_NO_REMOTE': '1', 09:59:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:01 INFO - 'NO_EM_RESTART': '1', 09:59:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:01 INFO - 'PWD': '/builds/slave/test', 09:59:01 INFO - 'SHELL': '/bin/bash', 09:59:01 INFO - 'SHLVL': '1', 09:59:01 INFO - 'TERM': 'linux', 09:59:01 INFO - 'TMOUT': '86400', 09:59:01 INFO - 'USER': 'cltbld', 09:59:01 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465836397.985122-1928431301', 09:59:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:01 INFO - '_': '/tools/buildbot/bin/python'} 09:59:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:59:02 INFO - Running setup.py (path:/tmp/pip-n3JZmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:59:02 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)) 09:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:59:02 INFO - Running setup.py (path:/tmp/pip-GJ_PAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:59:02 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)) 09:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:59:02 INFO - Running setup.py (path:/tmp/pip-TEo6FS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:59:02 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)) 09:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:59:02 INFO - Running setup.py (path:/tmp/pip-vKw4TI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:59:02 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)) 09:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:59:02 INFO - Running setup.py (path:/tmp/pip-duuBK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:59:02 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)) 09:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:59:02 INFO - Running setup.py (path:/tmp/pip-9YpJ6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:59:02 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)) 09:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:59:02 INFO - Running setup.py (path:/tmp/pip-6t0Unh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:59:02 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)) 09:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:59:02 INFO - Running setup.py (path:/tmp/pip-tFM2WS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:59:02 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)) 09:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:59:02 INFO - Running setup.py (path:/tmp/pip-b44Fes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:59:02 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)) 09:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:59:02 INFO - Running setup.py (path:/tmp/pip-bA0HBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:59:02 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)) 09:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:59:02 INFO - Running setup.py (path:/tmp/pip-zsOwzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:59:02 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)) 09:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:59:02 INFO - Running setup.py (path:/tmp/pip-6yDNhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:59:03 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)) 09:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:59:03 INFO - Running setup.py (path:/tmp/pip-r9JWED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:59:03 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)) 09:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:59:03 INFO - Running setup.py (path:/tmp/pip-v27gW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:59:03 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)) 09:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:59:03 INFO - Running setup.py (path:/tmp/pip-HNBHRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:59:03 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)) 09:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:59:03 INFO - Running setup.py (path:/tmp/pip-Wa8QlU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:59:03 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)) 09:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:59:03 INFO - Running setup.py (path:/tmp/pip-WQQCdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:59:03 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)) 09:59:03 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)) 09:59:03 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)) 09:59:03 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)) 09:59:03 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)) 09:59:03 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)) 09:59:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:59:03 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 09:59:03 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 09:59:03 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 09:59:03 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 09:59:03 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 09:59:03 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 09:59:05 INFO - Downloading blessings-1.6.tar.gz 09:59:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:59:05 INFO - Installing collected packages: blessings 09:59:05 INFO - Running setup.py install for blessings 09:59:05 INFO - Successfully installed blessings 09:59:05 INFO - Cleaning up... 09:59:05 INFO - Return code: 0 09:59:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:59:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:59:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:59:05 INFO - Reading from file tmpfile_stdout 09:59:05 INFO - Current package versions: 09:59:05 INFO - argparse == 1.2.1 09:59:05 INFO - blessings == 1.6 09:59:05 INFO - blobuploader == 1.2.4 09:59:05 INFO - docopt == 0.6.1 09:59:05 INFO - functools32 == 3.2.3-2 09:59:05 INFO - jsonschema == 2.5.1 09:59:05 INFO - manifestparser == 1.1 09:59:05 INFO - mozInstall == 1.12 09:59:05 INFO - mozcrash == 0.17 09:59:05 INFO - mozdebug == 0.1 09:59:05 INFO - mozdevice == 0.48 09:59:05 INFO - mozfile == 1.2 09:59:05 INFO - mozhttpd == 0.7 09:59:05 INFO - mozinfo == 0.9 09:59:05 INFO - mozleak == 0.1 09:59:05 INFO - mozlog == 3.2 09:59:05 INFO - moznetwork == 0.27 09:59:05 INFO - mozprocess == 0.22 09:59:05 INFO - mozprofile == 0.28 09:59:05 INFO - mozrunner == 6.11 09:59:05 INFO - mozscreenshot == 0.1 09:59:05 INFO - mozsystemmonitor == 0.3 09:59:05 INFO - moztest == 0.7 09:59:05 INFO - mozversion == 1.4 09:59:05 INFO - psutil == 3.1.1 09:59:05 INFO - requests == 1.2.3 09:59:05 INFO - wsgiref == 0.1.2 09:59:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:59:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:05 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 0x7fa688a4cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fe1c0>, '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 0x25ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ff550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465836397.985122-1928431301', '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 09:59:05 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 09:59:05 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 09:59:05 INFO - Using env: {'DISPLAY': ':0', 09:59:05 INFO - 'HOME': '/home/cltbld', 09:59:05 INFO - 'LANG': 'en_US.UTF-8', 09:59:05 INFO - 'LANGUAGE': 'en_US:en', 09:59:05 INFO - 'LOGNAME': 'cltbld', 09:59:05 INFO - 'MAIL': '/var/mail/cltbld', 09:59:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:05 INFO - 'MOZ_NO_REMOTE': '1', 09:59:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:05 INFO - 'NO_EM_RESTART': '1', 09:59:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:05 INFO - 'PWD': '/builds/slave/test', 09:59:05 INFO - 'SHELL': '/bin/bash', 09:59:05 INFO - 'SHLVL': '1', 09:59:05 INFO - 'TERM': 'linux', 09:59:05 INFO - 'TMOUT': '86400', 09:59:05 INFO - 'USER': 'cltbld', 09:59:05 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465836397.985122-1928431301', 09:59:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:05 INFO - '_': '/tools/buildbot/bin/python'} 09:59:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:06 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)) 09:59:06 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)) 09:59:06 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)) 09:59:06 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)) 09:59:06 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)) 09:59:06 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)) 09:59:06 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)) 09:59:06 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)) 09:59:06 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)) 09:59:06 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)) 09:59:06 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)) 09:59:06 INFO - Cleaning up... 09:59:06 INFO - Return code: 0 09:59:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:59:06 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')]} 09:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:06 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')]} 09:59:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:06 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 0x7fa688a4cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fe1c0>, '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 0x25ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ff550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465836397.985122-1928431301', '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 09:59:06 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 09:59:06 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 09:59:06 INFO - Using env: {'DISPLAY': ':0', 09:59:06 INFO - 'HOME': '/home/cltbld', 09:59:06 INFO - 'LANG': 'en_US.UTF-8', 09:59:06 INFO - 'LANGUAGE': 'en_US:en', 09:59:06 INFO - 'LOGNAME': 'cltbld', 09:59:06 INFO - 'MAIL': '/var/mail/cltbld', 09:59:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:06 INFO - 'MOZ_NO_REMOTE': '1', 09:59:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:06 INFO - 'NO_EM_RESTART': '1', 09:59:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:06 INFO - 'PWD': '/builds/slave/test', 09:59:06 INFO - 'SHELL': '/bin/bash', 09:59:06 INFO - 'SHLVL': '1', 09:59:06 INFO - 'TERM': 'linux', 09:59:06 INFO - 'TMOUT': '86400', 09:59:06 INFO - 'USER': 'cltbld', 09:59:06 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465836397.985122-1928431301', 09:59:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:06 INFO - '_': '/tools/buildbot/bin/python'} 09:59:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:59:06 INFO - Cleaning up... 09:59:06 INFO - Return code: 0 09:59:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:59:06 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')]} 09:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:06 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')]} 09:59:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:06 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 0x7fa688a4cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fe1c0>, '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 0x25ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ff550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465836397.985122-1928431301', '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 09:59:06 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 09:59:06 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 09:59:06 INFO - Using env: {'DISPLAY': ':0', 09:59:06 INFO - 'HOME': '/home/cltbld', 09:59:06 INFO - 'LANG': 'en_US.UTF-8', 09:59:06 INFO - 'LANGUAGE': 'en_US:en', 09:59:06 INFO - 'LOGNAME': 'cltbld', 09:59:06 INFO - 'MAIL': '/var/mail/cltbld', 09:59:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:06 INFO - 'MOZ_NO_REMOTE': '1', 09:59:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:06 INFO - 'NO_EM_RESTART': '1', 09:59:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:06 INFO - 'PWD': '/builds/slave/test', 09:59:06 INFO - 'SHELL': '/bin/bash', 09:59:06 INFO - 'SHLVL': '1', 09:59:06 INFO - 'TERM': 'linux', 09:59:06 INFO - 'TMOUT': '86400', 09:59:06 INFO - 'USER': 'cltbld', 09:59:06 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465836397.985122-1928431301', 09:59:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:06 INFO - '_': '/tools/buildbot/bin/python'} 09:59:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:06 INFO - Downloading/unpacking flake8 09:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:59:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:59:08 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 09:59:08 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 09:59:08 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 09:59:08 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 09:59:08 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 09:59:08 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 09:59:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:59:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:59:08 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 09:59:08 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 09:59:08 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 09:59:08 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 09:59:08 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 09:59:08 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 09:59:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:59:08 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 09:59:08 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 09:59:08 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 09:59:08 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 09:59:08 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 09:59:08 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 09:59:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:59:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:59:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:59:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:59:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:59:09 INFO - no previously-included directories found matching 'docs/_build' 09:59:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:59:09 INFO - Running setup.py install for pep8 09:59:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:59:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:59:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:59:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:59:09 INFO - no previously-included directories found matching 'docs/_build' 09:59:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:59:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:59:09 INFO - Cleaning up... 09:59:09 INFO - Return code: 0 09:59:09 INFO - Running post-action listener: _resource_record_post_action 09:59:09 INFO - Running post-action listener: _start_resource_monitoring 09:59:09 INFO - Starting resource monitoring. 09:59:09 INFO - ##### 09:59:09 INFO - ##### Finished create-virtualenv step (success) 09:59:09 INFO - ##### 09:59:09 INFO - ##### 09:59:09 INFO - ##### Running install step. 09:59:09 INFO - ##### 09:59:09 INFO - Running pre-action listener: _resource_record_pre_action 09:59:09 INFO - Running main action method: install 09:59:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:59:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:59:09 INFO - Reading from file tmpfile_stdout 09:59:09 INFO - Detecting whether we're running mozinstall >=1.0... 09:59:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:59:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:59:09 INFO - Reading from file tmpfile_stdout 09:59:09 INFO - Output received: 09:59:09 INFO - Usage: mozinstall [options] installer 09:59:09 INFO - Options: 09:59:09 INFO - -h, --help show this help message and exit 09:59:09 INFO - -d DEST, --destination=DEST 09:59:09 INFO - Directory to install application into. [default: 09:59:09 INFO - "/builds/slave/test"] 09:59:09 INFO - --app=APP Application being installed. [default: firefox] 09:59:09 INFO - mkdir: /builds/slave/test/build/application 09:59:09 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'] 09:59:09 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 09:59:25 INFO - Reading from file tmpfile_stdout 09:59:25 INFO - Output received: 09:59:25 INFO - /builds/slave/test/build/application/firefox/firefox 09:59:25 INFO - Running post-action listener: _resource_record_post_action 09:59:25 INFO - ##### 09:59:25 INFO - ##### Finished install step (success) 09:59:25 INFO - ##### 09:59:25 INFO - ##### 09:59:25 INFO - ##### Running run-tests step. 09:59:25 INFO - ##### 09:59:25 INFO - Running pre-action listener: _resource_record_pre_action 09:59:25 INFO - Running main action method: run_tests 09:59:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:59:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:59:25 INFO - Python 2.7.3 09:59:25 INFO - Return code: 0 09:59:25 INFO - grabbing minidump binary from tooltool 09:59:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:25 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 0x25fe1c0>, '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 0x25ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ff550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:59:25 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 09:59:25 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 09:59:25 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 09:59:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:59:25 INFO - Return code: 0 09:59:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:59:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:59:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:59:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:59:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:59:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:59:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:59:26 INFO - Return code: 0 09:59:26 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/Zp2JaXMLSJCJjW-t0X0tKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 09:59:26 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/Zp2JaXMLSJCJjW-t0X0tKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 09:59:26 INFO - Using env: {'DISPLAY': ':0', 09:59:26 INFO - 'HOME': '/home/cltbld', 09:59:26 INFO - 'LANG': 'en_US.UTF-8', 09:59:26 INFO - 'LANGUAGE': 'en_US:en', 09:59:26 INFO - 'LOGNAME': 'cltbld', 09:59:26 INFO - 'MAIL': '/var/mail/cltbld', 09:59:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:59:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:59:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:26 INFO - 'MOZ_NO_REMOTE': '1', 09:59:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:59:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:26 INFO - 'NO_EM_RESTART': '1', 09:59:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:26 INFO - 'PWD': '/builds/slave/test', 09:59:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:59:26 INFO - 'SHELL': '/bin/bash', 09:59:26 INFO - 'SHLVL': '1', 09:59:26 INFO - 'TERM': 'linux', 09:59:26 INFO - 'TMOUT': '86400', 09:59:26 INFO - 'USER': 'cltbld', 09:59:26 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465836397.985122-1928431301', 09:59:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:26 INFO - '_': '/tools/buildbot/bin/python'} 09:59:26 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/Zp2JaXMLSJCJjW-t0X0tKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 09:59:26 INFO - mozversion application_buildid: 20160613092325 09:59:26 INFO - mozversion application_changeset: ea5833a015a141c08d9d63b768841af97287033f 09:59:26 INFO - mozversion application_display_name: Nightly 09:59:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:59:26 INFO - mozversion application_name: Firefox 09:59:26 INFO - mozversion application_remotingname: firefox 09:59:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:59:26 INFO - mozversion application_vendor: Mozilla 09:59:26 INFO - mozversion application_version: 50.0a1 09:59:26 INFO - mozversion platform_buildid: 20160613092325 09:59:26 INFO - mozversion platform_changeset: ea5833a015a141c08d9d63b768841af97287033f 09:59:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:59:26 INFO - mozversion platform_version: 50.0a1 09:59:26 INFO - using testdate: 1465837166 09:59:26 INFO - actual date: 1465837166 09:59:26 INFO - starting webserver on 'localhost:52628' 09:59:26 INFO - SUITE-START | Running 2 tests 09:59:26 INFO - TEST-START | dromaeo_css 09:59:26 INFO - operating with platform_type : linux_ 09:59:26 INFO - Initialising browser for dromaeo_css test... 09:59:26 INFO - TEST-INFO | started process 7919 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgu7kQ1/profile http://localhost:52628/getInfo.html) 09:59:31 INFO - PROCESS | 7919 | __metrics Screen width/height:1600/1200 09:59:31 INFO - PROCESS | 7919 | colorDepth:24 09:59:31 INFO - PROCESS | 7919 | Browser inner width/height: 1024/697 09:59:31 INFO - PROCESS | 7919 | __metrics 09:59:32 INFO - PROCESS | 7919 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:59:33 INFO - PROCESS | 7919 | console.error: PushService: 09:59:33 INFO - PROCESS | 7919 | stateChangeProcessEnqueue: Error transitioning state 09:59:33 INFO - PROCESS | 7919 | UnknownError 09:59:33 INFO - TEST-INFO | 7919: exit 0 09:59:33 INFO - Browser initialized. 09:59:33 INFO - Running cycle 1/1 for dromaeo_css test... 09:59:33 INFO - TEST-INFO | started process 7999 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgu7kQ1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:59:45 INFO - PROCESS | 7999 | RSS: Main: 179486720 09:59:45 INFO - PROCESS | 7999 | 10:00:36 INFO - PROCESS | 7999 | 1465837236853 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] 10:02:49 INFO - PROCESS | 7999 | Cycle 1(1): loaded http://localhost:52628/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52628/tests/dromaeo/cssquery-ext.html) 10:02:51 INFO - PROCESS | 7999 | RSS: Main: 259444736 10:02:51 INFO - PROCESS | 7999 | 10:05:53 INFO - PROCESS | 7999 | Cycle 1(1): loaded http://localhost:52628/tests/dromaeo/cssquery-ext.html (next: http://localhost:52628/tests/dromaeo/cssquery-jquery.html) 10:05:54 INFO - PROCESS | 7999 | RSS: Main: 267894784 10:05:54 INFO - PROCESS | 7999 | 10:08:56 INFO - PROCESS | 7999 | Cycle 1(1): loaded http://localhost:52628/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52628/tests/dromaeo/cssquery-mootools.html) 10:08:57 INFO - PROCESS | 7999 | RSS: Main: 260108288 10:08:57 INFO - PROCESS | 7999 | 10:11:59 INFO - PROCESS | 7999 | Cycle 1(1): loaded http://localhost:52628/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52628/tests/dromaeo/cssquery-prototype.html) 10:11:59 INFO - PROCESS | 7999 | RSS: Main: 261382144 10:11:59 INFO - PROCESS | 7999 | 10:15:03 INFO - PROCESS | 7999 | Cycle 1(1): loaded http://localhost:52628/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52628/tests/dromaeo/cssquery-yui.html) 10:15:03 INFO - PROCESS | 7999 | RSS: Main: 243507200 10:15:03 INFO - PROCESS | 7999 | 10:18:06 INFO - PROCESS | 7999 | Cycle 1(1): loaded http://localhost:52628/tests/dromaeo/cssquery-yui.html (next: http://localhost:52628/tests/dromaeo/cssquery-dojo.html) 10:18:06 INFO - PROCESS | 7999 | RSS: Main: 308920320 10:18:06 INFO - PROCESS | 7999 | 10:18:06 INFO - PROCESS | 7999 | __start_tp_report 10:18:06 INFO - PROCESS | 7999 | _x_x_mozilla_page_load 10:18:06 INFO - PROCESS | 7999 | _x_x_mozilla_page_load_details 10:18:06 INFO - PROCESS | 7999 | |i|pagename|runs| 10:18:06 INFO - PROCESS | 7999 | |0;dojo.html;2645.748653877881;2651;2692.8653567321635;2694.030149146307;2703;4691.5777580017875;4782.450018247902;4785.401824771903;4896.216605343141;4905.460399356068;4765.356676848624;4797.448293446255;4804.087223427547;4804.759762011894;4821.156297647906;4336.262835318003;4365.934510982338;4438.600525952664;4466.486354069291;4533.455985281771;4439.156560253574;4476.529964353745;4497.820087196508;4503.684742068041;4528.04910968697;4334.978325108385;4343.2182207202695;4388.078503514266;4400.185965596343;4452.354408610766;4464.374987501752;4528.569785870337;4532.093581283723;4532.501424843264;4580.496145424001;4457.153140903218;4469.083837813273;4511.097780443924;4519.435070616173;4525.343825145368;4693.530646935279;4715;4756.714597124149;4806;4882.170031094723;5207.895842083137;5210.452902445264;5219.42586315505;5236.345456817898;5237.8428647140645;5052.368453943257;5190.195519694454;5246.029484545371;5249.265102885599;5250.894982100374;4843.079814835135;4866.29438731389;4867.537583929521;4875.804967801319;4899.975500122477;5376.973115134399;5380.300560927133;5391.595630327741;5391.892162156735;5407.432219616962;4973.751312434364;5084.567811736044;5095.414027386898;5129.64092513528;5140.588752899759;5242;5254.369475662945;5280.287161233261;5280.630355875129;5330.360356757214;5212.609054320941;5230.869228269324;5232.693440812791;5236;5285.07511185541;4967.130752118364;5146.382434107931;5188.507091826271;5197.974010129925;5202;4390.5828946250695;4415.492218394926;4441.533638967927;4458.175237580993;4458.576435238647;3857.228554289153;3873.1091848874353;3883.0680636647003;3888.202918401721;3911.647951684362;4324.372965919924;4362.8036738346855;4364.454443194601;4447.177272204653;4488.820447182142;5236.29310043147;5252.1596544552685;5267.999080174754;5272.604554658416;5275.076861549213;4423.447069116361;4435.733855968652;4436.157130145262;4483.32750087483;4483.55164483549;4541.114482675846;4674.205385084544;4715.339852420664;4717.339572459859;4723.102610503994;4836.661433699748;4864.173090574682;4886.267059941038;4932.827351042696;4955.727434991038;5179.81870634526;5210.322658054429;5222.608304377263;5224.7126408047925;5239.187925871496;4697.835575754969;4862.805487780449;4881.8535443936735;4912;4914.92627610579;5165.457626949116;5217.269582258563;5217.556507696889;5220.582353411642;5223.085959956917;5197.194434862602;5251.054810134213;5270.525652691276;5275.103232450416;5305.65513241638;4856.441509226484;4975.552200301845;5041.067402530543;5055.090083784807;5072.51811077947;5032.647714659939;5079.415867175322;5133.307003554472;5134.5635620972635;5188.688678679291;4852;5046.59627229828;5069.9746501267255;5100.770465329143;5118.820841270538;5062.519060689228;5121.411037730709;5127.307813445137;5137.460566640449;5152.072626927189;5013.473585273639;5038.345015148007;5043.747812609428;5054.949450505448;5086.694798312114 10:18:06 INFO - PROCESS | 7999 | |1;ext.html;592.2951687491885;595.0301009354752;599.8470390050536;603.2730559675591;608.370336701514;27452.588211176822;39657.405138922906;40127;40382;43667.34498982518;41293;41737.582624173825;41741.16517669645;41769.58230417703;41850.58149418505;7372.74195403161;7747.535147891116;7895.131535531087;7897.842043159133;7898.05223373196;9735.610575576968;9987.850182247272;9988.051135142186;10381.221408394364;10389;10115.039071288216;10205.03052210039;10256.487175641225;10259.538320775546;10272.845907311395;7502.774916752506;9895.208383329316;10137.239707022003;10144.036316549917;10231.488425578691;9992.250581206366;10028.348157369821;10041.246906482043;10053.949730251303;10123.1901447884;38497.80751096254;38806.80596597027;38860;38890.22219555621;38909.61090389088;3165.2403423178503;3193.5369371441243;3301.290222602128;3401.642827503101;3462.982685086584;29127.563086553717;29199;29735.25661858449;29891.25271868199;30069.849650751825;3395.456726923705;3410.0545728452644;3428.6571342865764;3441.82790860456;3520.612732599412;245097;245314;245322.77338613372;245986;246977;31610.525842112387;51328.48671513312;51647.741761290956;51760.74119629453;51779;31877.362452750815;32618.673813261565;32815.83592082072;32944.505832412535;32976.835115824266;12912.935435322952;13082.803757943639;13093.541726039733;13094.083414161109;13105.868941310655;8869.334799890034;10470.581176752845;10724.356538607708;10749.83875241872;10827.917208279108;7537.773866784005;7557.2820582044615;7585.886211706828;7591.240875912365;7612.7716168515035;2906.97093029067;2992.3716019635685;3015.7135072168107;3025.198322444554;3026.122424496871;821.5645707774889;899.7480705402497;935.9110884465965;1013.3869009249445;1055.2771351624008;28267;28560;28560.571591426145;28871.566926496118;29050.564241536395;918.2791508665799;958.9280803939592;987.2496902354262;988.960441582343;1003.7741508160606;14911.850881491046;14981.625459363386;15228.771568426482;15534.844651553565;15551.766723499157;120431;120464;121031;121084;121154;50062.749686251336;50408.747956259984;50472;50617.24074138891;50655.49344506581;1070.6680928912062;1097.8078836203792;1171.4552732979205;1207.7161866961258;1210.1589395370133;28122.43755124927;29279.268018299714;29300.70699293065;29930.25174370658;30113.849430752707;41994.58005419907;42119.36820947749;42550.57449425466;42558.95689909453;42592.78703606586;243422;244665;244744;245244;245863;20421;21087;21250.36248912535;22066.668999965335;25390.746092538837;42617.78691106648;43407.34888976605;43430.34854477249;43549;43624;36639.816800915825;37422.25155496929;37438.8128059358;37977.4303385455;38316.42525362066;36554;37299.62700372961;37345;37633.2473350537;37762.43356349602;34937.65062349344;35027.649723502436;35239.295214096084;36811;38047.61952380441;25395.238142855746;25990.480190396465;26534.734652653227;27052.864735676194;27102.186934392;24009.399765006016;24265;24362.634560481252;24486.75513244845;24767.13315034037 10:18:06 INFO - PROCESS | 7999 | |2;jquery.html;377.7620099337417;379.1601602450572;380.4027676547821;391.15900813251505;393.5926316262669;15995.200239988013;17325.22036508357;17494.82505174951;17783.91108044458;17871.106444677764;16970.49088527343;17001.404950826724;17373.478795636118;17744.112794360295;17774.822251777478;4975.751212439382;5167.689938603677;5204.739763011853;5220.947790522103;5221.503957124067;3731.9440208396895;3926.214757048587;3938.448617193595;6141.754329826824;6149.938500614981;6199.504039676837;6223.035429508411;6237.18916540849;6243.687815609224;6249.906266403384;5886.705664716747;6026.517878569748;6034.607750496248;6036.034234522455;6071.632063495241;3419.9487007694906;5001.949980500185;5274.55166310864;5299.046171689094;5357.517823395913;20591.8970405147;21193.576128477343;21249.468763281042;21254.574908501745;21374.89312553443;2025.7872923343132;2243.057915675404;2302.9769702303097;2435.5737745894576;2517.962230566543;12466.688332791662;13274.269915154759;13295.53465628708;13553.119047261896;13854.792178117335;1688.425935182044;1707.42801161611;1715.665445238179;1814.482872381365;1830.8718389712726;65414.67292663554;67584.98622520617;68217;68402;68909;9189.218916392181;9270.490123043162;9795.179879846723;9811.460369679593;9912.752181195383;13812.654683632789;13832.100913440594;13877.306134693426;13898;13907.652308692364;7230.927690723025;7272;7299.635018249172;7350.191478937312;7378.631068446556;7038.40173585251;7152.105986751656;7186.389156921616;7286.48994570375;7309.232530584319;6190.3190649028575;6261.526696954677;6285.842853928689;6299.370062993664;6348.650824204621;1755.4551994245237;1759.5337235632567;1770.8317709817804;1776.67131580658;1796.4071856287394;838.6980686952692;863.9006514250941;915.4873270968279;966.5747071288611;991.0634450444405;16680.916595416944;17117.42045375782;17591.73612395815;17913.37303194382;17954.281828726966;875.9474431534128;900.3202582050641;918.4351623751345;944.419182202954;952.2049089010616;9803.460809655395;9981;10378.896211037792;10502.474876256156;10512.579496820195;387393;392951;406860;412106;413060;43370.56629433728;45855.54144458513;66567;69322;69870.65064674745;905.4024343932973;913.2009491694768;934.2759361494896;939.6852054561662;963.8120566489607;11780.646580602595;15274.847251527786;15748.133852638215;16580.917095414447;16828.242729076977;30455.390892182477;35887.461688074174;38304.80847595744;38652.420213697376;40450.39324410195;47850;51757;52034;52238.47761522336;52344.47655523396;7520.435967302365;7698.307152356315;7711.575863327571;7981.521108733495;8139.186081391814;5910.054391297372;5979.910301345396;11803.173777835469;11871.643850684493;12127.57553485659;6741.460683145435;8067.959660201662;9996.900030999597;10041.799164016826;10042.397456152654;9704.563294651898;10402.739931501774;10595.15238780911;10626;10761.569537218737;7736.303732664087;9813.950930245303;10144.54349554257;10442;10494.527746251284;6698.899516507354;7040.718371265092;7070.257622949516;7954.164812694584;8068.07217170033;8829;9900;10069.295149339476;10072.647457339252;10270.6405275815 10:18:06 INFO - PROCESS | 7999 | |3;mootools.html;1223.406647775829;1411.449534681474;1440.1287221231155;1542.5141080559622;1716.4936343778593;6810.761623343184;7651.579163146025;7911.60441977901;7918.049834019926;8103.513789172654;7972.840543189132;7982.800429989239;8040.678372865078;8042.075161356446;8051.476654017485;2209.569134018867;2239.283429302624;2240.7535171131244;2240.9439764005947;2242.4618091657967;2148.151480165334;2189.4526368407896;2196.5716685246384;2199.087378737822;2199.802017818396;2202.2402271216406;2206.646936490162;2219.9001044953015;2222.4888275696517;2241.1371621925596;2160.384290477214;2167.6640120781303;2172.576347612216;2173.8913054347377;2174.510735084609;2118.03629348646;2135.4874830040835;2161.8378621603283;2162.4593851537115;2164.1127137873395;7843.529388236667;7970.362371010363;8029.437939344249;8030.839383212303;8047.195280471906;4652.464966528859;4796;4798.256270278112;4812.446568644616;4813.3983252093485;2758.6275852760023;2857.3713782967716;2883.7260460256243;2885.293103189711;2902.3759891623404;866.3459088388289;867.2151702709058;869.5869462005497;875.159846547309;883.2624758326805;11017.063549598293;11091.500882460308;11146.665600032013;11151.442427878656;11168.66494005181;4082.6121518455698;4177.56135605757;4245.405643209953;4267.317229243306;4276.893077673083;8623.137686231452;8711.128887111365;8729.388942774072;8733.868991965126;8738;4603.884902877455;4653.813847446064;4713.198756211452;4716.410448693913;4716.434027916672;3744.251149770057;4214.262504061777;4382.05785756064;4403.097365040159;4432.867013989586;3515.5957064937347;3536.1159710072484;3591.120175557005;3600.963990360063;3626.746127771031;1050.4117694091333;1053.757635743783;1065.9040686338267;1069.850220969065;1078.1590359519587;732.9006490264603;840.7561807076002;863.369740089738;865.7056600755773;866.7269810009826;5320.600954928318;5344.706041167696;5544.695041772741;5628.409017053233;5670.631408958405;403.92729308724125;408.75883228895094;411.6295334199245;414.0890041907755;421.04212915617217;3574.5889222739197;3664.9083772905356;3798.772073675588;3807.3908174691915;3842.5773164951834;9631.325807193569;10011;10023.398596084258;10091.69724908254;10135.341202821794;9943.254255930835;9949.651762188289;9970.551325190383;9999.700008999742;10012.849807252896;6817.727290908408;7396.223396543393;7458.70165193397;7510.849783004419;7535.058117735283;5448.645838020516;5448.972755136199;5470.152126420411;5560.388357280615;5611.579131565068;9036.59335329925;9242.953785231031;9310.813783724423;9312.767180820534;9320.114589114024;8949.418287811272;9253.259739220981;9275.86086208721;9372.812543749224;9378.718638440858;6067.180930574493;6262;6280.905786413299;6615.536912416084;6803.25164231944;7089.7873063808165;7161.355478007004;7234.63826808668;7298.744543940937;7299.635018249172;6707.5975441473665;6959.8608027838145;6999.615021173884;7059.858802824017;7142.392896603639;6704.229013663491;6705.765298214539;6746.628935408599;6833;6863.519553631198;6375.107484952203;6389.393007664265;6428.935710642833;6462.515311351762;6490.3185165558825;4482.955170448254;4529.796159172779;4535.523770004234;4604.0331530379;4627.745473998963;4634.629229661687;4648.140094082605;4816.470188279357;4846.757662116809;4901.3383193268455 10:18:06 INFO - PROCESS | 7999 | |4;prototype.html;301.22885413341845;301.79477954990614;305.7676166113753;315.8625997691003;318.0347644897736;4687.69529980551;4790.856274311767;4827.589654879335;4828.633969355013;4840.225563909775;4647.302904564317;4856.635752318582;4866.294387313837;4872.3677568014755;4887.144749668802;3820.522434695663;3832.386818109103;3853.9614603854025;3868.323043467396;3871.9032024199337;3688.7417880748358;3693;3824.445455408964;3887.319719049169;3908.8045597720143;3823.3500304948225;3845.576986531479;3851.3054256127352;3855.61443855615;3859.729818912663;3824.7896365699876;3829.3107240696663;3829.6256321080828;3836.175222327213;3845.288621604984;3399.5410619566287;3413.232022794851;3417;3419.230673098533;3425.1608355952703;4604.539546045368;4718.268668356376;4738.739369334685;4745.738984355859;4747.240441529339;4364.258076127066;4386.429764130675;4394.231009573312;4397.780110994438;4403.163398954189;5068.265101560253;5083.034223497523;5092.236164575306;5099.271889539116;5104.3619547556555;3576.8390422431053;3711.554613446404;3719.7396182267253;3722.2183341498317;3748.3815170496837;5245.816396426107;5278.181881808326;5284.735763211824;5300.7349632517835;5315.415304316522;3785.09157802131;3788.1476667749534;3803.125281185343;3834.654881060718;3841.116543195081;3778.962210377916;3874.6319099685484;3892.785896775648;3893.96106038936;3895.610438956082;4345.543717909637;4357.629601483846;4357.7385356878685;4358.21552120615;4373.278409062469;4976.377952755905;4980.800767969241;4994.225894986283;4998.950010499849;5082.745862706924;1268.5940499040403;1282.7434513097419;1309.3845892430543;1323;1338.9489250937968;862.3489265604554;864.179029921577;881.1144799476485;882.8984666763405;891.7592250092439;3986.820593073319;3988.940165897514;3994.5406278277787;3998.8000599969887;4039.2325458162854;4611.262198048296;4630.259158534685;4673.08403554541;4720.362751028636;4732.4856046065615;3930.2336044471626;3979.224051309967;4008.2584721826556;4043.3732771420478;4065.2479291331197;2305.953880922406;2427.4659574893494;2442.963355549668;2471.653968444419;2485.5526005318857;4329.588689074533;4357.694961352675;4366.868993930188;4371.737695738202;4381.956180438218;4704;4748.501407352178;4752.477227504972;4779.450363208206;4785.3300537924715;4380.233459144637;4408.875736687124;4562.51718191589;4980.630326660197;5002.974985125051;5281.9471805281455;5300.628955973045;5309.36287645485;5318.920216196838;5325.668582854287;5175.353080864892;5191.62544346178;5197.0905091609575;5204.245384419314;5208.609354298367;4690.132325519789;4908.9754551227015;4940.901181976412;4973.47778483254;4981.427135879276;3697.4453831925425;3717.8326975285636;3728.1798004440066;3730.626937306356;3731.8507259710395;5023.095842748195;5253.2645429639115;5283.498067683564;5308.708021058725;5309.36287645485;4981.452040275494;5039.546440820343;5079.822206222764;5133.820316289061;5159.039564965289;5113.897722045613;5127.769250383667;5130.846074617767;5148.227765835005;5152.536271735562;4802.567768900815;5021.924671130009;5042.84871453857;5047.662369472019;5075.593952483866;5203.19350500673;5211.869703257297;5221.164613661796;5230.450802665818;5239.685618862881;5091.159958606789;5101.20931255656;5101.627743099477;5107.336046313955;5111.437741848468 10:18:06 INFO - PROCESS | 7999 | |5;yui.html;665.1951139121662;665.3764813854192;699.5173330402024;704.9918616378579;720.8522252938149;11767.235129716573;12164.026877849785;12182.573609923655;12182.81725774114;12286.385680715974;12297.446614902328;12355.444005019774;12367.257964522136;12436.626901192956;12450.252984820894;616.4729156571112;764.2510339866934;786.0606575142707;791.7545560876118;793.892824468698;787.3268355555974;799.9040115186157;799.9880001799978;800.0918956983836;801.5471258738824;834.8205135895781;836.7406104107715;842.2377748137945;842.6755699055877;842.9915700843005;647.2427260105687;813.6460639621724;828.9171082891722;836.1178956201205;837.0290463062848;606.3421188011014;606.6996836565884;607.2621764556042;607.6870411737958;607.9969600152015;12308.323042232674;12310.81533776994;12350.62948111558;12355.25868447887;12362.320072396014;12453.688657783538;13018.414171362312;13121.671958201026;13160.802587961189;13204.801927971088;10287.434191119486;10385.169186465064;10385.42880141592;10414.114800241989;10436.947815260952;3213.6786321367676;4131.194417088669;4171.958280417188;4196.832126714928;4305.375720520538;51945.48054519444;58077.41922580762;58477.707611462094;58559;58785.41214587842;9806.460644664612;10247.436390998566;10337.173026157889;10345.482725863676;10406.427646479366;17301.480955571355;17326.220320085627;17343.653126937643;17421.738673919903;17579.56051098707;6712.630805305657;6731.427828634621;6740.730370785113;6782.084418603426;6853.554518956352;3716.572594151653;3730.198007428416;3775.8867233983024;3805.562360328542;3872.9225415491533;2873.956890646642;2968.228260652246;2975.6875528069672;2977.077106097117;2977.970220297769;500.62953414473026;517.6195496310208;517.9922301165485;532.3930718980365;569.8091139468324;396.6648182285964;508.57025813187795;571.4057380324499;584.8157830283532;585.3736501942881;7024.157101147793;7405.518641288407;7461.962690186514;7559.735409260649;7586.658600362997;507.7841917185182;539.2262103880944;545.7625932719279;549.8048192891546;557.7629507459395;3312.5362449257123;3580.104973756561;3624.52881125452;3669.834857431422;3695.1685870678884;86684.13315866886;89025.55487222652;90181;90481;91993.54003230075;78135.60932195303;80137.19862801414;81056;81529;83844;70390;71587;71759;72078;72092.27907720856;6412.070249813658;6512.088307637029;6631.469482441489;6712.865742685021;6802.319768023158;37955.810220949825;40275.79862100788;42154;42878.35682464828;42882;38635.2272954545;40164.59835401725;40390.59609403869;59755;60342.094868577886;10134.189264858645;10320.48397580103;10447.477626118816;10831.891681083089;11393.658190254306;12519.061070419573;12999.805002925154;13125.54060607874;13468.259245741187;13470.93264533671;12052;12160.878391216329;12190.2076365036;12247.571335003233;12898.80651790205;12316.50733970667;12322.81515777282;12657.556985505464;12682.619521414372;13061.314006868726;11230.270032447865;11526.135539834713;11771;12141.75716485683;12147.331896745764;10060.647877324258;10291.433971131659;10567.94716026415;10626.681199563716;10672.679819605424;9817.312788104764;10252.618729810705;10485.842712359168;10534.209934254808;10577.259591828499 10:18:06 INFO - PROCESS | 7999 | __end_tp_report 10:18:06 INFO - PROCESS | 7999 | __start_cc_report 10:18:06 INFO - PROCESS | 7999 | _x_x_mozilla_cycle_collect,1024 10:18:06 INFO - PROCESS | 7999 | __end_cc_report 10:18:06 INFO - PROCESS | 7999 | __startTimestamp1465838286487__endTimestamp 10:18:06 INFO - PROCESS | 7999 | 10:18:06 INFO - PROCESS | 7999 | ------- Summary: start ------- 10:18:06 INFO - PROCESS | 7999 | Number of tests: 6 10:18:06 INFO - PROCESS | 7999 | 10:18:06 INFO - PROCESS | 7999 | [#0] dojo.html Cycles:165 Average:4807.85 Median:4905.46 stddev:520.24 (10.6%) stddev-sans-first:493.42 10:18:06 INFO - PROCESS | 7999 | Values: 2645.7 2651.0 2692.9 2694.0 2703.0 4691.6 4782.5 4785.4 4896.2 4905.5 4765.4 4797.4 4804.1 4804.8 4821.2 4336.3 4365.9 4438.6 4466.5 4533.5 4439.2 4476.5 4497.8 4503.7 4528.0 4335.0 4343.2 4388.1 4400.2 4452.4 4464.4 4528.6 4532.1 4532.5 4580.5 4457.2 4469.1 4511.1 4519.4 4525.3 4693.5 4715.0 4756.7 4806.0 4882.2 5207.9 5210.5 5219.4 5236.3 5237.8 5052.4 5190.2 5246.0 5249.3 5250.9 4843.1 4866.3 4867.5 4875.8 4900.0 5377.0 5380.3 5391.6 5391.9 5407.4 4973.8 5084.6 5095.4 5129.6 5140.6 5242.0 5254.4 5280.3 5280.6 5330.4 5212.6 5230.9 5232.7 5236.0 5285.1 4967.1 5146.4 5188.5 5198.0 5202.0 4390.6 4415.5 4441.5 4458.2 4458.6 3857.2 3873.1 3883.1 3888.2 3911.6 4324.4 4362.8 4364.5 4447.2 4488.8 5236.3 5252.2 5268.0 5272.6 5275.1 4423.4 4435.7 4436.2 4483.3 4483.6 4541.1 4674.2 4715.3 4717.3 4723.1 4836.7 4864.2 4886.3 4932.8 4955.7 5179.8 5210.3 5222.6 5224.7 5239.2 4697.8 4862.8 4881.9 4912.0 4914.9 5165.5 5217.3 5217.6 5220.6 5223.1 5197.2 5251.1 5270.5 5275.1 5305.7 4856.4 4975.6 5041.1 5055.1 5072.5 5032.6 5079.4 5133.3 5134.6 5188.7 4852.0 5046.6 5070.0 5100.8 5118.8 5062.5 5121.4 5127.3 5137.5 5152.1 5013.5 5038.3 5043.7 5054.9 5086.7 10:18:06 INFO - PROCESS | 7999 | 10:18:06 INFO - PROCESS | 7999 | [#1] ext.html Cycles:180 Average:36809.89 Median:17906.11 stddev:55428.92 (309.6%) stddev-sans-first:55517.70 10:18:06 INFO - PROCESS | 7999 | Values: 592.3 595.0 599.8 603.3 608.4 27452.6 39657.4 40127.0 40382.0 43667.3 41293.0 41737.6 41741.2 41769.6 41850.6 7372.7 7747.5 7895.1 7897.8 7898.1 9735.6 9987.9 9988.1 10381.2 10389.0 10115.0 10205.0 10256.5 10259.5 10272.8 7502.8 9895.2 10137.2 10144.0 10231.5 9992.3 10028.3 10041.2 10053.9 10123.2 38497.8 38806.8 38860.0 38890.2 38909.6 3165.2 3193.5 3301.3 3401.6 3463.0 29127.6 29199.0 29735.3 29891.3 30069.8 3395.5 3410.1 3428.7 3441.8 3520.6 245097.0 245314.0 245322.8 245986.0 246977.0 31610.5 51328.5 51647.7 51760.7 51779.0 31877.4 32618.7 32815.8 32944.5 32976.8 12912.9 13082.8 13093.5 13094.1 13105.9 8869.3 10470.6 10724.4 10749.8 10827.9 7537.8 7557.3 7585.9 7591.2 7612.8 2907.0 2992.4 3015.7 3025.2 3026.1 821.6 899.7 935.9 1013.4 1055.3 28267.0 28560.0 28560.6 28871.6 29050.6 918.3 958.9 987.2 989.0 1003.8 14911.9 14981.6 15228.8 15534.8 15551.8 120431.0 120464.0 121031.0 121084.0 121154.0 50062.7 50408.7 50472.0 50617.2 50655.5 1070.7 1097.8 1171.5 1207.7 1210.2 28122.4 29279.3 29300.7 29930.3 30113.8 41994.6 42119.4 42550.6 42559.0 42592.8 243422.0 244665.0 244744.0 245244.0 245863.0 20421.0 21087.0 21250.4 22066.7 25390.7 42617.8 43407.3 43430.3 43549.0 43624.0 36639.8 37422.3 37438.8 37977.4 38316.4 36554.0 37299.6 37345.0 37633.2 37762.4 34937.7 35027.6 35239.3 36811.0 38047.6 25395.2 25990.5 26534.7 27052.9 27102.2 24009.4 24265.0 24362.6 24486.8 24767.1 10:18:06 INFO - PROCESS | 7999 | 10:18:06 INFO - PROCESS | 7999 | [#2] jquery.html Cycles:180 Average:24253.35 Median:4988.85 stddev:66049.21 (1323.9%) stddev-sans-first:66210.17 10:18:06 INFO - PROCESS | 7999 | Values: 377.8 379.2 380.4 391.2 393.6 15995.2 17325.2 17494.8 17783.9 17871.1 16970.5 17001.4 17373.5 17744.1 17774.8 4975.8 5167.7 5204.7 5220.9 5221.5 3731.9 3926.2 3938.4 6141.8 6149.9 6199.5 6223.0 6237.2 6243.7 6249.9 5886.7 6026.5 6034.6 6036.0 6071.6 3419.9 5001.9 5274.6 5299.0 5357.5 20591.9 21193.6 21249.5 21254.6 21374.9 2025.8 2243.1 2303.0 2435.6 2518.0 12466.7 13274.3 13295.5 13553.1 13854.8 1688.4 1707.4 1715.7 1814.5 1830.9 65414.7 67585.0 68217.0 68402.0 68909.0 9189.2 9270.5 9795.2 9811.5 9912.8 13812.7 13832.1 13877.3 13898.0 13907.7 7230.9 7272.0 7299.6 7350.2 7378.6 7038.4 7152.1 7186.4 7286.5 7309.2 6190.3 6261.5 6285.8 6299.4 6348.7 1755.5 1759.5 1770.8 1776.7 1796.4 838.7 863.9 915.5 966.6 991.1 16680.9 17117.4 17591.7 17913.4 17954.3 875.9 900.3 918.4 944.4 952.2 9803.5 9981.0 10378.9 10502.5 10512.6 387393.0 392951.0 406860.0 412106.0 413060.0 43370.6 45855.5 66567.0 69322.0 69870.7 905.4 913.2 934.3 939.7 963.8 11780.6 15274.8 15748.1 16580.9 16828.2 30455.4 35887.5 38304.8 38652.4 40450.4 47850.0 51757.0 52034.0 52238.5 52344.5 7520.4 7698.3 7711.6 7981.5 8139.2 5910.1 5979.9 11803.2 11871.6 12127.6 6741.5 8068.0 9996.9 10041.8 10042.4 9704.6 10402.7 10595.2 10626.0 10761.6 7736.3 9814.0 10144.5 10442.0 10494.5 6698.9 7040.7 7070.3 7954.2 8068.1 8829.0 9900.0 10069.3 10072.6 10270.6 10:18:06 INFO - PROCESS | 7999 | 10:18:06 INFO - PROCESS | 7999 | [#3] mootools.html Cycles:180 Average:5197.21 Median:4812.92 stddev:2970.06 (61.7%) stddev-sans-first:2963.38 10:18:06 INFO - PROCESS | 7999 | Values: 1223.4 1411.4 1440.1 1542.5 1716.5 6810.8 7651.6 7911.6 7918.0 8103.5 7972.8 7982.8 8040.7 8042.1 8051.5 2209.6 2239.3 2240.8 2240.9 2242.5 2148.2 2189.5 2196.6 2199.1 2199.8 2202.2 2206.6 2219.9 2222.5 2241.1 2160.4 2167.7 2172.6 2173.9 2174.5 2118.0 2135.5 2161.8 2162.5 2164.1 7843.5 7970.4 8029.4 8030.8 8047.2 4652.5 4796.0 4798.3 4812.4 4813.4 2758.6 2857.4 2883.7 2885.3 2902.4 866.3 867.2 869.6 875.2 883.3 11017.1 11091.5 11146.7 11151.4 11168.7 4082.6 4177.6 4245.4 4267.3 4276.9 8623.1 8711.1 8729.4 8733.9 8738.0 4603.9 4653.8 4713.2 4716.4 4716.4 3744.3 4214.3 4382.1 4403.1 4432.9 3515.6 3536.1 3591.1 3601.0 3626.7 1050.4 1053.8 1065.9 1069.9 1078.2 732.9 840.8 863.4 865.7 866.7 5320.6 5344.7 5544.7 5628.4 5670.6 403.9 408.8 411.6 414.1 421.0 3574.6 3664.9 3798.8 3807.4 3842.6 9631.3 10011.0 10023.4 10091.7 10135.3 9943.3 9949.7 9970.6 9999.7 10012.8 6817.7 7396.2 7458.7 7510.8 7535.1 5448.6 5449.0 5470.2 5560.4 5611.6 9036.6 9243.0 9310.8 9312.8 9320.1 8949.4 9253.3 9275.9 9372.8 9378.7 6067.2 6262.0 6280.9 6615.5 6803.3 7089.8 7161.4 7234.6 7298.7 7299.6 6707.6 6959.9 6999.6 7059.9 7142.4 6704.2 6705.8 6746.6 6833.0 6863.5 6375.1 6389.4 6428.9 6462.5 6490.3 4483.0 4529.8 4535.5 4604.0 4627.7 4634.6 4648.1 4816.5 4846.8 4901.3 10:18:06 INFO - PROCESS | 7999 | 10:18:06 INFO - PROCESS | 7999 | [#4] prototype.html Cycles:180 Average:4162.55 Median:4638.78 stddev:1207.34 (26.0%) stddev-sans-first:1175.43 10:18:06 INFO - PROCESS | 7999 | Values: 301.2 301.8 305.8 315.9 318.0 4687.7 4790.9 4827.6 4828.6 4840.2 4647.3 4856.6 4866.3 4872.4 4887.1 3820.5 3832.4 3854.0 3868.3 3871.9 3688.7 3693.0 3824.4 3887.3 3908.8 3823.4 3845.6 3851.3 3855.6 3859.7 3824.8 3829.3 3829.6 3836.2 3845.3 3399.5 3413.2 3417.0 3419.2 3425.2 4604.5 4718.3 4738.7 4745.7 4747.2 4364.3 4386.4 4394.2 4397.8 4403.2 5068.3 5083.0 5092.2 5099.3 5104.4 3576.8 3711.6 3719.7 3722.2 3748.4 5245.8 5278.2 5284.7 5300.7 5315.4 3785.1 3788.1 3803.1 3834.7 3841.1 3779.0 3874.6 3892.8 3894.0 3895.6 4345.5 4357.6 4357.7 4358.2 4373.3 4976.4 4980.8 4994.2 4999.0 5082.7 1268.6 1282.7 1309.4 1323.0 1338.9 862.3 864.2 881.1 882.9 891.8 3986.8 3988.9 3994.5 3998.8 4039.2 4611.3 4630.3 4673.1 4720.4 4732.5 3930.2 3979.2 4008.3 4043.4 4065.2 2306.0 2427.5 2443.0 2471.7 2485.6 4329.6 4357.7 4366.9 4371.7 4382.0 4704.0 4748.5 4752.5 4779.5 4785.3 4380.2 4408.9 4562.5 4980.6 5003.0 5281.9 5300.6 5309.4 5318.9 5325.7 5175.4 5191.6 5197.1 5204.2 5208.6 4690.1 4909.0 4940.9 4973.5 4981.4 3697.4 3717.8 3728.2 3730.6 3731.9 5023.1 5253.3 5283.5 5308.7 5309.4 4981.5 5039.5 5079.8 5133.8 5159.0 5113.9 5127.8 5130.8 5148.2 5152.5 4802.6 5021.9 5042.8 5047.7 5075.6 5203.2 5211.9 5221.2 5230.5 5239.7 5091.2 5101.2 5101.6 5107.3 5111.4 10:18:06 INFO - PROCESS | 7999 | 10:18:06 INFO - PROCESS | 7999 | [#5] yui.html Cycles:180 Average:16629.47 Median:4151.58 stddev:23293.05 (561.1%) stddev-sans-first:23327.55 10:18:06 INFO - PROCESS | 7999 | Values: 665.2 665.4 699.5 705.0 720.9 11767.2 12164.0 12182.6 12182.8 12286.4 12297.4 12355.4 12367.3 12436.6 12450.3 616.5 764.3 786.1 791.8 793.9 787.3 799.9 800.0 800.1 801.5 834.8 836.7 842.2 842.7 843.0 647.2 813.6 828.9 836.1 837.0 606.3 606.7 607.3 607.7 608.0 12308.3 12310.8 12350.6 12355.3 12362.3 12453.7 13018.4 13121.7 13160.8 13204.8 10287.4 10385.2 10385.4 10414.1 10436.9 3213.7 4131.2 4172.0 4196.8 4305.4 51945.5 58077.4 58477.7 58559.0 58785.4 9806.5 10247.4 10337.2 10345.5 10406.4 17301.5 17326.2 17343.7 17421.7 17579.6 6712.6 6731.4 6740.7 6782.1 6853.6 3716.6 3730.2 3775.9 3805.6 3872.9 2874.0 2968.2 2975.7 2977.1 2978.0 500.6 517.6 518.0 532.4 569.8 396.7 508.6 571.4 584.8 585.4 7024.2 7405.5 7462.0 7559.7 7586.7 507.8 539.2 545.8 549.8 557.8 3312.5 3580.1 3624.5 3669.8 3695.2 86684.1 89025.6 90181.0 90481.0 91993.5 78135.6 80137.2 81056.0 81529.0 83844.0 70390.0 71587.0 71759.0 72078.0 72092.3 6412.1 6512.1 6631.5 6712.9 6802.3 37955.8 40275.8 42154.0 42878.4 42882.0 38635.2 40164.6 40390.6 59755.0 60342.1 10134.2 10320.5 10447.5 10831.9 11393.7 12519.1 12999.8 13125.5 13468.3 13470.9 12052.0 12160.9 12190.2 12247.6 12898.8 12316.5 12322.8 12657.6 12682.6 13061.3 11230.3 11526.1 11771.0 12141.8 12147.3 10060.6 10291.4 10567.9 10626.7 10672.7 9817.3 10252.6 10485.8 10534.2 10577.3 10:18:06 INFO - PROCESS | 7999 | -------- Summary: end -------- 10:18:06 INFO - PROCESS | 7999 | 10:18:07 INFO - TEST-INFO | 7999: exit 0 10:18:07 INFO - TEST-OK | dromaeo_css | took 1120479ms 10:18:07 INFO - TEST-START | kraken 10:18:07 INFO - operating with platform_type : linux_ 10:18:07 INFO - Initialising browser for kraken test... 10:18:07 INFO - TEST-INFO | started process 8182 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfCfFxR/profile http://localhost:52628/getInfo.html) 10:18:11 INFO - PROCESS | 8182 | __metrics Screen width/height:1600/1200 10:18:11 INFO - PROCESS | 8182 | colorDepth:24 10:18:11 INFO - PROCESS | 8182 | Browser inner width/height: 1024/697 10:18:11 INFO - PROCESS | 8182 | __metrics 10:18:12 INFO - PROCESS | 8182 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:18:13 INFO - PROCESS | 8182 | console.error: PushService: 10:18:13 INFO - PROCESS | 8182 | stateChangeProcessEnqueue: Error transitioning state 10:18:13 INFO - PROCESS | 8182 | UnknownError 10:18:14 INFO - TEST-INFO | 8182: exit 0 10:18:14 INFO - Browser initialized. 10:18:14 INFO - Running cycle 1/1 for kraken test... 10:18:14 INFO - TEST-INFO | started process 8261 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfCfFxR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:18:26 INFO - PROCESS | 8261 | RSS: Main: 176119808 10:18:26 INFO - PROCESS | 8261 | 10:18:28 INFO - PROCESS | 8261 | Cycle 1(1): loaded http://localhost:52628/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52628/tests/kraken/driver.html?testName=audio-beat-detection) 10:18:29 INFO - PROCESS | 8261 | RSS: Main: 233381888 10:18:29 INFO - PROCESS | 8261 | 10:18:32 INFO - PROCESS | 8261 | Cycle 1(1): loaded http://localhost:52628/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52628/tests/kraken/driver.html?testName=audio-dft) 10:18:33 INFO - PROCESS | 8261 | RSS: Main: 221003776 10:18:33 INFO - PROCESS | 8261 | 10:18:36 INFO - PROCESS | 8261 | Cycle 1(1): loaded http://localhost:52628/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52628/tests/kraken/driver.html?testName=audio-fft) 10:18:37 INFO - PROCESS | 8261 | RSS: Main: 289427456 10:18:37 INFO - PROCESS | 8261 | 10:18:39 INFO - PROCESS | 8261 | Cycle 1(1): loaded http://localhost:52628/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52628/tests/kraken/driver.html?testName=audio-oscillator) 10:18:39 INFO - PROCESS | 8261 | RSS: Main: 199344128 10:18:39 INFO - PROCESS | 8261 | 10:18:42 INFO - PROCESS | 8261 | Cycle 1(1): loaded http://localhost:52628/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52628/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:18:42 INFO - PROCESS | 8261 | RSS: Main: 203227136 10:18:42 INFO - PROCESS | 8261 | 10:18:46 INFO - PROCESS | 8261 | Cycle 1(1): loaded http://localhost:52628/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52628/tests/kraken/driver.html?testName=imaging-darkroom) 10:18:46 INFO - PROCESS | 8261 | RSS: Main: 239259648 10:18:46 INFO - PROCESS | 8261 | 10:18:50 INFO - PROCESS | 8261 | Cycle 1(1): loaded http://localhost:52628/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52628/tests/kraken/driver.html?testName=imaging-desaturate) 10:18:50 INFO - PROCESS | 8261 | RSS: Main: 235626496 10:18:50 INFO - PROCESS | 8261 | 10:18:53 INFO - PROCESS | 8261 | Cycle 1(1): loaded http://localhost:52628/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52628/tests/kraken/driver.html?testName=json-parse-financial) 10:18:54 INFO - PROCESS | 8261 | RSS: Main: 237756416 10:18:54 INFO - PROCESS | 8261 | 10:18:55 INFO - PROCESS | 8261 | Cycle 1(1): loaded http://localhost:52628/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52628/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:18:56 INFO - PROCESS | 8261 | RSS: Main: 224706560 10:18:56 INFO - PROCESS | 8261 | 10:18:58 INFO - PROCESS | 8261 | Cycle 1(1): loaded http://localhost:52628/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52628/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:18:59 INFO - PROCESS | 8261 | RSS: Main: 228868096 10:18:59 INFO - PROCESS | 8261 | 10:19:01 INFO - PROCESS | 8261 | Cycle 1(1): loaded http://localhost:52628/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52628/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:19:02 INFO - PROCESS | 8261 | RSS: Main: 236097536 10:19:02 INFO - PROCESS | 8261 | 10:19:04 INFO - PROCESS | 8261 | Cycle 1(1): loaded http://localhost:52628/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52628/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:19:05 INFO - PROCESS | 8261 | RSS: Main: 239202304 10:19:05 INFO - PROCESS | 8261 | 10:19:08 INFO - PROCESS | 8261 | Cycle 1(1): loaded http://localhost:52628/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52628/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:19:08 INFO - PROCESS | 8261 | RSS: Main: 239792128 10:19:08 INFO - PROCESS | 8261 | 10:19:10 INFO - PROCESS | 8261 | Cycle 1(1): loaded http://localhost:52628/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52628/tests/kraken/driver.html?testName=ai-astar) 10:19:10 INFO - PROCESS | 8261 | RSS: Main: 282517504 10:19:10 INFO - PROCESS | 8261 | 10:19:10 INFO - PROCESS | 8261 | __start_tp_report 10:19:10 INFO - PROCESS | 8261 | _x_x_mozilla_page_load 10:19:10 INFO - PROCESS | 8261 | _x_x_mozilla_page_load_details 10:19:10 INFO - PROCESS | 8261 | |i|pagename|runs| 10:19:10 INFO - PROCESS | 8261 | |0;ai-astar;111;111;113;113;113;111;113;111;113;113 10:19:10 INFO - PROCESS | 8261 | |1;audio-beat-detection;163;132;136;189;132;131;157;130;187;131 10:19:10 INFO - PROCESS | 8261 | |2;audio-dft;164;162;160;162;162;162;162;162;162;162 10:19:10 INFO - PROCESS | 8261 | |3;audio-fft;76;75;76;102;75;76;75;75;106;76 10:19:10 INFO - PROCESS | 8261 | |4;audio-oscillator;85;86;113;86;85;84;120;86;85;132 10:19:10 INFO - PROCESS | 8261 | |5;imaging-gaussian-blur;116;117;117;116;117;116;117;117;116;117 10:19:10 INFO - PROCESS | 8261 | |6;imaging-darkroom;148;147;147;147;147;146;146;146;146;146 10:19:10 INFO - PROCESS | 8261 | |7;imaging-desaturate;96;95;95;94;94;94;95;95;95;94 10:19:10 INFO - PROCESS | 8261 | |8;json-parse-financial;62;61;64;62;62;63;62;63;63;63 10:19:10 INFO - PROCESS | 8261 | |9;json-stringify-tinderbox;65;65;66;66;69;64;65;65;65;65 10:19:10 INFO - PROCESS | 8261 | |10;stanford-crypto-aes;85;83;83;84;88;84;89;84;122;84 10:19:10 INFO - PROCESS | 8261 | |11;stanford-crypto-ccm;130;129;141;138;141;129;128;140;134;136 10:19:10 INFO - PROCESS | 8261 | |12;stanford-crypto-pbkdf2;172;175;171;169;170;171;172;171;187;177 10:19:10 INFO - PROCESS | 8261 | |13;stanford-crypto-sha256-iterative;70;67;77;67;67;72;68;67;67;67 10:19:10 INFO - PROCESS | 8261 | __end_tp_report 10:19:10 INFO - PROCESS | 8261 | __start_cc_report 10:19:10 INFO - PROCESS | 8261 | _x_x_mozilla_cycle_collect,1953 10:19:10 INFO - PROCESS | 8261 | __end_cc_report 10:19:10 INFO - PROCESS | 8261 | __startTimestamp1465838350968__endTimestamp 10:19:10 INFO - PROCESS | 8261 | 10:19:10 INFO - PROCESS | 8261 | ------- Summary: start ------- 10:19:10 INFO - PROCESS | 8261 | Number of tests: 14 10:19:10 INFO - PROCESS | 8261 | 10:19:10 INFO - PROCESS | 8261 | [#0] ai-astar Cycles:10 Average:112.20 Median:113.00 stddev:1.03 (0.9%) stddev-sans-first:1.00 10:19:10 INFO - PROCESS | 8261 | Values: 111.0 111.0 113.0 113.0 113.0 111.0 113.0 111.0 113.0 113.0 10:19:10 INFO - PROCESS | 8261 | 10:19:10 INFO - PROCESS | 8261 | [#1] audio-beat-detection Cycles:10 Average:148.80 Median:146.50 stddev:23.71 (16.2%) stddev-sans-first:24.59 10:19:10 INFO - PROCESS | 8261 | Values: 163.0 132.0 136.0 189.0 132.0 131.0 157.0 130.0 187.0 131.0 10:19:10 INFO - PROCESS | 8261 | 10:19:10 INFO - PROCESS | 8261 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.94 (0.6%) stddev-sans-first:0.67 10:19:10 INFO - PROCESS | 8261 | Values: 164.0 162.0 160.0 162.0 162.0 162.0 162.0 162.0 162.0 162.0 10:19:10 INFO - PROCESS | 8261 | 10:19:10 INFO - PROCESS | 8261 | [#3] audio-fft Cycles:10 Average:81.20 Median:75.50 stddev:12.06 (16.0%) stddev-sans-first:12.65 10:19:10 INFO - PROCESS | 8261 | Values: 76.0 75.0 76.0 102.0 75.0 76.0 75.0 75.0 106.0 76.0 10:19:10 INFO - PROCESS | 8261 | 10:19:10 INFO - PROCESS | 8261 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:85.00 stddev:18.16 (21.4%) stddev-sans-first:18.80 10:19:10 INFO - PROCESS | 8261 | Values: 85.0 86.0 113.0 86.0 85.0 84.0 120.0 86.0 85.0 132.0 10:19:10 INFO - PROCESS | 8261 | 10:19:10 INFO - PROCESS | 8261 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 10:19:10 INFO - PROCESS | 8261 | Values: 116.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 116.0 117.0 10:19:10 INFO - PROCESS | 8261 | 10:19:10 INFO - PROCESS | 8261 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.53 10:19:10 INFO - PROCESS | 8261 | Values: 148.0 147.0 147.0 147.0 147.0 146.0 146.0 146.0 146.0 146.0 10:19:10 INFO - PROCESS | 8261 | 10:19:10 INFO - PROCESS | 8261 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.53 10:19:10 INFO - PROCESS | 8261 | Values: 96.0 95.0 95.0 94.0 94.0 94.0 95.0 95.0 95.0 94.0 10:19:10 INFO - PROCESS | 8261 | 10:19:10 INFO - PROCESS | 8261 | [#8] json-parse-financial Cycles:10 Average:62.50 Median:63.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 10:19:10 INFO - PROCESS | 8261 | Values: 62.0 61.0 64.0 62.0 62.0 63.0 62.0 63.0 63.0 63.0 10:19:10 INFO - PROCESS | 8261 | 10:19:10 INFO - PROCESS | 8261 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:65.00 stddev:1.35 (2.1%) stddev-sans-first:1.42 10:19:10 INFO - PROCESS | 8261 | Values: 65.0 65.0 66.0 66.0 69.0 64.0 65.0 65.0 65.0 65.0 10:19:10 INFO - PROCESS | 8261 | 10:19:10 INFO - PROCESS | 8261 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:84.00 stddev:11.91 (14.2%) stddev-sans-first:12.56 10:19:10 INFO - PROCESS | 8261 | Values: 85.0 83.0 83.0 84.0 88.0 84.0 89.0 84.0 122.0 84.0 10:19:10 INFO - PROCESS | 8261 | 10:19:10 INFO - PROCESS | 8261 | [#11] stanford-crypto-ccm Cycles:10 Average:134.60 Median:137.00 stddev:5.30 (3.9%) stddev-sans-first:5.35 10:19:10 INFO - PROCESS | 8261 | Values: 130.0 129.0 141.0 138.0 141.0 129.0 128.0 140.0 134.0 136.0 10:19:10 INFO - PROCESS | 8261 | 10:19:10 INFO - PROCESS | 8261 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.50 Median:172.00 stddev:5.30 (3.1%) stddev-sans-first:5.59 10:19:10 INFO - PROCESS | 8261 | Values: 172.0 175.0 171.0 169.0 170.0 171.0 172.0 171.0 187.0 177.0 10:19:10 INFO - PROCESS | 8261 | 10:19:10 INFO - PROCESS | 8261 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:67.50 stddev:3.31 (4.9%) stddev-sans-first:3.49 10:19:10 INFO - PROCESS | 8261 | Values: 70.0 67.0 77.0 67.0 67.0 72.0 68.0 67.0 67.0 67.0 10:19:10 INFO - PROCESS | 8261 | -------- Summary: end -------- 10:19:10 INFO - PROCESS | 8261 | 10:19:12 INFO - TEST-INFO | 8261: exit 0 10:19:12 INFO - TEST-OK | kraken | took 64834ms 10:19:12 INFO - SUITE-END | took 1185s 10:19:12 INFO - Completed test suite (00:19:45) 10:19:12 INFO - javascript benchmark 10:19:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2645.748653877881, 2651.0, 2692.8653567321635, 2694.030149146307, 2703.0, 4691.5777580017875, 4782.450018247902, 4785.401824771903, 4896.216605343141, 4905.460399356068, 4765.356676848624, 4797.448293446255, 4804.087223427547, 4804.759762011894, 4821.156297647906, 4336.262835318003, 4365.934510982338, 4438.600525952664, 4466.486354069291, 4533.455985281771, 4439.156560253574, 4476.529964353745, 4497.820087196508, 4503.684742068041, 4528.04910968697, 4334.978325108385, 4343.2182207202695, 4388.078503514266, 4400.185965596343, 4452.354408610766, 4464.374987501752, 4528.569785870337, 4532.093581283723, 4532.501424843264, 4580.496145424001, 4457.153140903218, 4469.083837813273, 4511.097780443924, 4519.435070616173, 4525.343825145368, 4693.530646935279, 4715.0, 4756.714597124149, 4806.0, 4882.170031094723, 5207.895842083137, 5210.452902445264, 5219.42586315505, 5236.345456817898, 5237.8428647140645, 5052.368453943257, 5190.195519694454, 5246.029484545371, 5249.265102885599, 5250.894982100374, 4843.079814835135, 4866.29438731389, 4867.537583929521, 4875.804967801319, 4899.975500122477, 5376.973115134399, 5380.300560927133, 5391.595630327741, 5391.892162156735, 5407.432219616962, 4973.751312434364, 5084.567811736044, 5095.414027386898, 5129.64092513528, 5140.588752899759, 5242.0, 5254.369475662945, 5280.287161233261, 5280.630355875129, 5330.360356757214, 5212.609054320941, 5230.869228269324, 5232.693440812791, 5236.0, 5285.07511185541, 4967.130752118364, 5146.382434107931, 5188.507091826271, 5197.974010129925, 5202.0, 4390.5828946250695, 4415.492218394926, 4441.533638967927, 4458.175237580993, 4458.576435238647, 3857.228554289153, 3873.1091848874353, 3883.0680636647003, 3888.202918401721, 3911.647951684362, 4324.372965919924, 4362.8036738346855, 4364.454443194601, 4447.177272204653, 4488.820447182142, 5236.29310043147, 5252.1596544552685, 5267.999080174754, 5272.604554658416, 5275.076861549213, 4423.447069116361, 4435.733855968652, 4436.157130145262, 4483.32750087483, 4483.55164483549, 4541.114482675846, 4674.205385084544, 4715.339852420664, 4717.339572459859, 4723.102610503994, 4836.661433699748, 4864.173090574682, 4886.267059941038, 4932.827351042696, 4955.727434991038, 5179.81870634526, 5210.322658054429, 5222.608304377263, 5224.7126408047925, 5239.187925871496, 4697.835575754969, 4862.805487780449, 4881.8535443936735, 4912.0, 4914.92627610579, 5165.457626949116, 5217.269582258563, 5217.556507696889, 5220.582353411642, 5223.085959956917, 5197.194434862602, 5251.054810134213, 5270.525652691276, 5275.103232450416, 5305.65513241638, 4856.441509226484, 4975.552200301845, 5041.067402530543, 5055.090083784807, 5072.51811077947, 5032.647714659939, 5079.415867175322, 5133.307003554472, 5134.5635620972635, 5188.688678679291, 4852.0, 5046.59627229828, 5069.9746501267255, 5100.770465329143, 5118.820841270538, 5062.519060689228, 5121.411037730709, 5127.307813445137, 5137.460566640449, 5152.072626927189, 5013.473585273639, 5038.345015148007, 5043.747812609428, 5054.949450505448, 5086.694798312114], "value": 4773.6495751664315, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.2951687491885, 595.0301009354752, 599.8470390050536, 603.2730559675591, 608.370336701514, 27452.588211176822, 39657.405138922906, 40127.0, 40382.0, 43667.34498982518, 41293.0, 41737.582624173825, 41741.16517669645, 41769.58230417703, 41850.58149418505, 7372.74195403161, 7747.535147891116, 7895.131535531087, 7897.842043159133, 7898.05223373196, 9735.610575576968, 9987.850182247272, 9988.051135142186, 10381.221408394364, 10389.0, 10115.039071288216, 10205.03052210039, 10256.487175641225, 10259.538320775546, 10272.845907311395, 7502.774916752506, 9895.208383329316, 10137.239707022003, 10144.036316549917, 10231.488425578691, 9992.250581206366, 10028.348157369821, 10041.246906482043, 10053.949730251303, 10123.1901447884, 38497.80751096254, 38806.80596597027, 38860.0, 38890.22219555621, 38909.61090389088, 3165.2403423178503, 3193.5369371441243, 3301.290222602128, 3401.642827503101, 3462.982685086584, 29127.563086553717, 29199.0, 29735.25661858449, 29891.25271868199, 30069.849650751825, 3395.456726923705, 3410.0545728452644, 3428.6571342865764, 3441.82790860456, 3520.612732599412, 245097.0, 245314.0, 245322.77338613372, 245986.0, 246977.0, 31610.525842112387, 51328.48671513312, 51647.741761290956, 51760.74119629453, 51779.0, 31877.362452750815, 32618.673813261565, 32815.83592082072, 32944.505832412535, 32976.835115824266, 12912.935435322952, 13082.803757943639, 13093.541726039733, 13094.083414161109, 13105.868941310655, 8869.334799890034, 10470.581176752845, 10724.356538607708, 10749.83875241872, 10827.917208279108, 7537.773866784005, 7557.2820582044615, 7585.886211706828, 7591.240875912365, 7612.7716168515035, 2906.97093029067, 2992.3716019635685, 3015.7135072168107, 3025.198322444554, 3026.122424496871, 821.5645707774889, 899.7480705402497, 935.9110884465965, 1013.3869009249445, 1055.2771351624008, 28267.0, 28560.0, 28560.571591426145, 28871.566926496118, 29050.564241536395, 918.2791508665799, 958.9280803939592, 987.2496902354262, 988.960441582343, 1003.7741508160606, 14911.850881491046, 14981.625459363386, 15228.771568426482, 15534.844651553565, 15551.766723499157, 120431.0, 120464.0, 121031.0, 121084.0, 121154.0, 50062.749686251336, 50408.747956259984, 50472.0, 50617.24074138891, 50655.49344506581, 1070.6680928912062, 1097.8078836203792, 1171.4552732979205, 1207.7161866961258, 1210.1589395370133, 28122.43755124927, 29279.268018299714, 29300.70699293065, 29930.25174370658, 30113.849430752707, 41994.58005419907, 42119.36820947749, 42550.57449425466, 42558.95689909453, 42592.78703606586, 243422.0, 244665.0, 244744.0, 245244.0, 245863.0, 20421.0, 21087.0, 21250.36248912535, 22066.668999965335, 25390.746092538837, 42617.78691106648, 43407.34888976605, 43430.34854477249, 43549.0, 43624.0, 36639.816800915825, 37422.25155496929, 37438.8128059358, 37977.4303385455, 38316.42525362066, 36554.0, 37299.62700372961, 37345.0, 37633.2473350537, 37762.43356349602, 34937.65062349344, 35027.649723502436, 35239.295214096084, 36811.0, 38047.61952380441, 25395.238142855746, 25990.480190396465, 26534.734652653227, 27052.864735676194, 27102.186934392, 24009.399765006016, 24265.0, 24362.634560481252, 24486.75513244845, 24767.13315034037], "value": 16133.481753925114, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.7620099337417, 379.1601602450572, 380.4027676547821, 391.15900813251505, 393.5926316262669, 15995.200239988013, 17325.22036508357, 17494.82505174951, 17783.91108044458, 17871.106444677764, 16970.49088527343, 17001.404950826724, 17373.478795636118, 17744.112794360295, 17774.822251777478, 4975.751212439382, 5167.689938603677, 5204.739763011853, 5220.947790522103, 5221.503957124067, 3731.9440208396895, 3926.214757048587, 3938.448617193595, 6141.754329826824, 6149.938500614981, 6199.504039676837, 6223.035429508411, 6237.18916540849, 6243.687815609224, 6249.906266403384, 5886.705664716747, 6026.517878569748, 6034.607750496248, 6036.034234522455, 6071.632063495241, 3419.9487007694906, 5001.949980500185, 5274.55166310864, 5299.046171689094, 5357.517823395913, 20591.8970405147, 21193.576128477343, 21249.468763281042, 21254.574908501745, 21374.89312553443, 2025.7872923343132, 2243.057915675404, 2302.9769702303097, 2435.5737745894576, 2517.962230566543, 12466.688332791662, 13274.269915154759, 13295.53465628708, 13553.119047261896, 13854.792178117335, 1688.425935182044, 1707.42801161611, 1715.665445238179, 1814.482872381365, 1830.8718389712726, 65414.67292663554, 67584.98622520617, 68217.0, 68402.0, 68909.0, 9189.218916392181, 9270.490123043162, 9795.179879846723, 9811.460369679593, 9912.752181195383, 13812.654683632789, 13832.100913440594, 13877.306134693426, 13898.0, 13907.652308692364, 7230.927690723025, 7272.0, 7299.635018249172, 7350.191478937312, 7378.631068446556, 7038.40173585251, 7152.105986751656, 7186.389156921616, 7286.48994570375, 7309.232530584319, 6190.3190649028575, 6261.526696954677, 6285.842853928689, 6299.370062993664, 6348.650824204621, 1755.4551994245237, 1759.5337235632567, 1770.8317709817804, 1776.67131580658, 1796.4071856287394, 838.6980686952692, 863.9006514250941, 915.4873270968279, 966.5747071288611, 991.0634450444405, 16680.916595416944, 17117.42045375782, 17591.73612395815, 17913.37303194382, 17954.281828726966, 875.9474431534128, 900.3202582050641, 918.4351623751345, 944.419182202954, 952.2049089010616, 9803.460809655395, 9981.0, 10378.896211037792, 10502.474876256156, 10512.579496820195, 387393.0, 392951.0, 406860.0, 412106.0, 413060.0, 43370.56629433728, 45855.54144458513, 66567.0, 69322.0, 69870.65064674745, 905.4024343932973, 913.2009491694768, 934.2759361494896, 939.6852054561662, 963.8120566489607, 11780.646580602595, 15274.847251527786, 15748.133852638215, 16580.917095414447, 16828.242729076977, 30455.390892182477, 35887.461688074174, 38304.80847595744, 38652.420213697376, 40450.39324410195, 47850.0, 51757.0, 52034.0, 52238.47761522336, 52344.47655523396, 7520.435967302365, 7698.307152356315, 7711.575863327571, 7981.521108733495, 8139.186081391814, 5910.054391297372, 5979.910301345396, 11803.173777835469, 11871.643850684493, 12127.57553485659, 6741.460683145435, 8067.959660201662, 9996.900030999597, 10041.799164016826, 10042.397456152654, 9704.563294651898, 10402.739931501774, 10595.15238780911, 10626.0, 10761.569537218737, 7736.303732664087, 9813.950930245303, 10144.54349554257, 10442.0, 10494.527746251284, 6698.899516507354, 7040.718371265092, 7070.257622949516, 7954.164812694584, 8068.07217170033, 8829.0, 9900.0, 10069.295149339476, 10072.647457339252, 10270.6405275815], "value": 8340.960406815604, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1223.406647775829, 1411.449534681474, 1440.1287221231155, 1542.5141080559622, 1716.4936343778593, 6810.761623343184, 7651.579163146025, 7911.60441977901, 7918.049834019926, 8103.513789172654, 7972.840543189132, 7982.800429989239, 8040.678372865078, 8042.075161356446, 8051.476654017485, 2209.569134018867, 2239.283429302624, 2240.7535171131244, 2240.9439764005947, 2242.4618091657967, 2148.151480165334, 2189.4526368407896, 2196.5716685246384, 2199.087378737822, 2199.802017818396, 2202.2402271216406, 2206.646936490162, 2219.9001044953015, 2222.4888275696517, 2241.1371621925596, 2160.384290477214, 2167.6640120781303, 2172.576347612216, 2173.8913054347377, 2174.510735084609, 2118.03629348646, 2135.4874830040835, 2161.8378621603283, 2162.4593851537115, 2164.1127137873395, 7843.529388236667, 7970.362371010363, 8029.437939344249, 8030.839383212303, 8047.195280471906, 4652.464966528859, 4796.0, 4798.256270278112, 4812.446568644616, 4813.3983252093485, 2758.6275852760023, 2857.3713782967716, 2883.7260460256243, 2885.293103189711, 2902.3759891623404, 866.3459088388289, 867.2151702709058, 869.5869462005497, 875.159846547309, 883.2624758326805, 11017.063549598293, 11091.500882460308, 11146.665600032013, 11151.442427878656, 11168.66494005181, 4082.6121518455698, 4177.56135605757, 4245.405643209953, 4267.317229243306, 4276.893077673083, 8623.137686231452, 8711.128887111365, 8729.388942774072, 8733.868991965126, 8738.0, 4603.884902877455, 4653.813847446064, 4713.198756211452, 4716.410448693913, 4716.434027916672, 3744.251149770057, 4214.262504061777, 4382.05785756064, 4403.097365040159, 4432.867013989586, 3515.5957064937347, 3536.1159710072484, 3591.120175557005, 3600.963990360063, 3626.746127771031, 1050.4117694091333, 1053.757635743783, 1065.9040686338267, 1069.850220969065, 1078.1590359519587, 732.9006490264603, 840.7561807076002, 863.369740089738, 865.7056600755773, 866.7269810009826, 5320.600954928318, 5344.706041167696, 5544.695041772741, 5628.409017053233, 5670.631408958405, 403.92729308724125, 408.75883228895094, 411.6295334199245, 414.0890041907755, 421.04212915617217, 3574.5889222739197, 3664.9083772905356, 3798.772073675588, 3807.3908174691915, 3842.5773164951834, 9631.325807193569, 10011.0, 10023.398596084258, 10091.69724908254, 10135.341202821794, 9943.254255930835, 9949.651762188289, 9970.551325190383, 9999.700008999742, 10012.849807252896, 6817.727290908408, 7396.223396543393, 7458.70165193397, 7510.849783004419, 7535.058117735283, 5448.645838020516, 5448.972755136199, 5470.152126420411, 5560.388357280615, 5611.579131565068, 9036.59335329925, 9242.953785231031, 9310.813783724423, 9312.767180820534, 9320.114589114024, 8949.418287811272, 9253.259739220981, 9275.86086208721, 9372.812543749224, 9378.718638440858, 6067.180930574493, 6262.0, 6280.905786413299, 6615.536912416084, 6803.25164231944, 7089.7873063808165, 7161.355478007004, 7234.63826808668, 7298.744543940937, 7299.635018249172, 6707.5975441473665, 6959.8608027838145, 6999.615021173884, 7059.858802824017, 7142.392896603639, 6704.229013663491, 6705.765298214539, 6746.628935408599, 6833.0, 6863.519553631198, 6375.107484952203, 6389.393007664265, 6428.935710642833, 6462.515311351762, 6490.3185165558825, 4482.955170448254, 4529.796159172779, 4535.523770004234, 4604.0331530379, 4627.745473998963, 4634.629229661687, 4648.140094082605, 4816.470188279357, 4846.757662116809, 4901.3383193268455], "value": 4083.243646400729, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.22885413341845, 301.79477954990614, 305.7676166113753, 315.8625997691003, 318.0347644897736, 4687.69529980551, 4790.856274311767, 4827.589654879335, 4828.633969355013, 4840.225563909775, 4647.302904564317, 4856.635752318582, 4866.294387313837, 4872.3677568014755, 4887.144749668802, 3820.522434695663, 3832.386818109103, 3853.9614603854025, 3868.323043467396, 3871.9032024199337, 3688.7417880748358, 3693.0, 3824.445455408964, 3887.319719049169, 3908.8045597720143, 3823.3500304948225, 3845.576986531479, 3851.3054256127352, 3855.61443855615, 3859.729818912663, 3824.7896365699876, 3829.3107240696663, 3829.6256321080828, 3836.175222327213, 3845.288621604984, 3399.5410619566287, 3413.232022794851, 3417.0, 3419.230673098533, 3425.1608355952703, 4604.539546045368, 4718.268668356376, 4738.739369334685, 4745.738984355859, 4747.240441529339, 4364.258076127066, 4386.429764130675, 4394.231009573312, 4397.780110994438, 4403.163398954189, 5068.265101560253, 5083.034223497523, 5092.236164575306, 5099.271889539116, 5104.3619547556555, 3576.8390422431053, 3711.554613446404, 3719.7396182267253, 3722.2183341498317, 3748.3815170496837, 5245.816396426107, 5278.181881808326, 5284.735763211824, 5300.7349632517835, 5315.415304316522, 3785.09157802131, 3788.1476667749534, 3803.125281185343, 3834.654881060718, 3841.116543195081, 3778.962210377916, 3874.6319099685484, 3892.785896775648, 3893.96106038936, 3895.610438956082, 4345.543717909637, 4357.629601483846, 4357.7385356878685, 4358.21552120615, 4373.278409062469, 4976.377952755905, 4980.800767969241, 4994.225894986283, 4998.950010499849, 5082.745862706924, 1268.5940499040403, 1282.7434513097419, 1309.3845892430543, 1323.0, 1338.9489250937968, 862.3489265604554, 864.179029921577, 881.1144799476485, 882.8984666763405, 891.7592250092439, 3986.820593073319, 3988.940165897514, 3994.5406278277787, 3998.8000599969887, 4039.2325458162854, 4611.262198048296, 4630.259158534685, 4673.08403554541, 4720.362751028636, 4732.4856046065615, 3930.2336044471626, 3979.224051309967, 4008.2584721826556, 4043.3732771420478, 4065.2479291331197, 2305.953880922406, 2427.4659574893494, 2442.963355549668, 2471.653968444419, 2485.5526005318857, 4329.588689074533, 4357.694961352675, 4366.868993930188, 4371.737695738202, 4381.956180438218, 4704.0, 4748.501407352178, 4752.477227504972, 4779.450363208206, 4785.3300537924715, 4380.233459144637, 4408.875736687124, 4562.51718191589, 4980.630326660197, 5002.974985125051, 5281.9471805281455, 5300.628955973045, 5309.36287645485, 5318.920216196838, 5325.668582854287, 5175.353080864892, 5191.62544346178, 5197.0905091609575, 5204.245384419314, 5208.609354298367, 4690.132325519789, 4908.9754551227015, 4940.901181976412, 4973.47778483254, 4981.427135879276, 3697.4453831925425, 3717.8326975285636, 3728.1798004440066, 3730.626937306356, 3731.8507259710395, 5023.095842748195, 5253.2645429639115, 5283.498067683564, 5308.708021058725, 5309.36287645485, 4981.452040275494, 5039.546440820343, 5079.822206222764, 5133.820316289061, 5159.039564965289, 5113.897722045613, 5127.769250383667, 5130.846074617767, 5148.227765835005, 5152.536271735562, 4802.567768900815, 5021.924671130009, 5042.84871453857, 5047.662369472019, 5075.593952483866, 5203.19350500673, 5211.869703257297, 5221.164613661796, 5230.450802665818, 5239.685618862881, 5091.159958606789, 5101.20931255656, 5101.627743099477, 5107.336046313955, 5111.437741848468], "value": 3784.148935077736, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [665.1951139121662, 665.3764813854192, 699.5173330402024, 704.9918616378579, 720.8522252938149, 11767.235129716573, 12164.026877849785, 12182.573609923655, 12182.81725774114, 12286.385680715974, 12297.446614902328, 12355.444005019774, 12367.257964522136, 12436.626901192956, 12450.252984820894, 616.4729156571112, 764.2510339866934, 786.0606575142707, 791.7545560876118, 793.892824468698, 787.3268355555974, 799.9040115186157, 799.9880001799978, 800.0918956983836, 801.5471258738824, 834.8205135895781, 836.7406104107715, 842.2377748137945, 842.6755699055877, 842.9915700843005, 647.2427260105687, 813.6460639621724, 828.9171082891722, 836.1178956201205, 837.0290463062848, 606.3421188011014, 606.6996836565884, 607.2621764556042, 607.6870411737958, 607.9969600152015, 12308.323042232674, 12310.81533776994, 12350.62948111558, 12355.25868447887, 12362.320072396014, 12453.688657783538, 13018.414171362312, 13121.671958201026, 13160.802587961189, 13204.801927971088, 10287.434191119486, 10385.169186465064, 10385.42880141592, 10414.114800241989, 10436.947815260952, 3213.6786321367676, 4131.194417088669, 4171.958280417188, 4196.832126714928, 4305.375720520538, 51945.48054519444, 58077.41922580762, 58477.707611462094, 58559.0, 58785.41214587842, 9806.460644664612, 10247.436390998566, 10337.173026157889, 10345.482725863676, 10406.427646479366, 17301.480955571355, 17326.220320085627, 17343.653126937643, 17421.738673919903, 17579.56051098707, 6712.630805305657, 6731.427828634621, 6740.730370785113, 6782.084418603426, 6853.554518956352, 3716.572594151653, 3730.198007428416, 3775.8867233983024, 3805.562360328542, 3872.9225415491533, 2873.956890646642, 2968.228260652246, 2975.6875528069672, 2977.077106097117, 2977.970220297769, 500.62953414473026, 517.6195496310208, 517.9922301165485, 532.3930718980365, 569.8091139468324, 396.6648182285964, 508.57025813187795, 571.4057380324499, 584.8157830283532, 585.3736501942881, 7024.157101147793, 7405.518641288407, 7461.962690186514, 7559.735409260649, 7586.658600362997, 507.7841917185182, 539.2262103880944, 545.7625932719279, 549.8048192891546, 557.7629507459395, 3312.5362449257123, 3580.104973756561, 3624.52881125452, 3669.834857431422, 3695.1685870678884, 86684.13315866886, 89025.55487222652, 90181.0, 90481.0, 91993.54003230075, 78135.60932195303, 80137.19862801414, 81056.0, 81529.0, 83844.0, 70390.0, 71587.0, 71759.0, 72078.0, 72092.27907720856, 6412.070249813658, 6512.088307637029, 6631.469482441489, 6712.865742685021, 6802.319768023158, 37955.810220949825, 40275.79862100788, 42154.0, 42878.35682464828, 42882.0, 38635.2272954545, 40164.59835401725, 40390.59609403869, 59755.0, 60342.094868577886, 10134.189264858645, 10320.48397580103, 10447.477626118816, 10831.891681083089, 11393.658190254306, 12519.061070419573, 12999.805002925154, 13125.54060607874, 13468.259245741187, 13470.93264533671, 12052.0, 12160.878391216329, 12190.2076365036, 12247.571335003233, 12898.80651790205, 12316.50733970667, 12322.81515777282, 12657.556985505464, 12682.619521414372, 13061.314006868726, 11230.270032447865, 11526.135539834713, 11771.0, 12141.75716485683, 12147.331896745764, 10060.647877324258, 10291.433971131659, 10567.94716026415, 10626.681199563716, 10672.679819605424, 9817.312788104764, 10252.618729810705, 10485.842712359168, 10534.209934254808, 10577.259591828499], "value": 6384.789159581285, "unit": "score"}], "name": "dromaeo_css", "value": 6314.3240457384245, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 113.0, 113.0, 113.0, 111.0, 113.0, 111.0, 113.0, 113.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 132.0, 136.0, 189.0, 132.0, 131.0, 157.0, 130.0, 187.0, 131.0], "value": 148.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 160.0, 162.0, 162.0, 162.0, 162.0, 162.0, 162.0, 162.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 102.0, 75.0, 76.0, 75.0, 75.0, 106.0, 76.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 113.0, 86.0, 85.0, 84.0, 120.0, 86.0, 85.0, 132.0], "value": 96.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 64.0, 62.0, 62.0, 63.0, 62.0, 63.0, 63.0, 63.0], "value": 62.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 66.0, 69.0, 64.0, 65.0, 65.0, 65.0, 65.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 83.0, 84.0, 88.0, 84.0, 89.0, 84.0, 122.0, 84.0], "value": 88.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 129.0, 141.0, 138.0, 141.0, 129.0, 128.0, 140.0, 134.0, 136.0], "value": 134.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 175.0, 171.0, 169.0, 170.0, 171.0, 172.0, 171.0, 187.0, 177.0], "value": 173.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 77.0, 67.0, 67.0, 72.0, 68.0, 67.0, 67.0, 67.0], "value": 68.9, "unit": "score"}], "name": "kraken", "value": 1551.9, "alertThreshold": 2.0}]} 10:19:12 INFO - Return code: 0 10:19:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:19:12 INFO - # TBPL SUCCESS # 10:19:12 INFO - Running post-action listener: _resource_record_post_action 10:19:12 INFO - ##### 10:19:12 INFO - ##### Finished run-tests step (success) 10:19:12 INFO - ##### 10:19:12 INFO - Running post-run listener: _resource_record_post_run 10:19:12 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 540983296; Read time: 8; Write time: 405280 10:19:12 INFO - TinderboxPrint: CPU usage
13.2% 10:19:12 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 10:19:12 INFO - TinderboxPrint: I/O write bytes / time
540,983,296 / 405,280 10:19:12 INFO - TinderboxPrint: CPU idle
8,331.9 (86.8%) 10:19:12 INFO - TinderboxPrint: CPU user
1,218.0 (12.7%) 10:19:12 INFO - TinderboxPrint: Swap in / out
0 / 0 10:19:12 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 244785152; Read time: 0; Write time: 207636 10:19:12 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296198144; Read time: 8; Write time: 197644 10:19:13 INFO - Running post-run listener: _upload_blobber_files 10:19:13 INFO - Blob upload gear active. 10:19:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:19:13 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 10:19:13 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'] 10:19:13 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 10:19:13 INFO - (blobuploader) - INFO - Open directory for files ... 10:19:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:19:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:19:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:19:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:19:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:19:14 INFO - (blobuploader) - INFO - Done attempting. 10:19:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:19:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:19:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:19:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:19:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:19:18 INFO - (blobuploader) - INFO - Done attempting. 10:19:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:19:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:19:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:19:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:19:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:19:18 INFO - (blobuploader) - INFO - Done attempting. 10:19:18 INFO - (blobuploader) - INFO - Iteration through files over. 10:19:18 INFO - Return code: 0 10:19:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:19:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:19:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9c042cf4a61a04bab1b973bb5f805dbf490caa063406bb7e596f969ca59504325aedc983d26cc9e1129864821ced3a3381522f243db98838b64f985c7c370cec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/51df5be3b1b0cabb5379d8b8b33e149b65c26105425f32b599f0f8df9e54deafe8812728a5f03f06fd73945751ec7f5595d02a1f4a0be6db887f28c0b46cccf7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c9d2d5767cac94de242c726e3240ebe4180e470c702543cfe352c4c313a9d0f7974bb4c9111fa107c6ec532553bfd2bf428df09e3bd91809542691c0dccd2269"} 10:19:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:19:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:19:18 INFO - Contents: 10:19:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9c042cf4a61a04bab1b973bb5f805dbf490caa063406bb7e596f969ca59504325aedc983d26cc9e1129864821ced3a3381522f243db98838b64f985c7c370cec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/51df5be3b1b0cabb5379d8b8b33e149b65c26105425f32b599f0f8df9e54deafe8812728a5f03f06fd73945751ec7f5595d02a1f4a0be6db887f28c0b46cccf7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c9d2d5767cac94de242c726e3240ebe4180e470c702543cfe352c4c313a9d0f7974bb4c9111fa107c6ec532553bfd2bf428df09e3bd91809542691c0dccd2269"} 10:19:18 INFO - Running post-run listener: copy_logs_to_upload_dir 10:19:18 INFO - Copying logs to upload dir... 10:19:18 INFO - mkdir: /builds/slave/test/build/upload/logs 10:19:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.616893 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-06-13 10:19:18.373750) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-13 10:19:18.377080) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1465836397.985122-1928431301 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/9c042cf4a61a04bab1b973bb5f805dbf490caa063406bb7e596f969ca59504325aedc983d26cc9e1129864821ced3a3381522f243db98838b64f985c7c370cec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/51df5be3b1b0cabb5379d8b8b33e149b65c26105425f32b599f0f8df9e54deafe8812728a5f03f06fd73945751ec7f5595d02a1f4a0be6db887f28c0b46cccf7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c9d2d5767cac94de242c726e3240ebe4180e470c702543cfe352c4c313a9d0f7974bb4c9111fa107c6ec532553bfd2bf428df09e3bd91809542691c0dccd2269"} build_url:https://queue.taskcluster.net/v1/task/Zp2JaXMLSJCJjW-t0X0tKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011356 build_url: 'https://queue.taskcluster.net/v1/task/Zp2JaXMLSJCJjW-t0X0tKg/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/9c042cf4a61a04bab1b973bb5f805dbf490caa063406bb7e596f969ca59504325aedc983d26cc9e1129864821ced3a3381522f243db98838b64f985c7c370cec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/51df5be3b1b0cabb5379d8b8b33e149b65c26105425f32b599f0f8df9e54deafe8812728a5f03f06fd73945751ec7f5595d02a1f4a0be6db887f28c0b46cccf7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c9d2d5767cac94de242c726e3240ebe4180e470c702543cfe352c4c313a9d0f7974bb4c9111fa107c6ec532553bfd2bf428df09e3bd91809542691c0dccd2269"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-13 10:19:18.404670) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 10:19:18.405345) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1465836397.985122-1928431301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004536 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 10:19:18.489158) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-13 10:19:18.489904) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-13 10:19:18.490585) ========= ========= Total master_lag: 0.39 =========