builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-054 starttime: 1464962192.84 results: success (0) buildid: 20160603062911 builduid: ada3a5a0713149b5b3464b66425a2509 revision: f4fbac42bc5e86aeb36fb2d4157fa6dbcf4e441e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 06:56:32.840896) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 06:56:32.841401) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 06:56:32.841804) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 06:56:32.892319) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 06:56:32.892623) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=cbe409c6de289db6ac707de3000001d4-1464958590.5005-1771471860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-03 06:56:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.2M=0s 2016-06-03 06:56:33 (69.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.194568 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 06:56:33.114157) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 06:56:33.114535) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=cbe409c6de289db6ac707de3000001d4-1464958590.5005-1771471860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017211 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 06:56:33.164168) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 06:56:33.164538) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f4fbac42bc5e86aeb36fb2d4157fa6dbcf4e441e --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 f4fbac42bc5e86aeb36fb2d4157fa6dbcf4e441e --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=cbe409c6de289db6ac707de3000001d4-1464958590.5005-1771471860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-03 06:56:33,209 truncating revision to first 12 chars 2016-06-03 06:56:33,209 Setting DEBUG logging. 2016-06-03 06:56:33,209 attempt 1/10 2016-06-03 06:56:33,210 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f4fbac42bc5e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-03 06:56:33,518 unpacking tar archive at: fx-team-f4fbac42bc5e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.733929 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 06:56:33.911825) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 06:56:33.912117) ========= script_repo_revision: f4fbac42bc5e86aeb36fb2d4157fa6dbcf4e441e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 06:56:33.912533) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 06:56:33.912818) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 06:56:33.921655) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-06-03 06:56:33.921953) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=cbe409c6de289db6ac707de3000001d4-1464958590.5005-1771471860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:56:34 INFO - MultiFileLogger online at 20160603 06:56:34 in /builds/slave/test 06:56:34 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 06:56:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:56:34 INFO - {'append_to_log': False, 06:56:34 INFO - 'base_work_dir': '/builds/slave/test', 06:56:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:56:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:56:34 INFO - 'branch': 'Fx-Team-Non-PGO', 06:56:34 INFO - 'buildbot_json_path': 'buildprops.json', 06:56:34 INFO - 'config_files': ('talos/linux_config.py',), 06:56:34 INFO - 'default_actions': ('clobber', 06:56:34 INFO - 'read-buildbot-config', 06:56:34 INFO - 'download-and-extract', 06:56:34 INFO - 'populate-webroot', 06:56:34 INFO - 'create-virtualenv', 06:56:34 INFO - 'install', 06:56:34 INFO - 'run-tests'), 06:56:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:56:34 INFO - 'download_minidump_stackwalk': True, 06:56:34 INFO - 'download_symbols': 'ondemand', 06:56:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:56:34 INFO - 'tooltool.py': '/tools/tooltool.py', 06:56:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:56:34 INFO - '/tools/misc-python/virtualenv.py')}, 06:56:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:56:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:56:34 INFO - 'installer_path': 'installer.exe', 06:56:34 INFO - 'log_level': 'info', 06:56:34 INFO - 'log_name': 'talos', 06:56:34 INFO - 'log_to_console': True, 06:56:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:56:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:56:34 INFO - 'opt_config_files': (), 06:56:34 INFO - 'pip_index': False, 06:56:34 INFO - 'sps_profile': False, 06:56:34 INFO - 'sps_profile_interval': 0, 06:56:34 INFO - 'suite': 'dromaeojs', 06:56:34 INFO - 'system_bits': '32', 06:56:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:56:34 INFO - 'title': 'talos-linux64-ix-054', 06:56:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:56:34 INFO - 'use_talos_json': True, 06:56:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:56:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:56:34 INFO - 'work_dir': 'build'} 06:56:34 INFO - ##### 06:56:34 INFO - ##### Running clobber step. 06:56:34 INFO - ##### 06:56:34 INFO - Running pre-action listener: _resource_record_pre_action 06:56:34 INFO - Running main action method: clobber 06:56:34 INFO - rmtree: /builds/slave/test/build 06:56:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:56:34 INFO - Running post-action listener: _resource_record_post_action 06:56:34 INFO - ##### 06:56:34 INFO - ##### Finished clobber step (success) 06:56:34 INFO - ##### 06:56:34 INFO - ##### 06:56:34 INFO - ##### Running read-buildbot-config step. 06:56:34 INFO - ##### 06:56:34 INFO - Running pre-action listener: _resource_record_pre_action 06:56:34 INFO - Running main action method: read_buildbot_config 06:56:34 INFO - Using buildbot properties: 06:56:34 INFO - { 06:56:34 INFO - "project": "", 06:56:34 INFO - "product": "firefox", 06:56:34 INFO - "script_repo_revision": "production", 06:56:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:56:34 INFO - "repository": "", 06:56:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 06:56:34 INFO - "buildid": "20160603062911", 06:56:34 INFO - "pgo_build": "False", 06:56:34 INFO - "basedir": "/builds/slave/test", 06:56:34 INFO - "buildnumber": 1748, 06:56:34 INFO - "slavename": "talos-linux64-ix-054", 06:56:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:56:34 INFO - "platform": "ubuntu64_hw", 06:56:34 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:56:34 INFO - "branch": "fx-team", 06:56:34 INFO - "repo_path": "integration/fx-team", 06:56:34 INFO - "revision": "f4fbac42bc5e86aeb36fb2d4157fa6dbcf4e441e", 06:56:34 INFO - "stage_platform": "linux64", 06:56:34 INFO - "builduid": "ada3a5a0713149b5b3464b66425a2509", 06:56:34 INFO - "slavebuilddir": "test" 06:56:34 INFO - } 06:56:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/UrvNGEweR2Wh8oN2JV773g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 06:56:34 INFO - Running post-action listener: _resource_record_post_action 06:56:34 INFO - ##### 06:56:34 INFO - ##### Finished read-buildbot-config step (success) 06:56:34 INFO - ##### 06:56:34 INFO - ##### 06:56:34 INFO - ##### Running download-and-extract step. 06:56:34 INFO - ##### 06:56:34 INFO - Running pre-action listener: _resource_record_pre_action 06:56:34 INFO - Running main action method: download_and_extract 06:56:34 INFO - mkdir: /builds/slave/test/build/tests 06:56:34 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')]} 06:56:34 INFO - https://queue.taskcluster.net/v1/task/UrvNGEweR2Wh8oN2JV773g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:56:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UrvNGEweR2Wh8oN2JV773g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:56:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UrvNGEweR2Wh8oN2JV773g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:56:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UrvNGEweR2Wh8oN2JV773g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:56:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UrvNGEweR2Wh8oN2JV773g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:56:40 INFO - Downloaded 1361 bytes. 06:56:40 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:56:40 INFO - Using the following test package requirements: 06:56:40 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:56:40 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:56:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:56:40 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:56:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:56:40 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:56:40 INFO - u'jsshell-linux-x86_64.zip'], 06:56:40 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:56:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:56:40 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:56:40 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:56:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:56:40 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:56:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:56:40 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:56:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:56:40 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:56:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:56:40 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:56:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:40 INFO - https://queue.taskcluster.net/v1/task/UrvNGEweR2Wh8oN2JV773g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:56:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UrvNGEweR2Wh8oN2JV773g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:56:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UrvNGEweR2Wh8oN2JV773g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:56:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UrvNGEweR2Wh8oN2JV773g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:56:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UrvNGEweR2Wh8oN2JV773g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:56:47 INFO - Downloaded 22868152 bytes. 06:56:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:56:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:56:49 INFO - Return code: 0 06:56:49 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:56:49 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')]} 06:56:49 INFO - https://queue.taskcluster.net/v1/task/UrvNGEweR2Wh8oN2JV773g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:56:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UrvNGEweR2Wh8oN2JV773g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:56:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UrvNGEweR2Wh8oN2JV773g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:56:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UrvNGEweR2Wh8oN2JV773g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:56:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UrvNGEweR2Wh8oN2JV773g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:56:50 INFO - Downloaded 22868152 bytes. 06:56:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:56:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:56:51 INFO - Return code: 0 06:56:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:51 INFO - https://queue.taskcluster.net/v1/task/UrvNGEweR2Wh8oN2JV773g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:56:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UrvNGEweR2Wh8oN2JV773g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:56:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UrvNGEweR2Wh8oN2JV773g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:56:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UrvNGEweR2Wh8oN2JV773g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:56:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UrvNGEweR2Wh8oN2JV773g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:56:53 INFO - Downloaded 10833369 bytes. 06:56:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:56:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:56:53 INFO - Return code: 0 06:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:53 INFO - https://queue.taskcluster.net/v1/task/UrvNGEweR2Wh8oN2JV773g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:56:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UrvNGEweR2Wh8oN2JV773g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:56:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UrvNGEweR2Wh8oN2JV773g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:56:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UrvNGEweR2Wh8oN2JV773g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:56:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UrvNGEweR2Wh8oN2JV773g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:56:55 INFO - Downloaded 55169903 bytes. 06:56:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UrvNGEweR2Wh8oN2JV773g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:56:55 INFO - mkdir: /builds/slave/test/properties 06:56:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:56:55 INFO - Writing to file /builds/slave/test/properties/build_url 06:56:55 INFO - Contents: 06:56:55 INFO - build_url:https://queue.taskcluster.net/v1/task/UrvNGEweR2Wh8oN2JV773g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:56:56 INFO - Running post-action listener: _resource_record_post_action 06:56:56 INFO - Running post-action listener: set_extra_try_arguments 06:56:56 INFO - ##### 06:56:56 INFO - ##### Finished download-and-extract step (success) 06:56:56 INFO - ##### 06:56:56 INFO - ##### 06:56:56 INFO - ##### Running populate-webroot step. 06:56:56 INFO - ##### 06:56:56 INFO - Running pre-action listener: _resource_record_pre_action 06:56:56 INFO - Running main action method: populate_webroot 06:56:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:56:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:56:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:56:56 INFO - '--tppagecycles', 06:56:56 INFO - '7'], 06:56:56 INFO - 'tests': ['tsvgm']}}, 06:56:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:56:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:56:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:56:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:56:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:56:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:56:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:56:56 INFO - 'talos_options': ['--disable-e10s'], 06:56:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:56:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:56:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:56:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:56:56 INFO - 'talos_options': ['--disable-e10s'], 06:56:56 INFO - 'tests': ['damp', 'tps']}, 06:56:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:56:56 INFO - 'tests': ['damp', 'tps']}, 06:56:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:56:56 INFO - 'tests': ['dromaeo_dom']}, 06:56:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:56:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:56:56 INFO - 'tests': ['a11yr', 06:56:56 INFO - 'ts_paint', 06:56:56 INFO - 'tpaint', 06:56:56 INFO - 'sessionrestore', 06:56:56 INFO - 'sessionrestore_no_auto_restore', 06:56:56 INFO - 'tabpaint']}, 06:56:56 INFO - 'other-e10s': {'tests': ['a11yr', 06:56:56 INFO - 'ts_paint', 06:56:56 INFO - 'tpaint', 06:56:56 INFO - 'sessionrestore', 06:56:56 INFO - 'sessionrestore_no_auto_restore', 06:56:56 INFO - 'tabpaint']}, 06:56:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:56:56 INFO - 'ts_paint', 06:56:56 INFO - 'tpaint', 06:56:56 INFO - 'sessionrestore', 06:56:56 INFO - 'sessionrestore_no_auto_restore', 06:56:56 INFO - 'tabpaint']}, 06:56:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:56:56 INFO - 'ts_paint', 06:56:56 INFO - 'tpaint', 06:56:56 INFO - 'sessionrestore', 06:56:56 INFO - 'sessionrestore_no_auto_restore', 06:56:56 INFO - 'tabpaint']}, 06:56:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:56:56 INFO - 'tests': ['a11yr', 06:56:56 INFO - 'ts_paint', 06:56:56 INFO - 'tpaint', 06:56:56 INFO - 'sessionrestore', 06:56:56 INFO - 'sessionrestore_no_auto_restore', 06:56:56 INFO - 'tabpaint']}, 06:56:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:56:56 INFO - 'tests': ['a11yr', 06:56:56 INFO - 'ts_paint', 06:56:56 INFO - 'tpaint', 06:56:56 INFO - 'sessionrestore', 06:56:56 INFO - 'sessionrestore_no_auto_restore', 06:56:56 INFO - 'tabpaint']}, 06:56:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:56:56 INFO - 'tests': ['tsvgx', 06:56:56 INFO - 'tsvgr_opacity', 06:56:56 INFO - 'tart', 06:56:56 INFO - 'tscrollx', 06:56:56 INFO - 'cart']}, 06:56:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:56:56 INFO - 'tsvgr_opacity', 06:56:56 INFO - 'tart', 06:56:56 INFO - 'tscrollx', 06:56:56 INFO - 'cart']}, 06:56:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:56:56 INFO - 'talos_options': ['--disable-e10s'], 06:56:56 INFO - 'tests': ['tp5o']}, 06:56:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:56:56 INFO - 'tests': ['tp5o']}, 06:56:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:56:56 INFO - 'talos_options': ['--disable-e10s', 06:56:56 INFO - '--xperf_path', 06:56:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:56:56 INFO - 'tests': ['tp5n']}, 06:56:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:56:56 INFO - 'talos_options': ['--xperf_path', 06:56:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:56:56 INFO - 'tests': ['tp5n']}}, 06:56:56 INFO - 'talos.zip': {'path': '', 06:56:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:56:56 INFO - Running post-action listener: _resource_record_post_action 06:56:56 INFO - ##### 06:56:56 INFO - ##### Finished populate-webroot step (success) 06:56:56 INFO - ##### 06:56:56 INFO - ##### 06:56:56 INFO - ##### Running create-virtualenv step. 06:56:56 INFO - ##### 06:56:56 INFO - Running pre-action listener: _resource_record_pre_action 06:56:56 INFO - Running main action method: create_virtualenv 06:56:56 INFO - Creating virtualenv /builds/slave/test/build/venv 06:56:56 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 06:56:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:56:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:56:56 INFO - Using real prefix '/usr' 06:56:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:56:57 INFO - Installing distribute.............................................................................................................................................................................................done. 06:56:59 INFO - Installing pip.................done. 06:56:59 INFO - Return code: 0 06:56:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:56:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:59 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 0x7f6144104f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b07450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b962c0>, '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 0x2b971c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b97650>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464958590.5005-1771471860', '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 06:56:59 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 06:56:59 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 06:56:59 INFO - Using env: {'DISPLAY': ':0', 06:56:59 INFO - 'HOME': '/home/cltbld', 06:56:59 INFO - 'LANG': 'en_US.UTF-8', 06:56:59 INFO - 'LANGUAGE': 'en_US:en', 06:56:59 INFO - 'LOGNAME': 'cltbld', 06:56:59 INFO - 'MAIL': '/var/mail/cltbld', 06:56:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:59 INFO - 'MOZ_NO_REMOTE': '1', 06:56:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:56:59 INFO - 'NO_EM_RESTART': '1', 06:56:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:56:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:56:59 INFO - 'PWD': '/builds/slave/test', 06:56:59 INFO - 'SHELL': '/bin/bash', 06:56:59 INFO - 'SHLVL': '1', 06:56:59 INFO - 'TERM': 'linux', 06:56:59 INFO - 'TMOUT': '86400', 06:56:59 INFO - 'USER': 'cltbld', 06:56:59 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464958590.5005-1771471860', 06:56:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:59 INFO - '_': '/tools/buildbot/bin/python'} 06:56:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:59 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 06:56:59 INFO - Cleaning up... 06:56:59 INFO - Return code: 0 06:56:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:56:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:59 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 0x7f6144104f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b07450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b962c0>, '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 0x2b971c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b97650>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464958590.5005-1771471860', '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 06:56:59 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 06:56:59 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 06:56:59 INFO - Using env: {'DISPLAY': ':0', 06:56:59 INFO - 'HOME': '/home/cltbld', 06:56:59 INFO - 'LANG': 'en_US.UTF-8', 06:56:59 INFO - 'LANGUAGE': 'en_US:en', 06:56:59 INFO - 'LOGNAME': 'cltbld', 06:56:59 INFO - 'MAIL': '/var/mail/cltbld', 06:56:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:59 INFO - 'MOZ_NO_REMOTE': '1', 06:56:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:56:59 INFO - 'NO_EM_RESTART': '1', 06:56:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:56:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:56:59 INFO - 'PWD': '/builds/slave/test', 06:56:59 INFO - 'SHELL': '/bin/bash', 06:56:59 INFO - 'SHLVL': '1', 06:56:59 INFO - 'TERM': 'linux', 06:56:59 INFO - 'TMOUT': '86400', 06:56:59 INFO - 'USER': 'cltbld', 06:56:59 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464958590.5005-1771471860', 06:56:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:59 INFO - '_': '/tools/buildbot/bin/python'} 06:57:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:00 INFO - Downloading/unpacking psutil>=3.1.1 06:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:57:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:57:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:57:02 INFO - Installing collected packages: psutil 06:57:02 INFO - Running setup.py install for psutil 06:57:02 INFO - building 'psutil._psutil_linux' extension 06:57:02 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 06:57:03 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 06:57:03 INFO - building 'psutil._psutil_posix' extension 06:57:03 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 06:57:03 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 06:57:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:57:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:57:03 INFO - Successfully installed psutil 06:57:03 INFO - Cleaning up... 06:57:03 INFO - Return code: 0 06:57:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:57:03 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')]} 06:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:03 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')]} 06:57:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:03 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 0x7f6144104f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b07450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b962c0>, '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 0x2b971c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b97650>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464958590.5005-1771471860', '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 06:57:03 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 06:57:03 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 06:57:03 INFO - Using env: {'DISPLAY': ':0', 06:57:03 INFO - 'HOME': '/home/cltbld', 06:57:03 INFO - 'LANG': 'en_US.UTF-8', 06:57:03 INFO - 'LANGUAGE': 'en_US:en', 06:57:03 INFO - 'LOGNAME': 'cltbld', 06:57:03 INFO - 'MAIL': '/var/mail/cltbld', 06:57:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:03 INFO - 'MOZ_NO_REMOTE': '1', 06:57:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:03 INFO - 'NO_EM_RESTART': '1', 06:57:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:03 INFO - 'PWD': '/builds/slave/test', 06:57:03 INFO - 'SHELL': '/bin/bash', 06:57:03 INFO - 'SHLVL': '1', 06:57:03 INFO - 'TERM': 'linux', 06:57:03 INFO - 'TMOUT': '86400', 06:57:03 INFO - 'USER': 'cltbld', 06:57:03 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464958590.5005-1771471860', 06:57:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:03 INFO - '_': '/tools/buildbot/bin/python'} 06:57:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:57:04 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 06:57:04 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 06:57:04 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 06:57:04 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 06:57:04 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 06:57:04 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 06:57:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:57:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:57:05 INFO - Installing collected packages: mozsystemmonitor 06:57:05 INFO - Running setup.py install for mozsystemmonitor 06:57:06 INFO - Successfully installed mozsystemmonitor 06:57:06 INFO - Cleaning up... 06:57:06 INFO - Return code: 0 06:57:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:57: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')]} 06:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57: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')]} 06:57:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6144104f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b07450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b962c0>, '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 0x2b971c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b97650>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464958590.5005-1771471860', '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 06:57: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==2.5.1'] in /builds/slave/test/build 06:57: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==2.5.1 06:57:06 INFO - Using env: {'DISPLAY': ':0', 06:57:06 INFO - 'HOME': '/home/cltbld', 06:57:06 INFO - 'LANG': 'en_US.UTF-8', 06:57:06 INFO - 'LANGUAGE': 'en_US:en', 06:57:06 INFO - 'LOGNAME': 'cltbld', 06:57:06 INFO - 'MAIL': '/var/mail/cltbld', 06:57:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:06 INFO - 'MOZ_NO_REMOTE': '1', 06:57:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:06 INFO - 'NO_EM_RESTART': '1', 06:57:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:06 INFO - 'PWD': '/builds/slave/test', 06:57:06 INFO - 'SHELL': '/bin/bash', 06:57:06 INFO - 'SHLVL': '1', 06:57:06 INFO - 'TERM': 'linux', 06:57:06 INFO - 'TMOUT': '86400', 06:57:06 INFO - 'USER': 'cltbld', 06:57:06 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464958590.5005-1771471860', 06:57:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:06 INFO - '_': '/tools/buildbot/bin/python'} 06:57:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:06 INFO - Downloading/unpacking jsonschema==2.5.1 06:57: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 06:57: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 06:57: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 06:57: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 06:57: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 06:57: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 06:57:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:57:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:57: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 06:57: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 06:57: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 06:57: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 06:57: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 06:57: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 06:57:08 INFO - Downloading functools32-3.2.3-2.tar.gz 06:57:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:57:08 INFO - warning: no files found matching '*.txt' 06:57:08 INFO - no previously-included directories found matching 'build' 06:57:08 INFO - no previously-included directories found matching 'dist' 06:57:08 INFO - no previously-included directories found matching '.git*' 06:57:08 INFO - Installing collected packages: jsonschema, functools32 06:57:08 INFO - Running setup.py install for functools32 06:57:08 INFO - warning: no files found matching '*.txt' 06:57:08 INFO - no previously-included directories found matching 'build' 06:57:08 INFO - no previously-included directories found matching 'dist' 06:57:08 INFO - no previously-included directories found matching '.git*' 06:57:08 INFO - Successfully installed jsonschema functools32 06:57:08 INFO - Cleaning up... 06:57:08 INFO - Return code: 0 06:57:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:08 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 0x7f6144104f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b07450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b962c0>, '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 0x2b971c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b97650>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464958590.5005-1771471860', '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 06:57:08 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 06:57:08 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 06:57:08 INFO - Using env: {'DISPLAY': ':0', 06:57:08 INFO - 'HOME': '/home/cltbld', 06:57:08 INFO - 'LANG': 'en_US.UTF-8', 06:57:08 INFO - 'LANGUAGE': 'en_US:en', 06:57:08 INFO - 'LOGNAME': 'cltbld', 06:57:08 INFO - 'MAIL': '/var/mail/cltbld', 06:57:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:08 INFO - 'MOZ_NO_REMOTE': '1', 06:57:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:08 INFO - 'NO_EM_RESTART': '1', 06:57:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:08 INFO - 'PWD': '/builds/slave/test', 06:57:08 INFO - 'SHELL': '/bin/bash', 06:57:08 INFO - 'SHLVL': '1', 06:57:08 INFO - 'TERM': 'linux', 06:57:08 INFO - 'TMOUT': '86400', 06:57:08 INFO - 'USER': 'cltbld', 06:57:08 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464958590.5005-1771471860', 06:57:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:08 INFO - '_': '/tools/buildbot/bin/python'} 06:57:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:08 INFO - Downloading/unpacking blobuploader==1.2.4 06:57: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 06:57: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 06:57: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 06:57: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 06:57: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 06:57: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 06:57:13 INFO - Downloading blobuploader-1.2.4.tar.gz 06:57:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:57:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:57:13 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 06:57:13 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 06:57:13 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 06:57:13 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 06:57:13 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 06:57:13 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 06:57:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:57:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:14 INFO - Downloading docopt-0.6.1.tar.gz 06:57:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:57:14 INFO - Installing collected packages: blobuploader, requests, docopt 06:57:14 INFO - Running setup.py install for blobuploader 06:57:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:57:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:57:14 INFO - Running setup.py install for requests 06:57:15 INFO - Running setup.py install for docopt 06:57:15 INFO - Successfully installed blobuploader requests docopt 06:57:15 INFO - Cleaning up... 06:57:15 INFO - Return code: 0 06:57:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:57:15 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')]} 06:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:15 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')]} 06:57:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:15 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 0x7f6144104f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b07450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b962c0>, '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 0x2b971c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b97650>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464958590.5005-1771471860', '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 06:57:15 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 06:57:15 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 06:57:15 INFO - Using env: {'DISPLAY': ':0', 06:57:15 INFO - 'HOME': '/home/cltbld', 06:57:15 INFO - 'LANG': 'en_US.UTF-8', 06:57:15 INFO - 'LANGUAGE': 'en_US:en', 06:57:15 INFO - 'LOGNAME': 'cltbld', 06:57:15 INFO - 'MAIL': '/var/mail/cltbld', 06:57:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:15 INFO - 'MOZ_NO_REMOTE': '1', 06:57:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:15 INFO - 'NO_EM_RESTART': '1', 06:57:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:15 INFO - 'PWD': '/builds/slave/test', 06:57:15 INFO - 'SHELL': '/bin/bash', 06:57:15 INFO - 'SHLVL': '1', 06:57:15 INFO - 'TERM': 'linux', 06:57:15 INFO - 'TMOUT': '86400', 06:57:15 INFO - 'USER': 'cltbld', 06:57:15 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464958590.5005-1771471860', 06:57:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:15 INFO - '_': '/tools/buildbot/bin/python'} 06:57:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:57:15 INFO - Running setup.py (path:/tmp/pip-U0PEK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:57:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:57:15 INFO - Running setup.py (path:/tmp/pip-LqO3mq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:57:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:57:15 INFO - Running setup.py (path:/tmp/pip-tWmtTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:57:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:57:15 INFO - Running setup.py (path:/tmp/pip-w5XjNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:57:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:57:15 INFO - Running setup.py (path:/tmp/pip-iSEqXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:57:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:57:15 INFO - Running setup.py (path:/tmp/pip-WxH_Fp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:57:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:57:15 INFO - Running setup.py (path:/tmp/pip-4dNz1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:57:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:57:15 INFO - Running setup.py (path:/tmp/pip-7EjPnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:57:16 INFO - Running setup.py (path:/tmp/pip-SEb2Gd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:57:16 INFO - Running setup.py (path:/tmp/pip-b7xjXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:57:16 INFO - Running setup.py (path:/tmp/pip-wkJFT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:57:16 INFO - Running setup.py (path:/tmp/pip-p8acI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:57:16 INFO - Running setup.py (path:/tmp/pip-_DPbWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:57:16 INFO - Running setup.py (path:/tmp/pip-hQHCLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:57:16 INFO - Running setup.py (path:/tmp/pip-JPrkaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:57:16 INFO - Running setup.py (path:/tmp/pip-PClTuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:57:16 INFO - Running setup.py (path:/tmp/pip-IScnmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:57:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:57:16 INFO - Running setup.py install for manifestparser 06:57:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:57:16 INFO - Running setup.py install for mozcrash 06:57:16 INFO - Running setup.py install for mozdebug 06:57:16 INFO - Running setup.py install for mozdevice 06:57:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:57:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:57:17 INFO - Running setup.py install for mozfile 06:57:17 INFO - Running setup.py install for mozhttpd 06:57:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:57:17 INFO - Running setup.py install for mozinfo 06:57:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:57:17 INFO - Running setup.py install for mozInstall 06:57:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:57:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:57:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:57:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:57:17 INFO - Running setup.py install for mozleak 06:57:17 INFO - Running setup.py install for mozlog 06:57:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:57:17 INFO - Running setup.py install for moznetwork 06:57:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:57:17 INFO - Running setup.py install for mozprocess 06:57:17 INFO - Running setup.py install for mozprofile 06:57:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:57:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:57:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:57:18 INFO - Running setup.py install for mozrunner 06:57:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:57:18 INFO - Running setup.py install for mozscreenshot 06:57:18 INFO - Running setup.py install for moztest 06:57:18 INFO - Running setup.py install for mozversion 06:57:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:57:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:57:18 INFO - Cleaning up... 06:57:18 INFO - Return code: 0 06:57:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:57:18 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')]} 06:57:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:18 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')]} 06:57:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:18 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 0x7f6144104f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b07450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b962c0>, '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 0x2b971c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b97650>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464958590.5005-1771471860', '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 06:57:18 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 06:57:18 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 06:57:18 INFO - Using env: {'DISPLAY': ':0', 06:57:18 INFO - 'HOME': '/home/cltbld', 06:57:18 INFO - 'LANG': 'en_US.UTF-8', 06:57:18 INFO - 'LANGUAGE': 'en_US:en', 06:57:18 INFO - 'LOGNAME': 'cltbld', 06:57:18 INFO - 'MAIL': '/var/mail/cltbld', 06:57:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:18 INFO - 'MOZ_NO_REMOTE': '1', 06:57:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:18 INFO - 'NO_EM_RESTART': '1', 06:57:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:18 INFO - 'PWD': '/builds/slave/test', 06:57:18 INFO - 'SHELL': '/bin/bash', 06:57:18 INFO - 'SHLVL': '1', 06:57:18 INFO - 'TERM': 'linux', 06:57:18 INFO - 'TMOUT': '86400', 06:57:18 INFO - 'USER': 'cltbld', 06:57:18 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464958590.5005-1771471860', 06:57:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:18 INFO - '_': '/tools/buildbot/bin/python'} 06:57:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:57:18 INFO - Running setup.py (path:/tmp/pip-q4mlSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:57:18 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)) 06:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:57:18 INFO - Running setup.py (path:/tmp/pip-kjSSzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:57:18 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)) 06:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:57:18 INFO - Running setup.py (path:/tmp/pip-EoejCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:57:18 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)) 06:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:57:18 INFO - Running setup.py (path:/tmp/pip-GPaFia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:57:18 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)) 06:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:57:18 INFO - Running setup.py (path:/tmp/pip-NnK5l3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:57:19 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)) 06:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:57:19 INFO - Running setup.py (path:/tmp/pip-lOexti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:57:19 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)) 06:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:57:19 INFO - Running setup.py (path:/tmp/pip-MpLUbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:57:19 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)) 06:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:57:19 INFO - Running setup.py (path:/tmp/pip-6duehG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:57:19 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)) 06:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:57:19 INFO - Running setup.py (path:/tmp/pip-2Fn4Gl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:57:19 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)) 06:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:57:19 INFO - Running setup.py (path:/tmp/pip-HwXbTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:57:19 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)) 06:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:57:19 INFO - Running setup.py (path:/tmp/pip-J3jDvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:57:19 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)) 06:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:57:19 INFO - Running setup.py (path:/tmp/pip-iM1lQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:57:19 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)) 06:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:57:19 INFO - Running setup.py (path:/tmp/pip-Qze9WX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:57:19 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)) 06:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:57:19 INFO - Running setup.py (path:/tmp/pip-_LCVze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:57:19 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)) 06:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:57:19 INFO - Running setup.py (path:/tmp/pip-Ha58q2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:57:19 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)) 06:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:57:19 INFO - Running setup.py (path:/tmp/pip-Bl7mce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:57:19 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)) 06:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:57:19 INFO - Running setup.py (path:/tmp/pip-w38q3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:57:19 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)) 06:57:19 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)) 06:57:19 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)) 06:57:19 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)) 06:57:19 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)) 06:57:19 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)) 06:57:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:21 INFO - Downloading blessings-1.6.tar.gz 06:57:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:57:21 INFO - Installing collected packages: blessings 06:57:21 INFO - Running setup.py install for blessings 06:57:21 INFO - Successfully installed blessings 06:57:21 INFO - Cleaning up... 06:57:22 INFO - Return code: 0 06:57:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:57:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:57:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:57:22 INFO - Reading from file tmpfile_stdout 06:57:22 INFO - Current package versions: 06:57:22 INFO - argparse == 1.2.1 06:57:22 INFO - blessings == 1.6 06:57:22 INFO - blobuploader == 1.2.4 06:57:22 INFO - docopt == 0.6.1 06:57:22 INFO - functools32 == 3.2.3-2 06:57:22 INFO - jsonschema == 2.5.1 06:57:22 INFO - manifestparser == 1.1 06:57:22 INFO - mozInstall == 1.12 06:57:22 INFO - mozcrash == 0.17 06:57:22 INFO - mozdebug == 0.1 06:57:22 INFO - mozdevice == 0.48 06:57:22 INFO - mozfile == 1.2 06:57:22 INFO - mozhttpd == 0.7 06:57:22 INFO - mozinfo == 0.9 06:57:22 INFO - mozleak == 0.1 06:57:22 INFO - mozlog == 3.2 06:57:22 INFO - moznetwork == 0.27 06:57:22 INFO - mozprocess == 0.22 06:57:22 INFO - mozprofile == 0.28 06:57:22 INFO - mozrunner == 6.11 06:57:22 INFO - mozscreenshot == 0.1 06:57:22 INFO - mozsystemmonitor == 0.3 06:57:22 INFO - moztest == 0.7 06:57:22 INFO - mozversion == 1.4 06:57:22 INFO - psutil == 3.1.1 06:57:22 INFO - requests == 1.2.3 06:57:22 INFO - wsgiref == 0.1.2 06:57:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:22 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 0x7f6144104f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b07450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b962c0>, '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 0x2b971c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b97650>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464958590.5005-1771471860', '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 06:57:22 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 06:57:22 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 06:57:22 INFO - Using env: {'DISPLAY': ':0', 06:57:22 INFO - 'HOME': '/home/cltbld', 06:57:22 INFO - 'LANG': 'en_US.UTF-8', 06:57:22 INFO - 'LANGUAGE': 'en_US:en', 06:57:22 INFO - 'LOGNAME': 'cltbld', 06:57:22 INFO - 'MAIL': '/var/mail/cltbld', 06:57:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:22 INFO - 'MOZ_NO_REMOTE': '1', 06:57:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:22 INFO - 'NO_EM_RESTART': '1', 06:57:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:22 INFO - 'PWD': '/builds/slave/test', 06:57:22 INFO - 'SHELL': '/bin/bash', 06:57:22 INFO - 'SHLVL': '1', 06:57:22 INFO - 'TERM': 'linux', 06:57:22 INFO - 'TMOUT': '86400', 06:57:22 INFO - 'USER': 'cltbld', 06:57:22 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464958590.5005-1771471860', 06:57:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:22 INFO - '_': '/tools/buildbot/bin/python'} 06:57:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:22 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)) 06:57:22 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)) 06:57:22 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)) 06:57:22 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)) 06:57:22 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)) 06:57:22 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)) 06:57:22 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)) 06:57:22 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)) 06:57:22 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)) 06:57:22 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)) 06:57:22 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)) 06:57:22 INFO - Cleaning up... 06:57:22 INFO - Return code: 0 06:57:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6144104f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b07450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b962c0>, '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 0x2b971c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b97650>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464958590.5005-1771471860', '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 06:57:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:57:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:57:22 INFO - Using env: {'DISPLAY': ':0', 06:57:22 INFO - 'HOME': '/home/cltbld', 06:57:22 INFO - 'LANG': 'en_US.UTF-8', 06:57:22 INFO - 'LANGUAGE': 'en_US:en', 06:57:22 INFO - 'LOGNAME': 'cltbld', 06:57:22 INFO - 'MAIL': '/var/mail/cltbld', 06:57:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:22 INFO - 'MOZ_NO_REMOTE': '1', 06:57:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:22 INFO - 'NO_EM_RESTART': '1', 06:57:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:22 INFO - 'PWD': '/builds/slave/test', 06:57:22 INFO - 'SHELL': '/bin/bash', 06:57:22 INFO - 'SHLVL': '1', 06:57:22 INFO - 'TERM': 'linux', 06:57:22 INFO - 'TMOUT': '86400', 06:57:22 INFO - 'USER': 'cltbld', 06:57:22 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464958590.5005-1771471860', 06:57:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:22 INFO - '_': '/tools/buildbot/bin/python'} 06:57:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:57:22 INFO - Cleaning up... 06:57:22 INFO - Return code: 0 06:57:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6144104f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b07450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b962c0>, '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 0x2b971c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b97650>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464958590.5005-1771471860', '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 06:57:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 06:57:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:57:22 INFO - Using env: {'DISPLAY': ':0', 06:57:22 INFO - 'HOME': '/home/cltbld', 06:57:22 INFO - 'LANG': 'en_US.UTF-8', 06:57:22 INFO - 'LANGUAGE': 'en_US:en', 06:57:22 INFO - 'LOGNAME': 'cltbld', 06:57:22 INFO - 'MAIL': '/var/mail/cltbld', 06:57:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:22 INFO - 'MOZ_NO_REMOTE': '1', 06:57:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:22 INFO - 'NO_EM_RESTART': '1', 06:57:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:22 INFO - 'PWD': '/builds/slave/test', 06:57:22 INFO - 'SHELL': '/bin/bash', 06:57:22 INFO - 'SHLVL': '1', 06:57:22 INFO - 'TERM': 'linux', 06:57:22 INFO - 'TMOUT': '86400', 06:57:22 INFO - 'USER': 'cltbld', 06:57:22 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464958590.5005-1771471860', 06:57:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:22 INFO - '_': '/tools/buildbot/bin/python'} 06:57:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:22 INFO - Downloading/unpacking flake8 06:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:57:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:57:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:57:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:57:25 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 06:57:25 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 06:57:25 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 06:57:25 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 06:57:25 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 06:57:25 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 06:57:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:57:25 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 06:57:25 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 06:57:25 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 06:57:25 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 06:57:25 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 06:57:25 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 06:57:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:57:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:57:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:57:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:57:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:57:25 INFO - no previously-included directories found matching 'docs/_build' 06:57:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:57:25 INFO - Running setup.py install for pep8 06:57:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:57:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:57:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:57:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:57:25 INFO - no previously-included directories found matching 'docs/_build' 06:57:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:57:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:57:25 INFO - Cleaning up... 06:57:25 INFO - Return code: 0 06:57:25 INFO - Running post-action listener: _resource_record_post_action 06:57:25 INFO - Running post-action listener: _start_resource_monitoring 06:57:25 INFO - Starting resource monitoring. 06:57:25 INFO - ##### 06:57:25 INFO - ##### Finished create-virtualenv step (success) 06:57:25 INFO - ##### 06:57:25 INFO - ##### 06:57:25 INFO - ##### Running install step. 06:57:25 INFO - ##### 06:57:25 INFO - Running pre-action listener: _resource_record_pre_action 06:57:25 INFO - Running main action method: install 06:57:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:57:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:57:26 INFO - Reading from file tmpfile_stdout 06:57:26 INFO - Detecting whether we're running mozinstall >=1.0... 06:57:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:57:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:57:26 INFO - Reading from file tmpfile_stdout 06:57:26 INFO - Output received: 06:57:26 INFO - Usage: mozinstall [options] installer 06:57:26 INFO - Options: 06:57:26 INFO - -h, --help show this help message and exit 06:57:26 INFO - -d DEST, --destination=DEST 06:57:26 INFO - Directory to install application into. [default: 06:57:26 INFO - "/builds/slave/test"] 06:57:26 INFO - --app=APP Application being installed. [default: firefox] 06:57:26 INFO - mkdir: /builds/slave/test/build/application 06:57:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:57:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:57:42 INFO - Reading from file tmpfile_stdout 06:57:42 INFO - Output received: 06:57:42 INFO - /builds/slave/test/build/application/firefox/firefox 06:57:42 INFO - Running post-action listener: _resource_record_post_action 06:57:42 INFO - ##### 06:57:42 INFO - ##### Finished install step (success) 06:57:42 INFO - ##### 06:57:42 INFO - ##### 06:57:42 INFO - ##### Running run-tests step. 06:57:42 INFO - ##### 06:57:42 INFO - Running pre-action listener: _resource_record_pre_action 06:57:42 INFO - Running main action method: run_tests 06:57:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:57:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:57:42 INFO - Python 2.7.3 06:57:42 INFO - Return code: 0 06:57:42 INFO - grabbing minidump binary from tooltool 06:57: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')]} 06:57:42 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 0x2b962c0>, '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 0x2b971c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b97650>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:57:42 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 06:57:42 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 06:57:42 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 06:57:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:57:42 INFO - Return code: 0 06:57:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:57:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:57:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:57:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:57:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:57:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:57:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:57:43 INFO - Return code: 0 06:57:43 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/UrvNGEweR2Wh8oN2JV773g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:57:43 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/UrvNGEweR2Wh8oN2JV773g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:57:43 INFO - Using env: {'DISPLAY': ':0', 06:57:43 INFO - 'HOME': '/home/cltbld', 06:57:43 INFO - 'LANG': 'en_US.UTF-8', 06:57:43 INFO - 'LANGUAGE': 'en_US:en', 06:57:43 INFO - 'LOGNAME': 'cltbld', 06:57:43 INFO - 'MAIL': '/var/mail/cltbld', 06:57:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:57:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:57:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:43 INFO - 'MOZ_NO_REMOTE': '1', 06:57:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:57:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:43 INFO - 'NO_EM_RESTART': '1', 06:57:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:43 INFO - 'PWD': '/builds/slave/test', 06:57:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:57:43 INFO - 'SHELL': '/bin/bash', 06:57:43 INFO - 'SHLVL': '1', 06:57:43 INFO - 'TERM': 'linux', 06:57:43 INFO - 'TMOUT': '86400', 06:57:43 INFO - 'USER': 'cltbld', 06:57:43 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464958590.5005-1771471860', 06:57:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:43 INFO - '_': '/tools/buildbot/bin/python'} 06:57:43 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/UrvNGEweR2Wh8oN2JV773g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:57:43 INFO - mozversion application_buildid: 20160603062911 06:57:43 INFO - mozversion application_changeset: f4fbac42bc5e86aeb36fb2d4157fa6dbcf4e441e 06:57:43 INFO - mozversion application_display_name: Nightly 06:57:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:57:43 INFO - mozversion application_name: Firefox 06:57:43 INFO - mozversion application_remotingname: firefox 06:57:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:57:43 INFO - mozversion application_vendor: Mozilla 06:57:43 INFO - mozversion application_version: 49.0a1 06:57:43 INFO - mozversion platform_buildid: 20160603062911 06:57:43 INFO - mozversion platform_changeset: f4fbac42bc5e86aeb36fb2d4157fa6dbcf4e441e 06:57:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:57:43 INFO - mozversion platform_version: 49.0a1 06:57:43 INFO - using testdate: 1464962263 06:57:43 INFO - actual date: 1464962263 06:57:43 INFO - starting webserver on 'localhost:53669' 06:57:43 INFO - SUITE-START | Running 2 tests 06:57:43 INFO - TEST-START | dromaeo_css 06:57:43 INFO - operating with platform_type : linux_ 06:57:43 INFO - Initialising browser for dromaeo_css test... 06:57:43 INFO - TEST-INFO | started process 3328 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpojktI_/profile http://localhost:53669/getInfo.html) 06:57:49 INFO - PROCESS | 3328 | __metrics Screen width/height:1600/1200 06:57:49 INFO - PROCESS | 3328 | colorDepth:24 06:57:49 INFO - PROCESS | 3328 | Browser inner width/height: 1024/697 06:57:49 INFO - PROCESS | 3328 | __metrics 06:57:50 ERROR - PROCESS | 3328 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:57:51 INFO - TEST-INFO | 3328: exit 0 06:57:51 INFO - Browser initialized. 06:57:51 INFO - Running cycle 1/1 for dromaeo_css test... 06:57:51 INFO - TEST-INFO | started process 3411 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpojktI_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:58:03 INFO - PROCESS | 3411 | RSS: Main: 157622272 06:58:03 INFO - PROCESS | 3411 | 06:58:55 INFO - PROCESS | 3411 | 1464962335590 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:01:07 INFO - PROCESS | 3411 | Cycle 1(1): loaded http://localhost:53669/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53669/tests/dromaeo/cssquery-ext.html) 07:01:08 INFO - PROCESS | 3411 | RSS: Main: 255447040 07:01:08 INFO - PROCESS | 3411 | 07:04:11 INFO - PROCESS | 3411 | Cycle 1(1): loaded http://localhost:53669/tests/dromaeo/cssquery-ext.html (next: http://localhost:53669/tests/dromaeo/cssquery-jquery.html) 07:04:12 INFO - PROCESS | 3411 | RSS: Main: 235753472 07:04:12 INFO - PROCESS | 3411 | 07:07:14 INFO - PROCESS | 3411 | Cycle 1(1): loaded http://localhost:53669/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53669/tests/dromaeo/cssquery-mootools.html) 07:07:14 INFO - PROCESS | 3411 | RSS: Main: 242327552 07:07:14 INFO - PROCESS | 3411 | 07:10:17 INFO - PROCESS | 3411 | Cycle 1(1): loaded http://localhost:53669/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53669/tests/dromaeo/cssquery-prototype.html) 07:10:17 INFO - PROCESS | 3411 | RSS: Main: 232099840 07:10:17 INFO - PROCESS | 3411 | 07:13:20 INFO - PROCESS | 3411 | Cycle 1(1): loaded http://localhost:53669/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53669/tests/dromaeo/cssquery-yui.html) 07:13:21 INFO - PROCESS | 3411 | RSS: Main: 213983232 07:13:21 INFO - PROCESS | 3411 | 07:16:24 INFO - PROCESS | 3411 | Cycle 1(1): loaded http://localhost:53669/tests/dromaeo/cssquery-yui.html (next: http://localhost:53669/tests/dromaeo/cssquery-dojo.html) 07:16:24 INFO - PROCESS | 3411 | RSS: Main: 256237568 07:16:24 INFO - PROCESS | 3411 | 07:16:24 INFO - PROCESS | 3411 | __start_tp_report 07:16:24 INFO - PROCESS | 3411 | _x_x_mozilla_page_load 07:16:24 INFO - PROCESS | 3411 | _x_x_mozilla_page_load_details 07:16:24 INFO - PROCESS | 3411 | |i|pagename|runs| 07:16:24 INFO - PROCESS | 3411 | |0;dojo.html;2700.122460200435;2709.011210908017;2728.577070554064;2735.5076086304457;2773.098742908554;4602.056578401428;4683;4727.52724727527;4798.376211092562;4840.80636774529;4726.456457507387;4727.5036121207295;4746.145693775119;4747.572718455338;4755.833545825897;4307.418498502709;4352.912941741163;4386.451693538308;4421.977890110561;4520.751358675271;4445.110977804436;4461.754603496806;4462.977685111586;4495.6628252881;4521.321801729734;4272.6154646082;4317.805698743564;4324.8486302979245;4380.277254253045;4401.955980440219;4338.891527711801;4366.454193225847;4367;4378.5183629800695;4384.298512238059;4389.582989615981;4402.779861006937;4405.779711014468;4418.6023257906945;4442.022754993928;4596.632269418438;4644.210484217691;4664.696794708333;4776.331313616097;4781.330613714083;5120.15517439622;5158.174692049254;5158.871028224287;5213.687178769286;5218.843434696965;5126.410462796789;5168;5185.299984502081;5185.403678576974;5244.659097158673;4670.486246512881;4798.304245884327;4831.323614693945;4831.516848315211;4894.216925291937;5267;5285.841424757264;5329.1206950852675;5346.331708536433;5348.144296912553;5103.617228707788;5127.948720512822;5133.076046311625;5133.897322053538;5135.768890399866;4992.600591952635;5066.746662666852;5097.541221290027;5141.922871156936;5217.165253559412;5086.313347698014;5091.389033316026;5097.1844504879045;5097.566706829961;5129.12804823181;5077.466865979093;5078.5937125029905;5083.161278389024;5088.592912566985;5098.260752190986;4163.437935878617;4205.852795152155;4252.447181866338;4285.250081235771;4359.106383191438;3759.2293579816073;3760.0599850037493;3774.641409066134;3805.2009078093356;3817.0838998640684;4409.426774519292;4421.049474363027;4422.071365013319;4447.2439685253585;4473.373727678128;4967.677100988424;5067.265246539231;5074.543291103819;5089.287499750038;5163;4370.541093185233;4410.867673969786;4452.977735111303;4467.419235499365;4470.977645111819;4599.425071866017;4609.055143695535;4609.446866376056;4619.260918253063;4660.231061874752;4718.929216061831;4808.975955120272;4844.128056949783;4858.076965376567;4884.535969082932;5056.191009438472;5075.771590278372;5126.333576635014;5126.641135120506;5208.583313335;4826.1795494766675;4827.710337379768;4834.178189707828;4845.224764037737;4861.829835955725;5070.239464080418;5074.517920797518;5075.1625981712605;5082.237664350377;5124.026434977342;4985.501449854985;5083.059633967728;5110.105731497048;5127;5146.279520867007;5012.147934851011;5014.7994080236385;5019.824306149268;5026.723530205728;5038.924416133687;5009.173486374853;5019.272205530251;5021.472745361684;5026.472220416804;5035.370578677665;4807.4471435785335;4836.153673107263;4891.192953162688;4891.682040667345;4972.602191824718;5029.119904016856;5033.194688849767;5037.697738135724;5056.595472362275;5096.770645321044;4786.904261914812;4834.114695268919;4866.829660961849;4896.094222568836;4948.233023881304 07:16:24 INFO - PROCESS | 3411 | |1;ext.html;556.3351794605449;592.9377415371385;594.8037147741243;595.6247564034658;605.724395400093;27455.450890982167;30076.84961575192;40157.39763903544;41130.794346028226;41138.177236455325;41568.37647435291;42134.57865421345;42138.578614213846;42161.156776864445;42186.36720449188;7500.099988001421;7695.5767432791035;7867.095284042322;7868.370530357586;9972.800543989117;9699.127078562928;10103.59585616578;10108.494575271245;10118.089371956523;10118.595256189743;10103.191744660446;10182.64360747374;10194.541245643964;10209.693709188736;10216.387016779017;7533.246675332451;9841.655542055994;10031.548580313867;10135.341202821866;10143.797124057552;9922.3054386193;10027.59889604415;10043.447610381427;10043.74890627733;10056.094951454332;38312.61687383118;38660.613393865984;38723;38754.61245387538;38793.41809872854;2963.273997870514;2973;3030.6363236411553;3039.027511196418;3112.579801726783;29492;29679.406411871856;29795.55306670402;30056.24859378533;30250.697493025007;3223.580934478526;3235.8867439639735;3276.0499455157974;3342.131045928052;3343.6154842193214;258366;258866.70566647235;258969;259085;259882;32045.35909281848;52496;52541;52814.20778688323;52835.471645283826;31441;33575.66424335774;33591.32817343639;33596.32807343888;33637.663623363944;12100.394980250952;12111.818322725167;12148.87851121495;12149.635510934686;12165.817512737316;9109.089091090838;10262.281640285257;10441.530131144116;10458;10697.572097116185;7944.04671439431;7962.840743185104;7976.803479478125;8054.275115239657;8060.395470339748;3118.8128712277335;3127.56214130022;3136.5922430083942;3166.699163579456;3173.4287828190686;883.4964070479765;892.9107089291149;931.4597533430594;1034.022848408247;1058.1904842795268;28640.713592863805;28742.856285718437;28746.712532874404;28947.276318092216;29160.270993224916;957.4542510768935;1014.4268488304084;1036.0623635609786;1103.4096758234307;1112.9554817807198;15006.849931500763;15131.243437828065;15360.308786104428;15492.578674029808;15513.844861551466;394708;398279;399695;401237;402206;48937.51062489401;50223.497765022614;50277.49722502801;50384.24423633575;50394.999999999265;1094.9124070074374;1183.1776915044134;1197.7305106351175;1225.6629426907493;1232.6055662188014;28227.57658635163;28806;29408.852955735085;30072.69927300699;30153.698463015087;42237.36643950405;42664.36003459888;42771;42886.57113428951;42892.571074288855;293721;295165;295353;295814;297013;22213.22253721112;22778.35546312648;24501.632475512524;25176.874115629304;25297.62053569161;41619;41629.375559366024;41840;42586;42702.78648606737;35458;36324;36644.26711465809;36780.81609592042;37243.44134838034;36264.45603316005;36327.63672363242;36796.448053278684;36887.81556092203;37200.81399592985;35099.298014039065;35648.64351356453;36065.81967090148;36482.8175859119;36513.087172820895;31691.20771980719;32463.823115257124;32600.673993260712;32926.34147317088;33049.33901322008;25052.62421063649;25158.24525264245;25219.621705674796;25242.350689547453;25592.23223303304 07:16:24 INFO - PROCESS | 3411 | |2;jquery.html;342.18047775577475;348.59737003760665;356.8287222133376;357.20521838908434;380.49204312243154;15527;16279.59301017475;16688.41590544331;16697.74953375699;16986.150692465373;14675;15118.622034449145;15306.770398444005;15491.767623485628;15514.30185641646;4765.28520721891;5029.119904016782;5191.766370513317;5195.818146364859;5196.168613021917;3748.400255959047;3917.7061720370943;5142.151544995071;5156.329677141966;5640.407757185498;5900.203472531196;6001;6023.939760602404;6028.3067447243475;6028.788992385267;5816.302043754734;5925.73334199962;6001.069834175688;6035.7887473938645;6044.637321760686;3375.9831200844083;4816.951830481686;5100.311457953203;5109.923351149736;5145.794168233266;19308.32420865277;20139;20264.392068237976;20267.29064482736;20269.49326266855;1983.1769815526538;2031.2484380779058;2086.739157605299;2383.2492764779213;2510.786583140435;8858.202761751474;9130.086991300817;9578.90421095794;11892.940535297355;12627.810582841264;1726.2922201897288;1751.8160593137663;1782.2069179215255;1814.7640806695176;1821.8906865588108;66204.66897665529;68487.65756171188;69745.65127174383;69816;70191;9907.702768916799;9979.900200997898;10028.197744180448;10038.196944244442;10147.64483243083;13730.519431820037;13823.51617693376;13828.585142445743;13841.723165536632;13853.584392468241;6907.516473846783;6983.93016069843;7004.054452648929;7030.789076327718;7137.750178743719;6455.193100862392;6523.608583485006;6525.934740652628;6657.7669781557415;6686.699098540577;4286.2284788738325;4291.313389857608;4321.978390108029;4425.225585522585;4433.889152771207;1699.6345785656142;1738.6957282475516;1814.8088004448591;1830.3326517380892;1856.5265857206325;863.9697610583725;879.0813599788108;898.5776684958059;910.0080911806164;954.7231302922214;15755.369785208462;16603.252853621616;16623.667526649642;16731.414400495923;16856.66286674284;834.7746108550657;847.4788005376649;850.4174640371366;886.2821114896825;925.0749250749251;9194.77013074665;9370.10983956523;9470.95264523673;9540;9727.610895564098;354799;354900;356963;357488;357819;71212;73926;73940.26059739442;74919;75543;874.5976850648773;910.8132832769267;913.6756451459769;923.9491827949392;926.7497775600685;12969.481220751064;14682.63293417673;14748.926255368655;15261.847381526042;15850.60373490672;33812.661873381934;33827.51332202043;34764.652353477155;35081.64918350886;35192;45432;47434.52565474439;47438.28842567295;47588;47855.76072119756;7492.100947886289;7597.164311925573;7608.31525162738;7714.1128770192145;7813.413993950363;11298;11968.222065565711;11987.820182697093;12169.574064907685;12562.183458075197;9640.807183856425;10093.798124037625;10247.282690211614;10504.632337868137;10779.89220107789;10478.318909270873;10682.359058456517;10894.346339219355;10929.016388525071;11006.834897476385;10472.790544189225;10723.337882628206;10882.12942964545;10979.451027448436;11220.326780393203;7766.106897706836;7810.297073263207;7856.5678887661725;7962.641681124247;8110.553919534483;7773.1060927994;9210.263178945803;10253.794924101625;10749.408782516724;10951.178661600252 07:16:24 INFO - PROCESS | 3411 | |3;mootools.html;1252.6116903759842;1329.6371219500013;1399.2234309957973;1517.5219805761185;1762.91185440728;6573.934260657398;7355.963220183905;7606.92393076069;7613.961930190341;7625.809354766134;7404.96297518513;7411.814704632387;7424.517406368583;7464.664090115944;7479.850402991937;1883;2136.316378758798;2194.4952660887966;2202.7797220277926;2219.6670499425136;2213.3691897809126;2271.59111359956;2271.931842044733;2273.7271527416733;2276.1236923784295;2184.5740080684272;2196.2642514757495;2198.857074290166;2206.007296716484;2224.5439684864564;1810.9094545272683;2049.405672355015;2107.093949601671;2144.292383513437;2180.2151225558705;2099.349201747463;2154.3321570313096;2155.665871789875;2157.9784202157934;2165.2638103044883;7343.265673432614;7386.298301661333;7386.815329616748;7401.444891633149;7403.259674032607;4374.518802931675;4498.437695288089;4505.189065968125;4505.684602077856;4505.7747112644565;2850.900218492343;2949.292169879235;2960.0231923465203;2972.5689774982507;2988.4023195361015;856.7686724584389;857.4812238595684;883.6686242659002;889.6619284671848;897.6499165325529;10281.280310378277;10531.473426328654;10557.313774604627;10567.947160264226;10572.947135264352;4091.427200191916;4223.345381465878;4251.766152861561;4290.635295999812;4292.82828686849;9179.127982841619;9212.401193922373;9237.445753254826;9246.4914429707;9248.445093294424;4481.596656300883;4491.550844915548;4492.213862574036;4498.932516012263;4500.707454015478;3475.4265546184597;3835.8465661373234;3936.901577460529;3941.0935484838074;4078.3270760324212;3601.3157500075426;3621.348157331653;3664.725145614036;3696.094456858087;3735.7758534488016;1163.8894305041008;1170.3738499902681;1175.9235649682744;1182.2788099259444;1184.0527577937617;831.3640065350012;873.9825203495894;903.3902116071625;916.4592890194684;926.2312280806914;5258.8159414420315;5384.515393614593;5411.783528658888;5497.917531237034;5558.027345214652;378.73867031748006;389.2526349409141;390.2000898158763;391.0419472292894;391.1063220541107;3703.9814800925824;3784.4890939723336;3897.0841852164717;3938.6258305460933;3951.9012024699036;8941.195292423714;9558.474283914451;9565;9568.808623827623;9586.66446674363;9299.395539289924;9455.479948602893;9486.95256523713;9497.715068547956;9557.713268601952;7163.6060016699585;7298.854022919512;7311.341979221896;7311.670974806147;7328.780136595804;5339.9466005341;5351.759170837244;5482.457233742226;5491.341039075177;5519.586031047607;8407.159284071544;8473.152684731478;8574.742757717278;8791.120887911158;8807.955960220157;8841.867371989554;8971.147740964598;8976.551172441483;8977.596008179517;9075.410098343587;5913.349531551612;6123.203983482119;6137.3862613738265;6454.709538070704;6555.2789193187755;6849.48628852848;6909.930900690929;7056;7299.5255308404785;7319.597422141834;6426.839329016812;6452.9677351612945;6491.448226900767;6536.542442029203;6539;6614.669266536558;6640.933590664032;6651.966740166268;6685.799426017227;6725.125733654593;6249.6562689052535;6278.529110316653;6310.842228944313;6312.905306420315;6313.43179113882;4626.3523106764405;4631.305304204397;4637.327587499726;4742.359781429463;4779.784909679142;4696.178168820375;4727.858164255078;4861.1979023460735;4866.7079975201605;4943.036107958914 07:16:24 INFO - PROCESS | 3411 | |4;prototype.html;296.2475312705728;300.6452386184303;304.08773678963104;305.89599536157715;306.1977618639166;4711.387519622449;4724.126036683216;4738.881527961803;4770.451398089221;4770.499097594746;4647.674662773607;4682.765861706918;4685.50802165772;4703;4706.505816889228;3525.576930768305;3621.7102631789526;3644.781313121221;3736.364817980936;3754.155315054118;3692.280005398948;3704.1850792825535;3725.3853114236254;3733.813309334536;3737.588865224823;3499.1602015516346;3696.5009723687226;3703.2778608171416;3709.9072523186865;3738.476613274144;3568.982155089221;3691.575468821093;3699.4265888787013;3699.741018128732;3708.6476784705546;3271.656476070002;3288.52316414121;3299.835008249578;3300.2574420755136;3302.719268862126;4519.502854685982;4524.140413321458;4527.479339875924;4527.796249168762;4547.8635640930825;3994.681755020836;4204.024108668921;4231.386448964914;4244.533101358848;4288.935665965013;4894.853154405374;4921.483244259372;4930.827421040282;4934.950650493485;4939.481354457766;3599.1464395836165;3626.4379021251484;3657.1771351445977;3665.981670091659;3674.393725035366;5025.748712564357;5158.896822063538;5161.1742121260795;5178.922316165261;5188.377394712621;3757.1734218471893;3761.5674197467642;3773.2453509298252;3776.244751049801;3786.545614526219;3791.7724936503896;3805.980970095132;3806.657400833883;3821.3885778275344;3824.732268741217;4213.894652633709;4223.915521689549;4246.8725938221905;4247.341662042389;4258.9139769359235;4705.411823522059;4910.729909854992;4933.260010998379;4958.479359667255;4967.205247160509;1298.6169080121388;1306.431702209542;1309.18830325199;1309.9324050898488;1312.3700623700677;849.4054162086564;852.4331319672349;889.4974339498162;915.9985431831469;918.5958178401482;4274.995376086617;4335.848245311399;4339.609435150852;4365.410669559632;4367.344898265285;5032.899342013213;5044.117279476077;5066.518680725325;5069.493050694901;5070.61970352225;4189.853355132555;4322.0491491871735;4351.782410879443;4359.80380882861;4360.585744354281;2648.4173481833964;2661.321363052409;2673.345030467509;2673.46530693862;2674.9732502675115;4680.297955306732;4701.130290896195;4724.740139292372;4727.976360118178;4737.763111844394;4919.852404427873;5046.571041461517;5088.821891233789;5112.284280200774;5159.716215608178;4750.287456881495;4765.547273009059;4772.570468657837;4776.2119250324;4776.808927642855;4985.900281994267;5040.34475518195;5047.545720885138;5056.64603477753;5056.646034777677;4782.713037217639;4935.876603084952;4946.554810067111;4948.950510494849;5081.560850791715;4853.466118726867;4890.828820991248;4891.87770305731;4898.167311556973;4898.363212782316;3632.3643362410944;3635.636436356343;3637.799526156309;3647.3799454092336;3649.835757390977;4951.702897826142;5020.7991680333835;5096.490350964874;5162.97418512905;5165.92251116226;4937.160682683881;4972.477889821661;4984.0843106781485;5008.595873980437;5013.523715247045;4993.126202914403;4999.750012499288;5002.474740152232;5013.498650134958;5016.899662006813;4775.283707443911;4897.4857639947295;4912.649021519111;4912.778924948458;4916.483769204182;4773.427188737373;4878.219484882544;5001.549860512571;5041.1430056889685;5042.647014708935;4799.9760001199775;4822.397200349957;4876.366072410564;4898.093852637274;4916.237983112624 07:16:24 INFO - PROCESS | 3411 | |5;yui.html;620.1194304088194;631.9715612797427;652.3150691773639;671.8320419895026;753.9711949405865;11566.768664626703;12419.56531521397;12632.936835315833;12946.546870859522;12948.999999999989;12592.370381480912;12667.429965651545;12710;12728;12744.681382965407;634.0742515926753;769.084789100968;797.6011994002998;811.663159788687;813.662330132994;798.7284323330067;812.8130529978108;813.1908750792969;813.2314962360572;813.3574476163824;845.378646694682;850.5364576305897;851.5912362066211;851.7359618518249;852.0159216105408;657.4937298280345;814.1654803826126;835.6532039203784;839.5802098950525;839.7564706235185;617.0743884173739;617.5337620096798;618.0512912679061;618.1253526260336;618.6010023534794;11013.559457621686;11078.667639970814;11117.388543630097;11129.666110016713;11241.887581124165;12292;12619.936900315439;12797.808032879515;13031.674208144777;13308.73382532344;11146.275492092987;11247.044001259903;11257;11264.887351126548;11475.13936454761;4113.945999504583;4149.128682976579;4156.355764856452;4200;4249.575042495757;57221;58592;58723.70638146825;58825.7058714708;58954.41045589575;9706.272029597809;9717.6598819041;9864.753381165385;10040.397576145455;10419.479026048668;19201.423957281302;19204.423867284004;19208.519787005156;19240.615187696447;19254.903725481283;6624.668766561653;6668.133142691419;6922.411595014481;6926.134233220848;6927.826804329932;3649.2154186849953;3687.649673281034;3729.2914346274665;3825.387937929918;3870.53553573573;2963.303623648441;3080.5995220621626;3083.4758091124563;3085.1361618746787;3086;497.9751012449363;516.5273774496369;517.1415450352472;569.0780934885429;608.2518502242267;435.8583460375327;525.865904194428;550.6338285040404;593.6349145275624;642.996785016072;8361.163883611713;8694.260987816106;8783.604737786814;8876.423032502867;8920.598573064228;479.8176692856692;562.5668235458755;574.4513989140361;650.3593959949541;654.653033892038;4070.592940705965;4074.8573799916862;4147.834086636501;4241.745495270294;4309.267424537836;84220.57889710512;85178.72231916526;90096;92153.53923230476;92262.07737922668;51182.23226651603;58194.70902645544;67626.323736762;76571.23428765753;76957.23042769612;67524;68240.65879670669;68702.31297687058;69198.65400672964;69243;8157.55133467665;8271.669133234604;8330.375221858507;8345.248927596545;8367.832643347221;42846.78576607097;43703;44511.77744111259;44771.31372117683;45395.319070213314;58220.4177958215;59989;61640.38359616346;62415.68792156192;62626.06060908999;9697.563609637724;10118.342307749972;10387.844182337421;10461.476926153815;10618.787624247627;10341.896581034094;10641.89358106409;10675.145988321072;12019.819702704292;13379.130356526795;10046.179055563714;10162.085412312927;10372.222083343628;10586.788264234518;11203;11279.661610151708;11699.181057325906;11903.40482975865;11988.340641264815;11996.340201289013;11665.475053622438;11682.824757628812;11850.585229516926;12341.93829030885;12420.192687475284;9478.146966773023;9714.562844671866;9740.951295243478;10011.149052330633;10027.398356098365;9775.951120244354;10063.540959899155;10113.848292275474;10166.169154228855;10334.483275836328 07:16:24 INFO - PROCESS | 3411 | __end_tp_report 07:16:24 INFO - PROCESS | 3411 | __start_cc_report 07:16:24 INFO - PROCESS | 3411 | _x_x_mozilla_cycle_collect,903 07:16:24 INFO - PROCESS | 3411 | __end_cc_report 07:16:24 INFO - PROCESS | 3411 | __startTimestamp1464963384741__endTimestamp 07:16:24 INFO - PROCESS | 3411 | 07:16:24 INFO - PROCESS | 3411 | ------- Summary: start ------- 07:16:24 INFO - PROCESS | 3411 | Number of tests: 6 07:16:24 INFO - PROCESS | 3411 | 07:16:24 INFO - PROCESS | 3411 | [#0] dojo.html Cycles:165 Average:4732.55 Median:4840.81 stddev:497.23 (10.3%) stddev-sans-first:472.50 07:16:24 INFO - PROCESS | 3411 | Values: 2700.1 2709.0 2728.6 2735.5 2773.1 4602.1 4683.0 4727.5 4798.4 4840.8 4726.5 4727.5 4746.1 4747.6 4755.8 4307.4 4352.9 4386.5 4422.0 4520.8 4445.1 4461.8 4463.0 4495.7 4521.3 4272.6 4317.8 4324.8 4380.3 4402.0 4338.9 4366.5 4367.0 4378.5 4384.3 4389.6 4402.8 4405.8 4418.6 4442.0 4596.6 4644.2 4664.7 4776.3 4781.3 5120.2 5158.2 5158.9 5213.7 5218.8 5126.4 5168.0 5185.3 5185.4 5244.7 4670.5 4798.3 4831.3 4831.5 4894.2 5267.0 5285.8 5329.1 5346.3 5348.1 5103.6 5127.9 5133.1 5133.9 5135.8 4992.6 5066.7 5097.5 5141.9 5217.2 5086.3 5091.4 5097.2 5097.6 5129.1 5077.5 5078.6 5083.2 5088.6 5098.3 4163.4 4205.9 4252.4 4285.3 4359.1 3759.2 3760.1 3774.6 3805.2 3817.1 4409.4 4421.0 4422.1 4447.2 4473.4 4967.7 5067.3 5074.5 5089.3 5163.0 4370.5 4410.9 4453.0 4467.4 4471.0 4599.4 4609.1 4609.4 4619.3 4660.2 4718.9 4809.0 4844.1 4858.1 4884.5 5056.2 5075.8 5126.3 5126.6 5208.6 4826.2 4827.7 4834.2 4845.2 4861.8 5070.2 5074.5 5075.2 5082.2 5124.0 4985.5 5083.1 5110.1 5127.0 5146.3 5012.1 5014.8 5019.8 5026.7 5038.9 5009.2 5019.3 5021.5 5026.5 5035.4 4807.4 4836.2 4891.2 4891.7 4972.6 5029.1 5033.2 5037.7 5056.6 5096.8 4786.9 4834.1 4866.8 4896.1 4948.2 07:16:24 INFO - PROCESS | 3411 | 07:16:24 INFO - PROCESS | 3411 | [#1] ext.html Cycles:180 Average:46462.81 Median:17634.47 stddev:85242.69 (483.4%) stddev-sans-first:85412.14 07:16:24 INFO - PROCESS | 3411 | Values: 556.3 592.9 594.8 595.6 605.7 27455.5 30076.8 40157.4 41130.8 41138.2 41568.4 42134.6 42138.6 42161.2 42186.4 7500.1 7695.6 7867.1 7868.4 9972.8 9699.1 10103.6 10108.5 10118.1 10118.6 10103.2 10182.6 10194.5 10209.7 10216.4 7533.2 9841.7 10031.5 10135.3 10143.8 9922.3 10027.6 10043.4 10043.7 10056.1 38312.6 38660.6 38723.0 38754.6 38793.4 2963.3 2973.0 3030.6 3039.0 3112.6 29492.0 29679.4 29795.6 30056.2 30250.7 3223.6 3235.9 3276.0 3342.1 3343.6 258366.0 258866.7 258969.0 259085.0 259882.0 32045.4 52496.0 52541.0 52814.2 52835.5 31441.0 33575.7 33591.3 33596.3 33637.7 12100.4 12111.8 12148.9 12149.6 12165.8 9109.1 10262.3 10441.5 10458.0 10697.6 7944.0 7962.8 7976.8 8054.3 8060.4 3118.8 3127.6 3136.6 3166.7 3173.4 883.5 892.9 931.5 1034.0 1058.2 28640.7 28742.9 28746.7 28947.3 29160.3 957.5 1014.4 1036.1 1103.4 1113.0 15006.8 15131.2 15360.3 15492.6 15513.8 394708.0 398279.0 399695.0 401237.0 402206.0 48937.5 50223.5 50277.5 50384.2 50395.0 1094.9 1183.2 1197.7 1225.7 1232.6 28227.6 28806.0 29408.9 30072.7 30153.7 42237.4 42664.4 42771.0 42886.6 42892.6 293721.0 295165.0 295353.0 295814.0 297013.0 22213.2 22778.4 24501.6 25176.9 25297.6 41619.0 41629.4 41840.0 42586.0 42702.8 35458.0 36324.0 36644.3 36780.8 37243.4 36264.5 36327.6 36796.4 36887.8 37200.8 35099.3 35648.6 36065.8 36482.8 36513.1 31691.2 32463.8 32600.7 32926.3 33049.3 25052.6 25158.2 25219.6 25242.4 25592.2 07:16:24 INFO - PROCESS | 3411 | 07:16:24 INFO - PROCESS | 3411 | [#2] jquery.html Cycles:180 Average:23054.38 Median:4288.77 stddev:58940.67 (1374.3%) stddev-sans-first:59081.34 07:16:24 INFO - PROCESS | 3411 | Values: 342.2 348.6 356.8 357.2 380.5 15527.0 16279.6 16688.4 16697.7 16986.2 14675.0 15118.6 15306.8 15491.8 15514.3 4765.3 5029.1 5191.8 5195.8 5196.2 3748.4 3917.7 5142.2 5156.3 5640.4 5900.2 6001.0 6023.9 6028.3 6028.8 5816.3 5925.7 6001.1 6035.8 6044.6 3376.0 4817.0 5100.3 5109.9 5145.8 19308.3 20139.0 20264.4 20267.3 20269.5 1983.2 2031.2 2086.7 2383.2 2510.8 8858.2 9130.1 9578.9 11892.9 12627.8 1726.3 1751.8 1782.2 1814.8 1821.9 66204.7 68487.7 69745.7 69816.0 70191.0 9907.7 9979.9 10028.2 10038.2 10147.6 13730.5 13823.5 13828.6 13841.7 13853.6 6907.5 6983.9 7004.1 7030.8 7137.8 6455.2 6523.6 6525.9 6657.8 6686.7 4286.2 4291.3 4322.0 4425.2 4433.9 1699.6 1738.7 1814.8 1830.3 1856.5 864.0 879.1 898.6 910.0 954.7 15755.4 16603.3 16623.7 16731.4 16856.7 834.8 847.5 850.4 886.3 925.1 9194.8 9370.1 9471.0 9540.0 9727.6 354799.0 354900.0 356963.0 357488.0 357819.0 71212.0 73926.0 73940.3 74919.0 75543.0 874.6 910.8 913.7 923.9 926.7 12969.5 14682.6 14748.9 15261.8 15850.6 33812.7 33827.5 34764.7 35081.6 35192.0 45432.0 47434.5 47438.3 47588.0 47855.8 7492.1 7597.2 7608.3 7714.1 7813.4 11298.0 11968.2 11987.8 12169.6 12562.2 9640.8 10093.8 10247.3 10504.6 10779.9 10478.3 10682.4 10894.3 10929.0 11006.8 10472.8 10723.3 10882.1 10979.5 11220.3 7766.1 7810.3 7856.6 7962.6 8110.6 7773.1 9210.3 10253.8 10749.4 10951.2 07:16:24 INFO - PROCESS | 3411 | 07:16:24 INFO - PROCESS | 3411 | [#3] mootools.html Cycles:180 Average:5052.70 Median:5299.38 stddev:2821.13 (53.2%) stddev-sans-first:2814.59 07:16:24 INFO - PROCESS | 3411 | Values: 1252.6 1329.6 1399.2 1517.5 1762.9 6573.9 7356.0 7606.9 7614.0 7625.8 7405.0 7411.8 7424.5 7464.7 7479.9 1883.0 2136.3 2194.5 2202.8 2219.7 2213.4 2271.6 2271.9 2273.7 2276.1 2184.6 2196.3 2198.9 2206.0 2224.5 1810.9 2049.4 2107.1 2144.3 2180.2 2099.3 2154.3 2155.7 2158.0 2165.3 7343.3 7386.3 7386.8 7401.4 7403.3 4374.5 4498.4 4505.2 4505.7 4505.8 2850.9 2949.3 2960.0 2972.6 2988.4 856.8 857.5 883.7 889.7 897.6 10281.3 10531.5 10557.3 10567.9 10572.9 4091.4 4223.3 4251.8 4290.6 4292.8 9179.1 9212.4 9237.4 9246.5 9248.4 4481.6 4491.6 4492.2 4498.9 4500.7 3475.4 3835.8 3936.9 3941.1 4078.3 3601.3 3621.3 3664.7 3696.1 3735.8 1163.9 1170.4 1175.9 1182.3 1184.1 831.4 874.0 903.4 916.5 926.2 5258.8 5384.5 5411.8 5497.9 5558.0 378.7 389.3 390.2 391.0 391.1 3704.0 3784.5 3897.1 3938.6 3951.9 8941.2 9558.5 9565.0 9568.8 9586.7 9299.4 9455.5 9487.0 9497.7 9557.7 7163.6 7298.9 7311.3 7311.7 7328.8 5339.9 5351.8 5482.5 5491.3 5519.6 8407.2 8473.2 8574.7 8791.1 8808.0 8841.9 8971.1 8976.6 8977.6 9075.4 5913.3 6123.2 6137.4 6454.7 6555.3 6849.5 6909.9 7056.0 7299.5 7319.6 6426.8 6453.0 6491.4 6536.5 6539.0 6614.7 6640.9 6652.0 6685.8 6725.1 6249.7 6278.5 6310.8 6312.9 6313.4 4626.4 4631.3 4637.3 4742.4 4779.8 4696.2 4727.9 4861.2 4866.7 4943.0 07:16:24 INFO - PROCESS | 3411 | 07:16:24 INFO - PROCESS | 3411 | [#4] prototype.html Cycles:180 Average:4118.65 Median:4704.21 stddev:1175.57 (25.0%) stddev-sans-first:1143.32 07:16:24 INFO - PROCESS | 3411 | Values: 296.2 300.6 304.1 305.9 306.2 4711.4 4724.1 4738.9 4770.5 4770.5 4647.7 4682.8 4685.5 4703.0 4706.5 3525.6 3621.7 3644.8 3736.4 3754.2 3692.3 3704.2 3725.4 3733.8 3737.6 3499.2 3696.5 3703.3 3709.9 3738.5 3569.0 3691.6 3699.4 3699.7 3708.6 3271.7 3288.5 3299.8 3300.3 3302.7 4519.5 4524.1 4527.5 4527.8 4547.9 3994.7 4204.0 4231.4 4244.5 4288.9 4894.9 4921.5 4930.8 4935.0 4939.5 3599.1 3626.4 3657.2 3666.0 3674.4 5025.7 5158.9 5161.2 5178.9 5188.4 3757.2 3761.6 3773.2 3776.2 3786.5 3791.8 3806.0 3806.7 3821.4 3824.7 4213.9 4223.9 4246.9 4247.3 4258.9 4705.4 4910.7 4933.3 4958.5 4967.2 1298.6 1306.4 1309.2 1309.9 1312.4 849.4 852.4 889.5 916.0 918.6 4275.0 4335.8 4339.6 4365.4 4367.3 5032.9 5044.1 5066.5 5069.5 5070.6 4189.9 4322.0 4351.8 4359.8 4360.6 2648.4 2661.3 2673.3 2673.5 2675.0 4680.3 4701.1 4724.7 4728.0 4737.8 4919.9 5046.6 5088.8 5112.3 5159.7 4750.3 4765.5 4772.6 4776.2 4776.8 4985.9 5040.3 5047.5 5056.6 5056.6 4782.7 4935.9 4946.6 4949.0 5081.6 4853.5 4890.8 4891.9 4898.2 4898.4 3632.4 3635.6 3637.8 3647.4 3649.8 4951.7 5020.8 5096.5 5163.0 5165.9 4937.2 4972.5 4984.1 5008.6 5013.5 4993.1 4999.8 5002.5 5013.5 5016.9 4775.3 4897.5 4912.6 4912.8 4916.5 4773.4 4878.2 5001.5 5041.1 5042.6 4800.0 4822.4 4876.4 4898.1 4916.2 07:16:24 INFO - PROCESS | 3411 | 07:16:24 INFO - PROCESS | 3411 | [#5] yui.html Cycles:180 Average:16602.55 Median:25849.38 stddev:22749.60 (88.0%) stddev-sans-first:22781.77 07:16:24 INFO - PROCESS | 3411 | Values: 620.1 632.0 652.3 671.8 754.0 11566.8 12419.6 12632.9 12946.5 12949.0 12592.4 12667.4 12710.0 12728.0 12744.7 634.1 769.1 797.6 811.7 813.7 798.7 812.8 813.2 813.2 813.4 845.4 850.5 851.6 851.7 852.0 657.5 814.2 835.7 839.6 839.8 617.1 617.5 618.1 618.1 618.6 11013.6 11078.7 11117.4 11129.7 11241.9 12292.0 12619.9 12797.8 13031.7 13308.7 11146.3 11247.0 11257.0 11264.9 11475.1 4113.9 4149.1 4156.4 4200.0 4249.6 57221.0 58592.0 58723.7 58825.7 58954.4 9706.3 9717.7 9864.8 10040.4 10419.5 19201.4 19204.4 19208.5 19240.6 19254.9 6624.7 6668.1 6922.4 6926.1 6927.8 3649.2 3687.6 3729.3 3825.4 3870.5 2963.3 3080.6 3083.5 3085.1 3086.0 498.0 516.5 517.1 569.1 608.3 435.9 525.9 550.6 593.6 643.0 8361.2 8694.3 8783.6 8876.4 8920.6 479.8 562.6 574.5 650.4 654.7 4070.6 4074.9 4147.8 4241.7 4309.3 84220.6 85178.7 90096.0 92153.5 92262.1 51182.2 58194.7 67626.3 76571.2 76957.2 67524.0 68240.7 68702.3 69198.7 69243.0 8157.6 8271.7 8330.4 8345.2 8367.8 42846.8 43703.0 44511.8 44771.3 45395.3 58220.4 59989.0 61640.4 62415.7 62626.1 9697.6 10118.3 10387.8 10461.5 10618.8 10341.9 10641.9 10675.1 12019.8 13379.1 10046.2 10162.1 10372.2 10586.8 11203.0 11279.7 11699.2 11903.4 11988.3 11996.3 11665.5 11682.8 11850.6 12341.9 12420.2 9478.1 9714.6 9741.0 10011.1 10027.4 9776.0 10063.5 10113.8 10166.2 10334.5 07:16:24 INFO - PROCESS | 3411 | -------- Summary: end -------- 07:16:24 INFO - PROCESS | 3411 | 07:16:25 INFO - TEST-INFO | 3411: exit 0 07:16:25 INFO - TEST-OK | dromaeo_css | took 1122084ms 07:16:25 INFO - TEST-START | kraken 07:16:25 INFO - operating with platform_type : linux_ 07:16:25 INFO - Initialising browser for kraken test... 07:16:25 INFO - TEST-INFO | started process 3586 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaQKPDz/profile http://localhost:53669/getInfo.html) 07:16:30 INFO - PROCESS | 3586 | __metrics Screen width/height:1600/1200 07:16:30 INFO - PROCESS | 3586 | colorDepth:24 07:16:30 INFO - PROCESS | 3586 | Browser inner width/height: 1024/697 07:16:30 INFO - PROCESS | 3586 | __metrics 07:16:31 ERROR - PROCESS | 3586 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:16:32 INFO - TEST-INFO | 3586: exit 0 07:16:32 INFO - Browser initialized. 07:16:32 INFO - Running cycle 1/1 for kraken test... 07:16:32 INFO - TEST-INFO | started process 3668 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaQKPDz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:16:44 INFO - PROCESS | 3668 | RSS: Main: 157810688 07:16:44 INFO - PROCESS | 3668 | 07:16:47 INFO - PROCESS | 3668 | Cycle 1(1): loaded http://localhost:53669/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53669/tests/kraken/driver.html?testName=audio-beat-detection) 07:16:47 INFO - PROCESS | 3668 | RSS: Main: 214609920 07:16:47 INFO - PROCESS | 3668 | 07:16:50 INFO - PROCESS | 3668 | Cycle 1(1): loaded http://localhost:53669/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53669/tests/kraken/driver.html?testName=audio-dft) 07:16:51 INFO - PROCESS | 3668 | RSS: Main: 201011200 07:16:51 INFO - PROCESS | 3668 | 07:16:54 INFO - PROCESS | 3668 | Cycle 1(1): loaded http://localhost:53669/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53669/tests/kraken/driver.html?testName=audio-fft) 07:16:55 INFO - PROCESS | 3668 | RSS: Main: 270553088 07:16:55 INFO - PROCESS | 3668 | 07:16:57 INFO - PROCESS | 3668 | Cycle 1(1): loaded http://localhost:53669/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53669/tests/kraken/driver.html?testName=audio-oscillator) 07:16:58 INFO - PROCESS | 3668 | RSS: Main: 180211712 07:16:58 INFO - PROCESS | 3668 | 07:17:00 INFO - PROCESS | 3668 | Cycle 1(1): loaded http://localhost:53669/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53669/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:17:00 INFO - PROCESS | 3668 | RSS: Main: 184074240 07:17:00 INFO - PROCESS | 3668 | 07:17:04 INFO - PROCESS | 3668 | Cycle 1(1): loaded http://localhost:53669/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53669/tests/kraken/driver.html?testName=imaging-darkroom) 07:17:04 INFO - PROCESS | 3668 | RSS: Main: 220237824 07:17:04 INFO - PROCESS | 3668 | 07:17:08 INFO - PROCESS | 3668 | Cycle 1(1): loaded http://localhost:53669/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53669/tests/kraken/driver.html?testName=imaging-desaturate) 07:17:08 INFO - PROCESS | 3668 | RSS: Main: 215928832 07:17:08 INFO - PROCESS | 3668 | 07:17:11 INFO - PROCESS | 3668 | Cycle 1(1): loaded http://localhost:53669/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53669/tests/kraken/driver.html?testName=json-parse-financial) 07:17:12 INFO - PROCESS | 3668 | RSS: Main: 219713536 07:17:12 INFO - PROCESS | 3668 | 07:17:14 INFO - PROCESS | 3668 | Cycle 1(1): loaded http://localhost:53669/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53669/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:17:14 INFO - PROCESS | 3668 | RSS: Main: 207712256 07:17:15 INFO - PROCESS | 3668 | 07:17:16 INFO - PROCESS | 3668 | Cycle 1(1): loaded http://localhost:53669/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53669/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:17:17 INFO - PROCESS | 3668 | RSS: Main: 210280448 07:17:17 INFO - PROCESS | 3668 | 07:17:19 INFO - PROCESS | 3668 | Cycle 1(1): loaded http://localhost:53669/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53669/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:17:20 INFO - PROCESS | 3668 | RSS: Main: 216633344 07:17:20 INFO - PROCESS | 3668 | 07:17:23 INFO - PROCESS | 3668 | Cycle 1(1): loaded http://localhost:53669/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53669/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:17:23 INFO - PROCESS | 3668 | RSS: Main: 223277056 07:17:23 INFO - PROCESS | 3668 | 07:17:26 INFO - PROCESS | 3668 | Cycle 1(1): loaded http://localhost:53669/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53669/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:17:27 INFO - PROCESS | 3668 | RSS: Main: 223711232 07:17:27 INFO - PROCESS | 3668 | 07:17:29 INFO - PROCESS | 3668 | Cycle 1(1): loaded http://localhost:53669/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53669/tests/kraken/driver.html?testName=ai-astar) 07:17:29 INFO - PROCESS | 3668 | RSS: Main: 266952704 07:17:29 INFO - PROCESS | 3668 | 07:17:29 INFO - PROCESS | 3668 | __start_tp_report 07:17:29 INFO - PROCESS | 3668 | _x_x_mozilla_page_load 07:17:29 INFO - PROCESS | 3668 | _x_x_mozilla_page_load_details 07:17:29 INFO - PROCESS | 3668 | |i|pagename|runs| 07:17:29 INFO - PROCESS | 3668 | |0;ai-astar;113;109;113;112;111;111;112;112;114;114 07:17:29 INFO - PROCESS | 3668 | |1;audio-beat-detection;164;130;137;188;131;164;172;131;195;132 07:17:29 INFO - PROCESS | 3668 | |2;audio-dft;161;160;163;161;160;160;161;161;161;159 07:17:29 INFO - PROCESS | 3668 | |3;audio-fft;75;76;77;119;77;76;74;74;97;75 07:17:29 INFO - PROCESS | 3668 | |4;audio-oscillator;87;86;122;85;86;86;124;86;85;127 07:17:29 INFO - PROCESS | 3668 | |5;imaging-gaussian-blur;119;116;117;120;117;117;116;117;117;117 07:17:29 INFO - PROCESS | 3668 | |6;imaging-darkroom;147;148;147;149;147;147;146;147;147;147 07:17:29 INFO - PROCESS | 3668 | |7;imaging-desaturate;95;95;94;95;95;96;95;94;95;95 07:17:29 INFO - PROCESS | 3668 | |8;json-parse-financial;63;63;64;63;65;64;64;63;63;64 07:17:29 INFO - PROCESS | 3668 | |9;json-stringify-tinderbox;64;67;66;65;65;65;65;65;67;65 07:17:29 INFO - PROCESS | 3668 | |10;stanford-crypto-aes;83;84;83;82;84;84;83;84;118;84 07:17:29 INFO - PROCESS | 3668 | |11;stanford-crypto-ccm;135;129;130;130;130;129;130;132;134;143 07:17:29 INFO - PROCESS | 3668 | |12;stanford-crypto-pbkdf2;168;173;168;168;166;168;168;167;165;167 07:17:29 INFO - PROCESS | 3668 | |13;stanford-crypto-sha256-iterative;67;66;67;67;66;68;67;66;72;69 07:17:29 INFO - PROCESS | 3668 | __end_tp_report 07:17:29 INFO - PROCESS | 3668 | __start_cc_report 07:17:29 INFO - PROCESS | 3668 | _x_x_mozilla_cycle_collect,1872 07:17:29 INFO - PROCESS | 3668 | __end_cc_report 07:17:29 INFO - PROCESS | 3668 | __startTimestamp1464963449260__endTimestamp 07:17:29 INFO - PROCESS | 3668 | 07:17:29 INFO - PROCESS | 3668 | ------- Summary: start ------- 07:17:29 INFO - PROCESS | 3668 | Number of tests: 14 07:17:29 INFO - PROCESS | 3668 | 07:17:29 INFO - PROCESS | 3668 | [#0] ai-astar Cycles:10 Average:112.10 Median:112.50 stddev:1.52 (1.4%) stddev-sans-first:1.58 07:17:29 INFO - PROCESS | 3668 | Values: 113.0 109.0 113.0 112.0 111.0 111.0 112.0 112.0 114.0 114.0 07:17:29 INFO - PROCESS | 3668 | 07:17:29 INFO - PROCESS | 3668 | [#1] audio-beat-detection Cycles:10 Average:154.40 Median:164.00 stddev:25.31 (15.4%) stddev-sans-first:26.61 07:17:29 INFO - PROCESS | 3668 | Values: 164.0 130.0 137.0 188.0 131.0 164.0 172.0 131.0 195.0 132.0 07:17:29 INFO - PROCESS | 3668 | 07:17:29 INFO - PROCESS | 3668 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 07:17:29 INFO - PROCESS | 3668 | Values: 161.0 160.0 163.0 161.0 160.0 160.0 161.0 161.0 161.0 159.0 07:17:29 INFO - PROCESS | 3668 | 07:17:29 INFO - PROCESS | 3668 | [#3] audio-fft Cycles:10 Average:82.00 Median:76.00 stddev:14.69 (19.3%) stddev-sans-first:15.36 07:17:29 INFO - PROCESS | 3668 | Values: 75.0 76.0 77.0 119.0 77.0 76.0 74.0 74.0 97.0 75.0 07:17:29 INFO - PROCESS | 3668 | 07:17:29 INFO - PROCESS | 3668 | [#4] audio-oscillator Cycles:10 Average:97.40 Median:86.00 stddev:18.63 (21.7%) stddev-sans-first:19.38 07:17:29 INFO - PROCESS | 3668 | Values: 87.0 86.0 122.0 85.0 86.0 86.0 124.0 86.0 85.0 127.0 07:17:29 INFO - PROCESS | 3668 | 07:17:29 INFO - PROCESS | 3668 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:1.25 (1.1%) stddev-sans-first:1.17 07:17:29 INFO - PROCESS | 3668 | Values: 119.0 116.0 117.0 120.0 117.0 117.0 116.0 117.0 117.0 117.0 07:17:29 INFO - PROCESS | 3668 | 07:17:29 INFO - PROCESS | 3668 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 07:17:29 INFO - PROCESS | 3668 | Values: 147.0 148.0 147.0 149.0 147.0 147.0 146.0 147.0 147.0 147.0 07:17:29 INFO - PROCESS | 3668 | 07:17:29 INFO - PROCESS | 3668 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 07:17:29 INFO - PROCESS | 3668 | Values: 95.0 95.0 94.0 95.0 95.0 96.0 95.0 94.0 95.0 95.0 07:17:29 INFO - PROCESS | 3668 | 07:17:29 INFO - PROCESS | 3668 | [#8] json-parse-financial Cycles:10 Average:63.60 Median:64.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 07:17:29 INFO - PROCESS | 3668 | Values: 63.0 63.0 64.0 63.0 65.0 64.0 64.0 63.0 63.0 64.0 07:17:29 INFO - PROCESS | 3668 | 07:17:29 INFO - PROCESS | 3668 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.00 stddev:0.97 (1.5%) stddev-sans-first:0.88 07:17:29 INFO - PROCESS | 3668 | Values: 64.0 67.0 66.0 65.0 65.0 65.0 65.0 65.0 67.0 65.0 07:17:29 INFO - PROCESS | 3668 | 07:17:29 INFO - PROCESS | 3668 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:84.00 stddev:10.95 (13.0%) stddev-sans-first:11.52 07:17:29 INFO - PROCESS | 3668 | Values: 83.0 84.0 83.0 82.0 84.0 84.0 83.0 84.0 118.0 84.0 07:17:29 INFO - PROCESS | 3668 | 07:17:29 INFO - PROCESS | 3668 | [#11] stanford-crypto-ccm Cycles:10 Average:132.20 Median:131.00 stddev:4.32 (3.3%) stddev-sans-first:4.46 07:17:29 INFO - PROCESS | 3668 | Values: 135.0 129.0 130.0 130.0 130.0 129.0 130.0 132.0 134.0 143.0 07:17:29 INFO - PROCESS | 3668 | 07:17:29 INFO - PROCESS | 3668 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.80 Median:168.00 stddev:2.10 (1.2%) stddev-sans-first:2.22 07:17:29 INFO - PROCESS | 3668 | Values: 168.0 173.0 168.0 168.0 166.0 168.0 168.0 167.0 165.0 167.0 07:17:29 INFO - PROCESS | 3668 | 07:17:29 INFO - PROCESS | 3668 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.00 stddev:1.84 (2.7%) stddev-sans-first:1.94 07:17:29 INFO - PROCESS | 3668 | Values: 67.0 66.0 67.0 67.0 66.0 68.0 67.0 66.0 72.0 69.0 07:17:29 INFO - PROCESS | 3668 | -------- Summary: end -------- 07:17:29 INFO - PROCESS | 3668 | 07:17:30 INFO - TEST-INFO | 3668: exit 0 07:17:30 INFO - TEST-OK | kraken | took 64888ms 07:17:30 INFO - SUITE-END | took 1186s 07:17:30 INFO - Completed test suite (00:19:47) 07:17:30 INFO - javascript benchmark 07:17:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2700.122460200435, 2709.011210908017, 2728.577070554064, 2735.5076086304457, 2773.098742908554, 4602.056578401428, 4683.0, 4727.52724727527, 4798.376211092562, 4840.80636774529, 4726.456457507387, 4727.5036121207295, 4746.145693775119, 4747.572718455338, 4755.833545825897, 4307.418498502709, 4352.912941741163, 4386.451693538308, 4421.977890110561, 4520.751358675271, 4445.110977804436, 4461.754603496806, 4462.977685111586, 4495.6628252881, 4521.321801729734, 4272.6154646082, 4317.805698743564, 4324.8486302979245, 4380.277254253045, 4401.955980440219, 4338.891527711801, 4366.454193225847, 4367.0, 4378.5183629800695, 4384.298512238059, 4389.582989615981, 4402.779861006937, 4405.779711014468, 4418.6023257906945, 4442.022754993928, 4596.632269418438, 4644.210484217691, 4664.696794708333, 4776.331313616097, 4781.330613714083, 5120.15517439622, 5158.174692049254, 5158.871028224287, 5213.687178769286, 5218.843434696965, 5126.410462796789, 5168.0, 5185.299984502081, 5185.403678576974, 5244.659097158673, 4670.486246512881, 4798.304245884327, 4831.323614693945, 4831.516848315211, 4894.216925291937, 5267.0, 5285.841424757264, 5329.1206950852675, 5346.331708536433, 5348.144296912553, 5103.617228707788, 5127.948720512822, 5133.076046311625, 5133.897322053538, 5135.768890399866, 4992.600591952635, 5066.746662666852, 5097.541221290027, 5141.922871156936, 5217.165253559412, 5086.313347698014, 5091.389033316026, 5097.1844504879045, 5097.566706829961, 5129.12804823181, 5077.466865979093, 5078.5937125029905, 5083.161278389024, 5088.592912566985, 5098.260752190986, 4163.437935878617, 4205.852795152155, 4252.447181866338, 4285.250081235771, 4359.106383191438, 3759.2293579816073, 3760.0599850037493, 3774.641409066134, 3805.2009078093356, 3817.0838998640684, 4409.426774519292, 4421.049474363027, 4422.071365013319, 4447.2439685253585, 4473.373727678128, 4967.677100988424, 5067.265246539231, 5074.543291103819, 5089.287499750038, 5163.0, 4370.541093185233, 4410.867673969786, 4452.977735111303, 4467.419235499365, 4470.977645111819, 4599.425071866017, 4609.055143695535, 4609.446866376056, 4619.260918253063, 4660.231061874752, 4718.929216061831, 4808.975955120272, 4844.128056949783, 4858.076965376567, 4884.535969082932, 5056.191009438472, 5075.771590278372, 5126.333576635014, 5126.641135120506, 5208.583313335, 4826.1795494766675, 4827.710337379768, 4834.178189707828, 4845.224764037737, 4861.829835955725, 5070.239464080418, 5074.517920797518, 5075.1625981712605, 5082.237664350377, 5124.026434977342, 4985.501449854985, 5083.059633967728, 5110.105731497048, 5127.0, 5146.279520867007, 5012.147934851011, 5014.7994080236385, 5019.824306149268, 5026.723530205728, 5038.924416133687, 5009.173486374853, 5019.272205530251, 5021.472745361684, 5026.472220416804, 5035.370578677665, 4807.4471435785335, 4836.153673107263, 4891.192953162688, 4891.682040667345, 4972.602191824718, 5029.119904016856, 5033.194688849767, 5037.697738135724, 5056.595472362275, 5096.770645321044, 4786.904261914812, 4834.114695268919, 4866.829660961849, 4896.094222568836, 4948.233023881304], "value": 4701.254669808276, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.3351794605449, 592.9377415371385, 594.8037147741243, 595.6247564034658, 605.724395400093, 27455.450890982167, 30076.84961575192, 40157.39763903544, 41130.794346028226, 41138.177236455325, 41568.37647435291, 42134.57865421345, 42138.578614213846, 42161.156776864445, 42186.36720449188, 7500.099988001421, 7695.5767432791035, 7867.095284042322, 7868.370530357586, 9972.800543989117, 9699.127078562928, 10103.59585616578, 10108.494575271245, 10118.089371956523, 10118.595256189743, 10103.191744660446, 10182.64360747374, 10194.541245643964, 10209.693709188736, 10216.387016779017, 7533.246675332451, 9841.655542055994, 10031.548580313867, 10135.341202821866, 10143.797124057552, 9922.3054386193, 10027.59889604415, 10043.447610381427, 10043.74890627733, 10056.094951454332, 38312.61687383118, 38660.613393865984, 38723.0, 38754.61245387538, 38793.41809872854, 2963.273997870514, 2973.0, 3030.6363236411553, 3039.027511196418, 3112.579801726783, 29492.0, 29679.406411871856, 29795.55306670402, 30056.24859378533, 30250.697493025007, 3223.580934478526, 3235.8867439639735, 3276.0499455157974, 3342.131045928052, 3343.6154842193214, 258366.0, 258866.70566647235, 258969.0, 259085.0, 259882.0, 32045.35909281848, 52496.0, 52541.0, 52814.20778688323, 52835.471645283826, 31441.0, 33575.66424335774, 33591.32817343639, 33596.32807343888, 33637.663623363944, 12100.394980250952, 12111.818322725167, 12148.87851121495, 12149.635510934686, 12165.817512737316, 9109.089091090838, 10262.281640285257, 10441.530131144116, 10458.0, 10697.572097116185, 7944.04671439431, 7962.840743185104, 7976.803479478125, 8054.275115239657, 8060.395470339748, 3118.8128712277335, 3127.56214130022, 3136.5922430083942, 3166.699163579456, 3173.4287828190686, 883.4964070479765, 892.9107089291149, 931.4597533430594, 1034.022848408247, 1058.1904842795268, 28640.713592863805, 28742.856285718437, 28746.712532874404, 28947.276318092216, 29160.270993224916, 957.4542510768935, 1014.4268488304084, 1036.0623635609786, 1103.4096758234307, 1112.9554817807198, 15006.849931500763, 15131.243437828065, 15360.308786104428, 15492.578674029808, 15513.844861551466, 394708.0, 398279.0, 399695.0, 401237.0, 402206.0, 48937.51062489401, 50223.497765022614, 50277.49722502801, 50384.24423633575, 50394.999999999265, 1094.9124070074374, 1183.1776915044134, 1197.7305106351175, 1225.6629426907493, 1232.6055662188014, 28227.57658635163, 28806.0, 29408.852955735085, 30072.69927300699, 30153.698463015087, 42237.36643950405, 42664.36003459888, 42771.0, 42886.57113428951, 42892.571074288855, 293721.0, 295165.0, 295353.0, 295814.0, 297013.0, 22213.22253721112, 22778.35546312648, 24501.632475512524, 25176.874115629304, 25297.62053569161, 41619.0, 41629.375559366024, 41840.0, 42586.0, 42702.78648606737, 35458.0, 36324.0, 36644.26711465809, 36780.81609592042, 37243.44134838034, 36264.45603316005, 36327.63672363242, 36796.448053278684, 36887.81556092203, 37200.81399592985, 35099.298014039065, 35648.64351356453, 36065.81967090148, 36482.8175859119, 36513.087172820895, 31691.20771980719, 32463.823115257124, 32600.673993260712, 32926.34147317088, 33049.33901322008, 25052.62421063649, 25158.24525264245, 25219.621705674796, 25242.350689547453, 25592.23223303304], "value": 16914.566702603366, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.18047775577475, 348.59737003760665, 356.8287222133376, 357.20521838908434, 380.49204312243154, 15527.0, 16279.59301017475, 16688.41590544331, 16697.74953375699, 16986.150692465373, 14675.0, 15118.622034449145, 15306.770398444005, 15491.767623485628, 15514.30185641646, 4765.28520721891, 5029.119904016782, 5191.766370513317, 5195.818146364859, 5196.168613021917, 3748.400255959047, 3917.7061720370943, 5142.151544995071, 5156.329677141966, 5640.407757185498, 5900.203472531196, 6001.0, 6023.939760602404, 6028.3067447243475, 6028.788992385267, 5816.302043754734, 5925.73334199962, 6001.069834175688, 6035.7887473938645, 6044.637321760686, 3375.9831200844083, 4816.951830481686, 5100.311457953203, 5109.923351149736, 5145.794168233266, 19308.32420865277, 20139.0, 20264.392068237976, 20267.29064482736, 20269.49326266855, 1983.1769815526538, 2031.2484380779058, 2086.739157605299, 2383.2492764779213, 2510.786583140435, 8858.202761751474, 9130.086991300817, 9578.90421095794, 11892.940535297355, 12627.810582841264, 1726.2922201897288, 1751.8160593137663, 1782.2069179215255, 1814.7640806695176, 1821.8906865588108, 66204.66897665529, 68487.65756171188, 69745.65127174383, 69816.0, 70191.0, 9907.702768916799, 9979.900200997898, 10028.197744180448, 10038.196944244442, 10147.64483243083, 13730.519431820037, 13823.51617693376, 13828.585142445743, 13841.723165536632, 13853.584392468241, 6907.516473846783, 6983.93016069843, 7004.054452648929, 7030.789076327718, 7137.750178743719, 6455.193100862392, 6523.608583485006, 6525.934740652628, 6657.7669781557415, 6686.699098540577, 4286.2284788738325, 4291.313389857608, 4321.978390108029, 4425.225585522585, 4433.889152771207, 1699.6345785656142, 1738.6957282475516, 1814.8088004448591, 1830.3326517380892, 1856.5265857206325, 863.9697610583725, 879.0813599788108, 898.5776684958059, 910.0080911806164, 954.7231302922214, 15755.369785208462, 16603.252853621616, 16623.667526649642, 16731.414400495923, 16856.66286674284, 834.7746108550657, 847.4788005376649, 850.4174640371366, 886.2821114896825, 925.0749250749251, 9194.77013074665, 9370.10983956523, 9470.95264523673, 9540.0, 9727.610895564098, 354799.0, 354900.0, 356963.0, 357488.0, 357819.0, 71212.0, 73926.0, 73940.26059739442, 74919.0, 75543.0, 874.5976850648773, 910.8132832769267, 913.6756451459769, 923.9491827949392, 926.7497775600685, 12969.481220751064, 14682.63293417673, 14748.926255368655, 15261.847381526042, 15850.60373490672, 33812.661873381934, 33827.51332202043, 34764.652353477155, 35081.64918350886, 35192.0, 45432.0, 47434.52565474439, 47438.28842567295, 47588.0, 47855.76072119756, 7492.100947886289, 7597.164311925573, 7608.31525162738, 7714.1128770192145, 7813.413993950363, 11298.0, 11968.222065565711, 11987.820182697093, 12169.574064907685, 12562.183458075197, 9640.807183856425, 10093.798124037625, 10247.282690211614, 10504.632337868137, 10779.89220107789, 10478.318909270873, 10682.359058456517, 10894.346339219355, 10929.016388525071, 11006.834897476385, 10472.790544189225, 10723.337882628206, 10882.12942964545, 10979.451027448436, 11220.326780393203, 7766.106897706836, 7810.297073263207, 7856.5678887661725, 7962.641681124247, 8110.553919534483, 7773.1060927994, 9210.263178945803, 10253.794924101625, 10749.408782516724, 10951.178661600252], "value": 8140.276988245286, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1252.6116903759842, 1329.6371219500013, 1399.2234309957973, 1517.5219805761185, 1762.91185440728, 6573.934260657398, 7355.963220183905, 7606.92393076069, 7613.961930190341, 7625.809354766134, 7404.96297518513, 7411.814704632387, 7424.517406368583, 7464.664090115944, 7479.850402991937, 1883.0, 2136.316378758798, 2194.4952660887966, 2202.7797220277926, 2219.6670499425136, 2213.3691897809126, 2271.59111359956, 2271.931842044733, 2273.7271527416733, 2276.1236923784295, 2184.5740080684272, 2196.2642514757495, 2198.857074290166, 2206.007296716484, 2224.5439684864564, 1810.9094545272683, 2049.405672355015, 2107.093949601671, 2144.292383513437, 2180.2151225558705, 2099.349201747463, 2154.3321570313096, 2155.665871789875, 2157.9784202157934, 2165.2638103044883, 7343.265673432614, 7386.298301661333, 7386.815329616748, 7401.444891633149, 7403.259674032607, 4374.518802931675, 4498.437695288089, 4505.189065968125, 4505.684602077856, 4505.7747112644565, 2850.900218492343, 2949.292169879235, 2960.0231923465203, 2972.5689774982507, 2988.4023195361015, 856.7686724584389, 857.4812238595684, 883.6686242659002, 889.6619284671848, 897.6499165325529, 10281.280310378277, 10531.473426328654, 10557.313774604627, 10567.947160264226, 10572.947135264352, 4091.427200191916, 4223.345381465878, 4251.766152861561, 4290.635295999812, 4292.82828686849, 9179.127982841619, 9212.401193922373, 9237.445753254826, 9246.4914429707, 9248.445093294424, 4481.596656300883, 4491.550844915548, 4492.213862574036, 4498.932516012263, 4500.707454015478, 3475.4265546184597, 3835.8465661373234, 3936.901577460529, 3941.0935484838074, 4078.3270760324212, 3601.3157500075426, 3621.348157331653, 3664.725145614036, 3696.094456858087, 3735.7758534488016, 1163.8894305041008, 1170.3738499902681, 1175.9235649682744, 1182.2788099259444, 1184.0527577937617, 831.3640065350012, 873.9825203495894, 903.3902116071625, 916.4592890194684, 926.2312280806914, 5258.8159414420315, 5384.515393614593, 5411.783528658888, 5497.917531237034, 5558.027345214652, 378.73867031748006, 389.2526349409141, 390.2000898158763, 391.0419472292894, 391.1063220541107, 3703.9814800925824, 3784.4890939723336, 3897.0841852164717, 3938.6258305460933, 3951.9012024699036, 8941.195292423714, 9558.474283914451, 9565.0, 9568.808623827623, 9586.66446674363, 9299.395539289924, 9455.479948602893, 9486.95256523713, 9497.715068547956, 9557.713268601952, 7163.6060016699585, 7298.854022919512, 7311.341979221896, 7311.670974806147, 7328.780136595804, 5339.9466005341, 5351.759170837244, 5482.457233742226, 5491.341039075177, 5519.586031047607, 8407.159284071544, 8473.152684731478, 8574.742757717278, 8791.120887911158, 8807.955960220157, 8841.867371989554, 8971.147740964598, 8976.551172441483, 8977.596008179517, 9075.410098343587, 5913.349531551612, 6123.203983482119, 6137.3862613738265, 6454.709538070704, 6555.2789193187755, 6849.48628852848, 6909.930900690929, 7056.0, 7299.5255308404785, 7319.597422141834, 6426.839329016812, 6452.9677351612945, 6491.448226900767, 6536.542442029203, 6539.0, 6614.669266536558, 6640.933590664032, 6651.966740166268, 6685.799426017227, 6725.125733654593, 6249.6562689052535, 6278.529110316653, 6310.842228944313, 6312.905306420315, 6313.43179113882, 4626.3523106764405, 4631.305304204397, 4637.327587499726, 4742.359781429463, 4779.784909679142, 4696.178168820375, 4727.858164255078, 4861.1979023460735, 4866.7079975201605, 4943.036107958914], "value": 4011.0995642572598, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.2475312705728, 300.6452386184303, 304.08773678963104, 305.89599536157715, 306.1977618639166, 4711.387519622449, 4724.126036683216, 4738.881527961803, 4770.451398089221, 4770.499097594746, 4647.674662773607, 4682.765861706918, 4685.50802165772, 4703.0, 4706.505816889228, 3525.576930768305, 3621.7102631789526, 3644.781313121221, 3736.364817980936, 3754.155315054118, 3692.280005398948, 3704.1850792825535, 3725.3853114236254, 3733.813309334536, 3737.588865224823, 3499.1602015516346, 3696.5009723687226, 3703.2778608171416, 3709.9072523186865, 3738.476613274144, 3568.982155089221, 3691.575468821093, 3699.4265888787013, 3699.741018128732, 3708.6476784705546, 3271.656476070002, 3288.52316414121, 3299.835008249578, 3300.2574420755136, 3302.719268862126, 4519.502854685982, 4524.140413321458, 4527.479339875924, 4527.796249168762, 4547.8635640930825, 3994.681755020836, 4204.024108668921, 4231.386448964914, 4244.533101358848, 4288.935665965013, 4894.853154405374, 4921.483244259372, 4930.827421040282, 4934.950650493485, 4939.481354457766, 3599.1464395836165, 3626.4379021251484, 3657.1771351445977, 3665.981670091659, 3674.393725035366, 5025.748712564357, 5158.896822063538, 5161.1742121260795, 5178.922316165261, 5188.377394712621, 3757.1734218471893, 3761.5674197467642, 3773.2453509298252, 3776.244751049801, 3786.545614526219, 3791.7724936503896, 3805.980970095132, 3806.657400833883, 3821.3885778275344, 3824.732268741217, 4213.894652633709, 4223.915521689549, 4246.8725938221905, 4247.341662042389, 4258.9139769359235, 4705.411823522059, 4910.729909854992, 4933.260010998379, 4958.479359667255, 4967.205247160509, 1298.6169080121388, 1306.431702209542, 1309.18830325199, 1309.9324050898488, 1312.3700623700677, 849.4054162086564, 852.4331319672349, 889.4974339498162, 915.9985431831469, 918.5958178401482, 4274.995376086617, 4335.848245311399, 4339.609435150852, 4365.410669559632, 4367.344898265285, 5032.899342013213, 5044.117279476077, 5066.518680725325, 5069.493050694901, 5070.61970352225, 4189.853355132555, 4322.0491491871735, 4351.782410879443, 4359.80380882861, 4360.585744354281, 2648.4173481833964, 2661.321363052409, 2673.345030467509, 2673.46530693862, 2674.9732502675115, 4680.297955306732, 4701.130290896195, 4724.740139292372, 4727.976360118178, 4737.763111844394, 4919.852404427873, 5046.571041461517, 5088.821891233789, 5112.284280200774, 5159.716215608178, 4750.287456881495, 4765.547273009059, 4772.570468657837, 4776.2119250324, 4776.808927642855, 4985.900281994267, 5040.34475518195, 5047.545720885138, 5056.64603477753, 5056.646034777677, 4782.713037217639, 4935.876603084952, 4946.554810067111, 4948.950510494849, 5081.560850791715, 4853.466118726867, 4890.828820991248, 4891.87770305731, 4898.167311556973, 4898.363212782316, 3632.3643362410944, 3635.636436356343, 3637.799526156309, 3647.3799454092336, 3649.835757390977, 4951.702897826142, 5020.7991680333835, 5096.490350964874, 5162.97418512905, 5165.92251116226, 4937.160682683881, 4972.477889821661, 4984.0843106781485, 5008.595873980437, 5013.523715247045, 4993.126202914403, 4999.750012499288, 5002.474740152232, 5013.498650134958, 5016.899662006813, 4775.283707443911, 4897.4857639947295, 4912.649021519111, 4912.778924948458, 4916.483769204182, 4773.427188737373, 4878.219484882544, 5001.549860512571, 5041.1430056889685, 5042.647014708935, 4799.9760001199775, 4822.397200349957, 4876.366072410564, 4898.093852637274, 4916.237983112624], "value": 3750.794948145824, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [620.1194304088194, 631.9715612797427, 652.3150691773639, 671.8320419895026, 753.9711949405865, 11566.768664626703, 12419.56531521397, 12632.936835315833, 12946.546870859522, 12948.999999999989, 12592.370381480912, 12667.429965651545, 12710.0, 12728.0, 12744.681382965407, 634.0742515926753, 769.084789100968, 797.6011994002998, 811.663159788687, 813.662330132994, 798.7284323330067, 812.8130529978108, 813.1908750792969, 813.2314962360572, 813.3574476163824, 845.378646694682, 850.5364576305897, 851.5912362066211, 851.7359618518249, 852.0159216105408, 657.4937298280345, 814.1654803826126, 835.6532039203784, 839.5802098950525, 839.7564706235185, 617.0743884173739, 617.5337620096798, 618.0512912679061, 618.1253526260336, 618.6010023534794, 11013.559457621686, 11078.667639970814, 11117.388543630097, 11129.666110016713, 11241.887581124165, 12292.0, 12619.936900315439, 12797.808032879515, 13031.674208144777, 13308.73382532344, 11146.275492092987, 11247.044001259903, 11257.0, 11264.887351126548, 11475.13936454761, 4113.945999504583, 4149.128682976579, 4156.355764856452, 4200.0, 4249.575042495757, 57221.0, 58592.0, 58723.70638146825, 58825.7058714708, 58954.41045589575, 9706.272029597809, 9717.6598819041, 9864.753381165385, 10040.397576145455, 10419.479026048668, 19201.423957281302, 19204.423867284004, 19208.519787005156, 19240.615187696447, 19254.903725481283, 6624.668766561653, 6668.133142691419, 6922.411595014481, 6926.134233220848, 6927.826804329932, 3649.2154186849953, 3687.649673281034, 3729.2914346274665, 3825.387937929918, 3870.53553573573, 2963.303623648441, 3080.5995220621626, 3083.4758091124563, 3085.1361618746787, 3086.0, 497.9751012449363, 516.5273774496369, 517.1415450352472, 569.0780934885429, 608.2518502242267, 435.8583460375327, 525.865904194428, 550.6338285040404, 593.6349145275624, 642.996785016072, 8361.163883611713, 8694.260987816106, 8783.604737786814, 8876.423032502867, 8920.598573064228, 479.8176692856692, 562.5668235458755, 574.4513989140361, 650.3593959949541, 654.653033892038, 4070.592940705965, 4074.8573799916862, 4147.834086636501, 4241.745495270294, 4309.267424537836, 84220.57889710512, 85178.72231916526, 90096.0, 92153.53923230476, 92262.07737922668, 51182.23226651603, 58194.70902645544, 67626.323736762, 76571.23428765753, 76957.23042769612, 67524.0, 68240.65879670669, 68702.31297687058, 69198.65400672964, 69243.0, 8157.55133467665, 8271.669133234604, 8330.375221858507, 8345.248927596545, 8367.832643347221, 42846.78576607097, 43703.0, 44511.77744111259, 44771.31372117683, 45395.319070213314, 58220.4177958215, 59989.0, 61640.38359616346, 62415.68792156192, 62626.06060908999, 9697.563609637724, 10118.342307749972, 10387.844182337421, 10461.476926153815, 10618.787624247627, 10341.896581034094, 10641.89358106409, 10675.145988321072, 12019.819702704292, 13379.130356526795, 10046.179055563714, 10162.085412312927, 10372.222083343628, 10586.788264234518, 11203.0, 11279.661610151708, 11699.181057325906, 11903.40482975865, 11988.340641264815, 11996.340201289013, 11665.475053622438, 11682.824757628812, 11850.585229516926, 12341.93829030885, 12420.192687475284, 9478.146966773023, 9714.562844671866, 9740.951295243478, 10011.149052330633, 10027.398356098365, 9775.951120244354, 10063.540959899155, 10113.848292275474, 10166.169154228855, 10334.483275836328], "value": 6473.337045081626, "unit": "score"}], "name": "dromaeo_css", "value": 6308.794593966411, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 109.0, 113.0, 112.0, 111.0, 111.0, 112.0, 112.0, 114.0, 114.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 130.0, 137.0, 188.0, 131.0, 164.0, 172.0, 131.0, 195.0, 132.0], "value": 154.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 163.0, 161.0, 160.0, 160.0, 161.0, 161.0, 161.0, 159.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 119.0, 77.0, 76.0, 74.0, 74.0, 97.0, 75.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 122.0, 85.0, 86.0, 86.0, 124.0, 86.0, 85.0, 127.0], "value": 97.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 116.0, 117.0, 120.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 149.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 96.0, 95.0, 94.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 63.0, 65.0, 64.0, 64.0, 63.0, 63.0, 64.0], "value": 63.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0, 67.0, 65.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 83.0, 82.0, 84.0, 84.0, 83.0, 84.0, 118.0, 84.0], "value": 86.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 129.0, 130.0, 130.0, 130.0, 129.0, 130.0, 132.0, 134.0, 143.0], "value": 132.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 173.0, 168.0, 168.0, 166.0, 168.0, 168.0, 167.0, 165.0, 167.0], "value": 167.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 67.0, 66.0, 68.0, 67.0, 66.0, 72.0, 69.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1549.4, "alertThreshold": 2.0}]} 07:17:30 INFO - Return code: 0 07:17:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:17:30 ERROR - # TBPL SUCCESS # 07:17:30 INFO - Running post-action listener: _resource_record_post_action 07:17:30 INFO - ##### 07:17:30 INFO - ##### Finished run-tests step (success) 07:17:30 INFO - ##### 07:17:30 INFO - Running post-run listener: _resource_record_post_run 07:17:30 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 7675904; Write bytes: 416980992; Read time: 1236; Write time: 266852 07:17:30 INFO - TinderboxPrint: CPU usage
13.1% 07:17:30 INFO - TinderboxPrint: I/O read bytes / time
7,675,904 / 1,236 07:17:30 INFO - TinderboxPrint: I/O write bytes / time
416,980,992 / 266,852 07:17:30 INFO - TinderboxPrint: CPU idle
8,351.9 (86.9%) 07:17:30 INFO - TinderboxPrint: CPU user
1,211.0 (12.6%) 07:17:30 INFO - TinderboxPrint: Swap in / out
0 / 0 07:17:30 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 84824064; Read time: 0; Write time: 63884 07:17:30 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 5914624; Write bytes: 332156928; Read time: 1172; Write time: 202968 07:17:31 INFO - Running post-run listener: _upload_blobber_files 07:17:31 INFO - Blob upload gear active. 07:17:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:17:31 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:17:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:17:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:17:31 INFO - (blobuploader) - INFO - Open directory for files ... 07:17:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:17:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:17:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:17:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:17:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:17:32 INFO - (blobuploader) - INFO - Done attempting. 07:17:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:17:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:17:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:17:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:17:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:17:40 INFO - (blobuploader) - INFO - Done attempting. 07:17:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:17:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:17:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:17:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:17:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:17:41 INFO - (blobuploader) - INFO - Done attempting. 07:17:41 INFO - (blobuploader) - INFO - Iteration through files over. 07:17:41 INFO - Return code: 0 07:17:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:17:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:17:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2cd3884c46a702c2243eb4eb770125a29a58925d93788e46989112f93018abad976f25decbd89ac716dca8f00714b40b2ef498a83d2122e9373ff459beba1690", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e38889013038651b0959702bcc67f1c20f066bccafba88c682a17deecc62257f7db1db42d2dc52a2dc9903f95eee5690c49c3cd8a1a005dc4ad3076ef844323e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e18b06bf6e9385623ca658984540a9e3014411796771ea42b1d875c94d1257eca73a1e430c871a339b69379a8025f6ffc45bdb20fae588762149049fd70b549d"} 07:17:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:17:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:17:41 INFO - Contents: 07:17:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2cd3884c46a702c2243eb4eb770125a29a58925d93788e46989112f93018abad976f25decbd89ac716dca8f00714b40b2ef498a83d2122e9373ff459beba1690", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e38889013038651b0959702bcc67f1c20f066bccafba88c682a17deecc62257f7db1db42d2dc52a2dc9903f95eee5690c49c3cd8a1a005dc4ad3076ef844323e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e18b06bf6e9385623ca658984540a9e3014411796771ea42b1d875c94d1257eca73a1e430c871a339b69379a8025f6ffc45bdb20fae588762149049fd70b549d"} 07:17:41 INFO - Running post-run listener: copy_logs_to_upload_dir 07:17:41 INFO - Copying logs to upload dir... 07:17:41 INFO - mkdir: /builds/slave/test/build/upload/logs 07:17:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.490510 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-06-03 07:17:41.426500) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 07:17:41.429923) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=cbe409c6de289db6ac707de3000001d4-1464958590.5005-1771471860 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/2cd3884c46a702c2243eb4eb770125a29a58925d93788e46989112f93018abad976f25decbd89ac716dca8f00714b40b2ef498a83d2122e9373ff459beba1690", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e38889013038651b0959702bcc67f1c20f066bccafba88c682a17deecc62257f7db1db42d2dc52a2dc9903f95eee5690c49c3cd8a1a005dc4ad3076ef844323e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e18b06bf6e9385623ca658984540a9e3014411796771ea42b1d875c94d1257eca73a1e430c871a339b69379a8025f6ffc45bdb20fae588762149049fd70b549d"} build_url:https://queue.taskcluster.net/v1/task/UrvNGEweR2Wh8oN2JV773g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011127 build_url: 'https://queue.taskcluster.net/v1/task/UrvNGEweR2Wh8oN2JV773g/artifacts/public/build/firefox-49.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/2cd3884c46a702c2243eb4eb770125a29a58925d93788e46989112f93018abad976f25decbd89ac716dca8f00714b40b2ef498a83d2122e9373ff459beba1690", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e38889013038651b0959702bcc67f1c20f066bccafba88c682a17deecc62257f7db1db42d2dc52a2dc9903f95eee5690c49c3cd8a1a005dc4ad3076ef844323e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e18b06bf6e9385623ca658984540a9e3014411796771ea42b1d875c94d1257eca73a1e430c871a339b69379a8025f6ffc45bdb20fae588762149049fd70b549d"}' ========= master_lag: 0.05 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 07:17:41.493694) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 07:17:41.494016) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=cbe409c6de289db6ac707de3000001d4-1464958590.5005-1771471860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004382 ========= master_lag: 0.10 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 07:17:41.601038) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 07:17:41.601424) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 07:17:41.601812) ========= ========= Total master_lag: 0.24 =========