builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-036 starttime: 1464392657.72 results: success (0) buildid: 20160527161740 builduid: 37a6d34321b142ecb945c297c69c8570 revision: 1bd815acf6d3d51ded73a0ffbe05bd8a2c515784 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 16:44:17.722454) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 16:44:17.723099) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 16:44:17.723465) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 16:44:17.738960) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 16:44:17.739355) ========= 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=14ef55db36f7623abb31b9cf000001d5-1464392275.220705-773915763 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-27 16:44:17-- 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% 28.9M=0s 2016-05-27 16:44:17 (28.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121147 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 16:44:17.879248) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 16:44:17.879572) ========= 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=14ef55db36f7623abb31b9cf000001d5-1464392275.220705-773915763 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020613 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 16:44:17.930267) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 16:44:17.930644) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1bd815acf6d3d51ded73a0ffbe05bd8a2c515784 --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 1bd815acf6d3d51ded73a0ffbe05bd8a2c515784 --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=14ef55db36f7623abb31b9cf000001d5-1464392275.220705-773915763 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-27 16:44:18,079 truncating revision to first 12 chars 2016-05-27 16:44:18,079 Setting DEBUG logging. 2016-05-27 16:44:18,079 attempt 1/10 2016-05-27 16:44:18,079 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1bd815acf6d3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-27 16:44:18,386 unpacking tar archive at: fx-team-1bd815acf6d3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.646842 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 16:44:18.591303) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 16:44:18.591674) ========= script_repo_revision: 1bd815acf6d3d51ded73a0ffbe05bd8a2c515784 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 16:44:18.592113) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 16:44:18.592402) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 16:44:18.601653) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-05-27 16:44:18.602080) ========= /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=14ef55db36f7623abb31b9cf000001d5-1464392275.220705-773915763 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:44:18 INFO - MultiFileLogger online at 20160527 16:44:18 in /builds/slave/test 16:44:18 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 16:44:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:44:18 INFO - {'append_to_log': False, 16:44:18 INFO - 'base_work_dir': '/builds/slave/test', 16:44:18 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:44:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:44:18 INFO - 'branch': 'Fx-Team-Non-PGO', 16:44:18 INFO - 'buildbot_json_path': 'buildprops.json', 16:44:18 INFO - 'config_files': ('talos/linux_config.py',), 16:44:18 INFO - 'default_actions': ('clobber', 16:44:18 INFO - 'read-buildbot-config', 16:44:18 INFO - 'download-and-extract', 16:44:18 INFO - 'populate-webroot', 16:44:18 INFO - 'create-virtualenv', 16:44:18 INFO - 'install', 16:44:18 INFO - 'run-tests'), 16:44:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:44:18 INFO - 'download_minidump_stackwalk': True, 16:44:18 INFO - 'download_symbols': 'ondemand', 16:44:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:44:18 INFO - 'tooltool.py': '/tools/tooltool.py', 16:44:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:44:18 INFO - '/tools/misc-python/virtualenv.py')}, 16:44:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:44:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:44:18 INFO - 'installer_path': 'installer.exe', 16:44:18 INFO - 'log_level': 'info', 16:44:18 INFO - 'log_name': 'talos', 16:44:18 INFO - 'log_to_console': True, 16:44:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:44:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:44:18 INFO - 'opt_config_files': (), 16:44:18 INFO - 'pip_index': False, 16:44:18 INFO - 'sps_profile': False, 16:44:18 INFO - 'sps_profile_interval': 0, 16:44:18 INFO - 'suite': 'dromaeojs', 16:44:18 INFO - 'system_bits': '32', 16:44:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:44:18 INFO - 'title': 'talos-linux64-ix-036', 16:44:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:44:18 INFO - 'use_talos_json': True, 16:44:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:44:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:44:18 INFO - 'work_dir': 'build'} 16:44:18 INFO - ##### 16:44:18 INFO - ##### Running clobber step. 16:44:18 INFO - ##### 16:44:18 INFO - Running pre-action listener: _resource_record_pre_action 16:44:18 INFO - Running main action method: clobber 16:44:18 INFO - rmtree: /builds/slave/test/build 16:44:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:44:19 INFO - Running post-action listener: _resource_record_post_action 16:44:19 INFO - ##### 16:44:19 INFO - ##### Finished clobber step (success) 16:44:19 INFO - ##### 16:44:19 INFO - ##### 16:44:19 INFO - ##### Running read-buildbot-config step. 16:44:19 INFO - ##### 16:44:19 INFO - Running pre-action listener: _resource_record_pre_action 16:44:19 INFO - Running main action method: read_buildbot_config 16:44:19 INFO - Using buildbot properties: 16:44:19 INFO - { 16:44:19 INFO - "project": "", 16:44:19 INFO - "product": "firefox", 16:44:19 INFO - "script_repo_revision": "production", 16:44:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:44:19 INFO - "repository": "", 16:44:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 16:44:19 INFO - "buildid": "20160527161740", 16:44:19 INFO - "pgo_build": "False", 16:44:19 INFO - "basedir": "/builds/slave/test", 16:44:19 INFO - "buildnumber": 1796, 16:44:19 INFO - "slavename": "talos-linux64-ix-036", 16:44:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:44:19 INFO - "platform": "ubuntu64_hw", 16:44:19 INFO - "scheduler": "tests-fx-team-linux64-talos", 16:44:19 INFO - "branch": "fx-team", 16:44:19 INFO - "repo_path": "integration/fx-team", 16:44:19 INFO - "revision": "1bd815acf6d3d51ded73a0ffbe05bd8a2c515784", 16:44:19 INFO - "stage_platform": "linux64", 16:44:19 INFO - "builduid": "37a6d34321b142ecb945c297c69c8570", 16:44:19 INFO - "slavebuilddir": "test" 16:44:19 INFO - } 16:44:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/Fp0Ea1pdSoKfGxsnV7e2ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 16:44:19 INFO - Running post-action listener: _resource_record_post_action 16:44:19 INFO - ##### 16:44:19 INFO - ##### Finished read-buildbot-config step (success) 16:44:19 INFO - ##### 16:44:19 INFO - ##### 16:44:19 INFO - ##### Running download-and-extract step. 16:44:19 INFO - ##### 16:44:19 INFO - Running pre-action listener: _resource_record_pre_action 16:44:19 INFO - Running main action method: download_and_extract 16:44:19 INFO - mkdir: /builds/slave/test/build/tests 16:44:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:19 INFO - https://queue.taskcluster.net/v1/task/Fp0Ea1pdSoKfGxsnV7e2ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:44:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fp0Ea1pdSoKfGxsnV7e2ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:44:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fp0Ea1pdSoKfGxsnV7e2ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:44:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fp0Ea1pdSoKfGxsnV7e2ag/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 16:44:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fp0Ea1pdSoKfGxsnV7e2ag/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 16:44:19 INFO - Downloaded 1361 bytes. 16:44:19 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:44:19 INFO - Using the following test package requirements: 16:44:19 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 16:44:19 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:44:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:44:19 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:44:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:44:19 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:44:19 INFO - u'jsshell-linux-x86_64.zip'], 16:44:19 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:44:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:44:19 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 16:44:19 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:44:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:44:19 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:44:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:44:19 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:44:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:44:19 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:44:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:44:19 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:44:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:19 INFO - https://queue.taskcluster.net/v1/task/Fp0Ea1pdSoKfGxsnV7e2ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:44:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fp0Ea1pdSoKfGxsnV7e2ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:44:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fp0Ea1pdSoKfGxsnV7e2ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:44:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fp0Ea1pdSoKfGxsnV7e2ag/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 16:44:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fp0Ea1pdSoKfGxsnV7e2ag/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 16:44:21 INFO - Downloaded 22837934 bytes. 16:44:21 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'] 16:44:21 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 16:44:22 INFO - Return code: 0 16:44:22 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 16:44:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:22 INFO - https://queue.taskcluster.net/v1/task/Fp0Ea1pdSoKfGxsnV7e2ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:44:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fp0Ea1pdSoKfGxsnV7e2ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:44:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fp0Ea1pdSoKfGxsnV7e2ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:44:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fp0Ea1pdSoKfGxsnV7e2ag/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 16:44:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fp0Ea1pdSoKfGxsnV7e2ag/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 16:44:23 INFO - Downloaded 22837934 bytes. 16:44:23 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'] 16:44:23 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 16:44:25 INFO - Return code: 0 16:44:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:25 INFO - https://queue.taskcluster.net/v1/task/Fp0Ea1pdSoKfGxsnV7e2ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:44:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fp0Ea1pdSoKfGxsnV7e2ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:44:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fp0Ea1pdSoKfGxsnV7e2ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:44:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fp0Ea1pdSoKfGxsnV7e2ag/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 16:44:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fp0Ea1pdSoKfGxsnV7e2ag/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 16:44:26 INFO - Downloaded 10834034 bytes. 16:44:26 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'] 16:44:26 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 16:44:27 INFO - Return code: 0 16:44: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')]} 16:44:27 INFO - https://queue.taskcluster.net/v1/task/Fp0Ea1pdSoKfGxsnV7e2ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:44:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fp0Ea1pdSoKfGxsnV7e2ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:44:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fp0Ea1pdSoKfGxsnV7e2ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:44:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fp0Ea1pdSoKfGxsnV7e2ag/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 16:44:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fp0Ea1pdSoKfGxsnV7e2ag/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 16:44:31 INFO - Downloaded 54848669 bytes. 16:44:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fp0Ea1pdSoKfGxsnV7e2ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:44:31 INFO - mkdir: /builds/slave/test/properties 16:44:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:44:31 INFO - Writing to file /builds/slave/test/properties/build_url 16:44:31 INFO - Contents: 16:44:31 INFO - build_url:https://queue.taskcluster.net/v1/task/Fp0Ea1pdSoKfGxsnV7e2ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:44:31 INFO - Running post-action listener: _resource_record_post_action 16:44:31 INFO - Running post-action listener: set_extra_try_arguments 16:44:31 INFO - ##### 16:44:31 INFO - ##### Finished download-and-extract step (success) 16:44:31 INFO - ##### 16:44:31 INFO - ##### 16:44:31 INFO - ##### Running populate-webroot step. 16:44:31 INFO - ##### 16:44:31 INFO - Running pre-action listener: _resource_record_pre_action 16:44:31 INFO - Running main action method: populate_webroot 16:44:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:44:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:44:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:44:31 INFO - '--tppagecycles', 16:44:31 INFO - '7'], 16:44:31 INFO - 'tests': ['tsvgm']}}, 16:44:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:44:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:44:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:44:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:44:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:44:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:44:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:31 INFO - 'talos_options': ['--disable-e10s'], 16:44:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:44:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:44:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:31 INFO - 'talos_options': ['--disable-e10s'], 16:44:31 INFO - 'tests': ['damp', 'tps']}, 16:44:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:31 INFO - 'tests': ['damp', 'tps']}, 16:44:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:44:31 INFO - 'tests': ['dromaeo_dom']}, 16:44:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:44:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:44:31 INFO - 'tests': ['a11yr', 16:44:31 INFO - 'ts_paint', 16:44:31 INFO - 'tpaint', 16:44:31 INFO - 'sessionrestore', 16:44:31 INFO - 'sessionrestore_no_auto_restore', 16:44:31 INFO - 'tabpaint']}, 16:44:31 INFO - 'other-e10s': {'tests': ['a11yr', 16:44:31 INFO - 'ts_paint', 16:44:31 INFO - 'tpaint', 16:44:31 INFO - 'sessionrestore', 16:44:31 INFO - 'sessionrestore_no_auto_restore', 16:44:31 INFO - 'tabpaint']}, 16:44:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:44:31 INFO - 'ts_paint', 16:44:31 INFO - 'tpaint', 16:44:31 INFO - 'sessionrestore', 16:44:31 INFO - 'sessionrestore_no_auto_restore', 16:44:31 INFO - 'tabpaint']}, 16:44:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:44:31 INFO - 'ts_paint', 16:44:31 INFO - 'tpaint', 16:44:31 INFO - 'sessionrestore', 16:44:31 INFO - 'sessionrestore_no_auto_restore', 16:44:31 INFO - 'tabpaint']}, 16:44:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:44:31 INFO - 'tests': ['a11yr', 16:44:31 INFO - 'ts_paint', 16:44:31 INFO - 'tpaint', 16:44:31 INFO - 'sessionrestore', 16:44:31 INFO - 'sessionrestore_no_auto_restore', 16:44:31 INFO - 'tabpaint']}, 16:44:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:44:31 INFO - 'tests': ['a11yr', 16:44:31 INFO - 'ts_paint', 16:44:31 INFO - 'tpaint', 16:44:31 INFO - 'sessionrestore', 16:44:31 INFO - 'sessionrestore_no_auto_restore', 16:44:31 INFO - 'tabpaint']}, 16:44:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:44:31 INFO - 'tests': ['tsvgx', 16:44:31 INFO - 'tsvgr_opacity', 16:44:31 INFO - 'tart', 16:44:31 INFO - 'tscrollx', 16:44:31 INFO - 'cart']}, 16:44:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:44:31 INFO - 'tsvgr_opacity', 16:44:31 INFO - 'tart', 16:44:31 INFO - 'tscrollx', 16:44:31 INFO - 'cart']}, 16:44:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:31 INFO - 'talos_options': ['--disable-e10s'], 16:44:31 INFO - 'tests': ['tp5o']}, 16:44:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:31 INFO - 'tests': ['tp5o']}, 16:44:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:31 INFO - 'talos_options': ['--disable-e10s', 16:44:31 INFO - '--xperf_path', 16:44:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:44:31 INFO - 'tests': ['tp5n']}, 16:44:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:31 INFO - 'talos_options': ['--xperf_path', 16:44:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:44:31 INFO - 'tests': ['tp5n']}}, 16:44:31 INFO - 'talos.zip': {'path': '', 16:44:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:44:31 INFO - Running post-action listener: _resource_record_post_action 16:44:31 INFO - ##### 16:44:31 INFO - ##### Finished populate-webroot step (success) 16:44:31 INFO - ##### 16:44:31 INFO - ##### 16:44:31 INFO - ##### Running create-virtualenv step. 16:44:31 INFO - ##### 16:44:31 INFO - Running pre-action listener: _resource_record_pre_action 16:44:31 INFO - Running main action method: create_virtualenv 16:44:31 INFO - Creating virtualenv /builds/slave/test/build/venv 16:44:31 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 16:44:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:44:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:44:32 INFO - Using real prefix '/usr' 16:44:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:44:32 INFO - Installing distribute.............................................................................................................................................................................................done. 16:44:34 INFO - Installing pip.................done. 16:44:34 INFO - Return code: 0 16:44:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:44:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:34 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 0x7f0fe3d7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1764770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f39c0>, '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 0x17f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f4d50>, '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': '14ef55db36f7623abb31b9cf000001d5-1464392275.220705-773915763', '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 16:44:34 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 16:44:34 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 16:44:34 INFO - Using env: {'DISPLAY': ':0', 16:44:34 INFO - 'HOME': '/home/cltbld', 16:44:34 INFO - 'LANG': 'en_US.UTF-8', 16:44:34 INFO - 'LANGUAGE': 'en_US:en', 16:44:34 INFO - 'LOGNAME': 'cltbld', 16:44:34 INFO - 'MAIL': '/var/mail/cltbld', 16:44:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:34 INFO - 'MOZ_NO_REMOTE': '1', 16:44:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:34 INFO - 'NO_EM_RESTART': '1', 16:44:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:34 INFO - 'PWD': '/builds/slave/test', 16:44:34 INFO - 'SHELL': '/bin/bash', 16:44:34 INFO - 'SHLVL': '1', 16:44:34 INFO - 'TERM': 'linux', 16:44:34 INFO - 'TMOUT': '86400', 16:44:34 INFO - 'USER': 'cltbld', 16:44:34 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1464392275.220705-773915763', 16:44:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:34 INFO - '_': '/tools/buildbot/bin/python'} 16:44:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:34 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 16:44:34 INFO - Cleaning up... 16:44:34 INFO - Return code: 0 16:44:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:44:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:34 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 0x7f0fe3d7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1764770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f39c0>, '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 0x17f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f4d50>, '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': '14ef55db36f7623abb31b9cf000001d5-1464392275.220705-773915763', '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 16:44:34 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 16:44:34 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 16:44:34 INFO - Using env: {'DISPLAY': ':0', 16:44:34 INFO - 'HOME': '/home/cltbld', 16:44:34 INFO - 'LANG': 'en_US.UTF-8', 16:44:34 INFO - 'LANGUAGE': 'en_US:en', 16:44:34 INFO - 'LOGNAME': 'cltbld', 16:44:34 INFO - 'MAIL': '/var/mail/cltbld', 16:44:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:34 INFO - 'MOZ_NO_REMOTE': '1', 16:44:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:34 INFO - 'NO_EM_RESTART': '1', 16:44:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:34 INFO - 'PWD': '/builds/slave/test', 16:44:34 INFO - 'SHELL': '/bin/bash', 16:44:34 INFO - 'SHLVL': '1', 16:44:34 INFO - 'TERM': 'linux', 16:44:34 INFO - 'TMOUT': '86400', 16:44:34 INFO - 'USER': 'cltbld', 16:44:34 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1464392275.220705-773915763', 16:44:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:34 INFO - '_': '/tools/buildbot/bin/python'} 16:44:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:34 INFO - Downloading/unpacking psutil>=3.1.1 16:44:34 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 16:44:34 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 16:44:34 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 16:44:34 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 16:44:34 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 16:44:34 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 16:44:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:44:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:44:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:44:36 INFO - Installing collected packages: psutil 16:44:36 INFO - Running setup.py install for psutil 16:44:36 INFO - building 'psutil._psutil_linux' extension 16:44:36 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 16:44:37 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 16:44:37 INFO - building 'psutil._psutil_posix' extension 16:44:37 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 16:44:37 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 16:44:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:44:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:44:37 INFO - Successfully installed psutil 16:44:37 INFO - Cleaning up... 16:44:37 INFO - Return code: 0 16:44:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:44: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')]} 16:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44: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')]} 16:44:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0fe3d7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1764770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f39c0>, '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 0x17f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f4d50>, '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': '14ef55db36f7623abb31b9cf000001d5-1464392275.220705-773915763', '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 16:44:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:44:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:44:37 INFO - Using env: {'DISPLAY': ':0', 16:44:37 INFO - 'HOME': '/home/cltbld', 16:44:37 INFO - 'LANG': 'en_US.UTF-8', 16:44:37 INFO - 'LANGUAGE': 'en_US:en', 16:44:37 INFO - 'LOGNAME': 'cltbld', 16:44:37 INFO - 'MAIL': '/var/mail/cltbld', 16:44:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:37 INFO - 'MOZ_NO_REMOTE': '1', 16:44:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:37 INFO - 'NO_EM_RESTART': '1', 16:44:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:37 INFO - 'PWD': '/builds/slave/test', 16:44:37 INFO - 'SHELL': '/bin/bash', 16:44:37 INFO - 'SHLVL': '1', 16:44:37 INFO - 'TERM': 'linux', 16:44:37 INFO - 'TMOUT': '86400', 16:44:37 INFO - 'USER': 'cltbld', 16:44:37 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1464392275.220705-773915763', 16:44:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:37 INFO - '_': '/tools/buildbot/bin/python'} 16:44:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:44:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:44:39 INFO - Installing collected packages: mozsystemmonitor 16:44:39 INFO - Running setup.py install for mozsystemmonitor 16:44:39 INFO - Successfully installed mozsystemmonitor 16:44:39 INFO - Cleaning up... 16:44:39 INFO - Return code: 0 16:44:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:44: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')]} 16:44:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44: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')]} 16:44:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:39 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 0x7f0fe3d7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1764770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f39c0>, '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 0x17f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f4d50>, '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': '14ef55db36f7623abb31b9cf000001d5-1464392275.220705-773915763', '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 16:44:39 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 16:44:39 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 16:44:39 INFO - Using env: {'DISPLAY': ':0', 16:44:39 INFO - 'HOME': '/home/cltbld', 16:44:39 INFO - 'LANG': 'en_US.UTF-8', 16:44:39 INFO - 'LANGUAGE': 'en_US:en', 16:44:39 INFO - 'LOGNAME': 'cltbld', 16:44:39 INFO - 'MAIL': '/var/mail/cltbld', 16:44:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:39 INFO - 'MOZ_NO_REMOTE': '1', 16:44:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:39 INFO - 'NO_EM_RESTART': '1', 16:44:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:39 INFO - 'PWD': '/builds/slave/test', 16:44:39 INFO - 'SHELL': '/bin/bash', 16:44:39 INFO - 'SHLVL': '1', 16:44:39 INFO - 'TERM': 'linux', 16:44:39 INFO - 'TMOUT': '86400', 16:44:39 INFO - 'USER': 'cltbld', 16:44:39 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1464392275.220705-773915763', 16:44:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:39 INFO - '_': '/tools/buildbot/bin/python'} 16:44:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:39 INFO - Downloading/unpacking blobuploader==1.2.4 16:44:39 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 16:44:39 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 16:44:39 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 16:44:39 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 16:44:39 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 16:44:39 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 16:44:41 INFO - Downloading blobuploader-1.2.4.tar.gz 16:44:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:44:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:44:41 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 16:44:41 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 16:44:41 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 16:44:41 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 16:44:41 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 16:44:41 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 16:44:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:44:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:44:42 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 16:44:42 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 16:44:42 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 16:44:42 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 16:44:42 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 16:44:42 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 16:44:42 INFO - Downloading docopt-0.6.1.tar.gz 16:44:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:44:42 INFO - Installing collected packages: blobuploader, requests, docopt 16:44:42 INFO - Running setup.py install for blobuploader 16:44:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:44:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:44:42 INFO - Running setup.py install for requests 16:44:43 INFO - Running setup.py install for docopt 16:44:43 INFO - Successfully installed blobuploader requests docopt 16:44:43 INFO - Cleaning up... 16:44:43 INFO - Return code: 0 16:44:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:44: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')]} 16:44:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44: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')]} 16:44:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:43 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 0x7f0fe3d7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1764770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f39c0>, '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 0x17f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f4d50>, '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': '14ef55db36f7623abb31b9cf000001d5-1464392275.220705-773915763', '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 16:44:43 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 16:44:43 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 16:44:43 INFO - Using env: {'DISPLAY': ':0', 16:44:43 INFO - 'HOME': '/home/cltbld', 16:44:43 INFO - 'LANG': 'en_US.UTF-8', 16:44:43 INFO - 'LANGUAGE': 'en_US:en', 16:44:43 INFO - 'LOGNAME': 'cltbld', 16:44:43 INFO - 'MAIL': '/var/mail/cltbld', 16:44:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:43 INFO - 'MOZ_NO_REMOTE': '1', 16:44:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:43 INFO - 'NO_EM_RESTART': '1', 16:44:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:43 INFO - 'PWD': '/builds/slave/test', 16:44:43 INFO - 'SHELL': '/bin/bash', 16:44:43 INFO - 'SHLVL': '1', 16:44:43 INFO - 'TERM': 'linux', 16:44:43 INFO - 'TMOUT': '86400', 16:44:43 INFO - 'USER': 'cltbld', 16:44:43 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1464392275.220705-773915763', 16:44:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:43 INFO - '_': '/tools/buildbot/bin/python'} 16:44:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:44:43 INFO - Running setup.py (path:/tmp/pip-WgMZrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:44:43 INFO - Running setup.py (path:/tmp/pip-Sx2_J8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:44:43 INFO - Running setup.py (path:/tmp/pip-veoB16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:44:43 INFO - Running setup.py (path:/tmp/pip-ImpUOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:44:43 INFO - Running setup.py (path:/tmp/pip-t6QTbo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:44:43 INFO - Running setup.py (path:/tmp/pip-QKPu4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:44:43 INFO - Running setup.py (path:/tmp/pip-fTBvkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:44:43 INFO - Running setup.py (path:/tmp/pip-d6zTYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:44:44 INFO - Running setup.py (path:/tmp/pip-56D14G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:44:44 INFO - Running setup.py (path:/tmp/pip-zyUcFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:44:44 INFO - Running setup.py (path:/tmp/pip-vSdoZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:44:44 INFO - Running setup.py (path:/tmp/pip-qk52gW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:44:44 INFO - Running setup.py (path:/tmp/pip-9sQFxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:44:44 INFO - Running setup.py (path:/tmp/pip-O7zdJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:44:44 INFO - Running setup.py (path:/tmp/pip-rbYpkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:44:44 INFO - Running setup.py (path:/tmp/pip-3nS9QJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:44:44 INFO - Running setup.py (path:/tmp/pip-FQoKnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:44:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:44:44 INFO - Running setup.py install for manifestparser 16:44:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:44:44 INFO - Running setup.py install for mozcrash 16:44:44 INFO - Running setup.py install for mozdebug 16:44:44 INFO - Running setup.py install for mozdevice 16:44:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:44:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:44:45 INFO - Running setup.py install for mozfile 16:44:45 INFO - Running setup.py install for mozhttpd 16:44:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:44:45 INFO - Running setup.py install for mozinfo 16:44:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:44:45 INFO - Running setup.py install for mozInstall 16:44:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:44:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:44:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:44:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:44:45 INFO - Running setup.py install for mozleak 16:44:45 INFO - Running setup.py install for mozlog 16:44:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:44:45 INFO - Running setup.py install for moznetwork 16:44:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:44:45 INFO - Running setup.py install for mozprocess 16:44:45 INFO - Running setup.py install for mozprofile 16:44:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:44:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:44:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:44:46 INFO - Running setup.py install for mozrunner 16:44:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:44:46 INFO - Running setup.py install for mozscreenshot 16:44:46 INFO - Running setup.py install for moztest 16:44:46 INFO - Running setup.py install for mozversion 16:44:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:44:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:44:46 INFO - Cleaning up... 16:44:46 INFO - Return code: 0 16:44:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:44: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')]} 16:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44: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')]} 16:44:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:46 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 0x7f0fe3d7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1764770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f39c0>, '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 0x17f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f4d50>, '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': '14ef55db36f7623abb31b9cf000001d5-1464392275.220705-773915763', '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 16:44:46 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 16:44:46 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 16:44:46 INFO - Using env: {'DISPLAY': ':0', 16:44:46 INFO - 'HOME': '/home/cltbld', 16:44:46 INFO - 'LANG': 'en_US.UTF-8', 16:44:46 INFO - 'LANGUAGE': 'en_US:en', 16:44:46 INFO - 'LOGNAME': 'cltbld', 16:44:46 INFO - 'MAIL': '/var/mail/cltbld', 16:44:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:46 INFO - 'MOZ_NO_REMOTE': '1', 16:44:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:46 INFO - 'NO_EM_RESTART': '1', 16:44:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:46 INFO - 'PWD': '/builds/slave/test', 16:44:46 INFO - 'SHELL': '/bin/bash', 16:44:46 INFO - 'SHLVL': '1', 16:44:46 INFO - 'TERM': 'linux', 16:44:46 INFO - 'TMOUT': '86400', 16:44:46 INFO - 'USER': 'cltbld', 16:44:46 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1464392275.220705-773915763', 16:44:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:46 INFO - '_': '/tools/buildbot/bin/python'} 16:44:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:44:46 INFO - Running setup.py (path:/tmp/pip-VSI_vI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:44:46 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)) 16:44:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:44:46 INFO - Running setup.py (path:/tmp/pip-jkc__u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:44:46 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)) 16:44:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:44:46 INFO - Running setup.py (path:/tmp/pip-IYm4dP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:44:46 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)) 16:44:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:44:46 INFO - Running setup.py (path:/tmp/pip-cmqQJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:44:46 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)) 16:44:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:44:47 INFO - Running setup.py (path:/tmp/pip-WGcmQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:44:47 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)) 16:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:44:47 INFO - Running setup.py (path:/tmp/pip-hWfI3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:44:47 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)) 16:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:44:47 INFO - Running setup.py (path:/tmp/pip-rKQj8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:44:47 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)) 16:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:44:47 INFO - Running setup.py (path:/tmp/pip-8yo08R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:44:47 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)) 16:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:44:47 INFO - Running setup.py (path:/tmp/pip-0LhlxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:44:47 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)) 16:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:44:47 INFO - Running setup.py (path:/tmp/pip-kXHxWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:44:47 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)) 16:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:44:47 INFO - Running setup.py (path:/tmp/pip-LE4IWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:44:47 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)) 16:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:44:47 INFO - Running setup.py (path:/tmp/pip-lopvHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:44:47 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)) 16:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:44:47 INFO - Running setup.py (path:/tmp/pip-Ny5Xix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:44:47 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)) 16:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:44:47 INFO - Running setup.py (path:/tmp/pip-kDfS7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:44:47 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)) 16:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:44:47 INFO - Running setup.py (path:/tmp/pip-tGtsvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:44:47 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)) 16:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:44:47 INFO - Running setup.py (path:/tmp/pip-JRRRAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:44:47 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)) 16:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:44:47 INFO - Running setup.py (path:/tmp/pip-7Q6yLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:44:47 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)) 16:44:47 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)) 16:44:47 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)) 16:44:47 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)) 16:44:47 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)) 16:44:47 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)) 16:44:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:49 INFO - Downloading blessings-1.6.tar.gz 16:44:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:44:49 INFO - Installing collected packages: blessings 16:44:49 INFO - Running setup.py install for blessings 16:44:50 INFO - Successfully installed blessings 16:44:50 INFO - Cleaning up... 16:44:50 INFO - Return code: 0 16:44:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:44:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:44:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:44:50 INFO - Reading from file tmpfile_stdout 16:44:50 INFO - Current package versions: 16:44:50 INFO - argparse == 1.2.1 16:44:50 INFO - blessings == 1.6 16:44:50 INFO - blobuploader == 1.2.4 16:44:50 INFO - docopt == 0.6.1 16:44:50 INFO - manifestparser == 1.1 16:44:50 INFO - mozInstall == 1.12 16:44:50 INFO - mozcrash == 0.17 16:44:50 INFO - mozdebug == 0.1 16:44:50 INFO - mozdevice == 0.48 16:44:50 INFO - mozfile == 1.2 16:44:50 INFO - mozhttpd == 0.7 16:44:50 INFO - mozinfo == 0.9 16:44:50 INFO - mozleak == 0.1 16:44:50 INFO - mozlog == 3.2 16:44:50 INFO - moznetwork == 0.27 16:44:50 INFO - mozprocess == 0.22 16:44:50 INFO - mozprofile == 0.28 16:44:50 INFO - mozrunner == 6.11 16:44:50 INFO - mozscreenshot == 0.1 16:44:50 INFO - mozsystemmonitor == 0.3 16:44:50 INFO - moztest == 0.7 16:44:50 INFO - mozversion == 1.4 16:44:50 INFO - psutil == 3.1.1 16:44:50 INFO - requests == 1.2.3 16:44:50 INFO - wsgiref == 0.1.2 16:44:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:44:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:50 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 0x7f0fe3d7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1764770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f39c0>, '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 0x17f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f4d50>, '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': '14ef55db36f7623abb31b9cf000001d5-1464392275.220705-773915763', '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 16:44:50 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 16:44:50 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 16:44:50 INFO - Using env: {'DISPLAY': ':0', 16:44:50 INFO - 'HOME': '/home/cltbld', 16:44:50 INFO - 'LANG': 'en_US.UTF-8', 16:44:50 INFO - 'LANGUAGE': 'en_US:en', 16:44:50 INFO - 'LOGNAME': 'cltbld', 16:44:50 INFO - 'MAIL': '/var/mail/cltbld', 16:44:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:50 INFO - 'MOZ_NO_REMOTE': '1', 16:44:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:50 INFO - 'NO_EM_RESTART': '1', 16:44:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:50 INFO - 'PWD': '/builds/slave/test', 16:44:50 INFO - 'SHELL': '/bin/bash', 16:44:50 INFO - 'SHLVL': '1', 16:44:50 INFO - 'TERM': 'linux', 16:44:50 INFO - 'TMOUT': '86400', 16:44:50 INFO - 'USER': 'cltbld', 16:44:50 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1464392275.220705-773915763', 16:44:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:50 INFO - '_': '/tools/buildbot/bin/python'} 16:44:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:50 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)) 16:44:50 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)) 16:44:50 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)) 16:44:50 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)) 16:44:50 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)) 16:44:50 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)) 16:44:50 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)) 16:44:50 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)) 16:44:50 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)) 16:44:50 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)) 16:44:50 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)) 16:44:50 INFO - Cleaning up... 16:44:50 INFO - Return code: 0 16:44:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:44:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0fe3d7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1764770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f39c0>, '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 0x17f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f4d50>, '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': '14ef55db36f7623abb31b9cf000001d5-1464392275.220705-773915763', '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 16:44:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:44:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:44:50 INFO - Using env: {'DISPLAY': ':0', 16:44:50 INFO - 'HOME': '/home/cltbld', 16:44:50 INFO - 'LANG': 'en_US.UTF-8', 16:44:50 INFO - 'LANGUAGE': 'en_US:en', 16:44:50 INFO - 'LOGNAME': 'cltbld', 16:44:50 INFO - 'MAIL': '/var/mail/cltbld', 16:44:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:50 INFO - 'MOZ_NO_REMOTE': '1', 16:44:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:50 INFO - 'NO_EM_RESTART': '1', 16:44:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:50 INFO - 'PWD': '/builds/slave/test', 16:44:50 INFO - 'SHELL': '/bin/bash', 16:44:50 INFO - 'SHLVL': '1', 16:44:50 INFO - 'TERM': 'linux', 16:44:50 INFO - 'TMOUT': '86400', 16:44:50 INFO - 'USER': 'cltbld', 16:44:50 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1464392275.220705-773915763', 16:44:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:50 INFO - '_': '/tools/buildbot/bin/python'} 16:44:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:50 INFO - Downloading/unpacking jsonschema 16:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:44:52 INFO - Downloading/unpacking functools32 (from jsonschema) 16:44:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:52 INFO - Downloading functools32-3.2.3-2.tar.gz 16:44:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:44:52 INFO - warning: no files found matching '*.txt' 16:44:52 INFO - no previously-included directories found matching 'build' 16:44:52 INFO - no previously-included directories found matching 'dist' 16:44:52 INFO - no previously-included directories found matching '.git*' 16:44:52 INFO - Installing collected packages: jsonschema, functools32 16:44:52 INFO - Running setup.py install for functools32 16:44:53 INFO - warning: no files found matching '*.txt' 16:44:53 INFO - no previously-included directories found matching 'build' 16:44:53 INFO - no previously-included directories found matching 'dist' 16:44:53 INFO - no previously-included directories found matching '.git*' 16:44:53 INFO - Successfully installed jsonschema functools32 16:44:53 INFO - Cleaning up... 16:44:53 INFO - Return code: 0 16:44:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:44:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:53 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 0x7f0fe3d7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1764770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f39c0>, '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 0x17f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f4d50>, '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': '14ef55db36f7623abb31b9cf000001d5-1464392275.220705-773915763', '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 16:44:53 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 16:44:53 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 16:44:53 INFO - Using env: {'DISPLAY': ':0', 16:44:53 INFO - 'HOME': '/home/cltbld', 16:44:53 INFO - 'LANG': 'en_US.UTF-8', 16:44:53 INFO - 'LANGUAGE': 'en_US:en', 16:44:53 INFO - 'LOGNAME': 'cltbld', 16:44:53 INFO - 'MAIL': '/var/mail/cltbld', 16:44:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:53 INFO - 'MOZ_NO_REMOTE': '1', 16:44:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:53 INFO - 'NO_EM_RESTART': '1', 16:44:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:53 INFO - 'PWD': '/builds/slave/test', 16:44:53 INFO - 'SHELL': '/bin/bash', 16:44:53 INFO - 'SHLVL': '1', 16:44:53 INFO - 'TERM': 'linux', 16:44:53 INFO - 'TMOUT': '86400', 16:44:53 INFO - 'USER': 'cltbld', 16:44:53 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1464392275.220705-773915763', 16:44:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:53 INFO - '_': '/tools/buildbot/bin/python'} 16:44:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:53 INFO - Downloading/unpacking flake8 16:44:53 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 16:44:53 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 16:44:53 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 16:44:53 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 16:44:53 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 16:44:53 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 16:44:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:44:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:44:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:44:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:44:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:44:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:44:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:44:55 INFO - no previously-included directories found matching 'docs/_build' 16:44:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:44:55 INFO - Running setup.py install for pep8 16:44:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:44:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:44:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:44:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:44:56 INFO - no previously-included directories found matching 'docs/_build' 16:44:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:44:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:44:56 INFO - Cleaning up... 16:44:56 INFO - Return code: 0 16:44:56 INFO - Running post-action listener: _resource_record_post_action 16:44:56 INFO - Running post-action listener: _start_resource_monitoring 16:44:56 INFO - Starting resource monitoring. 16:44:56 INFO - ##### 16:44:56 INFO - ##### Finished create-virtualenv step (success) 16:44:56 INFO - ##### 16:44:56 INFO - ##### 16:44:56 INFO - ##### Running install step. 16:44:56 INFO - ##### 16:44:56 INFO - Running pre-action listener: _resource_record_pre_action 16:44:56 INFO - Running main action method: install 16:44:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:44:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:44:56 INFO - Reading from file tmpfile_stdout 16:44:56 INFO - Detecting whether we're running mozinstall >=1.0... 16:44:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:44:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:44:56 INFO - Reading from file tmpfile_stdout 16:44:56 INFO - Output received: 16:44:56 INFO - Usage: mozinstall [options] installer 16:44:56 INFO - Options: 16:44:56 INFO - -h, --help show this help message and exit 16:44:56 INFO - -d DEST, --destination=DEST 16:44:56 INFO - Directory to install application into. [default: 16:44:56 INFO - "/builds/slave/test"] 16:44:56 INFO - --app=APP Application being installed. [default: firefox] 16:44:56 INFO - mkdir: /builds/slave/test/build/application 16:44:56 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'] 16:44:56 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 16:45:12 INFO - Reading from file tmpfile_stdout 16:45:12 INFO - Output received: 16:45:12 INFO - /builds/slave/test/build/application/firefox/firefox 16:45:12 INFO - Running post-action listener: _resource_record_post_action 16:45:12 INFO - ##### 16:45:12 INFO - ##### Finished install step (success) 16:45:12 INFO - ##### 16:45:12 INFO - ##### 16:45:12 INFO - ##### Running run-tests step. 16:45:12 INFO - ##### 16:45:12 INFO - Running pre-action listener: _resource_record_pre_action 16:45:12 INFO - Running main action method: run_tests 16:45:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:45:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:45:12 INFO - Python 2.7.3 16:45:12 INFO - Return code: 0 16:45:12 INFO - grabbing minidump binary from tooltool 16:45:12 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')]} 16:45:12 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 0x17f39c0>, '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 0x17f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f4d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:45:12 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 16:45:12 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 16:45:12 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 16:45:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:45:12 INFO - Return code: 0 16:45:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:45:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:45:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:45:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:45:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:45:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:45:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:45:13 INFO - Return code: 0 16:45:13 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/Fp0Ea1pdSoKfGxsnV7e2ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 16:45:13 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/Fp0Ea1pdSoKfGxsnV7e2ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 16:45:13 INFO - Using env: {'DISPLAY': ':0', 16:45:13 INFO - 'HOME': '/home/cltbld', 16:45:13 INFO - 'LANG': 'en_US.UTF-8', 16:45:13 INFO - 'LANGUAGE': 'en_US:en', 16:45:13 INFO - 'LOGNAME': 'cltbld', 16:45:13 INFO - 'MAIL': '/var/mail/cltbld', 16:45:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:45:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:45:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:13 INFO - 'MOZ_NO_REMOTE': '1', 16:45:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:45:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:13 INFO - 'NO_EM_RESTART': '1', 16:45:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:13 INFO - 'PWD': '/builds/slave/test', 16:45:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:45:13 INFO - 'SHELL': '/bin/bash', 16:45:13 INFO - 'SHLVL': '1', 16:45:13 INFO - 'TERM': 'linux', 16:45:13 INFO - 'TMOUT': '86400', 16:45:13 INFO - 'USER': 'cltbld', 16:45:13 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1464392275.220705-773915763', 16:45:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:13 INFO - '_': '/tools/buildbot/bin/python'} 16:45:13 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/Fp0Ea1pdSoKfGxsnV7e2ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 16:45:13 INFO - mozversion application_buildid: 20160527161740 16:45:13 INFO - mozversion application_changeset: 1bd815acf6d3d51ded73a0ffbe05bd8a2c515784 16:45:13 INFO - mozversion application_display_name: Nightly 16:45:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:45:13 INFO - mozversion application_name: Firefox 16:45:13 INFO - mozversion application_remotingname: firefox 16:45:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:45:13 INFO - mozversion application_vendor: Mozilla 16:45:13 INFO - mozversion application_version: 49.0a1 16:45:13 INFO - mozversion platform_buildid: 20160527161740 16:45:13 INFO - mozversion platform_changeset: 1bd815acf6d3d51ded73a0ffbe05bd8a2c515784 16:45:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:45:13 INFO - mozversion platform_version: 49.0a1 16:45:13 INFO - using testdate: 1464392713 16:45:13 INFO - actual date: 1464392713 16:45:13 INFO - starting webserver on 'localhost:42761' 16:45:13 INFO - SUITE-START | Running 2 tests 16:45:13 INFO - TEST-START | dromaeo_css 16:45:13 INFO - operating with platform_type : linux_ 16:45:13 INFO - Initialising browser for dromaeo_css test... 16:45:13 INFO - TEST-INFO | started process 13660 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoNwDhs/profile http://localhost:42761/getInfo.html) 16:45:17 INFO - PROCESS | 13660 | __metrics Screen width/height:1600/1200 16:45:17 INFO - PROCESS | 13660 | colorDepth:24 16:45:17 INFO - PROCESS | 13660 | Browser inner width/height: 1024/697 16:45:17 INFO - PROCESS | 13660 | __metrics 16:45:18 ERROR - PROCESS | 13660 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:45:19 INFO - TEST-INFO | 13660: exit 0 16:45:19 INFO - Browser initialized. 16:45:19 INFO - Running cycle 1/1 for dromaeo_css test... 16:45:19 INFO - TEST-INFO | started process 13743 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoNwDhs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:45:31 INFO - PROCESS | 13743 | RSS: Main: 157237248 16:45:31 INFO - PROCESS | 13743 | 16:46:23 INFO - PROCESS | 13743 | 1464392783200 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] 16:48:34 INFO - PROCESS | 13743 | Cycle 1(1): loaded http://localhost:42761/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42761/tests/dromaeo/cssquery-ext.html) 16:48:35 INFO - PROCESS | 13743 | RSS: Main: 269160448 16:48:35 INFO - PROCESS | 13743 | 16:51:38 INFO - PROCESS | 13743 | Cycle 1(1): loaded http://localhost:42761/tests/dromaeo/cssquery-ext.html (next: http://localhost:42761/tests/dromaeo/cssquery-jquery.html) 16:51:39 INFO - PROCESS | 13743 | RSS: Main: 241844224 16:51:39 INFO - PROCESS | 13743 | 16:54:41 INFO - PROCESS | 13743 | Cycle 1(1): loaded http://localhost:42761/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42761/tests/dromaeo/cssquery-mootools.html) 16:54:42 INFO - PROCESS | 13743 | RSS: Main: 244269056 16:54:42 INFO - PROCESS | 13743 | 16:57:44 INFO - PROCESS | 13743 | Cycle 1(1): loaded http://localhost:42761/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42761/tests/dromaeo/cssquery-prototype.html) 16:57:44 INFO - PROCESS | 13743 | RSS: Main: 234450944 16:57:44 INFO - PROCESS | 13743 | 17:00:47 INFO - PROCESS | 13743 | Cycle 1(1): loaded http://localhost:42761/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42761/tests/dromaeo/cssquery-yui.html) 17:00:48 INFO - PROCESS | 13743 | RSS: Main: 207794176 17:00:48 INFO - PROCESS | 13743 | 17:03:51 INFO - PROCESS | 13743 | Cycle 1(1): loaded http://localhost:42761/tests/dromaeo/cssquery-yui.html (next: http://localhost:42761/tests/dromaeo/cssquery-dojo.html) 17:03:51 INFO - PROCESS | 13743 | RSS: Main: 271978496 17:03:51 INFO - PROCESS | 13743 | 17:03:51 INFO - PROCESS | 13743 | __start_tp_report 17:03:51 INFO - PROCESS | 13743 | _x_x_mozilla_page_load 17:03:51 INFO - PROCESS | 13743 | _x_x_mozilla_page_load_details 17:03:51 INFO - PROCESS | 13743 | |i|pagename|runs| 17:03:51 INFO - PROCESS | 13743 | |0;dojo.html;2649.417128231789;2662.9334266643345;2689.6234527166193;2703.824251423657;2708.498927698376;4635.513271106536;4702.130105930405;4708.835190768324;4718.976405117978;4797.064572408377;4719.07977944301;4720.055988802244;4736.763161841911;4743.57307842295;4780.856574302777;4280.293751530994;4318.870433886988;4365.759883206422;4396.670249731267;4443.755593442359;4377.802998865059;4392.538783427742;4395.120975804836;4434.645228381738;4444.866654000385;4303.053328267807;4322.351647252905;4351.6953813233085;4354.673399495051;4379.255526560492;4338.609525142752;4343.782810859444;4350.216960947028;4364.978175109104;4381.101874115799;4371.715838470521;4374.256376416017;4388.868333949987;4426.291793313055;4433.046894917608;4635.072985402933;4652.278896771006;4690.296455531663;4698.3187437821325;4782.067496838118;5127.692338459704;5172.612054095958;5178.326817513699;5185.429602743695;5194.454582268845;5157.48425157485;5222.0861349264105;5235.816746413895;5240.68555886648;5242.475752424765;4681.976590117061;4727.952720472751;4748.6438517111355;4757.381540399726;4864;5279.551238144801;5293.947060529345;5298.993191293642;5299.12564426873;5301.522862942354;5074.797008119634;5075.441701412841;5077.314562534085;5078.466760990117;5080;5028.321176641107;5105.463926287761;5113.974430127825;5156.097682905476;5161.561267292247;5124.92312615311;5126.87182820425;5131.153359695683;5134.024535338273;5142.408623008327;5041.79832806691;5042.84871453857;5048.495150484996;5077.796888124433;5145.073886700355;4296.720713153635;4334.068175342317;4336.869893903188;4347.174036932973;4366.519682834885;3831.616838316146;3835.1562656215588;3839.404892241707;3852.056246219638;3886.7279290449396;4454.576815202616;4470.955290447054;4472.038511719996;4486.057927835126;4519.0735899141255;5001.774920128603;5014.247862820606;5015.097282489187;5025.095482813129;5183.948160518422;4328.632066274339;4351.69538132334;4359.888228501775;4365.3670217818235;4400.823967041347;4526.117407105583;4536.02475467776;4542.727436353829;4544.977275113603;4584.587387135174;4740.5733483986605;4740.928886066781;4809.350737650372;4847.054824309226;4857.927131093107;5175.741212939262;5180.067587834075;5193.584513239008;5195.792168313225;5201.635885487979;4842.806287748451;4849.830255941025;4856.150173719514;4885.5358740919555;4902.7058376497525;4977;5013.222950442687;5018.071656743514;5051.292819005415;5074.771635276347;5141.074606570854;5161.22581612746;5165.405978312392;5166.715830629351;5213.921791173059;4923.606111511142;4997.775100120431;5010.674306170087;5015.799368025384;5017.046761115376;4906.582940450102;4927.876803079952;4954.083494553519;4954.232094025432;4978.775955081957;4916;4928.630352723631;4973.055119527278;4979.800807967641;4984.626153038609;4875.19559272716;4943.530364615356;5039.722815245197;5089.287499749964;5090.032893750175;4867.3915760529935;4896.681715688469;4920.434150072788;4921.704697718148;4967.230079337708 17:03:51 INFO - PROCESS | 13743 | |1;ext.html;541.9033985367619;585.9882802343953;589.2987345059381;590.8581940334318;611.767528339231;27241;39834.40248396273;40911;40963.38554921671;41068.178636427256;41357.17285654293;41783.37324940121;41860.58139418605;41886.581134188724;41936.161276774445;7782.221777822229;7973.441859069868;7977.56123413212;7993.640286187136;7999.240072193162;7770.728024519143;7911.881321780178;7928.16754240805;7935.64289606969;7938.087119981218;7878.4485086044;7963.562004089773;7974.481658692195;7976.641051152712;7980.4413691041655;7891.092524359686;7939.801504962365;7959.0847052589115;7967.163447837952;7967.8406431871035;7929.4845835021115;8008.359331253486;8036.357091432671;8036.959815200887;8046.879296810553;38373.232535349416;38748.41877371842;38841.80579097115;38910.22179556393;38951.805240973896;2868.1108856254627;2926.180669412568;2938.603288556039;2970.9405811883857;3170.396398810854;29572.11283661472;29619;29838;29909.700902991128;30068.8496557518;3509.6490350964955;3518.225990282134;3528.929421411583;3546.627604101558;3581.7313701472235;252491;256081;256728;258063;258160.9999999981;52818.207726884124;52829.47170528323;53188.46811531913;53259;53293.733531332095;33736.49395259073;34430.13924651904;34485.827570861984;51039.489605104216;51194.23208651873;13593.184408935298;13725.313734313244;13744.450221991208;13744.862551374557;13785.586432407044;10253.948730256301;10343.172546196287;10350.792984140275;10361.792764144826;10390.896091039143;18493.53766155857;18580.535486612942;18645.627087458175;18771.812281877006;18780;6709.29552397001;6817.659117044227;6955.547889387173;6979.267176946449;7089.414326670516;731.5098883747902;785.9685612575547;815.2458975447805;895.9204158988404;897.2104547997851;25095.623565646165;25178;25519.010034110703;25529.61705574418;25801.354966125622;920.3373571028849;945.6926498887889;960.6637676813199;981.215027977615;1065.7442213868771;13438.664033399244;14011.509597164051;14243.85756142446;14267.143971361751;14402.279886005657;389019;442708;452768;453778;456171;51417.485825142016;51868.22197667038;51988.74005629947;52007.73996129995;52077;1109.522905150793;1224.455117472716;1229.4263342921076;1231.963041108786;1233.5929143382662;26125;28655.5701664471;30557.54163687591;30691.386172275983;30994.225144371572;44584;45035.77482112699;45668.314975276066;45685.77157114193;45705;367503;370565;371766;373177;373178;32410.83794581012;35290.47064294089;38213;39120;39159.6084039156;43052;43592.56407435885;43747.12505749931;44526;44673.776631116634;37454;37642;37642.43536346902;37917;38068.80965595154;35998.820005899805;36673.26653466969;37071;37375.2524949494;37519.62480375161;36467.63532364643;36620.63379366279;36745.63254367422;37219.81390093032;37656.05859853526;32482.187945301557;32732.50901236531;32932.50601241031;33545.66454335425;33673.66326336705;25374.74625253724;25546.744532554436;25595.36011599725;25740.227793166236;25965.350866227738 17:03:51 INFO - PROCESS | 13743 | |2;jquery.html;378.17180374978795;379.6146910885451;380.3114173071562;394.0601665028905;398.4521283235551;15737.449189278377;16491.83508164918;17087.060211688353;17089.230984605692;17095.91452042738;15658.295376708047;16359.182040897937;16376.263068161932;16481.258343374546;17047.829521704778;3399.167204035015;4552.63578913687;4748.5726284634375;4749.501302363254;4749.76251187441;3489.7033752130974;5214.921776173361;5433.565314774828;5457.317835270572;5538.529225015878;5474.863128421802;5480.26016487773;5526.944730552683;5528.44715528446;5812.854678633047;5835.503982161521;5964.850878728023;5970.402959704038;5977;6059.878802423949;5048.368953880765;5260.105782017066;5292.470752924715;5331.147016477384;5340.652857564285;12181.878181218162;12195.39023048844;12221.205621634565;12318.322492262922;14546.34541445627;1823.4529641107747;1906.8093190680959;1908.2557802457052;1918.7985261547476;2066.741657292838;8659.826803463895;8725.127487251288;8954.37319387643;8964.50695211763;8992;1704.539774260955;1719.3724290633954;1726.2404542001605;1751.7547543343942;1776.3960253513737;60504.69747651234;61518.69240653813;62927.685361573356;63407.36592634061;63612.36387636157;9734.805303894023;9738.805223895624;9779.608815647294;9801.033872673579;9829.655962041294;13127.803082953764;13210.141340812816;13267.800982985264;13281.601551953458;13284.73430531384;6875.7937261881225;6901.344372284625;7053.717851285891;7118.216996130422;7157.498975071695;6585.440237579764;6633;6676.232987919689;6712.530122891449;6759.526833121634;4154.480689913761;4192.874213773592;4243.172581346607;4258.701890867609;4360.607545320873;1591.6657501924494;1611.5407108973886;1694.1783235130952;1724.4567961092216;1753.7720096387388;805.2672068417712;832.196929962589;871.9520426376483;943.5093751249312;977.4086677560116;16363.181840907908;16495.670086598202;16636.33454661824;16813.91593042027;17156.142192890307;820.3396266005803;826.9090400055989;844.7085755414372;895.2390468102061;897.82043591282;9244.953775231215;9450.905490945002;9470.810583788285;9506.95246523763;9507.809843803085;363687;367040;367627;368120;377869;74978;77480;78694.60652696699;78744.60627696825;79310.41379172384;894.6872335013932;939.6945992552447;943.4575119306289;946.1201082992883;947.1002547579827;14498.420063197354;14708.191049492381;15002.270651701869;15021.849781502046;15030.17334046638;32655.836720816245;33981.49027764635;34086.829565852015;34136.82931585326;34500.309993799485;42984.35523467213;47124.52875471202;48614;48659.27011094907;49548.25677614911;7389.150247721581;7410.4442166836625;7574.166841647304;7713.850927674468;7742.264484873928;8294.004719433466;10604.628837990633;11484.19610627248;11516.078713703051;11691.649250522498;8656.653733850575;9565.808683826424;9757.56090975922;9770.169535589555;10069.899301006895;9013.774655633399;9321.766955825888;9430.669926552811;9602.759931001501;9913.55389007482;9848.753781155528;9907.554160062959;10051.145652619316;10164.186865050926;10211.132053775513;7494.662740176596;7517.511361761468;7526.962365188139;7634.541927484369;7716.42126840478;9372.812543749224;9830.4101753895;9837.360571562825;9905.108540231126;10143.847842282225 17:03:51 INFO - PROCESS | 13743 | |3;mootools.html;1219.4695307541215;1386.722655468906;1443.3937746146619;1518.1650092449156;1747.414616103606;6683.598984060954;7569.280918312758;7752.302292793647;7755.573443460607;7964.800879978004;7725.150233474314;7875.763727088182;7880.251376119274;7886.329661978724;7888.881666775003;2195.6157672407385;2216.866987980726;2225.543763528473;2226.755056943735;2227.587896239193;2210.8120809731113;2234.3967128875192;2243.663450482424;2247.022545192838;2248.415411992877;2185.595664802017;2200.702905107806;2203.5152266501423;2204.64725643897;2219.2232718548457;2117.798809113132;2158.902849371774;2166.0361139293022;2167.4798048468333;2168.0568952505632;2150.9462263443384;2161.7081693971427;2164.9567008659737;2166.1118941234017;2166.837487188467;7706.113796913371;7793.610319484003;7846.843063138763;7848.686052557948;7855.5286682799215;4544.227481328149;4692.7653617319;4692.953070469286;4693.06138772247;4703.247480403119;2858.5997960285576;2927.956080658792;2974.137500124961;2974.2861713188895;2974.73227409532;969.1762002297991;970.8446648536271;977.6724797192878;978.3200675530509;984.807962447323;10435.060844523954;10533.157347412265;10536.157107431463;10547.419891905942;10567.10179634732;4073.51117865858;4101.52832424269;4156.168766246763;4193.266178418765;4205.201011807747;8083.919160808434;8130.186981301823;8143.837123257502;8165.061017983008;8165.346772258205;4607.585317321457;4607.838725644587;4614.630829533629;4619.8845028873875;4621.930671039937;3731.4962480065387;3880.243352546283;4182.916341673211;4205.936910946277;4236.3857240700545;3380.5098260752543;3407.2504049109157;3454.9827250863586;3471;3486.651334866493;1015.4668798880499;1037.242812746684;1038.3406536849154;1039.0700323210835;1042.6090216168936;846.2552953400967;853.3727710133047;854.6709516836063;880.9251213646784;882.2677177942293;5064.442911279756;5073.239014147907;5082.440931497532;5091.7963281469065;5216.947830521722;852.4459101584021;879.9912000880038;905.4657751926395;906.1277382913255;909.1181553892714;3496.1434448560267;3581.4985901973746;3655.141041855162;3772.9056773580332;3779.074126838942;9386.577604007836;9438.38650487716;9665.565049572786;9706.514674266258;9766.46284454362;9425.622975081056;9546.474943878015;9572.186364158984;9573.28200384974;9586.233101351874;6979.4765392595755;7148.106486689164;7280.453965952574;7288.781336559911;7292.635368231568;5364.9731751341;5411.2153737708595;5412;5674.886502270014;5706.9714651426475;8888.911110889067;9056.456612603264;9119.635214591342;9154.267658587163;9166.312526560401;8685.522296273766;8932.955335223282;8956.731298061068;8973.28213742886;9195.724128276162;6112.969435152796;6561.179852518435;6737.29258427858;6743.9325606743305;6977.302269772982;7456.589887556236;7475.215102414386;7487.737929172453;7493.70025198986;7540.283673051052;6703.497237707289;6735.797926062226;6767.661616919233;6869.278725733726;6966.442684585119;6677.432418244503;6717.328267173243;6721.327867213239;6725.4619630430425;6877.6217308048535;5935.851603709769;6103.938960610337;6136.140940268277;6527.902081468686;6605.240397354173;4467.5085740567865;4480.081583275486;4539.863804085882;4695.084458530554;4818.975905120452;4721.504242054535;4740.265258884879;4746.596539294061;4842.128416884994;4882.462929077869 17:03:51 INFO - PROCESS | 13743 | |4;prototype.html;304.33958310466284;306.4988743404533;309.21305278067325;314.9984250078749;315.09253350350986;4758.976205118974;4762.333273341735;4770.236762118062;4770.833020844271;4799;4701.647376446772;4712.3638308828295;4713.9057218855605;4717.900534262255;4728.40894888139;3525.224450620866;3621.8551257949653;3631.658873836077;3639.1084184374863;3654.1230104774927;3579.284143171363;3665.523481947343;3736.645018723217;3739.9252014959684;3744.681702055315;3661.5240018797517;3674.6325367463173;3677;3711.3319602471543;3719.237556300952;3609.3683605368956;3657.7256705747177;3686.926261474769;3692.759970601916;3702.500162478058;3260.6250281217726;3261.72275356595;3278.9670404349217;3279.508073788927;3279.622843373019;4511.541210040536;4531.52418996004;4534.025184585297;4536.138133754609;4544.545545445462;4179.975905903073;4187.539370669224;4196.706230563862;4209.158168366339;4210.536840947493;4703.882402939919;4899.779509922062;4900.705957642553;4906.288588154734;4915.262710593403;3563.592381009513;3574.6246644102257;3580.480830279595;3598.748087633867;3610.332088563624;5066.569341605968;5085.644004919657;5102.6428150029515;5103.642745007851;5124.180131178993;3540.6282340354405;3642.8360723767496;3651.2697460508007;3656.780593164419;3661.1213308805695;3663.7984910829628;3687.2809802088336;3699.2601479704167;3713.665770080706;3727.6953066427077;4147.460830092129;4169.4162817205615;4177.91644167121;4181.121964387452;4195.265828480004;4839.153148199051;4856.538628830255;4856.660033797601;4889.902201955941;4900.240462728283;1188.8157335612993;1264.5510843650557;1265.487477571585;1267.9112462127562;1268.213707501355;801.7674874286508;802.3340627279345;806.6612022950375;806.8103995561039;809.8623234050226;4217.198732240864;4306.2248795217165;4389.934150987738;4422.425084738963;4424.424824772824;5072.695638261716;5085.64400491962;5086.923696144487;5089.931114466003;5096;4379.255526560492;4390.595009596962;4393.450818647669;4396.5818799660055;4419.558044195554;2591.7667409933197;2659.255408485627;2700.5814098814717;2709.309126172813;2711.769499592517;4798.488476130008;4815.133276010351;4818.180909245437;4828.855134345975;4834.879128021757;5184.196449550326;5188.195829646411;5192.273081768555;5197.324347834758;5209.140491818884;4551.951621770217;4838.7338696371335;4841.709497430165;4843.321934929113;4859.198232291632;5096;5102.336696229615;5113.181890897438;5114.33513643224;5115.897682046264;4881.438634557071;4974.353334066693;4979.253112033224;4986.750662466935;4993.3259010034635;4775.498572649961;4803.471618121934;4805.735684537244;4813.350197723263;4819.975900120618;3503.1767534629853;3537.805420701783;3541.919714487003;3545.3441113394106;3550.573931128281;5070.847874563769;5093.388793344674;5103.132467480612;5106.744662766772;5116.74416279192;4779.665423420466;4911.852644420673;4930.802767889244;4948.752562371939;4961.692812841901;4908.435529914105;4911.631627628014;4914.115459217375;4939.851804445872;4961.576512206566;4882.36529251195;4883.87790305231;4890.119778439915;4891.926621100615;4895.975520122377;4734;4770.833020844254;4889.217725163957;4964.255361695775;4973.502649734997;4882.170031094652;4898.485659005753;4913.213885778258;4913.322239379619;4915.033986405467 17:03:51 INFO - PROCESS | 13743 | |5;yui.html;610.667186383421;619.4332186049768;691.5815931361526;708.6421357214606;741.703318672531;11607.883921160796;13024.34878256087;13043.869561304384;13104.868951310484;13134.343282835844;13131.803022954664;13693.3837977291;13761.587152385444;14160.07959482633;14178.220197889137;624.8437890527368;765.2041876448487;804.2359758229676;807.3460496997421;811.9188081191863;801.2588355770918;809.6639894443828;810.1938571121742;810.2059981218409;811.3549727966251;841.9957900210491;847.3941132090554;848.6181218451721;849.452103393311;849.5667209723055;654.8690261947581;800.8678568036268;831.5052543736527;839.7061028639988;840.0968958369776;608.9634621922698;609.9786507472262;610.3591229209312;610.703808652803;610.9755609775603;12482.563110291096;12492.875071249262;12494.625161245178;12498.437570309266;12521.436535355931;11336.093112550976;11564.595239166589;11660.358680272582;11667.073225371278;12073.57742479009;10011.849822252672;10038.949805251;11046.116310695206;11050.834237486444;11166.776664466746;3211.2293049668147;3214.9678503215137;3242.951355729666;3341.832908354597;3352.195473086466;46209;46523.30215046777;46890.06219875583;47180.528194717954;47248.52751472476;9229.123233292827;9346.672866449777;9436.716898493056;9662.3719458235;9867.161291290176;16809.747853782203;16886;16891.550725144785;16906.830931690773;16934.83065169357;6287.622742635456;6408.198975128109;6416.197975253093;6593.142891424084;6816.386525212655;3694.852205911787;3699.260147970363;3756.718246131551;3806.1245913440066;3972.781497017634;2862.3130448692164;2978.255436140965;2981.5825784390204;2991.4017196560776;2991.7905746597967;530.4377359998414;532.1751285507448;535.8586211369835;537.2290762755458;548.1558400063857;456.7556357348869;466.82260740918235;550.1719911533118;586.5307753796945;599.706143989442;7775.883361749578;7907.169747176578;7915.287624113857;7952.681892724227;7954.840903181904;507.8222622082242;562.5387182510302;597.4459186975714;621.7326549583722;646.4828137489989;3587.282543491312;3647.1429214134655;3650.142216579102;3670.7614005089586;3844.1350696093714;55707;56426;56936.145957810666;58413.12380314299;58416.415835841944;48968.61345252019;50138.24792628113;51037;51299;52822.20766688503;46814.5318546817;47619.76190119027;48118;49109.50890491192;49339.753301233985;7590.506617069873;7718.691252350068;7822.921770782219;8064.725435978403;8068.87896681562;31164.68835311618;31330.843345783127;31367.372652547278;31749.377370589944;31806.52290215695;38769;41683.37474937818;41796;41986.79006604947;42642.78678606587;10511.316764410289;10534.78930421372;10831.18766092562;10984.398235413837;11108;11305.43472826339;11340.788546233405;11935.701607459883;12145.817812732992;12640.30478323701;10439.478026098514;10621.681349559525;10688;11005.119590432587;11351.54593816238;10684.519196636014;10767.246292759432;10832.404217768099;10923.945380273048;11163.72090697739;10478.842817357898;10683.091937185427;10759.515821788194;11216.495257713259;11308.208425410143;9016.872890888639;9158.852566262773;9192.770180745267;9219.078092190728;9277.768055798659;8436.198561136682;9270.44377337362;9311.953440232755;9318.72043838686;9366.718998430058 17:03:51 INFO - PROCESS | 13743 | __end_tp_report 17:03:51 INFO - PROCESS | 13743 | __start_cc_report 17:03:51 INFO - PROCESS | 13743 | _x_x_mozilla_cycle_collect,1068 17:03:51 INFO - PROCESS | 13743 | __end_cc_report 17:03:51 INFO - PROCESS | 13743 | __startTimestamp1464393831558__endTimestamp 17:03:51 INFO - PROCESS | 13743 | 17:03:51 INFO - PROCESS | 13743 | ------- Summary: start ------- 17:03:51 INFO - PROCESS | 13743 | Number of tests: 6 17:03:51 INFO - PROCESS | 13743 | 17:03:51 INFO - PROCESS | 13743 | [#0] dojo.html Cycles:165 Average:4727.87 Median:4864.00 stddev:501.00 (10.3%) stddev-sans-first:475.27 17:03:51 INFO - PROCESS | 13743 | Values: 2649.4 2662.9 2689.6 2703.8 2708.5 4635.5 4702.1 4708.8 4719.0 4797.1 4719.1 4720.1 4736.8 4743.6 4780.9 4280.3 4318.9 4365.8 4396.7 4443.8 4377.8 4392.5 4395.1 4434.6 4444.9 4303.1 4322.4 4351.7 4354.7 4379.3 4338.6 4343.8 4350.2 4365.0 4381.1 4371.7 4374.3 4388.9 4426.3 4433.0 4635.1 4652.3 4690.3 4698.3 4782.1 5127.7 5172.6 5178.3 5185.4 5194.5 5157.5 5222.1 5235.8 5240.7 5242.5 4682.0 4728.0 4748.6 4757.4 4864.0 5279.6 5293.9 5299.0 5299.1 5301.5 5074.8 5075.4 5077.3 5078.5 5080.0 5028.3 5105.5 5114.0 5156.1 5161.6 5124.9 5126.9 5131.2 5134.0 5142.4 5041.8 5042.8 5048.5 5077.8 5145.1 4296.7 4334.1 4336.9 4347.2 4366.5 3831.6 3835.2 3839.4 3852.1 3886.7 4454.6 4471.0 4472.0 4486.1 4519.1 5001.8 5014.2 5015.1 5025.1 5183.9 4328.6 4351.7 4359.9 4365.4 4400.8 4526.1 4536.0 4542.7 4545.0 4584.6 4740.6 4740.9 4809.4 4847.1 4857.9 5175.7 5180.1 5193.6 5195.8 5201.6 4842.8 4849.8 4856.2 4885.5 4902.7 4977.0 5013.2 5018.1 5051.3 5074.8 5141.1 5161.2 5165.4 5166.7 5213.9 4923.6 4997.8 5010.7 5015.8 5017.0 4906.6 4927.9 4954.1 4954.2 4978.8 4916.0 4928.6 4973.1 4979.8 4984.6 4875.2 4943.5 5039.7 5089.3 5090.0 4867.4 4896.7 4920.4 4921.7 4967.2 17:03:51 INFO - PROCESS | 13743 | 17:03:51 INFO - PROCESS | 13743 | [#1] ext.html Cycles:180 Average:50708.30 Median:37992.90 stddev:96166.71 (253.1%) stddev-sans-first:96362.72 17:03:51 INFO - PROCESS | 13743 | Values: 541.9 586.0 589.3 590.9 611.8 27241.0 39834.4 40911.0 40963.4 41068.2 41357.2 41783.4 41860.6 41886.6 41936.2 7782.2 7973.4 7977.6 7993.6 7999.2 7770.7 7911.9 7928.2 7935.6 7938.1 7878.4 7963.6 7974.5 7976.6 7980.4 7891.1 7939.8 7959.1 7967.2 7967.8 7929.5 8008.4 8036.4 8037.0 8046.9 38373.2 38748.4 38841.8 38910.2 38951.8 2868.1 2926.2 2938.6 2970.9 3170.4 29572.1 29619.0 29838.0 29909.7 30068.8 3509.6 3518.2 3528.9 3546.6 3581.7 252491.0 256081.0 256728.0 258063.0 258161.0 52818.2 52829.5 53188.5 53259.0 53293.7 33736.5 34430.1 34485.8 51039.5 51194.2 13593.2 13725.3 13744.5 13744.9 13785.6 10253.9 10343.2 10350.8 10361.8 10390.9 18493.5 18580.5 18645.6 18771.8 18780.0 6709.3 6817.7 6955.5 6979.3 7089.4 731.5 786.0 815.2 895.9 897.2 25095.6 25178.0 25519.0 25529.6 25801.4 920.3 945.7 960.7 981.2 1065.7 13438.7 14011.5 14243.9 14267.1 14402.3 389019.0 442708.0 452768.0 453778.0 456171.0 51417.5 51868.2 51988.7 52007.7 52077.0 1109.5 1224.5 1229.4 1232.0 1233.6 26125.0 28655.6 30557.5 30691.4 30994.2 44584.0 45035.8 45668.3 45685.8 45705.0 367503.0 370565.0 371766.0 373177.0 373178.0 32410.8 35290.5 38213.0 39120.0 39159.6 43052.0 43592.6 43747.1 44526.0 44673.8 37454.0 37642.0 37642.4 37917.0 38068.8 35998.8 36673.3 37071.0 37375.3 37519.6 36467.6 36620.6 36745.6 37219.8 37656.1 32482.2 32732.5 32932.5 33545.7 33673.7 25374.7 25546.7 25595.4 25740.2 25965.4 17:03:51 INFO - PROCESS | 13743 | 17:03:51 INFO - PROCESS | 13743 | [#2] jquery.html Cycles:180 Average:22953.12 Median:5387.11 stddev:60950.59 (1131.4%) stddev-sans-first:61098.00 17:03:51 INFO - PROCESS | 13743 | Values: 378.2 379.6 380.3 394.1 398.5 15737.4 16491.8 17087.1 17089.2 17095.9 15658.3 16359.2 16376.3 16481.3 17047.8 3399.2 4552.6 4748.6 4749.5 4749.8 3489.7 5214.9 5433.6 5457.3 5538.5 5474.9 5480.3 5526.9 5528.4 5812.9 5835.5 5964.9 5970.4 5977.0 6059.9 5048.4 5260.1 5292.5 5331.1 5340.7 12181.9 12195.4 12221.2 12318.3 14546.3 1823.5 1906.8 1908.3 1918.8 2066.7 8659.8 8725.1 8954.4 8964.5 8992.0 1704.5 1719.4 1726.2 1751.8 1776.4 60504.7 61518.7 62927.7 63407.4 63612.4 9734.8 9738.8 9779.6 9801.0 9829.7 13127.8 13210.1 13267.8 13281.6 13284.7 6875.8 6901.3 7053.7 7118.2 7157.5 6585.4 6633.0 6676.2 6712.5 6759.5 4154.5 4192.9 4243.2 4258.7 4360.6 1591.7 1611.5 1694.2 1724.5 1753.8 805.3 832.2 872.0 943.5 977.4 16363.2 16495.7 16636.3 16813.9 17156.1 820.3 826.9 844.7 895.2 897.8 9245.0 9450.9 9470.8 9507.0 9507.8 363687.0 367040.0 367627.0 368120.0 377869.0 74978.0 77480.0 78694.6 78744.6 79310.4 894.7 939.7 943.5 946.1 947.1 14498.4 14708.2 15002.3 15021.8 15030.2 32655.8 33981.5 34086.8 34136.8 34500.3 42984.4 47124.5 48614.0 48659.3 49548.3 7389.2 7410.4 7574.2 7713.9 7742.3 8294.0 10604.6 11484.2 11516.1 11691.6 8656.7 9565.8 9757.6 9770.2 10069.9 9013.8 9321.8 9430.7 9602.8 9913.6 9848.8 9907.6 10051.1 10164.2 10211.1 7494.7 7517.5 7527.0 7634.5 7716.4 9372.8 9830.4 9837.4 9905.1 10143.8 17:03:51 INFO - PROCESS | 13743 | 17:03:51 INFO - PROCESS | 13743 | [#3] mootools.html Cycles:180 Average:5107.75 Median:5388.09 stddev:2832.21 (52.6%) stddev-sans-first:2825.08 17:03:51 INFO - PROCESS | 13743 | Values: 1219.5 1386.7 1443.4 1518.2 1747.4 6683.6 7569.3 7752.3 7755.6 7964.8 7725.2 7875.8 7880.3 7886.3 7888.9 2195.6 2216.9 2225.5 2226.8 2227.6 2210.8 2234.4 2243.7 2247.0 2248.4 2185.6 2200.7 2203.5 2204.6 2219.2 2117.8 2158.9 2166.0 2167.5 2168.1 2150.9 2161.7 2165.0 2166.1 2166.8 7706.1 7793.6 7846.8 7848.7 7855.5 4544.2 4692.8 4693.0 4693.1 4703.2 2858.6 2928.0 2974.1 2974.3 2974.7 969.2 970.8 977.7 978.3 984.8 10435.1 10533.2 10536.2 10547.4 10567.1 4073.5 4101.5 4156.2 4193.3 4205.2 8083.9 8130.2 8143.8 8165.1 8165.3 4607.6 4607.8 4614.6 4619.9 4621.9 3731.5 3880.2 4182.9 4205.9 4236.4 3380.5 3407.3 3455.0 3471.0 3486.7 1015.5 1037.2 1038.3 1039.1 1042.6 846.3 853.4 854.7 880.9 882.3 5064.4 5073.2 5082.4 5091.8 5216.9 852.4 880.0 905.5 906.1 909.1 3496.1 3581.5 3655.1 3772.9 3779.1 9386.6 9438.4 9665.6 9706.5 9766.5 9425.6 9546.5 9572.2 9573.3 9586.2 6979.5 7148.1 7280.5 7288.8 7292.6 5365.0 5411.2 5412.0 5674.9 5707.0 8888.9 9056.5 9119.6 9154.3 9166.3 8685.5 8933.0 8956.7 8973.3 9195.7 6113.0 6561.2 6737.3 6743.9 6977.3 7456.6 7475.2 7487.7 7493.7 7540.3 6703.5 6735.8 6767.7 6869.3 6966.4 6677.4 6717.3 6721.3 6725.5 6877.6 5935.9 6103.9 6136.1 6527.9 6605.2 4467.5 4480.1 4539.9 4695.1 4819.0 4721.5 4740.3 4746.6 4842.1 4882.5 17:03:51 INFO - PROCESS | 13743 | 17:03:51 INFO - PROCESS | 13743 | [#4] prototype.html Cycles:180 Average:4104.18 Median:4723.15 stddev:1191.05 (25.2%) stddev-sans-first:1159.74 17:03:51 INFO - PROCESS | 13743 | Values: 304.3 306.5 309.2 315.0 315.1 4759.0 4762.3 4770.2 4770.8 4799.0 4701.6 4712.4 4713.9 4717.9 4728.4 3525.2 3621.9 3631.7 3639.1 3654.1 3579.3 3665.5 3736.6 3739.9 3744.7 3661.5 3674.6 3677.0 3711.3 3719.2 3609.4 3657.7 3686.9 3692.8 3702.5 3260.6 3261.7 3279.0 3279.5 3279.6 4511.5 4531.5 4534.0 4536.1 4544.5 4180.0 4187.5 4196.7 4209.2 4210.5 4703.9 4899.8 4900.7 4906.3 4915.3 3563.6 3574.6 3580.5 3598.7 3610.3 5066.6 5085.6 5102.6 5103.6 5124.2 3540.6 3642.8 3651.3 3656.8 3661.1 3663.8 3687.3 3699.3 3713.7 3727.7 4147.5 4169.4 4177.9 4181.1 4195.3 4839.2 4856.5 4856.7 4889.9 4900.2 1188.8 1264.6 1265.5 1267.9 1268.2 801.8 802.3 806.7 806.8 809.9 4217.2 4306.2 4389.9 4422.4 4424.4 5072.7 5085.6 5086.9 5089.9 5096.0 4379.3 4390.6 4393.5 4396.6 4419.6 2591.8 2659.3 2700.6 2709.3 2711.8 4798.5 4815.1 4818.2 4828.9 4834.9 5184.2 5188.2 5192.3 5197.3 5209.1 4552.0 4838.7 4841.7 4843.3 4859.2 5096.0 5102.3 5113.2 5114.3 5115.9 4881.4 4974.4 4979.3 4986.8 4993.3 4775.5 4803.5 4805.7 4813.4 4820.0 3503.2 3537.8 3541.9 3545.3 3550.6 5070.8 5093.4 5103.1 5106.7 5116.7 4779.7 4911.9 4930.8 4948.8 4961.7 4908.4 4911.6 4914.1 4939.9 4961.6 4882.4 4883.9 4890.1 4891.9 4896.0 4734.0 4770.8 4889.2 4964.3 4973.5 4882.2 4898.5 4913.2 4913.3 4915.0 17:03:51 INFO - PROCESS | 13743 | 17:03:51 INFO - PROCESS | 13743 | [#5] yui.html Cycles:180 Average:13315.64 Median:47035.30 stddev:15704.66 (33.4%) stddev-sans-first:15719.73 17:03:51 INFO - PROCESS | 13743 | Values: 610.7 619.4 691.6 708.6 741.7 11607.9 13024.3 13043.9 13104.9 13134.3 13131.8 13693.4 13761.6 14160.1 14178.2 624.8 765.2 804.2 807.3 811.9 801.3 809.7 810.2 810.2 811.4 842.0 847.4 848.6 849.5 849.6 654.9 800.9 831.5 839.7 840.1 609.0 610.0 610.4 610.7 611.0 12482.6 12492.9 12494.6 12498.4 12521.4 11336.1 11564.6 11660.4 11667.1 12073.6 10011.8 10038.9 11046.1 11050.8 11166.8 3211.2 3215.0 3243.0 3341.8 3352.2 46209.0 46523.3 46890.1 47180.5 47248.5 9229.1 9346.7 9436.7 9662.4 9867.2 16809.7 16886.0 16891.6 16906.8 16934.8 6287.6 6408.2 6416.2 6593.1 6816.4 3694.9 3699.3 3756.7 3806.1 3972.8 2862.3 2978.3 2981.6 2991.4 2991.8 530.4 532.2 535.9 537.2 548.2 456.8 466.8 550.2 586.5 599.7 7775.9 7907.2 7915.3 7952.7 7954.8 507.8 562.5 597.4 621.7 646.5 3587.3 3647.1 3650.1 3670.8 3844.1 55707.0 56426.0 56936.1 58413.1 58416.4 48968.6 50138.2 51037.0 51299.0 52822.2 46814.5 47619.8 48118.0 49109.5 49339.8 7590.5 7718.7 7822.9 8064.7 8068.9 31164.7 31330.8 31367.4 31749.4 31806.5 38769.0 41683.4 41796.0 41986.8 42642.8 10511.3 10534.8 10831.2 10984.4 11108.0 11305.4 11340.8 11935.7 12145.8 12640.3 10439.5 10621.7 10688.0 11005.1 11351.5 10684.5 10767.2 10832.4 10923.9 11163.7 10478.8 10683.1 10759.5 11216.5 11308.2 9016.9 9158.9 9192.8 9219.1 9277.8 8436.2 9270.4 9312.0 9318.7 9366.7 17:03:51 INFO - PROCESS | 13743 | -------- Summary: end -------- 17:03:51 INFO - PROCESS | 13743 | 17:03:52 INFO - TEST-INFO | 13743: exit 0 17:03:52 INFO - TEST-OK | dromaeo_css | took 1118881ms 17:03:52 INFO - TEST-START | kraken 17:03:52 INFO - operating with platform_type : linux_ 17:03:52 INFO - Initialising browser for kraken test... 17:03:52 INFO - TEST-INFO | started process 13920 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI9yldD/profile http://localhost:42761/getInfo.html) 17:03:56 INFO - PROCESS | 13920 | __metrics Screen width/height:1600/1200 17:03:56 INFO - PROCESS | 13920 | colorDepth:24 17:03:56 INFO - PROCESS | 13920 | Browser inner width/height: 1024/697 17:03:56 INFO - PROCESS | 13920 | __metrics 17:03:57 ERROR - PROCESS | 13920 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:03:58 INFO - TEST-INFO | 13920: exit 0 17:03:58 INFO - Browser initialized. 17:03:58 INFO - Running cycle 1/1 for kraken test... 17:03:58 INFO - TEST-INFO | started process 14001 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI9yldD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:04:10 INFO - PROCESS | 14001 | RSS: Main: 157270016 17:04:10 INFO - PROCESS | 14001 | 17:04:12 INFO - PROCESS | 14001 | Cycle 1(1): loaded http://localhost:42761/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42761/tests/kraken/driver.html?testName=audio-beat-detection) 17:04:13 INFO - PROCESS | 14001 | RSS: Main: 214953984 17:04:13 INFO - PROCESS | 14001 | 17:04:16 INFO - PROCESS | 14001 | Cycle 1(1): loaded http://localhost:42761/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42761/tests/kraken/driver.html?testName=audio-dft) 17:04:17 INFO - PROCESS | 14001 | RSS: Main: 203677696 17:04:17 INFO - PROCESS | 14001 | 17:04:20 INFO - PROCESS | 14001 | Cycle 1(1): loaded http://localhost:42761/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42761/tests/kraken/driver.html?testName=audio-fft) 17:04:21 INFO - PROCESS | 14001 | RSS: Main: 269955072 17:04:21 INFO - PROCESS | 14001 | 17:04:23 INFO - PROCESS | 14001 | Cycle 1(1): loaded http://localhost:42761/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42761/tests/kraken/driver.html?testName=audio-oscillator) 17:04:23 INFO - PROCESS | 14001 | RSS: Main: 180391936 17:04:23 INFO - PROCESS | 14001 | 17:04:26 INFO - PROCESS | 14001 | Cycle 1(1): loaded http://localhost:42761/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42761/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:04:26 INFO - PROCESS | 14001 | RSS: Main: 184836096 17:04:26 INFO - PROCESS | 14001 | 17:04:29 INFO - PROCESS | 14001 | Cycle 1(1): loaded http://localhost:42761/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42761/tests/kraken/driver.html?testName=imaging-darkroom) 17:04:30 INFO - PROCESS | 14001 | RSS: Main: 220282880 17:04:30 INFO - PROCESS | 14001 | 17:04:34 INFO - PROCESS | 14001 | Cycle 1(1): loaded http://localhost:42761/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42761/tests/kraken/driver.html?testName=imaging-desaturate) 17:04:34 INFO - PROCESS | 14001 | RSS: Main: 217018368 17:04:34 INFO - PROCESS | 14001 | 17:04:37 INFO - PROCESS | 14001 | Cycle 1(1): loaded http://localhost:42761/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42761/tests/kraken/driver.html?testName=json-parse-financial) 17:04:38 INFO - PROCESS | 14001 | RSS: Main: 219545600 17:04:38 INFO - PROCESS | 14001 | 17:04:39 INFO - PROCESS | 14001 | Cycle 1(1): loaded http://localhost:42761/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42761/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:04:40 INFO - PROCESS | 14001 | RSS: Main: 209498112 17:04:40 INFO - PROCESS | 14001 | 17:04:42 INFO - PROCESS | 14001 | Cycle 1(1): loaded http://localhost:42761/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42761/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:04:43 INFO - PROCESS | 14001 | RSS: Main: 212267008 17:04:43 INFO - PROCESS | 14001 | 17:04:45 INFO - PROCESS | 14001 | Cycle 1(1): loaded http://localhost:42761/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42761/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:04:45 INFO - PROCESS | 14001 | RSS: Main: 218869760 17:04:45 INFO - PROCESS | 14001 | 17:04:48 INFO - PROCESS | 14001 | Cycle 1(1): loaded http://localhost:42761/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42761/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:04:49 INFO - PROCESS | 14001 | RSS: Main: 224542720 17:04:49 INFO - PROCESS | 14001 | 17:04:52 INFO - PROCESS | 14001 | Cycle 1(1): loaded http://localhost:42761/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42761/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:04:52 INFO - PROCESS | 14001 | RSS: Main: 225071104 17:04:52 INFO - PROCESS | 14001 | 17:04:54 INFO - PROCESS | 14001 | Cycle 1(1): loaded http://localhost:42761/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42761/tests/kraken/driver.html?testName=ai-astar) 17:04:54 INFO - PROCESS | 14001 | RSS: Main: 267264000 17:04:54 INFO - PROCESS | 14001 | 17:04:54 INFO - PROCESS | 14001 | __start_tp_report 17:04:54 INFO - PROCESS | 14001 | _x_x_mozilla_page_load 17:04:54 INFO - PROCESS | 14001 | _x_x_mozilla_page_load_details 17:04:54 INFO - PROCESS | 14001 | |i|pagename|runs| 17:04:54 INFO - PROCESS | 14001 | |0;ai-astar;113;109;114;117;113;115;114;114;113;113 17:04:54 INFO - PROCESS | 14001 | |1;audio-beat-detection;153;129;141;159;130;154;152;140;181;130 17:04:54 INFO - PROCESS | 14001 | |2;audio-dft;163;161;160;161;161;162;161;162;162;161 17:04:54 INFO - PROCESS | 14001 | |3;audio-fft;75;76;78;129;76;77;74;75;112;75 17:04:54 INFO - PROCESS | 14001 | |4;audio-oscillator;84;86;114;85;86;84;111;83;84;126 17:04:54 INFO - PROCESS | 14001 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;117;117;117 17:04:54 INFO - PROCESS | 14001 | |6;imaging-darkroom;146;146;146;146;146;146;146;146;148;148 17:04:54 INFO - PROCESS | 14001 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;94 17:04:54 INFO - PROCESS | 14001 | |8;json-parse-financial;64;64;63;64;63;72;67;63;71;63 17:04:54 INFO - PROCESS | 14001 | |9;json-stringify-tinderbox;64;65;64;65;65;64;64;65;65;70 17:04:54 INFO - PROCESS | 14001 | |10;stanford-crypto-aes;83;83;82;83;84;85;83;83;119;84 17:04:54 INFO - PROCESS | 14001 | |11;stanford-crypto-ccm;134;144;139;132;139;129;130;127;152;143 17:04:54 INFO - PROCESS | 14001 | |12;stanford-crypto-pbkdf2;177;169;169;167;175;168;168;170;169;166 17:04:54 INFO - PROCESS | 14001 | |13;stanford-crypto-sha256-iterative;68;68;66;67;68;67;67;66;66;68 17:04:54 INFO - PROCESS | 14001 | __end_tp_report 17:04:54 INFO - PROCESS | 14001 | __start_cc_report 17:04:54 INFO - PROCESS | 14001 | _x_x_mozilla_cycle_collect,1899 17:04:54 INFO - PROCESS | 14001 | __end_cc_report 17:04:54 INFO - PROCESS | 14001 | __startTimestamp1464393894864__endTimestamp 17:04:54 INFO - PROCESS | 14001 | 17:04:54 INFO - PROCESS | 14001 | ------- Summary: start ------- 17:04:54 INFO - PROCESS | 14001 | Number of tests: 14 17:04:54 INFO - PROCESS | 14001 | 17:04:54 INFO - PROCESS | 14001 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.00 stddev:2.01 (1.8%) stddev-sans-first:2.13 17:04:54 INFO - PROCESS | 14001 | Values: 113.0 109.0 114.0 117.0 113.0 115.0 114.0 114.0 113.0 113.0 17:04:54 INFO - PROCESS | 14001 | 17:04:54 INFO - PROCESS | 14001 | [#1] audio-beat-detection Cycles:10 Average:146.90 Median:152.50 stddev:16.32 (10.7%) stddev-sans-first:17.16 17:04:54 INFO - PROCESS | 14001 | Values: 153.0 129.0 141.0 159.0 130.0 154.0 152.0 140.0 181.0 130.0 17:04:54 INFO - PROCESS | 14001 | 17:04:54 INFO - PROCESS | 14001 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:0.84 (0.5%) stddev-sans-first:0.67 17:04:54 INFO - PROCESS | 14001 | Values: 163.0 161.0 160.0 161.0 161.0 162.0 161.0 162.0 162.0 161.0 17:04:54 INFO - PROCESS | 14001 | 17:04:54 INFO - PROCESS | 14001 | [#3] audio-fft Cycles:10 Average:84.70 Median:75.50 stddev:19.32 (25.6%) stddev-sans-first:20.17 17:04:54 INFO - PROCESS | 14001 | Values: 75.0 76.0 78.0 129.0 76.0 77.0 74.0 75.0 112.0 75.0 17:04:54 INFO - PROCESS | 14001 | 17:04:54 INFO - PROCESS | 14001 | [#4] audio-oscillator Cycles:10 Average:94.30 Median:84.00 stddev:16.13 (19.2%) stddev-sans-first:16.67 17:04:54 INFO - PROCESS | 14001 | Values: 84.0 86.0 114.0 85.0 86.0 84.0 111.0 83.0 84.0 126.0 17:04:54 INFO - PROCESS | 14001 | 17:04:54 INFO - PROCESS | 14001 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 17:04:54 INFO - PROCESS | 14001 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 17:04:54 INFO - PROCESS | 14001 | 17:04:54 INFO - PROCESS | 14001 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.84 (0.6%) stddev-sans-first:0.88 17:04:54 INFO - PROCESS | 14001 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 148.0 148.0 17:04:54 INFO - PROCESS | 14001 | 17:04:54 INFO - PROCESS | 14001 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 17:04:54 INFO - PROCESS | 14001 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 17:04:54 INFO - PROCESS | 14001 | 17:04:54 INFO - PROCESS | 14001 | [#8] json-parse-financial Cycles:10 Average:65.40 Median:64.00 stddev:3.44 (5.4%) stddev-sans-first:3.61 17:04:54 INFO - PROCESS | 14001 | Values: 64.0 64.0 63.0 64.0 63.0 72.0 67.0 63.0 71.0 63.0 17:04:54 INFO - PROCESS | 14001 | 17:04:54 INFO - PROCESS | 14001 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:1.79 (2.8%) stddev-sans-first:1.86 17:04:54 INFO - PROCESS | 14001 | Values: 64.0 65.0 64.0 65.0 65.0 64.0 64.0 65.0 65.0 70.0 17:04:54 INFO - PROCESS | 14001 | 17:04:54 INFO - PROCESS | 14001 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:83.00 stddev:11.31 (13.6%) stddev-sans-first:11.91 17:04:54 INFO - PROCESS | 14001 | Values: 83.0 83.0 82.0 83.0 84.0 85.0 83.0 83.0 119.0 84.0 17:04:54 INFO - PROCESS | 14001 | 17:04:54 INFO - PROCESS | 14001 | [#11] stanford-crypto-ccm Cycles:10 Average:136.90 Median:139.00 stddev:7.92 (5.7%) stddev-sans-first:8.33 17:04:54 INFO - PROCESS | 14001 | Values: 134.0 144.0 139.0 132.0 139.0 129.0 130.0 127.0 152.0 143.0 17:04:54 INFO - PROCESS | 14001 | 17:04:54 INFO - PROCESS | 14001 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.80 Median:169.00 stddev:3.49 (2.1%) stddev-sans-first:2.55 17:04:54 INFO - PROCESS | 14001 | Values: 177.0 169.0 169.0 167.0 175.0 168.0 168.0 170.0 169.0 166.0 17:04:54 INFO - PROCESS | 14001 | 17:04:54 INFO - PROCESS | 14001 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.50 stddev:0.88 (1.3%) stddev-sans-first:0.87 17:04:54 INFO - PROCESS | 14001 | Values: 68.0 68.0 66.0 67.0 68.0 67.0 67.0 66.0 66.0 68.0 17:04:54 INFO - PROCESS | 14001 | -------- Summary: end -------- 17:04:54 INFO - PROCESS | 14001 | 17:04:55 INFO - TEST-INFO | 14001: exit 0 17:04:55 INFO - TEST-OK | kraken | took 63615ms 17:04:55 INFO - SUITE-END | took 1182s 17:04:56 INFO - Completed test suite (00:19:42) 17:04:56 INFO - javascript benchmark 17:04:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2649.417128231789, 2662.9334266643345, 2689.6234527166193, 2703.824251423657, 2708.498927698376, 4635.513271106536, 4702.130105930405, 4708.835190768324, 4718.976405117978, 4797.064572408377, 4719.07977944301, 4720.055988802244, 4736.763161841911, 4743.57307842295, 4780.856574302777, 4280.293751530994, 4318.870433886988, 4365.759883206422, 4396.670249731267, 4443.755593442359, 4377.802998865059, 4392.538783427742, 4395.120975804836, 4434.645228381738, 4444.866654000385, 4303.053328267807, 4322.351647252905, 4351.6953813233085, 4354.673399495051, 4379.255526560492, 4338.609525142752, 4343.782810859444, 4350.216960947028, 4364.978175109104, 4381.101874115799, 4371.715838470521, 4374.256376416017, 4388.868333949987, 4426.291793313055, 4433.046894917608, 4635.072985402933, 4652.278896771006, 4690.296455531663, 4698.3187437821325, 4782.067496838118, 5127.692338459704, 5172.612054095958, 5178.326817513699, 5185.429602743695, 5194.454582268845, 5157.48425157485, 5222.0861349264105, 5235.816746413895, 5240.68555886648, 5242.475752424765, 4681.976590117061, 4727.952720472751, 4748.6438517111355, 4757.381540399726, 4864.0, 5279.551238144801, 5293.947060529345, 5298.993191293642, 5299.12564426873, 5301.522862942354, 5074.797008119634, 5075.441701412841, 5077.314562534085, 5078.466760990117, 5080.0, 5028.321176641107, 5105.463926287761, 5113.974430127825, 5156.097682905476, 5161.561267292247, 5124.92312615311, 5126.87182820425, 5131.153359695683, 5134.024535338273, 5142.408623008327, 5041.79832806691, 5042.84871453857, 5048.495150484996, 5077.796888124433, 5145.073886700355, 4296.720713153635, 4334.068175342317, 4336.869893903188, 4347.174036932973, 4366.519682834885, 3831.616838316146, 3835.1562656215588, 3839.404892241707, 3852.056246219638, 3886.7279290449396, 4454.576815202616, 4470.955290447054, 4472.038511719996, 4486.057927835126, 4519.0735899141255, 5001.774920128603, 5014.247862820606, 5015.097282489187, 5025.095482813129, 5183.948160518422, 4328.632066274339, 4351.69538132334, 4359.888228501775, 4365.3670217818235, 4400.823967041347, 4526.117407105583, 4536.02475467776, 4542.727436353829, 4544.977275113603, 4584.587387135174, 4740.5733483986605, 4740.928886066781, 4809.350737650372, 4847.054824309226, 4857.927131093107, 5175.741212939262, 5180.067587834075, 5193.584513239008, 5195.792168313225, 5201.635885487979, 4842.806287748451, 4849.830255941025, 4856.150173719514, 4885.5358740919555, 4902.7058376497525, 4977.0, 5013.222950442687, 5018.071656743514, 5051.292819005415, 5074.771635276347, 5141.074606570854, 5161.22581612746, 5165.405978312392, 5166.715830629351, 5213.921791173059, 4923.606111511142, 4997.775100120431, 5010.674306170087, 5015.799368025384, 5017.046761115376, 4906.582940450102, 4927.876803079952, 4954.083494553519, 4954.232094025432, 4978.775955081957, 4916.0, 4928.630352723631, 4973.055119527278, 4979.800807967641, 4984.626153038609, 4875.19559272716, 4943.530364615356, 5039.722815245197, 5089.287499749964, 5090.032893750175, 4867.3915760529935, 4896.681715688469, 4920.434150072788, 4921.704697718148, 4967.230079337708], "value": 4695.798993944372, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.9033985367619, 585.9882802343953, 589.2987345059381, 590.8581940334318, 611.767528339231, 27241.0, 39834.40248396273, 40911.0, 40963.38554921671, 41068.178636427256, 41357.17285654293, 41783.37324940121, 41860.58139418605, 41886.581134188724, 41936.161276774445, 7782.221777822229, 7973.441859069868, 7977.56123413212, 7993.640286187136, 7999.240072193162, 7770.728024519143, 7911.881321780178, 7928.16754240805, 7935.64289606969, 7938.087119981218, 7878.4485086044, 7963.562004089773, 7974.481658692195, 7976.641051152712, 7980.4413691041655, 7891.092524359686, 7939.801504962365, 7959.0847052589115, 7967.163447837952, 7967.8406431871035, 7929.4845835021115, 8008.359331253486, 8036.357091432671, 8036.959815200887, 8046.879296810553, 38373.232535349416, 38748.41877371842, 38841.80579097115, 38910.22179556393, 38951.805240973896, 2868.1108856254627, 2926.180669412568, 2938.603288556039, 2970.9405811883857, 3170.396398810854, 29572.11283661472, 29619.0, 29838.0, 29909.700902991128, 30068.8496557518, 3509.6490350964955, 3518.225990282134, 3528.929421411583, 3546.627604101558, 3581.7313701472235, 252491.0, 256081.0, 256728.0, 258063.0, 258160.9999999981, 52818.207726884124, 52829.47170528323, 53188.46811531913, 53259.0, 53293.733531332095, 33736.49395259073, 34430.13924651904, 34485.827570861984, 51039.489605104216, 51194.23208651873, 13593.184408935298, 13725.313734313244, 13744.450221991208, 13744.862551374557, 13785.586432407044, 10253.948730256301, 10343.172546196287, 10350.792984140275, 10361.792764144826, 10390.896091039143, 18493.53766155857, 18580.535486612942, 18645.627087458175, 18771.812281877006, 18780.0, 6709.29552397001, 6817.659117044227, 6955.547889387173, 6979.267176946449, 7089.414326670516, 731.5098883747902, 785.9685612575547, 815.2458975447805, 895.9204158988404, 897.2104547997851, 25095.623565646165, 25178.0, 25519.010034110703, 25529.61705574418, 25801.354966125622, 920.3373571028849, 945.6926498887889, 960.6637676813199, 981.215027977615, 1065.7442213868771, 13438.664033399244, 14011.509597164051, 14243.85756142446, 14267.143971361751, 14402.279886005657, 389019.0, 442708.0, 452768.0, 453778.0, 456171.0, 51417.485825142016, 51868.22197667038, 51988.74005629947, 52007.73996129995, 52077.0, 1109.522905150793, 1224.455117472716, 1229.4263342921076, 1231.963041108786, 1233.5929143382662, 26125.0, 28655.5701664471, 30557.54163687591, 30691.386172275983, 30994.225144371572, 44584.0, 45035.77482112699, 45668.314975276066, 45685.77157114193, 45705.0, 367503.0, 370565.0, 371766.0, 373177.0, 373178.0, 32410.83794581012, 35290.47064294089, 38213.0, 39120.0, 39159.6084039156, 43052.0, 43592.56407435885, 43747.12505749931, 44526.0, 44673.776631116634, 37454.0, 37642.0, 37642.43536346902, 37917.0, 38068.80965595154, 35998.820005899805, 36673.26653466969, 37071.0, 37375.2524949494, 37519.62480375161, 36467.63532364643, 36620.63379366279, 36745.63254367422, 37219.81390093032, 37656.05859853526, 32482.187945301557, 32732.50901236531, 32932.50601241031, 33545.66454335425, 33673.66326336705, 25374.74625253724, 25546.744532554436, 25595.36011599725, 25740.227793166236, 25965.350866227738], "value": 17789.099743593826, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.17180374978795, 379.6146910885451, 380.3114173071562, 394.0601665028905, 398.4521283235551, 15737.449189278377, 16491.83508164918, 17087.060211688353, 17089.230984605692, 17095.91452042738, 15658.295376708047, 16359.182040897937, 16376.263068161932, 16481.258343374546, 17047.829521704778, 3399.167204035015, 4552.63578913687, 4748.5726284634375, 4749.501302363254, 4749.76251187441, 3489.7033752130974, 5214.921776173361, 5433.565314774828, 5457.317835270572, 5538.529225015878, 5474.863128421802, 5480.26016487773, 5526.944730552683, 5528.44715528446, 5812.854678633047, 5835.503982161521, 5964.850878728023, 5970.402959704038, 5977.0, 6059.878802423949, 5048.368953880765, 5260.105782017066, 5292.470752924715, 5331.147016477384, 5340.652857564285, 12181.878181218162, 12195.39023048844, 12221.205621634565, 12318.322492262922, 14546.34541445627, 1823.4529641107747, 1906.8093190680959, 1908.2557802457052, 1918.7985261547476, 2066.741657292838, 8659.826803463895, 8725.127487251288, 8954.37319387643, 8964.50695211763, 8992.0, 1704.539774260955, 1719.3724290633954, 1726.2404542001605, 1751.7547543343942, 1776.3960253513737, 60504.69747651234, 61518.69240653813, 62927.685361573356, 63407.36592634061, 63612.36387636157, 9734.805303894023, 9738.805223895624, 9779.608815647294, 9801.033872673579, 9829.655962041294, 13127.803082953764, 13210.141340812816, 13267.800982985264, 13281.601551953458, 13284.73430531384, 6875.7937261881225, 6901.344372284625, 7053.717851285891, 7118.216996130422, 7157.498975071695, 6585.440237579764, 6633.0, 6676.232987919689, 6712.530122891449, 6759.526833121634, 4154.480689913761, 4192.874213773592, 4243.172581346607, 4258.701890867609, 4360.607545320873, 1591.6657501924494, 1611.5407108973886, 1694.1783235130952, 1724.4567961092216, 1753.7720096387388, 805.2672068417712, 832.196929962589, 871.9520426376483, 943.5093751249312, 977.4086677560116, 16363.181840907908, 16495.670086598202, 16636.33454661824, 16813.91593042027, 17156.142192890307, 820.3396266005803, 826.9090400055989, 844.7085755414372, 895.2390468102061, 897.82043591282, 9244.953775231215, 9450.905490945002, 9470.810583788285, 9506.95246523763, 9507.809843803085, 363687.0, 367040.0, 367627.0, 368120.0, 377869.0, 74978.0, 77480.0, 78694.60652696699, 78744.60627696825, 79310.41379172384, 894.6872335013932, 939.6945992552447, 943.4575119306289, 946.1201082992883, 947.1002547579827, 14498.420063197354, 14708.191049492381, 15002.270651701869, 15021.849781502046, 15030.17334046638, 32655.836720816245, 33981.49027764635, 34086.829565852015, 34136.82931585326, 34500.309993799485, 42984.35523467213, 47124.52875471202, 48614.0, 48659.27011094907, 49548.25677614911, 7389.150247721581, 7410.4442166836625, 7574.166841647304, 7713.850927674468, 7742.264484873928, 8294.004719433466, 10604.628837990633, 11484.19610627248, 11516.078713703051, 11691.649250522498, 8656.653733850575, 9565.808683826424, 9757.56090975922, 9770.169535589555, 10069.899301006895, 9013.774655633399, 9321.766955825888, 9430.669926552811, 9602.759931001501, 9913.55389007482, 9848.753781155528, 9907.554160062959, 10051.145652619316, 10164.186865050926, 10211.132053775513, 7494.662740176596, 7517.511361761468, 7526.962365188139, 7634.541927484369, 7716.42126840478, 9372.812543749224, 9830.4101753895, 9837.360571562825, 9905.108540231126, 10143.847842282225], "value": 7863.855054941208, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1219.4695307541215, 1386.722655468906, 1443.3937746146619, 1518.1650092449156, 1747.414616103606, 6683.598984060954, 7569.280918312758, 7752.302292793647, 7755.573443460607, 7964.800879978004, 7725.150233474314, 7875.763727088182, 7880.251376119274, 7886.329661978724, 7888.881666775003, 2195.6157672407385, 2216.866987980726, 2225.543763528473, 2226.755056943735, 2227.587896239193, 2210.8120809731113, 2234.3967128875192, 2243.663450482424, 2247.022545192838, 2248.415411992877, 2185.595664802017, 2200.702905107806, 2203.5152266501423, 2204.64725643897, 2219.2232718548457, 2117.798809113132, 2158.902849371774, 2166.0361139293022, 2167.4798048468333, 2168.0568952505632, 2150.9462263443384, 2161.7081693971427, 2164.9567008659737, 2166.1118941234017, 2166.837487188467, 7706.113796913371, 7793.610319484003, 7846.843063138763, 7848.686052557948, 7855.5286682799215, 4544.227481328149, 4692.7653617319, 4692.953070469286, 4693.06138772247, 4703.247480403119, 2858.5997960285576, 2927.956080658792, 2974.137500124961, 2974.2861713188895, 2974.73227409532, 969.1762002297991, 970.8446648536271, 977.6724797192878, 978.3200675530509, 984.807962447323, 10435.060844523954, 10533.157347412265, 10536.157107431463, 10547.419891905942, 10567.10179634732, 4073.51117865858, 4101.52832424269, 4156.168766246763, 4193.266178418765, 4205.201011807747, 8083.919160808434, 8130.186981301823, 8143.837123257502, 8165.061017983008, 8165.346772258205, 4607.585317321457, 4607.838725644587, 4614.630829533629, 4619.8845028873875, 4621.930671039937, 3731.4962480065387, 3880.243352546283, 4182.916341673211, 4205.936910946277, 4236.3857240700545, 3380.5098260752543, 3407.2504049109157, 3454.9827250863586, 3471.0, 3486.651334866493, 1015.4668798880499, 1037.242812746684, 1038.3406536849154, 1039.0700323210835, 1042.6090216168936, 846.2552953400967, 853.3727710133047, 854.6709516836063, 880.9251213646784, 882.2677177942293, 5064.442911279756, 5073.239014147907, 5082.440931497532, 5091.7963281469065, 5216.947830521722, 852.4459101584021, 879.9912000880038, 905.4657751926395, 906.1277382913255, 909.1181553892714, 3496.1434448560267, 3581.4985901973746, 3655.141041855162, 3772.9056773580332, 3779.074126838942, 9386.577604007836, 9438.38650487716, 9665.565049572786, 9706.514674266258, 9766.46284454362, 9425.622975081056, 9546.474943878015, 9572.186364158984, 9573.28200384974, 9586.233101351874, 6979.4765392595755, 7148.106486689164, 7280.453965952574, 7288.781336559911, 7292.635368231568, 5364.9731751341, 5411.2153737708595, 5412.0, 5674.886502270014, 5706.9714651426475, 8888.911110889067, 9056.456612603264, 9119.635214591342, 9154.267658587163, 9166.312526560401, 8685.522296273766, 8932.955335223282, 8956.731298061068, 8973.28213742886, 9195.724128276162, 6112.969435152796, 6561.179852518435, 6737.29258427858, 6743.9325606743305, 6977.302269772982, 7456.589887556236, 7475.215102414386, 7487.737929172453, 7493.70025198986, 7540.283673051052, 6703.497237707289, 6735.797926062226, 6767.661616919233, 6869.278725733726, 6966.442684585119, 6677.432418244503, 6717.328267173243, 6721.327867213239, 6725.4619630430425, 6877.6217308048535, 5935.851603709769, 6103.938960610337, 6136.140940268277, 6527.902081468686, 6605.240397354173, 4467.5085740567865, 4480.081583275486, 4539.863804085882, 4695.084458530554, 4818.975905120452, 4721.504242054535, 4740.265258884879, 4746.596539294061, 4842.128416884994, 4882.462929077869], "value": 4127.101380486924, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.33958310466284, 306.4988743404533, 309.21305278067325, 314.9984250078749, 315.09253350350986, 4758.976205118974, 4762.333273341735, 4770.236762118062, 4770.833020844271, 4799.0, 4701.647376446772, 4712.3638308828295, 4713.9057218855605, 4717.900534262255, 4728.40894888139, 3525.224450620866, 3621.8551257949653, 3631.658873836077, 3639.1084184374863, 3654.1230104774927, 3579.284143171363, 3665.523481947343, 3736.645018723217, 3739.9252014959684, 3744.681702055315, 3661.5240018797517, 3674.6325367463173, 3677.0, 3711.3319602471543, 3719.237556300952, 3609.3683605368956, 3657.7256705747177, 3686.926261474769, 3692.759970601916, 3702.500162478058, 3260.6250281217726, 3261.72275356595, 3278.9670404349217, 3279.508073788927, 3279.622843373019, 4511.541210040536, 4531.52418996004, 4534.025184585297, 4536.138133754609, 4544.545545445462, 4179.975905903073, 4187.539370669224, 4196.706230563862, 4209.158168366339, 4210.536840947493, 4703.882402939919, 4899.779509922062, 4900.705957642553, 4906.288588154734, 4915.262710593403, 3563.592381009513, 3574.6246644102257, 3580.480830279595, 3598.748087633867, 3610.332088563624, 5066.569341605968, 5085.644004919657, 5102.6428150029515, 5103.642745007851, 5124.180131178993, 3540.6282340354405, 3642.8360723767496, 3651.2697460508007, 3656.780593164419, 3661.1213308805695, 3663.7984910829628, 3687.2809802088336, 3699.2601479704167, 3713.665770080706, 3727.6953066427077, 4147.460830092129, 4169.4162817205615, 4177.91644167121, 4181.121964387452, 4195.265828480004, 4839.153148199051, 4856.538628830255, 4856.660033797601, 4889.902201955941, 4900.240462728283, 1188.8157335612993, 1264.5510843650557, 1265.487477571585, 1267.9112462127562, 1268.213707501355, 801.7674874286508, 802.3340627279345, 806.6612022950375, 806.8103995561039, 809.8623234050226, 4217.198732240864, 4306.2248795217165, 4389.934150987738, 4422.425084738963, 4424.424824772824, 5072.695638261716, 5085.64400491962, 5086.923696144487, 5089.931114466003, 5096.0, 4379.255526560492, 4390.595009596962, 4393.450818647669, 4396.5818799660055, 4419.558044195554, 2591.7667409933197, 2659.255408485627, 2700.5814098814717, 2709.309126172813, 2711.769499592517, 4798.488476130008, 4815.133276010351, 4818.180909245437, 4828.855134345975, 4834.879128021757, 5184.196449550326, 5188.195829646411, 5192.273081768555, 5197.324347834758, 5209.140491818884, 4551.951621770217, 4838.7338696371335, 4841.709497430165, 4843.321934929113, 4859.198232291632, 5096.0, 5102.336696229615, 5113.181890897438, 5114.33513643224, 5115.897682046264, 4881.438634557071, 4974.353334066693, 4979.253112033224, 4986.750662466935, 4993.3259010034635, 4775.498572649961, 4803.471618121934, 4805.735684537244, 4813.350197723263, 4819.975900120618, 3503.1767534629853, 3537.805420701783, 3541.919714487003, 3545.3441113394106, 3550.573931128281, 5070.847874563769, 5093.388793344674, 5103.132467480612, 5106.744662766772, 5116.74416279192, 4779.665423420466, 4911.852644420673, 4930.802767889244, 4948.752562371939, 4961.692812841901, 4908.435529914105, 4911.631627628014, 4914.115459217375, 4939.851804445872, 4961.576512206566, 4882.36529251195, 4883.87790305231, 4890.119778439915, 4891.926621100615, 4895.975520122377, 4734.0, 4770.833020844254, 4889.217725163957, 4964.255361695775, 4973.502649734997, 4882.170031094652, 4898.485659005753, 4913.213885778258, 4913.322239379619, 4915.033986405467], "value": 3727.2465214037766, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [610.667186383421, 619.4332186049768, 691.5815931361526, 708.6421357214606, 741.703318672531, 11607.883921160796, 13024.34878256087, 13043.869561304384, 13104.868951310484, 13134.343282835844, 13131.803022954664, 13693.3837977291, 13761.587152385444, 14160.07959482633, 14178.220197889137, 624.8437890527368, 765.2041876448487, 804.2359758229676, 807.3460496997421, 811.9188081191863, 801.2588355770918, 809.6639894443828, 810.1938571121742, 810.2059981218409, 811.3549727966251, 841.9957900210491, 847.3941132090554, 848.6181218451721, 849.452103393311, 849.5667209723055, 654.8690261947581, 800.8678568036268, 831.5052543736527, 839.7061028639988, 840.0968958369776, 608.9634621922698, 609.9786507472262, 610.3591229209312, 610.703808652803, 610.9755609775603, 12482.563110291096, 12492.875071249262, 12494.625161245178, 12498.437570309266, 12521.436535355931, 11336.093112550976, 11564.595239166589, 11660.358680272582, 11667.073225371278, 12073.57742479009, 10011.849822252672, 10038.949805251, 11046.116310695206, 11050.834237486444, 11166.776664466746, 3211.2293049668147, 3214.9678503215137, 3242.951355729666, 3341.832908354597, 3352.195473086466, 46209.0, 46523.30215046777, 46890.06219875583, 47180.528194717954, 47248.52751472476, 9229.123233292827, 9346.672866449777, 9436.716898493056, 9662.3719458235, 9867.161291290176, 16809.747853782203, 16886.0, 16891.550725144785, 16906.830931690773, 16934.83065169357, 6287.622742635456, 6408.198975128109, 6416.197975253093, 6593.142891424084, 6816.386525212655, 3694.852205911787, 3699.260147970363, 3756.718246131551, 3806.1245913440066, 3972.781497017634, 2862.3130448692164, 2978.255436140965, 2981.5825784390204, 2991.4017196560776, 2991.7905746597967, 530.4377359998414, 532.1751285507448, 535.8586211369835, 537.2290762755458, 548.1558400063857, 456.7556357348869, 466.82260740918235, 550.1719911533118, 586.5307753796945, 599.706143989442, 7775.883361749578, 7907.169747176578, 7915.287624113857, 7952.681892724227, 7954.840903181904, 507.8222622082242, 562.5387182510302, 597.4459186975714, 621.7326549583722, 646.4828137489989, 3587.282543491312, 3647.1429214134655, 3650.142216579102, 3670.7614005089586, 3844.1350696093714, 55707.0, 56426.0, 56936.145957810666, 58413.12380314299, 58416.415835841944, 48968.61345252019, 50138.24792628113, 51037.0, 51299.0, 52822.20766688503, 46814.5318546817, 47619.76190119027, 48118.0, 49109.50890491192, 49339.753301233985, 7590.506617069873, 7718.691252350068, 7822.921770782219, 8064.725435978403, 8068.87896681562, 31164.68835311618, 31330.843345783127, 31367.372652547278, 31749.377370589944, 31806.52290215695, 38769.0, 41683.37474937818, 41796.0, 41986.79006604947, 42642.78678606587, 10511.316764410289, 10534.78930421372, 10831.18766092562, 10984.398235413837, 11108.0, 11305.43472826339, 11340.788546233405, 11935.701607459883, 12145.817812732992, 12640.30478323701, 10439.478026098514, 10621.681349559525, 10688.0, 11005.119590432587, 11351.54593816238, 10684.519196636014, 10767.246292759432, 10832.404217768099, 10923.945380273048, 11163.72090697739, 10478.842817357898, 10683.091937185427, 10759.515821788194, 11216.495257713259, 11308.208425410143, 9016.872890888639, 9158.852566262773, 9192.770180745267, 9219.078092190728, 9277.768055798659, 8436.198561136682, 9270.44377337362, 9311.953440232755, 9318.72043838686, 9366.718998430058], "value": 5960.883473082472, "unit": "score"}], "name": "dromaeo_css", "value": 6261.074882067878, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 109.0, 114.0, 117.0, 113.0, 115.0, 114.0, 114.0, 113.0, 113.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 129.0, 141.0, 159.0, 130.0, 154.0, 152.0, 140.0, 181.0, 130.0], "value": 146.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 160.0, 161.0, 161.0, 162.0, 161.0, 162.0, 162.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 78.0, 129.0, 76.0, 77.0, 74.0, 75.0, 112.0, 75.0], "value": 84.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 114.0, 85.0, 86.0, 84.0, 111.0, 83.0, 84.0, 126.0], "value": 94.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 148.0, 148.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 64.0, 63.0, 72.0, 67.0, 63.0, 71.0, 63.0], "value": 65.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 65.0, 65.0, 64.0, 64.0, 65.0, 65.0, 70.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 82.0, 83.0, 84.0, 85.0, 83.0, 83.0, 119.0, 84.0], "value": 86.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 144.0, 139.0, 132.0, 139.0, 129.0, 130.0, 127.0, 152.0, 143.0], "value": 136.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 169.0, 169.0, 167.0, 175.0, 168.0, 168.0, 170.0, 169.0, 166.0], "value": 169.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 66.0, 67.0, 68.0, 67.0, 67.0, 66.0, 66.0, 68.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1550.1999999999998, "alertThreshold": 2.0}]} 17:04:56 INFO - Return code: 0 17:04:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:04:56 ERROR - # TBPL SUCCESS # 17:04:56 INFO - Running post-action listener: _resource_record_post_action 17:04:56 INFO - ##### 17:04:56 INFO - ##### Finished run-tests step (success) 17:04:56 INFO - ##### 17:04:56 INFO - Running post-run listener: _resource_record_post_run 17:04:56 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 528936960; Read time: 0; Write time: 490384 17:04:56 INFO - TinderboxPrint: CPU usage
13.1% 17:04:56 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 17:04:56 INFO - TinderboxPrint: I/O write bytes / time
528,936,960 / 490,384 17:04:56 INFO - TinderboxPrint: CPU idle
8,318.1 (86.9%) 17:04:56 INFO - TinderboxPrint: CPU user
1,208.2 (12.6%) 17:04:56 INFO - TinderboxPrint: Swap in / out
0 / 0 17:04:56 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 245424128; Read time: 0; Write time: 261848 17:04:56 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 283512832; Read time: 0; Write time: 228536 17:04:56 INFO - Running post-run listener: _upload_blobber_files 17:04:56 INFO - Blob upload gear active. 17:04:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:04:56 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 17:04:56 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'] 17:04:56 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 17:04:57 INFO - (blobuploader) - INFO - Open directory for files ... 17:04:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:04:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:04:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:04:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:04:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:04:57 INFO - (blobuploader) - INFO - Done attempting. 17:04:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:04:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:04:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:04:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:04:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:04:58 INFO - (blobuploader) - INFO - Done attempting. 17:04:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:04:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:04:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:05:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:05:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:05:07 INFO - (blobuploader) - INFO - Done attempting. 17:05:07 INFO - (blobuploader) - INFO - Iteration through files over. 17:05:07 INFO - Return code: 0 17:05:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:05:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:05:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5277e09554698433cb9230caae8e21a416b300afa068293bdaefff8bb5b13dabc0fd722a475861113f782437069830c10ccf7fdb2a67d6161b701cfa79e2527f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7d361775242f0e8e2fc41983d93a1878e28fdd57390a7c4e5640df26cfb4e85f0fb6f8ea748300683d3d5bb578856664f53b960be60287166ef4289a548c2111", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/373e62356264e45feb80c51d415bf4e78b61548d2264d7f1bd0f8e7da688c3a208559535e70b66f95533d31353d6aca01493867f8152c594c1c5d5a5af81dcba"} 17:05:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:05:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:05:07 INFO - Contents: 17:05:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5277e09554698433cb9230caae8e21a416b300afa068293bdaefff8bb5b13dabc0fd722a475861113f782437069830c10ccf7fdb2a67d6161b701cfa79e2527f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7d361775242f0e8e2fc41983d93a1878e28fdd57390a7c4e5640df26cfb4e85f0fb6f8ea748300683d3d5bb578856664f53b960be60287166ef4289a548c2111", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/373e62356264e45feb80c51d415bf4e78b61548d2264d7f1bd0f8e7da688c3a208559535e70b66f95533d31353d6aca01493867f8152c594c1c5d5a5af81dcba"} 17:05:07 INFO - Running post-run listener: copy_logs_to_upload_dir 17:05:07 INFO - Copying logs to upload dir... 17:05:07 INFO - mkdir: /builds/slave/test/build/upload/logs 17:05:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.210575 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-05-27 17:05:07.848482) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 17:05:07.855928) ========= 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=14ef55db36f7623abb31b9cf000001d5-1464392275.220705-773915763 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/5277e09554698433cb9230caae8e21a416b300afa068293bdaefff8bb5b13dabc0fd722a475861113f782437069830c10ccf7fdb2a67d6161b701cfa79e2527f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7d361775242f0e8e2fc41983d93a1878e28fdd57390a7c4e5640df26cfb4e85f0fb6f8ea748300683d3d5bb578856664f53b960be60287166ef4289a548c2111", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/373e62356264e45feb80c51d415bf4e78b61548d2264d7f1bd0f8e7da688c3a208559535e70b66f95533d31353d6aca01493867f8152c594c1c5d5a5af81dcba"} build_url:https://queue.taskcluster.net/v1/task/Fp0Ea1pdSoKfGxsnV7e2ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011294 build_url: 'https://queue.taskcluster.net/v1/task/Fp0Ea1pdSoKfGxsnV7e2ag/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/5277e09554698433cb9230caae8e21a416b300afa068293bdaefff8bb5b13dabc0fd722a475861113f782437069830c10ccf7fdb2a67d6161b701cfa79e2527f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7d361775242f0e8e2fc41983d93a1878e28fdd57390a7c4e5640df26cfb4e85f0fb6f8ea748300683d3d5bb578856664f53b960be60287166ef4289a548c2111", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/373e62356264e45feb80c51d415bf4e78b61548d2264d7f1bd0f8e7da688c3a208559535e70b66f95533d31353d6aca01493867f8152c594c1c5d5a5af81dcba"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 17:05:07.884100) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 17:05:07.884428) ========= 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=14ef55db36f7623abb31b9cf000001d5-1464392275.220705-773915763 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004606 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 17:05:07.967342) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 17:05:07.970829) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 17:05:07.971203) ========= ========= Total master_lag: 0.19 =========