builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-024 starttime: 1464031817.84 results: success (0) buildid: 20160523104044 builduid: 8bfc5daffab44767b7efa10e51005c3a revision: 6ac30d36c92309de1e179a1dd230c04e14a97f7f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 12:30:17.837405) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 12:30:17.837910) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 12:30:17.838199) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 12:30:17.886808) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 12:30:17.887066) ========= 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=ea34ab03e80221fdf844251c000001a3-1464031573.155194-759672629 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-23 12:30:18-- 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% 50.3M=0s 2016-05-23 12:30:18 (50.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112341 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 12:30:18.017858) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 12:30:18.018145) ========= 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=ea34ab03e80221fdf844251c000001a3-1464031573.155194-759672629 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018596 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 12:30:18.071764) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-23 12:30:18.072073) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6ac30d36c92309de1e179a1dd230c04e14a97f7f --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 6ac30d36c92309de1e179a1dd230c04e14a97f7f --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=ea34ab03e80221fdf844251c000001a3-1464031573.155194-759672629 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-23 12:30:18,658 truncating revision to first 12 chars 2016-05-23 12:30:18,658 Setting DEBUG logging. 2016-05-23 12:30:18,658 attempt 1/10 2016-05-23 12:30:18,658 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6ac30d36c923?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-23 12:30:19,633 unpacking tar archive at: fx-team-6ac30d36c923/testing/mozharness/ program finished with exit code 0 elapsedTime=1.267069 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-23 12:30:19.352029) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 12:30:19.352369) ========= script_repo_revision: 6ac30d36c92309de1e179a1dd230c04e14a97f7f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 12:30:19.352804) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 12:30:19.353079) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 12:30:19.363772) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-05-23 12:30:19.364159) ========= /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=ea34ab03e80221fdf844251c000001a3-1464031573.155194-759672629 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:30:20 INFO - MultiFileLogger online at 20160523 12:30:20 in /builds/slave/test 12:30:20 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 12:30:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:30:20 INFO - {'append_to_log': False, 12:30:20 INFO - 'base_work_dir': '/builds/slave/test', 12:30:20 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:30:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:30:20 INFO - 'branch': 'Fx-Team-Non-PGO', 12:30:20 INFO - 'buildbot_json_path': 'buildprops.json', 12:30:20 INFO - 'config_files': ('talos/linux_config.py',), 12:30:20 INFO - 'default_actions': ('clobber', 12:30:20 INFO - 'read-buildbot-config', 12:30:20 INFO - 'download-and-extract', 12:30:20 INFO - 'populate-webroot', 12:30:20 INFO - 'create-virtualenv', 12:30:20 INFO - 'install', 12:30:20 INFO - 'run-tests'), 12:30:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:30:20 INFO - 'download_minidump_stackwalk': True, 12:30:20 INFO - 'download_symbols': 'ondemand', 12:30:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:30:20 INFO - 'tooltool.py': '/tools/tooltool.py', 12:30:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:30:20 INFO - '/tools/misc-python/virtualenv.py')}, 12:30:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:30:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:30:20 INFO - 'installer_path': 'installer.exe', 12:30:20 INFO - 'log_level': 'info', 12:30:20 INFO - 'log_name': 'talos', 12:30:20 INFO - 'log_to_console': True, 12:30:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:30:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:30:20 INFO - 'opt_config_files': (), 12:30:20 INFO - 'pip_index': False, 12:30:20 INFO - 'sps_profile': False, 12:30:20 INFO - 'sps_profile_interval': 0, 12:30:20 INFO - 'suite': 'dromaeojs', 12:30:20 INFO - 'system_bits': '32', 12:30:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:30:20 INFO - 'title': 'talos-linux64-ix-024', 12:30:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:30:20 INFO - 'use_talos_json': True, 12:30:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:30:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:30:20 INFO - 'work_dir': 'build'} 12:30:20 INFO - ##### 12:30:20 INFO - ##### Running clobber step. 12:30:20 INFO - ##### 12:30:20 INFO - Running pre-action listener: _resource_record_pre_action 12:30:20 INFO - Running main action method: clobber 12:30:20 INFO - rmtree: /builds/slave/test/build 12:30:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:30:20 INFO - Running post-action listener: _resource_record_post_action 12:30:20 INFO - ##### 12:30:20 INFO - ##### Finished clobber step (success) 12:30:20 INFO - ##### 12:30:20 INFO - ##### 12:30:20 INFO - ##### Running read-buildbot-config step. 12:30:20 INFO - ##### 12:30:20 INFO - Running pre-action listener: _resource_record_pre_action 12:30:20 INFO - Running main action method: read_buildbot_config 12:30:20 INFO - Using buildbot properties: 12:30:20 INFO - { 12:30:20 INFO - "project": "", 12:30:20 INFO - "product": "firefox", 12:30:20 INFO - "script_repo_revision": "production", 12:30:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:30:20 INFO - "repository": "", 12:30:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 12:30:20 INFO - "buildid": "20160523104044", 12:30:20 INFO - "pgo_build": "False", 12:30:20 INFO - "basedir": "/builds/slave/test", 12:30:20 INFO - "buildnumber": 1766, 12:30:20 INFO - "slavename": "talos-linux64-ix-024", 12:30:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:30:20 INFO - "platform": "ubuntu64_hw", 12:30:20 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:30:20 INFO - "branch": "fx-team", 12:30:20 INFO - "repo_path": "integration/fx-team", 12:30:20 INFO - "revision": "6ac30d36c92309de1e179a1dd230c04e14a97f7f", 12:30:20 INFO - "stage_platform": "linux64", 12:30:20 INFO - "builduid": "8bfc5daffab44767b7efa10e51005c3a", 12:30:20 INFO - "slavebuilddir": "test" 12:30:20 INFO - } 12:30:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 12:30:20 INFO - Running post-action listener: _resource_record_post_action 12:30:20 INFO - ##### 12:30:20 INFO - ##### Finished read-buildbot-config step (success) 12:30:20 INFO - ##### 12:30:20 INFO - ##### 12:30:20 INFO - ##### Running download-and-extract step. 12:30:20 INFO - ##### 12:30:20 INFO - Running pre-action listener: _resource_record_pre_action 12:30:20 INFO - Running main action method: download_and_extract 12:30:20 INFO - mkdir: /builds/slave/test/build/tests 12:30:20 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')]} 12:30:20 INFO - https://queue.taskcluster.net/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:30:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:30:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:30:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/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 12:30:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/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 12:30:27 INFO - Downloaded 1361 bytes. 12:30:27 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:30:27 INFO - Using the following test package requirements: 12:30:27 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 12:30:27 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:30:27 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:30:27 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:27 INFO - u'jsshell-linux-x86_64.zip'], 12:30:27 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:30:27 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 12:30:27 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:30:27 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:30:27 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:30:27 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:30:27 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:30:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:30:27 INFO - https://queue.taskcluster.net/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:30:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:30:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:30:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/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 12:30:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/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 12:30:28 INFO - Downloaded 22814444 bytes. 12:30:28 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'] 12:30:28 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 12:30:29 INFO - Return code: 0 12:30:29 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 12:30:29 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')]} 12:30:29 INFO - https://queue.taskcluster.net/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:30:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:30:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:30:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/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 12:30:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/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 12:30:36 INFO - Downloaded 22814444 bytes. 12:30:36 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'] 12:30:36 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 12:30:37 INFO - Return code: 0 12:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:30:37 INFO - https://queue.taskcluster.net/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:30:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 12:30:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 12:30:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/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 12:30:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/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 12:30:38 INFO - Downloaded 10840359 bytes. 12:30:38 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'] 12:30:38 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 12:30:39 INFO - Return code: 0 12:30:39 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')]} 12:30:39 INFO - https://queue.taskcluster.net/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:30:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:30:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:30:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/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 12:30:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/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 12:30:40 INFO - Downloaded 54814831 bytes. 12:30:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:30:40 INFO - mkdir: /builds/slave/test/properties 12:30:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:30:40 INFO - Writing to file /builds/slave/test/properties/build_url 12:30:40 INFO - Contents: 12:30:40 INFO - build_url:https://queue.taskcluster.net/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:30:41 INFO - Running post-action listener: _resource_record_post_action 12:30:41 INFO - Running post-action listener: set_extra_try_arguments 12:30:41 INFO - ##### 12:30:41 INFO - ##### Finished download-and-extract step (success) 12:30:41 INFO - ##### 12:30:41 INFO - ##### 12:30:41 INFO - ##### Running populate-webroot step. 12:30:41 INFO - ##### 12:30:41 INFO - Running pre-action listener: _resource_record_pre_action 12:30:41 INFO - Running main action method: populate_webroot 12:30:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:30:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:30:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:30:41 INFO - '--tppagecycles', 12:30:41 INFO - '7'], 12:30:41 INFO - 'tests': ['tsvgm']}}, 12:30:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:30:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:30:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:30:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:30:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:30:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:30:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:30:41 INFO - 'talos_options': ['--disable-e10s'], 12:30:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:30:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:30:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:30:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:30:41 INFO - 'talos_options': ['--disable-e10s'], 12:30:41 INFO - 'tests': ['damp', 'tps']}, 12:30:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:30:41 INFO - 'tests': ['damp', 'tps']}, 12:30:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:30:41 INFO - 'tests': ['dromaeo_dom']}, 12:30:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:30:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:30:41 INFO - 'tests': ['a11yr', 12:30:41 INFO - 'ts_paint', 12:30:41 INFO - 'tpaint', 12:30:41 INFO - 'sessionrestore', 12:30:41 INFO - 'sessionrestore_no_auto_restore', 12:30:41 INFO - 'tabpaint']}, 12:30:41 INFO - 'other-e10s': {'tests': ['a11yr', 12:30:41 INFO - 'ts_paint', 12:30:41 INFO - 'tpaint', 12:30:41 INFO - 'sessionrestore', 12:30:41 INFO - 'sessionrestore_no_auto_restore', 12:30:41 INFO - 'tabpaint']}, 12:30:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:30:41 INFO - 'ts_paint', 12:30:41 INFO - 'tpaint', 12:30:41 INFO - 'sessionrestore', 12:30:41 INFO - 'sessionrestore_no_auto_restore', 12:30:41 INFO - 'tabpaint']}, 12:30:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:30:41 INFO - 'ts_paint', 12:30:41 INFO - 'tpaint', 12:30:41 INFO - 'sessionrestore', 12:30:41 INFO - 'sessionrestore_no_auto_restore', 12:30:41 INFO - 'tabpaint']}, 12:30:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:30:41 INFO - 'tests': ['a11yr', 12:30:41 INFO - 'ts_paint', 12:30:41 INFO - 'tpaint', 12:30:41 INFO - 'sessionrestore', 12:30:41 INFO - 'sessionrestore_no_auto_restore', 12:30:41 INFO - 'tabpaint']}, 12:30:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:30:41 INFO - 'tests': ['a11yr', 12:30:41 INFO - 'ts_paint', 12:30:41 INFO - 'tpaint', 12:30:41 INFO - 'sessionrestore', 12:30:41 INFO - 'sessionrestore_no_auto_restore', 12:30:41 INFO - 'tabpaint']}, 12:30:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:30:41 INFO - 'tests': ['tsvgx', 12:30:41 INFO - 'tsvgr_opacity', 12:30:41 INFO - 'tart', 12:30:41 INFO - 'tscrollx', 12:30:41 INFO - 'cart']}, 12:30:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:30:41 INFO - 'tsvgr_opacity', 12:30:41 INFO - 'tart', 12:30:41 INFO - 'tscrollx', 12:30:41 INFO - 'cart']}, 12:30:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:30:41 INFO - 'talos_options': ['--disable-e10s'], 12:30:41 INFO - 'tests': ['tp5o']}, 12:30:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:30:41 INFO - 'tests': ['tp5o']}, 12:30:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:30:41 INFO - 'talos_options': ['--disable-e10s', 12:30:41 INFO - '--xperf_path', 12:30:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:30:41 INFO - 'tests': ['tp5n']}, 12:30:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:30:41 INFO - 'talos_options': ['--xperf_path', 12:30:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:30:41 INFO - 'tests': ['tp5n']}}, 12:30:41 INFO - 'talos.zip': {'path': '', 12:30:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:30:41 INFO - Running post-action listener: _resource_record_post_action 12:30:41 INFO - ##### 12:30:41 INFO - ##### Finished populate-webroot step (success) 12:30:41 INFO - ##### 12:30:41 INFO - ##### 12:30:41 INFO - ##### Running create-virtualenv step. 12:30:41 INFO - ##### 12:30:41 INFO - Running pre-action listener: _resource_record_pre_action 12:30:41 INFO - Running main action method: create_virtualenv 12:30:41 INFO - Creating virtualenv /builds/slave/test/build/venv 12:30:41 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 12:30:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:30:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:30:41 INFO - Using real prefix '/usr' 12:30:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:30:41 INFO - Installing distribute.............................................................................................................................................................................................done. 12:30:43 INFO - Installing pip.................done. 12:30:43 INFO - Return code: 0 12:30:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:30:43 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')]} 12:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:30:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:43 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')]} 12:30:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:30:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:43 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 0x7fac47ea1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1504770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15939c0>, '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 0x15948c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1594d50>, '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': 'ea34ab03e80221fdf844251c000001a3-1464031573.155194-759672629', '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 12:30:43 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 12:30:43 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 12:30:43 INFO - Using env: {'DISPLAY': ':0', 12:30:43 INFO - 'HOME': '/home/cltbld', 12:30:43 INFO - 'LANG': 'en_US.UTF-8', 12:30:43 INFO - 'LANGUAGE': 'en_US:en', 12:30:43 INFO - 'LOGNAME': 'cltbld', 12:30:43 INFO - 'MAIL': '/var/mail/cltbld', 12:30:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:30:43 INFO - 'MOZ_NO_REMOTE': '1', 12:30:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:30:43 INFO - 'NO_EM_RESTART': '1', 12:30:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:30:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:30:43 INFO - 'PWD': '/builds/slave/test', 12:30:43 INFO - 'SHELL': '/bin/bash', 12:30:43 INFO - 'SHLVL': '1', 12:30:43 INFO - 'TERM': 'linux', 12:30:43 INFO - 'TMOUT': '86400', 12:30:43 INFO - 'USER': 'cltbld', 12:30:43 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1464031573.155194-759672629', 12:30:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:30:43 INFO - '_': '/tools/buildbot/bin/python'} 12:30:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:30:43 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 12:30:43 INFO - Cleaning up... 12:30:43 INFO - Return code: 0 12:30:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:30:43 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')]} 12:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:30:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:43 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')]} 12:30:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:30:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:43 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 0x7fac47ea1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1504770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15939c0>, '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 0x15948c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1594d50>, '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': 'ea34ab03e80221fdf844251c000001a3-1464031573.155194-759672629', '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 12:30:43 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 12:30:43 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 12:30:43 INFO - Using env: {'DISPLAY': ':0', 12:30:43 INFO - 'HOME': '/home/cltbld', 12:30:43 INFO - 'LANG': 'en_US.UTF-8', 12:30:43 INFO - 'LANGUAGE': 'en_US:en', 12:30:43 INFO - 'LOGNAME': 'cltbld', 12:30:43 INFO - 'MAIL': '/var/mail/cltbld', 12:30:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:30:43 INFO - 'MOZ_NO_REMOTE': '1', 12:30:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:30:43 INFO - 'NO_EM_RESTART': '1', 12:30:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:30:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:30:43 INFO - 'PWD': '/builds/slave/test', 12:30:43 INFO - 'SHELL': '/bin/bash', 12:30:43 INFO - 'SHLVL': '1', 12:30:43 INFO - 'TERM': 'linux', 12:30:43 INFO - 'TMOUT': '86400', 12:30:43 INFO - 'USER': 'cltbld', 12:30:43 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1464031573.155194-759672629', 12:30:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:30:43 INFO - '_': '/tools/buildbot/bin/python'} 12:30:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:30:44 INFO - Downloading/unpacking psutil>=3.1.1 12:30:44 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 12:30:44 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 12:30:44 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 12:30:44 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 12:30:44 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 12:30:44 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 12:30:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:30:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:30:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:30:46 INFO - Installing collected packages: psutil 12:30:46 INFO - Running setup.py install for psutil 12:30:46 INFO - building 'psutil._psutil_linux' extension 12:30:46 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 12:30:46 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 12:30:46 INFO - building 'psutil._psutil_posix' extension 12:30:46 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 12:30:46 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 12:30:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:30:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:30:46 INFO - Successfully installed psutil 12:30:46 INFO - Cleaning up... 12:30:46 INFO - Return code: 0 12:30:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:30: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')]} 12:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:30:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30: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')]} 12:30:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:30:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac47ea1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1504770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15939c0>, '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 0x15948c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1594d50>, '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': 'ea34ab03e80221fdf844251c000001a3-1464031573.155194-759672629', '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 12:30: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:30: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 mozsystemmonitor==0.3 12:30:46 INFO - Using env: {'DISPLAY': ':0', 12:30:46 INFO - 'HOME': '/home/cltbld', 12:30:46 INFO - 'LANG': 'en_US.UTF-8', 12:30:46 INFO - 'LANGUAGE': 'en_US:en', 12:30:46 INFO - 'LOGNAME': 'cltbld', 12:30:46 INFO - 'MAIL': '/var/mail/cltbld', 12:30:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:30:46 INFO - 'MOZ_NO_REMOTE': '1', 12:30:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:30:46 INFO - 'NO_EM_RESTART': '1', 12:30:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:30:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:30:46 INFO - 'PWD': '/builds/slave/test', 12:30:46 INFO - 'SHELL': '/bin/bash', 12:30:46 INFO - 'SHLVL': '1', 12:30:46 INFO - 'TERM': 'linux', 12:30:46 INFO - 'TMOUT': '86400', 12:30:46 INFO - 'USER': 'cltbld', 12:30:46 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1464031573.155194-759672629', 12:30:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:30:46 INFO - '_': '/tools/buildbot/bin/python'} 12:30:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:30:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:30:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:30:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:30:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:30:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:30:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:30:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:30:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:30:48 INFO - Installing collected packages: mozsystemmonitor 12:30:48 INFO - Running setup.py install for mozsystemmonitor 12:30:49 INFO - Successfully installed mozsystemmonitor 12:30:49 INFO - Cleaning up... 12:30:49 INFO - Return code: 0 12:30:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:30: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')]} 12:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:30:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30: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')]} 12:30:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:30:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30: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', '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 0x7fac47ea1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1504770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15939c0>, '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 0x15948c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1594d50>, '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': 'ea34ab03e80221fdf844251c000001a3-1464031573.155194-759672629', '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 12:30: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:30: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 blobuploader==1.2.4 12:30:49 INFO - Using env: {'DISPLAY': ':0', 12:30:49 INFO - 'HOME': '/home/cltbld', 12:30:49 INFO - 'LANG': 'en_US.UTF-8', 12:30:49 INFO - 'LANGUAGE': 'en_US:en', 12:30:49 INFO - 'LOGNAME': 'cltbld', 12:30:49 INFO - 'MAIL': '/var/mail/cltbld', 12:30:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:30:49 INFO - 'MOZ_NO_REMOTE': '1', 12:30:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:30:49 INFO - 'NO_EM_RESTART': '1', 12:30:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:30:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:30:49 INFO - 'PWD': '/builds/slave/test', 12:30:49 INFO - 'SHELL': '/bin/bash', 12:30:49 INFO - 'SHLVL': '1', 12:30:49 INFO - 'TERM': 'linux', 12:30:49 INFO - 'TMOUT': '86400', 12:30:49 INFO - 'USER': 'cltbld', 12:30:49 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1464031573.155194-759672629', 12:30:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:30:49 INFO - '_': '/tools/buildbot/bin/python'} 12:30:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:30:49 INFO - Downloading/unpacking blobuploader==1.2.4 12:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:30:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:30:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:30:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:30:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:30:51 INFO - Downloading blobuploader-1.2.4.tar.gz 12:30:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:30:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:30:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:30:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:30:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:30:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:30:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:30:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:30:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:30:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:30:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:30:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:30:51 INFO - Downloading docopt-0.6.1.tar.gz 12:30:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:30:51 INFO - Installing collected packages: blobuploader, requests, docopt 12:30:51 INFO - Running setup.py install for blobuploader 12:30:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:30:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:30:52 INFO - Running setup.py install for requests 12:30:52 INFO - Running setup.py install for docopt 12:30:52 INFO - Successfully installed blobuploader requests docopt 12:30:52 INFO - Cleaning up... 12:30:52 INFO - Return code: 0 12:30:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:30: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')]} 12:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:30:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30: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')]} 12:30:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:30:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:52 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 0x7fac47ea1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1504770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15939c0>, '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 0x15948c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1594d50>, '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': 'ea34ab03e80221fdf844251c000001a3-1464031573.155194-759672629', '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 12:30:52 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 12:30:52 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 12:30:52 INFO - Using env: {'DISPLAY': ':0', 12:30:52 INFO - 'HOME': '/home/cltbld', 12:30:52 INFO - 'LANG': 'en_US.UTF-8', 12:30:52 INFO - 'LANGUAGE': 'en_US:en', 12:30:52 INFO - 'LOGNAME': 'cltbld', 12:30:52 INFO - 'MAIL': '/var/mail/cltbld', 12:30:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:30:52 INFO - 'MOZ_NO_REMOTE': '1', 12:30:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:30:52 INFO - 'NO_EM_RESTART': '1', 12:30:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:30:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:30:52 INFO - 'PWD': '/builds/slave/test', 12:30:52 INFO - 'SHELL': '/bin/bash', 12:30:52 INFO - 'SHLVL': '1', 12:30:52 INFO - 'TERM': 'linux', 12:30:52 INFO - 'TMOUT': '86400', 12:30:52 INFO - 'USER': 'cltbld', 12:30:52 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1464031573.155194-759672629', 12:30:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:30:52 INFO - '_': '/tools/buildbot/bin/python'} 12:30:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:30:52 INFO - Running setup.py (path:/tmp/pip-DhN_TW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:30:52 INFO - Running setup.py (path:/tmp/pip-cp5jO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:30:52 INFO - Running setup.py (path:/tmp/pip-6hb42u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:30:53 INFO - Running setup.py (path:/tmp/pip-yCYyV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:30:53 INFO - Running setup.py (path:/tmp/pip-PrvCE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:30:53 INFO - Running setup.py (path:/tmp/pip-u2fnnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:30:53 INFO - Running setup.py (path:/tmp/pip-P57Oc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:30:53 INFO - Running setup.py (path:/tmp/pip-ZFnPEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:30:53 INFO - Running setup.py (path:/tmp/pip-NuapD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:30:53 INFO - Running setup.py (path:/tmp/pip-6a6D_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:30:53 INFO - Running setup.py (path:/tmp/pip-9LVm2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:30:53 INFO - Running setup.py (path:/tmp/pip-l_Gm0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:30:53 INFO - Running setup.py (path:/tmp/pip-FtiJUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:30:53 INFO - Running setup.py (path:/tmp/pip-lxfkzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:30:53 INFO - Running setup.py (path:/tmp/pip-83ogaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:30:53 INFO - Running setup.py (path:/tmp/pip-yilEh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:30:53 INFO - Running setup.py (path:/tmp/pip-OED49f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:30:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:30:54 INFO - Running setup.py install for manifestparser 12:30:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:30:54 INFO - Running setup.py install for mozcrash 12:30:54 INFO - Running setup.py install for mozdebug 12:30:54 INFO - Running setup.py install for mozdevice 12:30:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:30:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:30:54 INFO - Running setup.py install for mozfile 12:30:54 INFO - Running setup.py install for mozhttpd 12:30:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:30:54 INFO - Running setup.py install for mozinfo 12:30:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:30:54 INFO - Running setup.py install for mozInstall 12:30:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:30:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:30:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:30:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:30:54 INFO - Running setup.py install for mozleak 12:30:54 INFO - Running setup.py install for mozlog 12:30:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:30:55 INFO - Running setup.py install for moznetwork 12:30:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:30:55 INFO - Running setup.py install for mozprocess 12:30:55 INFO - Running setup.py install for mozprofile 12:30:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:30:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:30:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:30:55 INFO - Running setup.py install for mozrunner 12:30:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:30:55 INFO - Running setup.py install for mozscreenshot 12:30:55 INFO - Running setup.py install for moztest 12:30:55 INFO - Running setup.py install for mozversion 12:30:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:30:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:30:55 INFO - Cleaning up... 12:30:55 INFO - Return code: 0 12:30:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:30: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')]} 12:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:30:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30: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')]} 12:30:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:30:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:55 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 0x7fac47ea1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1504770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15939c0>, '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 0x15948c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1594d50>, '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': 'ea34ab03e80221fdf844251c000001a3-1464031573.155194-759672629', '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 12:30:55 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 12:30:55 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 12:30:55 INFO - Using env: {'DISPLAY': ':0', 12:30:55 INFO - 'HOME': '/home/cltbld', 12:30:55 INFO - 'LANG': 'en_US.UTF-8', 12:30:55 INFO - 'LANGUAGE': 'en_US:en', 12:30:55 INFO - 'LOGNAME': 'cltbld', 12:30:55 INFO - 'MAIL': '/var/mail/cltbld', 12:30:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:30:55 INFO - 'MOZ_NO_REMOTE': '1', 12:30:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:30:55 INFO - 'NO_EM_RESTART': '1', 12:30:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:30:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:30:55 INFO - 'PWD': '/builds/slave/test', 12:30:55 INFO - 'SHELL': '/bin/bash', 12:30:55 INFO - 'SHLVL': '1', 12:30:55 INFO - 'TERM': 'linux', 12:30:55 INFO - 'TMOUT': '86400', 12:30:55 INFO - 'USER': 'cltbld', 12:30:55 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1464031573.155194-759672629', 12:30:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:30:55 INFO - '_': '/tools/buildbot/bin/python'} 12:30:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:30:56 INFO - Running setup.py (path:/tmp/pip-aZMLAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:30:56 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)) 12:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:30:56 INFO - Running setup.py (path:/tmp/pip-kgujjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:30:56 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)) 12:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:30:56 INFO - Running setup.py (path:/tmp/pip-znZk8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:30:56 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)) 12:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:30:56 INFO - Running setup.py (path:/tmp/pip-a0VlIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:30:56 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)) 12:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:30:56 INFO - Running setup.py (path:/tmp/pip-589AY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:30:56 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)) 12:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:30:56 INFO - Running setup.py (path:/tmp/pip-6uP14q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:30:56 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)) 12:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:30:56 INFO - Running setup.py (path:/tmp/pip-gihQd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:30:56 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)) 12:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:30:56 INFO - Running setup.py (path:/tmp/pip-0vT0Xe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:30:56 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)) 12:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:30:56 INFO - Running setup.py (path:/tmp/pip-DMImY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:30:56 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)) 12:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:30:56 INFO - Running setup.py (path:/tmp/pip-7Ny0MM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:30:56 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)) 12:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:30:56 INFO - Running setup.py (path:/tmp/pip-YexAPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:30:56 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)) 12:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:30:56 INFO - Running setup.py (path:/tmp/pip-nKdoa5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:30:56 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)) 12:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:30:56 INFO - Running setup.py (path:/tmp/pip-AsH9ih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:30:56 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)) 12:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:30:56 INFO - Running setup.py (path:/tmp/pip-LMZXuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:30:57 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)) 12:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:30:57 INFO - Running setup.py (path:/tmp/pip-vi1nHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:30:57 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)) 12:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:30:57 INFO - Running setup.py (path:/tmp/pip-NQk3Fa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:30:57 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)) 12:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:30:57 INFO - Running setup.py (path:/tmp/pip-1HxrmH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:30:57 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)) 12:30:57 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)) 12:30:57 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)) 12:30:57 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)) 12:30:57 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)) 12:30:57 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)) 12:30:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:30:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:30:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:30:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:30:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:30:59 INFO - Downloading blessings-1.6.tar.gz 12:30:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:30:59 INFO - Installing collected packages: blessings 12:30:59 INFO - Running setup.py install for blessings 12:30:59 INFO - Successfully installed blessings 12:30:59 INFO - Cleaning up... 12:30:59 INFO - Return code: 0 12:30:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:30:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:30:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:30:59 INFO - Reading from file tmpfile_stdout 12:30:59 INFO - Current package versions: 12:30:59 INFO - argparse == 1.2.1 12:30:59 INFO - blessings == 1.6 12:30:59 INFO - blobuploader == 1.2.4 12:30:59 INFO - docopt == 0.6.1 12:30:59 INFO - manifestparser == 1.1 12:30:59 INFO - mozInstall == 1.12 12:30:59 INFO - mozcrash == 0.17 12:30:59 INFO - mozdebug == 0.1 12:30:59 INFO - mozdevice == 0.48 12:30:59 INFO - mozfile == 1.2 12:30:59 INFO - mozhttpd == 0.7 12:30:59 INFO - mozinfo == 0.9 12:30:59 INFO - mozleak == 0.1 12:30:59 INFO - mozlog == 3.2 12:30:59 INFO - moznetwork == 0.27 12:30:59 INFO - mozprocess == 0.22 12:30:59 INFO - mozprofile == 0.28 12:30:59 INFO - mozrunner == 6.11 12:30:59 INFO - mozscreenshot == 0.1 12:30:59 INFO - mozsystemmonitor == 0.3 12:30:59 INFO - moztest == 0.7 12:30:59 INFO - mozversion == 1.4 12:30:59 INFO - psutil == 3.1.1 12:30:59 INFO - requests == 1.2.3 12:30:59 INFO - wsgiref == 0.1.2 12:30:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:30:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:30:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:30:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:30:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:59 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 0x7fac47ea1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1504770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15939c0>, '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 0x15948c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1594d50>, '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': 'ea34ab03e80221fdf844251c000001a3-1464031573.155194-759672629', '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 12:30:59 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 12:30:59 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 12:30:59 INFO - Using env: {'DISPLAY': ':0', 12:30:59 INFO - 'HOME': '/home/cltbld', 12:30:59 INFO - 'LANG': 'en_US.UTF-8', 12:30:59 INFO - 'LANGUAGE': 'en_US:en', 12:30:59 INFO - 'LOGNAME': 'cltbld', 12:30:59 INFO - 'MAIL': '/var/mail/cltbld', 12:30:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:30:59 INFO - 'MOZ_NO_REMOTE': '1', 12:30:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:30:59 INFO - 'NO_EM_RESTART': '1', 12:30:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:30:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:30:59 INFO - 'PWD': '/builds/slave/test', 12:30:59 INFO - 'SHELL': '/bin/bash', 12:30:59 INFO - 'SHLVL': '1', 12:30:59 INFO - 'TERM': 'linux', 12:30:59 INFO - 'TMOUT': '86400', 12:30:59 INFO - 'USER': 'cltbld', 12:30:59 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1464031573.155194-759672629', 12:30:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:30:59 INFO - '_': '/tools/buildbot/bin/python'} 12:30:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:30:59 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)) 12:30:59 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)) 12:30:59 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)) 12:30:59 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)) 12:30:59 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)) 12:30:59 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)) 12:30:59 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)) 12:30:59 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)) 12:30:59 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)) 12:30:59 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)) 12:30:59 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)) 12:30:59 INFO - Cleaning up... 12:30:59 INFO - Return code: 0 12:30:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:30:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:30:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:30:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:30:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac47ea1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1504770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15939c0>, '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 0x15948c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1594d50>, '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': 'ea34ab03e80221fdf844251c000001a3-1464031573.155194-759672629', '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 12:30:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:30:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:30:59 INFO - Using env: {'DISPLAY': ':0', 12:30:59 INFO - 'HOME': '/home/cltbld', 12:30:59 INFO - 'LANG': 'en_US.UTF-8', 12:30:59 INFO - 'LANGUAGE': 'en_US:en', 12:30:59 INFO - 'LOGNAME': 'cltbld', 12:30:59 INFO - 'MAIL': '/var/mail/cltbld', 12:30:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:30:59 INFO - 'MOZ_NO_REMOTE': '1', 12:30:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:30:59 INFO - 'NO_EM_RESTART': '1', 12:30:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:30:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:30:59 INFO - 'PWD': '/builds/slave/test', 12:30:59 INFO - 'SHELL': '/bin/bash', 12:30:59 INFO - 'SHLVL': '1', 12:30:59 INFO - 'TERM': 'linux', 12:30:59 INFO - 'TMOUT': '86400', 12:30:59 INFO - 'USER': 'cltbld', 12:30:59 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1464031573.155194-759672629', 12:30:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:30:59 INFO - '_': '/tools/buildbot/bin/python'} 12:31:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:00 INFO - Downloading/unpacking jsonschema 12:31: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 12:31: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 12:31: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 12:31: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 12:31: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 12:31: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 12:31:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:31:01 INFO - Downloading/unpacking functools32 (from jsonschema) 12:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:02 INFO - Downloading functools32-3.2.3-2.tar.gz 12:31:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:31:02 INFO - warning: no files found matching '*.txt' 12:31:02 INFO - no previously-included directories found matching 'build' 12:31:02 INFO - no previously-included directories found matching 'dist' 12:31:02 INFO - no previously-included directories found matching '.git*' 12:31:02 INFO - Installing collected packages: jsonschema, functools32 12:31:02 INFO - Running setup.py install for functools32 12:31:02 INFO - warning: no files found matching '*.txt' 12:31:02 INFO - no previously-included directories found matching 'build' 12:31:02 INFO - no previously-included directories found matching 'dist' 12:31:02 INFO - no previously-included directories found matching '.git*' 12:31:02 INFO - Successfully installed jsonschema functools32 12:31:02 INFO - Cleaning up... 12:31:02 INFO - Return code: 0 12:31:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:31: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')]} 12:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31: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')]} 12:31:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac47ea1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1504770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15939c0>, '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 0x15948c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1594d50>, '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': 'ea34ab03e80221fdf844251c000001a3-1464031573.155194-759672629', '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 12:31: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', 'flake8'] in /builds/slave/test/build 12:31: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 flake8 12:31:02 INFO - Using env: {'DISPLAY': ':0', 12:31:02 INFO - 'HOME': '/home/cltbld', 12:31:02 INFO - 'LANG': 'en_US.UTF-8', 12:31:02 INFO - 'LANGUAGE': 'en_US:en', 12:31:02 INFO - 'LOGNAME': 'cltbld', 12:31:02 INFO - 'MAIL': '/var/mail/cltbld', 12:31:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:02 INFO - 'MOZ_NO_REMOTE': '1', 12:31:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:02 INFO - 'NO_EM_RESTART': '1', 12:31:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:02 INFO - 'PWD': '/builds/slave/test', 12:31:02 INFO - 'SHELL': '/bin/bash', 12:31:02 INFO - 'SHLVL': '1', 12:31:02 INFO - 'TERM': 'linux', 12:31:02 INFO - 'TMOUT': '86400', 12:31:02 INFO - 'USER': 'cltbld', 12:31:02 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1464031573.155194-759672629', 12:31:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:02 INFO - '_': '/tools/buildbot/bin/python'} 12:31:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:02 INFO - Downloading/unpacking flake8 12:31:02 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 12:31:02 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 12:31:02 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 12:31:02 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 12:31:02 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 12:31:02 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 12:31:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:31:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:31: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 12:31: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 12:31: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 12:31: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 12:31: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 12:31: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 12:31:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:31:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:31: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 12:31: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 12:31: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 12:31: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 12:31: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 12:31: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 12:31:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:31: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 12:31: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 12:31: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 12:31: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 12:31: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 12:31: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 12:31:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:31:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:31:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:31:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:31:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:31:05 INFO - no previously-included directories found matching 'docs/_build' 12:31:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:31:05 INFO - Running setup.py install for pep8 12:31:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:31:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:31:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:31:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:31:05 INFO - no previously-included directories found matching 'docs/_build' 12:31:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:31:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:31:05 INFO - Cleaning up... 12:31:05 INFO - Return code: 0 12:31:05 INFO - Running post-action listener: _resource_record_post_action 12:31:05 INFO - Running post-action listener: _start_resource_monitoring 12:31:05 INFO - Starting resource monitoring. 12:31:05 INFO - ##### 12:31:05 INFO - ##### Finished create-virtualenv step (success) 12:31:05 INFO - ##### 12:31:05 INFO - ##### 12:31:05 INFO - ##### Running install step. 12:31:05 INFO - ##### 12:31:05 INFO - Running pre-action listener: _resource_record_pre_action 12:31:05 INFO - Running main action method: install 12:31:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:31:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:31:05 INFO - Reading from file tmpfile_stdout 12:31:05 INFO - Detecting whether we're running mozinstall >=1.0... 12:31:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:31:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:31:05 INFO - Reading from file tmpfile_stdout 12:31:05 INFO - Output received: 12:31:05 INFO - Usage: mozinstall [options] installer 12:31:05 INFO - Options: 12:31:05 INFO - -h, --help show this help message and exit 12:31:05 INFO - -d DEST, --destination=DEST 12:31:05 INFO - Directory to install application into. [default: 12:31:05 INFO - "/builds/slave/test"] 12:31:05 INFO - --app=APP Application being installed. [default: firefox] 12:31:05 INFO - mkdir: /builds/slave/test/build/application 12:31:05 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'] 12:31:05 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 12:31:21 INFO - Reading from file tmpfile_stdout 12:31:21 INFO - Output received: 12:31:21 INFO - /builds/slave/test/build/application/firefox/firefox 12:31:21 INFO - Running post-action listener: _resource_record_post_action 12:31:21 INFO - ##### 12:31:21 INFO - ##### Finished install step (success) 12:31:21 INFO - ##### 12:31:21 INFO - ##### 12:31:21 INFO - ##### Running run-tests step. 12:31:21 INFO - ##### 12:31:21 INFO - Running pre-action listener: _resource_record_pre_action 12:31:21 INFO - Running main action method: run_tests 12:31:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:31:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:31:21 INFO - Python 2.7.3 12:31:21 INFO - Return code: 0 12:31:21 INFO - grabbing minidump binary from tooltool 12:31:21 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')]} 12:31:21 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 0x15939c0>, '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 0x15948c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1594d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:31:21 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 12:31:21 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 12:31:21 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 12:31:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:31:21 INFO - Return code: 0 12:31:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:31:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:31:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:31:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:31:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:31:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:31:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:31:22 INFO - Return code: 0 12:31:22 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/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 12:31:22 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/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --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 12:31:22 INFO - Using env: {'DISPLAY': ':0', 12:31:22 INFO - 'HOME': '/home/cltbld', 12:31:22 INFO - 'LANG': 'en_US.UTF-8', 12:31:22 INFO - 'LANGUAGE': 'en_US:en', 12:31:22 INFO - 'LOGNAME': 'cltbld', 12:31:22 INFO - 'MAIL': '/var/mail/cltbld', 12:31:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:31:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:31:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:22 INFO - 'MOZ_NO_REMOTE': '1', 12:31:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:31:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:22 INFO - 'NO_EM_RESTART': '1', 12:31:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:22 INFO - 'PWD': '/builds/slave/test', 12:31:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:31:22 INFO - 'SHELL': '/bin/bash', 12:31:22 INFO - 'SHLVL': '1', 12:31:22 INFO - 'TERM': 'linux', 12:31:22 INFO - 'TMOUT': '86400', 12:31:22 INFO - 'USER': 'cltbld', 12:31:22 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1464031573.155194-759672629', 12:31:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:22 INFO - '_': '/tools/buildbot/bin/python'} 12:31:22 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/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 12:31:22 INFO - mozversion application_buildid: 20160523104044 12:31:22 INFO - mozversion application_changeset: 6ac30d36c92309de1e179a1dd230c04e14a97f7f 12:31:22 INFO - mozversion application_display_name: Nightly 12:31:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:31:22 INFO - mozversion application_name: Firefox 12:31:22 INFO - mozversion application_remotingname: firefox 12:31:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:31:22 INFO - mozversion application_vendor: Mozilla 12:31:22 INFO - mozversion application_version: 49.0a1 12:31:22 INFO - mozversion platform_buildid: 20160523104044 12:31:22 INFO - mozversion platform_changeset: 6ac30d36c92309de1e179a1dd230c04e14a97f7f 12:31:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:31:22 INFO - mozversion platform_version: 49.0a1 12:31:22 INFO - using testdate: 1464031882 12:31:22 INFO - actual date: 1464031882 12:31:22 INFO - starting webserver on 'localhost:40793' 12:31:22 INFO - SUITE-START | Running 2 tests 12:31:22 INFO - TEST-START | dromaeo_css 12:31:22 INFO - operating with platform_type : linux_ 12:31:22 INFO - Initialising browser for dromaeo_css test... 12:31:22 INFO - TEST-INFO | started process 32610 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ91tKP/profile http://localhost:40793/getInfo.html) 12:31:27 INFO - PROCESS | 32610 | __metrics Screen width/height:1600/1200 12:31:27 INFO - PROCESS | 32610 | colorDepth:24 12:31:27 INFO - PROCESS | 32610 | Browser inner width/height: 1024/697 12:31:27 INFO - PROCESS | 32610 | __metrics 12:31:28 ERROR - PROCESS | 32610 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:31:29 INFO - TEST-INFO | 32610: exit 0 12:31:29 INFO - Browser initialized. 12:31:29 INFO - Running cycle 1/1 for dromaeo_css test... 12:31:29 INFO - TEST-INFO | started process 32694 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ91tKP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:31:41 INFO - PROCESS | 32694 | RSS: Main: 154750976 12:31:41 INFO - PROCESS | 32694 | 12:32:32 INFO - PROCESS | 32694 | 1464031952720 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] 12:34:44 INFO - PROCESS | 32694 | Cycle 1(1): loaded http://localhost:40793/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40793/tests/dromaeo/cssquery-ext.html) 12:34:45 INFO - PROCESS | 32694 | RSS: Main: 234381312 12:34:45 INFO - PROCESS | 32694 | 12:37:47 INFO - PROCESS | 32694 | Cycle 1(1): loaded http://localhost:40793/tests/dromaeo/cssquery-ext.html (next: http://localhost:40793/tests/dromaeo/cssquery-jquery.html) 12:37:48 INFO - PROCESS | 32694 | RSS: Main: 241684480 12:37:48 INFO - PROCESS | 32694 | 12:40:50 INFO - PROCESS | 32694 | Cycle 1(1): loaded http://localhost:40793/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40793/tests/dromaeo/cssquery-mootools.html) 12:40:51 INFO - PROCESS | 32694 | RSS: Main: 239054848 12:40:51 INFO - PROCESS | 32694 | 12:43:53 INFO - PROCESS | 32694 | Cycle 1(1): loaded http://localhost:40793/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40793/tests/dromaeo/cssquery-prototype.html) 12:43:53 INFO - PROCESS | 32694 | RSS: Main: 235442176 12:43:53 INFO - PROCESS | 32694 | 12:46:56 INFO - PROCESS | 32694 | Cycle 1(1): loaded http://localhost:40793/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40793/tests/dromaeo/cssquery-yui.html) 12:46:57 INFO - PROCESS | 32694 | RSS: Main: 208584704 12:46:57 INFO - PROCESS | 32694 | 12:49:59 INFO - PROCESS | 32694 | Cycle 1(1): loaded http://localhost:40793/tests/dromaeo/cssquery-yui.html (next: http://localhost:40793/tests/dromaeo/cssquery-dojo.html) 12:50:00 INFO - PROCESS | 32694 | RSS: Main: 261881856 12:50:00 INFO - PROCESS | 32694 | 12:50:00 INFO - PROCESS | 32694 | __start_tp_report 12:50:00 INFO - PROCESS | 32694 | _x_x_mozilla_page_load 12:50:00 INFO - PROCESS | 32694 | _x_x_mozilla_page_load_details 12:50:00 INFO - PROCESS | 32694 | |i|pagename|runs| 12:50:00 INFO - PROCESS | 32694 | |0;dojo.html;2655.9867200663994;2682.570788673813;2706.8240564363314;2708.3499960009603;2717.3070866928942;4668.18306796311;4688.789004494797;4718.976405117974;4738.9526104739025;4797.664163508556;4677.087967846272;4683.086798074377;4763.285507173926;4772.78522466489;4832.299316599091;4276.337167739005;4337.1325734853;4352.042550638855;4374.278244089737;4564.178447879381;4465.665075119363;4499.280115181556;4506.346579745935;4524.298733696266;4562.885927851797;4302.569743025703;4351.608355248011;4383.408239887606;4398.846040388603;4441.489228738672;4379.211741886459;4385.649148068147;4391.077873646538;4489.057297967431;4494.550544945512;4408.647308215335;4413.249747542925;4421.911561768747;4429.3798868158165;4467.932981005288;4536.364908912755;4616.630669546428;4671.719696818202;4709.364235828154;4764.190087685067;5138.229265610151;5188.481151884819;5200.765965531522;5210.270562121306;5213.452587478336;5156.92264616031;5197.376314842243;5222.321098257202;5237.921431178497;5244.344456942882;4627.421572303462;4751.857444276678;4815.95184048155;4817.879553011133;4867;5270.209468579667;5274.7626356814035;5286.920696189561;5346.492083252085;5361.973190134025;5089.923651145235;5115.539601435814;5133.563647089964;5136.743162841918;5137.717425541631;4937.530934561211;5038.899222015612;5097.0060838136205;5099.949000509948;5124.743762811919;5057.620678449131;5085.313482679865;5086.796528138833;5086.949130508721;5143.151380022329;4973.204287314013;5041.966396888629;5045.217991211368;5047.772850221749;5050.141475949097;4274.658027357804;4325.307950727868;4328.458942632171;4330.090680957034;4331.7184383015;3772.7170462215445;3786.8295926683363;3788.355979483439;3800.638939300762;3829.119302560371;4330.956690433055;4370;4488.9102217956115;4499.617532509773;4522.321651752263;5097.311862898536;5144.562712169432;5155.922661160085;5172.379314482287;5182.196759502283;4426.623736982393;4453.955460445419;4456.532064133284;4470.821167153343;4506.504284528699;4511.436070491189;4533.252013417815;4604.838830640979;4609.608183304456;4651.790669419885;4840.08038472682;4856.975715121402;4869.293952376815;4872.756362181806;4915.729634870117;5054.60529596572;5073.59411247092;5081.92377114351;5088.643794934319;5133.743312834418;4721.9055618888115;4807.7836497357;4828.227483602606;4838.104950584153;4879.170541007966;5034.471380504994;5055.873603159804;5063.544281014726;5064.721440320818;5117.411497677815;5152.76812543444;5161.354830646169;5162.5869930406225;5165.173572228426;5171.896562068662;4776.140294746979;4947.60419166473;5003.699778013185;5013.899722005613;5021.548060674557;4969.105560999054;4991.301217829579;5002.124628190125;5017.147084995487;5059.974700126623;4933.679310844927;4933.975330123327;4948.678335908155;4993.051320249141;5006.549410552922;4908.680935739166;4943.629227807857;4970.826021089245;4984.750762461935;5015.84952451427;4898.53463920927;4919.458859525521;4924.064427758714;4925.556699897026;4953.108440480604 12:50:00 INFO - PROCESS | 32694 | |1;ext.html;549.7276811949637;563.4844117632366;580.0834681203696;582.2372691773774;593.6972144206457;39586.20827583447;40897.3865392019;40931.59068409315;44692.3296150558;44838.55161448385;41377.37933930986;41631.16737665253;41761.79119104408;41908.16183676325;41984.370234446505;7682.769516914487;7830.412719046066;7843.058832940055;7850.293473587376;7854.764357069297;7763.262490063435;7825.217478252186;7835.882461763078;7855.725049623265;7860.606969651494;7853.607319633996;7908.762737117896;7931.6034198290145;7934.960325198366;7935.404844636647;7774.805629859242;7871.8032049198655;7873.5275883447175;7881.724139655084;7885.329746971514;7624.733134340327;7762.728304509372;7797.532148071134;7799.337056350217;7806.102298235719;39131.80434097811;39193;39217.90167278264;39331.41002884931;39433.40849887254;3254.6908043735807;3286.3098749262685;3335.4163021471386;3343.4650455926935;3779.130799916035;29171.708282917323;29749;29830.25896325169;30096;30940;3375.375555522236;3395.2530443302435;3416.0605833395766;3482;3543.85824567017;264264;365580.1720991378;371406;372139;372320;52287;56123.438765612635;56126.43873561294;56568.151477727864;56690;57444.42555574475;58303.70848145817;58492.7075364629;62797;63003.36996629975;11852.466639001266;11853.940730296294;11878;11878.465469053914;11887.76224475523;8345.207205315486;9013.143751343612;9118.544072796467;9139.817203656023;9230.907690923139;17928.55178620519;18128.27486900509;18261.178246978652;18285.817141828677;18297.35959241447;6924.723011079601;7045.626102909883;7110.57336559808;7231;7355.411567074621;814.6252723747024;910.526526206369;918.2975024106564;931.101487064972;1065.8028264771042;27668.44663106767;28374.574381384296;28377.155484893417;28422.43155136927;28681.42637147287;902.2195800632405;964.8215080210043;973.8685277487449;1001.3040936549174;1010.8938561451089;14827.258637068104;14890.702185956221;15114.09315441077;15304.464343748137;15365.846341536666;379235;383468;383968;385329;386362;49525.257121143215;49896.50103498991;49964.25053624198;49996.50003499918;50020.249696254585;1109.0794640448407;1176.9588064417876;1217.062861596548;1222.5965431407615;1224.4489979509078;27495.175144745688;28576.714232858238;28852.134435966953;29050.564241535973;29405.705942940298;41683.20643126079;42240.577594223665;42246.366304506075;42246.366304506075;42254.78872605618;304179;306492;306672;307487;308307;20511.18019251736;24490.265292041266;25234.116805911704;25911.093111741;26447.33881652974;41275;41544.169116618104;41718.79140604277;42291.36562951496;42795.786021069696;35821.28357432889;36050.819745901106;36053;36262.8186859064;36910.63089369072;35646;35890.4616430759;35984.640153599175;36493;36544.81727591345;35670.64329356673;35694;38114.80942595269;38694.61305387023;39565;32031;33404.665953340154;33487;33724.3255134891;33777.662223377454;24337.14819981292;24857.378565536008;25244.242672719847;25694.229173124088;25744.8712756435 12:50:00 INFO - PROCESS | 32694 | |2;jquery.html;364.35327294053053;368.98339574719137;371.73792476304203;374.7039838527563;377.3264722470391;16467;17043.914780426112;17128.31486740529;17477.213525391355;17486.038267895277;16007.519774406757;16283.348666053344;17017.57456063599;17122.31510739569;17160.39938602149;4930.235813448921;5074.238864170386;5080.872978175556;5115.693058416488;5130.3074084998425;3633.563972323325;3853.3064048471265;4992.575631071363;5627.2684551008315;5960.493358064569;6016.518678505731;6029.638221706711;6049.909251361233;6057.666828324463;6060.272767267912;5869.266341707286;5914.585978981473;6019.849503762397;6037.63774173551;6045.758169673208;3270.885519006847;4958.157113290749;5265.183896496011;5278.392984806758;5300.284461597674;19384.224631014742;20165.09257083435;20168.394948151432;20173.5965280695;20187.39437816853;1910.2550005497867;1971.7387421358724;2040.7142999980015;2143.678448232762;2319.373769082355;12745.299008554619;12909.354532273443;13039.348032598333;13140.277284749334;13363.265020423873;1750.0724615953566;1828.9817101829078;1998.8500862435376;2012.2471590483788;2058.7941205879442;67115.66442167807;67195.32804671988;67379;67906;68924.31075689229;10031.498425078717;10061.496925153859;10204.336718113447;10305;10385.740356490996;14179.22014289224;14207.289635518182;14278.643033924234;14284.500042498463;14286.642833929027;6511.0558968949235;6612;6620.933790662128;6666.666666666647;6702.698378572976;5885.176075349455;6020.69896505173;6092.573519853568;6106.755729770848;6107.236595425572;4342.934855977162;4464.352668862996;4485.865424037284;4554.225781617133;4560.247559152769;1711.3496871189118;1741.7735694359906;1819.9490215914577;1840.720699114103;1850.288483153078;886.6187539358137;889.2707979456912;892.1970226795936;895.1630225738955;944.6410364061612;16025.599360016093;16760.1619919006;16781.748273775902;16866.694711835982;16892.57768555796;864.9610767515477;883.8895138107737;894.5035505294624;925.0564424287189;959.0553304994575;9212.401193922373;9524.476153811469;9562.569684364082;9582.233421326277;9660;393966;394894;396452;397515;404996;73933.63033184799;74552.25447745562;74571;74612.25387746161;74832.25167748253;913.2420091324185;922.7923717163585;941.0589410589411;975.8341082016075;975.9707208783748;15667;15760;15838.28727707233;15849.762253566436;16180.838191617933;33592.66407335895;33972;34125.65874341225;34496.310073798886;35121.64878351286;42837;47851.28223076587;48010.75994620004;48056;48156.27765583449;7158.391536719437;7225.1329840419485;7274.199838017708;7367.631618419165;7385.52289542083;8287.295579875778;10208.897911021091;10414.843777343194;10482.213833962636;10630.52162652667;8952.865707014531;9103.408278461879;9180.495072771062;9313.906860931575;9449.527523623929;9057.456552606865;9337.439753614804;9474.052594740471;9507.477088760184;9527.28545359087;8316.503029454756;9327.86008209891;9356.204722598655;9432.783295925588;9453.43279403238;7095.538789978635;7221.31397517235;7250.709971601077;7304.123505179413;7341.559506429631;7167.283271673;8543.74368768913;8790.956045219733;9063.365564410427;9270.072992700676 12:50:00 INFO - PROCESS | 32694 | |3;mootools.html;1249.2566922681;1394.9721005579886;1447.8190226221723;1553.8679212266957;1809.2220345251537;6727.461803055756;7434.070741157356;7591.164971853092;7593.544387336764;7770.795526693371;7539.170691223961;7668.884966725504;7669.463137580357;7686.5772382518935;7688.654010569524;2158.093600687711;2190.4195388222133;2193.649016157415;2196.1105752170315;2196.516766311409;2107.6627739561673;2145.517258616814;2176.064292354287;2176.249194028058;2180.7819218078225;2116.2064225915283;2130.2437634639714;2139.903704333301;2142.3787101740477;2162.718846549946;2092.9162833486644;2098.097817938286;2100.737407824022;2101.548167144071;2102.211670623524;2054.732884724991;2101.7898210179014;2102.2747152232455;2104.8737075775502;2105.536781907978;7612.657430415645;7654.540727556365;7657.272559106876;7662.65518051689;7710.498817576839;4301.935470967938;4463.531329210418;4465.062336909253;4466.218411777958;4467.709598876095;2919.7810164237767;2939.92650183745;2981.9403611927855;2986.1190948670196;3071.9232019199476;925.2690374604055;933.407286373158;933.6592143867507;936.7049379445452;937.924966002725;10533.36799792015;10612.946935265274;10624.362538247653;10650.467476626138;10655.413952232624;4017.77902215381;4124.319487284624;4156.272652285898;4194.014406614443;4195;8353.289970352467;8397.202265784741;8411.327093832479;8415.747527574182;8429.241368276762;4236.110416812442;4290.806913688892;4293.527711951683;4297.892552686208;4303.591158839968;3431.8970430886616;3861.4014827701753;3922.2351641429645;3922.646961773454;3993.1614360984518;3375.274316022018;3401.5748031496064;3475.878344257939;3485.3444613808238;3522.1546828761425;987.7530617345664;1003.1673710820002;1018.5823812236947;1029.4492446541215;1031.118393773328;671.0873212431089;699.7410957945593;710.9111361079865;719.1406269507993;805.9032916050112;4895.510448955147;5054.646174767805;5133.101707201225;5171.63798534099;5277.419483856773;858.1632907914858;875.9868601970976;879.6701237036111;898.1691934960136;906.3338446242138;3559.982200088983;3593.2813437312643;3633.9636603633626;3641.908952276214;3655.451682247684;9625.614975401046;9853.261005424622;9873.555689993824;9988.700338989842;10003.449810260505;9850.901490985141;9869.506524673738;9889.406635601887;9897.158741506908;9922.206223502102;7349.889751653729;7387.187409384964;7469.962650186714;7491.850162996819;7497.512661676865;5002.699838009586;5053.797848086036;5062.316587260672;5089.51649593288;5092.955944031539;8761.737147885573;9029.458232506071;9085.318601105077;9187.219086377732;9192.95403522978;9066.27469802401;9212.263018958332;9298.442093474414;9306.348555601044;9310.534473276444;6307.526935479949;6324.968375158095;6356.173697419491;6412.871742565029;6450.903236451551;7271.745488908075;7451.2921272479025;7455.254474552501;7465.29079737424;7472.103347598323;6883.451223474678;6938;6940.201876784033;7032.437405007689;7051.823704407431;6669.299723529154;6780.355866192704;6797.5581587196675;6845.418139458202;7040.718371265092;6352.269489008639;6380.617162970237;6481.319461456667;6547.476201903932;6563.835904102436;4434.689571729948;4454.354118652842;4476.977615111904;4531.478879928851;4575.199340115533;4610.976945115253;4740.312654665123;4769.403824521934;4803.1114243864995;4822.855314340575 12:50:00 INFO - PROCESS | 32694 | |4;prototype.html;289.21478186723044;294.2760808411308;298.5626057825284;301.2288541334186;304.10289645545635;4716.839717389349;4751.786169622363;4759.476457589667;4761.90476190476;4801.303810947419;4724.1260366832075;4754.239321708527;4759.785809638566;4764.309175169598;4777.163996300651;3596.7662101963356;3701.2597480503873;3709.981450092746;3787.5644300905474;3814.2180852925085;3731.514903062598;3781.149241420686;3802.4676545283683;3807.9048023799487;3810.5236845394325;3530.858765649371;3730.123420996077;3741.644543768338;3742.6257374262627;3747.362948298782;3643.325984692827;3745.7752534847723;3758.49260349852;3759.0978165240417;3763.247350529905;3361.092505023654;3366;3373.1398493384277;3374.7131493823053;3378.6452422495777;4499.52754960731;4509.25597276449;4532.252178390561;4535.569120933506;4550.203714349976;4172.624463798243;4180.895477613084;4290.356446533014;4329.610335069828;4335.479742430897;4907.411110666742;4949.331840201563;4953.0836795192645;4973.229149481836;4984.950150498485;3645.9453108203134;3668.52309199805;3670.15586415126;3672.6510981456986;3688.2992231475932;4977.527134922177;5120.411152717448;5146.794128234867;5161.66449180802;5169;3573.749837511349;3603.56757189139;3608.079939615381;3614.403623402109;3626;3664.8350824212976;3697.7041836653;3707.462417949382;3711.6659500645073;3723.1064544509663;4058.492688413948;4178.22702799983;4200.4038465382955;4207.789610519461;4238.279492486285;4894.975525122351;4897.534734200245;4918.139325618003;4928.162212423897;4959.553640172402;1304.9412776425083;1311.1084462565357;1319.280991859439;1320.39261939507;1321.2468892731051;854.3805740837967;869.8086420987372;895.7044175422095;898.9101089890959;907.2469850024464;4386.276264416336;4387.670924680598;4407.27279998803;4407.603315701603;4413.801378937956;5049.873753156127;5059.241113832954;5060.671056381323;5067.366579177603;5079.8984020319385;4263.914721705611;4263.957360426418;4342.717723347972;4352.7823608819435;4377.649788016951;2661.401184733458;2682.114902082308;2689.5024420482273;2693.905713300025;2694.9461010779673;4741.241401375763;4768.354917553438;4790.4969978152485;4795.20879054959;4804.765783910499;4972.453030166679;5082.390113186441;5086;5108.897822043538;5120.825088445188;4843.660943734046;4866.124097662384;4871.878203044952;4878.414590249193;4887.144749668793;5084.51697088776;5117.437081920912;5136.357955255593;5140.3831540215415;5161.561267292323;4835.637327200404;5041.974790126026;5073.416557095834;5074.112030394593;5097.362829646294;4880.877978050577;4910.950890491049;4919.2129259318335;4921.311016457627;4929.9154186079;3651.1967367179177;3659.359612067931;3692.667659910621;3695.6304369562827;3707.9814600926825;4870.634702397405;5082.898342033212;5116.386033675983;5116.718580478109;5194.662346947436;4921.981987385155;4937.136001199704;4943.4562198157455;4946.996466431101;4950.356453661001;4950.950490495193;4955.752212389294;4978.651494395358;4980.452150263541;4995.675281106716;4609.884752881205;4877;4878;4882.170031094794;4925.876853078702;4756.548127927841;4864.318995340726;4992.925106123338;5006.098902197639;5034.194528875362;4919.409670839522;4927.9507204927495;4928;4929.876753081202;4931.654784165074 12:50:00 INFO - PROCESS | 32694 | |5;yui.html;629.8205011571703;637.8883695353314;659.1661548141602;659.3933581105382;760.4524742185624;11414.942925285372;12080.69798255044;12162.087843411757;12186.81719774203;12195.268283902971;12177;12221.083418743607;12240.265584064962;12246.693832654188;12267;623.7629700713723;769.0732667136087;782.2724865874734;797.8962734844462;801.527099011583;800.1878093734834;800.6157044618586;805.2591615713528;805.3436449293807;806.8265322955564;841.3689732700475;843.9662413503453;846.2087947768825;851.2551517422255;851.3019324154196;656.1535619051418;816.999999999997;834.4200780457585;836.9370898958289;837.4682076881163;615.6644628677382;616.9660668663222;617.1206031405275;617.3579477343558;619.5013014523307;12519.624411267676;12531.874681253254;12541;12574.371281435982;12584.37078146089;11798.410079496076;12123.33321667308;12234.327112008836;12507.749845003049;12537.185082969578;10898.346099234072;10951.945240273828;11175;11279.661610151708;11355.432228388547;4076.5923407659293;4085.816138273785;4108.281050816096;4252.08580155265;4262.552431994627;44712;44785.55214447879;45015.54984450146;46638.76680616609;47043.52956470426;9703.660371887092;9749.512524373753;9922.355046921926;9977.10206081456;10044.799104017879;17045.91477042607;17163.7425438616;17163.742543861852;17166.31334746621;17166.742498862528;6709.094272273278;6854.691538880762;6868.347506986828;6870.31296870319;7063.04648872406;3787.9242415151543;3790.5640851302455;3800.980995095062;3849.01850028241;3886.125621735087;2662.400959784033;2715.0361621624434;2739.931501712433;2745.629340039069;2747.3406382468065;471.96696231264167;496.6895690193629;507.0872429626657;512.8564002079423;513.637885290869;480.9591184749265;540.7890922540213;554.1466142141138;566.8271177290883;613.4969325153421;8217.712380066669;8273.46222495536;8288.751337459886;8335.49987000782;8450;540.7620646915344;600.4115966352998;615.3139249736512;624.3194917539903;634.7587916591758;3643.7429086964953;3745.250949810049;3826.9808650956566;3868.4777555030273;3909.9609003910164;50862.74568627133;51616.22575661368;51619.741901290254;51663;52027.47972520226;45724.314135288;46311;46606.76696616495;47158;48219.75890120597;43181.13637727291;43190;43513.34729979053;43824;44074;7528.623568821647;7705.383569314554;7725.150233474201;7776.650050747617;7778.377729781717;30353;30666.080017599506;31122.066338009896;31201.8439907799;31275;36990.44514332234;37444.62555374411;39887.2022559553;39974.80012599919;40480.1903961925;10187.235957303084;10202.897971020491;10413.583456661649;10424.530896109542;10666.413347265974;9972.900270997197;10627.468626568796;10796.89203107959;10902.400367979837;11007.394593297126;9494.335396522178;9754.812281259852;10025.248106391904;10088.54601542947;10188.745281368025;9617.615295388106;9740.951295243762;9858.753531161778;10073.798524029626;10083.798324033332;9786.217102631916;9966.252531060345;10028.424674612335;10094.444805535766;10130.08829205375;8506.276966457674;8597.914020859962;8617.69838055665;8861.867071994055;8916;8491.320694344562;8861.512616806138;8879.556022198993;8895.421797583136;8999.19007289347 12:50:00 INFO - PROCESS | 32694 | __end_tp_report 12:50:00 INFO - PROCESS | 32694 | __start_cc_report 12:50:00 INFO - PROCESS | 32694 | _x_x_mozilla_cycle_collect,1060 12:50:00 INFO - PROCESS | 32694 | __end_cc_report 12:50:00 INFO - PROCESS | 32694 | __startTimestamp1464033000222__endTimestamp 12:50:00 INFO - PROCESS | 32694 | 12:50:00 INFO - PROCESS | 32694 | ------- Summary: start ------- 12:50:00 INFO - PROCESS | 32694 | Number of tests: 6 12:50:00 INFO - PROCESS | 32694 | 12:50:00 INFO - PROCESS | 32694 | [#0] dojo.html Cycles:165 Average:4736.51 Median:4869.29 stddev:496.57 (10.2%) stddev-sans-first:470.51 12:50:00 INFO - PROCESS | 32694 | Values: 2656.0 2682.6 2706.8 2708.3 2717.3 4668.2 4688.8 4719.0 4739.0 4797.7 4677.1 4683.1 4763.3 4772.8 4832.3 4276.3 4337.1 4352.0 4374.3 4564.2 4465.7 4499.3 4506.3 4524.3 4562.9 4302.6 4351.6 4383.4 4398.8 4441.5 4379.2 4385.6 4391.1 4489.1 4494.6 4408.6 4413.2 4421.9 4429.4 4467.9 4536.4 4616.6 4671.7 4709.4 4764.2 5138.2 5188.5 5200.8 5210.3 5213.5 5156.9 5197.4 5222.3 5237.9 5244.3 4627.4 4751.9 4816.0 4817.9 4867.0 5270.2 5274.8 5286.9 5346.5 5362.0 5089.9 5115.5 5133.6 5136.7 5137.7 4937.5 5038.9 5097.0 5099.9 5124.7 5057.6 5085.3 5086.8 5086.9 5143.2 4973.2 5042.0 5045.2 5047.8 5050.1 4274.7 4325.3 4328.5 4330.1 4331.7 3772.7 3786.8 3788.4 3800.6 3829.1 4331.0 4370.0 4488.9 4499.6 4522.3 5097.3 5144.6 5155.9 5172.4 5182.2 4426.6 4454.0 4456.5 4470.8 4506.5 4511.4 4533.3 4604.8 4609.6 4651.8 4840.1 4857.0 4869.3 4872.8 4915.7 5054.6 5073.6 5081.9 5088.6 5133.7 4721.9 4807.8 4828.2 4838.1 4879.2 5034.5 5055.9 5063.5 5064.7 5117.4 5152.8 5161.4 5162.6 5165.2 5171.9 4776.1 4947.6 5003.7 5013.9 5021.5 4969.1 4991.3 5002.1 5017.1 5060.0 4933.7 4934.0 4948.7 4993.1 5006.5 4908.7 4943.6 4970.8 4984.8 5015.8 4898.5 4919.5 4924.1 4925.6 4953.1 12:50:00 INFO - PROCESS | 32694 | 12:50:00 INFO - PROCESS | 32694 | [#1] ext.html Cycles:180 Average:50079.34 Median:212528.31 stddev:91922.78 (43.3%) stddev-sans-first:92105.43 12:50:00 INFO - PROCESS | 32694 | Values: 549.7 563.5 580.1 582.2 593.7 39586.2 40897.4 40931.6 44692.3 44838.6 41377.4 41631.2 41761.8 41908.2 41984.4 7682.8 7830.4 7843.1 7850.3 7854.8 7763.3 7825.2 7835.9 7855.7 7860.6 7853.6 7908.8 7931.6 7935.0 7935.4 7774.8 7871.8 7873.5 7881.7 7885.3 7624.7 7762.7 7797.5 7799.3 7806.1 39131.8 39193.0 39217.9 39331.4 39433.4 3254.7 3286.3 3335.4 3343.5 3779.1 29171.7 29749.0 29830.3 30096.0 30940.0 3375.4 3395.3 3416.1 3482.0 3543.9 264264.0 365580.2 371406.0 372139.0 372320.0 52287.0 56123.4 56126.4 56568.2 56690.0 57444.4 58303.7 58492.7 62797.0 63003.4 11852.5 11853.9 11878.0 11878.5 11887.8 8345.2 9013.1 9118.5 9139.8 9230.9 17928.6 18128.3 18261.2 18285.8 18297.4 6924.7 7045.6 7110.6 7231.0 7355.4 814.6 910.5 918.3 931.1 1065.8 27668.4 28374.6 28377.2 28422.4 28681.4 902.2 964.8 973.9 1001.3 1010.9 14827.3 14890.7 15114.1 15304.5 15365.8 379235.0 383468.0 383968.0 385329.0 386362.0 49525.3 49896.5 49964.3 49996.5 50020.2 1109.1 1177.0 1217.1 1222.6 1224.4 27495.2 28576.7 28852.1 29050.6 29405.7 41683.2 42240.6 42246.4 42246.4 42254.8 304179.0 306492.0 306672.0 307487.0 308307.0 20511.2 24490.3 25234.1 25911.1 26447.3 41275.0 41544.2 41718.8 42291.4 42795.8 35821.3 36050.8 36053.0 36262.8 36910.6 35646.0 35890.5 35984.6 36493.0 36544.8 35670.6 35694.0 38114.8 38694.6 39565.0 32031.0 33404.7 33487.0 33724.3 33777.7 24337.1 24857.4 25244.2 25694.2 25744.9 12:50:00 INFO - PROCESS | 32694 | 12:50:00 INFO - PROCESS | 32694 | [#2] jquery.html Cycles:180 Average:24111.79 Median:5077.56 stddev:65487.41 (1289.7%) stddev-sans-first:65646.84 12:50:00 INFO - PROCESS | 32694 | Values: 364.4 369.0 371.7 374.7 377.3 16467.0 17043.9 17128.3 17477.2 17486.0 16007.5 16283.3 17017.6 17122.3 17160.4 4930.2 5074.2 5080.9 5115.7 5130.3 3633.6 3853.3 4992.6 5627.3 5960.5 6016.5 6029.6 6049.9 6057.7 6060.3 5869.3 5914.6 6019.8 6037.6 6045.8 3270.9 4958.2 5265.2 5278.4 5300.3 19384.2 20165.1 20168.4 20173.6 20187.4 1910.3 1971.7 2040.7 2143.7 2319.4 12745.3 12909.4 13039.3 13140.3 13363.3 1750.1 1829.0 1998.9 2012.2 2058.8 67115.7 67195.3 67379.0 67906.0 68924.3 10031.5 10061.5 10204.3 10305.0 10385.7 14179.2 14207.3 14278.6 14284.5 14286.6 6511.1 6612.0 6620.9 6666.7 6702.7 5885.2 6020.7 6092.6 6106.8 6107.2 4342.9 4464.4 4485.9 4554.2 4560.2 1711.3 1741.8 1819.9 1840.7 1850.3 886.6 889.3 892.2 895.2 944.6 16025.6 16760.2 16781.7 16866.7 16892.6 865.0 883.9 894.5 925.1 959.1 9212.4 9524.5 9562.6 9582.2 9660.0 393966.0 394894.0 396452.0 397515.0 404996.0 73933.6 74552.3 74571.0 74612.3 74832.3 913.2 922.8 941.1 975.8 976.0 15667.0 15760.0 15838.3 15849.8 16180.8 33592.7 33972.0 34125.7 34496.3 35121.6 42837.0 47851.3 48010.8 48056.0 48156.3 7158.4 7225.1 7274.2 7367.6 7385.5 8287.3 10208.9 10414.8 10482.2 10630.5 8952.9 9103.4 9180.5 9313.9 9449.5 9057.5 9337.4 9474.1 9507.5 9527.3 8316.5 9327.9 9356.2 9432.8 9453.4 7095.5 7221.3 7250.7 7304.1 7341.6 7167.3 8543.7 8791.0 9063.4 9270.1 12:50:00 INFO - PROCESS | 32694 | 12:50:00 INFO - PROCESS | 32694 | [#3] mootools.html Cycles:180 Average:5087.45 Median:5091.24 stddev:2899.05 (56.9%) stddev-sans-first:2892.83 12:50:00 INFO - PROCESS | 32694 | Values: 1249.3 1395.0 1447.8 1553.9 1809.2 6727.5 7434.1 7591.2 7593.5 7770.8 7539.2 7668.9 7669.5 7686.6 7688.7 2158.1 2190.4 2193.6 2196.1 2196.5 2107.7 2145.5 2176.1 2176.2 2180.8 2116.2 2130.2 2139.9 2142.4 2162.7 2092.9 2098.1 2100.7 2101.5 2102.2 2054.7 2101.8 2102.3 2104.9 2105.5 7612.7 7654.5 7657.3 7662.7 7710.5 4301.9 4463.5 4465.1 4466.2 4467.7 2919.8 2939.9 2981.9 2986.1 3071.9 925.3 933.4 933.7 936.7 937.9 10533.4 10612.9 10624.4 10650.5 10655.4 4017.8 4124.3 4156.3 4194.0 4195.0 8353.3 8397.2 8411.3 8415.7 8429.2 4236.1 4290.8 4293.5 4297.9 4303.6 3431.9 3861.4 3922.2 3922.6 3993.2 3375.3 3401.6 3475.9 3485.3 3522.2 987.8 1003.2 1018.6 1029.4 1031.1 671.1 699.7 710.9 719.1 805.9 4895.5 5054.6 5133.1 5171.6 5277.4 858.2 876.0 879.7 898.2 906.3 3560.0 3593.3 3634.0 3641.9 3655.5 9625.6 9853.3 9873.6 9988.7 10003.4 9850.9 9869.5 9889.4 9897.2 9922.2 7349.9 7387.2 7470.0 7491.9 7497.5 5002.7 5053.8 5062.3 5089.5 5093.0 8761.7 9029.5 9085.3 9187.2 9193.0 9066.3 9212.3 9298.4 9306.3 9310.5 6307.5 6325.0 6356.2 6412.9 6450.9 7271.7 7451.3 7455.3 7465.3 7472.1 6883.5 6938.0 6940.2 7032.4 7051.8 6669.3 6780.4 6797.6 6845.4 7040.7 6352.3 6380.6 6481.3 6547.5 6563.8 4434.7 4454.4 4477.0 4531.5 4575.2 4611.0 4740.3 4769.4 4803.1 4822.9 12:50:00 INFO - PROCESS | 32694 | 12:50:00 INFO - PROCESS | 32694 | [#4] prototype.html Cycles:180 Average:4135.31 Median:4755.39 stddev:1180.74 (24.8%) stddev-sans-first:1148.22 12:50:00 INFO - PROCESS | 32694 | Values: 289.2 294.3 298.6 301.2 304.1 4716.8 4751.8 4759.5 4761.9 4801.3 4724.1 4754.2 4759.8 4764.3 4777.2 3596.8 3701.3 3710.0 3787.6 3814.2 3731.5 3781.1 3802.5 3807.9 3810.5 3530.9 3730.1 3741.6 3742.6 3747.4 3643.3 3745.8 3758.5 3759.1 3763.2 3361.1 3366.0 3373.1 3374.7 3378.6 4499.5 4509.3 4532.3 4535.6 4550.2 4172.6 4180.9 4290.4 4329.6 4335.5 4907.4 4949.3 4953.1 4973.2 4985.0 3645.9 3668.5 3670.2 3672.7 3688.3 4977.5 5120.4 5146.8 5161.7 5169.0 3573.7 3603.6 3608.1 3614.4 3626.0 3664.8 3697.7 3707.5 3711.7 3723.1 4058.5 4178.2 4200.4 4207.8 4238.3 4895.0 4897.5 4918.1 4928.2 4959.6 1304.9 1311.1 1319.3 1320.4 1321.2 854.4 869.8 895.7 898.9 907.2 4386.3 4387.7 4407.3 4407.6 4413.8 5049.9 5059.2 5060.7 5067.4 5079.9 4263.9 4264.0 4342.7 4352.8 4377.6 2661.4 2682.1 2689.5 2693.9 2694.9 4741.2 4768.4 4790.5 4795.2 4804.8 4972.5 5082.4 5086.0 5108.9 5120.8 4843.7 4866.1 4871.9 4878.4 4887.1 5084.5 5117.4 5136.4 5140.4 5161.6 4835.6 5042.0 5073.4 5074.1 5097.4 4880.9 4911.0 4919.2 4921.3 4929.9 3651.2 3659.4 3692.7 3695.6 3708.0 4870.6 5082.9 5116.4 5116.7 5194.7 4922.0 4937.1 4943.5 4947.0 4950.4 4951.0 4955.8 4978.7 4980.5 4995.7 4609.9 4877.0 4878.0 4882.2 4925.9 4756.5 4864.3 4992.9 5006.1 5034.2 4919.4 4928.0 4928.0 4929.9 4931.7 12:50:00 INFO - PROCESS | 32694 | 12:50:00 INFO - PROCESS | 32694 | [#5] yui.html Cycles:180 Average:12680.65 Median:23757.75 stddev:14512.22 (61.1%) stddev-sans-first:14524.71 12:50:00 INFO - PROCESS | 32694 | Values: 629.8 637.9 659.2 659.4 760.5 11414.9 12080.7 12162.1 12186.8 12195.3 12177.0 12221.1 12240.3 12246.7 12267.0 623.8 769.1 782.3 797.9 801.5 800.2 800.6 805.3 805.3 806.8 841.4 844.0 846.2 851.3 851.3 656.2 817.0 834.4 836.9 837.5 615.7 617.0 617.1 617.4 619.5 12519.6 12531.9 12541.0 12574.4 12584.4 11798.4 12123.3 12234.3 12507.7 12537.2 10898.3 10951.9 11175.0 11279.7 11355.4 4076.6 4085.8 4108.3 4252.1 4262.6 44712.0 44785.6 45015.5 46638.8 47043.5 9703.7 9749.5 9922.4 9977.1 10044.8 17045.9 17163.7 17163.7 17166.3 17166.7 6709.1 6854.7 6868.3 6870.3 7063.0 3787.9 3790.6 3801.0 3849.0 3886.1 2662.4 2715.0 2739.9 2745.6 2747.3 472.0 496.7 507.1 512.9 513.6 481.0 540.8 554.1 566.8 613.5 8217.7 8273.5 8288.8 8335.5 8450.0 540.8 600.4 615.3 624.3 634.8 3643.7 3745.3 3827.0 3868.5 3910.0 50862.7 51616.2 51619.7 51663.0 52027.5 45724.3 46311.0 46606.8 47158.0 48219.8 43181.1 43190.0 43513.3 43824.0 44074.0 7528.6 7705.4 7725.2 7776.7 7778.4 30353.0 30666.1 31122.1 31201.8 31275.0 36990.4 37444.6 39887.2 39974.8 40480.2 10187.2 10202.9 10413.6 10424.5 10666.4 9972.9 10627.5 10796.9 10902.4 11007.4 9494.3 9754.8 10025.2 10088.5 10188.7 9617.6 9741.0 9858.8 10073.8 10083.8 9786.2 9966.3 10028.4 10094.4 10130.1 8506.3 8597.9 8617.7 8861.9 8916.0 8491.3 8861.5 8879.6 8895.4 8999.2 12:50:00 INFO - PROCESS | 32694 | -------- Summary: end -------- 12:50:00 INFO - PROCESS | 32694 | 12:50:00 INFO - TEST-INFO | 32694: exit 0 12:50:00 INFO - TEST-OK | dromaeo_css | took 1118142ms 12:50:00 INFO - TEST-START | kraken 12:50:00 INFO - operating with platform_type : linux_ 12:50:00 INFO - Initialising browser for kraken test... 12:50:00 INFO - TEST-INFO | started process 403 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpERAiTA/profile http://localhost:40793/getInfo.html) 12:50:05 INFO - PROCESS | 403 | __metrics Screen width/height:1600/1200 12:50:05 INFO - PROCESS | 403 | colorDepth:24 12:50:05 INFO - PROCESS | 403 | Browser inner width/height: 1024/697 12:50:05 INFO - PROCESS | 403 | __metrics 12:50:06 ERROR - PROCESS | 403 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:50:07 INFO - TEST-INFO | 403: exit 0 12:50:07 INFO - Browser initialized. 12:50:07 INFO - Running cycle 1/1 for kraken test... 12:50:07 INFO - TEST-INFO | started process 486 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpERAiTA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:50:19 INFO - PROCESS | 486 | RSS: Main: 154939392 12:50:19 INFO - PROCESS | 486 | 12:50:22 INFO - PROCESS | 486 | Cycle 1(1): loaded http://localhost:40793/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40793/tests/kraken/driver.html?testName=audio-beat-detection) 12:50:23 INFO - PROCESS | 486 | RSS: Main: 209485824 12:50:23 INFO - PROCESS | 486 | 12:50:26 INFO - PROCESS | 486 | Cycle 1(1): loaded http://localhost:40793/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40793/tests/kraken/driver.html?testName=audio-dft) 12:50:26 INFO - PROCESS | 486 | RSS: Main: 197513216 12:50:26 INFO - PROCESS | 486 | 12:50:29 INFO - PROCESS | 486 | Cycle 1(1): loaded http://localhost:40793/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40793/tests/kraken/driver.html?testName=audio-fft) 12:50:30 INFO - PROCESS | 486 | RSS: Main: 267776000 12:50:30 INFO - PROCESS | 486 | 12:50:32 INFO - PROCESS | 486 | Cycle 1(1): loaded http://localhost:40793/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40793/tests/kraken/driver.html?testName=audio-oscillator) 12:50:33 INFO - PROCESS | 486 | RSS: Main: 177401856 12:50:33 INFO - PROCESS | 486 | 12:50:35 INFO - PROCESS | 486 | Cycle 1(1): loaded http://localhost:40793/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40793/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:50:36 INFO - PROCESS | 486 | RSS: Main: 181141504 12:50:36 INFO - PROCESS | 486 | 12:50:39 INFO - PROCESS | 486 | Cycle 1(1): loaded http://localhost:40793/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40793/tests/kraken/driver.html?testName=imaging-darkroom) 12:50:40 INFO - PROCESS | 486 | RSS: Main: 216322048 12:50:40 INFO - PROCESS | 486 | 12:50:43 INFO - PROCESS | 486 | Cycle 1(1): loaded http://localhost:40793/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40793/tests/kraken/driver.html?testName=imaging-desaturate) 12:50:44 INFO - PROCESS | 486 | RSS: Main: 214867968 12:50:44 INFO - PROCESS | 486 | 12:50:47 INFO - PROCESS | 486 | Cycle 1(1): loaded http://localhost:40793/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40793/tests/kraken/driver.html?testName=json-parse-financial) 12:50:48 INFO - PROCESS | 486 | RSS: Main: 215543808 12:50:48 INFO - PROCESS | 486 | 12:50:50 INFO - PROCESS | 486 | Cycle 1(1): loaded http://localhost:40793/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40793/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:50:50 INFO - PROCESS | 486 | RSS: Main: 210112512 12:50:50 INFO - PROCESS | 486 | 12:50:52 INFO - PROCESS | 486 | Cycle 1(1): loaded http://localhost:40793/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40793/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:50:53 INFO - PROCESS | 486 | RSS: Main: 212606976 12:50:53 INFO - PROCESS | 486 | 12:50:55 INFO - PROCESS | 486 | Cycle 1(1): loaded http://localhost:40793/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40793/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:50:56 INFO - PROCESS | 486 | RSS: Main: 218386432 12:50:56 INFO - PROCESS | 486 | 12:50:59 INFO - PROCESS | 486 | Cycle 1(1): loaded http://localhost:40793/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40793/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:50:59 INFO - PROCESS | 486 | RSS: Main: 219615232 12:50:59 INFO - PROCESS | 486 | 12:51:02 INFO - PROCESS | 486 | Cycle 1(1): loaded http://localhost:40793/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40793/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:51:03 INFO - PROCESS | 486 | RSS: Main: 220045312 12:51:03 INFO - PROCESS | 486 | 12:51:05 INFO - PROCESS | 486 | Cycle 1(1): loaded http://localhost:40793/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40793/tests/kraken/driver.html?testName=ai-astar) 12:51:05 INFO - PROCESS | 486 | RSS: Main: 265981952 12:51:05 INFO - PROCESS | 486 | 12:51:05 INFO - PROCESS | 486 | __start_tp_report 12:51:05 INFO - PROCESS | 486 | _x_x_mozilla_page_load 12:51:05 INFO - PROCESS | 486 | _x_x_mozilla_page_load_details 12:51:05 INFO - PROCESS | 486 | |i|pagename|runs| 12:51:05 INFO - PROCESS | 486 | |0;ai-astar;115;109;114;115;113;113;112;113;114;114 12:51:05 INFO - PROCESS | 486 | |1;audio-beat-detection;160;130;140;210;142;156;156;140;185;131 12:51:05 INFO - PROCESS | 486 | |2;audio-dft;161;160;162;161;162;161;161;162;162;161 12:51:05 INFO - PROCESS | 486 | |3;audio-fft;77;76;76;136;76;76;76;76;121;75 12:51:05 INFO - PROCESS | 486 | |4;audio-oscillator;92;93;164;94;94;95;121;93;93;136 12:51:05 INFO - PROCESS | 486 | |5;imaging-gaussian-blur;116;116;117;117;116;117;116;118;117;118 12:51:05 INFO - PROCESS | 486 | |6;imaging-darkroom;145;146;147;146;146;146;147;146;146;146 12:51:05 INFO - PROCESS | 486 | |7;imaging-desaturate;95;94;94;94;95;95;95;96;96;94 12:51:05 INFO - PROCESS | 486 | |8;json-parse-financial;71;63;64;65;65;64;64;64;63;64 12:51:05 INFO - PROCESS | 486 | |9;json-stringify-tinderbox;65;65;65;65;66;64;65;65;65;65 12:51:05 INFO - PROCESS | 486 | |10;stanford-crypto-aes;84;85;85;83;81;83;85;84;165;83 12:51:05 INFO - PROCESS | 486 | |11;stanford-crypto-ccm;134;139;139;130;128;135;125;136;146;133 12:51:05 INFO - PROCESS | 486 | |12;stanford-crypto-pbkdf2;172;174;188;173;176;173;172;171;172;169 12:51:05 INFO - PROCESS | 486 | |13;stanford-crypto-sha256-iterative;67;66;68;68;70;66;66;75;70;65 12:51:05 INFO - PROCESS | 486 | __end_tp_report 12:51:05 INFO - PROCESS | 486 | __start_cc_report 12:51:05 INFO - PROCESS | 486 | _x_x_mozilla_cycle_collect,2077 12:51:05 INFO - PROCESS | 486 | __end_cc_report 12:51:05 INFO - PROCESS | 486 | __startTimestamp1464033065433__endTimestamp 12:51:05 INFO - PROCESS | 486 | 12:51:05 INFO - PROCESS | 486 | ------- Summary: start ------- 12:51:05 INFO - PROCESS | 486 | Number of tests: 14 12:51:05 INFO - PROCESS | 486 | 12:51:05 INFO - PROCESS | 486 | [#0] ai-astar Cycles:10 Average:113.20 Median:114.00 stddev:1.75 (1.5%) stddev-sans-first:1.73 12:51:05 INFO - PROCESS | 486 | Values: 115.0 109.0 114.0 115.0 113.0 113.0 112.0 113.0 114.0 114.0 12:51:05 INFO - PROCESS | 486 | 12:51:05 INFO - PROCESS | 486 | [#1] audio-beat-detection Cycles:10 Average:155.00 Median:156.00 stddev:25.32 (16.2%) stddev-sans-first:26.80 12:51:05 INFO - PROCESS | 486 | Values: 160.0 130.0 140.0 210.0 142.0 156.0 156.0 140.0 185.0 131.0 12:51:05 INFO - PROCESS | 486 | 12:51:05 INFO - PROCESS | 486 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.67 (0.4%) stddev-sans-first:0.71 12:51:05 INFO - PROCESS | 486 | Values: 161.0 160.0 162.0 161.0 162.0 161.0 161.0 162.0 162.0 161.0 12:51:05 INFO - PROCESS | 486 | 12:51:05 INFO - PROCESS | 486 | [#3] audio-fft Cycles:10 Average:86.50 Median:76.00 stddev:22.42 (29.5%) stddev-sans-first:23.52 12:51:05 INFO - PROCESS | 486 | Values: 77.0 76.0 76.0 136.0 76.0 76.0 76.0 76.0 121.0 75.0 12:51:05 INFO - PROCESS | 486 | 12:51:05 INFO - PROCESS | 486 | [#4] audio-oscillator Cycles:10 Average:107.50 Median:93.00 stddev:24.90 (26.8%) stddev-sans-first:25.77 12:51:05 INFO - PROCESS | 486 | Values: 92.0 93.0 164.0 94.0 94.0 95.0 121.0 93.0 93.0 136.0 12:51:05 INFO - PROCESS | 486 | 12:51:05 INFO - PROCESS | 486 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 12:51:05 INFO - PROCESS | 486 | Values: 116.0 116.0 117.0 117.0 116.0 117.0 116.0 118.0 117.0 118.0 12:51:05 INFO - PROCESS | 486 | 12:51:05 INFO - PROCESS | 486 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.44 12:51:05 INFO - PROCESS | 486 | Values: 145.0 146.0 147.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 12:51:05 INFO - PROCESS | 486 | 12:51:05 INFO - PROCESS | 486 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 12:51:05 INFO - PROCESS | 486 | Values: 95.0 94.0 94.0 94.0 95.0 95.0 95.0 96.0 96.0 94.0 12:51:05 INFO - PROCESS | 486 | 12:51:05 INFO - PROCESS | 486 | [#8] json-parse-financial Cycles:10 Average:64.70 Median:64.00 stddev:2.31 (3.6%) stddev-sans-first:0.71 12:51:05 INFO - PROCESS | 486 | Values: 71.0 63.0 64.0 65.0 65.0 64.0 64.0 64.0 63.0 64.0 12:51:05 INFO - PROCESS | 486 | 12:51:05 INFO - PROCESS | 486 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 12:51:05 INFO - PROCESS | 486 | Values: 65.0 65.0 65.0 65.0 66.0 64.0 65.0 65.0 65.0 65.0 12:51:05 INFO - PROCESS | 486 | 12:51:05 INFO - PROCESS | 486 | [#10] stanford-crypto-aes Cycles:10 Average:91.80 Median:84.00 stddev:25.75 (30.7%) stddev-sans-first:27.16 12:51:05 INFO - PROCESS | 486 | Values: 84.0 85.0 85.0 83.0 81.0 83.0 85.0 84.0 165.0 83.0 12:51:05 INFO - PROCESS | 486 | 12:51:05 INFO - PROCESS | 486 | [#11] stanford-crypto-ccm Cycles:10 Average:134.50 Median:135.50 stddev:6.06 (4.5%) stddev-sans-first:6.42 12:51:05 INFO - PROCESS | 486 | Values: 134.0 139.0 139.0 130.0 128.0 135.0 125.0 136.0 146.0 133.0 12:51:05 INFO - PROCESS | 486 | 12:51:05 INFO - PROCESS | 486 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.00 Median:173.00 stddev:5.25 (3.0%) stddev-sans-first:5.52 12:51:05 INFO - PROCESS | 486 | Values: 172.0 174.0 188.0 173.0 176.0 173.0 172.0 171.0 172.0 169.0 12:51:05 INFO - PROCESS | 486 | 12:51:05 INFO - PROCESS | 486 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.00 stddev:2.96 (4.4%) stddev-sans-first:3.11 12:51:05 INFO - PROCESS | 486 | Values: 67.0 66.0 68.0 68.0 70.0 66.0 66.0 75.0 70.0 65.0 12:51:05 INFO - PROCESS | 486 | -------- Summary: end -------- 12:51:05 INFO - PROCESS | 486 | 12:51:06 INFO - TEST-INFO | 486: exit 0 12:51:06 INFO - TEST-OK | kraken | took 65579ms 12:51:06 INFO - SUITE-END | took 1183s 12:51:06 INFO - Completed test suite (00:19:43) 12:51:06 INFO - javascript benchmark 12:51:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2655.9867200663994, 2682.570788673813, 2706.8240564363314, 2708.3499960009603, 2717.3070866928942, 4668.18306796311, 4688.789004494797, 4718.976405117974, 4738.9526104739025, 4797.664163508556, 4677.087967846272, 4683.086798074377, 4763.285507173926, 4772.78522466489, 4832.299316599091, 4276.337167739005, 4337.1325734853, 4352.042550638855, 4374.278244089737, 4564.178447879381, 4465.665075119363, 4499.280115181556, 4506.346579745935, 4524.298733696266, 4562.885927851797, 4302.569743025703, 4351.608355248011, 4383.408239887606, 4398.846040388603, 4441.489228738672, 4379.211741886459, 4385.649148068147, 4391.077873646538, 4489.057297967431, 4494.550544945512, 4408.647308215335, 4413.249747542925, 4421.911561768747, 4429.3798868158165, 4467.932981005288, 4536.364908912755, 4616.630669546428, 4671.719696818202, 4709.364235828154, 4764.190087685067, 5138.229265610151, 5188.481151884819, 5200.765965531522, 5210.270562121306, 5213.452587478336, 5156.92264616031, 5197.376314842243, 5222.321098257202, 5237.921431178497, 5244.344456942882, 4627.421572303462, 4751.857444276678, 4815.95184048155, 4817.879553011133, 4867.0, 5270.209468579667, 5274.7626356814035, 5286.920696189561, 5346.492083252085, 5361.973190134025, 5089.923651145235, 5115.539601435814, 5133.563647089964, 5136.743162841918, 5137.717425541631, 4937.530934561211, 5038.899222015612, 5097.0060838136205, 5099.949000509948, 5124.743762811919, 5057.620678449131, 5085.313482679865, 5086.796528138833, 5086.949130508721, 5143.151380022329, 4973.204287314013, 5041.966396888629, 5045.217991211368, 5047.772850221749, 5050.141475949097, 4274.658027357804, 4325.307950727868, 4328.458942632171, 4330.090680957034, 4331.7184383015, 3772.7170462215445, 3786.8295926683363, 3788.355979483439, 3800.638939300762, 3829.119302560371, 4330.956690433055, 4370.0, 4488.9102217956115, 4499.617532509773, 4522.321651752263, 5097.311862898536, 5144.562712169432, 5155.922661160085, 5172.379314482287, 5182.196759502283, 4426.623736982393, 4453.955460445419, 4456.532064133284, 4470.821167153343, 4506.504284528699, 4511.436070491189, 4533.252013417815, 4604.838830640979, 4609.608183304456, 4651.790669419885, 4840.08038472682, 4856.975715121402, 4869.293952376815, 4872.756362181806, 4915.729634870117, 5054.60529596572, 5073.59411247092, 5081.92377114351, 5088.643794934319, 5133.743312834418, 4721.9055618888115, 4807.7836497357, 4828.227483602606, 4838.104950584153, 4879.170541007966, 5034.471380504994, 5055.873603159804, 5063.544281014726, 5064.721440320818, 5117.411497677815, 5152.76812543444, 5161.354830646169, 5162.5869930406225, 5165.173572228426, 5171.896562068662, 4776.140294746979, 4947.60419166473, 5003.699778013185, 5013.899722005613, 5021.548060674557, 4969.105560999054, 4991.301217829579, 5002.124628190125, 5017.147084995487, 5059.974700126623, 4933.679310844927, 4933.975330123327, 4948.678335908155, 4993.051320249141, 5006.549410552922, 4908.680935739166, 4943.629227807857, 4970.826021089245, 4984.750762461935, 5015.84952451427, 4898.53463920927, 4919.458859525521, 4924.064427758714, 4925.556699897026, 4953.108440480604], "value": 4705.012030901641, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.7276811949637, 563.4844117632366, 580.0834681203696, 582.2372691773774, 593.6972144206457, 39586.20827583447, 40897.3865392019, 40931.59068409315, 44692.3296150558, 44838.55161448385, 41377.37933930986, 41631.16737665253, 41761.79119104408, 41908.16183676325, 41984.370234446505, 7682.769516914487, 7830.412719046066, 7843.058832940055, 7850.293473587376, 7854.764357069297, 7763.262490063435, 7825.217478252186, 7835.882461763078, 7855.725049623265, 7860.606969651494, 7853.607319633996, 7908.762737117896, 7931.6034198290145, 7934.960325198366, 7935.404844636647, 7774.805629859242, 7871.8032049198655, 7873.5275883447175, 7881.724139655084, 7885.329746971514, 7624.733134340327, 7762.728304509372, 7797.532148071134, 7799.337056350217, 7806.102298235719, 39131.80434097811, 39193.0, 39217.90167278264, 39331.41002884931, 39433.40849887254, 3254.6908043735807, 3286.3098749262685, 3335.4163021471386, 3343.4650455926935, 3779.130799916035, 29171.708282917323, 29749.0, 29830.25896325169, 30096.0, 30940.0, 3375.375555522236, 3395.2530443302435, 3416.0605833395766, 3482.0, 3543.85824567017, 264264.0, 365580.1720991378, 371406.0, 372139.0, 372320.0, 52287.0, 56123.438765612635, 56126.43873561294, 56568.151477727864, 56690.0, 57444.42555574475, 58303.70848145817, 58492.7075364629, 62797.0, 63003.36996629975, 11852.466639001266, 11853.940730296294, 11878.0, 11878.465469053914, 11887.76224475523, 8345.207205315486, 9013.143751343612, 9118.544072796467, 9139.817203656023, 9230.907690923139, 17928.55178620519, 18128.27486900509, 18261.178246978652, 18285.817141828677, 18297.35959241447, 6924.723011079601, 7045.626102909883, 7110.57336559808, 7231.0, 7355.411567074621, 814.6252723747024, 910.526526206369, 918.2975024106564, 931.101487064972, 1065.8028264771042, 27668.44663106767, 28374.574381384296, 28377.155484893417, 28422.43155136927, 28681.42637147287, 902.2195800632405, 964.8215080210043, 973.8685277487449, 1001.3040936549174, 1010.8938561451089, 14827.258637068104, 14890.702185956221, 15114.09315441077, 15304.464343748137, 15365.846341536666, 379235.0, 383468.0, 383968.0, 385329.0, 386362.0, 49525.257121143215, 49896.50103498991, 49964.25053624198, 49996.50003499918, 50020.249696254585, 1109.0794640448407, 1176.9588064417876, 1217.062861596548, 1222.5965431407615, 1224.4489979509078, 27495.175144745688, 28576.714232858238, 28852.134435966953, 29050.564241535973, 29405.705942940298, 41683.20643126079, 42240.577594223665, 42246.366304506075, 42246.366304506075, 42254.78872605618, 304179.0, 306492.0, 306672.0, 307487.0, 308307.0, 20511.18019251736, 24490.265292041266, 25234.116805911704, 25911.093111741, 26447.33881652974, 41275.0, 41544.169116618104, 41718.79140604277, 42291.36562951496, 42795.786021069696, 35821.28357432889, 36050.819745901106, 36053.0, 36262.8186859064, 36910.63089369072, 35646.0, 35890.4616430759, 35984.640153599175, 36493.0, 36544.81727591345, 35670.64329356673, 35694.0, 38114.80942595269, 38694.61305387023, 39565.0, 32031.0, 33404.665953340154, 33487.0, 33724.3255134891, 33777.662223377454, 24337.14819981292, 24857.378565536008, 25244.242672719847, 25694.229173124088, 25744.8712756435], "value": 17736.603299767834, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.35327294053053, 368.98339574719137, 371.73792476304203, 374.7039838527563, 377.3264722470391, 16467.0, 17043.914780426112, 17128.31486740529, 17477.213525391355, 17486.038267895277, 16007.519774406757, 16283.348666053344, 17017.57456063599, 17122.31510739569, 17160.39938602149, 4930.235813448921, 5074.238864170386, 5080.872978175556, 5115.693058416488, 5130.3074084998425, 3633.563972323325, 3853.3064048471265, 4992.575631071363, 5627.2684551008315, 5960.493358064569, 6016.518678505731, 6029.638221706711, 6049.909251361233, 6057.666828324463, 6060.272767267912, 5869.266341707286, 5914.585978981473, 6019.849503762397, 6037.63774173551, 6045.758169673208, 3270.885519006847, 4958.157113290749, 5265.183896496011, 5278.392984806758, 5300.284461597674, 19384.224631014742, 20165.09257083435, 20168.394948151432, 20173.5965280695, 20187.39437816853, 1910.2550005497867, 1971.7387421358724, 2040.7142999980015, 2143.678448232762, 2319.373769082355, 12745.299008554619, 12909.354532273443, 13039.348032598333, 13140.277284749334, 13363.265020423873, 1750.0724615953566, 1828.9817101829078, 1998.8500862435376, 2012.2471590483788, 2058.7941205879442, 67115.66442167807, 67195.32804671988, 67379.0, 67906.0, 68924.31075689229, 10031.498425078717, 10061.496925153859, 10204.336718113447, 10305.0, 10385.740356490996, 14179.22014289224, 14207.289635518182, 14278.643033924234, 14284.500042498463, 14286.642833929027, 6511.0558968949235, 6612.0, 6620.933790662128, 6666.666666666647, 6702.698378572976, 5885.176075349455, 6020.69896505173, 6092.573519853568, 6106.755729770848, 6107.236595425572, 4342.934855977162, 4464.352668862996, 4485.865424037284, 4554.225781617133, 4560.247559152769, 1711.3496871189118, 1741.7735694359906, 1819.9490215914577, 1840.720699114103, 1850.288483153078, 886.6187539358137, 889.2707979456912, 892.1970226795936, 895.1630225738955, 944.6410364061612, 16025.599360016093, 16760.1619919006, 16781.748273775902, 16866.694711835982, 16892.57768555796, 864.9610767515477, 883.8895138107737, 894.5035505294624, 925.0564424287189, 959.0553304994575, 9212.401193922373, 9524.476153811469, 9562.569684364082, 9582.233421326277, 9660.0, 393966.0, 394894.0, 396452.0, 397515.0, 404996.0, 73933.63033184799, 74552.25447745562, 74571.0, 74612.25387746161, 74832.25167748253, 913.2420091324185, 922.7923717163585, 941.0589410589411, 975.8341082016075, 975.9707208783748, 15667.0, 15760.0, 15838.28727707233, 15849.762253566436, 16180.838191617933, 33592.66407335895, 33972.0, 34125.65874341225, 34496.310073798886, 35121.64878351286, 42837.0, 47851.28223076587, 48010.75994620004, 48056.0, 48156.27765583449, 7158.391536719437, 7225.1329840419485, 7274.199838017708, 7367.631618419165, 7385.52289542083, 8287.295579875778, 10208.897911021091, 10414.843777343194, 10482.213833962636, 10630.52162652667, 8952.865707014531, 9103.408278461879, 9180.495072771062, 9313.906860931575, 9449.527523623929, 9057.456552606865, 9337.439753614804, 9474.052594740471, 9507.477088760184, 9527.28545359087, 8316.503029454756, 9327.86008209891, 9356.204722598655, 9432.783295925588, 9453.43279403238, 7095.538789978635, 7221.31397517235, 7250.709971601077, 7304.123505179413, 7341.559506429631, 7167.283271673, 8543.74368768913, 8790.956045219733, 9063.365564410427, 9270.072992700676], "value": 8095.342675143, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1249.2566922681, 1394.9721005579886, 1447.8190226221723, 1553.8679212266957, 1809.2220345251537, 6727.461803055756, 7434.070741157356, 7591.164971853092, 7593.544387336764, 7770.795526693371, 7539.170691223961, 7668.884966725504, 7669.463137580357, 7686.5772382518935, 7688.654010569524, 2158.093600687711, 2190.4195388222133, 2193.649016157415, 2196.1105752170315, 2196.516766311409, 2107.6627739561673, 2145.517258616814, 2176.064292354287, 2176.249194028058, 2180.7819218078225, 2116.2064225915283, 2130.2437634639714, 2139.903704333301, 2142.3787101740477, 2162.718846549946, 2092.9162833486644, 2098.097817938286, 2100.737407824022, 2101.548167144071, 2102.211670623524, 2054.732884724991, 2101.7898210179014, 2102.2747152232455, 2104.8737075775502, 2105.536781907978, 7612.657430415645, 7654.540727556365, 7657.272559106876, 7662.65518051689, 7710.498817576839, 4301.935470967938, 4463.531329210418, 4465.062336909253, 4466.218411777958, 4467.709598876095, 2919.7810164237767, 2939.92650183745, 2981.9403611927855, 2986.1190948670196, 3071.9232019199476, 925.2690374604055, 933.407286373158, 933.6592143867507, 936.7049379445452, 937.924966002725, 10533.36799792015, 10612.946935265274, 10624.362538247653, 10650.467476626138, 10655.413952232624, 4017.77902215381, 4124.319487284624, 4156.272652285898, 4194.014406614443, 4195.0, 8353.289970352467, 8397.202265784741, 8411.327093832479, 8415.747527574182, 8429.241368276762, 4236.110416812442, 4290.806913688892, 4293.527711951683, 4297.892552686208, 4303.591158839968, 3431.8970430886616, 3861.4014827701753, 3922.2351641429645, 3922.646961773454, 3993.1614360984518, 3375.274316022018, 3401.5748031496064, 3475.878344257939, 3485.3444613808238, 3522.1546828761425, 987.7530617345664, 1003.1673710820002, 1018.5823812236947, 1029.4492446541215, 1031.118393773328, 671.0873212431089, 699.7410957945593, 710.9111361079865, 719.1406269507993, 805.9032916050112, 4895.510448955147, 5054.646174767805, 5133.101707201225, 5171.63798534099, 5277.419483856773, 858.1632907914858, 875.9868601970976, 879.6701237036111, 898.1691934960136, 906.3338446242138, 3559.982200088983, 3593.2813437312643, 3633.9636603633626, 3641.908952276214, 3655.451682247684, 9625.614975401046, 9853.261005424622, 9873.555689993824, 9988.700338989842, 10003.449810260505, 9850.901490985141, 9869.506524673738, 9889.406635601887, 9897.158741506908, 9922.206223502102, 7349.889751653729, 7387.187409384964, 7469.962650186714, 7491.850162996819, 7497.512661676865, 5002.699838009586, 5053.797848086036, 5062.316587260672, 5089.51649593288, 5092.955944031539, 8761.737147885573, 9029.458232506071, 9085.318601105077, 9187.219086377732, 9192.95403522978, 9066.27469802401, 9212.263018958332, 9298.442093474414, 9306.348555601044, 9310.534473276444, 6307.526935479949, 6324.968375158095, 6356.173697419491, 6412.871742565029, 6450.903236451551, 7271.745488908075, 7451.2921272479025, 7455.254474552501, 7465.29079737424, 7472.103347598323, 6883.451223474678, 6938.0, 6940.201876784033, 7032.437405007689, 7051.823704407431, 6669.299723529154, 6780.355866192704, 6797.5581587196675, 6845.418139458202, 7040.718371265092, 6352.269489008639, 6380.617162970237, 6481.319461456667, 6547.476201903932, 6563.835904102436, 4434.689571729948, 4454.354118652842, 4476.977615111904, 4531.478879928851, 4575.199340115533, 4610.976945115253, 4740.312654665123, 4769.403824521934, 4803.1114243864995, 4822.855314340575], "value": 4065.2724379550714, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.21478186723044, 294.2760808411308, 298.5626057825284, 301.2288541334186, 304.10289645545635, 4716.839717389349, 4751.786169622363, 4759.476457589667, 4761.90476190476, 4801.303810947419, 4724.1260366832075, 4754.239321708527, 4759.785809638566, 4764.309175169598, 4777.163996300651, 3596.7662101963356, 3701.2597480503873, 3709.981450092746, 3787.5644300905474, 3814.2180852925085, 3731.514903062598, 3781.149241420686, 3802.4676545283683, 3807.9048023799487, 3810.5236845394325, 3530.858765649371, 3730.123420996077, 3741.644543768338, 3742.6257374262627, 3747.362948298782, 3643.325984692827, 3745.7752534847723, 3758.49260349852, 3759.0978165240417, 3763.247350529905, 3361.092505023654, 3366.0, 3373.1398493384277, 3374.7131493823053, 3378.6452422495777, 4499.52754960731, 4509.25597276449, 4532.252178390561, 4535.569120933506, 4550.203714349976, 4172.624463798243, 4180.895477613084, 4290.356446533014, 4329.610335069828, 4335.479742430897, 4907.411110666742, 4949.331840201563, 4953.0836795192645, 4973.229149481836, 4984.950150498485, 3645.9453108203134, 3668.52309199805, 3670.15586415126, 3672.6510981456986, 3688.2992231475932, 4977.527134922177, 5120.411152717448, 5146.794128234867, 5161.66449180802, 5169.0, 3573.749837511349, 3603.56757189139, 3608.079939615381, 3614.403623402109, 3626.0, 3664.8350824212976, 3697.7041836653, 3707.462417949382, 3711.6659500645073, 3723.1064544509663, 4058.492688413948, 4178.22702799983, 4200.4038465382955, 4207.789610519461, 4238.279492486285, 4894.975525122351, 4897.534734200245, 4918.139325618003, 4928.162212423897, 4959.553640172402, 1304.9412776425083, 1311.1084462565357, 1319.280991859439, 1320.39261939507, 1321.2468892731051, 854.3805740837967, 869.8086420987372, 895.7044175422095, 898.9101089890959, 907.2469850024464, 4386.276264416336, 4387.670924680598, 4407.27279998803, 4407.603315701603, 4413.801378937956, 5049.873753156127, 5059.241113832954, 5060.671056381323, 5067.366579177603, 5079.8984020319385, 4263.914721705611, 4263.957360426418, 4342.717723347972, 4352.7823608819435, 4377.649788016951, 2661.401184733458, 2682.114902082308, 2689.5024420482273, 2693.905713300025, 2694.9461010779673, 4741.241401375763, 4768.354917553438, 4790.4969978152485, 4795.20879054959, 4804.765783910499, 4972.453030166679, 5082.390113186441, 5086.0, 5108.897822043538, 5120.825088445188, 4843.660943734046, 4866.124097662384, 4871.878203044952, 4878.414590249193, 4887.144749668793, 5084.51697088776, 5117.437081920912, 5136.357955255593, 5140.3831540215415, 5161.561267292323, 4835.637327200404, 5041.974790126026, 5073.416557095834, 5074.112030394593, 5097.362829646294, 4880.877978050577, 4910.950890491049, 4919.2129259318335, 4921.311016457627, 4929.9154186079, 3651.1967367179177, 3659.359612067931, 3692.667659910621, 3695.6304369562827, 3707.9814600926825, 4870.634702397405, 5082.898342033212, 5116.386033675983, 5116.718580478109, 5194.662346947436, 4921.981987385155, 4937.136001199704, 4943.4562198157455, 4946.996466431101, 4950.356453661001, 4950.950490495193, 4955.752212389294, 4978.651494395358, 4980.452150263541, 4995.675281106716, 4609.884752881205, 4877.0, 4878.0, 4882.170031094794, 4925.876853078702, 4756.548127927841, 4864.318995340726, 4992.925106123338, 5006.098902197639, 5034.194528875362, 4919.409670839522, 4927.9507204927495, 4928.0, 4929.876753081202, 4931.654784165074], "value": 3763.8713820824023, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [629.8205011571703, 637.8883695353314, 659.1661548141602, 659.3933581105382, 760.4524742185624, 11414.942925285372, 12080.69798255044, 12162.087843411757, 12186.81719774203, 12195.268283902971, 12177.0, 12221.083418743607, 12240.265584064962, 12246.693832654188, 12267.0, 623.7629700713723, 769.0732667136087, 782.2724865874734, 797.8962734844462, 801.527099011583, 800.1878093734834, 800.6157044618586, 805.2591615713528, 805.3436449293807, 806.8265322955564, 841.3689732700475, 843.9662413503453, 846.2087947768825, 851.2551517422255, 851.3019324154196, 656.1535619051418, 816.999999999997, 834.4200780457585, 836.9370898958289, 837.4682076881163, 615.6644628677382, 616.9660668663222, 617.1206031405275, 617.3579477343558, 619.5013014523307, 12519.624411267676, 12531.874681253254, 12541.0, 12574.371281435982, 12584.37078146089, 11798.410079496076, 12123.33321667308, 12234.327112008836, 12507.749845003049, 12537.185082969578, 10898.346099234072, 10951.945240273828, 11175.0, 11279.661610151708, 11355.432228388547, 4076.5923407659293, 4085.816138273785, 4108.281050816096, 4252.08580155265, 4262.552431994627, 44712.0, 44785.55214447879, 45015.54984450146, 46638.76680616609, 47043.52956470426, 9703.660371887092, 9749.512524373753, 9922.355046921926, 9977.10206081456, 10044.799104017879, 17045.91477042607, 17163.7425438616, 17163.742543861852, 17166.31334746621, 17166.742498862528, 6709.094272273278, 6854.691538880762, 6868.347506986828, 6870.31296870319, 7063.04648872406, 3787.9242415151543, 3790.5640851302455, 3800.980995095062, 3849.01850028241, 3886.125621735087, 2662.400959784033, 2715.0361621624434, 2739.931501712433, 2745.629340039069, 2747.3406382468065, 471.96696231264167, 496.6895690193629, 507.0872429626657, 512.8564002079423, 513.637885290869, 480.9591184749265, 540.7890922540213, 554.1466142141138, 566.8271177290883, 613.4969325153421, 8217.712380066669, 8273.46222495536, 8288.751337459886, 8335.49987000782, 8450.0, 540.7620646915344, 600.4115966352998, 615.3139249736512, 624.3194917539903, 634.7587916591758, 3643.7429086964953, 3745.250949810049, 3826.9808650956566, 3868.4777555030273, 3909.9609003910164, 50862.74568627133, 51616.22575661368, 51619.741901290254, 51663.0, 52027.47972520226, 45724.314135288, 46311.0, 46606.76696616495, 47158.0, 48219.75890120597, 43181.13637727291, 43190.0, 43513.34729979053, 43824.0, 44074.0, 7528.623568821647, 7705.383569314554, 7725.150233474201, 7776.650050747617, 7778.377729781717, 30353.0, 30666.080017599506, 31122.066338009896, 31201.8439907799, 31275.0, 36990.44514332234, 37444.62555374411, 39887.2022559553, 39974.80012599919, 40480.1903961925, 10187.235957303084, 10202.897971020491, 10413.583456661649, 10424.530896109542, 10666.413347265974, 9972.900270997197, 10627.468626568796, 10796.89203107959, 10902.400367979837, 11007.394593297126, 9494.335396522178, 9754.812281259852, 10025.248106391904, 10088.54601542947, 10188.745281368025, 9617.615295388106, 9740.951295243762, 9858.753531161778, 10073.798524029626, 10083.798324033332, 9786.217102631916, 9966.252531060345, 10028.424674612335, 10094.444805535766, 10130.08829205375, 8506.276966457674, 8597.914020859962, 8617.69838055665, 8861.867071994055, 8916.0, 8491.320694344562, 8861.512616806138, 8879.556022198993, 8895.421797583136, 8999.19007289347], "value": 5852.158858739281, "unit": "score"}], "name": "dromaeo_css", "value": 6265.556553578146, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 109.0, 114.0, 115.0, 113.0, 113.0, 112.0, 113.0, 114.0, 114.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 130.0, 140.0, 210.0, 142.0, 156.0, 156.0, 140.0, 185.0, 131.0], "value": 155.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 161.0, 162.0, 161.0, 161.0, 162.0, 162.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 136.0, 76.0, 76.0, 76.0, 76.0, 121.0, 75.0], "value": 86.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 164.0, 94.0, 94.0, 95.0, 121.0, 93.0, 93.0, 136.0], "value": 107.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 118.0, 117.0, 118.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0, 96.0, 96.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 63.0, 64.0, 65.0, 65.0, 64.0, 64.0, 64.0, 63.0, 64.0], "value": 64.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 66.0, 64.0, 65.0, 65.0, 65.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 83.0, 81.0, 83.0, 85.0, 84.0, 165.0, 83.0], "value": 91.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 139.0, 139.0, 130.0, 128.0, 135.0, 125.0, 136.0, 146.0, 133.0], "value": 134.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 174.0, 188.0, 173.0, 176.0, 173.0, 172.0, 171.0, 172.0, 169.0], "value": 174.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 68.0, 68.0, 70.0, 66.0, 66.0, 75.0, 70.0, 65.0], "value": 68.1, "unit": "score"}], "name": "kraken", "value": 1579.2999999999997, "alertThreshold": 2.0}]} 12:51:06 INFO - Return code: 0 12:51:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:51:06 ERROR - # TBPL SUCCESS # 12:51:06 INFO - Running post-action listener: _resource_record_post_action 12:51:06 INFO - ##### 12:51:06 INFO - ##### Finished run-tests step (success) 12:51:06 INFO - ##### 12:51:06 INFO - Running post-run listener: _resource_record_post_run 12:51:06 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 530657280; Read time: 136; Write time: 332288 12:51:06 INFO - TinderboxPrint: CPU usage
13.0% 12:51:06 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 136 12:51:06 INFO - TinderboxPrint: I/O write bytes / time
530,657,280 / 332,288 12:51:06 INFO - TinderboxPrint: CPU idle
8,334.8 (86.9%) 12:51:06 INFO - TinderboxPrint: CPU user
1,210.6 (12.6%) 12:51:06 INFO - TinderboxPrint: Swap in / out
0 / 0 12:51:06 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 236838912; Read time: 0; Write time: 182764 12:51:06 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293818368; Read time: 136; Write time: 149524 12:51:07 INFO - Running post-run listener: _upload_blobber_files 12:51:07 INFO - Blob upload gear active. 12:51:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:51:07 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 12:51:07 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'] 12:51:07 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 12:51:08 INFO - (blobuploader) - INFO - Open directory for files ... 12:51:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:51:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:51:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:51:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:51:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:51:09 INFO - (blobuploader) - INFO - Done attempting. 12:51:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:51:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:51:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:51:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:51:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:51:12 INFO - (blobuploader) - INFO - Done attempting. 12:51:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:51:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:51:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:51:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:51:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:51:16 INFO - (blobuploader) - INFO - Done attempting. 12:51:16 INFO - (blobuploader) - INFO - Iteration through files over. 12:51:16 INFO - Return code: 0 12:51:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:51:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:51:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/801f98edea9667b819d96f2c6438233f59b02fd792d7e5ad5ef87ec0d7cf31124f4eebce48a3f5d7e1b64446122364f9d482dab2d041c593e9a5d3e69dbbd10c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b08ae9d4e038868f16645fbf0be300df60bf974990b76016fbe388eb876b918f460d73afdf367ce15d59dab9da2ab5199da2accfd00c5a2dcdfc20962a798aa7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/84bbc1b664321be9bb327b58c8a64a3c2d9bbf8b3446e6694fe18ebb07a003dfdf93dbe49b18704c85188489e9c824616be3291679214601b4b15c9186189e58"} 12:51:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:51:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:51:16 INFO - Contents: 12:51:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/801f98edea9667b819d96f2c6438233f59b02fd792d7e5ad5ef87ec0d7cf31124f4eebce48a3f5d7e1b64446122364f9d482dab2d041c593e9a5d3e69dbbd10c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b08ae9d4e038868f16645fbf0be300df60bf974990b76016fbe388eb876b918f460d73afdf367ce15d59dab9da2ab5199da2accfd00c5a2dcdfc20962a798aa7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/84bbc1b664321be9bb327b58c8a64a3c2d9bbf8b3446e6694fe18ebb07a003dfdf93dbe49b18704c85188489e9c824616be3291679214601b4b15c9186189e58"} 12:51:16 INFO - Running post-run listener: copy_logs_to_upload_dir 12:51:16 INFO - Copying logs to upload dir... 12:51:16 INFO - mkdir: /builds/slave/test/build/upload/logs 12:51:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.111738 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-05-23 12:51:16.491888) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 12:51:16.494935) ========= 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=ea34ab03e80221fdf844251c000001a3-1464031573.155194-759672629 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/801f98edea9667b819d96f2c6438233f59b02fd792d7e5ad5ef87ec0d7cf31124f4eebce48a3f5d7e1b64446122364f9d482dab2d041c593e9a5d3e69dbbd10c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b08ae9d4e038868f16645fbf0be300df60bf974990b76016fbe388eb876b918f460d73afdf367ce15d59dab9da2ab5199da2accfd00c5a2dcdfc20962a798aa7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/84bbc1b664321be9bb327b58c8a64a3c2d9bbf8b3446e6694fe18ebb07a003dfdf93dbe49b18704c85188489e9c824616be3291679214601b4b15c9186189e58"} build_url:https://queue.taskcluster.net/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011263 build_url: 'https://queue.taskcluster.net/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/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/801f98edea9667b819d96f2c6438233f59b02fd792d7e5ad5ef87ec0d7cf31124f4eebce48a3f5d7e1b64446122364f9d482dab2d041c593e9a5d3e69dbbd10c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b08ae9d4e038868f16645fbf0be300df60bf974990b76016fbe388eb876b918f460d73afdf367ce15d59dab9da2ab5199da2accfd00c5a2dcdfc20962a798aa7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/84bbc1b664321be9bb327b58c8a64a3c2d9bbf8b3446e6694fe18ebb07a003dfdf93dbe49b18704c85188489e9c824616be3291679214601b4b15c9186189e58"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 12:51:16.520047) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 12:51:16.520396) ========= 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=ea34ab03e80221fdf844251c000001a3-1464031573.155194-759672629 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004696 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 12:51:16.604626) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 12:51:16.604939) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 12:51:16.605240) ========= ========= Total master_lag: 0.18 =========