builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-021 starttime: 1464145741.12 results: success (0) buildid: 20160524173017 builduid: 21dc8c984ecd44c581e20f7f7fc6d176 revision: 788365ddaf61746bc66479335ae72d3e566c38ec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 20:09:01.118006) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 20:09:01.118459) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 20:09:01.118746) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 20:09:01.132977) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 20:09:01.133237) ========= 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=df17445c3590ff7897617a0e00000225-1464145740.770290-1072037691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-24 20:09:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 36.4M=0s 2016-05-24 20:09:01 (36.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.141160 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 20:09:01.288396) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 20:09:01.288746) ========= 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=df17445c3590ff7897617a0e00000225-1464145740.770290-1072037691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016186 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 20:09:01.338327) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 20:09:01.338692) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 788365ddaf61746bc66479335ae72d3e566c38ec --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 788365ddaf61746bc66479335ae72d3e566c38ec --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=df17445c3590ff7897617a0e00000225-1464145740.770290-1072037691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-24 20:09:01,702 truncating revision to first 12 chars 2016-05-24 20:09:01,702 Setting DEBUG logging. 2016-05-24 20:09:01,702 attempt 1/10 2016-05-24 20:09:01,702 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/788365ddaf61?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-24 20:09:01,972 unpacking tar archive at: fx-team-788365ddaf61/testing/mozharness/ program finished with exit code 0 elapsedTime=0.576379 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 20:09:01.928284) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 20:09:01.928620) ========= script_repo_revision: 788365ddaf61746bc66479335ae72d3e566c38ec ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 20:09:01.929015) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 20:09:01.929285) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 20:09:01.937830) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-24 20:09:01.938099) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=df17445c3590ff7897617a0e00000225-1464145740.770290-1072037691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:09:02 INFO - MultiFileLogger online at 20160524 20:09:02 in /builds/slave/test 20:09:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:09:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:09:02 INFO - {'append_to_log': False, 20:09:02 INFO - 'base_work_dir': '/builds/slave/test', 20:09:02 INFO - 'blob_upload_branch': 'Fx-Team', 20:09:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:09:02 INFO - 'branch': 'Fx-Team', 20:09:02 INFO - 'buildbot_json_path': 'buildprops.json', 20:09:02 INFO - 'config_files': ('talos/linux_config.py',), 20:09:02 INFO - 'default_actions': ('clobber', 20:09:02 INFO - 'read-buildbot-config', 20:09:02 INFO - 'download-and-extract', 20:09:02 INFO - 'populate-webroot', 20:09:02 INFO - 'create-virtualenv', 20:09:02 INFO - 'install', 20:09:02 INFO - 'run-tests'), 20:09:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:09:02 INFO - 'download_minidump_stackwalk': True, 20:09:02 INFO - 'download_symbols': 'ondemand', 20:09:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:09:02 INFO - 'tooltool.py': '/tools/tooltool.py', 20:09:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:09:02 INFO - '/tools/misc-python/virtualenv.py')}, 20:09:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:09:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:09:02 INFO - 'installer_path': 'installer.exe', 20:09:02 INFO - 'log_level': 'info', 20:09:02 INFO - 'log_name': 'talos', 20:09:02 INFO - 'log_to_console': True, 20:09:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:09:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:09:02 INFO - 'opt_config_files': (), 20:09:02 INFO - 'pip_index': False, 20:09:02 INFO - 'sps_profile': False, 20:09:02 INFO - 'sps_profile_interval': 0, 20:09:02 INFO - 'suite': 'dromaeojs-e10s', 20:09:02 INFO - 'system_bits': '32', 20:09:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:09:02 INFO - 'title': 'talos-linux64-ix-021', 20:09:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:09:02 INFO - 'use_talos_json': True, 20:09:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:09:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:09:02 INFO - 'work_dir': 'build'} 20:09:02 INFO - ##### 20:09:02 INFO - ##### Running clobber step. 20:09:02 INFO - ##### 20:09:02 INFO - Running pre-action listener: _resource_record_pre_action 20:09:02 INFO - Running main action method: clobber 20:09:02 INFO - rmtree: /builds/slave/test/build 20:09:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:09:02 INFO - Running post-action listener: _resource_record_post_action 20:09:02 INFO - ##### 20:09:02 INFO - ##### Finished clobber step (success) 20:09:02 INFO - ##### 20:09:02 INFO - ##### 20:09:02 INFO - ##### Running read-buildbot-config step. 20:09:02 INFO - ##### 20:09:02 INFO - Running pre-action listener: _resource_record_pre_action 20:09:02 INFO - Running main action method: read_buildbot_config 20:09:02 INFO - Using buildbot properties: 20:09:02 INFO - { 20:09:02 INFO - "project": "", 20:09:02 INFO - "product": "firefox", 20:09:02 INFO - "script_repo_revision": "production", 20:09:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 20:09:02 INFO - "repository": "", 20:09:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 20:09:02 INFO - "buildid": "20160524173017", 20:09:02 INFO - "pgo_build": "True", 20:09:02 INFO - "basedir": "/builds/slave/test", 20:09:02 INFO - "buildnumber": 372, 20:09:02 INFO - "slavename": "talos-linux64-ix-021", 20:09:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:09:02 INFO - "platform": "ubuntu64_hw", 20:09:02 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:09:02 INFO - "branch": "fx-team", 20:09:02 INFO - "repo_path": "integration/fx-team", 20:09:02 INFO - "revision": "788365ddaf61746bc66479335ae72d3e566c38ec", 20:09:02 INFO - "stage_platform": "linux64-pgo", 20:09:02 INFO - "builduid": "21dc8c984ecd44c581e20f7f7fc6d176", 20:09:02 INFO - "slavebuilddir": "test" 20:09:02 INFO - } 20:09:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 20:09:02 INFO - Running post-action listener: _resource_record_post_action 20:09:02 INFO - ##### 20:09:02 INFO - ##### Finished read-buildbot-config step (success) 20:09:02 INFO - ##### 20:09:02 INFO - ##### 20:09:02 INFO - ##### Running download-and-extract step. 20:09:02 INFO - ##### 20:09:02 INFO - Running pre-action listener: _resource_record_pre_action 20:09:02 INFO - Running main action method: download_and_extract 20:09:02 INFO - mkdir: /builds/slave/test/build/tests 20:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:02 INFO - https://queue.taskcluster.net/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:09:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:09:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:09:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:09:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:09:03 INFO - Downloaded 1361 bytes. 20:09:03 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:09:03 INFO - Using the following test package requirements: 20:09:03 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:09:03 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:03 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:09:03 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:03 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:09:03 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:03 INFO - u'jsshell-linux-x86_64.zip'], 20:09:03 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:03 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:09:03 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:09:03 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:03 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:09:03 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:03 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:09:03 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:03 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:09:03 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:03 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:09:03 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:03 INFO - https://queue.taskcluster.net/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:09:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:09:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:09:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:09:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:09:04 INFO - Downloaded 24417235 bytes. 20:09:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:09:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:09:06 INFO - Return code: 0 20:09:06 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:06 INFO - https://queue.taskcluster.net/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:09:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:09:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:09:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:09:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:09:07 INFO - Downloaded 24417235 bytes. 20:09:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:09:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:09:08 INFO - Return code: 0 20:09:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:08 INFO - https://queue.taskcluster.net/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:09:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:09:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:09:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:09:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:09:09 INFO - Downloaded 10840359 bytes. 20:09:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:09:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 20:09:10 INFO - Return code: 0 20:09:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:10 INFO - https://queue.taskcluster.net/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:09:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:09:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:09:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:09:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:09:12 INFO - Downloaded 58621454 bytes. 20:09:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:09:12 INFO - mkdir: /builds/slave/test/properties 20:09:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:09:12 INFO - Writing to file /builds/slave/test/properties/build_url 20:09:12 INFO - Contents: 20:09:12 INFO - build_url:https://queue.taskcluster.net/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:09:13 INFO - Running post-action listener: _resource_record_post_action 20:09:13 INFO - Running post-action listener: set_extra_try_arguments 20:09:13 INFO - ##### 20:09:13 INFO - ##### Finished download-and-extract step (success) 20:09:13 INFO - ##### 20:09:13 INFO - ##### 20:09:13 INFO - ##### Running populate-webroot step. 20:09:13 INFO - ##### 20:09:13 INFO - Running pre-action listener: _resource_record_pre_action 20:09:13 INFO - Running main action method: populate_webroot 20:09:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:09:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:09:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:09:13 INFO - '--tppagecycles', 20:09:13 INFO - '7'], 20:09:13 INFO - 'tests': ['tsvgm']}}, 20:09:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:09:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:09:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:09:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:09:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:09:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:09:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:13 INFO - 'talos_options': ['--disable-e10s'], 20:09:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:09:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:09:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:13 INFO - 'talos_options': ['--disable-e10s'], 20:09:13 INFO - 'tests': ['damp', 'tps']}, 20:09:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:13 INFO - 'tests': ['damp', 'tps']}, 20:09:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:09:13 INFO - 'tests': ['dromaeo_dom']}, 20:09:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:09:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:09:13 INFO - 'tests': ['a11yr', 20:09:13 INFO - 'ts_paint', 20:09:13 INFO - 'tpaint', 20:09:13 INFO - 'sessionrestore', 20:09:13 INFO - 'sessionrestore_no_auto_restore', 20:09:13 INFO - 'tabpaint']}, 20:09:13 INFO - 'other-e10s': {'tests': ['a11yr', 20:09:13 INFO - 'ts_paint', 20:09:13 INFO - 'tpaint', 20:09:13 INFO - 'sessionrestore', 20:09:13 INFO - 'sessionrestore_no_auto_restore', 20:09:13 INFO - 'tabpaint']}, 20:09:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:09:13 INFO - 'ts_paint', 20:09:13 INFO - 'tpaint', 20:09:13 INFO - 'sessionrestore', 20:09:13 INFO - 'sessionrestore_no_auto_restore', 20:09:13 INFO - 'tabpaint']}, 20:09:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:09:13 INFO - 'ts_paint', 20:09:13 INFO - 'tpaint', 20:09:13 INFO - 'sessionrestore', 20:09:13 INFO - 'sessionrestore_no_auto_restore', 20:09:13 INFO - 'tabpaint']}, 20:09:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:09:13 INFO - 'tests': ['a11yr', 20:09:13 INFO - 'ts_paint', 20:09:13 INFO - 'tpaint', 20:09:13 INFO - 'sessionrestore', 20:09:13 INFO - 'sessionrestore_no_auto_restore', 20:09:13 INFO - 'tabpaint']}, 20:09:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:09:13 INFO - 'tests': ['a11yr', 20:09:13 INFO - 'ts_paint', 20:09:13 INFO - 'tpaint', 20:09:13 INFO - 'sessionrestore', 20:09:13 INFO - 'sessionrestore_no_auto_restore', 20:09:13 INFO - 'tabpaint']}, 20:09:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:09:13 INFO - 'tests': ['tsvgx', 20:09:13 INFO - 'tsvgr_opacity', 20:09:13 INFO - 'tart', 20:09:13 INFO - 'tscrollx', 20:09:13 INFO - 'cart']}, 20:09:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:09:13 INFO - 'tsvgr_opacity', 20:09:13 INFO - 'tart', 20:09:13 INFO - 'tscrollx', 20:09:13 INFO - 'cart']}, 20:09:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:13 INFO - 'talos_options': ['--disable-e10s'], 20:09:13 INFO - 'tests': ['tp5o']}, 20:09:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:13 INFO - 'tests': ['tp5o']}, 20:09:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:13 INFO - 'talos_options': ['--disable-e10s', 20:09:13 INFO - '--xperf_path', 20:09:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:09:13 INFO - 'tests': ['tp5n']}, 20:09:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:13 INFO - 'talos_options': ['--xperf_path', 20:09:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:09:13 INFO - 'tests': ['tp5n']}}, 20:09:13 INFO - 'talos.zip': {'path': '', 20:09:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:09:13 INFO - Running post-action listener: _resource_record_post_action 20:09:13 INFO - ##### 20:09:13 INFO - ##### Finished populate-webroot step (success) 20:09:13 INFO - ##### 20:09:13 INFO - ##### 20:09:13 INFO - ##### Running create-virtualenv step. 20:09:13 INFO - ##### 20:09:13 INFO - Running pre-action listener: _resource_record_pre_action 20:09:13 INFO - Running main action method: create_virtualenv 20:09:13 INFO - Creating virtualenv /builds/slave/test/build/venv 20:09:13 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:09:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:09:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:09:13 INFO - Using real prefix '/usr' 20:09:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:09:14 INFO - Installing distribute.............................................................................................................................................................................................done. 20:09:16 INFO - Installing pip.................done. 20:09:16 INFO - Return code: 0 20:09:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:16 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 0x7faff34fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b19770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba89c0>, '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 0x1ba98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba9d50>, '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': 'df17445c3590ff7897617a0e00000225-1464145740.770290-1072037691', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:09:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:09:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:09:16 INFO - Using env: {'DISPLAY': ':0', 20:09:16 INFO - 'HOME': '/home/cltbld', 20:09:16 INFO - 'LANG': 'en_US.UTF-8', 20:09:16 INFO - 'LANGUAGE': 'en_US:en', 20:09:16 INFO - 'LOGNAME': 'cltbld', 20:09:16 INFO - 'MAIL': '/var/mail/cltbld', 20:09:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:16 INFO - 'MOZ_NO_REMOTE': '1', 20:09:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:16 INFO - 'NO_EM_RESTART': '1', 20:09:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:16 INFO - 'PWD': '/builds/slave/test', 20:09:16 INFO - 'SHELL': '/bin/bash', 20:09:16 INFO - 'SHLVL': '1', 20:09:16 INFO - 'TERM': 'linux', 20:09:16 INFO - 'TMOUT': '86400', 20:09:16 INFO - 'USER': 'cltbld', 20:09:16 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1464145740.770290-1072037691', 20:09:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:16 INFO - '_': '/tools/buildbot/bin/python'} 20:09:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 20:09:16 INFO - Cleaning up... 20:09:16 INFO - Return code: 0 20:09:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:16 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 0x7faff34fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b19770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba89c0>, '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 0x1ba98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba9d50>, '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': 'df17445c3590ff7897617a0e00000225-1464145740.770290-1072037691', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:09:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:09:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:09:16 INFO - Using env: {'DISPLAY': ':0', 20:09:16 INFO - 'HOME': '/home/cltbld', 20:09:16 INFO - 'LANG': 'en_US.UTF-8', 20:09:16 INFO - 'LANGUAGE': 'en_US:en', 20:09:16 INFO - 'LOGNAME': 'cltbld', 20:09:16 INFO - 'MAIL': '/var/mail/cltbld', 20:09:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:16 INFO - 'MOZ_NO_REMOTE': '1', 20:09:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:16 INFO - 'NO_EM_RESTART': '1', 20:09:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:16 INFO - 'PWD': '/builds/slave/test', 20:09:16 INFO - 'SHELL': '/bin/bash', 20:09:16 INFO - 'SHLVL': '1', 20:09:16 INFO - 'TERM': 'linux', 20:09:16 INFO - 'TMOUT': '86400', 20:09:16 INFO - 'USER': 'cltbld', 20:09:16 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1464145740.770290-1072037691', 20:09:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:16 INFO - '_': '/tools/buildbot/bin/python'} 20:09:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:16 INFO - Downloading/unpacking psutil>=3.1.1 20:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:09:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:09:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:09:18 INFO - Installing collected packages: psutil 20:09:18 INFO - Running setup.py install for psutil 20:09:18 INFO - building 'psutil._psutil_linux' extension 20:09:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 20:09:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 20:09:19 INFO - building 'psutil._psutil_posix' extension 20:09:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 20:09:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 20:09:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:09:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:09:19 INFO - Successfully installed psutil 20:09:19 INFO - Cleaning up... 20:09:19 INFO - Return code: 0 20:09:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:09: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')]} 20:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09: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')]} 20:09:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:19 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 0x7faff34fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b19770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba89c0>, '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 0x1ba98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba9d50>, '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': 'df17445c3590ff7897617a0e00000225-1464145740.770290-1072037691', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:09:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:09:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:09:19 INFO - Using env: {'DISPLAY': ':0', 20:09:19 INFO - 'HOME': '/home/cltbld', 20:09:19 INFO - 'LANG': 'en_US.UTF-8', 20:09:19 INFO - 'LANGUAGE': 'en_US:en', 20:09:19 INFO - 'LOGNAME': 'cltbld', 20:09:19 INFO - 'MAIL': '/var/mail/cltbld', 20:09:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:19 INFO - 'MOZ_NO_REMOTE': '1', 20:09:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:19 INFO - 'NO_EM_RESTART': '1', 20:09:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:19 INFO - 'PWD': '/builds/slave/test', 20:09:19 INFO - 'SHELL': '/bin/bash', 20:09:19 INFO - 'SHLVL': '1', 20:09:19 INFO - 'TERM': 'linux', 20:09:19 INFO - 'TMOUT': '86400', 20:09:19 INFO - 'USER': 'cltbld', 20:09:19 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1464145740.770290-1072037691', 20:09:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:19 INFO - '_': '/tools/buildbot/bin/python'} 20:09:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:09:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:09:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:09:21 INFO - Installing collected packages: mozsystemmonitor 20:09:21 INFO - Running setup.py install for mozsystemmonitor 20:09:21 INFO - Successfully installed mozsystemmonitor 20:09:21 INFO - Cleaning up... 20:09:21 INFO - Return code: 0 20:09:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:21 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 0x7faff34fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b19770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba89c0>, '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 0x1ba98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba9d50>, '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': 'df17445c3590ff7897617a0e00000225-1464145740.770290-1072037691', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:09:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:09:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:09:21 INFO - Using env: {'DISPLAY': ':0', 20:09:21 INFO - 'HOME': '/home/cltbld', 20:09:21 INFO - 'LANG': 'en_US.UTF-8', 20:09:21 INFO - 'LANGUAGE': 'en_US:en', 20:09:21 INFO - 'LOGNAME': 'cltbld', 20:09:21 INFO - 'MAIL': '/var/mail/cltbld', 20:09:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:21 INFO - 'MOZ_NO_REMOTE': '1', 20:09:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:21 INFO - 'NO_EM_RESTART': '1', 20:09:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:21 INFO - 'PWD': '/builds/slave/test', 20:09:21 INFO - 'SHELL': '/bin/bash', 20:09:21 INFO - 'SHLVL': '1', 20:09:21 INFO - 'TERM': 'linux', 20:09:21 INFO - 'TMOUT': '86400', 20:09:21 INFO - 'USER': 'cltbld', 20:09:21 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1464145740.770290-1072037691', 20:09:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:21 INFO - '_': '/tools/buildbot/bin/python'} 20:09:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:21 INFO - Downloading/unpacking blobuploader==1.2.4 20:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:23 INFO - Downloading blobuploader-1.2.4.tar.gz 20:09:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:09:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:09:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:24 INFO - Downloading docopt-0.6.1.tar.gz 20:09:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:09:24 INFO - Installing collected packages: blobuploader, requests, docopt 20:09:24 INFO - Running setup.py install for blobuploader 20:09:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:09:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:09:24 INFO - Running setup.py install for requests 20:09:24 INFO - Running setup.py install for docopt 20:09:25 INFO - Successfully installed blobuploader requests docopt 20:09:25 INFO - Cleaning up... 20:09:25 INFO - Return code: 0 20:09:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:09: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')]} 20:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09: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')]} 20:09:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:25 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 0x7faff34fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b19770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba89c0>, '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 0x1ba98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba9d50>, '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': 'df17445c3590ff7897617a0e00000225-1464145740.770290-1072037691', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:09:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:09:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:09:25 INFO - Using env: {'DISPLAY': ':0', 20:09:25 INFO - 'HOME': '/home/cltbld', 20:09:25 INFO - 'LANG': 'en_US.UTF-8', 20:09:25 INFO - 'LANGUAGE': 'en_US:en', 20:09:25 INFO - 'LOGNAME': 'cltbld', 20:09:25 INFO - 'MAIL': '/var/mail/cltbld', 20:09:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:25 INFO - 'MOZ_NO_REMOTE': '1', 20:09:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:25 INFO - 'NO_EM_RESTART': '1', 20:09:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:25 INFO - 'PWD': '/builds/slave/test', 20:09:25 INFO - 'SHELL': '/bin/bash', 20:09:25 INFO - 'SHLVL': '1', 20:09:25 INFO - 'TERM': 'linux', 20:09:25 INFO - 'TMOUT': '86400', 20:09:25 INFO - 'USER': 'cltbld', 20:09:25 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1464145740.770290-1072037691', 20:09:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:25 INFO - '_': '/tools/buildbot/bin/python'} 20:09:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:09:25 INFO - Running setup.py (path:/tmp/pip-bWBQO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:09:25 INFO - Running setup.py (path:/tmp/pip-ikuXLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:09:25 INFO - Running setup.py (path:/tmp/pip-Dn6piz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:09:25 INFO - Running setup.py (path:/tmp/pip-ZetTGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:09:25 INFO - Running setup.py (path:/tmp/pip-2ViBE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:09:25 INFO - Running setup.py (path:/tmp/pip-NK3JU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:09:25 INFO - Running setup.py (path:/tmp/pip-ILRtOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:09:25 INFO - Running setup.py (path:/tmp/pip-D4CYRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:09:25 INFO - Running setup.py (path:/tmp/pip-OH_nEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:09:26 INFO - Running setup.py (path:/tmp/pip-l58x8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:09:26 INFO - Running setup.py (path:/tmp/pip-8rlikX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:09:26 INFO - Running setup.py (path:/tmp/pip-wDUiif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:09:26 INFO - Running setup.py (path:/tmp/pip-7Vr3FF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:09:26 INFO - Running setup.py (path:/tmp/pip-l9Pr6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:09:26 INFO - Running setup.py (path:/tmp/pip-VNSnFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:09:26 INFO - Running setup.py (path:/tmp/pip-FcXEYq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:09:26 INFO - Running setup.py (path:/tmp/pip-H1v5Fg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:09:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:09:26 INFO - Running setup.py install for manifestparser 20:09:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:09:26 INFO - Running setup.py install for mozcrash 20:09:26 INFO - Running setup.py install for mozdebug 20:09:26 INFO - Running setup.py install for mozdevice 20:09:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:09:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:09:27 INFO - Running setup.py install for mozfile 20:09:27 INFO - Running setup.py install for mozhttpd 20:09:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:09:27 INFO - Running setup.py install for mozinfo 20:09:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:09:27 INFO - Running setup.py install for mozInstall 20:09:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:09:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:09:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:09:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:09:27 INFO - Running setup.py install for mozleak 20:09:27 INFO - Running setup.py install for mozlog 20:09:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:09:27 INFO - Running setup.py install for moznetwork 20:09:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:09:27 INFO - Running setup.py install for mozprocess 20:09:27 INFO - Running setup.py install for mozprofile 20:09:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:09:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:09:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:09:27 INFO - Running setup.py install for mozrunner 20:09:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:09:28 INFO - Running setup.py install for mozscreenshot 20:09:28 INFO - Running setup.py install for moztest 20:09:28 INFO - Running setup.py install for mozversion 20:09:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:09:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:09:28 INFO - Cleaning up... 20:09:28 INFO - Return code: 0 20:09:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:28 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 0x7faff34fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b19770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba89c0>, '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 0x1ba98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba9d50>, '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': 'df17445c3590ff7897617a0e00000225-1464145740.770290-1072037691', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:09:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:09:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:09:28 INFO - Using env: {'DISPLAY': ':0', 20:09:28 INFO - 'HOME': '/home/cltbld', 20:09:28 INFO - 'LANG': 'en_US.UTF-8', 20:09:28 INFO - 'LANGUAGE': 'en_US:en', 20:09:28 INFO - 'LOGNAME': 'cltbld', 20:09:28 INFO - 'MAIL': '/var/mail/cltbld', 20:09:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:28 INFO - 'MOZ_NO_REMOTE': '1', 20:09:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:28 INFO - 'NO_EM_RESTART': '1', 20:09:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:28 INFO - 'PWD': '/builds/slave/test', 20:09:28 INFO - 'SHELL': '/bin/bash', 20:09:28 INFO - 'SHLVL': '1', 20:09:28 INFO - 'TERM': 'linux', 20:09:28 INFO - 'TMOUT': '86400', 20:09:28 INFO - 'USER': 'cltbld', 20:09:28 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1464145740.770290-1072037691', 20:09:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:28 INFO - '_': '/tools/buildbot/bin/python'} 20:09:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:09:28 INFO - Running setup.py (path:/tmp/pip-YWExIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:09:28 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 20:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:09:28 INFO - Running setup.py (path:/tmp/pip-ftrpWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:09:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:09:28 INFO - Running setup.py (path:/tmp/pip-g5RFje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:09:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:09:28 INFO - Running setup.py (path:/tmp/pip-Po0aai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:09:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:09:28 INFO - Running setup.py (path:/tmp/pip-j8kvSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:09:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 20:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:09:28 INFO - Running setup.py (path:/tmp/pip-wtr8Ig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 20:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:09:29 INFO - Running setup.py (path:/tmp/pip-8XGiel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 20:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:09:29 INFO - Running setup.py (path:/tmp/pip-MqimoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 20:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:09:29 INFO - Running setup.py (path:/tmp/pip-hw4Hwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 20:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:09:29 INFO - Running setup.py (path:/tmp/pip-ObdAui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:09:29 INFO - Running setup.py (path:/tmp/pip-VnNtqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 20:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:09:29 INFO - Running setup.py (path:/tmp/pip-a9DcUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:09:29 INFO - Running setup.py (path:/tmp/pip-6ETWP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 20:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:09:29 INFO - Running setup.py (path:/tmp/pip-XilZh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:09:29 INFO - Running setup.py (path:/tmp/pip-vUimiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 20:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:09:29 INFO - Running setup.py (path:/tmp/pip-uCZREi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:09:29 INFO - Running setup.py (path:/tmp/pip-cnf4Wo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 20:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:09:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:31 INFO - Downloading blessings-1.6.tar.gz 20:09:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:09:31 INFO - Installing collected packages: blessings 20:09:31 INFO - Running setup.py install for blessings 20:09:31 INFO - Successfully installed blessings 20:09:31 INFO - Cleaning up... 20:09:32 INFO - Return code: 0 20:09:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:09:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:09:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:09:32 INFO - Reading from file tmpfile_stdout 20:09:32 INFO - Current package versions: 20:09:32 INFO - argparse == 1.2.1 20:09:32 INFO - blessings == 1.6 20:09:32 INFO - blobuploader == 1.2.4 20:09:32 INFO - docopt == 0.6.1 20:09:32 INFO - manifestparser == 1.1 20:09:32 INFO - mozInstall == 1.12 20:09:32 INFO - mozcrash == 0.17 20:09:32 INFO - mozdebug == 0.1 20:09:32 INFO - mozdevice == 0.48 20:09:32 INFO - mozfile == 1.2 20:09:32 INFO - mozhttpd == 0.7 20:09:32 INFO - mozinfo == 0.9 20:09:32 INFO - mozleak == 0.1 20:09:32 INFO - mozlog == 3.2 20:09:32 INFO - moznetwork == 0.27 20:09:32 INFO - mozprocess == 0.22 20:09:32 INFO - mozprofile == 0.28 20:09:32 INFO - mozrunner == 6.11 20:09:32 INFO - mozscreenshot == 0.1 20:09:32 INFO - mozsystemmonitor == 0.3 20:09:32 INFO - moztest == 0.7 20:09:32 INFO - mozversion == 1.4 20:09:32 INFO - psutil == 3.1.1 20:09:32 INFO - requests == 1.2.3 20:09:32 INFO - wsgiref == 0.1.2 20:09:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:32 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 0x7faff34fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b19770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba89c0>, '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 0x1ba98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba9d50>, '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': 'df17445c3590ff7897617a0e00000225-1464145740.770290-1072037691', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:09:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 20:09:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:09:32 INFO - Using env: {'DISPLAY': ':0', 20:09:32 INFO - 'HOME': '/home/cltbld', 20:09:32 INFO - 'LANG': 'en_US.UTF-8', 20:09:32 INFO - 'LANGUAGE': 'en_US:en', 20:09:32 INFO - 'LOGNAME': 'cltbld', 20:09:32 INFO - 'MAIL': '/var/mail/cltbld', 20:09:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:32 INFO - 'MOZ_NO_REMOTE': '1', 20:09:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:32 INFO - 'NO_EM_RESTART': '1', 20:09:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:32 INFO - 'PWD': '/builds/slave/test', 20:09:32 INFO - 'SHELL': '/bin/bash', 20:09:32 INFO - 'SHLVL': '1', 20:09:32 INFO - 'TERM': 'linux', 20:09:32 INFO - 'TMOUT': '86400', 20:09:32 INFO - 'USER': 'cltbld', 20:09:32 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1464145740.770290-1072037691', 20:09:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:32 INFO - '_': '/tools/buildbot/bin/python'} 20:09:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 20:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 20:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 20:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 20:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 20:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 20:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 20:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:09:32 INFO - Cleaning up... 20:09:32 INFO - Return code: 0 20:09:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:32 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 0x7faff34fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b19770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba89c0>, '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 0x1ba98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba9d50>, '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': 'df17445c3590ff7897617a0e00000225-1464145740.770290-1072037691', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:09:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:09:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:09:32 INFO - Using env: {'DISPLAY': ':0', 20:09:32 INFO - 'HOME': '/home/cltbld', 20:09:32 INFO - 'LANG': 'en_US.UTF-8', 20:09:32 INFO - 'LANGUAGE': 'en_US:en', 20:09:32 INFO - 'LOGNAME': 'cltbld', 20:09:32 INFO - 'MAIL': '/var/mail/cltbld', 20:09:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:32 INFO - 'MOZ_NO_REMOTE': '1', 20:09:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:32 INFO - 'NO_EM_RESTART': '1', 20:09:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:32 INFO - 'PWD': '/builds/slave/test', 20:09:32 INFO - 'SHELL': '/bin/bash', 20:09:32 INFO - 'SHLVL': '1', 20:09:32 INFO - 'TERM': 'linux', 20:09:32 INFO - 'TMOUT': '86400', 20:09:32 INFO - 'USER': 'cltbld', 20:09:32 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1464145740.770290-1072037691', 20:09:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:32 INFO - '_': '/tools/buildbot/bin/python'} 20:09:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:32 INFO - Downloading/unpacking jsonschema 20:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:09:34 INFO - Downloading/unpacking functools32 (from jsonschema) 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09:34 INFO - Downloading functools32-3.2.3-2.tar.gz 20:09:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:09:34 INFO - warning: no files found matching '*.txt' 20:09:34 INFO - no previously-included directories found matching 'build' 20:09:34 INFO - no previously-included directories found matching 'dist' 20:09:34 INFO - no previously-included directories found matching '.git*' 20:09:34 INFO - Installing collected packages: jsonschema, functools32 20:09:34 INFO - Running setup.py install for functools32 20:09:34 INFO - warning: no files found matching '*.txt' 20:09:34 INFO - no previously-included directories found matching 'build' 20:09:34 INFO - no previously-included directories found matching 'dist' 20:09:34 INFO - no previously-included directories found matching '.git*' 20:09:34 INFO - Successfully installed jsonschema functools32 20:09:34 INFO - Cleaning up... 20:09:34 INFO - Return code: 0 20:09:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:09: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')]} 20:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09: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')]} 20:09:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faff34fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b19770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba89c0>, '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 0x1ba98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba9d50>, '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': 'df17445c3590ff7897617a0e00000225-1464145740.770290-1072037691', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:09: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', 'flake8'] in /builds/slave/test/build 20:09: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 flake8 20:09:34 INFO - Using env: {'DISPLAY': ':0', 20:09:34 INFO - 'HOME': '/home/cltbld', 20:09:34 INFO - 'LANG': 'en_US.UTF-8', 20:09:34 INFO - 'LANGUAGE': 'en_US:en', 20:09:34 INFO - 'LOGNAME': 'cltbld', 20:09:34 INFO - 'MAIL': '/var/mail/cltbld', 20:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:34 INFO - 'MOZ_NO_REMOTE': '1', 20:09:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:35 INFO - 'NO_EM_RESTART': '1', 20:09:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:35 INFO - 'PWD': '/builds/slave/test', 20:09:35 INFO - 'SHELL': '/bin/bash', 20:09:35 INFO - 'SHLVL': '1', 20:09:35 INFO - 'TERM': 'linux', 20:09:35 INFO - 'TMOUT': '86400', 20:09:35 INFO - 'USER': 'cltbld', 20:09:35 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1464145740.770290-1072037691', 20:09:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:35 INFO - '_': '/tools/buildbot/bin/python'} 20:09:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:35 INFO - Downloading/unpacking flake8 20:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:37 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:09:37 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09:37 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:09:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:09:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:09:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:09:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:09:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:09:37 INFO - no previously-included directories found matching 'docs/_build' 20:09:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:09:37 INFO - Running setup.py install for pep8 20:09:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:09:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:09:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:09:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:09:37 INFO - no previously-included directories found matching 'docs/_build' 20:09:37 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:09:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:09:37 INFO - Cleaning up... 20:09:38 INFO - Return code: 0 20:09:38 INFO - Running post-action listener: _resource_record_post_action 20:09:38 INFO - Running post-action listener: _start_resource_monitoring 20:09:38 INFO - Starting resource monitoring. 20:09:38 INFO - ##### 20:09:38 INFO - ##### Finished create-virtualenv step (success) 20:09:38 INFO - ##### 20:09:38 INFO - ##### 20:09:38 INFO - ##### Running install step. 20:09:38 INFO - ##### 20:09:38 INFO - Running pre-action listener: _resource_record_pre_action 20:09:38 INFO - Running main action method: install 20:09:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:09:38 INFO - Reading from file tmpfile_stdout 20:09:38 INFO - Detecting whether we're running mozinstall >=1.0... 20:09:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:09:38 INFO - Reading from file tmpfile_stdout 20:09:38 INFO - Output received: 20:09:38 INFO - Usage: mozinstall [options] installer 20:09:38 INFO - Options: 20:09:38 INFO - -h, --help show this help message and exit 20:09:38 INFO - -d DEST, --destination=DEST 20:09:38 INFO - Directory to install application into. [default: 20:09:38 INFO - "/builds/slave/test"] 20:09:38 INFO - --app=APP Application being installed. [default: firefox] 20:09:38 INFO - mkdir: /builds/slave/test/build/application 20:09:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:09:54 INFO - Reading from file tmpfile_stdout 20:09:54 INFO - Output received: 20:09:54 INFO - /builds/slave/test/build/application/firefox/firefox 20:09:54 INFO - Running post-action listener: _resource_record_post_action 20:09:54 INFO - ##### 20:09:54 INFO - ##### Finished install step (success) 20:09:54 INFO - ##### 20:09:54 INFO - ##### 20:09:54 INFO - ##### Running run-tests step. 20:09:54 INFO - ##### 20:09:54 INFO - Running pre-action listener: _resource_record_pre_action 20:09:54 INFO - Running main action method: run_tests 20:09:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:09:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:09:55 INFO - Python 2.7.3 20:09:55 INFO - Return code: 0 20:09:55 INFO - grabbing minidump binary from tooltool 20:09:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:55 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 0x1ba89c0>, '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 0x1ba98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba9d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:09:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 20:09:55 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 20:09:55 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 20:09:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:09:55 INFO - Return code: 0 20:09:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:09:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:09:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:09:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:09:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:09:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:09:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:09:56 INFO - Return code: 0 20:09:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 20:09:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 20:09:56 INFO - Using env: {'DISPLAY': ':0', 20:09:56 INFO - 'HOME': '/home/cltbld', 20:09:56 INFO - 'LANG': 'en_US.UTF-8', 20:09:56 INFO - 'LANGUAGE': 'en_US:en', 20:09:56 INFO - 'LOGNAME': 'cltbld', 20:09:56 INFO - 'MAIL': '/var/mail/cltbld', 20:09:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:09:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:09:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:56 INFO - 'MOZ_NO_REMOTE': '1', 20:09:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:09:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:56 INFO - 'NO_EM_RESTART': '1', 20:09:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:56 INFO - 'PWD': '/builds/slave/test', 20:09:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:09:56 INFO - 'SHELL': '/bin/bash', 20:09:56 INFO - 'SHLVL': '1', 20:09:56 INFO - 'TERM': 'linux', 20:09:56 INFO - 'TMOUT': '86400', 20:09:56 INFO - 'USER': 'cltbld', 20:09:56 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1464145740.770290-1072037691', 20:09:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:56 INFO - '_': '/tools/buildbot/bin/python'} 20:09:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 20:09:56 INFO - mozversion application_buildid: 20160524173017 20:09:56 INFO - mozversion application_changeset: 788365ddaf61746bc66479335ae72d3e566c38ec 20:09:56 INFO - mozversion application_display_name: Nightly 20:09:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:09:56 INFO - mozversion application_name: Firefox 20:09:56 INFO - mozversion application_remotingname: firefox 20:09:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:09:56 INFO - mozversion application_vendor: Mozilla 20:09:56 INFO - mozversion application_version: 49.0a1 20:09:56 INFO - mozversion platform_buildid: 20160524173017 20:09:56 INFO - mozversion platform_changeset: 788365ddaf61746bc66479335ae72d3e566c38ec 20:09:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:09:56 INFO - mozversion platform_version: 49.0a1 20:09:56 INFO - using testdate: 1464145796 20:09:56 INFO - actual date: 1464145796 20:09:56 INFO - starting webserver on 'localhost:52827' 20:09:56 INFO - SUITE-START | Running 2 tests 20:09:56 INFO - TEST-START | dromaeo_css 20:09:56 INFO - operating with platform_type : linux_ 20:09:56 INFO - Initialising browser for dromaeo_css test... 20:09:56 INFO - TEST-INFO | started process 13479 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6ukDl4/profile http://localhost:52827/getInfo.html) 20:10:01 INFO - PROCESS | 13479 | 20:10:01 INFO - PROCESS | 13479 | (process:13546): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:10:01 INFO - PROCESS | 13479 | __metrics Screen width/height:1600/1200 20:10:01 INFO - PROCESS | 13479 | colorDepth:24 20:10:01 INFO - PROCESS | 13479 | Browser inner width/height: 1024/697 20:10:01 INFO - PROCESS | 13479 | __metrics 20:10:02 ERROR - PROCESS | 13479 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 20:10:03 INFO - TEST-INFO | 13479: exit 0 20:10:03 INFO - Browser initialized. 20:10:03 INFO - Running cycle 1/1 for dromaeo_css test... 20:10:03 INFO - TEST-INFO | started process 13597 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6ukDl4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:10:05 INFO - PROCESS | 13597 | 20:10:05 INFO - PROCESS | 13597 | (process:13658): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:10:15 INFO - PROCESS | 13597 | RSS: Main: 164184064 20:10:15 INFO - PROCESS | 13597 | 20:11:05 INFO - PROCESS | 13597 | 1464145865215 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 20:13:13 INFO - PROCESS | 13597 | Cycle 1(1): loaded http://localhost:52827/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52827/tests/dromaeo/cssquery-ext.html) 20:13:14 INFO - PROCESS | 13597 | RSS: Main: 168071168 20:13:14 INFO - PROCESS | 13597 | 20:16:16 INFO - PROCESS | 13597 | Cycle 1(1): loaded http://localhost:52827/tests/dromaeo/cssquery-ext.html (next: http://localhost:52827/tests/dromaeo/cssquery-jquery.html) 20:16:16 INFO - PROCESS | 13597 | RSS: Main: 166686720 20:16:16 INFO - PROCESS | 13597 | 20:19:18 INFO - PROCESS | 13597 | Cycle 1(1): loaded http://localhost:52827/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52827/tests/dromaeo/cssquery-mootools.html) 20:19:19 INFO - PROCESS | 13597 | RSS: Main: 167776256 20:19:19 INFO - PROCESS | 13597 | 20:22:21 INFO - PROCESS | 13597 | Cycle 1(1): loaded http://localhost:52827/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52827/tests/dromaeo/cssquery-prototype.html) 20:22:21 INFO - PROCESS | 13597 | RSS: Main: 165965824 20:22:21 INFO - PROCESS | 13597 | 20:25:24 INFO - PROCESS | 13597 | Cycle 1(1): loaded http://localhost:52827/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52827/tests/dromaeo/cssquery-yui.html) 20:25:24 INFO - PROCESS | 13597 | RSS: Main: 167145472 20:25:24 INFO - PROCESS | 13597 | 20:28:26 INFO - PROCESS | 13597 | Cycle 1(1): loaded http://localhost:52827/tests/dromaeo/cssquery-yui.html (next: http://localhost:52827/tests/dromaeo/cssquery-dojo.html) 20:28:27 INFO - PROCESS | 13597 | RSS: Main: 169017344 20:28:27 INFO - PROCESS | 13597 | 20:28:27 INFO - PROCESS | 13597 | __start_tp_report 20:28:27 INFO - PROCESS | 13597 | _x_x_mozilla_page_load 20:28:27 INFO - PROCESS | 13597 | _x_x_mozilla_page_load_details 20:28:27 INFO - PROCESS | 13597 | |i|pagename|runs| 20:28:27 INFO - PROCESS | 13597 | |0;dojo.html;3094.566760653509;3122.437961166989;3154.8580313885873;3161.8102913825173;3178.3643271345722;5334.5198932096155;5359.892802143955;5393.622446428752;5423.430539793324;5426.647267927582;5315.521603055724;5350.732463376826;5425.457454254582;5427.240186373911;5431.131019036955;4874.390701162355;4875.561199492045;4941.160002799533;5043.193089105744;5049.192129259319;4847.03059388122;5018.7992480300745;5037.168867136918;5039.269305950635;5041.294218809369;4811.446683631392;4821.325014497973;4877;4886.144924638174;4901.338319326898;4842.176829938919;4845.3216549683075;4866.416030076378;4877.439094504142;4931.728754918514;4863.100326439585;4865.440474345425;4872.1473742094995;4872.951270487285;4900.852974410738;5166.61250406221;5244.082285600005;5256.237845512417;5307.734613269321;5347.037533244014;5734.856628584277;5788.102844059177;5798.797042103548;5800.53595712342;5809.302883653946;5731.254936858223;5822.679752613604;5834.795782147605;5853.560982926298;5858.648481091105;5262.631615786897;5270.9736451317885;5319.2287118368;5333.679979201261;5340.519353258225;5804.88390232193;5806.390329015477;5812.912806307909;5823.737931793079;5828.358880523139;5529.198266251371;5582.91625625616;5607.018771714934;5608.46719561641;5649.943500564942;5713.942860571424;5766.538676905838;5794;5796.884062318814;5843.678597677083;5567.66594004361;5701.657900525899;5728.856778580569;5736.13957906309;5766.596338256366;5589.161625756169;5750.396208398141;5766.625169363978;5811.0411782056335;5819.185314056035;4299.333603291495;4337.240982827992;4397.934030989538;4402.16358891816;4407.933880991788;3814.4469051987307;3841.2317536492815;3868.7872167031082;3887.222555488857;3908;5417.6478528895495;5425.565954723613;5466.1527463243265;5472.890542189134;5482.698451585201;5709.3434255060365;5712.6286791358425;5726.341470730836;5757.107648314518;5834.5624078194305;5581.079121944915;5645.266115404971;5659.717014149276;5686.2607860977805;5710.971445142748;5043.773030213649;5055.620828437882;5057.165567681365;5067.87330316745;5136.306598609214;5902.3507414184405;6031.185789918392;6119.724612392453;6126.908096378558;6135;5861.677607731615;5909.202257695156;5920.733566989582;5934.169216309807;5981.700914954322;6011.308699499614;6076.817695469143;6088.573799833969;6093.664848433202;6099.085137229451;5553.222548843084;5574.136008918624;5592.049351610155;5701.173329867229;5809.94190058111;5717.171010203414;5722.570807189394;5726.599138060295;5727.599068065362;5766.221560089334;5544.944550554443;5559.63862348946;5561.221429000024;5562.110062389998;5574.832755017356;5505.697186654773;5558.777648894161;5631.070873305859;5651.943480565306;5676.375598684059;5626.2967129108865;5628.662280263197;5647;5651.180578816131;5660.150977353265;5681.4034526374135;5719.5710321726865;5752.424757524214;5783.277090363705;5803.564732644984;5452.672839629635;5528.44715528444;5550.861228469321;5575.8606034847835;5645.209670646031 20:28:27 INFO - PROCESS | 13597 | |1;ext.html;571.1233256950582;618.718483090194;631.7094136697119;642.2517766801676;658.2331583704984;36595.63404365956;41020.17959640809;41050.7947460263;41386.37920431196;41487;42219.577804221946;42953;43067.13865722684;43124.137517249634;43142;8564.272036876857;8688.435251708619;8695.913040869606;8700.434471759316;8702.042775294713;8641.222289993899;8732.388732788708;8737.169968852948;8746.125387461267;8787.516686582236;8792.296616270683;8792.34057445691;8835.204831565157;8860.645574177026;8867.77830554238;8794.296456283482;8811.206991370775;8825.117488251188;8848.20366167048;8857.468551886876;8652.653893844301;8765.956170219171;8779.561021948877;8797.252233560155;8819.867701984474;39817.40273895894;40044.19911601781;40141;40353.79823100866;40466.39300410496;3427.280271143063;3617.0776452004834;3642.0348607619003;3656.524651795276;4009.0459504460905;31356.216094597818;31681.207969800707;32309.192270193198;32336.838315808505;33497.497537536954;4166.729162604452;4249.660027197817;4267.573242675739;4282.336237883133;4327.8052487637815;340276;341809;343763;344699;345390;35618.64381356205;56348;57241.427585723606;57442.425575743706;57510.42489575134;36667;36751.4487282691;36780;36844.078898027765;36888;14095.295235238196;14253.144811311355;14257.78613320801;14262.072965257224;14281;11667.299962002307;12008.219465734699;12030.15788894769;12031.87968120325;12033.518659253532;8294.668213271521;8402.747917562483;8420;8423.663053477914;8483.533405662747;3284.2282063715484;3309.5532103165765;3314.2211580278617;3314.320564284316;3336.4161271777343;1030.057497389895;1048.4600430778155;1100.9229353945307;1183.5975768238668;1198.2750435986277;31392.372152557276;31650.841745791586;31866.68133318637;31984.360312793615;32327;1118.5134466507095;1226.760781647588;1258.2702032820941;1267.518343029643;1279.8464184297943;16420.59525529809;16787.32850685959;16878.915605421895;16986.32054717822;17180.742288865677;512572;514163;514648;515939;521166;57172.71413642905;57990.710046449494;58021;58220.417795822344;58229.4177058224;1368.857004401336;1369.1716511510392;1388.916665000083;1401.0822910993315;1409.5700811252461;30547.319897405858;31067.68932310648;31322.530162047133;32158.839205803823;32263.35473290474;50428.49571504238;50432.74783626058;50564;50657.49342506528;50689.74655126701;409132;410756;412890;412946;413697;27602.447951040464;27701;27952.30119247035;28009.299767505974;28204.71795282103;46966;47155;47231.05537889154;47347;48441;39889.00277493086;40220.59779402168;40447.59552404438;40544.79727601343;40795.59204408037;38816.80591597024;39583.40624890687;39791.2041759169;39998.40002400024;40062.39906401348;40838.387424189255;40901.590984090966;41386;41708.3743743838;44343.77828110839;34824.65175348315;36609.26781464409;42631.573684264;46609.766951165024;46836.7658161707;32216.83891580527;34748.131296716776;34786.82606586951;35067.123321917155;35137.110608357994 20:28:27 INFO - PROCESS | 13597 | |2;jquery.html;371.5355805243446;381.46404301955744;381.5040447418356;388.0686352753393;391.3581725969411;17539;19413.12640931158;19803.504912377197;20467.283645072424;20514.384568462934;18515;18913.054347282614;18959.62080758384;19157.616847663037;19420;5453.809116680917;5517.834464966048;5668.093105103184;5682.147677848335;5710;5557.638753481011;5567.220589117527;5573.442655734435;5573.916391254134;5623.26897503324;5362.624616276862;5577.8047768328115;5585.050541407971;5596.076647353202;5616.185653080301;5563.276774019392;5568.888622227532;5571.4428557144365;5601.879624075181;5604.355499117592;4872.65891387603;4938.530839570271;4946.505349465061;4969.031038947407;4978.925316120261;22177.334679959626;22186.446948713598;22548.098076076938;22568.66147007796;22697.886510567507;2317.7566355532763;2424.6484259782233;2463.3964678653665;2548.719640839506;2657.6146458763565;14016.43934242629;14117.78823317651;14299.85700143006;14371;14863.851361486355;1923.2114832918576;2020.7170996060563;2048.94877628059;2050.282401159582;2053.486628342914;54674.72662636662;68893.65553172253;69726.65136674284;70238.29761702368;78692;9901.554430050664;10048.598056077675;10265;10314.535845886952;10565.101966332948;14450.060746051473;14502.709945801025;14544.85455145435;14608.853911460961;14632;7575.128860181039;7893.644785984645;7921.801954951173;7962.163972782891;7972.920270797218;7639.69441222356;7682.385409167253;7725.111612164561;7778.494397864234;7802.102758182768;6405.29541750407;6427.935720642828;6480.805575832733;6500.804975850732;6580.80257592273;1836.6969450040594;1878.389523404899;1892.0823400650672;1905.2664724081328;1911.6559019376646;431.9503257125408;464.0487001646611;960.3181740963994;1048.0724558765396;1097.545751878764;11157.609483668195;11346.829797553044;11576.76846463066;11841.5855445059;12041;434.55675211284944;440.874350810024;441.2939297124575;454.5318322128213;467.8970626462173;6269.310375858652;6401.071844582602;6409.230892292955;6413;6421.357864213542;453621;456457;493859;503634;506377;58171.418285817446;75330;96195;97657.5117124424;97877.5106124479;436.5329097865317;451.821530495459;460.0752487500149;460.24519787548445;464.20620738536803;11067.557297708323;11380.317180969168;11407.315561066363;11429.828552571551;11488.908553687386;37603.81198093992;38490.42264365981;38865;39004.609953901236;44350;54196.729016354664;55416.72291638516;62683.37316626775;63614;64451;8272.875906861522;8443.95778021106;8449.619767110618;8473.57632118404;8579.184977427134;12359.32023738703;12512.74974500523;12671.80992285135;13673.521426750016;13925.51260705911;10787.730306742395;11272.436378181223;11379.317240965569;11490.54037838477;12144.453499592362;8028.31759300466;8400.495970241805;11298.943505282421;12066.155369124428;12133.939330303645;12070.637880863587;12090.335031572997;12151.210171338835;12269.263844169378;12448.751024979269;8491.320694344562;8548.358873084419;8555.871661924952;8755.649774008969;8781.429207101773;8792.560371981248;11434.48544815502;11463.942680286546;11504.827427588425;11796.29222246668 20:28:27 INFO - PROCESS | 13597 | |3;mootools.html;1443.6102252391854;1526.1834918318702;1704.1394095981527;1819.654265689518;1844.2530775036114;7779.144294127642;8182.509049457022;8365;8992.100789921005;9009.639614415424;8268.503889766618;8350.248477637011;8492.278156356717;8611.526366049864;8634.136586341363;2254.5603607296584;2325.2907863101746;2335.696359473266;2335.7313908900437;2342.754010828864;2287.7369102553253;2293.4495721026915;2311.6763653088583;2317.397476656073;2323.233333000106;2302.0906741836966;2302.9078836846506;2316.9536609267802;2328.9534209315802;2346.2374728213313;2236.586231547169;2259.344790010895;2268.217464974581;2270.2167752125574;2274.215395688493;2231.542533780571;2232.36377632374;2236.798688118061;2237.8209743220505;2238.675392068141;8569.914300856974;8571.785705357353;8649.048604653482;8684.392092553524;8720.21518063371;5044.848654540333;5151.742412879378;5191.5846732261325;5196.92204616931;5197.246399272122;3085.4754691702465;3196.824174670392;3231.3052693670975;3283.917902052468;3300.488424294238;1014.7260239735231;1020.739711373595;1037.7768779712324;1054.6730513540826;1057.6351158850184;11811;11911.404429778562;11914.046876249879;11964.760704785942;11973.580924667594;4693.460252070987;4734.644901632322;4760.238361862085;4819.108464933928;4820.108279968217;10151.593936242616;10210.183185345155;10237.385756854464;10253.897461025443;10274.126699230648;5238.842834714965;5300.761465734051;5314.813981510629;5326.813561525406;5347.545458636059;4334.089841133397;4612.446506419251;4788.066327066189;4814.20565606678;4825.95174048262;4042.3936409538214;4087.550369459357;4106.609872062149;4117.094239267416;4166.312558427886;1288.9162204456868;1300.1678925487695;1317.3215793866166;1328.6014195741238;1343.1605246720799;946.8485042393185;1019.0828254570946;1037.9117774989058;1038.159091136167;1055.150603763962;5995.550333724988;6040.365761595057;6061.4544690977145;6142.78500252489;6380.844491244095;940.501534186882;963.6241865672393;964.5659453246068;1007.315025782475;1026.856240126383;4113.136241389282;4304.526502084768;4307.978460107679;4348.391225228471;4393.0994146199955;10416.531256093342;10768.623098191681;10845.674629761119;10877.0754485868;10908.563657453771;10698;10737.731556710989;10739.892601073889;10753.677389678322;10766;7747.690092396354;8115;8119.878201826978;8299.95850020746;8314.750557483165;5836.445537673914;5955.940440595712;5991.580589358703;6107.083937409247;6113.602615829956;9695.418274903528;9857.162141218078;9937.701868943943;9981.60073597048;10013.899861001297;9900.25748068912;10102.595896164072;10197.745056373353;10245.129164021142;10287.177025838064;7067.081279433641;7542.509736867086;7685.193054729173;7770.611469426619;7866.292033716993;8352.290055345364;8424.62089205975;8459.534725590152;8490.15098490146;8530.402871798915;7473.103227612722;7709.267619576131;7733.072031356048;7764.145943946274;7783.377329813715;7451.3293803557945;7622.733204337822;7667.923320766944;7679.347255483123;7727;6982.441404687715;7008.789736307919;7014.579125252501;7081.787546373617;7136.286371362822;5245.790168393374;5315.495027972336;5351.170568561879;5401.135818269058;5443.156310771837;5317.627766056339;5320.308359913187;5328.7602057906715;5388.973055134699;5431.728413579384 20:28:27 INFO - PROCESS | 13597 | |4;prototype.html;322.62414287355233;333.23190046941806;338.29803158446225;338.9322135572886;342.66932410224126;5314.92027619586;5393;5503.862403439911;5551.611387202897;5627.324721033477;5454.509094181523;5475.5072043516075;5479.2602998595175;5501.83644404468;5521.558275337973;4105.651019663324;4176.728512646683;4177.644900183473;4202.684798640099;4299.720518166325;4219.683523735716;4268.67357290276;4312;4318.481782186126;4324.459442569679;4209.9789501052455;4234.386014027964;4236.4916210054835;4274.187904298189;4277.935830962538;4268.445102136733;4270.210011147932;4295.871123866289;4297.677674174418;4304.956950430487;3655.177585043344;3818.4081467372603;3821.178446633987;3823.9808800956093;3825.713071519647;5320.388155362144;5321.707306098163;5328.602129041908;5352.812651557216;5366.7853285868905;4856.538628830255;4856.781444834991;4857.854264372075;4863.562279394836;4885.8045678173185;5521.834344969658;5760.6255593386295;5828.708564571797;5833.649981001111;5842.444967728102;4131.462909821704;4141.349536296772;4143.8964025899295;4151.335786274211;4184.330507118877;6017.021574320695;6077.508221629111;6083.6349819011;6088.543359248074;6118.388161183846;4013.478247827764;4189.282394218356;4272.16692744918;4280.272353699878;4295.226859165317;4193.853215137517;4237.364395340662;4253.893652658709;4269.615734583902;4271.530131685512;4903.828366007173;4910.337104490919;4920.852374428701;4923.458419573844;4945.159322915113;5644.435556444405;5840.153177789197;5900.734466948998;5938.554608404387;5950.7917222896995;1437.4106616287272;1459.547540262522;1467.9192644404447;1468.0531057467874;1480.1193289992436;915.56053094515;927.9072092790667;935.0275713258271;947.824652439301;950.7290422229631;5018.5232402921665;5025.547700706954;5041.949580504222;5102.923456148161;5109.20807274873;5256.658317209369;5288.867778305573;5353.250544923714;5368.248445217672;5388.703621300866;5072.86939485417;5077.400618805138;5137.768800403991;5265.815696450606;5676.716164191774;3147.937041259162;3199.9040028799172;3226.5644138041534;3232.383808095952;3236.947991902594;6146.200993870858;6244.562880598314;6280.654563998933;6301.842453938597;6343.619382836952;6164;6164.291106522807;6177.62934223948;6201.844953876189;6228;6241.751649670085;6263.154474145932;6265.780697675559;6266.279377871512;6290.622562646165;5756.827295181151;6012.278526576664;6032.3967603239325;6055.666938318434;6103.542234332354;5996.850078748066;6014.278286605635;6020.290869109006;6027.78902738402;6056.788012419544;6020.247469066367;6240.937590624036;6271.905921411274;6281.497480201664;6293.339199383999;4123.8556650518285;4129.91740165201;4147.585241475828;4180.268453020648;4199.02645756494;6011.639301641915;6022.09668549721;6070.666113363631;6070.939290607037;6085.543584231112;5521.834344969658;5834.299884013945;5839.211706419579;5841.357450680337;5850.765969361178;5784.334801497882;5814.098814683731;5835.708214589338;5837.503812176013;5855.414458554111;5567.3040869891265;5722.4277572242445;5747.626404283708;5752.676884316715;5767.163761254678;5838.883222335615;5886.6173698709445;5889.116632505158;5901.380355062828;5917.615355001911;5694.829155125353;5698.658080515016;5734.569907256889;5785.8553536161935;5840.707964601838 20:28:27 INFO - PROCESS | 13597 | |5;yui.html;758.8444368904375;839.8194388206531;842.4271495383141;849.6304107713145;864.5461132905228;13497.39261733222;14783.556493305217;14898.77651835222;14912.403503859832;14922.253887305646;13565.050446468751;13607.11553749008;13635;13658.521951731691;13661.863381366184;684.2507454337505;802.3741481644327;825.6697321071589;826.4834478450969;827.668932427028;810.6635746165334;815.8735396013627;817.0195765081926;820.409305300183;820.7168526858225;855.9358048146382;857.0743596915316;857.2927334948661;857.5026484638895;858.841114393836;851.1956201389689;851.6721062391024;851.7785375802335;852.1138016462871;852.8891244138284;616.8797084568511;617.1637431280595;618.1006635345607;618.4526693875907;618.9535784816112;13583.932080339535;13588.320583970763;13638.863611363859;13657.317134143253;13658.658533536642;13860.930695346458;14201.928990354982;14280.857191428056;14569.781453278209;14837.10977341363;11776;11791.941040294743;11828.526858925632;12025.759484810254;12066.336351500664;3846.615338466159;3874.380099184117;3906.1797022625283;3917.4319723639915;3922.5489068757174;56507;57052.144217836765;57061;57174.42825571733;57237.42762572363;11108.949319285122;11298.830517542243;11480.507534020524;11552.152729442212;11663.391457923999;18678.626427471376;18703.812961870208;18704.438866834018;18711.251549938122;18749.81250187508;8027.15714849944;8178.1821817817745;8210.466319689202;8220.136885626924;8342.916570834335;4719.082090704793;4828.227483602677;4891.315215869781;4912.361393018885;4945.505449455026;3359.160209947513;3455.7926524408617;3471.340445315382;3478.9910925831227;3480.3387356402204;602.2261394108549;608.330836080317;615.6306216270202;632.1686981619156;634.194572892424;693.407136897945;706.2266817834463;722.8771108911498;755.1806290175222;756.0851369842442;9207.355485116112;9657.22742180624;9695.224382049419;9761.07269809367;9769.413835169771;699.3950233048377;733.1641928201855;767.3951144161334;795.9681612735542;797.4178849439826;4480.932786008212;4643.349931009661;4679;4685.367475390847;4717.905641887143;64027;64786;65113;65239.34760652428;65719.34280657132;58832.7058364714;59513;59522;59913.40086599165;60802.695986519786;51734.48265517372;52699.736501317246;53771.19343209855;53923.73038134784;54255.72872135693;8746.256568191775;8780.385373023826;8827.646894124164;9073;9148.63405463774;35989.640103599675;36125.45811812877;36162.638373615926;36291.81854090712;36773.81613091917;43811.342829858215;45479.31781023221;46989;47584.52415475939;47960.7601961988;11764;11992.64022079339;12208;12234.388280586114;12444.191127576678;12948.8057679133;13173.143745656502;13630.386632601754;13915.095518791246;14019.439222430989;12536.435860386488;12542.122051456676;12556.183848049848;12713.11008229415;12856.485740570646;12497.25016499013;12613.180143290656;12637.93681031589;12780.744385112059;13264.668383290495;11406.429678516208;11542.672592651952;11704.473298701409;11706.414679266172;11723.179377443837;10293.330933489298;10555.15558755313;10734.463276836283;10793.40636265013;10883.727906802076;10296.485175741333;10520.842187367043;10651.573937042742;10829.566817327219;10885.020348168702 20:28:27 INFO - PROCESS | 13597 | __end_tp_report 20:28:27 INFO - PROCESS | 13597 | __start_cc_report 20:28:27 INFO - PROCESS | 13597 | _x_x_mozilla_cycle_collect,341 20:28:27 INFO - PROCESS | 13597 | __end_cc_report 20:28:27 INFO - PROCESS | 13597 | __startTimestamp1464146907147__endTimestamp 20:28:27 INFO - PROCESS | 13597 | 20:28:27 INFO - PROCESS | 13597 | ------- Summary: start ------- 20:28:27 INFO - PROCESS | 13597 | Number of tests: 6 20:28:27 INFO - PROCESS | 13597 | 20:28:27 INFO - PROCESS | 13597 | [#0] dojo.html Cycles:165 Average:5363.75 Median:5574.14 stddev:619.48 (11.1%) stddev-sans-first:595.26 20:28:27 INFO - PROCESS | 13597 | Values: 3094.6 3122.4 3154.9 3161.8 3178.4 5334.5 5359.9 5393.6 5423.4 5426.6 5315.5 5350.7 5425.5 5427.2 5431.1 4874.4 4875.6 4941.2 5043.2 5049.2 4847.0 5018.8 5037.2 5039.3 5041.3 4811.4 4821.3 4877.0 4886.1 4901.3 4842.2 4845.3 4866.4 4877.4 4931.7 4863.1 4865.4 4872.1 4873.0 4900.9 5166.6 5244.1 5256.2 5307.7 5347.0 5734.9 5788.1 5798.8 5800.5 5809.3 5731.3 5822.7 5834.8 5853.6 5858.6 5262.6 5271.0 5319.2 5333.7 5340.5 5804.9 5806.4 5812.9 5823.7 5828.4 5529.2 5582.9 5607.0 5608.5 5649.9 5713.9 5766.5 5794.0 5796.9 5843.7 5567.7 5701.7 5728.9 5736.1 5766.6 5589.2 5750.4 5766.6 5811.0 5819.2 4299.3 4337.2 4397.9 4402.2 4407.9 3814.4 3841.2 3868.8 3887.2 3908.0 5417.6 5425.6 5466.2 5472.9 5482.7 5709.3 5712.6 5726.3 5757.1 5834.6 5581.1 5645.3 5659.7 5686.3 5711.0 5043.8 5055.6 5057.2 5067.9 5136.3 5902.4 6031.2 6119.7 6126.9 6135.0 5861.7 5909.2 5920.7 5934.2 5981.7 6011.3 6076.8 6088.6 6093.7 6099.1 5553.2 5574.1 5592.0 5701.2 5809.9 5717.2 5722.6 5726.6 5727.6 5766.2 5544.9 5559.6 5561.2 5562.1 5574.8 5505.7 5558.8 5631.1 5651.9 5676.4 5626.3 5628.7 5647.0 5651.2 5660.2 5681.4 5719.6 5752.4 5783.3 5803.6 5452.7 5528.4 5550.9 5575.9 5645.2 20:28:27 INFO - PROCESS | 13597 | 20:28:27 INFO - PROCESS | 13597 | [#1] ext.html Cycles:180 Average:57548.06 Median:40456.99 stddev:113902.83 (281.5%) stddev-sans-first:114142.02 20:28:27 INFO - PROCESS | 13597 | Values: 571.1 618.7 631.7 642.3 658.2 36595.6 41020.2 41050.8 41386.4 41487.0 42219.6 42953.0 43067.1 43124.1 43142.0 8564.3 8688.4 8695.9 8700.4 8702.0 8641.2 8732.4 8737.2 8746.1 8787.5 8792.3 8792.3 8835.2 8860.6 8867.8 8794.3 8811.2 8825.1 8848.2 8857.5 8652.7 8766.0 8779.6 8797.3 8819.9 39817.4 40044.2 40141.0 40353.8 40466.4 3427.3 3617.1 3642.0 3656.5 4009.0 31356.2 31681.2 32309.2 32336.8 33497.5 4166.7 4249.7 4267.6 4282.3 4327.8 340276.0 341809.0 343763.0 344699.0 345390.0 35618.6 56348.0 57241.4 57442.4 57510.4 36667.0 36751.4 36780.0 36844.1 36888.0 14095.3 14253.1 14257.8 14262.1 14281.0 11667.3 12008.2 12030.2 12031.9 12033.5 8294.7 8402.7 8420.0 8423.7 8483.5 3284.2 3309.6 3314.2 3314.3 3336.4 1030.1 1048.5 1100.9 1183.6 1198.3 31392.4 31650.8 31866.7 31984.4 32327.0 1118.5 1226.8 1258.3 1267.5 1279.8 16420.6 16787.3 16878.9 16986.3 17180.7 512572.0 514163.0 514648.0 515939.0 521166.0 57172.7 57990.7 58021.0 58220.4 58229.4 1368.9 1369.2 1388.9 1401.1 1409.6 30547.3 31067.7 31322.5 32158.8 32263.4 50428.5 50432.7 50564.0 50657.5 50689.7 409132.0 410756.0 412890.0 412946.0 413697.0 27602.4 27701.0 27952.3 28009.3 28204.7 46966.0 47155.0 47231.1 47347.0 48441.0 39889.0 40220.6 40447.6 40544.8 40795.6 38816.8 39583.4 39791.2 39998.4 40062.4 40838.4 40901.6 41386.0 41708.4 44343.8 34824.7 36609.3 42631.6 46609.8 46836.8 32216.8 34748.1 34786.8 35067.1 35137.1 20:28:27 INFO - PROCESS | 13597 | 20:28:27 INFO - PROCESS | 13597 | [#2] jquery.html Cycles:180 Average:27731.25 Median:441.08 stddev:79558.68 (18037.1%) stddev-sans-first:79755.34 20:28:27 INFO - PROCESS | 13597 | Values: 371.5 381.5 381.5 388.1 391.4 17539.0 19413.1 19803.5 20467.3 20514.4 18515.0 18913.1 18959.6 19157.6 19420.0 5453.8 5517.8 5668.1 5682.1 5710.0 5557.6 5567.2 5573.4 5573.9 5623.3 5362.6 5577.8 5585.1 5596.1 5616.2 5563.3 5568.9 5571.4 5601.9 5604.4 4872.7 4938.5 4946.5 4969.0 4978.9 22177.3 22186.4 22548.1 22568.7 22697.9 2317.8 2424.6 2463.4 2548.7 2657.6 14016.4 14117.8 14299.9 14371.0 14863.9 1923.2 2020.7 2048.9 2050.3 2053.5 54674.7 68893.7 69726.7 70238.3 78692.0 9901.6 10048.6 10265.0 10314.5 10565.1 14450.1 14502.7 14544.9 14608.9 14632.0 7575.1 7893.6 7921.8 7962.2 7972.9 7639.7 7682.4 7725.1 7778.5 7802.1 6405.3 6427.9 6480.8 6500.8 6580.8 1836.7 1878.4 1892.1 1905.3 1911.7 432.0 464.0 960.3 1048.1 1097.5 11157.6 11346.8 11576.8 11841.6 12041.0 434.6 440.9 441.3 454.5 467.9 6269.3 6401.1 6409.2 6413.0 6421.4 453621.0 456457.0 493859.0 503634.0 506377.0 58171.4 75330.0 96195.0 97657.5 97877.5 436.5 451.8 460.1 460.2 464.2 11067.6 11380.3 11407.3 11429.8 11488.9 37603.8 38490.4 38865.0 39004.6 44350.0 54196.7 55416.7 62683.4 63614.0 64451.0 8272.9 8444.0 8449.6 8473.6 8579.2 12359.3 12512.7 12671.8 13673.5 13925.5 10787.7 11272.4 11379.3 11490.5 12144.5 8028.3 8400.5 11298.9 12066.2 12133.9 12070.6 12090.3 12151.2 12269.3 12448.8 8491.3 8548.4 8555.9 8755.6 8781.4 8792.6 11434.5 11463.9 11504.8 11796.3 20:28:27 INFO - PROCESS | 13597 | 20:28:27 INFO - PROCESS | 13597 | [#3] mootools.html Cycles:180 Average:5766.75 Median:4774.15 stddev:3221.69 (67.5%) stddev-sans-first:3214.34 20:28:27 INFO - PROCESS | 13597 | Values: 1443.6 1526.2 1704.1 1819.7 1844.3 7779.1 8182.5 8365.0 8992.1 9009.6 8268.5 8350.2 8492.3 8611.5 8634.1 2254.6 2325.3 2335.7 2335.7 2342.8 2287.7 2293.4 2311.7 2317.4 2323.2 2302.1 2302.9 2317.0 2329.0 2346.2 2236.6 2259.3 2268.2 2270.2 2274.2 2231.5 2232.4 2236.8 2237.8 2238.7 8569.9 8571.8 8649.0 8684.4 8720.2 5044.8 5151.7 5191.6 5196.9 5197.2 3085.5 3196.8 3231.3 3283.9 3300.5 1014.7 1020.7 1037.8 1054.7 1057.6 11811.0 11911.4 11914.0 11964.8 11973.6 4693.5 4734.6 4760.2 4819.1 4820.1 10151.6 10210.2 10237.4 10253.9 10274.1 5238.8 5300.8 5314.8 5326.8 5347.5 4334.1 4612.4 4788.1 4814.2 4826.0 4042.4 4087.6 4106.6 4117.1 4166.3 1288.9 1300.2 1317.3 1328.6 1343.2 946.8 1019.1 1037.9 1038.2 1055.2 5995.6 6040.4 6061.5 6142.8 6380.8 940.5 963.6 964.6 1007.3 1026.9 4113.1 4304.5 4308.0 4348.4 4393.1 10416.5 10768.6 10845.7 10877.1 10908.6 10698.0 10737.7 10739.9 10753.7 10766.0 7747.7 8115.0 8119.9 8300.0 8314.8 5836.4 5955.9 5991.6 6107.1 6113.6 9695.4 9857.2 9937.7 9981.6 10013.9 9900.3 10102.6 10197.7 10245.1 10287.2 7067.1 7542.5 7685.2 7770.6 7866.3 8352.3 8424.6 8459.5 8490.2 8530.4 7473.1 7709.3 7733.1 7764.1 7783.4 7451.3 7622.7 7667.9 7679.3 7727.0 6982.4 7008.8 7014.6 7081.8 7136.3 5245.8 5315.5 5351.2 5401.1 5443.2 5317.6 5320.3 5328.8 5389.0 5431.7 20:28:27 INFO - PROCESS | 13597 | 20:28:27 INFO - PROCESS | 13597 | [#4] prototype.html Cycles:180 Average:4857.75 Median:5423.75 stddev:1451.31 (26.8%) stddev-sans-first:1414.90 20:28:27 INFO - PROCESS | 13597 | Values: 322.6 333.2 338.3 338.9 342.7 5314.9 5393.0 5503.9 5551.6 5627.3 5454.5 5475.5 5479.3 5501.8 5521.6 4105.7 4176.7 4177.6 4202.7 4299.7 4219.7 4268.7 4312.0 4318.5 4324.5 4210.0 4234.4 4236.5 4274.2 4277.9 4268.4 4270.2 4295.9 4297.7 4305.0 3655.2 3818.4 3821.2 3824.0 3825.7 5320.4 5321.7 5328.6 5352.8 5366.8 4856.5 4856.8 4857.9 4863.6 4885.8 5521.8 5760.6 5828.7 5833.6 5842.4 4131.5 4141.3 4143.9 4151.3 4184.3 6017.0 6077.5 6083.6 6088.5 6118.4 4013.5 4189.3 4272.2 4280.3 4295.2 4193.9 4237.4 4253.9 4269.6 4271.5 4903.8 4910.3 4920.9 4923.5 4945.2 5644.4 5840.2 5900.7 5938.6 5950.8 1437.4 1459.5 1467.9 1468.1 1480.1 915.6 927.9 935.0 947.8 950.7 5018.5 5025.5 5041.9 5102.9 5109.2 5256.7 5288.9 5353.3 5368.2 5388.7 5072.9 5077.4 5137.8 5265.8 5676.7 3147.9 3199.9 3226.6 3232.4 3236.9 6146.2 6244.6 6280.7 6301.8 6343.6 6164.0 6164.3 6177.6 6201.8 6228.0 6241.8 6263.2 6265.8 6266.3 6290.6 5756.8 6012.3 6032.4 6055.7 6103.5 5996.9 6014.3 6020.3 6027.8 6056.8 6020.2 6240.9 6271.9 6281.5 6293.3 4123.9 4129.9 4147.6 4180.3 4199.0 6011.6 6022.1 6070.7 6070.9 6085.5 5521.8 5834.3 5839.2 5841.4 5850.8 5784.3 5814.1 5835.7 5837.5 5855.4 5567.3 5722.4 5747.6 5752.7 5767.2 5838.9 5886.6 5889.1 5901.4 5917.6 5694.8 5698.7 5734.6 5785.9 5840.7 20:28:27 INFO - PROCESS | 13597 | 20:28:27 INFO - PROCESS | 13597 | [#5] yui.html Cycles:180 Average:15284.95 Median:25837.18 stddev:18062.19 (69.9%) stddev-sans-first:18079.92 20:28:27 INFO - PROCESS | 13597 | Values: 758.8 839.8 842.4 849.6 864.5 13497.4 14783.6 14898.8 14912.4 14922.3 13565.1 13607.1 13635.0 13658.5 13661.9 684.3 802.4 825.7 826.5 827.7 810.7 815.9 817.0 820.4 820.7 855.9 857.1 857.3 857.5 858.8 851.2 851.7 851.8 852.1 852.9 616.9 617.2 618.1 618.5 619.0 13583.9 13588.3 13638.9 13657.3 13658.7 13860.9 14201.9 14280.9 14569.8 14837.1 11776.0 11791.9 11828.5 12025.8 12066.3 3846.6 3874.4 3906.2 3917.4 3922.5 56507.0 57052.1 57061.0 57174.4 57237.4 11108.9 11298.8 11480.5 11552.2 11663.4 18678.6 18703.8 18704.4 18711.3 18749.8 8027.2 8178.2 8210.5 8220.1 8342.9 4719.1 4828.2 4891.3 4912.4 4945.5 3359.2 3455.8 3471.3 3479.0 3480.3 602.2 608.3 615.6 632.2 634.2 693.4 706.2 722.9 755.2 756.1 9207.4 9657.2 9695.2 9761.1 9769.4 699.4 733.2 767.4 796.0 797.4 4480.9 4643.3 4679.0 4685.4 4717.9 64027.0 64786.0 65113.0 65239.3 65719.3 58832.7 59513.0 59522.0 59913.4 60802.7 51734.5 52699.7 53771.2 53923.7 54255.7 8746.3 8780.4 8827.6 9073.0 9148.6 35989.6 36125.5 36162.6 36291.8 36773.8 43811.3 45479.3 46989.0 47584.5 47960.8 11764.0 11992.6 12208.0 12234.4 12444.2 12948.8 13173.1 13630.4 13915.1 14019.4 12536.4 12542.1 12556.2 12713.1 12856.5 12497.3 12613.2 12637.9 12780.7 13264.7 11406.4 11542.7 11704.5 11706.4 11723.2 10293.3 10555.2 10734.5 10793.4 10883.7 10296.5 10520.8 10651.6 10829.6 10885.0 20:28:27 INFO - PROCESS | 13597 | -------- Summary: end -------- 20:28:27 INFO - PROCESS | 13597 | 20:28:27 INFO - PROCESS | 13597 | [Child 13658] WARNING: pipe error (3): Connection reset by peer: file /builds/slave/fx-team-l64-pgo-00000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_posix.cc, line 315 20:28:27 INFO - PROCESS | 13597 | 20:28:27 INFO - PROCESS | 13597 | ###!!! [Child][MessageChannel] Error: (msgtype=0x46010F,name=PContent::Msg_AsyncMessage) Channel closing: too late to send/recv, messages will be lost 20:28:27 INFO - PROCESS | 13597 | 20:28:27 INFO - PROCESS | 13597 | 20:28:27 INFO - PROCESS | 13597 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2C0043,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 20:28:27 INFO - PROCESS | 13597 | 20:28:27 INFO - PROCESS | 13597 | 20:28:27 INFO - PROCESS | 13597 | ###!!! [Child][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 20:28:27 INFO - PROCESS | 13597 | 20:28:27 INFO - TEST-INFO | 13597: exit 0 20:28:27 INFO - TEST-OK | dromaeo_css | took 1111576ms 20:28:27 INFO - TEST-START | kraken 20:28:27 INFO - operating with platform_type : linux_ 20:28:27 INFO - Initialising browser for kraken test... 20:28:27 INFO - TEST-INFO | started process 13834 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC_nVB4/profile http://localhost:52827/getInfo.html) 20:28:32 INFO - PROCESS | 13834 | 20:28:32 INFO - PROCESS | 13834 | (process:13903): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:28:33 INFO - PROCESS | 13834 | __metrics Screen width/height:1600/1200 20:28:33 INFO - PROCESS | 13834 | colorDepth:24 20:28:33 INFO - PROCESS | 13834 | Browser inner width/height: 1024/697 20:28:33 INFO - PROCESS | 13834 | __metrics 20:28:34 ERROR - PROCESS | 13834 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 20:28:35 INFO - TEST-INFO | 13834: exit 0 20:28:35 INFO - Browser initialized. 20:28:35 INFO - Running cycle 1/1 for kraken test... 20:28:35 INFO - TEST-INFO | started process 13954 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC_nVB4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:28:36 INFO - PROCESS | 13954 | 20:28:36 INFO - PROCESS | 13954 | (process:14016): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:28:46 INFO - PROCESS | 13954 | RSS: Main: 164573184 20:28:46 INFO - PROCESS | 13954 | 20:28:49 INFO - PROCESS | 13954 | Cycle 1(1): loaded http://localhost:52827/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52827/tests/kraken/driver.html?testName=audio-beat-detection) 20:28:50 INFO - PROCESS | 13954 | RSS: Main: 168906752 20:28:50 INFO - PROCESS | 13954 | 20:28:53 INFO - PROCESS | 13954 | Cycle 1(1): loaded http://localhost:52827/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52827/tests/kraken/driver.html?testName=audio-dft) 20:28:53 INFO - PROCESS | 13954 | RSS: Main: 169791488 20:28:53 INFO - PROCESS | 13954 | 20:28:56 INFO - PROCESS | 13954 | Cycle 1(1): loaded http://localhost:52827/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52827/tests/kraken/driver.html?testName=audio-fft) 20:28:57 INFO - PROCESS | 13954 | RSS: Main: 163856384 20:28:57 INFO - PROCESS | 13954 | 20:28:59 INFO - PROCESS | 13954 | Cycle 1(1): loaded http://localhost:52827/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52827/tests/kraken/driver.html?testName=audio-oscillator) 20:28:59 INFO - PROCESS | 13954 | RSS: Main: 164122624 20:28:59 INFO - PROCESS | 13954 | 20:29:02 INFO - PROCESS | 13954 | Cycle 1(1): loaded http://localhost:52827/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52827/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:29:02 INFO - PROCESS | 13954 | RSS: Main: 164540416 20:29:02 INFO - PROCESS | 13954 | 20:29:05 INFO - PROCESS | 13954 | Cycle 1(1): loaded http://localhost:52827/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52827/tests/kraken/driver.html?testName=imaging-darkroom) 20:29:06 INFO - PROCESS | 13954 | RSS: Main: 164753408 20:29:06 INFO - PROCESS | 13954 | 20:29:09 INFO - PROCESS | 13954 | Cycle 1(1): loaded http://localhost:52827/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52827/tests/kraken/driver.html?testName=imaging-desaturate) 20:29:10 INFO - PROCESS | 13954 | RSS: Main: 164368384 20:29:10 INFO - PROCESS | 13954 | 20:29:13 INFO - PROCESS | 13954 | Cycle 1(1): loaded http://localhost:52827/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52827/tests/kraken/driver.html?testName=json-parse-financial) 20:29:13 INFO - PROCESS | 13954 | RSS: Main: 164683776 20:29:13 INFO - PROCESS | 13954 | 20:29:15 INFO - PROCESS | 13954 | Cycle 1(1): loaded http://localhost:52827/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52827/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:29:15 INFO - PROCESS | 13954 | RSS: Main: 164921344 20:29:15 INFO - PROCESS | 13954 | 20:29:17 INFO - PROCESS | 13954 | Cycle 1(1): loaded http://localhost:52827/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52827/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:29:18 INFO - PROCESS | 13954 | RSS: Main: 165142528 20:29:18 INFO - PROCESS | 13954 | 20:29:20 INFO - PROCESS | 13954 | Cycle 1(1): loaded http://localhost:52827/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52827/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:29:21 INFO - PROCESS | 13954 | RSS: Main: 165613568 20:29:21 INFO - PROCESS | 13954 | 20:29:23 INFO - PROCESS | 13954 | Cycle 1(1): loaded http://localhost:52827/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52827/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:29:24 INFO - PROCESS | 13954 | RSS: Main: 165576704 20:29:24 INFO - PROCESS | 13954 | 20:29:27 INFO - PROCESS | 13954 | Cycle 1(1): loaded http://localhost:52827/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52827/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:29:27 INFO - PROCESS | 13954 | RSS: Main: 165277696 20:29:27 INFO - PROCESS | 13954 | 20:29:29 INFO - PROCESS | 13954 | Cycle 1(1): loaded http://localhost:52827/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52827/tests/kraken/driver.html?testName=ai-astar) 20:29:29 INFO - PROCESS | 13954 | RSS: Main: 166834176 20:29:29 INFO - PROCESS | 13954 | 20:29:29 INFO - PROCESS | 13954 | __start_tp_report 20:29:29 INFO - PROCESS | 13954 | _x_x_mozilla_page_load 20:29:29 INFO - PROCESS | 13954 | _x_x_mozilla_page_load_details 20:29:29 INFO - PROCESS | 13954 | |i|pagename|runs| 20:29:29 INFO - PROCESS | 13954 | |0;ai-astar;111;115;111;111;113;113;112;111;112;110 20:29:29 INFO - PROCESS | 13954 | |1;audio-beat-detection;157;130;165;174;126;162;159;126;190;134 20:29:29 INFO - PROCESS | 13954 | |2;audio-dft;163;164;162;162;165;166;167;162;161;162 20:29:29 INFO - PROCESS | 13954 | |3;audio-fft;74;75;75;147;76;75;75;74;182;76 20:29:29 INFO - PROCESS | 13954 | |4;audio-oscillator;84;83;147;85;84;84;147;83;84;143 20:29:29 INFO - PROCESS | 13954 | |5;imaging-gaussian-blur;117;118;118;117;118;117;117;117;117;117 20:29:29 INFO - PROCESS | 13954 | |6;imaging-darkroom;145;147;146;147;149;146;146;147;147;146 20:29:29 INFO - PROCESS | 13954 | |7;imaging-desaturate;95;95;96;95;96;95;95;96;96;95 20:29:29 INFO - PROCESS | 13954 | |8;json-parse-financial;60;55;56;55;61;57;65;81;55;52 20:29:29 INFO - PROCESS | 13954 | |9;json-stringify-tinderbox;61;62;61;62;62;61;62;62;63;63 20:29:29 INFO - PROCESS | 13954 | |10;stanford-crypto-aes;81;80;80;82;80;80;82;81;87;81 20:29:29 INFO - PROCESS | 13954 | |11;stanford-crypto-ccm;137;128;122;129;136;129;119;124;165;127 20:29:29 INFO - PROCESS | 13954 | |12;stanford-crypto-pbkdf2;165;163;162;165;164;165;158;161;158;159 20:29:29 INFO - PROCESS | 13954 | |13;stanford-crypto-sha256-iterative;68;62;65;63;64;67;63;61;63;66 20:29:29 INFO - PROCESS | 13954 | __end_tp_report 20:29:29 INFO - PROCESS | 13954 | __start_cc_report 20:29:29 INFO - PROCESS | 13954 | _x_x_mozilla_cycle_collect,836 20:29:29 INFO - PROCESS | 13954 | __end_cc_report 20:29:29 INFO - PROCESS | 13954 | __startTimestamp1464146969627__endTimestamp 20:29:29 INFO - PROCESS | 13954 | 20:29:29 INFO - PROCESS | 13954 | ------- Summary: start ------- 20:29:29 INFO - PROCESS | 13954 | Number of tests: 14 20:29:29 INFO - PROCESS | 13954 | 20:29:29 INFO - PROCESS | 13954 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.00 stddev:1.45 (1.3%) stddev-sans-first:1.50 20:29:29 INFO - PROCESS | 13954 | Values: 111.0 115.0 111.0 111.0 113.0 113.0 112.0 111.0 112.0 110.0 20:29:29 INFO - PROCESS | 13954 | 20:29:29 INFO - PROCESS | 13954 | [#1] audio-beat-detection Cycles:10 Average:152.30 Median:160.50 stddev:22.19 (13.8%) stddev-sans-first:23.47 20:29:29 INFO - PROCESS | 13954 | Values: 157.0 130.0 165.0 174.0 126.0 162.0 159.0 126.0 190.0 134.0 20:29:29 INFO - PROCESS | 13954 | 20:29:29 INFO - PROCESS | 13954 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.50 stddev:2.01 (1.2%) stddev-sans-first:2.13 20:29:29 INFO - PROCESS | 13954 | Values: 163.0 164.0 162.0 162.0 165.0 166.0 167.0 162.0 161.0 162.0 20:29:29 INFO - PROCESS | 13954 | 20:29:29 INFO - PROCESS | 13954 | [#3] audio-fft Cycles:10 Average:92.90 Median:75.00 stddev:38.63 (51.5%) stddev-sans-first:40.37 20:29:29 INFO - PROCESS | 13954 | Values: 74.0 75.0 75.0 147.0 76.0 75.0 75.0 74.0 182.0 76.0 20:29:29 INFO - PROCESS | 13954 | 20:29:29 INFO - PROCESS | 13954 | [#4] audio-oscillator Cycles:10 Average:102.40 Median:84.00 stddev:29.88 (35.6%) stddev-sans-first:30.94 20:29:29 INFO - PROCESS | 13954 | Values: 84.0 83.0 147.0 85.0 84.0 84.0 147.0 83.0 84.0 143.0 20:29:29 INFO - PROCESS | 13954 | 20:29:29 INFO - PROCESS | 13954 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 20:29:29 INFO - PROCESS | 13954 | Values: 117.0 118.0 118.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 20:29:29 INFO - PROCESS | 13954 | 20:29:29 INFO - PROCESS | 13954 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:1.07 (0.7%) stddev-sans-first:0.97 20:29:29 INFO - PROCESS | 13954 | Values: 145.0 147.0 146.0 147.0 149.0 146.0 146.0 147.0 147.0 146.0 20:29:29 INFO - PROCESS | 13954 | 20:29:29 INFO - PROCESS | 13954 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 20:29:29 INFO - PROCESS | 13954 | Values: 95.0 95.0 96.0 95.0 96.0 95.0 95.0 96.0 96.0 95.0 20:29:29 INFO - PROCESS | 13954 | 20:29:29 INFO - PROCESS | 13954 | [#8] json-parse-financial Cycles:10 Average:59.70 Median:58.50 stddev:8.37 (14.3%) stddev-sans-first:8.87 20:29:29 INFO - PROCESS | 13954 | Values: 60.0 55.0 56.0 55.0 61.0 57.0 65.0 81.0 55.0 52.0 20:29:29 INFO - PROCESS | 13954 | 20:29:29 INFO - PROCESS | 13954 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 20:29:29 INFO - PROCESS | 13954 | Values: 61.0 62.0 61.0 62.0 62.0 61.0 62.0 62.0 63.0 63.0 20:29:29 INFO - PROCESS | 13954 | 20:29:29 INFO - PROCESS | 13954 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:81.00 stddev:2.12 (2.6%) stddev-sans-first:2.24 20:29:29 INFO - PROCESS | 13954 | Values: 81.0 80.0 80.0 82.0 80.0 80.0 82.0 81.0 87.0 81.0 20:29:29 INFO - PROCESS | 13954 | 20:29:29 INFO - PROCESS | 13954 | [#11] stanford-crypto-ccm Cycles:10 Average:131.60 Median:129.00 stddev:13.00 (10.1%) stddev-sans-first:13.64 20:29:29 INFO - PROCESS | 13954 | Values: 137.0 128.0 122.0 129.0 136.0 129.0 119.0 124.0 165.0 127.0 20:29:29 INFO - PROCESS | 13954 | 20:29:29 INFO - PROCESS | 13954 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.00 Median:163.50 stddev:2.87 (1.8%) stddev-sans-first:2.83 20:29:29 INFO - PROCESS | 13954 | Values: 165.0 163.0 162.0 165.0 164.0 165.0 158.0 161.0 158.0 159.0 20:29:29 INFO - PROCESS | 13954 | 20:29:29 INFO - PROCESS | 13954 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.50 stddev:2.25 (3.5%) stddev-sans-first:1.92 20:29:29 INFO - PROCESS | 13954 | Values: 68.0 62.0 65.0 63.0 64.0 67.0 63.0 61.0 63.0 66.0 20:29:29 INFO - PROCESS | 13954 | -------- Summary: end -------- 20:29:29 INFO - PROCESS | 13954 | 20:29:30 INFO - TEST-INFO | 13954: exit 0 20:29:30 INFO - TEST-OK | kraken | took 62741ms 20:29:30 INFO - SUITE-END | took 1174s 20:29:30 INFO - Completed test suite (00:19:34) 20:29:30 INFO - javascript benchmark 20:29:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6999.122258497782, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3094.566760653509, 3122.437961166989, 3154.8580313885873, 3161.8102913825173, 3178.3643271345722, 5334.5198932096155, 5359.892802143955, 5393.622446428752, 5423.430539793324, 5426.647267927582, 5315.521603055724, 5350.732463376826, 5425.457454254582, 5427.240186373911, 5431.131019036955, 4874.390701162355, 4875.561199492045, 4941.160002799533, 5043.193089105744, 5049.192129259319, 4847.03059388122, 5018.7992480300745, 5037.168867136918, 5039.269305950635, 5041.294218809369, 4811.446683631392, 4821.325014497973, 4877.0, 4886.144924638174, 4901.338319326898, 4842.176829938919, 4845.3216549683075, 4866.416030076378, 4877.439094504142, 4931.728754918514, 4863.100326439585, 4865.440474345425, 4872.1473742094995, 4872.951270487285, 4900.852974410738, 5166.61250406221, 5244.082285600005, 5256.237845512417, 5307.734613269321, 5347.037533244014, 5734.856628584277, 5788.102844059177, 5798.797042103548, 5800.53595712342, 5809.302883653946, 5731.254936858223, 5822.679752613604, 5834.795782147605, 5853.560982926298, 5858.648481091105, 5262.631615786897, 5270.9736451317885, 5319.2287118368, 5333.679979201261, 5340.519353258225, 5804.88390232193, 5806.390329015477, 5812.912806307909, 5823.737931793079, 5828.358880523139, 5529.198266251371, 5582.91625625616, 5607.018771714934, 5608.46719561641, 5649.943500564942, 5713.942860571424, 5766.538676905838, 5794.0, 5796.884062318814, 5843.678597677083, 5567.66594004361, 5701.657900525899, 5728.856778580569, 5736.13957906309, 5766.596338256366, 5589.161625756169, 5750.396208398141, 5766.625169363978, 5811.0411782056335, 5819.185314056035, 4299.333603291495, 4337.240982827992, 4397.934030989538, 4402.16358891816, 4407.933880991788, 3814.4469051987307, 3841.2317536492815, 3868.7872167031082, 3887.222555488857, 3908.0, 5417.6478528895495, 5425.565954723613, 5466.1527463243265, 5472.890542189134, 5482.698451585201, 5709.3434255060365, 5712.6286791358425, 5726.341470730836, 5757.107648314518, 5834.5624078194305, 5581.079121944915, 5645.266115404971, 5659.717014149276, 5686.2607860977805, 5710.971445142748, 5043.773030213649, 5055.620828437882, 5057.165567681365, 5067.87330316745, 5136.306598609214, 5902.3507414184405, 6031.185789918392, 6119.724612392453, 6126.908096378558, 6135.0, 5861.677607731615, 5909.202257695156, 5920.733566989582, 5934.169216309807, 5981.700914954322, 6011.308699499614, 6076.817695469143, 6088.573799833969, 6093.664848433202, 6099.085137229451, 5553.222548843084, 5574.136008918624, 5592.049351610155, 5701.173329867229, 5809.94190058111, 5717.171010203414, 5722.570807189394, 5726.599138060295, 5727.599068065362, 5766.221560089334, 5544.944550554443, 5559.63862348946, 5561.221429000024, 5562.110062389998, 5574.832755017356, 5505.697186654773, 5558.777648894161, 5631.070873305859, 5651.943480565306, 5676.375598684059, 5626.2967129108865, 5628.662280263197, 5647.0, 5651.180578816131, 5660.150977353265, 5681.4034526374135, 5719.5710321726865, 5752.424757524214, 5783.277090363705, 5803.564732644984, 5452.672839629635, 5528.44715528444, 5550.861228469321, 5575.8606034847835, 5645.209670646031], "value": 5321.363993279766, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.1233256950582, 618.718483090194, 631.7094136697119, 642.2517766801676, 658.2331583704984, 36595.63404365956, 41020.17959640809, 41050.7947460263, 41386.37920431196, 41487.0, 42219.577804221946, 42953.0, 43067.13865722684, 43124.137517249634, 43142.0, 8564.272036876857, 8688.435251708619, 8695.913040869606, 8700.434471759316, 8702.042775294713, 8641.222289993899, 8732.388732788708, 8737.169968852948, 8746.125387461267, 8787.516686582236, 8792.296616270683, 8792.34057445691, 8835.204831565157, 8860.645574177026, 8867.77830554238, 8794.296456283482, 8811.206991370775, 8825.117488251188, 8848.20366167048, 8857.468551886876, 8652.653893844301, 8765.956170219171, 8779.561021948877, 8797.252233560155, 8819.867701984474, 39817.40273895894, 40044.19911601781, 40141.0, 40353.79823100866, 40466.39300410496, 3427.280271143063, 3617.0776452004834, 3642.0348607619003, 3656.524651795276, 4009.0459504460905, 31356.216094597818, 31681.207969800707, 32309.192270193198, 32336.838315808505, 33497.497537536954, 4166.729162604452, 4249.660027197817, 4267.573242675739, 4282.336237883133, 4327.8052487637815, 340276.0, 341809.0, 343763.0, 344699.0, 345390.0, 35618.64381356205, 56348.0, 57241.427585723606, 57442.425575743706, 57510.42489575134, 36667.0, 36751.4487282691, 36780.0, 36844.078898027765, 36888.0, 14095.295235238196, 14253.144811311355, 14257.78613320801, 14262.072965257224, 14281.0, 11667.299962002307, 12008.219465734699, 12030.15788894769, 12031.87968120325, 12033.518659253532, 8294.668213271521, 8402.747917562483, 8420.0, 8423.663053477914, 8483.533405662747, 3284.2282063715484, 3309.5532103165765, 3314.2211580278617, 3314.320564284316, 3336.4161271777343, 1030.057497389895, 1048.4600430778155, 1100.9229353945307, 1183.5975768238668, 1198.2750435986277, 31392.372152557276, 31650.841745791586, 31866.68133318637, 31984.360312793615, 32327.0, 1118.5134466507095, 1226.760781647588, 1258.2702032820941, 1267.518343029643, 1279.8464184297943, 16420.59525529809, 16787.32850685959, 16878.915605421895, 16986.32054717822, 17180.742288865677, 512572.0, 514163.0, 514648.0, 515939.0, 521166.0, 57172.71413642905, 57990.710046449494, 58021.0, 58220.417795822344, 58229.4177058224, 1368.857004401336, 1369.1716511510392, 1388.916665000083, 1401.0822910993315, 1409.5700811252461, 30547.319897405858, 31067.68932310648, 31322.530162047133, 32158.839205803823, 32263.35473290474, 50428.49571504238, 50432.74783626058, 50564.0, 50657.49342506528, 50689.74655126701, 409132.0, 410756.0, 412890.0, 412946.0, 413697.0, 27602.447951040464, 27701.0, 27952.30119247035, 28009.299767505974, 28204.71795282103, 46966.0, 47155.0, 47231.05537889154, 47347.0, 48441.0, 39889.00277493086, 40220.59779402168, 40447.59552404438, 40544.79727601343, 40795.59204408037, 38816.80591597024, 39583.40624890687, 39791.2041759169, 39998.40002400024, 40062.39906401348, 40838.387424189255, 40901.590984090966, 41386.0, 41708.3743743838, 44343.77828110839, 34824.65175348315, 36609.26781464409, 42631.573684264, 46609.766951165024, 46836.7658161707, 32216.83891580527, 34748.131296716776, 34786.82606586951, 35067.123321917155, 35137.110608357994], "value": 18904.12641875957, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.5355805243446, 381.46404301955744, 381.5040447418356, 388.0686352753393, 391.3581725969411, 17539.0, 19413.12640931158, 19803.504912377197, 20467.283645072424, 20514.384568462934, 18515.0, 18913.054347282614, 18959.62080758384, 19157.616847663037, 19420.0, 5453.809116680917, 5517.834464966048, 5668.093105103184, 5682.147677848335, 5710.0, 5557.638753481011, 5567.220589117527, 5573.442655734435, 5573.916391254134, 5623.26897503324, 5362.624616276862, 5577.8047768328115, 5585.050541407971, 5596.076647353202, 5616.185653080301, 5563.276774019392, 5568.888622227532, 5571.4428557144365, 5601.879624075181, 5604.355499117592, 4872.65891387603, 4938.530839570271, 4946.505349465061, 4969.031038947407, 4978.925316120261, 22177.334679959626, 22186.446948713598, 22548.098076076938, 22568.66147007796, 22697.886510567507, 2317.7566355532763, 2424.6484259782233, 2463.3964678653665, 2548.719640839506, 2657.6146458763565, 14016.43934242629, 14117.78823317651, 14299.85700143006, 14371.0, 14863.851361486355, 1923.2114832918576, 2020.7170996060563, 2048.94877628059, 2050.282401159582, 2053.486628342914, 54674.72662636662, 68893.65553172253, 69726.65136674284, 70238.29761702368, 78692.0, 9901.554430050664, 10048.598056077675, 10265.0, 10314.535845886952, 10565.101966332948, 14450.060746051473, 14502.709945801025, 14544.85455145435, 14608.853911460961, 14632.0, 7575.128860181039, 7893.644785984645, 7921.801954951173, 7962.163972782891, 7972.920270797218, 7639.69441222356, 7682.385409167253, 7725.111612164561, 7778.494397864234, 7802.102758182768, 6405.29541750407, 6427.935720642828, 6480.805575832733, 6500.804975850732, 6580.80257592273, 1836.6969450040594, 1878.389523404899, 1892.0823400650672, 1905.2664724081328, 1911.6559019376646, 431.9503257125408, 464.0487001646611, 960.3181740963994, 1048.0724558765396, 1097.545751878764, 11157.609483668195, 11346.829797553044, 11576.76846463066, 11841.5855445059, 12041.0, 434.55675211284944, 440.874350810024, 441.2939297124575, 454.5318322128213, 467.8970626462173, 6269.310375858652, 6401.071844582602, 6409.230892292955, 6413.0, 6421.357864213542, 453621.0, 456457.0, 493859.0, 503634.0, 506377.0, 58171.418285817446, 75330.0, 96195.0, 97657.5117124424, 97877.5106124479, 436.5329097865317, 451.821530495459, 460.0752487500149, 460.24519787548445, 464.20620738536803, 11067.557297708323, 11380.317180969168, 11407.315561066363, 11429.828552571551, 11488.908553687386, 37603.81198093992, 38490.42264365981, 38865.0, 39004.609953901236, 44350.0, 54196.729016354664, 55416.72291638516, 62683.37316626775, 63614.0, 64451.0, 8272.875906861522, 8443.95778021106, 8449.619767110618, 8473.57632118404, 8579.184977427134, 12359.32023738703, 12512.74974500523, 12671.80992285135, 13673.521426750016, 13925.51260705911, 10787.730306742395, 11272.436378181223, 11379.317240965569, 11490.54037838477, 12144.453499592362, 8028.31759300466, 8400.495970241805, 11298.943505282421, 12066.155369124428, 12133.939330303645, 12070.637880863587, 12090.335031572997, 12151.210171338835, 12269.263844169378, 12448.751024979269, 8491.320694344562, 8548.358873084419, 8555.871661924952, 8755.649774008969, 8781.429207101773, 8792.560371981248, 11434.48544815502, 11463.942680286546, 11504.827427588425, 11796.29222246668], "value": 8375.004289144636, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1443.6102252391854, 1526.1834918318702, 1704.1394095981527, 1819.654265689518, 1844.2530775036114, 7779.144294127642, 8182.509049457022, 8365.0, 8992.100789921005, 9009.639614415424, 8268.503889766618, 8350.248477637011, 8492.278156356717, 8611.526366049864, 8634.136586341363, 2254.5603607296584, 2325.2907863101746, 2335.696359473266, 2335.7313908900437, 2342.754010828864, 2287.7369102553253, 2293.4495721026915, 2311.6763653088583, 2317.397476656073, 2323.233333000106, 2302.0906741836966, 2302.9078836846506, 2316.9536609267802, 2328.9534209315802, 2346.2374728213313, 2236.586231547169, 2259.344790010895, 2268.217464974581, 2270.2167752125574, 2274.215395688493, 2231.542533780571, 2232.36377632374, 2236.798688118061, 2237.8209743220505, 2238.675392068141, 8569.914300856974, 8571.785705357353, 8649.048604653482, 8684.392092553524, 8720.21518063371, 5044.848654540333, 5151.742412879378, 5191.5846732261325, 5196.92204616931, 5197.246399272122, 3085.4754691702465, 3196.824174670392, 3231.3052693670975, 3283.917902052468, 3300.488424294238, 1014.7260239735231, 1020.739711373595, 1037.7768779712324, 1054.6730513540826, 1057.6351158850184, 11811.0, 11911.404429778562, 11914.046876249879, 11964.760704785942, 11973.580924667594, 4693.460252070987, 4734.644901632322, 4760.238361862085, 4819.108464933928, 4820.108279968217, 10151.593936242616, 10210.183185345155, 10237.385756854464, 10253.897461025443, 10274.126699230648, 5238.842834714965, 5300.761465734051, 5314.813981510629, 5326.813561525406, 5347.545458636059, 4334.089841133397, 4612.446506419251, 4788.066327066189, 4814.20565606678, 4825.95174048262, 4042.3936409538214, 4087.550369459357, 4106.609872062149, 4117.094239267416, 4166.312558427886, 1288.9162204456868, 1300.1678925487695, 1317.3215793866166, 1328.6014195741238, 1343.1605246720799, 946.8485042393185, 1019.0828254570946, 1037.9117774989058, 1038.159091136167, 1055.150603763962, 5995.550333724988, 6040.365761595057, 6061.4544690977145, 6142.78500252489, 6380.844491244095, 940.501534186882, 963.6241865672393, 964.5659453246068, 1007.315025782475, 1026.856240126383, 4113.136241389282, 4304.526502084768, 4307.978460107679, 4348.391225228471, 4393.0994146199955, 10416.531256093342, 10768.623098191681, 10845.674629761119, 10877.0754485868, 10908.563657453771, 10698.0, 10737.731556710989, 10739.892601073889, 10753.677389678322, 10766.0, 7747.690092396354, 8115.0, 8119.878201826978, 8299.95850020746, 8314.750557483165, 5836.445537673914, 5955.940440595712, 5991.580589358703, 6107.083937409247, 6113.602615829956, 9695.418274903528, 9857.162141218078, 9937.701868943943, 9981.60073597048, 10013.899861001297, 9900.25748068912, 10102.595896164072, 10197.745056373353, 10245.129164021142, 10287.177025838064, 7067.081279433641, 7542.509736867086, 7685.193054729173, 7770.611469426619, 7866.292033716993, 8352.290055345364, 8424.62089205975, 8459.534725590152, 8490.15098490146, 8530.402871798915, 7473.103227612722, 7709.267619576131, 7733.072031356048, 7764.145943946274, 7783.377329813715, 7451.3293803557945, 7622.733204337822, 7667.923320766944, 7679.347255483123, 7727.0, 6982.441404687715, 7008.789736307919, 7014.579125252501, 7081.787546373617, 7136.286371362822, 5245.790168393374, 5315.495027972336, 5351.170568561879, 5401.135818269058, 5443.156310771837, 5317.627766056339, 5320.308359913187, 5328.7602057906715, 5388.973055134699, 5431.728413579384], "value": 4639.371645965005, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.62414287355233, 333.23190046941806, 338.29803158446225, 338.9322135572886, 342.66932410224126, 5314.92027619586, 5393.0, 5503.862403439911, 5551.611387202897, 5627.324721033477, 5454.509094181523, 5475.5072043516075, 5479.2602998595175, 5501.83644404468, 5521.558275337973, 4105.651019663324, 4176.728512646683, 4177.644900183473, 4202.684798640099, 4299.720518166325, 4219.683523735716, 4268.67357290276, 4312.0, 4318.481782186126, 4324.459442569679, 4209.9789501052455, 4234.386014027964, 4236.4916210054835, 4274.187904298189, 4277.935830962538, 4268.445102136733, 4270.210011147932, 4295.871123866289, 4297.677674174418, 4304.956950430487, 3655.177585043344, 3818.4081467372603, 3821.178446633987, 3823.9808800956093, 3825.713071519647, 5320.388155362144, 5321.707306098163, 5328.602129041908, 5352.812651557216, 5366.7853285868905, 4856.538628830255, 4856.781444834991, 4857.854264372075, 4863.562279394836, 4885.8045678173185, 5521.834344969658, 5760.6255593386295, 5828.708564571797, 5833.649981001111, 5842.444967728102, 4131.462909821704, 4141.349536296772, 4143.8964025899295, 4151.335786274211, 4184.330507118877, 6017.021574320695, 6077.508221629111, 6083.6349819011, 6088.543359248074, 6118.388161183846, 4013.478247827764, 4189.282394218356, 4272.16692744918, 4280.272353699878, 4295.226859165317, 4193.853215137517, 4237.364395340662, 4253.893652658709, 4269.615734583902, 4271.530131685512, 4903.828366007173, 4910.337104490919, 4920.852374428701, 4923.458419573844, 4945.159322915113, 5644.435556444405, 5840.153177789197, 5900.734466948998, 5938.554608404387, 5950.7917222896995, 1437.4106616287272, 1459.547540262522, 1467.9192644404447, 1468.0531057467874, 1480.1193289992436, 915.56053094515, 927.9072092790667, 935.0275713258271, 947.824652439301, 950.7290422229631, 5018.5232402921665, 5025.547700706954, 5041.949580504222, 5102.923456148161, 5109.20807274873, 5256.658317209369, 5288.867778305573, 5353.250544923714, 5368.248445217672, 5388.703621300866, 5072.86939485417, 5077.400618805138, 5137.768800403991, 5265.815696450606, 5676.716164191774, 3147.937041259162, 3199.9040028799172, 3226.5644138041534, 3232.383808095952, 3236.947991902594, 6146.200993870858, 6244.562880598314, 6280.654563998933, 6301.842453938597, 6343.619382836952, 6164.0, 6164.291106522807, 6177.62934223948, 6201.844953876189, 6228.0, 6241.751649670085, 6263.154474145932, 6265.780697675559, 6266.279377871512, 6290.622562646165, 5756.827295181151, 6012.278526576664, 6032.3967603239325, 6055.666938318434, 6103.542234332354, 5996.850078748066, 6014.278286605635, 6020.290869109006, 6027.78902738402, 6056.788012419544, 6020.247469066367, 6240.937590624036, 6271.905921411274, 6281.497480201664, 6293.339199383999, 4123.8556650518285, 4129.91740165201, 4147.585241475828, 4180.268453020648, 4199.02645756494, 6011.639301641915, 6022.09668549721, 6070.666113363631, 6070.939290607037, 6085.543584231112, 5521.834344969658, 5834.299884013945, 5839.211706419579, 5841.357450680337, 5850.765969361178, 5784.334801497882, 5814.098814683731, 5835.708214589338, 5837.503812176013, 5855.414458554111, 5567.3040869891265, 5722.4277572242445, 5747.626404283708, 5752.676884316715, 5767.163761254678, 5838.883222335615, 5886.6173698709445, 5889.116632505158, 5901.380355062828, 5917.615355001911, 5694.829155125353, 5698.658080515016, 5734.569907256889, 5785.8553536161935, 5840.707964601838], "value": 4390.365854773707, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [758.8444368904375, 839.8194388206531, 842.4271495383141, 849.6304107713145, 864.5461132905228, 13497.39261733222, 14783.556493305217, 14898.77651835222, 14912.403503859832, 14922.253887305646, 13565.050446468751, 13607.11553749008, 13635.0, 13658.521951731691, 13661.863381366184, 684.2507454337505, 802.3741481644327, 825.6697321071589, 826.4834478450969, 827.668932427028, 810.6635746165334, 815.8735396013627, 817.0195765081926, 820.409305300183, 820.7168526858225, 855.9358048146382, 857.0743596915316, 857.2927334948661, 857.5026484638895, 858.841114393836, 851.1956201389689, 851.6721062391024, 851.7785375802335, 852.1138016462871, 852.8891244138284, 616.8797084568511, 617.1637431280595, 618.1006635345607, 618.4526693875907, 618.9535784816112, 13583.932080339535, 13588.320583970763, 13638.863611363859, 13657.317134143253, 13658.658533536642, 13860.930695346458, 14201.928990354982, 14280.857191428056, 14569.781453278209, 14837.10977341363, 11776.0, 11791.941040294743, 11828.526858925632, 12025.759484810254, 12066.336351500664, 3846.615338466159, 3874.380099184117, 3906.1797022625283, 3917.4319723639915, 3922.5489068757174, 56507.0, 57052.144217836765, 57061.0, 57174.42825571733, 57237.42762572363, 11108.949319285122, 11298.830517542243, 11480.507534020524, 11552.152729442212, 11663.391457923999, 18678.626427471376, 18703.812961870208, 18704.438866834018, 18711.251549938122, 18749.81250187508, 8027.15714849944, 8178.1821817817745, 8210.466319689202, 8220.136885626924, 8342.916570834335, 4719.082090704793, 4828.227483602677, 4891.315215869781, 4912.361393018885, 4945.505449455026, 3359.160209947513, 3455.7926524408617, 3471.340445315382, 3478.9910925831227, 3480.3387356402204, 602.2261394108549, 608.330836080317, 615.6306216270202, 632.1686981619156, 634.194572892424, 693.407136897945, 706.2266817834463, 722.8771108911498, 755.1806290175222, 756.0851369842442, 9207.355485116112, 9657.22742180624, 9695.224382049419, 9761.07269809367, 9769.413835169771, 699.3950233048377, 733.1641928201855, 767.3951144161334, 795.9681612735542, 797.4178849439826, 4480.932786008212, 4643.349931009661, 4679.0, 4685.367475390847, 4717.905641887143, 64027.0, 64786.0, 65113.0, 65239.34760652428, 65719.34280657132, 58832.7058364714, 59513.0, 59522.0, 59913.40086599165, 60802.695986519786, 51734.48265517372, 52699.736501317246, 53771.19343209855, 53923.73038134784, 54255.72872135693, 8746.256568191775, 8780.385373023826, 8827.646894124164, 9073.0, 9148.63405463774, 35989.640103599675, 36125.45811812877, 36162.638373615926, 36291.81854090712, 36773.81613091917, 43811.342829858215, 45479.31781023221, 46989.0, 47584.52415475939, 47960.7601961988, 11764.0, 11992.64022079339, 12208.0, 12234.388280586114, 12444.191127576678, 12948.8057679133, 13173.143745656502, 13630.386632601754, 13915.095518791246, 14019.439222430989, 12536.435860386488, 12542.122051456676, 12556.183848049848, 12713.11008229415, 12856.485740570646, 12497.25016499013, 12613.180143290656, 12637.93681031589, 12780.744385112059, 13264.668383290495, 11406.429678516208, 11542.672592651952, 11704.473298701409, 11706.414679266172, 11723.179377443837, 10293.330933489298, 10555.15558755313, 10734.463276836283, 10793.40636265013, 10883.727906802076, 10296.485175741333, 10520.842187367043, 10651.573937042742, 10829.566817327219, 10885.020348168702], "value": 6850.1001527003145, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1543.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 115.0, 111.0, 111.0, 113.0, 113.0, 112.0, 111.0, 112.0, 110.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 130.0, 165.0, 174.0, 126.0, 162.0, 159.0, 126.0, 190.0, 134.0], "value": 152.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 162.0, 162.0, 165.0, 166.0, 167.0, 162.0, 161.0, 162.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 147.0, 76.0, 75.0, 75.0, 74.0, 182.0, 76.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 147.0, 85.0, 84.0, 84.0, 147.0, 83.0, 84.0, 143.0], "value": 102.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 146.0, 147.0, 149.0, 146.0, 146.0, 147.0, 147.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 55.0, 56.0, 55.0, 61.0, 57.0, 65.0, 81.0, 55.0, 52.0], "value": 59.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 62.0, 62.0, 61.0, 62.0, 62.0, 63.0, 63.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 80.0, 82.0, 80.0, 80.0, 82.0, 81.0, 87.0, 81.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 128.0, 122.0, 129.0, 136.0, 129.0, 119.0, 124.0, 165.0, 127.0], "value": 131.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 162.0, 165.0, 164.0, 165.0, 158.0, 161.0, 158.0, 159.0], "value": 162.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 62.0, 65.0, 63.0, 64.0, 67.0, 63.0, 61.0, 63.0, 66.0], "value": 64.2, "unit": "score"}]}]} 20:29:30 INFO - Return code: 0 20:29:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:29:30 ERROR - # TBPL SUCCESS # 20:29:30 INFO - Running post-action listener: _resource_record_post_action 20:29:30 INFO - ##### 20:29:30 INFO - ##### Finished run-tests step (success) 20:29:30 INFO - ##### 20:29:30 INFO - Running post-run listener: _resource_record_post_run 20:29:31 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 8192; Write bytes: 539860992; Read time: 28; Write time: 1495552 20:29:31 INFO - TinderboxPrint: CPU usage
13.5% 20:29:31 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 28 20:29:31 INFO - TinderboxPrint: I/O write bytes / time
539,860,992 / 1,495,552 20:29:31 INFO - TinderboxPrint: CPU idle
8,229.7 (86.5%) 20:29:31 INFO - TinderboxPrint: CPU user
1,213.3 (12.8%) 20:29:31 INFO - TinderboxPrint: Swap in / out
0 / 0 20:29:31 INFO - install - Wall time: 17s; CPU: 20.0%; Read bytes: 0; Write bytes: 221106176; Read time: 0; Write time: 1011228 20:29:31 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 8192; Write bytes: 291913728; Read time: 28; Write time: 472372 20:29:31 INFO - Running post-run listener: _upload_blobber_files 20:29:31 INFO - Blob upload gear active. 20:29:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:29:31 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:29:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:29:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:29:31 INFO - (blobuploader) - INFO - Open directory for files ... 20:29:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:29:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:29:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:29:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:29:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:29:35 INFO - (blobuploader) - INFO - Done attempting. 20:29:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:29:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:29:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:29:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:29:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:29:36 INFO - (blobuploader) - INFO - Done attempting. 20:29:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:29:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:29:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:29:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:29:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:29:39 INFO - (blobuploader) - INFO - Done attempting. 20:29:39 INFO - (blobuploader) - INFO - Iteration through files over. 20:29:39 INFO - Return code: 0 20:29:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:29:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:29:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2a795fc7ed154550109caba6492592b6f60e987ab237726bec25f6fa527345d2d354ff0d938b2356263fecf07e870561b3cba61de0b80bbbd919d7be00e9596e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b725b3487d147f3986520e1c595a98302db4cb6320daa32f3623c6898c4b0c0204b51b622e1af0fc30a753ca28c50ba4eeddb52dc70a4c05518d5166bbb06002", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1bf6b0a7cc37135ea6c64db02ad23e497ea4c6567bd29fed753034b2e89bbdbd5651958c67195649bd542e0928c2afed8c0f6ecc822c9efb669fcfae8ef905b2"} 20:29:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:29:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:29:39 INFO - Contents: 20:29:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2a795fc7ed154550109caba6492592b6f60e987ab237726bec25f6fa527345d2d354ff0d938b2356263fecf07e870561b3cba61de0b80bbbd919d7be00e9596e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b725b3487d147f3986520e1c595a98302db4cb6320daa32f3623c6898c4b0c0204b51b622e1af0fc30a753ca28c50ba4eeddb52dc70a4c05518d5166bbb06002", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1bf6b0a7cc37135ea6c64db02ad23e497ea4c6567bd29fed753034b2e89bbdbd5651958c67195649bd542e0928c2afed8c0f6ecc822c9efb669fcfae8ef905b2"} 20:29:39 INFO - Running post-run listener: copy_logs_to_upload_dir 20:29:39 INFO - Copying logs to upload dir... 20:29:39 INFO - mkdir: /builds/slave/test/build/upload/logs 20:29:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.828752 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-24 20:29:38.782942) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 20:29:38.786921) ========= 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=df17445c3590ff7897617a0e00000225-1464145740.770290-1072037691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2a795fc7ed154550109caba6492592b6f60e987ab237726bec25f6fa527345d2d354ff0d938b2356263fecf07e870561b3cba61de0b80bbbd919d7be00e9596e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b725b3487d147f3986520e1c595a98302db4cb6320daa32f3623c6898c4b0c0204b51b622e1af0fc30a753ca28c50ba4eeddb52dc70a4c05518d5166bbb06002", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1bf6b0a7cc37135ea6c64db02ad23e497ea4c6567bd29fed753034b2e89bbdbd5651958c67195649bd542e0928c2afed8c0f6ecc822c9efb669fcfae8ef905b2"} build_url:https://queue.taskcluster.net/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011331 build_url: 'https://queue.taskcluster.net/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2a795fc7ed154550109caba6492592b6f60e987ab237726bec25f6fa527345d2d354ff0d938b2356263fecf07e870561b3cba61de0b80bbbd919d7be00e9596e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b725b3487d147f3986520e1c595a98302db4cb6320daa32f3623c6898c4b0c0204b51b622e1af0fc30a753ca28c50ba4eeddb52dc70a4c05518d5166bbb06002", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1bf6b0a7cc37135ea6c64db02ad23e497ea4c6567bd29fed753034b2e89bbdbd5651958c67195649bd542e0928c2afed8c0f6ecc822c9efb669fcfae8ef905b2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 20:29:38.812304) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 20:29:38.812700) ========= 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=df17445c3590ff7897617a0e00000225-1464145740.770290-1072037691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 20:29:38.895503) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 20:29:38.895861) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 20:29:38.896152) ========= ========= Total master_lag: 0.17 =========