builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-022 starttime: 1464061052.89 results: success (0) buildid: 20160523193703 builduid: f8fadc9d25bb43b29e1d138089a15f18 revision: 9e938575c485151e55c05dd7a1f824bdd8c64837 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 20:37:32.886948) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 20:37:32.887445) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 20:37:32.887743) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 20:37:32.900586) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 20:37:32.900875) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1464061052.390683-10520656 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-23 20:37:33-- 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% 46.4M=0s 2016-05-23 20:37:33 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096686 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 20:37:33.008529) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 20:37:33.008842) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1464061052.390683-10520656 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019866 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 20:37:33.058386) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 20:37:33.058753) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9e938575c485151e55c05dd7a1f824bdd8c64837 --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 9e938575c485151e55c05dd7a1f824bdd8c64837 --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=9c43b49b387003dc8f5b4e5c000001c4-1464061052.390683-10520656 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-23 20:37:33,389 truncating revision to first 12 chars 2016-05-23 20:37:33,389 Setting DEBUG logging. 2016-05-23 20:37:33,389 attempt 1/10 2016-05-23 20:37:33,389 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9e938575c485?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-23 20:37:34,087 unpacking tar archive at: fx-team-9e938575c485/testing/mozharness/ program finished with exit code 0 elapsedTime=0.971547 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 20:37:34.043271) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 20:37:34.043612) ========= script_repo_revision: 9e938575c485151e55c05dd7a1f824bdd8c64837 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 20:37:34.044020) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 20:37:34.044311) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 20:37:34.056188) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-23 20:37:34.056476) ========= /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=9c43b49b387003dc8f5b4e5c000001c4-1464061052.390683-10520656 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:37:34 INFO - MultiFileLogger online at 20160523 20:37:34 in /builds/slave/test 20:37: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 20:37:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:37:34 INFO - {'append_to_log': False, 20:37:34 INFO - 'base_work_dir': '/builds/slave/test', 20:37:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 20:37:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:37:34 INFO - 'branch': 'Fx-Team-Non-PGO', 20:37:34 INFO - 'buildbot_json_path': 'buildprops.json', 20:37:34 INFO - 'config_files': ('talos/linux_config.py',), 20:37:34 INFO - 'default_actions': ('clobber', 20:37:34 INFO - 'read-buildbot-config', 20:37:34 INFO - 'download-and-extract', 20:37:34 INFO - 'populate-webroot', 20:37:34 INFO - 'create-virtualenv', 20:37:34 INFO - 'install', 20:37:34 INFO - 'run-tests'), 20:37:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:37:34 INFO - 'download_minidump_stackwalk': True, 20:37:34 INFO - 'download_symbols': 'ondemand', 20:37:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:37:34 INFO - 'tooltool.py': '/tools/tooltool.py', 20:37:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:37:34 INFO - '/tools/misc-python/virtualenv.py')}, 20:37:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:37:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:37:34 INFO - 'installer_path': 'installer.exe', 20:37:34 INFO - 'log_level': 'info', 20:37:34 INFO - 'log_name': 'talos', 20:37:34 INFO - 'log_to_console': True, 20:37:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:37:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:37:34 INFO - 'opt_config_files': (), 20:37:34 INFO - 'pip_index': False, 20:37:34 INFO - 'sps_profile': False, 20:37:34 INFO - 'sps_profile_interval': 0, 20:37:34 INFO - 'suite': 'dromaeojs', 20:37:34 INFO - 'system_bits': '32', 20:37:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:37:34 INFO - 'title': 'talos-linux64-ix-022', 20:37:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:37:34 INFO - 'use_talos_json': True, 20:37:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:37:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:37:34 INFO - 'work_dir': 'build'} 20:37:34 INFO - ##### 20:37:34 INFO - ##### Running clobber step. 20:37:34 INFO - ##### 20:37:34 INFO - Running pre-action listener: _resource_record_pre_action 20:37:34 INFO - Running main action method: clobber 20:37:34 INFO - rmtree: /builds/slave/test/build 20:37:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:37:35 INFO - Running post-action listener: _resource_record_post_action 20:37:35 INFO - ##### 20:37:35 INFO - ##### Finished clobber step (success) 20:37:35 INFO - ##### 20:37:35 INFO - ##### 20:37:35 INFO - ##### Running read-buildbot-config step. 20:37:35 INFO - ##### 20:37:35 INFO - Running pre-action listener: _resource_record_pre_action 20:37:35 INFO - Running main action method: read_buildbot_config 20:37:35 INFO - Using buildbot properties: 20:37:35 INFO - { 20:37:35 INFO - "project": "", 20:37:35 INFO - "product": "firefox", 20:37:35 INFO - "script_repo_revision": "production", 20:37:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:37:35 INFO - "repository": "", 20:37:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 20:37:35 INFO - "buildid": "20160523193703", 20:37:35 INFO - "pgo_build": "False", 20:37:35 INFO - "basedir": "/builds/slave/test", 20:37:35 INFO - "buildnumber": 1768, 20:37:35 INFO - "slavename": "talos-linux64-ix-022", 20:37:35 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:37:35 INFO - "platform": "ubuntu64_hw", 20:37:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 20:37:35 INFO - "branch": "fx-team", 20:37:35 INFO - "repo_path": "integration/fx-team", 20:37:35 INFO - "revision": "9e938575c485151e55c05dd7a1f824bdd8c64837", 20:37:35 INFO - "stage_platform": "linux64", 20:37:35 INFO - "builduid": "f8fadc9d25bb43b29e1d138089a15f18", 20:37:35 INFO - "slavebuilddir": "test" 20:37:35 INFO - } 20:37:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/a5gN3mZZTtaXx46ZpYm64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 20:37:35 INFO - Running post-action listener: _resource_record_post_action 20:37:35 INFO - ##### 20:37:35 INFO - ##### Finished read-buildbot-config step (success) 20:37:35 INFO - ##### 20:37:35 INFO - ##### 20:37:35 INFO - ##### Running download-and-extract step. 20:37:35 INFO - ##### 20:37:35 INFO - Running pre-action listener: _resource_record_pre_action 20:37:35 INFO - Running main action method: download_and_extract 20:37:35 INFO - mkdir: /builds/slave/test/build/tests 20:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:37:35 INFO - https://queue.taskcluster.net/v1/task/a5gN3mZZTtaXx46ZpYm64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:37:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5gN3mZZTtaXx46ZpYm64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:37:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5gN3mZZTtaXx46ZpYm64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:37:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5gN3mZZTtaXx46ZpYm64w/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 20:37:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5gN3mZZTtaXx46ZpYm64w/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 20:37:36 INFO - Downloaded 1361 bytes. 20:37:36 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:37:36 INFO - Using the following test package requirements: 20:37:36 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:37:36 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:37:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:37:36 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:37:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:37:36 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:37:36 INFO - u'jsshell-linux-x86_64.zip'], 20:37:36 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:37:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:37:36 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:37:36 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:37:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:37:36 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:37:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:37:36 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:37:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:37:36 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:37:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:37:36 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:37:36 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')]} 20:37:36 INFO - https://queue.taskcluster.net/v1/task/a5gN3mZZTtaXx46ZpYm64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:37:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5gN3mZZTtaXx46ZpYm64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:37:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5gN3mZZTtaXx46ZpYm64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:37:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5gN3mZZTtaXx46ZpYm64w/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 20:37:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5gN3mZZTtaXx46ZpYm64w/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 20:37:37 INFO - Downloaded 22814444 bytes. 20:37:37 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'] 20:37:37 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 20:37:38 INFO - Return code: 0 20:37:38 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 20:37:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:37:38 INFO - https://queue.taskcluster.net/v1/task/a5gN3mZZTtaXx46ZpYm64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:37:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5gN3mZZTtaXx46ZpYm64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:37:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5gN3mZZTtaXx46ZpYm64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:37:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5gN3mZZTtaXx46ZpYm64w/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 20:37:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5gN3mZZTtaXx46ZpYm64w/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 20:37:39 INFO - Downloaded 22814444 bytes. 20:37:39 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'] 20:37:39 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 20:37:40 INFO - Return code: 0 20:37: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')]} 20:37:40 INFO - https://queue.taskcluster.net/v1/task/a5gN3mZZTtaXx46ZpYm64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:37:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5gN3mZZTtaXx46ZpYm64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:37:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5gN3mZZTtaXx46ZpYm64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:37:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5gN3mZZTtaXx46ZpYm64w/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 20:37:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5gN3mZZTtaXx46ZpYm64w/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 20:37:41 INFO - Downloaded 10840359 bytes. 20:37:41 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'] 20:37:41 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 20:37:42 INFO - Return code: 0 20:37: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')]} 20:37:42 INFO - https://queue.taskcluster.net/v1/task/a5gN3mZZTtaXx46ZpYm64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:37:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5gN3mZZTtaXx46ZpYm64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:37:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5gN3mZZTtaXx46ZpYm64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:37:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5gN3mZZTtaXx46ZpYm64w/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 20:37:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5gN3mZZTtaXx46ZpYm64w/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 20:37:43 INFO - Downloaded 54813681 bytes. 20:37:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a5gN3mZZTtaXx46ZpYm64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:37:43 INFO - mkdir: /builds/slave/test/properties 20:37:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:37:43 INFO - Writing to file /builds/slave/test/properties/build_url 20:37:43 INFO - Contents: 20:37:43 INFO - build_url:https://queue.taskcluster.net/v1/task/a5gN3mZZTtaXx46ZpYm64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:37:44 INFO - Running post-action listener: _resource_record_post_action 20:37:44 INFO - Running post-action listener: set_extra_try_arguments 20:37:44 INFO - ##### 20:37:44 INFO - ##### Finished download-and-extract step (success) 20:37:44 INFO - ##### 20:37:44 INFO - ##### 20:37:44 INFO - ##### Running populate-webroot step. 20:37:44 INFO - ##### 20:37:44 INFO - Running pre-action listener: _resource_record_pre_action 20:37:44 INFO - Running main action method: populate_webroot 20:37:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:37:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:37:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:37:44 INFO - '--tppagecycles', 20:37:44 INFO - '7'], 20:37:44 INFO - 'tests': ['tsvgm']}}, 20:37:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:37:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:37:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:37:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:37:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:37:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:37:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:37:44 INFO - 'talos_options': ['--disable-e10s'], 20:37:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:37:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:37:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:37:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:37:44 INFO - 'talos_options': ['--disable-e10s'], 20:37:44 INFO - 'tests': ['damp', 'tps']}, 20:37:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:37:44 INFO - 'tests': ['damp', 'tps']}, 20:37:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:37:44 INFO - 'tests': ['dromaeo_dom']}, 20:37:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:37:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:37:44 INFO - 'tests': ['a11yr', 20:37:44 INFO - 'ts_paint', 20:37:44 INFO - 'tpaint', 20:37:44 INFO - 'sessionrestore', 20:37:44 INFO - 'sessionrestore_no_auto_restore', 20:37:44 INFO - 'tabpaint']}, 20:37:44 INFO - 'other-e10s': {'tests': ['a11yr', 20:37:44 INFO - 'ts_paint', 20:37:44 INFO - 'tpaint', 20:37:44 INFO - 'sessionrestore', 20:37:44 INFO - 'sessionrestore_no_auto_restore', 20:37:44 INFO - 'tabpaint']}, 20:37:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:37:44 INFO - 'ts_paint', 20:37:44 INFO - 'tpaint', 20:37:44 INFO - 'sessionrestore', 20:37:44 INFO - 'sessionrestore_no_auto_restore', 20:37:44 INFO - 'tabpaint']}, 20:37:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:37:44 INFO - 'ts_paint', 20:37:44 INFO - 'tpaint', 20:37:44 INFO - 'sessionrestore', 20:37:44 INFO - 'sessionrestore_no_auto_restore', 20:37:44 INFO - 'tabpaint']}, 20:37:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:37:44 INFO - 'tests': ['a11yr', 20:37:44 INFO - 'ts_paint', 20:37:44 INFO - 'tpaint', 20:37:44 INFO - 'sessionrestore', 20:37:44 INFO - 'sessionrestore_no_auto_restore', 20:37:44 INFO - 'tabpaint']}, 20:37:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:37:44 INFO - 'tests': ['a11yr', 20:37:44 INFO - 'ts_paint', 20:37:44 INFO - 'tpaint', 20:37:44 INFO - 'sessionrestore', 20:37:44 INFO - 'sessionrestore_no_auto_restore', 20:37:44 INFO - 'tabpaint']}, 20:37:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:37:44 INFO - 'tests': ['tsvgx', 20:37:44 INFO - 'tsvgr_opacity', 20:37:44 INFO - 'tart', 20:37:44 INFO - 'tscrollx', 20:37:44 INFO - 'cart']}, 20:37:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:37:44 INFO - 'tsvgr_opacity', 20:37:44 INFO - 'tart', 20:37:44 INFO - 'tscrollx', 20:37:44 INFO - 'cart']}, 20:37:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:37:44 INFO - 'talos_options': ['--disable-e10s'], 20:37:44 INFO - 'tests': ['tp5o']}, 20:37:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:37:44 INFO - 'tests': ['tp5o']}, 20:37:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:37:44 INFO - 'talos_options': ['--disable-e10s', 20:37:44 INFO - '--xperf_path', 20:37:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:37:44 INFO - 'tests': ['tp5n']}, 20:37:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:37:44 INFO - 'talos_options': ['--xperf_path', 20:37:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:37:44 INFO - 'tests': ['tp5n']}}, 20:37:44 INFO - 'talos.zip': {'path': '', 20:37:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:37:44 INFO - Running post-action listener: _resource_record_post_action 20:37:44 INFO - ##### 20:37:44 INFO - ##### Finished populate-webroot step (success) 20:37:44 INFO - ##### 20:37:44 INFO - ##### 20:37:44 INFO - ##### Running create-virtualenv step. 20:37:44 INFO - ##### 20:37:44 INFO - Running pre-action listener: _resource_record_pre_action 20:37:44 INFO - Running main action method: create_virtualenv 20:37:44 INFO - Creating virtualenv /builds/slave/test/build/venv 20:37:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:37:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:37:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:37:44 INFO - Using real prefix '/usr' 20:37:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:37:44 INFO - Installing distribute.............................................................................................................................................................................................done. 20:37:46 INFO - Installing pip.................done. 20:37:46 INFO - Return code: 0 20:37:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:37:46 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')]} 20:37:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:37:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37:46 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')]} 20:37:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:37:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37:46 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 0x7f01f40b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a978e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b26b20>, '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 0x2b27a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27eb0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1464061052.390683-10520656', '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 20:37:46 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 20:37:46 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 20:37:46 INFO - Using env: {'DISPLAY': ':0', 20:37:46 INFO - 'HOME': '/home/cltbld', 20:37:46 INFO - 'LANG': 'en_US.UTF-8', 20:37:46 INFO - 'LANGUAGE': 'en_US:en', 20:37:46 INFO - 'LOGNAME': 'cltbld', 20:37:46 INFO - 'MAIL': '/var/mail/cltbld', 20:37:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:37:46 INFO - 'MOZ_NO_REMOTE': '1', 20:37:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:37:46 INFO - 'NO_EM_RESTART': '1', 20:37:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:37:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:37:46 INFO - 'PWD': '/builds/slave/test', 20:37:46 INFO - 'SHELL': '/bin/bash', 20:37:46 INFO - 'SHLVL': '1', 20:37:46 INFO - 'TERM': 'linux', 20:37:46 INFO - 'TMOUT': '86400', 20:37:46 INFO - 'USER': 'cltbld', 20:37:46 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464061052.390683-10520656', 20:37:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:37:46 INFO - '_': '/tools/buildbot/bin/python'} 20:37:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:37:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 20:37:47 INFO - Cleaning up... 20:37:47 INFO - Return code: 0 20:37:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:37:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:37:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:37:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:37:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f01f40b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a978e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b26b20>, '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 0x2b27a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27eb0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1464061052.390683-10520656', '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 20:37:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:37:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:37:47 INFO - Using env: {'DISPLAY': ':0', 20:37:47 INFO - 'HOME': '/home/cltbld', 20:37:47 INFO - 'LANG': 'en_US.UTF-8', 20:37:47 INFO - 'LANGUAGE': 'en_US:en', 20:37:47 INFO - 'LOGNAME': 'cltbld', 20:37:47 INFO - 'MAIL': '/var/mail/cltbld', 20:37:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:37:47 INFO - 'MOZ_NO_REMOTE': '1', 20:37:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:37:47 INFO - 'NO_EM_RESTART': '1', 20:37:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:37:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:37:47 INFO - 'PWD': '/builds/slave/test', 20:37:47 INFO - 'SHELL': '/bin/bash', 20:37:47 INFO - 'SHLVL': '1', 20:37:47 INFO - 'TERM': 'linux', 20:37:47 INFO - 'TMOUT': '86400', 20:37:47 INFO - 'USER': 'cltbld', 20:37:47 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464061052.390683-10520656', 20:37:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:37:47 INFO - '_': '/tools/buildbot/bin/python'} 20:37:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:37:47 INFO - Downloading/unpacking psutil>=3.1.1 20:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:37:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:37:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:37:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:37:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:37:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:37:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:37:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:37:49 INFO - Installing collected packages: psutil 20:37:49 INFO - Running setup.py install for psutil 20:37:49 INFO - building 'psutil._psutil_linux' extension 20:37:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 20:37:49 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 20:37:49 INFO - building 'psutil._psutil_posix' extension 20:37:49 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 20:37:49 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 20:37:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:37:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:37:49 INFO - Successfully installed psutil 20:37:49 INFO - Cleaning up... 20:37:49 INFO - Return code: 0 20:37:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:37: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')]} 20:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:37:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37: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')]} 20:37:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:37:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37:49 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 0x7f01f40b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a978e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b26b20>, '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 0x2b27a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27eb0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1464061052.390683-10520656', '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 20:37:49 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 20:37:49 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 20:37:49 INFO - Using env: {'DISPLAY': ':0', 20:37:49 INFO - 'HOME': '/home/cltbld', 20:37:49 INFO - 'LANG': 'en_US.UTF-8', 20:37:49 INFO - 'LANGUAGE': 'en_US:en', 20:37:49 INFO - 'LOGNAME': 'cltbld', 20:37:49 INFO - 'MAIL': '/var/mail/cltbld', 20:37:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:37:49 INFO - 'MOZ_NO_REMOTE': '1', 20:37:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:37:49 INFO - 'NO_EM_RESTART': '1', 20:37:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:37:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:37:49 INFO - 'PWD': '/builds/slave/test', 20:37:49 INFO - 'SHELL': '/bin/bash', 20:37:49 INFO - 'SHLVL': '1', 20:37:49 INFO - 'TERM': 'linux', 20:37:49 INFO - 'TMOUT': '86400', 20:37:49 INFO - 'USER': 'cltbld', 20:37:49 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464061052.390683-10520656', 20:37:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:37:49 INFO - '_': '/tools/buildbot/bin/python'} 20:37:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:37:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:37:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:37:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:37:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:37:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:37:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:37:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:37:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:37:51 INFO - Installing collected packages: mozsystemmonitor 20:37:51 INFO - Running setup.py install for mozsystemmonitor 20:37:52 INFO - Successfully installed mozsystemmonitor 20:37:52 INFO - Cleaning up... 20:37:52 INFO - Return code: 0 20:37:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:37:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:37:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:37:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:37:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f01f40b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a978e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b26b20>, '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 0x2b27a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27eb0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1464061052.390683-10520656', '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 20:37:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:37:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:37:52 INFO - Using env: {'DISPLAY': ':0', 20:37:52 INFO - 'HOME': '/home/cltbld', 20:37:52 INFO - 'LANG': 'en_US.UTF-8', 20:37:52 INFO - 'LANGUAGE': 'en_US:en', 20:37:52 INFO - 'LOGNAME': 'cltbld', 20:37:52 INFO - 'MAIL': '/var/mail/cltbld', 20:37:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:37:52 INFO - 'MOZ_NO_REMOTE': '1', 20:37:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:37:52 INFO - 'NO_EM_RESTART': '1', 20:37:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:37:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:37:52 INFO - 'PWD': '/builds/slave/test', 20:37:52 INFO - 'SHELL': '/bin/bash', 20:37:52 INFO - 'SHLVL': '1', 20:37:52 INFO - 'TERM': 'linux', 20:37:52 INFO - 'TMOUT': '86400', 20:37:52 INFO - 'USER': 'cltbld', 20:37:52 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464061052.390683-10520656', 20:37:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:37:52 INFO - '_': '/tools/buildbot/bin/python'} 20:37:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:37:52 INFO - Downloading/unpacking blobuploader==1.2.4 20:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:37:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:37:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:37:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:37:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:37:54 INFO - Downloading blobuploader-1.2.4.tar.gz 20:37:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:37:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:37:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:37:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:37:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:37:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:37:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:37:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:37:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:37:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:37:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:37:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:37:54 INFO - Downloading docopt-0.6.1.tar.gz 20:37:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:37:54 INFO - Installing collected packages: blobuploader, requests, docopt 20:37:54 INFO - Running setup.py install for blobuploader 20:37:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:37:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:37:55 INFO - Running setup.py install for requests 20:37:55 INFO - Running setup.py install for docopt 20:37:55 INFO - Successfully installed blobuploader requests docopt 20:37:55 INFO - Cleaning up... 20:37:55 INFO - Return code: 0 20:37:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:37:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:37:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:37:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37:55 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 0x7f01f40b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a978e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b26b20>, '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 0x2b27a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27eb0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1464061052.390683-10520656', '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 20:37:55 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 20:37:55 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 20:37:55 INFO - Using env: {'DISPLAY': ':0', 20:37:55 INFO - 'HOME': '/home/cltbld', 20:37:55 INFO - 'LANG': 'en_US.UTF-8', 20:37:55 INFO - 'LANGUAGE': 'en_US:en', 20:37:55 INFO - 'LOGNAME': 'cltbld', 20:37:55 INFO - 'MAIL': '/var/mail/cltbld', 20:37:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:37:55 INFO - 'MOZ_NO_REMOTE': '1', 20:37:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:37:55 INFO - 'NO_EM_RESTART': '1', 20:37:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:37:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:37:55 INFO - 'PWD': '/builds/slave/test', 20:37:55 INFO - 'SHELL': '/bin/bash', 20:37:55 INFO - 'SHLVL': '1', 20:37:55 INFO - 'TERM': 'linux', 20:37:55 INFO - 'TMOUT': '86400', 20:37:55 INFO - 'USER': 'cltbld', 20:37:55 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464061052.390683-10520656', 20:37:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:37:55 INFO - '_': '/tools/buildbot/bin/python'} 20:37:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:37:55 INFO - Running setup.py (path:/tmp/pip-papdON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:37:55 INFO - Running setup.py (path:/tmp/pip-a4jIm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:37:55 INFO - Running setup.py (path:/tmp/pip-fnDAQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:37:55 INFO - Running setup.py (path:/tmp/pip-n5ay3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:37:56 INFO - Running setup.py (path:/tmp/pip-UUoQUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:37:56 INFO - Running setup.py (path:/tmp/pip-sBGlom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:37:56 INFO - Running setup.py (path:/tmp/pip-p8UW9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:37:56 INFO - Running setup.py (path:/tmp/pip-w8P44u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:37:56 INFO - Running setup.py (path:/tmp/pip-E4IgST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:37:56 INFO - Running setup.py (path:/tmp/pip-gROlZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:37:56 INFO - Running setup.py (path:/tmp/pip-PBD5FV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:37:56 INFO - Running setup.py (path:/tmp/pip-Cr5r7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:37:56 INFO - Running setup.py (path:/tmp/pip-a_mpUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:37:56 INFO - Running setup.py (path:/tmp/pip-VNQTp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:37:56 INFO - Running setup.py (path:/tmp/pip-GM3jNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:37:56 INFO - Running setup.py (path:/tmp/pip-usg5On-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:37:56 INFO - Running setup.py (path:/tmp/pip-As_Vtq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:37:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:37:57 INFO - Running setup.py install for manifestparser 20:37:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:37:57 INFO - Running setup.py install for mozcrash 20:37:57 INFO - Running setup.py install for mozdebug 20:37:57 INFO - Running setup.py install for mozdevice 20:37:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:37:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:37:57 INFO - Running setup.py install for mozfile 20:37:57 INFO - Running setup.py install for mozhttpd 20:37:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:37:57 INFO - Running setup.py install for mozinfo 20:37:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:37:57 INFO - Running setup.py install for mozInstall 20:37:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:37:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:37:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:37:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:37:57 INFO - Running setup.py install for mozleak 20:37:57 INFO - Running setup.py install for mozlog 20:37:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:37:58 INFO - Running setup.py install for moznetwork 20:37:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:37:58 INFO - Running setup.py install for mozprocess 20:37:58 INFO - Running setup.py install for mozprofile 20:37:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:37:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:37:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:37:58 INFO - Running setup.py install for mozrunner 20:37:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:37:58 INFO - Running setup.py install for mozscreenshot 20:37:58 INFO - Running setup.py install for moztest 20:37:58 INFO - Running setup.py install for mozversion 20:37:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:37:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:37:58 INFO - Cleaning up... 20:37:58 INFO - Return code: 0 20:37:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:37:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:37:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:37:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:37:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:37:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37:58 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 0x7f01f40b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a978e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b26b20>, '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 0x2b27a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27eb0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1464061052.390683-10520656', '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 20:37:58 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 20:37:58 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 20:37:58 INFO - Using env: {'DISPLAY': ':0', 20:37:58 INFO - 'HOME': '/home/cltbld', 20:37:58 INFO - 'LANG': 'en_US.UTF-8', 20:37:58 INFO - 'LANGUAGE': 'en_US:en', 20:37:58 INFO - 'LOGNAME': 'cltbld', 20:37:58 INFO - 'MAIL': '/var/mail/cltbld', 20:37:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:37:58 INFO - 'MOZ_NO_REMOTE': '1', 20:37:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:37:58 INFO - 'NO_EM_RESTART': '1', 20:37:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:37:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:37:58 INFO - 'PWD': '/builds/slave/test', 20:37:58 INFO - 'SHELL': '/bin/bash', 20:37:58 INFO - 'SHLVL': '1', 20:37:58 INFO - 'TERM': 'linux', 20:37:58 INFO - 'TMOUT': '86400', 20:37:58 INFO - 'USER': 'cltbld', 20:37:58 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464061052.390683-10520656', 20:37:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:37:58 INFO - '_': '/tools/buildbot/bin/python'} 20:37:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:37:59 INFO - Running setup.py (path:/tmp/pip-8PTrPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:37:59 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)) 20:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:37:59 INFO - Running setup.py (path:/tmp/pip-2MOILG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:37:59 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)) 20:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:37:59 INFO - Running setup.py (path:/tmp/pip-sFGDKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:37:59 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)) 20:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:37:59 INFO - Running setup.py (path:/tmp/pip-b7VFYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:37:59 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)) 20:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:37:59 INFO - Running setup.py (path:/tmp/pip-wHnlOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:37:59 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)) 20:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:37:59 INFO - Running setup.py (path:/tmp/pip-ixHEZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:37:59 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)) 20:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:37:59 INFO - Running setup.py (path:/tmp/pip-GJH1S0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:37:59 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)) 20:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:37:59 INFO - Running setup.py (path:/tmp/pip-6Wpa5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:37:59 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)) 20:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:37:59 INFO - Running setup.py (path:/tmp/pip-xovNnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:37:59 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)) 20:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:37:59 INFO - Running setup.py (path:/tmp/pip-hja2OE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:37:59 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)) 20:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:37:59 INFO - Running setup.py (path:/tmp/pip-HMP5k_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:37:59 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)) 20:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:37:59 INFO - Running setup.py (path:/tmp/pip-4BeNd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:37:59 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)) 20:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:37:59 INFO - Running setup.py (path:/tmp/pip-9GLpri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:37:59 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)) 20:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:37:59 INFO - Running setup.py (path:/tmp/pip-aLi3TO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:38:00 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)) 20:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:38:00 INFO - Running setup.py (path:/tmp/pip-QB0BNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:38:00 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)) 20:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:38:00 INFO - Running setup.py (path:/tmp/pip-Arh9j2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:38:00 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)) 20:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:38:00 INFO - Running setup.py (path:/tmp/pip-1cx4y4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:38:00 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)) 20:38:00 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)) 20:38:00 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)) 20:38:00 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)) 20:38:00 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)) 20:38:00 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)) 20:38:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:38: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 20:38: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 20:38: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 20:38: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 20:38: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 20:38: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 20:38:02 INFO - Downloading blessings-1.6.tar.gz 20:38:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:38:02 INFO - Installing collected packages: blessings 20:38:02 INFO - Running setup.py install for blessings 20:38:02 INFO - Successfully installed blessings 20:38:02 INFO - Cleaning up... 20:38:02 INFO - Return code: 0 20:38:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:38:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:38:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:38:02 INFO - Reading from file tmpfile_stdout 20:38:02 INFO - Current package versions: 20:38:02 INFO - argparse == 1.2.1 20:38:02 INFO - blessings == 1.6 20:38:02 INFO - blobuploader == 1.2.4 20:38:02 INFO - docopt == 0.6.1 20:38:02 INFO - manifestparser == 1.1 20:38:02 INFO - mozInstall == 1.12 20:38:02 INFO - mozcrash == 0.17 20:38:02 INFO - mozdebug == 0.1 20:38:02 INFO - mozdevice == 0.48 20:38:02 INFO - mozfile == 1.2 20:38:02 INFO - mozhttpd == 0.7 20:38:02 INFO - mozinfo == 0.9 20:38:02 INFO - mozleak == 0.1 20:38:02 INFO - mozlog == 3.2 20:38:02 INFO - moznetwork == 0.27 20:38:02 INFO - mozprocess == 0.22 20:38:02 INFO - mozprofile == 0.28 20:38:02 INFO - mozrunner == 6.11 20:38:02 INFO - mozscreenshot == 0.1 20:38:02 INFO - mozsystemmonitor == 0.3 20:38:02 INFO - moztest == 0.7 20:38:02 INFO - mozversion == 1.4 20:38:02 INFO - psutil == 3.1.1 20:38:02 INFO - requests == 1.2.3 20:38:02 INFO - wsgiref == 0.1.2 20:38:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:38:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:38:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:38:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:38:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:38:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:38:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:38:02 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 0x7f01f40b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a978e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b26b20>, '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 0x2b27a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27eb0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1464061052.390683-10520656', '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 20:38:02 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 20:38:02 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 20:38:02 INFO - Using env: {'DISPLAY': ':0', 20:38:02 INFO - 'HOME': '/home/cltbld', 20:38:02 INFO - 'LANG': 'en_US.UTF-8', 20:38:02 INFO - 'LANGUAGE': 'en_US:en', 20:38:02 INFO - 'LOGNAME': 'cltbld', 20:38:02 INFO - 'MAIL': '/var/mail/cltbld', 20:38:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:38:02 INFO - 'MOZ_NO_REMOTE': '1', 20:38:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:38:02 INFO - 'NO_EM_RESTART': '1', 20:38:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:38:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:38:02 INFO - 'PWD': '/builds/slave/test', 20:38:02 INFO - 'SHELL': '/bin/bash', 20:38:02 INFO - 'SHLVL': '1', 20:38:02 INFO - 'TERM': 'linux', 20:38:02 INFO - 'TMOUT': '86400', 20:38:02 INFO - 'USER': 'cltbld', 20:38:02 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464061052.390683-10520656', 20:38:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:38:02 INFO - '_': '/tools/buildbot/bin/python'} 20:38:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:38:02 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)) 20:38:02 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)) 20:38:02 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)) 20:38:02 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)) 20:38:02 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)) 20:38:02 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)) 20:38:02 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)) 20:38:02 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)) 20:38:02 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)) 20:38:02 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)) 20:38:02 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)) 20:38:02 INFO - Cleaning up... 20:38:02 INFO - Return code: 0 20:38:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:38:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:38:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:38:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:38:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:38:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:38:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:38:02 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 0x7f01f40b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a978e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b26b20>, '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 0x2b27a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27eb0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1464061052.390683-10520656', '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 20:38:02 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 20:38:02 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 20:38:02 INFO - Using env: {'DISPLAY': ':0', 20:38:02 INFO - 'HOME': '/home/cltbld', 20:38:02 INFO - 'LANG': 'en_US.UTF-8', 20:38:02 INFO - 'LANGUAGE': 'en_US:en', 20:38:02 INFO - 'LOGNAME': 'cltbld', 20:38:02 INFO - 'MAIL': '/var/mail/cltbld', 20:38:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:38:02 INFO - 'MOZ_NO_REMOTE': '1', 20:38:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:38:02 INFO - 'NO_EM_RESTART': '1', 20:38:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:38:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:38:02 INFO - 'PWD': '/builds/slave/test', 20:38:02 INFO - 'SHELL': '/bin/bash', 20:38:02 INFO - 'SHLVL': '1', 20:38:02 INFO - 'TERM': 'linux', 20:38:02 INFO - 'TMOUT': '86400', 20:38:02 INFO - 'USER': 'cltbld', 20:38:02 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464061052.390683-10520656', 20:38:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:38:02 INFO - '_': '/tools/buildbot/bin/python'} 20:38:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:38:03 INFO - Downloading/unpacking jsonschema 20:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:38:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:38:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:38:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:38:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:38:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:38:04 INFO - Downloading/unpacking functools32 (from jsonschema) 20:38: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 20:38: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 20:38: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 20:38: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 20:38: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 20:38: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 20:38:05 INFO - Downloading functools32-3.2.3-2.tar.gz 20:38:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:38:05 INFO - warning: no files found matching '*.txt' 20:38:05 INFO - no previously-included directories found matching 'build' 20:38:05 INFO - no previously-included directories found matching 'dist' 20:38:05 INFO - no previously-included directories found matching '.git*' 20:38:05 INFO - Installing collected packages: jsonschema, functools32 20:38:05 INFO - Running setup.py install for functools32 20:38:05 INFO - warning: no files found matching '*.txt' 20:38:05 INFO - no previously-included directories found matching 'build' 20:38:05 INFO - no previously-included directories found matching 'dist' 20:38:05 INFO - no previously-included directories found matching '.git*' 20:38:05 INFO - Successfully installed jsonschema functools32 20:38:05 INFO - Cleaning up... 20:38:05 INFO - Return code: 0 20:38:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:38:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:38:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:38:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:38:05 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 0x7f01f40b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a978e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b26b20>, '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 0x2b27a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27eb0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1464061052.390683-10520656', '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 20:38:05 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 20:38:05 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 20:38:05 INFO - Using env: {'DISPLAY': ':0', 20:38:05 INFO - 'HOME': '/home/cltbld', 20:38:05 INFO - 'LANG': 'en_US.UTF-8', 20:38:05 INFO - 'LANGUAGE': 'en_US:en', 20:38:05 INFO - 'LOGNAME': 'cltbld', 20:38:05 INFO - 'MAIL': '/var/mail/cltbld', 20:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:38:05 INFO - 'MOZ_NO_REMOTE': '1', 20:38:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:38:05 INFO - 'NO_EM_RESTART': '1', 20:38:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:38:05 INFO - 'PWD': '/builds/slave/test', 20:38:05 INFO - 'SHELL': '/bin/bash', 20:38:05 INFO - 'SHLVL': '1', 20:38:05 INFO - 'TERM': 'linux', 20:38:05 INFO - 'TMOUT': '86400', 20:38:05 INFO - 'USER': 'cltbld', 20:38:05 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464061052.390683-10520656', 20:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:38:05 INFO - '_': '/tools/buildbot/bin/python'} 20:38:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:38:05 INFO - Downloading/unpacking flake8 20:38:05 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 20:38:05 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 20:38:05 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 20:38:05 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 20:38:05 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 20:38:05 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 20:38:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:38:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:38:07 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 20:38:07 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 20:38:07 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 20:38:07 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 20:38:07 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 20:38:07 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 20:38:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:38:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:38:07 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 20:38:07 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 20:38:07 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 20:38:07 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 20:38:07 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 20:38:07 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 20:38:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:38:07 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 20:38:07 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 20:38:07 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 20:38:07 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 20:38:07 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 20:38:07 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 20:38:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:38:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:38:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:38:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:38:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:38:08 INFO - no previously-included directories found matching 'docs/_build' 20:38:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:38:08 INFO - Running setup.py install for pep8 20:38:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:38:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:38:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:38:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:38:08 INFO - no previously-included directories found matching 'docs/_build' 20:38:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:38:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:38:08 INFO - Cleaning up... 20:38:08 INFO - Return code: 0 20:38:08 INFO - Running post-action listener: _resource_record_post_action 20:38:08 INFO - Running post-action listener: _start_resource_monitoring 20:38:08 INFO - Starting resource monitoring. 20:38:08 INFO - ##### 20:38:08 INFO - ##### Finished create-virtualenv step (success) 20:38:08 INFO - ##### 20:38:08 INFO - ##### 20:38:08 INFO - ##### Running install step. 20:38:08 INFO - ##### 20:38:08 INFO - Running pre-action listener: _resource_record_pre_action 20:38:08 INFO - Running main action method: install 20:38:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:38:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:38:08 INFO - Reading from file tmpfile_stdout 20:38:08 INFO - Detecting whether we're running mozinstall >=1.0... 20:38:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:38:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:38:08 INFO - Reading from file tmpfile_stdout 20:38:08 INFO - Output received: 20:38:08 INFO - Usage: mozinstall [options] installer 20:38:08 INFO - Options: 20:38:08 INFO - -h, --help show this help message and exit 20:38:08 INFO - -d DEST, --destination=DEST 20:38:08 INFO - Directory to install application into. [default: 20:38:08 INFO - "/builds/slave/test"] 20:38:08 INFO - --app=APP Application being installed. [default: firefox] 20:38:08 INFO - mkdir: /builds/slave/test/build/application 20:38:08 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'] 20:38:08 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 20:38:24 INFO - Reading from file tmpfile_stdout 20:38:24 INFO - Output received: 20:38:24 INFO - /builds/slave/test/build/application/firefox/firefox 20:38:24 INFO - Running post-action listener: _resource_record_post_action 20:38:24 INFO - ##### 20:38:24 INFO - ##### Finished install step (success) 20:38:24 INFO - ##### 20:38:24 INFO - ##### 20:38:24 INFO - ##### Running run-tests step. 20:38:24 INFO - ##### 20:38:24 INFO - Running pre-action listener: _resource_record_pre_action 20:38:24 INFO - Running main action method: run_tests 20:38:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:38:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:38:24 INFO - Python 2.7.3 20:38:24 INFO - Return code: 0 20:38:24 INFO - grabbing minidump binary from tooltool 20:38:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:38:24 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 0x2b26b20>, '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 0x2b27a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27eb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:38:24 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 20:38:24 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 20:38:24 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 20:38:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:38:24 INFO - Return code: 0 20:38:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:38:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:38:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:38:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:38:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:38:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:38:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:38:25 INFO - Return code: 0 20:38:25 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/a5gN3mZZTtaXx46ZpYm64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 20:38:25 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/a5gN3mZZTtaXx46ZpYm64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 20:38:25 INFO - Using env: {'DISPLAY': ':0', 20:38:25 INFO - 'HOME': '/home/cltbld', 20:38:25 INFO - 'LANG': 'en_US.UTF-8', 20:38:25 INFO - 'LANGUAGE': 'en_US:en', 20:38:25 INFO - 'LOGNAME': 'cltbld', 20:38:25 INFO - 'MAIL': '/var/mail/cltbld', 20:38:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:38:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:38:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:38:25 INFO - 'MOZ_NO_REMOTE': '1', 20:38:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:38:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:38:25 INFO - 'NO_EM_RESTART': '1', 20:38:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:38:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:38:25 INFO - 'PWD': '/builds/slave/test', 20:38:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:38:25 INFO - 'SHELL': '/bin/bash', 20:38:25 INFO - 'SHLVL': '1', 20:38:25 INFO - 'TERM': 'linux', 20:38:25 INFO - 'TMOUT': '86400', 20:38:25 INFO - 'USER': 'cltbld', 20:38:25 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464061052.390683-10520656', 20:38:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:38:25 INFO - '_': '/tools/buildbot/bin/python'} 20:38:25 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/a5gN3mZZTtaXx46ZpYm64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 20:38:25 INFO - mozversion application_buildid: 20160523193703 20:38:25 INFO - mozversion application_changeset: 9e938575c485151e55c05dd7a1f824bdd8c64837 20:38:25 INFO - mozversion application_display_name: Nightly 20:38:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:38:25 INFO - mozversion application_name: Firefox 20:38:25 INFO - mozversion application_remotingname: firefox 20:38:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 20:38:25 INFO - mozversion application_vendor: Mozilla 20:38:25 INFO - mozversion application_version: 49.0a1 20:38:25 INFO - mozversion platform_buildid: 20160523193703 20:38:25 INFO - mozversion platform_changeset: 9e938575c485151e55c05dd7a1f824bdd8c64837 20:38:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 20:38:25 INFO - mozversion platform_version: 49.0a1 20:38:25 INFO - using testdate: 1464061105 20:38:25 INFO - actual date: 1464061105 20:38:25 INFO - starting webserver on 'localhost:36914' 20:38:25 INFO - SUITE-START | Running 2 tests 20:38:25 INFO - TEST-START | dromaeo_css 20:38:25 INFO - operating with platform_type : linux_ 20:38:25 INFO - Initialising browser for dromaeo_css test... 20:38:25 INFO - TEST-INFO | started process 15059 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQpwj05/profile http://localhost:36914/getInfo.html) 20:38:30 INFO - PROCESS | 15059 | __metrics Screen width/height:1600/1200 20:38:30 INFO - PROCESS | 15059 | colorDepth:24 20:38:30 INFO - PROCESS | 15059 | Browser inner width/height: 1024/697 20:38:30 INFO - PROCESS | 15059 | __metrics 20:38:31 ERROR - PROCESS | 15059 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:38:32 INFO - TEST-INFO | 15059: exit 0 20:38:32 INFO - Browser initialized. 20:38:32 INFO - Running cycle 1/1 for dromaeo_css test... 20:38:32 INFO - TEST-INFO | started process 15140 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQpwj05/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:38:44 INFO - PROCESS | 15140 | RSS: Main: 154943488 20:38:44 INFO - PROCESS | 15140 | 20:39:34 INFO - PROCESS | 15140 | 1464061174856 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] 20:41:47 INFO - PROCESS | 15140 | Cycle 1(1): loaded http://localhost:36914/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36914/tests/dromaeo/cssquery-ext.html) 20:41:48 INFO - PROCESS | 15140 | RSS: Main: 233357312 20:41:48 INFO - PROCESS | 15140 | 20:44:50 INFO - PROCESS | 15140 | Cycle 1(1): loaded http://localhost:36914/tests/dromaeo/cssquery-ext.html (next: http://localhost:36914/tests/dromaeo/cssquery-jquery.html) 20:44:51 INFO - PROCESS | 15140 | RSS: Main: 236564480 20:44:51 INFO - PROCESS | 15140 | 20:47:53 INFO - PROCESS | 15140 | Cycle 1(1): loaded http://localhost:36914/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36914/tests/dromaeo/cssquery-mootools.html) 20:47:54 INFO - PROCESS | 15140 | RSS: Main: 234639360 20:47:54 INFO - PROCESS | 15140 | 20:50:56 INFO - PROCESS | 15140 | Cycle 1(1): loaded http://localhost:36914/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36914/tests/dromaeo/cssquery-prototype.html) 20:50:57 INFO - PROCESS | 15140 | RSS: Main: 233476096 20:50:57 INFO - PROCESS | 15140 | 20:53:59 INFO - PROCESS | 15140 | Cycle 1(1): loaded http://localhost:36914/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36914/tests/dromaeo/cssquery-yui.html) 20:54:00 INFO - PROCESS | 15140 | RSS: Main: 215347200 20:54:00 INFO - PROCESS | 15140 | 20:57:03 INFO - PROCESS | 15140 | Cycle 1(1): loaded http://localhost:36914/tests/dromaeo/cssquery-yui.html (next: http://localhost:36914/tests/dromaeo/cssquery-dojo.html) 20:57:03 INFO - PROCESS | 15140 | RSS: Main: 271597568 20:57:03 INFO - PROCESS | 15140 | 20:57:03 INFO - PROCESS | 15140 | __start_tp_report 20:57:03 INFO - PROCESS | 15140 | _x_x_mozilla_page_load 20:57:03 INFO - PROCESS | 15140 | _x_x_mozilla_page_load_details 20:57:03 INFO - PROCESS | 15140 | |i|pagename|runs| 20:57:03 INFO - PROCESS | 15140 | |0;dojo.html;2654.256808093734;2674.237842214969;2708.4041510867614;2714.877830497628;2722.550779121445;4633.582977532022;4670.649701272406;4699.506551812062;4744.264638980955;4755.928661070082;4684.578387945085;4688.554587314208;4721.38621979143;4781.043791241748;4803.687760295578;4292.012837047481;4343.4787825460835;4361.5856493633055;4374.825006999717;4566.315052742082;4497.932531012021;4514.887127821798;4515.593596576307;4548.226801443762;4575.748333841638;4324.200022995725;4364.061726728737;4373.147236288941;4382.583654552845;4397.032652816375;4378.584034516748;4378.978105109486;4381.978090109561;4469.173202957463;4477.440319960005;4407.735535867858;4408.228560002019;4408.559144085598;4414.4923333816705;4448.93326600098;4529.433820772403;4655.557722016403;4657.813687452498;4730.148573256813;4759.928601070987;5079.085764562377;5136.717480538568;5144.356955380577;5145;5152.227165925104;5113.284140220372;5153.5361817436615;5162.767675454614;5181.533661970403;5185.118529849935;4625.953740462553;4708;4760.09558183944;4767.380240568704;4822.975885120587;5195.116830138885;5214.921776173361;5274.235235890775;5274.5780337572905;5275.076861549213;4997.275395067695;5008.323876276656;5040.092783299041;5046.621503387188;5048.368953880765;4955.653104282737;5005.62457815658;5070.645054846199;5075.365579302587;5096.745162741848;5009.824656137018;5035.899282014339;5038.496150384932;5043.646944713835;5092.312537807348;4901.534354236342;4993.101241776515;5022.397312322545;5025.974870125626;5035.244713292962;4231.936520952188;4280.143971205771;4285.18581469526;4285.700000999963;4291.141771645684;3750.043738846631;3760.135168911111;3762.6613604775152;3763.7365384423374;3788.791616461066;4346.022145017346;4391.363252328394;4444.577765112309;4444.755538445416;4485.147821913891;5063.620228482879;5137.537621614073;5138.743062846917;5143.5113664201845;5147.639665223398;4420.425344705168;4421.292593185075;4422.3366495026;4445.799939002753;4452.332150177499;4471.463424389094;4516.661250406232;4595.195840727926;4599.195140850338;4634.351190833286;4809.95190048109;4826.517348265145;4846.079244943449;4850.320955066364;4901.460839307602;5076.7207803571155;5094.719790411563;5094.898102038012;5098.260752190838;5147.459516750687;4660.673752837269;4822.035592881508;4822.95177048225;4887;4891.119598472309;5053.974730126326;5071.264666623245;5081.949180508148;5096.490350965022;5142.434332223377;5117.411497677815;5151.253068305;5159.613029022913;5160.277561141518;5167.58659307262;4817.927731083966;4852.927206091841;4915.754212289443;4923.335349727884;4997.5002499749735;4884.7069175849565;4900.803967841389;4911.386076740408;4927.531884470969;4956.72737999399;4805.399325084364;4847.200211964986;4855.077535268288;4897.8285759998225;4899.069176856386;4878.5853202476765;4884.12085824555;4956.231784073474;4956.430010548833;4967.428745694291;4855.174620314626;4866.683665561727;4867.367242258484;4876.171050921423;4919.311296418433 20:57:03 INFO - PROCESS | 15140 | |1;ext.html;560.2800401484094;586.3550094895614;593.2643522032678;594.4946795224063;603.1495591216386;27831.304217394576;40393.59606403939;41603.79198104013;41908.58091419089;45601.087978240415;42641;42829.35755963663;42951.14097718044;43196.13607727844;43275.56724432763;7690.769276921687;7835.49069310493;7849.097353804328;7854.960725196394;7857.6856925722905;7631.046119235096;7689.730859419893;7718.035245594301;7745.031871016123;7749;7735.574543400111;7749.961250193769;7762.9611851940945;7763.611819409035;7764.456488045839;7733.1880152583735;7765.922340776633;7793.415493837928;7794.142644309121;7798.610069496503;7656.923430765677;7704.499207551491;7728.613569321511;7746.9225307746765;7751.922480775176;38444.03889902775;38686.22627547461;38905;38942.610573894184;38979.41530877039;3088.1044497095813;3238.9838050809594;3349.0455220262106;3452.499387588811;3484.4250698634696;29997.400051998837;30317.848410757804;30494.847525762452;30757.38485230283;31440;3505.6503246250377;3545.556805399325;3550.9347195841146;3564.9643503564894;3608.657177568127;259497;260374;260967;261304;261482;38868.80565597154;55144.172837407474;55202.44797551973;55470.16794748082;55525.16712249319;58620.41379586235;60660.393396066356;60922.39077609256;66207.33792662108;66275.66862165659;12390.876091239152;12478.313692746804;12494.125411221308;12494.875051249554;12521.686957826127;8009.839803203903;8717.259032982267;8877.201051905231;9615.759606009766;9665.468399237969;17754.644907102043;17840.732389014174;17902.373416930346;17932.9103354485;18012.279508819764;6454.4186674264165;6499.1876015498065;6597.581519973229;6689.297623749436;6721.529492935545;886.1802832380023;891.4294851295176;922.1838672774643;991.4646091110864;1033.7415646088477;27128.186154415398;28143.155705328874;28621.57067643987;29123.56314655282;29237.707622923925;998.3311181508261;998.6804222648828;1002.5388321372104;1033.1682995188944;1048.5962904281753;14753.77869331961;15375.308111135026;15375.615609609626;16105.67788644244;16329.510114696579;183280;183361.08319458316;185565;185608;357112;50499.74750126226;50698;50774.23838642424;50805.23792143121;50845.23732144021;1122.4836575175511;1229.4836168809122;1241.025794751134;1243.160866415166;1274.0699289518518;28356.291092722848;29188.416231675674;29207.269818253862;29257.268568285963;29883.55174672425;42133.36799947942;42660;42669;42758.144837103704;42794.14411711811;273732;282258;282530;282602;283475;22150.446238844157;24481.75518244795;25050.24849254525;25369.365765856;27227.183184504498;41464.3780343289;41989.79005105077;42132.78933605312;42231.366529501465;42393;35825.82087089548;35833.46249806307;35991.10022249465;36245.81877090703;36786.26427471382;36099;36231;36663;36816.44775328426;36836.631633684396;35351.469727954616;35467.64532354747;35884.461733073505;36393.818030910734;36544.45183322199;30172.698273016988;33372;33646.32707345888;33660;33726.49410258897;25219.495610088063;25463.490730185662;25662.486750265263;25758.613620796077;25944.351391215372 20:57:03 INFO - PROCESS | 15140 | |2;jquery.html;365.4244564810424;369.5879094809288;377.6261501113898;378.30958500736165;382.2412511165335;15993.680126397465;17325.480235592935;17446.3021479141;17833.91083044586;17886;15780.21098945054;16666.99998000121;17564.209610567523;17566.560835979108;17592;5005.899882002358;5141.614378921578;5156.407013193474;5177;5189.948100519003;3592.263585964884;3811.3520701480675;5629.155626655994;5941.435563621449;5958.40415958405;5926.674032928187;5955.493783028448;5964.910526342108;5977.402259774031;5996.010658241385;5757.942420575803;5815.069588865804;5892.263467066617;6014.939850601481;6018.307894592134;3325.933481330384;4944.159492886218;5264.052470555299;5271.28837606922;5349.812756553541;19594;19947.800521994886;19987.300444484372;20048.89975550113;20282.797172028237;2003.7996200379991;2090.780468050863;2101.7162683037745;2216.0027987405733;2536.8351057181226;6151.200343955257;6158.7228574714245;12709.936450317782;12975.156614820007;13277.747266463666;1678.0770576183052;1702;1752.7809023872016;1770.3538208553784;1784.4022252545412;66682.66658666676;68443;69024.6548767253;69147.65426172888;71045.64477177632;8449.32405407566;8979.775505612412;9074.637014519345;9259.861102083474;9501.334906556613;11745.29528228309;11786.94106529479;11807;11850.881491184979;11875.228110172811;6256.7810126645345;6393.488520918316;6479.708413121421;6514.120593719787;6626.271110177877;6212.409821066992;6219.657918814509;6285.622862628257;6296.968515157487;6311.305756366796;3826.6364695354455;3827.61723827615;3857.0550215196895;3909.6285852843935;3924.823382947774;1687.8143404225525;1722.879398442097;1829.428601191516;1873.597176607036;1882.7740671119554;822.9341652667772;825.1789469477787;876.0494863073509;945.669015844449;949.3686698345523;16440.588985275463;16589.91705041467;16643.167841607872;16652.666946661;17201.7419738704;837.4431003382682;847.4195176304252;866.540733411293;886.9911300887038;936.5317341329335;9365.71902842902;9468.668596599086;9548.236141108695;9717.708468745808;9823.803523929624;294486;300863;301318;391850;402370;75501.62249188719;79646.20353796388;81803;82633.58683206546;82984.58507707423;923.2798417234568;926.9768255793659;943.9716808495756;955.7037318431309;960.6205548808182;15454.459093931659;15489.5353139406;15637.374505019672;15764.448244311394;16048.679026419173;33702.32595348128;34580.308393832485;35603.287934241685;35900.10249743777;36932.630673693995;42689.14621707611;44171.337429939216;45080.77459612681;46615.30077048779;46825.89283482183;7034.2965703429245;7212.170600380813;7350.595717235603;7662.195469475848;7747.1090824555895;8343.45767525109;9636.855447168438;10341.586336546454;10508.684739457829;10688.465576721288;8917.242034427147;9098.954505227432;9106.908930910606;9193.816123677623;9415.717528474157;9119.270458363448;9278.536073196177;9282.257419406566;9310;9593.904060959301;4899.16714158601;5519.917201242065;8971.551422428984;9374.343795934219;9404.764880878032;6866.793996180123;7124.323189297009;7167.426605871414;7193.136823581203;7259.564426134449;8149.8370032600205;8870.64517419296;9117.954410227907;9131.817363652557;9553.808923821345 20:57:03 INFO - PROCESS | 15140 | |3;mootools.html;1273.3633183408297;1376.1536654957201;1427.3790900958081;1519.620094976256;1787.3654852527345;6602.240742314635;7472.813179670511;7703.46075774696;7744.148143704188;7949.642266098025;7700.6919723211;7855.4893931894385;7862.01724784402;7864.449488535804;7882.172371900954;1866.5240363707235;2117.597656445278;2141.1435425829713;2148.892555372233;2212.048819007826;2222.8777417242045;2245.618244898363;2251.0995601759264;2251.527179292342;2253.211376018397;2165.404513758713;2211.9889400552975;2221.7111775469166;2223.8999245033933;2224.243757122578;1825.8082901295438;2114;2173.9021744021397;2178.6296329624;2181.7818218178213;2180.0407820558903;2189.9562008759735;2192.5395666909967;2211.1266049910355;2212.126210146983;7940.364770818378;7979.880301795478;7993.120756716757;7997.880031799527;8005.839883202361;4364.170807546556;4512.526184750587;4516.254817955033;4516.299973504112;4519.502854685982;2966.480865848468;2975.4346674131843;3011.051518771602;3076.8000079994727;3106.192389978622;932.2961164320894;939.8355287824671;951.3435729346797;964.7057647417535;964.71058682395;11063.557457701681;11095.389753563551;11098.55605775768;11101.111911047097;11134.053605443547;4099.159672267178;4223.683223758169;4323.978380108079;4328.783560822009;4334.4798624165305;9394.154526092685;9460.716178514656;9460.905390946002;9468.621255149854;9473.28950328728;4496.280595104833;4496.460424748986;4497.9325310120375;4498.302763071729;4500.234960056799;3395.3379091077004;3946.210757848442;4075.735077219971;4076.3274059780397;4129.483814523184;3504.2465869837597;3573.428251479803;3594.227241143167;3627.4558816177782;3643.544556930384;1195.910306726999;1221.3160630047203;1223.5900973174087;1224.2348532167396;1228.3121451986915;667.4026746062248;803.8271771569141;824.8391563645032;835.6532039203784;851.5784686580182;4888.584470320063;5001.274815151783;5047.2429135629945;5067.315912351785;5167;411.1612310885819;413.08707755859285;420.3274760383423;422.3812115251172;427.31629392970996;3394.5926488821005;3425.246445781924;3445.0870519312402;3508.1054331145906;3539.699125574355;9498.430094194371;9876.555555000043;9914.851277230848;9919.40483570988;9925.3548519346;9763.121319081316;9807.215422766161;9820.950895245622;9828.705138845846;9840.11438970496;6904.275051119661;7198.352148306678;7204.0994875640545;7401.8149546261775;7464.589447580435;5354.946450535601;5410.377806552139;5428.83713488596;5429.565634749131;5558.610897237317;8767.21095101444;8841.734747957571;8936.955315223382;8944.284457243275;8952.776180595538;8514;8886.4668119913;8889.822203556021;8948.955255223942;9215.49314787693;5884.911726324023;6474.223093228843;6644;6680.565763225375;6784.3894049535775;7659.770206893802;7695.769126926201;7727.574983375744;7778.88331675014;7791.298783109547;6763.797086087426;6893.345132212432;6904.758333458305;6940.444764418935;7067.151941767021;6874.621895795779;6886.173659160932;6903;6996.405305549085;7033.437325013884;5899.705014749159;5939.940600593939;5957.523398128226;5967.850803729768;6208.875822483435;4334.609885110355;4365.039691267916;4372.540883207344;4399.538048504861;4444.200043991983;4170.958290417057;4233.322668373045;4272.060146767706;4284.143171365801;4291.957080429156 20:57:03 INFO - PROCESS | 15140 | |4;prototype.html;283.20196458985225;284.7081741215254;291.50880765909443;293.51423394282443;304.2500236916003;4603;4755.524447555243;4773.1646961781635;4792.472827988923;4798.232282834747;4553.5901768840795;4696.131215725093;4731.976340118304;4740.288956656504;4740.810367585293;3783.9432408513962;3786.75386099904;3787.6780473659774;3790.7346485746007;3797.0697179190997;3584.910377240564;3650.689691376223;3786;3789.6399842014966;3795.9620403795884;3693.6887404971253;3747.231817477424;3770.6040865709115;3774.2828862516035;3778.7165962552917;3716;3727.850885964558;3737.7570457920283;3741.906452338686;3748.4377343398437;3347.73218142548;3348.8493017814258;3355.2115252915546;3389.2882494676146;3414.1805966568095;4516.4806047304655;4570.497245303014;4571.679982401233;4578.10726908253;4578.862634120982;4248.277792775205;4249.895027292895;4260.169266992938;4267;4301.78491075445;4757.26262429324;4903.239997800347;4909.803607855717;4913.582345500637;4916.237983112624;3529.94705079424;3543.1496440854266;3543.4153364694794;3544.291141771656;3549.378858699717;5121.795128194905;5152.716600586966;5159.587233021387;5188.169892817131;5189.844304670866;3630.219502806909;3651.174412793603;3664.937168221186;3676.0809797550614;3678.3562876496508;3601.549806274216;3673.6142705016123;3674.669279764834;3691.280200360904;3695.2055308108884;4149.460570125924;4156.233600719682;4168.854090106832;4187.706860519735;4192.853250136231;4709.221559280041;4901.1913034349645;4937;4939.851804445872;4956.231784073474;1237.3503910447087;1264.6594609713734;1269.3462866623697;1269.7206614544784;1271.6058022013206;786.8173239247259;789.7512283630638;806.6289506826809;806.7741032510907;823.995880020596;3941.8423263069158;3961.564227934925;3974.145558704892;3982.506560039985;3989.2673518639244;4485.955140448619;4508.3769842856545;4519.41247637805;4532.546745325507;4532.88667783308;3936.626020528045;3952.5849785772657;3978.5225772906856;3983.8406463741703;3997.142043438897;2232.7320721513524;2412.9369389172357;2420.649005894171;2425.7331693513697;2437.9512409751705;4303.214166121087;4344.587264209895;4352.608265256079;4382.8904277392685;4387.451568553931;4584.17484852723;4611.239145540948;4629.930551041737;4670;4670.486246512881;4181.268278051329;4344.913101737948;4405.9559404405545;4412.735235885857;4418.2488976873365;4582.243929751687;4588.816447342069;4601.608863246662;4606.401167848158;4606.447226332862;4387.692861499664;4427.653343727829;4434.778261086997;4453.643708503248;4492.438445194351;4132.524759652679;4291.957080429156;4305.827766889414;4309.224339618899;4328.112736888867;3251.9674803251664;3259.9511007334436;3260.4457242268395;3281.98359008213;3294.4893541501106;4446.644268458451;4471.8658440246845;4494;4547.3179023146795;4888.413390393175;4716.410448693913;4901.877453063559;4936.802527898843;4955.578775803953;4969.868982540976;4919.745464906426;4940.641323636029;4942.135126352946;4952.4057113146655;4977.303177555073;4689.460712018162;4839.201531747222;4872.14737420957;4882.462929077869;4918.975405122951;4981.501849815135;4989.777504511418;4996.175631020841;4999.225120106389;5011.84964451067;4887.34020907173;4890.828820991248;4914.164592019294;4928.778204980713;4954.5540901319055 20:57:03 INFO - PROCESS | 15140 | |5;yui.html;647.5337756815093;708.3518580498842;769.8999130113084;780.8789637606174;785.8585454618167;11825.290482571052;12707.729227077287;12786.680332991667;12875.54935577255;12915.483380664786;12604;13316;13362.064655474122;13576.524821631245;13630.727385452285;640.4108220437186;786.7364432914952;825.0759149752286;828.5028982610415;831.6257684042175;810.1210186947169;816.4121832280748;816.4733746733353;816.5508970066469;818.1041759273586;852.3862818770475;854.8674955381925;856.6873091321654;857.1385757313891;857.6012154348227;671.1979184874077;825.8348330333957;851.0553285852699;851.3274513134617;857.3526987124743;629.1632129268063;629.4932579273728;629.7701339011273;629.9464545513637;630.2562975688686;11884.168108232427;11890.167688261825;11892.762144757056;11892.940535297355;11917.582884599084;11065.225434219608;11213.215074944757;11402.31586104828;11506.07951363889;11744.70638234051;10030.59877604895;10096.596136154545;10130.341527800669;10887.83668244977;11085.445727713663;3332.683395077464;3361.5798025246845;3383.340248651514;3413.0784688134313;3465.705415039725;46031.30953035707;46245;46921.76539117317;48170.51829481695;49209.75395123001;9650.131488166098;9779.559919803625;9810.166135878388;9861.408315501092;9931.553080111413;16237.106959117362;16237.188140592923;16256.837431625769;16259.674806503805;16281.185940702917;6723.428508576826;6739.966300168468;6847.109875716125;6852.28051054642;6967.372936435745;3842.9039274018373;3851;3893.5911729268587;3968.444417781513;3997.8600748973645;2755.9311017224327;2838.7728981681416;2843.317603775079;2848.643919510061;2851.4012057468162;487.3858937738475;487.79271303524206;501.2381180605459;501.3858023920668;502.43727025730686;483.02936937831913;539.7759929629239;609.4149616368247;629.8929182039064;642.9196350456193;7934.920650793533;8012.959935200403;8050.557219352875;8258.380621453294;8284.337253019745;486.9541020914159;599.7780821096135;601.9135460493851;610.5390430225151;610.8992016317346;3746.7751934883995;3753.680937120321;3800.4489349044234;3957.465742124834;4036.858709945138;55032;55043.72478137664;55546.72226638841;55855.441445585835;55941;48608.513914861105;48692.75653621709;48738;49726;51804;44930.32604510935;45055.77472112618;45600;45669.08661826811;46676.7666161667;7443.7766866991915;7569.697212111454;7640.808979775327;7658.387329013554;7729;30361.240968975068;30806.383872322876;30953.845230773702;31234.21914452157;31489.685103148677;37469.81265093657;39378;39389;39532;40396.596034040456;9594.934573224704;9704.951475242578;9814.65648702292;9824.55789489489;9923.553440095357;9038.37309284335;9120.361574689974;10531.684049478528;10572.101371383518;11099.72250693739;9955.552000159865;10261.435621040915;10332.690019299433;10392.896071039193;10566.841497377392;9238.076192380708;9294;9404.106609872051;9456.574454149717;9611.134997850228;9397.436153830791;10275.486225688835;10319.071283584513;10662.73343166427;10705;8336.958315208385;8393.83212335762;8420.831583368175;8429.4942303462;8635.956820215859;8170.550619715735;8481.36389770782;8636.006859211271;8653.134686531548;8781.20969112783 20:57:03 INFO - PROCESS | 15140 | __end_tp_report 20:57:03 INFO - PROCESS | 15140 | __start_cc_report 20:57:03 INFO - PROCESS | 15140 | _x_x_mozilla_cycle_collect,1102 20:57:03 INFO - PROCESS | 15140 | __end_cc_report 20:57:03 INFO - PROCESS | 15140 | __startTimestamp1464062223395__endTimestamp 20:57:03 INFO - PROCESS | 15140 | 20:57:03 INFO - PROCESS | 15140 | ------- Summary: start ------- 20:57:03 INFO - PROCESS | 15140 | Number of tests: 6 20:57:03 INFO - PROCESS | 15140 | 20:57:03 INFO - PROCESS | 15140 | [#0] dojo.html Cycles:165 Average:4708.40 Median:4846.08 stddev:486.37 (10.0%) stddev-sans-first:460.39 20:57:03 INFO - PROCESS | 15140 | Values: 2654.3 2674.2 2708.4 2714.9 2722.6 4633.6 4670.6 4699.5 4744.3 4755.9 4684.6 4688.6 4721.4 4781.0 4803.7 4292.0 4343.5 4361.6 4374.8 4566.3 4497.9 4514.9 4515.6 4548.2 4575.7 4324.2 4364.1 4373.1 4382.6 4397.0 4378.6 4379.0 4382.0 4469.2 4477.4 4407.7 4408.2 4408.6 4414.5 4448.9 4529.4 4655.6 4657.8 4730.1 4759.9 5079.1 5136.7 5144.4 5145.0 5152.2 5113.3 5153.5 5162.8 5181.5 5185.1 4626.0 4708.0 4760.1 4767.4 4823.0 5195.1 5214.9 5274.2 5274.6 5275.1 4997.3 5008.3 5040.1 5046.6 5048.4 4955.7 5005.6 5070.6 5075.4 5096.7 5009.8 5035.9 5038.5 5043.6 5092.3 4901.5 4993.1 5022.4 5026.0 5035.2 4231.9 4280.1 4285.2 4285.7 4291.1 3750.0 3760.1 3762.7 3763.7 3788.8 4346.0 4391.4 4444.6 4444.8 4485.1 5063.6 5137.5 5138.7 5143.5 5147.6 4420.4 4421.3 4422.3 4445.8 4452.3 4471.5 4516.7 4595.2 4599.2 4634.4 4810.0 4826.5 4846.1 4850.3 4901.5 5076.7 5094.7 5094.9 5098.3 5147.5 4660.7 4822.0 4823.0 4887.0 4891.1 5054.0 5071.3 5081.9 5096.5 5142.4 5117.4 5151.3 5159.6 5160.3 5167.6 4817.9 4852.9 4915.8 4923.3 4997.5 4884.7 4900.8 4911.4 4927.5 4956.7 4805.4 4847.2 4855.1 4897.8 4899.1 4878.6 4884.1 4956.2 4956.4 4967.4 4855.2 4866.7 4867.4 4876.2 4919.3 20:57:03 INFO - PROCESS | 15140 | 20:57:03 INFO - PROCESS | 15140 | [#1] ext.html Cycles:180 Average:42304.64 Median:36603.73 stddev:67485.04 (184.4%) stddev-sans-first:67601.56 20:57:03 INFO - PROCESS | 15140 | Values: 560.3 586.4 593.3 594.5 603.1 27831.3 40393.6 41603.8 41908.6 45601.1 42641.0 42829.4 42951.1 43196.1 43275.6 7690.8 7835.5 7849.1 7855.0 7857.7 7631.0 7689.7 7718.0 7745.0 7749.0 7735.6 7750.0 7763.0 7763.6 7764.5 7733.2 7765.9 7793.4 7794.1 7798.6 7656.9 7704.5 7728.6 7746.9 7751.9 38444.0 38686.2 38905.0 38942.6 38979.4 3088.1 3239.0 3349.0 3452.5 3484.4 29997.4 30317.8 30494.8 30757.4 31440.0 3505.7 3545.6 3550.9 3565.0 3608.7 259497.0 260374.0 260967.0 261304.0 261482.0 38868.8 55144.2 55202.4 55470.2 55525.2 58620.4 60660.4 60922.4 66207.3 66275.7 12390.9 12478.3 12494.1 12494.9 12521.7 8009.8 8717.3 8877.2 9615.8 9665.5 17754.6 17840.7 17902.4 17932.9 18012.3 6454.4 6499.2 6597.6 6689.3 6721.5 886.2 891.4 922.2 991.5 1033.7 27128.2 28143.2 28621.6 29123.6 29237.7 998.3 998.7 1002.5 1033.2 1048.6 14753.8 15375.3 15375.6 16105.7 16329.5 183280.0 183361.1 185565.0 185608.0 357112.0 50499.7 50698.0 50774.2 50805.2 50845.2 1122.5 1229.5 1241.0 1243.2 1274.1 28356.3 29188.4 29207.3 29257.3 29883.6 42133.4 42660.0 42669.0 42758.1 42794.1 273732.0 282258.0 282530.0 282602.0 283475.0 22150.4 24481.8 25050.2 25369.4 27227.2 41464.4 41989.8 42132.8 42231.4 42393.0 35825.8 35833.5 35991.1 36245.8 36786.3 36099.0 36231.0 36663.0 36816.4 36836.6 35351.5 35467.6 35884.5 36393.8 36544.5 30172.7 33372.0 33646.3 33660.0 33726.5 25219.5 25463.5 25662.5 25758.6 25944.4 20:57:03 INFO - PROCESS | 15140 | 20:57:03 INFO - PROCESS | 15140 | [#2] jquery.html Cycles:180 Average:22418.58 Median:5693.55 stddev:56883.87 (999.1%) stddev-sans-first:57019.35 20:57:03 INFO - PROCESS | 15140 | Values: 365.4 369.6 377.6 378.3 382.2 15993.7 17325.5 17446.3 17833.9 17886.0 15780.2 16667.0 17564.2 17566.6 17592.0 5005.9 5141.6 5156.4 5177.0 5189.9 3592.3 3811.4 5629.2 5941.4 5958.4 5926.7 5955.5 5964.9 5977.4 5996.0 5757.9 5815.1 5892.3 6014.9 6018.3 3325.9 4944.2 5264.1 5271.3 5349.8 19594.0 19947.8 19987.3 20048.9 20282.8 2003.8 2090.8 2101.7 2216.0 2536.8 6151.2 6158.7 12709.9 12975.2 13277.7 1678.1 1702.0 1752.8 1770.4 1784.4 66682.7 68443.0 69024.7 69147.7 71045.6 8449.3 8979.8 9074.6 9259.9 9501.3 11745.3 11786.9 11807.0 11850.9 11875.2 6256.8 6393.5 6479.7 6514.1 6626.3 6212.4 6219.7 6285.6 6297.0 6311.3 3826.6 3827.6 3857.1 3909.6 3924.8 1687.8 1722.9 1829.4 1873.6 1882.8 822.9 825.2 876.0 945.7 949.4 16440.6 16589.9 16643.2 16652.7 17201.7 837.4 847.4 866.5 887.0 936.5 9365.7 9468.7 9548.2 9717.7 9823.8 294486.0 300863.0 301318.0 391850.0 402370.0 75501.6 79646.2 81803.0 82633.6 82984.6 923.3 927.0 944.0 955.7 960.6 15454.5 15489.5 15637.4 15764.4 16048.7 33702.3 34580.3 35603.3 35900.1 36932.6 42689.1 44171.3 45080.8 46615.3 46825.9 7034.3 7212.2 7350.6 7662.2 7747.1 8343.5 9636.9 10341.6 10508.7 10688.5 8917.2 9099.0 9106.9 9193.8 9415.7 9119.3 9278.5 9282.3 9310.0 9593.9 4899.2 5519.9 8971.6 9374.3 9404.8 6866.8 7124.3 7167.4 7193.1 7259.6 8149.8 8870.6 9118.0 9131.8 9553.8 20:57:03 INFO - PROCESS | 15140 | 20:57:03 INFO - PROCESS | 15140 | [#3] mootools.html Cycles:180 Average:5128.99 Median:4944.93 stddev:2959.17 (59.8%) stddev-sans-first:2953.28 20:57:03 INFO - PROCESS | 15140 | Values: 1273.4 1376.2 1427.4 1519.6 1787.4 6602.2 7472.8 7703.5 7744.1 7949.6 7700.7 7855.5 7862.0 7864.4 7882.2 1866.5 2117.6 2141.1 2148.9 2212.0 2222.9 2245.6 2251.1 2251.5 2253.2 2165.4 2212.0 2221.7 2223.9 2224.2 1825.8 2114.0 2173.9 2178.6 2181.8 2180.0 2190.0 2192.5 2211.1 2212.1 7940.4 7979.9 7993.1 7997.9 8005.8 4364.2 4512.5 4516.3 4516.3 4519.5 2966.5 2975.4 3011.1 3076.8 3106.2 932.3 939.8 951.3 964.7 964.7 11063.6 11095.4 11098.6 11101.1 11134.1 4099.2 4223.7 4324.0 4328.8 4334.5 9394.2 9460.7 9460.9 9468.6 9473.3 4496.3 4496.5 4497.9 4498.3 4500.2 3395.3 3946.2 4075.7 4076.3 4129.5 3504.2 3573.4 3594.2 3627.5 3643.5 1195.9 1221.3 1223.6 1224.2 1228.3 667.4 803.8 824.8 835.7 851.6 4888.6 5001.3 5047.2 5067.3 5167.0 411.2 413.1 420.3 422.4 427.3 3394.6 3425.2 3445.1 3508.1 3539.7 9498.4 9876.6 9914.9 9919.4 9925.4 9763.1 9807.2 9821.0 9828.7 9840.1 6904.3 7198.4 7204.1 7401.8 7464.6 5354.9 5410.4 5428.8 5429.6 5558.6 8767.2 8841.7 8937.0 8944.3 8952.8 8514.0 8886.5 8889.8 8949.0 9215.5 5884.9 6474.2 6644.0 6680.6 6784.4 7659.8 7695.8 7727.6 7778.9 7791.3 6763.8 6893.3 6904.8 6940.4 7067.2 6874.6 6886.2 6903.0 6996.4 7033.4 5899.7 5939.9 5957.5 5967.9 6208.9 4334.6 4365.0 4372.5 4399.5 4444.2 4171.0 4233.3 4272.1 4284.1 4292.0 20:57:03 INFO - PROCESS | 15140 | 20:57:03 INFO - PROCESS | 15140 | [#4] prototype.html Cycles:180 Average:3969.10 Median:4385.17 stddev:1136.34 (25.9%) stddev-sans-first:1105.34 20:57:03 INFO - PROCESS | 15140 | Values: 283.2 284.7 291.5 293.5 304.3 4603.0 4755.5 4773.2 4792.5 4798.2 4553.6 4696.1 4732.0 4740.3 4740.8 3783.9 3786.8 3787.7 3790.7 3797.1 3584.9 3650.7 3786.0 3789.6 3796.0 3693.7 3747.2 3770.6 3774.3 3778.7 3716.0 3727.9 3737.8 3741.9 3748.4 3347.7 3348.8 3355.2 3389.3 3414.2 4516.5 4570.5 4571.7 4578.1 4578.9 4248.3 4249.9 4260.2 4267.0 4301.8 4757.3 4903.2 4909.8 4913.6 4916.2 3529.9 3543.1 3543.4 3544.3 3549.4 5121.8 5152.7 5159.6 5188.2 5189.8 3630.2 3651.2 3664.9 3676.1 3678.4 3601.5 3673.6 3674.7 3691.3 3695.2 4149.5 4156.2 4168.9 4187.7 4192.9 4709.2 4901.2 4937.0 4939.9 4956.2 1237.4 1264.7 1269.3 1269.7 1271.6 786.8 789.8 806.6 806.8 824.0 3941.8 3961.6 3974.1 3982.5 3989.3 4486.0 4508.4 4519.4 4532.5 4532.9 3936.6 3952.6 3978.5 3983.8 3997.1 2232.7 2412.9 2420.6 2425.7 2438.0 4303.2 4344.6 4352.6 4382.9 4387.5 4584.2 4611.2 4629.9 4670.0 4670.5 4181.3 4344.9 4406.0 4412.7 4418.2 4582.2 4588.8 4601.6 4606.4 4606.4 4387.7 4427.7 4434.8 4453.6 4492.4 4132.5 4292.0 4305.8 4309.2 4328.1 3252.0 3260.0 3260.4 3282.0 3294.5 4446.6 4471.9 4494.0 4547.3 4888.4 4716.4 4901.9 4936.8 4955.6 4969.9 4919.7 4940.6 4942.1 4952.4 4977.3 4689.5 4839.2 4872.1 4882.5 4919.0 4981.5 4989.8 4996.2 4999.2 5011.8 4887.3 4890.8 4914.2 4928.8 4954.6 20:57:03 INFO - PROCESS | 15140 | 20:57:03 INFO - PROCESS | 15140 | [#5] yui.html Cycles:180 Average:12873.39 Median:501.91 stddev:15252.01 (3038.8%) stddev-sans-first:15267.17 20:57:03 INFO - PROCESS | 15140 | Values: 647.5 708.4 769.9 780.9 785.9 11825.3 12707.7 12786.7 12875.5 12915.5 12604.0 13316.0 13362.1 13576.5 13630.7 640.4 786.7 825.1 828.5 831.6 810.1 816.4 816.5 816.6 818.1 852.4 854.9 856.7 857.1 857.6 671.2 825.8 851.1 851.3 857.4 629.2 629.5 629.8 629.9 630.3 11884.2 11890.2 11892.8 11892.9 11917.6 11065.2 11213.2 11402.3 11506.1 11744.7 10030.6 10096.6 10130.3 10887.8 11085.4 3332.7 3361.6 3383.3 3413.1 3465.7 46031.3 46245.0 46921.8 48170.5 49209.8 9650.1 9779.6 9810.2 9861.4 9931.6 16237.1 16237.2 16256.8 16259.7 16281.2 6723.4 6740.0 6847.1 6852.3 6967.4 3842.9 3851.0 3893.6 3968.4 3997.9 2755.9 2838.8 2843.3 2848.6 2851.4 487.4 487.8 501.2 501.4 502.4 483.0 539.8 609.4 629.9 642.9 7934.9 8013.0 8050.6 8258.4 8284.3 487.0 599.8 601.9 610.5 610.9 3746.8 3753.7 3800.4 3957.5 4036.9 55032.0 55043.7 55546.7 55855.4 55941.0 48608.5 48692.8 48738.0 49726.0 51804.0 44930.3 45055.8 45600.0 45669.1 46676.8 7443.8 7569.7 7640.8 7658.4 7729.0 30361.2 30806.4 30953.8 31234.2 31489.7 37469.8 39378.0 39389.0 39532.0 40396.6 9594.9 9705.0 9814.7 9824.6 9923.6 9038.4 9120.4 10531.7 10572.1 11099.7 9955.6 10261.4 10332.7 10392.9 10566.8 9238.1 9294.0 9404.1 9456.6 9611.1 9397.4 10275.5 10319.1 10662.7 10705.0 8337.0 8393.8 8420.8 8429.5 8636.0 8170.6 8481.4 8636.0 8653.1 8781.2 20:57:03 INFO - PROCESS | 15140 | -------- Summary: end -------- 20:57:03 INFO - PROCESS | 15140 | 20:57:04 INFO - TEST-INFO | 15140: exit 0 20:57:04 INFO - TEST-OK | dromaeo_css | took 1118299ms 20:57:04 INFO - TEST-START | kraken 20:57:04 INFO - operating with platform_type : linux_ 20:57:04 INFO - Initialising browser for kraken test... 20:57:04 INFO - TEST-INFO | started process 15321 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJZQYSH/profile http://localhost:36914/getInfo.html) 20:57:08 INFO - PROCESS | 15321 | __metrics Screen width/height:1600/1200 20:57:08 INFO - PROCESS | 15321 | colorDepth:24 20:57:08 INFO - PROCESS | 15321 | Browser inner width/height: 1024/697 20:57:08 INFO - PROCESS | 15321 | __metrics 20:57:09 ERROR - PROCESS | 15321 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:57:10 INFO - TEST-INFO | 15321: exit 0 20:57:10 INFO - Browser initialized. 20:57:10 INFO - Running cycle 1/1 for kraken test... 20:57:10 INFO - TEST-INFO | started process 15404 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJZQYSH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:57:22 INFO - PROCESS | 15404 | RSS: Main: 154456064 20:57:22 INFO - PROCESS | 15404 | 20:57:25 INFO - PROCESS | 15404 | Cycle 1(1): loaded http://localhost:36914/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36914/tests/kraken/driver.html?testName=audio-beat-detection) 20:57:26 INFO - PROCESS | 15404 | RSS: Main: 209584128 20:57:26 INFO - PROCESS | 15404 | 20:57:29 INFO - PROCESS | 15404 | Cycle 1(1): loaded http://localhost:36914/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36914/tests/kraken/driver.html?testName=audio-dft) 20:57:29 INFO - PROCESS | 15404 | RSS: Main: 196829184 20:57:29 INFO - PROCESS | 15404 | 20:57:33 INFO - PROCESS | 15404 | Cycle 1(1): loaded http://localhost:36914/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36914/tests/kraken/driver.html?testName=audio-fft) 20:57:33 INFO - PROCESS | 15404 | RSS: Main: 266854400 20:57:33 INFO - PROCESS | 15404 | 20:57:35 INFO - PROCESS | 15404 | Cycle 1(1): loaded http://localhost:36914/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36914/tests/kraken/driver.html?testName=audio-oscillator) 20:57:36 INFO - PROCESS | 15404 | RSS: Main: 177160192 20:57:36 INFO - PROCESS | 15404 | 20:57:39 INFO - PROCESS | 15404 | Cycle 1(1): loaded http://localhost:36914/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36914/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:57:39 INFO - PROCESS | 15404 | RSS: Main: 180248576 20:57:39 INFO - PROCESS | 15404 | 20:57:42 INFO - PROCESS | 15404 | Cycle 1(1): loaded http://localhost:36914/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36914/tests/kraken/driver.html?testName=imaging-darkroom) 20:57:43 INFO - PROCESS | 15404 | RSS: Main: 216010752 20:57:43 INFO - PROCESS | 15404 | 20:57:47 INFO - PROCESS | 15404 | Cycle 1(1): loaded http://localhost:36914/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36914/tests/kraken/driver.html?testName=imaging-desaturate) 20:57:47 INFO - PROCESS | 15404 | RSS: Main: 215384064 20:57:47 INFO - PROCESS | 15404 | 20:57:50 INFO - PROCESS | 15404 | Cycle 1(1): loaded http://localhost:36914/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36914/tests/kraken/driver.html?testName=json-parse-financial) 20:57:51 INFO - PROCESS | 15404 | RSS: Main: 215896064 20:57:51 INFO - PROCESS | 15404 | 20:57:53 INFO - PROCESS | 15404 | Cycle 1(1): loaded http://localhost:36914/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36914/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:57:54 INFO - PROCESS | 15404 | RSS: Main: 210280448 20:57:54 INFO - PROCESS | 15404 | 20:57:55 INFO - PROCESS | 15404 | Cycle 1(1): loaded http://localhost:36914/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36914/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:57:56 INFO - PROCESS | 15404 | RSS: Main: 214638592 20:57:56 INFO - PROCESS | 15404 | 20:57:58 INFO - PROCESS | 15404 | Cycle 1(1): loaded http://localhost:36914/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36914/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:57:59 INFO - PROCESS | 15404 | RSS: Main: 218533888 20:57:59 INFO - PROCESS | 15404 | 20:58:02 INFO - PROCESS | 15404 | Cycle 1(1): loaded http://localhost:36914/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36914/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:58:03 INFO - PROCESS | 15404 | RSS: Main: 220553216 20:58:03 INFO - PROCESS | 15404 | 20:58:06 INFO - PROCESS | 15404 | Cycle 1(1): loaded http://localhost:36914/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36914/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:58:06 INFO - PROCESS | 15404 | RSS: Main: 219840512 20:58:06 INFO - PROCESS | 15404 | 20:58:08 INFO - PROCESS | 15404 | Cycle 1(1): loaded http://localhost:36914/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36914/tests/kraken/driver.html?testName=ai-astar) 20:58:08 INFO - PROCESS | 15404 | RSS: Main: 266817536 20:58:08 INFO - PROCESS | 15404 | 20:58:08 INFO - PROCESS | 15404 | __start_tp_report 20:58:08 INFO - PROCESS | 15404 | _x_x_mozilla_page_load 20:58:08 INFO - PROCESS | 15404 | _x_x_mozilla_page_load_details 20:58:08 INFO - PROCESS | 15404 | |i|pagename|runs| 20:58:08 INFO - PROCESS | 15404 | |0;ai-astar;115;111;115;114;114;114;115;114;113;115 20:58:08 INFO - PROCESS | 15404 | |1;audio-beat-detection;158;135;132;221;132;131;159;135;178;133 20:58:08 INFO - PROCESS | 15404 | |2;audio-dft;162;162;161;165;162;163;161;162;163;162 20:58:08 INFO - PROCESS | 15404 | |3;audio-fft;76;76;76;140;75;75;76;76;138;76 20:58:08 INFO - PROCESS | 15404 | |4;audio-oscillator;94;95;159;93;93;92;128;93;93;126 20:58:08 INFO - PROCESS | 15404 | |5;imaging-gaussian-blur;117;117;117;117;116;117;116;117;117;117 20:58:08 INFO - PROCESS | 15404 | |6;imaging-darkroom;145;146;146;146;145;145;146;148;146;146 20:58:08 INFO - PROCESS | 15404 | |7;imaging-desaturate;94;95;94;94;95;95;95;95;96;94 20:58:08 INFO - PROCESS | 15404 | |8;json-parse-financial;66;64;65;65;64;65;64;73;65;65 20:58:08 INFO - PROCESS | 15404 | |9;json-stringify-tinderbox;65;65;65;64;66;64;66;64;65;65 20:58:08 INFO - PROCESS | 15404 | |10;stanford-crypto-aes;86;82;83;83;83;84;87;84;158;84 20:58:08 INFO - PROCESS | 15404 | |11;stanford-crypto-ccm;134;131;132;130;131;129;129;129;162;131 20:58:08 INFO - PROCESS | 15404 | |12;stanford-crypto-pbkdf2;172;175;171;177;178;167;169;170;173;171 20:58:08 INFO - PROCESS | 15404 | |13;stanford-crypto-sha256-iterative;70;67;68;67;67;66;66;66;67;66 20:58:08 INFO - PROCESS | 15404 | __end_tp_report 20:58:08 INFO - PROCESS | 15404 | __start_cc_report 20:58:08 INFO - PROCESS | 15404 | _x_x_mozilla_cycle_collect,2107 20:58:08 INFO - PROCESS | 15404 | __end_cc_report 20:58:08 INFO - PROCESS | 15404 | __startTimestamp1464062288744__endTimestamp 20:58:08 INFO - PROCESS | 15404 | 20:58:08 INFO - PROCESS | 15404 | ------- Summary: start ------- 20:58:08 INFO - PROCESS | 15404 | Number of tests: 14 20:58:08 INFO - PROCESS | 15404 | 20:58:08 INFO - PROCESS | 15404 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.50 stddev:1.25 (1.1%) stddev-sans-first:1.27 20:58:08 INFO - PROCESS | 15404 | Values: 115.0 111.0 115.0 114.0 114.0 114.0 115.0 114.0 113.0 115.0 20:58:08 INFO - PROCESS | 15404 | 20:58:08 INFO - PROCESS | 15404 | [#1] audio-beat-detection Cycles:10 Average:151.40 Median:146.50 stddev:29.25 (20.0%) stddev-sans-first:30.92 20:58:08 INFO - PROCESS | 15404 | Values: 158.0 135.0 132.0 221.0 132.0 131.0 159.0 135.0 178.0 133.0 20:58:08 INFO - PROCESS | 15404 | 20:58:08 INFO - PROCESS | 15404 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:1.16 (0.7%) stddev-sans-first:1.22 20:58:08 INFO - PROCESS | 15404 | Values: 162.0 162.0 161.0 165.0 162.0 163.0 161.0 162.0 163.0 162.0 20:58:08 INFO - PROCESS | 15404 | 20:58:08 INFO - PROCESS | 15404 | [#3] audio-fft Cycles:10 Average:88.40 Median:76.00 stddev:26.68 (35.1%) stddev-sans-first:27.91 20:58:08 INFO - PROCESS | 15404 | Values: 76.0 76.0 76.0 140.0 75.0 75.0 76.0 76.0 138.0 76.0 20:58:08 INFO - PROCESS | 15404 | 20:58:08 INFO - PROCESS | 15404 | [#4] audio-oscillator Cycles:10 Average:106.60 Median:93.00 stddev:23.16 (24.9%) stddev-sans-first:24.11 20:58:08 INFO - PROCESS | 15404 | Values: 94.0 95.0 159.0 93.0 93.0 92.0 128.0 93.0 93.0 126.0 20:58:08 INFO - PROCESS | 15404 | 20:58:08 INFO - PROCESS | 15404 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 20:58:08 INFO - PROCESS | 15404 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 20:58:08 INFO - PROCESS | 15404 | 20:58:08 INFO - PROCESS | 15404 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.88 (0.6%) stddev-sans-first:0.87 20:58:08 INFO - PROCESS | 15404 | Values: 145.0 146.0 146.0 146.0 145.0 145.0 146.0 148.0 146.0 146.0 20:58:08 INFO - PROCESS | 15404 | 20:58:08 INFO - PROCESS | 15404 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 20:58:08 INFO - PROCESS | 15404 | Values: 94.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 96.0 94.0 20:58:08 INFO - PROCESS | 15404 | 20:58:08 INFO - PROCESS | 15404 | [#8] json-parse-financial Cycles:10 Average:65.60 Median:65.00 stddev:2.67 (4.1%) stddev-sans-first:2.83 20:58:08 INFO - PROCESS | 15404 | Values: 66.0 64.0 65.0 65.0 64.0 65.0 64.0 73.0 65.0 65.0 20:58:08 INFO - PROCESS | 15404 | 20:58:08 INFO - PROCESS | 15404 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 20:58:08 INFO - PROCESS | 15404 | Values: 65.0 65.0 65.0 64.0 66.0 64.0 66.0 64.0 65.0 65.0 20:58:08 INFO - PROCESS | 15404 | 20:58:08 INFO - PROCESS | 15404 | [#10] stanford-crypto-aes Cycles:10 Average:91.40 Median:84.00 stddev:23.45 (27.9%) stddev-sans-first:24.79 20:58:08 INFO - PROCESS | 15404 | Values: 86.0 82.0 83.0 83.0 83.0 84.0 87.0 84.0 158.0 84.0 20:58:08 INFO - PROCESS | 15404 | 20:58:08 INFO - PROCESS | 15404 | [#11] stanford-crypto-ccm Cycles:10 Average:133.80 Median:131.00 stddev:10.03 (7.7%) stddev-sans-first:10.64 20:58:08 INFO - PROCESS | 15404 | Values: 134.0 131.0 132.0 130.0 131.0 129.0 129.0 129.0 162.0 131.0 20:58:08 INFO - PROCESS | 15404 | 20:58:08 INFO - PROCESS | 15404 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.30 Median:172.50 stddev:3.50 (2.0%) stddev-sans-first:3.71 20:58:08 INFO - PROCESS | 15404 | Values: 172.0 175.0 171.0 177.0 178.0 167.0 169.0 170.0 173.0 171.0 20:58:08 INFO - PROCESS | 15404 | 20:58:08 INFO - PROCESS | 15404 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:1.25 (1.9%) stddev-sans-first:0.71 20:58:08 INFO - PROCESS | 15404 | Values: 70.0 67.0 68.0 67.0 67.0 66.0 66.0 66.0 67.0 66.0 20:58:08 INFO - PROCESS | 15404 | -------- Summary: end -------- 20:58:08 INFO - PROCESS | 15404 | 20:58:09 INFO - TEST-INFO | 15404: exit 0 20:58:09 INFO - TEST-OK | kraken | took 65719ms 20:58:09 INFO - SUITE-END | took 1184s 20:58:09 INFO - Completed test suite (00:19:44) 20:58:09 INFO - javascript benchmark 20:58:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2654.256808093734, 2674.237842214969, 2708.4041510867614, 2714.877830497628, 2722.550779121445, 4633.582977532022, 4670.649701272406, 4699.506551812062, 4744.264638980955, 4755.928661070082, 4684.578387945085, 4688.554587314208, 4721.38621979143, 4781.043791241748, 4803.687760295578, 4292.012837047481, 4343.4787825460835, 4361.5856493633055, 4374.825006999717, 4566.315052742082, 4497.932531012021, 4514.887127821798, 4515.593596576307, 4548.226801443762, 4575.748333841638, 4324.200022995725, 4364.061726728737, 4373.147236288941, 4382.583654552845, 4397.032652816375, 4378.584034516748, 4378.978105109486, 4381.978090109561, 4469.173202957463, 4477.440319960005, 4407.735535867858, 4408.228560002019, 4408.559144085598, 4414.4923333816705, 4448.93326600098, 4529.433820772403, 4655.557722016403, 4657.813687452498, 4730.148573256813, 4759.928601070987, 5079.085764562377, 5136.717480538568, 5144.356955380577, 5145.0, 5152.227165925104, 5113.284140220372, 5153.5361817436615, 5162.767675454614, 5181.533661970403, 5185.118529849935, 4625.953740462553, 4708.0, 4760.09558183944, 4767.380240568704, 4822.975885120587, 5195.116830138885, 5214.921776173361, 5274.235235890775, 5274.5780337572905, 5275.076861549213, 4997.275395067695, 5008.323876276656, 5040.092783299041, 5046.621503387188, 5048.368953880765, 4955.653104282737, 5005.62457815658, 5070.645054846199, 5075.365579302587, 5096.745162741848, 5009.824656137018, 5035.899282014339, 5038.496150384932, 5043.646944713835, 5092.312537807348, 4901.534354236342, 4993.101241776515, 5022.397312322545, 5025.974870125626, 5035.244713292962, 4231.936520952188, 4280.143971205771, 4285.18581469526, 4285.700000999963, 4291.141771645684, 3750.043738846631, 3760.135168911111, 3762.6613604775152, 3763.7365384423374, 3788.791616461066, 4346.022145017346, 4391.363252328394, 4444.577765112309, 4444.755538445416, 4485.147821913891, 5063.620228482879, 5137.537621614073, 5138.743062846917, 5143.5113664201845, 5147.639665223398, 4420.425344705168, 4421.292593185075, 4422.3366495026, 4445.799939002753, 4452.332150177499, 4471.463424389094, 4516.661250406232, 4595.195840727926, 4599.195140850338, 4634.351190833286, 4809.95190048109, 4826.517348265145, 4846.079244943449, 4850.320955066364, 4901.460839307602, 5076.7207803571155, 5094.719790411563, 5094.898102038012, 5098.260752190838, 5147.459516750687, 4660.673752837269, 4822.035592881508, 4822.95177048225, 4887.0, 4891.119598472309, 5053.974730126326, 5071.264666623245, 5081.949180508148, 5096.490350965022, 5142.434332223377, 5117.411497677815, 5151.253068305, 5159.613029022913, 5160.277561141518, 5167.58659307262, 4817.927731083966, 4852.927206091841, 4915.754212289443, 4923.335349727884, 4997.5002499749735, 4884.7069175849565, 4900.803967841389, 4911.386076740408, 4927.531884470969, 4956.72737999399, 4805.399325084364, 4847.200211964986, 4855.077535268288, 4897.8285759998225, 4899.069176856386, 4878.5853202476765, 4884.12085824555, 4956.231784073474, 4956.430010548833, 4967.428745694291, 4855.174620314626, 4866.683665561727, 4867.367242258484, 4876.171050921423, 4919.311296418433], "value": 4677.940969693637, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.2800401484094, 586.3550094895614, 593.2643522032678, 594.4946795224063, 603.1495591216386, 27831.304217394576, 40393.59606403939, 41603.79198104013, 41908.58091419089, 45601.087978240415, 42641.0, 42829.35755963663, 42951.14097718044, 43196.13607727844, 43275.56724432763, 7690.769276921687, 7835.49069310493, 7849.097353804328, 7854.960725196394, 7857.6856925722905, 7631.046119235096, 7689.730859419893, 7718.035245594301, 7745.031871016123, 7749.0, 7735.574543400111, 7749.961250193769, 7762.9611851940945, 7763.611819409035, 7764.456488045839, 7733.1880152583735, 7765.922340776633, 7793.415493837928, 7794.142644309121, 7798.610069496503, 7656.923430765677, 7704.499207551491, 7728.613569321511, 7746.9225307746765, 7751.922480775176, 38444.03889902775, 38686.22627547461, 38905.0, 38942.610573894184, 38979.41530877039, 3088.1044497095813, 3238.9838050809594, 3349.0455220262106, 3452.499387588811, 3484.4250698634696, 29997.400051998837, 30317.848410757804, 30494.847525762452, 30757.38485230283, 31440.0, 3505.6503246250377, 3545.556805399325, 3550.9347195841146, 3564.9643503564894, 3608.657177568127, 259497.0, 260374.0, 260967.0, 261304.0, 261482.0, 38868.80565597154, 55144.172837407474, 55202.44797551973, 55470.16794748082, 55525.16712249319, 58620.41379586235, 60660.393396066356, 60922.39077609256, 66207.33792662108, 66275.66862165659, 12390.876091239152, 12478.313692746804, 12494.125411221308, 12494.875051249554, 12521.686957826127, 8009.839803203903, 8717.259032982267, 8877.201051905231, 9615.759606009766, 9665.468399237969, 17754.644907102043, 17840.732389014174, 17902.373416930346, 17932.9103354485, 18012.279508819764, 6454.4186674264165, 6499.1876015498065, 6597.581519973229, 6689.297623749436, 6721.529492935545, 886.1802832380023, 891.4294851295176, 922.1838672774643, 991.4646091110864, 1033.7415646088477, 27128.186154415398, 28143.155705328874, 28621.57067643987, 29123.56314655282, 29237.707622923925, 998.3311181508261, 998.6804222648828, 1002.5388321372104, 1033.1682995188944, 1048.5962904281753, 14753.77869331961, 15375.308111135026, 15375.615609609626, 16105.67788644244, 16329.510114696579, 183280.0, 183361.08319458316, 185565.0, 185608.0, 357112.0, 50499.74750126226, 50698.0, 50774.23838642424, 50805.23792143121, 50845.23732144021, 1122.4836575175511, 1229.4836168809122, 1241.025794751134, 1243.160866415166, 1274.0699289518518, 28356.291092722848, 29188.416231675674, 29207.269818253862, 29257.268568285963, 29883.55174672425, 42133.36799947942, 42660.0, 42669.0, 42758.144837103704, 42794.14411711811, 273732.0, 282258.0, 282530.0, 282602.0, 283475.0, 22150.446238844157, 24481.75518244795, 25050.24849254525, 25369.365765856, 27227.183184504498, 41464.3780343289, 41989.79005105077, 42132.78933605312, 42231.366529501465, 42393.0, 35825.82087089548, 35833.46249806307, 35991.10022249465, 36245.81877090703, 36786.26427471382, 36099.0, 36231.0, 36663.0, 36816.44775328426, 36836.631633684396, 35351.469727954616, 35467.64532354747, 35884.461733073505, 36393.818030910734, 36544.45183322199, 30172.698273016988, 33372.0, 33646.32707345888, 33660.0, 33726.49410258897, 25219.495610088063, 25463.490730185662, 25662.486750265263, 25758.613620796077, 25944.351391215372], "value": 17301.22170382971, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.4244564810424, 369.5879094809288, 377.6261501113898, 378.30958500736165, 382.2412511165335, 15993.680126397465, 17325.480235592935, 17446.3021479141, 17833.91083044586, 17886.0, 15780.21098945054, 16666.99998000121, 17564.209610567523, 17566.560835979108, 17592.0, 5005.899882002358, 5141.614378921578, 5156.407013193474, 5177.0, 5189.948100519003, 3592.263585964884, 3811.3520701480675, 5629.155626655994, 5941.435563621449, 5958.40415958405, 5926.674032928187, 5955.493783028448, 5964.910526342108, 5977.402259774031, 5996.010658241385, 5757.942420575803, 5815.069588865804, 5892.263467066617, 6014.939850601481, 6018.307894592134, 3325.933481330384, 4944.159492886218, 5264.052470555299, 5271.28837606922, 5349.812756553541, 19594.0, 19947.800521994886, 19987.300444484372, 20048.89975550113, 20282.797172028237, 2003.7996200379991, 2090.780468050863, 2101.7162683037745, 2216.0027987405733, 2536.8351057181226, 6151.200343955257, 6158.7228574714245, 12709.936450317782, 12975.156614820007, 13277.747266463666, 1678.0770576183052, 1702.0, 1752.7809023872016, 1770.3538208553784, 1784.4022252545412, 66682.66658666676, 68443.0, 69024.6548767253, 69147.65426172888, 71045.64477177632, 8449.32405407566, 8979.775505612412, 9074.637014519345, 9259.861102083474, 9501.334906556613, 11745.29528228309, 11786.94106529479, 11807.0, 11850.881491184979, 11875.228110172811, 6256.7810126645345, 6393.488520918316, 6479.708413121421, 6514.120593719787, 6626.271110177877, 6212.409821066992, 6219.657918814509, 6285.622862628257, 6296.968515157487, 6311.305756366796, 3826.6364695354455, 3827.61723827615, 3857.0550215196895, 3909.6285852843935, 3924.823382947774, 1687.8143404225525, 1722.879398442097, 1829.428601191516, 1873.597176607036, 1882.7740671119554, 822.9341652667772, 825.1789469477787, 876.0494863073509, 945.669015844449, 949.3686698345523, 16440.588985275463, 16589.91705041467, 16643.167841607872, 16652.666946661, 17201.7419738704, 837.4431003382682, 847.4195176304252, 866.540733411293, 886.9911300887038, 936.5317341329335, 9365.71902842902, 9468.668596599086, 9548.236141108695, 9717.708468745808, 9823.803523929624, 294486.0, 300863.0, 301318.0, 391850.0, 402370.0, 75501.62249188719, 79646.20353796388, 81803.0, 82633.58683206546, 82984.58507707423, 923.2798417234568, 926.9768255793659, 943.9716808495756, 955.7037318431309, 960.6205548808182, 15454.459093931659, 15489.5353139406, 15637.374505019672, 15764.448244311394, 16048.679026419173, 33702.32595348128, 34580.308393832485, 35603.287934241685, 35900.10249743777, 36932.630673693995, 42689.14621707611, 44171.337429939216, 45080.77459612681, 46615.30077048779, 46825.89283482183, 7034.2965703429245, 7212.170600380813, 7350.595717235603, 7662.195469475848, 7747.1090824555895, 8343.45767525109, 9636.855447168438, 10341.586336546454, 10508.684739457829, 10688.465576721288, 8917.242034427147, 9098.954505227432, 9106.908930910606, 9193.816123677623, 9415.717528474157, 9119.270458363448, 9278.536073196177, 9282.257419406566, 9310.0, 9593.904060959301, 4899.16714158601, 5519.917201242065, 8971.551422428984, 9374.343795934219, 9404.764880878032, 6866.793996180123, 7124.323189297009, 7167.426605871414, 7193.136823581203, 7259.564426134449, 8149.8370032600205, 8870.64517419296, 9117.954410227907, 9131.817363652557, 9553.808923821345], "value": 7880.356557206737, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1273.3633183408297, 1376.1536654957201, 1427.3790900958081, 1519.620094976256, 1787.3654852527345, 6602.240742314635, 7472.813179670511, 7703.46075774696, 7744.148143704188, 7949.642266098025, 7700.6919723211, 7855.4893931894385, 7862.01724784402, 7864.449488535804, 7882.172371900954, 1866.5240363707235, 2117.597656445278, 2141.1435425829713, 2148.892555372233, 2212.048819007826, 2222.8777417242045, 2245.618244898363, 2251.0995601759264, 2251.527179292342, 2253.211376018397, 2165.404513758713, 2211.9889400552975, 2221.7111775469166, 2223.8999245033933, 2224.243757122578, 1825.8082901295438, 2114.0, 2173.9021744021397, 2178.6296329624, 2181.7818218178213, 2180.0407820558903, 2189.9562008759735, 2192.5395666909967, 2211.1266049910355, 2212.126210146983, 7940.364770818378, 7979.880301795478, 7993.120756716757, 7997.880031799527, 8005.839883202361, 4364.170807546556, 4512.526184750587, 4516.254817955033, 4516.299973504112, 4519.502854685982, 2966.480865848468, 2975.4346674131843, 3011.051518771602, 3076.8000079994727, 3106.192389978622, 932.2961164320894, 939.8355287824671, 951.3435729346797, 964.7057647417535, 964.71058682395, 11063.557457701681, 11095.389753563551, 11098.55605775768, 11101.111911047097, 11134.053605443547, 4099.159672267178, 4223.683223758169, 4323.978380108079, 4328.783560822009, 4334.4798624165305, 9394.154526092685, 9460.716178514656, 9460.905390946002, 9468.621255149854, 9473.28950328728, 4496.280595104833, 4496.460424748986, 4497.9325310120375, 4498.302763071729, 4500.234960056799, 3395.3379091077004, 3946.210757848442, 4075.735077219971, 4076.3274059780397, 4129.483814523184, 3504.2465869837597, 3573.428251479803, 3594.227241143167, 3627.4558816177782, 3643.544556930384, 1195.910306726999, 1221.3160630047203, 1223.5900973174087, 1224.2348532167396, 1228.3121451986915, 667.4026746062248, 803.8271771569141, 824.8391563645032, 835.6532039203784, 851.5784686580182, 4888.584470320063, 5001.274815151783, 5047.2429135629945, 5067.315912351785, 5167.0, 411.1612310885819, 413.08707755859285, 420.3274760383423, 422.3812115251172, 427.31629392970996, 3394.5926488821005, 3425.246445781924, 3445.0870519312402, 3508.1054331145906, 3539.699125574355, 9498.430094194371, 9876.555555000043, 9914.851277230848, 9919.40483570988, 9925.3548519346, 9763.121319081316, 9807.215422766161, 9820.950895245622, 9828.705138845846, 9840.11438970496, 6904.275051119661, 7198.352148306678, 7204.0994875640545, 7401.8149546261775, 7464.589447580435, 5354.946450535601, 5410.377806552139, 5428.83713488596, 5429.565634749131, 5558.610897237317, 8767.21095101444, 8841.734747957571, 8936.955315223382, 8944.284457243275, 8952.776180595538, 8514.0, 8886.4668119913, 8889.822203556021, 8948.955255223942, 9215.49314787693, 5884.911726324023, 6474.223093228843, 6644.0, 6680.565763225375, 6784.3894049535775, 7659.770206893802, 7695.769126926201, 7727.574983375744, 7778.88331675014, 7791.298783109547, 6763.797086087426, 6893.345132212432, 6904.758333458305, 6940.444764418935, 7067.151941767021, 6874.621895795779, 6886.173659160932, 6903.0, 6996.405305549085, 7033.437325013884, 5899.705014749159, 5939.940600593939, 5957.523398128226, 5967.850803729768, 6208.875822483435, 4334.609885110355, 4365.039691267916, 4372.540883207344, 4399.538048504861, 4444.200043991983, 4170.958290417057, 4233.322668373045, 4272.060146767706, 4284.143171365801, 4291.957080429156], "value": 4043.1806009884153, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.20196458985225, 284.7081741215254, 291.50880765909443, 293.51423394282443, 304.2500236916003, 4603.0, 4755.524447555243, 4773.1646961781635, 4792.472827988923, 4798.232282834747, 4553.5901768840795, 4696.131215725093, 4731.976340118304, 4740.288956656504, 4740.810367585293, 3783.9432408513962, 3786.75386099904, 3787.6780473659774, 3790.7346485746007, 3797.0697179190997, 3584.910377240564, 3650.689691376223, 3786.0, 3789.6399842014966, 3795.9620403795884, 3693.6887404971253, 3747.231817477424, 3770.6040865709115, 3774.2828862516035, 3778.7165962552917, 3716.0, 3727.850885964558, 3737.7570457920283, 3741.906452338686, 3748.4377343398437, 3347.73218142548, 3348.8493017814258, 3355.2115252915546, 3389.2882494676146, 3414.1805966568095, 4516.4806047304655, 4570.497245303014, 4571.679982401233, 4578.10726908253, 4578.862634120982, 4248.277792775205, 4249.895027292895, 4260.169266992938, 4267.0, 4301.78491075445, 4757.26262429324, 4903.239997800347, 4909.803607855717, 4913.582345500637, 4916.237983112624, 3529.94705079424, 3543.1496440854266, 3543.4153364694794, 3544.291141771656, 3549.378858699717, 5121.795128194905, 5152.716600586966, 5159.587233021387, 5188.169892817131, 5189.844304670866, 3630.219502806909, 3651.174412793603, 3664.937168221186, 3676.0809797550614, 3678.3562876496508, 3601.549806274216, 3673.6142705016123, 3674.669279764834, 3691.280200360904, 3695.2055308108884, 4149.460570125924, 4156.233600719682, 4168.854090106832, 4187.706860519735, 4192.853250136231, 4709.221559280041, 4901.1913034349645, 4937.0, 4939.851804445872, 4956.231784073474, 1237.3503910447087, 1264.6594609713734, 1269.3462866623697, 1269.7206614544784, 1271.6058022013206, 786.8173239247259, 789.7512283630638, 806.6289506826809, 806.7741032510907, 823.995880020596, 3941.8423263069158, 3961.564227934925, 3974.145558704892, 3982.506560039985, 3989.2673518639244, 4485.955140448619, 4508.3769842856545, 4519.41247637805, 4532.546745325507, 4532.88667783308, 3936.626020528045, 3952.5849785772657, 3978.5225772906856, 3983.8406463741703, 3997.142043438897, 2232.7320721513524, 2412.9369389172357, 2420.649005894171, 2425.7331693513697, 2437.9512409751705, 4303.214166121087, 4344.587264209895, 4352.608265256079, 4382.8904277392685, 4387.451568553931, 4584.17484852723, 4611.239145540948, 4629.930551041737, 4670.0, 4670.486246512881, 4181.268278051329, 4344.913101737948, 4405.9559404405545, 4412.735235885857, 4418.2488976873365, 4582.243929751687, 4588.816447342069, 4601.608863246662, 4606.401167848158, 4606.447226332862, 4387.692861499664, 4427.653343727829, 4434.778261086997, 4453.643708503248, 4492.438445194351, 4132.524759652679, 4291.957080429156, 4305.827766889414, 4309.224339618899, 4328.112736888867, 3251.9674803251664, 3259.9511007334436, 3260.4457242268395, 3281.98359008213, 3294.4893541501106, 4446.644268458451, 4471.8658440246845, 4494.0, 4547.3179023146795, 4888.413390393175, 4716.410448693913, 4901.877453063559, 4936.802527898843, 4955.578775803953, 4969.868982540976, 4919.745464906426, 4940.641323636029, 4942.135126352946, 4952.4057113146655, 4977.303177555073, 4689.460712018162, 4839.201531747222, 4872.14737420957, 4882.462929077869, 4918.975405122951, 4981.501849815135, 4989.777504511418, 4996.175631020841, 4999.225120106389, 5011.84964451067, 4887.34020907173, 4890.828820991248, 4914.164592019294, 4928.778204980713, 4954.5540901319055], "value": 3609.4207568813, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.5337756815093, 708.3518580498842, 769.8999130113084, 780.8789637606174, 785.8585454618167, 11825.290482571052, 12707.729227077287, 12786.680332991667, 12875.54935577255, 12915.483380664786, 12604.0, 13316.0, 13362.064655474122, 13576.524821631245, 13630.727385452285, 640.4108220437186, 786.7364432914952, 825.0759149752286, 828.5028982610415, 831.6257684042175, 810.1210186947169, 816.4121832280748, 816.4733746733353, 816.5508970066469, 818.1041759273586, 852.3862818770475, 854.8674955381925, 856.6873091321654, 857.1385757313891, 857.6012154348227, 671.1979184874077, 825.8348330333957, 851.0553285852699, 851.3274513134617, 857.3526987124743, 629.1632129268063, 629.4932579273728, 629.7701339011273, 629.9464545513637, 630.2562975688686, 11884.168108232427, 11890.167688261825, 11892.762144757056, 11892.940535297355, 11917.582884599084, 11065.225434219608, 11213.215074944757, 11402.31586104828, 11506.07951363889, 11744.70638234051, 10030.59877604895, 10096.596136154545, 10130.341527800669, 10887.83668244977, 11085.445727713663, 3332.683395077464, 3361.5798025246845, 3383.340248651514, 3413.0784688134313, 3465.705415039725, 46031.30953035707, 46245.0, 46921.76539117317, 48170.51829481695, 49209.75395123001, 9650.131488166098, 9779.559919803625, 9810.166135878388, 9861.408315501092, 9931.553080111413, 16237.106959117362, 16237.188140592923, 16256.837431625769, 16259.674806503805, 16281.185940702917, 6723.428508576826, 6739.966300168468, 6847.109875716125, 6852.28051054642, 6967.372936435745, 3842.9039274018373, 3851.0, 3893.5911729268587, 3968.444417781513, 3997.8600748973645, 2755.9311017224327, 2838.7728981681416, 2843.317603775079, 2848.643919510061, 2851.4012057468162, 487.3858937738475, 487.79271303524206, 501.2381180605459, 501.3858023920668, 502.43727025730686, 483.02936937831913, 539.7759929629239, 609.4149616368247, 629.8929182039064, 642.9196350456193, 7934.920650793533, 8012.959935200403, 8050.557219352875, 8258.380621453294, 8284.337253019745, 486.9541020914159, 599.7780821096135, 601.9135460493851, 610.5390430225151, 610.8992016317346, 3746.7751934883995, 3753.680937120321, 3800.4489349044234, 3957.465742124834, 4036.858709945138, 55032.0, 55043.72478137664, 55546.72226638841, 55855.441445585835, 55941.0, 48608.513914861105, 48692.75653621709, 48738.0, 49726.0, 51804.0, 44930.32604510935, 45055.77472112618, 45600.0, 45669.08661826811, 46676.7666161667, 7443.7766866991915, 7569.697212111454, 7640.808979775327, 7658.387329013554, 7729.0, 30361.240968975068, 30806.383872322876, 30953.845230773702, 31234.21914452157, 31489.685103148677, 37469.81265093657, 39378.0, 39389.0, 39532.0, 40396.596034040456, 9594.934573224704, 9704.951475242578, 9814.65648702292, 9824.55789489489, 9923.553440095357, 9038.37309284335, 9120.361574689974, 10531.684049478528, 10572.101371383518, 11099.72250693739, 9955.552000159865, 10261.435621040915, 10332.690019299433, 10392.896071039193, 10566.841497377392, 9238.076192380708, 9294.0, 9404.106609872051, 9456.574454149717, 9611.134997850228, 9397.436153830791, 10275.486225688835, 10319.071283584513, 10662.73343166427, 10705.0, 8336.958315208385, 8393.83212335762, 8420.831583368175, 8429.4942303462, 8635.956820215859, 8170.550619715735, 8481.36389770782, 8636.006859211271, 8653.134686531548, 8781.20969112783], "value": 5848.066981376296, "unit": "score"}], "name": "dromaeo_css", "value": 6156.260972720489, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 111.0, 115.0, 114.0, 114.0, 114.0, 115.0, 114.0, 113.0, 115.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 135.0, 132.0, 221.0, 132.0, 131.0, 159.0, 135.0, 178.0, 133.0], "value": 151.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 165.0, 162.0, 163.0, 161.0, 162.0, 163.0, 162.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 140.0, 75.0, 75.0, 76.0, 76.0, 138.0, 76.0], "value": 88.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 159.0, 93.0, 93.0, 92.0, 128.0, 93.0, 93.0, 126.0], "value": 106.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 148.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 96.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 65.0, 65.0, 64.0, 65.0, 64.0, 73.0, 65.0, 65.0], "value": 65.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 64.0, 66.0, 64.0, 66.0, 64.0, 65.0, 65.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 82.0, 83.0, 83.0, 83.0, 84.0, 87.0, 84.0, 158.0, 84.0], "value": 91.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 131.0, 132.0, 130.0, 131.0, 129.0, 129.0, 129.0, 162.0, 131.0], "value": 133.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 175.0, 171.0, 177.0, 178.0, 167.0, 169.0, 170.0, 173.0, 171.0], "value": 172.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 68.0, 67.0, 67.0, 66.0, 66.0, 66.0, 67.0, 66.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1575.1000000000001, "alertThreshold": 2.0}]} 20:58:09 INFO - Return code: 0 20:58:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:58:10 ERROR - # TBPL SUCCESS # 20:58:10 INFO - Running post-action listener: _resource_record_post_action 20:58:10 INFO - ##### 20:58:10 INFO - ##### Finished run-tests step (success) 20:58:10 INFO - ##### 20:58:10 INFO - Running post-run listener: _resource_record_post_run 20:58:10 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 0; Write bytes: 549273600; Read time: 0; Write time: 463796 20:58:10 INFO - TinderboxPrint: CPU usage
13.2% 20:58:10 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 20:58:10 INFO - TinderboxPrint: I/O write bytes / time
549,273,600 / 463,796 20:58:10 INFO - TinderboxPrint: CPU idle
8,322.3 (86.8%) 20:58:10 INFO - TinderboxPrint: CPU user
1,220.6 (12.7%) 20:58:10 INFO - TinderboxPrint: Swap in / out
0 / 0 20:58:10 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236834816; Read time: 0; Write time: 261172 20:58:10 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 293380096; Read time: 0; Write time: 192080 20:58:10 INFO - Running post-run listener: _upload_blobber_files 20:58:10 INFO - Blob upload gear active. 20:58:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:58:10 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 20:58:10 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'] 20:58:10 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 20:58:11 INFO - (blobuploader) - INFO - Open directory for files ... 20:58:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:58:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:58:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:58:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:58:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:58:12 INFO - (blobuploader) - INFO - Done attempting. 20:58:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:58:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:58:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:58:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:58:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:58:16 INFO - (blobuploader) - INFO - Done attempting. 20:58:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:58:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:58:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:58:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:58:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:58:17 INFO - (blobuploader) - INFO - Done attempting. 20:58:17 INFO - (blobuploader) - INFO - Iteration through files over. 20:58:17 INFO - Return code: 0 20:58:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:58:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:58:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d467dd19d7b9f97e3746cb352cf7564135e9fb455239c610ff9722d8ba26692fdc3c2ad6a4b8a40ae46bfe256943f0bfaccedcfad0c115ea6b70b5592a0a8e0d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1090cff5939396b33be3ffb5476e982eca91204658eef074babb11d7775610420cb3b5c53a696f60217bb0e64e2d8a5f1dc24b6fddfd5bc0ac003a9285ed0eac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/81651a087f784528c26840144fd62276c401a4f7ad6a750d7e7072af442b2675d0b0a3d9fae64881fc2936ed0b2502fada0ca1e0690f75e65a7fcb3d96c53979"} 20:58:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:58:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:58:17 INFO - Contents: 20:58:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d467dd19d7b9f97e3746cb352cf7564135e9fb455239c610ff9722d8ba26692fdc3c2ad6a4b8a40ae46bfe256943f0bfaccedcfad0c115ea6b70b5592a0a8e0d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1090cff5939396b33be3ffb5476e982eca91204658eef074babb11d7775610420cb3b5c53a696f60217bb0e64e2d8a5f1dc24b6fddfd5bc0ac003a9285ed0eac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/81651a087f784528c26840144fd62276c401a4f7ad6a750d7e7072af442b2675d0b0a3d9fae64881fc2936ed0b2502fada0ca1e0690f75e65a7fcb3d96c53979"} 20:58:17 INFO - Running post-run listener: copy_logs_to_upload_dir 20:58:17 INFO - Copying logs to upload dir... 20:58:17 INFO - mkdir: /builds/slave/test/build/upload/logs 20:58:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.879951 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-23 20:58:16.952844) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 20:58:16.955938) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1464061052.390683-10520656 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/d467dd19d7b9f97e3746cb352cf7564135e9fb455239c610ff9722d8ba26692fdc3c2ad6a4b8a40ae46bfe256943f0bfaccedcfad0c115ea6b70b5592a0a8e0d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1090cff5939396b33be3ffb5476e982eca91204658eef074babb11d7775610420cb3b5c53a696f60217bb0e64e2d8a5f1dc24b6fddfd5bc0ac003a9285ed0eac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/81651a087f784528c26840144fd62276c401a4f7ad6a750d7e7072af442b2675d0b0a3d9fae64881fc2936ed0b2502fada0ca1e0690f75e65a7fcb3d96c53979"} build_url:https://queue.taskcluster.net/v1/task/a5gN3mZZTtaXx46ZpYm64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011298 build_url: 'https://queue.taskcluster.net/v1/task/a5gN3mZZTtaXx46ZpYm64w/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/d467dd19d7b9f97e3746cb352cf7564135e9fb455239c610ff9722d8ba26692fdc3c2ad6a4b8a40ae46bfe256943f0bfaccedcfad0c115ea6b70b5592a0a8e0d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1090cff5939396b33be3ffb5476e982eca91204658eef074babb11d7775610420cb3b5c53a696f60217bb0e64e2d8a5f1dc24b6fddfd5bc0ac003a9285ed0eac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/81651a087f784528c26840144fd62276c401a4f7ad6a750d7e7072af442b2675d0b0a3d9fae64881fc2936ed0b2502fada0ca1e0690f75e65a7fcb3d96c53979"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 20:58:16.980658) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 20:58:16.980990) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1464061052.390683-10520656 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004433 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 20:58:17.066372) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 20:58:17.066711) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 20:58:17.066995) ========= ========= Total master_lag: 0.16 =========