builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-064 starttime: 1464650020.19 results: success (0) buildid: 20160530133025 builduid: 575844494e154ced97d49ebb9ab0e03b revision: 09d0d424f914d064e30071fd85fc890e482fc79c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 16:13:40.192822) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 16:13:40.193278) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 16:13:40.193587) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 16:13:40.226699) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:13:40.227028) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1464650019.146245-389341864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 16:13:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.7M=0s 2016-05-30 16:13:40 (38.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.179570 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:13:40.420746) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:13:40.421066) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1464650019.146245-389341864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.045698 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:13:40.476742) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:13:40.477200) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 09d0d424f914d064e30071fd85fc890e482fc79c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 09d0d424f914d064e30071fd85fc890e482fc79c --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=a12cd81e0ef515edd9e0d800000001bb-1464650019.146245-389341864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 16:13:40,529 truncating revision to first 12 chars 2016-05-30 16:13:40,529 Setting DEBUG logging. 2016-05-30 16:13:40,529 attempt 1/10 2016-05-30 16:13:40,529 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/09d0d424f914?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 16:13:41,158 unpacking tar archive at: mozilla-inbound-09d0d424f914/testing/mozharness/ program finished with exit code 0 elapsedTime=0.970975 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:13:41.460101) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 16:13:41.460428) ========= script_repo_revision: 09d0d424f914d064e30071fd85fc890e482fc79c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 16:13:41.460884) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 16:13:41.461159) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 16:13:41.471724) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-05-30 16:13:41.472100) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=a12cd81e0ef515edd9e0d800000001bb-1464650019.146245-389341864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:13:41 INFO - MultiFileLogger online at 20160530 16:13:41 in /builds/slave/test 16:13:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 16:13:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:13:41 INFO - {'append_to_log': False, 16:13:41 INFO - 'base_work_dir': '/builds/slave/test', 16:13:41 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 16:13:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:13:41 INFO - 'branch': 'Mozilla-Inbound', 16:13:41 INFO - 'buildbot_json_path': 'buildprops.json', 16:13:41 INFO - 'config_files': ('talos/linux_config.py',), 16:13:41 INFO - 'default_actions': ('clobber', 16:13:41 INFO - 'read-buildbot-config', 16:13:41 INFO - 'download-and-extract', 16:13:41 INFO - 'populate-webroot', 16:13:41 INFO - 'create-virtualenv', 16:13:41 INFO - 'install', 16:13:41 INFO - 'run-tests'), 16:13:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:13:41 INFO - 'download_minidump_stackwalk': True, 16:13:41 INFO - 'download_symbols': 'ondemand', 16:13:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:13:41 INFO - 'tooltool.py': '/tools/tooltool.py', 16:13:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:13:41 INFO - '/tools/misc-python/virtualenv.py')}, 16:13:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:13:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:13:41 INFO - 'installer_path': 'installer.exe', 16:13:41 INFO - 'log_level': 'info', 16:13:41 INFO - 'log_name': 'talos', 16:13:41 INFO - 'log_to_console': True, 16:13:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:13:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:13:41 INFO - 'opt_config_files': (), 16:13:41 INFO - 'pip_index': False, 16:13:41 INFO - 'sps_profile': False, 16:13:41 INFO - 'sps_profile_interval': 0, 16:13:41 INFO - 'suite': 'dromaeojs-e10s', 16:13:41 INFO - 'system_bits': '32', 16:13:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:13:41 INFO - 'title': 'talos-linux64-ix-064', 16:13:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:13:41 INFO - 'use_talos_json': True, 16:13:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:13:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:13:41 INFO - 'work_dir': 'build'} 16:13:41 INFO - ##### 16:13:41 INFO - ##### Running clobber step. 16:13:41 INFO - ##### 16:13:41 INFO - Running pre-action listener: _resource_record_pre_action 16:13:41 INFO - Running main action method: clobber 16:13:41 INFO - rmtree: /builds/slave/test/build 16:13:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:13:44 INFO - Running post-action listener: _resource_record_post_action 16:13:44 INFO - ##### 16:13:44 INFO - ##### Finished clobber step (success) 16:13:44 INFO - ##### 16:13:44 INFO - ##### 16:13:44 INFO - ##### Running read-buildbot-config step. 16:13:44 INFO - ##### 16:13:44 INFO - Running pre-action listener: _resource_record_pre_action 16:13:44 INFO - Running main action method: read_buildbot_config 16:13:44 INFO - Using buildbot properties: 16:13:44 INFO - { 16:13:44 INFO - "project": "", 16:13:44 INFO - "product": "firefox", 16:13:44 INFO - "script_repo_revision": "production", 16:13:44 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 16:13:44 INFO - "repository": "", 16:13:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 16:13:44 INFO - "buildid": "20160530133025", 16:13:44 INFO - "pgo_build": "True", 16:13:44 INFO - "basedir": "/builds/slave/test", 16:13:44 INFO - "buildnumber": 632, 16:13:44 INFO - "slavename": "talos-linux64-ix-064", 16:13:44 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:13:44 INFO - "platform": "ubuntu64_hw", 16:13:44 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 16:13:44 INFO - "branch": "mozilla-inbound", 16:13:44 INFO - "repo_path": "integration/mozilla-inbound", 16:13:44 INFO - "revision": "09d0d424f914d064e30071fd85fc890e482fc79c", 16:13:44 INFO - "stage_platform": "linux64-pgo", 16:13:44 INFO - "builduid": "575844494e154ced97d49ebb9ab0e03b", 16:13:44 INFO - "slavebuilddir": "test" 16:13:44 INFO - } 16:13:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 16:13:44 INFO - Running post-action listener: _resource_record_post_action 16:13:44 INFO - ##### 16:13:44 INFO - ##### Finished read-buildbot-config step (success) 16:13:44 INFO - ##### 16:13:44 INFO - ##### 16:13:44 INFO - ##### Running download-and-extract step. 16:13:44 INFO - ##### 16:13:44 INFO - Running pre-action listener: _resource_record_pre_action 16:13:44 INFO - Running main action method: download_and_extract 16:13:44 INFO - mkdir: /builds/slave/test/build/tests 16:13:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:44 INFO - https://queue.taskcluster.net/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:13:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:13:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:13:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:13:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:13:44 INFO - Downloaded 1361 bytes. 16:13:44 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:13:44 INFO - Using the following test package requirements: 16:13:44 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 16:13:44 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:13:44 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:13:44 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:44 INFO - u'jsshell-linux-x86_64.zip'], 16:13:44 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:13:44 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 16:13:44 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:13:44 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:13:44 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:13:44 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:13:44 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:13:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:44 INFO - https://queue.taskcluster.net/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:13:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:13:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:13:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:13:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:13:45 INFO - Downloaded 24412402 bytes. 16:13:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:13:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:13:47 INFO - Return code: 0 16:13:47 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:13:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:47 INFO - https://queue.taskcluster.net/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:13:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:13:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:13:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:13:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:13:49 INFO - Downloaded 24412402 bytes. 16:13:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:13:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:13:51 INFO - Return code: 0 16:13:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:51 INFO - https://queue.taskcluster.net/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:13:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:13:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:13:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:13:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:13:52 INFO - Downloaded 10834055 bytes. 16:13:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:13:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:13:52 INFO - Return code: 0 16:13:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:52 INFO - https://queue.taskcluster.net/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:13:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:13:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:13:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:13:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:13:53 INFO - Downloaded 58955371 bytes. 16:13:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:13:53 INFO - mkdir: /builds/slave/test/properties 16:13:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:13:53 INFO - Writing to file /builds/slave/test/properties/build_url 16:13:53 INFO - Contents: 16:13:53 INFO - build_url:https://queue.taskcluster.net/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:13:54 INFO - Running post-action listener: _resource_record_post_action 16:13:54 INFO - Running post-action listener: set_extra_try_arguments 16:13:54 INFO - ##### 16:13:54 INFO - ##### Finished download-and-extract step (success) 16:13:54 INFO - ##### 16:13:54 INFO - ##### 16:13:54 INFO - ##### Running populate-webroot step. 16:13:54 INFO - ##### 16:13:54 INFO - Running pre-action listener: _resource_record_pre_action 16:13:54 INFO - Running main action method: populate_webroot 16:13:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:13:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:13:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:13:54 INFO - '--tppagecycles', 16:13:54 INFO - '7'], 16:13:54 INFO - 'tests': ['tsvgm']}}, 16:13:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:13:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:13:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:13:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:13:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:13:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:13:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:54 INFO - 'talos_options': ['--disable-e10s'], 16:13:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:13:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:13:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:54 INFO - 'talos_options': ['--disable-e10s'], 16:13:54 INFO - 'tests': ['damp', 'tps']}, 16:13:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:54 INFO - 'tests': ['damp', 'tps']}, 16:13:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:13:54 INFO - 'tests': ['dromaeo_dom']}, 16:13:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:13:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:13:54 INFO - 'tests': ['a11yr', 16:13:54 INFO - 'ts_paint', 16:13:54 INFO - 'tpaint', 16:13:54 INFO - 'sessionrestore', 16:13:54 INFO - 'sessionrestore_no_auto_restore', 16:13:54 INFO - 'tabpaint']}, 16:13:54 INFO - 'other-e10s': {'tests': ['a11yr', 16:13:54 INFO - 'ts_paint', 16:13:54 INFO - 'tpaint', 16:13:54 INFO - 'sessionrestore', 16:13:54 INFO - 'sessionrestore_no_auto_restore', 16:13:54 INFO - 'tabpaint']}, 16:13:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:13:54 INFO - 'ts_paint', 16:13:54 INFO - 'tpaint', 16:13:54 INFO - 'sessionrestore', 16:13:54 INFO - 'sessionrestore_no_auto_restore', 16:13:54 INFO - 'tabpaint']}, 16:13:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:13:54 INFO - 'ts_paint', 16:13:54 INFO - 'tpaint', 16:13:54 INFO - 'sessionrestore', 16:13:54 INFO - 'sessionrestore_no_auto_restore', 16:13:54 INFO - 'tabpaint']}, 16:13:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:13:54 INFO - 'tests': ['a11yr', 16:13:54 INFO - 'ts_paint', 16:13:54 INFO - 'tpaint', 16:13:54 INFO - 'sessionrestore', 16:13:54 INFO - 'sessionrestore_no_auto_restore', 16:13:54 INFO - 'tabpaint']}, 16:13:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:13:54 INFO - 'tests': ['a11yr', 16:13:54 INFO - 'ts_paint', 16:13:54 INFO - 'tpaint', 16:13:54 INFO - 'sessionrestore', 16:13:54 INFO - 'sessionrestore_no_auto_restore', 16:13:54 INFO - 'tabpaint']}, 16:13:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:13:54 INFO - 'tests': ['tsvgx', 16:13:54 INFO - 'tsvgr_opacity', 16:13:54 INFO - 'tart', 16:13:54 INFO - 'tscrollx', 16:13:54 INFO - 'cart']}, 16:13:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:13:54 INFO - 'tsvgr_opacity', 16:13:54 INFO - 'tart', 16:13:54 INFO - 'tscrollx', 16:13:54 INFO - 'cart']}, 16:13:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:54 INFO - 'talos_options': ['--disable-e10s'], 16:13:54 INFO - 'tests': ['tp5o']}, 16:13:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:54 INFO - 'tests': ['tp5o']}, 16:13:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:54 INFO - 'talos_options': ['--disable-e10s', 16:13:54 INFO - '--xperf_path', 16:13:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:13:54 INFO - 'tests': ['tp5n']}, 16:13:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:54 INFO - 'talos_options': ['--xperf_path', 16:13:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:13:54 INFO - 'tests': ['tp5n']}}, 16:13:54 INFO - 'talos.zip': {'path': '', 16:13:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:13:54 INFO - Running post-action listener: _resource_record_post_action 16:13:54 INFO - ##### 16:13:54 INFO - ##### Finished populate-webroot step (success) 16:13:54 INFO - ##### 16:13:54 INFO - ##### 16:13:54 INFO - ##### Running create-virtualenv step. 16:13:54 INFO - ##### 16:13:54 INFO - Running pre-action listener: _resource_record_pre_action 16:13:54 INFO - Running main action method: create_virtualenv 16:13:54 INFO - Creating virtualenv /builds/slave/test/build/venv 16:13:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:13:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:13:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:13:54 INFO - Using real prefix '/usr' 16:13:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:14:01 INFO - Installing distribute.............................................................................................................................................................................................done. 16:14:03 INFO - Installing pip.................done. 16:14:03 INFO - Return code: 0 16:14:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:14: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')]} 16:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14: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')]} 16:14:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffac7cbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aa9c0>, '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 0x21ab8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21abd50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464650019.146245-389341864', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:14:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:14:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:14:03 INFO - Using env: {'DISPLAY': ':0', 16:14:03 INFO - 'HOME': '/home/cltbld', 16:14:03 INFO - 'LANG': 'en_US.UTF-8', 16:14:03 INFO - 'LANGUAGE': 'en_US:en', 16:14:03 INFO - 'LOGNAME': 'cltbld', 16:14:03 INFO - 'MAIL': '/var/mail/cltbld', 16:14:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:03 INFO - 'MOZ_NO_REMOTE': '1', 16:14:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:03 INFO - 'NO_EM_RESTART': '1', 16:14:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:03 INFO - 'PWD': '/builds/slave/test', 16:14:03 INFO - 'SHELL': '/bin/bash', 16:14:03 INFO - 'SHLVL': '1', 16:14:03 INFO - 'TERM': 'linux', 16:14:03 INFO - 'TMOUT': '86400', 16:14:03 INFO - 'USER': 'cltbld', 16:14:03 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464650019.146245-389341864', 16:14:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:03 INFO - '_': '/tools/buildbot/bin/python'} 16:14:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:14:03 INFO - Cleaning up... 16:14:03 INFO - Return code: 0 16:14:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:14: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')]} 16:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14: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')]} 16:14:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffac7cbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aa9c0>, '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 0x21ab8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21abd50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464650019.146245-389341864', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:14:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:14:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:14:03 INFO - Using env: {'DISPLAY': ':0', 16:14:03 INFO - 'HOME': '/home/cltbld', 16:14:03 INFO - 'LANG': 'en_US.UTF-8', 16:14:03 INFO - 'LANGUAGE': 'en_US:en', 16:14:03 INFO - 'LOGNAME': 'cltbld', 16:14:03 INFO - 'MAIL': '/var/mail/cltbld', 16:14:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:03 INFO - 'MOZ_NO_REMOTE': '1', 16:14:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:03 INFO - 'NO_EM_RESTART': '1', 16:14:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:03 INFO - 'PWD': '/builds/slave/test', 16:14:03 INFO - 'SHELL': '/bin/bash', 16:14:03 INFO - 'SHLVL': '1', 16:14:03 INFO - 'TERM': 'linux', 16:14:03 INFO - 'TMOUT': '86400', 16:14:03 INFO - 'USER': 'cltbld', 16:14:03 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464650019.146245-389341864', 16:14:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:03 INFO - '_': '/tools/buildbot/bin/python'} 16:14:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:04 INFO - Downloading/unpacking psutil>=3.1.1 16:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:14:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:14:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:14:06 INFO - Installing collected packages: psutil 16:14:06 INFO - Running setup.py install for psutil 16:14:06 INFO - building 'psutil._psutil_linux' extension 16:14:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:14:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:14:07 INFO - building 'psutil._psutil_posix' extension 16:14:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:14:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:14:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:14:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:14:07 INFO - Successfully installed psutil 16:14:07 INFO - Cleaning up... 16:14:07 INFO - Return code: 0 16:14:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:14:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:14:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:07 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 0x7ffac7cbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aa9c0>, '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 0x21ab8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21abd50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464650019.146245-389341864', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:14:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:14:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:14:07 INFO - Using env: {'DISPLAY': ':0', 16:14:07 INFO - 'HOME': '/home/cltbld', 16:14:07 INFO - 'LANG': 'en_US.UTF-8', 16:14:07 INFO - 'LANGUAGE': 'en_US:en', 16:14:07 INFO - 'LOGNAME': 'cltbld', 16:14:07 INFO - 'MAIL': '/var/mail/cltbld', 16:14:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:07 INFO - 'MOZ_NO_REMOTE': '1', 16:14:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:07 INFO - 'NO_EM_RESTART': '1', 16:14:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:07 INFO - 'PWD': '/builds/slave/test', 16:14:07 INFO - 'SHELL': '/bin/bash', 16:14:07 INFO - 'SHLVL': '1', 16:14:07 INFO - 'TERM': 'linux', 16:14:07 INFO - 'TMOUT': '86400', 16:14:07 INFO - 'USER': 'cltbld', 16:14:07 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464650019.146245-389341864', 16:14:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:07 INFO - '_': '/tools/buildbot/bin/python'} 16:14:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:14:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:14:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:14:09 INFO - Installing collected packages: mozsystemmonitor 16:14:09 INFO - Running setup.py install for mozsystemmonitor 16:14:09 INFO - Successfully installed mozsystemmonitor 16:14:09 INFO - Cleaning up... 16:14:10 INFO - Return code: 0 16:14:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:14: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')]} 16:14:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14: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')]} 16:14:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:10 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 0x7ffac7cbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aa9c0>, '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 0x21ab8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21abd50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464650019.146245-389341864', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:14:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:14:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:14:10 INFO - Using env: {'DISPLAY': ':0', 16:14:10 INFO - 'HOME': '/home/cltbld', 16:14:10 INFO - 'LANG': 'en_US.UTF-8', 16:14:10 INFO - 'LANGUAGE': 'en_US:en', 16:14:10 INFO - 'LOGNAME': 'cltbld', 16:14:10 INFO - 'MAIL': '/var/mail/cltbld', 16:14:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:10 INFO - 'MOZ_NO_REMOTE': '1', 16:14:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:10 INFO - 'NO_EM_RESTART': '1', 16:14:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:10 INFO - 'PWD': '/builds/slave/test', 16:14:10 INFO - 'SHELL': '/bin/bash', 16:14:10 INFO - 'SHLVL': '1', 16:14:10 INFO - 'TERM': 'linux', 16:14:10 INFO - 'TMOUT': '86400', 16:14:10 INFO - 'USER': 'cltbld', 16:14:10 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464650019.146245-389341864', 16:14:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:10 INFO - '_': '/tools/buildbot/bin/python'} 16:14:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:10 INFO - Downloading/unpacking blobuploader==1.2.4 16:14:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:12 INFO - Downloading blobuploader-1.2.4.tar.gz 16:14:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:14:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:14:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:12 INFO - Downloading docopt-0.6.1.tar.gz 16:14:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:14:12 INFO - Installing collected packages: blobuploader, requests, docopt 16:14:12 INFO - Running setup.py install for blobuploader 16:14:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:14:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:14:13 INFO - Running setup.py install for requests 16:14:13 INFO - Running setup.py install for docopt 16:14:13 INFO - Successfully installed blobuploader requests docopt 16:14:13 INFO - Cleaning up... 16:14:13 INFO - Return code: 0 16:14:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:14:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:14:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:14:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:13 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 0x7ffac7cbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aa9c0>, '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 0x21ab8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21abd50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464650019.146245-389341864', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:14:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:14:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:14:13 INFO - Using env: {'DISPLAY': ':0', 16:14:13 INFO - 'HOME': '/home/cltbld', 16:14:13 INFO - 'LANG': 'en_US.UTF-8', 16:14:13 INFO - 'LANGUAGE': 'en_US:en', 16:14:13 INFO - 'LOGNAME': 'cltbld', 16:14:13 INFO - 'MAIL': '/var/mail/cltbld', 16:14:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:13 INFO - 'MOZ_NO_REMOTE': '1', 16:14:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:13 INFO - 'NO_EM_RESTART': '1', 16:14:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:13 INFO - 'PWD': '/builds/slave/test', 16:14:13 INFO - 'SHELL': '/bin/bash', 16:14:13 INFO - 'SHLVL': '1', 16:14:13 INFO - 'TERM': 'linux', 16:14:13 INFO - 'TMOUT': '86400', 16:14:13 INFO - 'USER': 'cltbld', 16:14:13 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464650019.146245-389341864', 16:14:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:13 INFO - '_': '/tools/buildbot/bin/python'} 16:14:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:14:13 INFO - Running setup.py (path:/tmp/pip-2C52tN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:14:13 INFO - Running setup.py (path:/tmp/pip-OWR7d3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:14:13 INFO - Running setup.py (path:/tmp/pip-Aj0Abz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:14:13 INFO - Running setup.py (path:/tmp/pip-V6ds5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:14:14 INFO - Running setup.py (path:/tmp/pip-axG0AG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:14:14 INFO - Running setup.py (path:/tmp/pip-Niu76z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:14:14 INFO - Running setup.py (path:/tmp/pip-UfdmTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:14:14 INFO - Running setup.py (path:/tmp/pip-vltLCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:14:14 INFO - Running setup.py (path:/tmp/pip-Xc8KR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:14:14 INFO - Running setup.py (path:/tmp/pip-u1S5BS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:14:14 INFO - Running setup.py (path:/tmp/pip-IOXNUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:14:14 INFO - Running setup.py (path:/tmp/pip-yguWwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:14:14 INFO - Running setup.py (path:/tmp/pip-VLGTZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:14:14 INFO - Running setup.py (path:/tmp/pip-o6w35i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:14:14 INFO - Running setup.py (path:/tmp/pip-TEfVt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:14:14 INFO - Running setup.py (path:/tmp/pip-7oQvKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:14:14 INFO - Running setup.py (path:/tmp/pip-u5paDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:14:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:14:14 INFO - Running setup.py install for manifestparser 16:14:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:14:15 INFO - Running setup.py install for mozcrash 16:14:15 INFO - Running setup.py install for mozdebug 16:14:15 INFO - Running setup.py install for mozdevice 16:14:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:14:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:14:15 INFO - Running setup.py install for mozfile 16:14:15 INFO - Running setup.py install for mozhttpd 16:14:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:14:15 INFO - Running setup.py install for mozinfo 16:14:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:14:15 INFO - Running setup.py install for mozInstall 16:14:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:14:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:14:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:14:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:14:15 INFO - Running setup.py install for mozleak 16:14:15 INFO - Running setup.py install for mozlog 16:14:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:14:15 INFO - Running setup.py install for moznetwork 16:14:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:14:16 INFO - Running setup.py install for mozprocess 16:14:16 INFO - Running setup.py install for mozprofile 16:14:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:14:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:14:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:14:16 INFO - Running setup.py install for mozrunner 16:14:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:14:16 INFO - Running setup.py install for mozscreenshot 16:14:16 INFO - Running setup.py install for moztest 16:14:16 INFO - Running setup.py install for mozversion 16:14:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:14:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:14:16 INFO - Cleaning up... 16:14:16 INFO - Return code: 0 16:14:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:14: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')]} 16:14:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14: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')]} 16:14:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:16 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 0x7ffac7cbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aa9c0>, '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 0x21ab8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21abd50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464650019.146245-389341864', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:14:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:14:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:14:16 INFO - Using env: {'DISPLAY': ':0', 16:14:16 INFO - 'HOME': '/home/cltbld', 16:14:16 INFO - 'LANG': 'en_US.UTF-8', 16:14:16 INFO - 'LANGUAGE': 'en_US:en', 16:14:16 INFO - 'LOGNAME': 'cltbld', 16:14:16 INFO - 'MAIL': '/var/mail/cltbld', 16:14:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:16 INFO - 'MOZ_NO_REMOTE': '1', 16:14:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:16 INFO - 'NO_EM_RESTART': '1', 16:14:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:16 INFO - 'PWD': '/builds/slave/test', 16:14:16 INFO - 'SHELL': '/bin/bash', 16:14:16 INFO - 'SHLVL': '1', 16:14:16 INFO - 'TERM': 'linux', 16:14:16 INFO - 'TMOUT': '86400', 16:14:16 INFO - 'USER': 'cltbld', 16:14:16 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464650019.146245-389341864', 16:14:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:16 INFO - '_': '/tools/buildbot/bin/python'} 16:14:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:14:16 INFO - Running setup.py (path:/tmp/pip-eyMt7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:14:17 INFO - Running setup.py (path:/tmp/pip-czANP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:14:17 INFO - Running setup.py (path:/tmp/pip-8t5UM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:14:17 INFO - Running setup.py (path:/tmp/pip-7VbXAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:14:17 INFO - Running setup.py (path:/tmp/pip-pMIenK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:14:17 INFO - Running setup.py (path:/tmp/pip-qkMDO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:14:17 INFO - Running setup.py (path:/tmp/pip-pLp2pQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:14:17 INFO - Running setup.py (path:/tmp/pip-TOF3VZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:14:17 INFO - Running setup.py (path:/tmp/pip-FFYChk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:14:17 INFO - Running setup.py (path:/tmp/pip-qUoNrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:14:17 INFO - Running setup.py (path:/tmp/pip-WssQGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:14:17 INFO - Running setup.py (path:/tmp/pip-eFx0jY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:14:17 INFO - Running setup.py (path:/tmp/pip-R3iPN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:14:17 INFO - Running setup.py (path:/tmp/pip-oY2jhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:14:17 INFO - Running setup.py (path:/tmp/pip-g_0OEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:14:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:14:18 INFO - Running setup.py (path:/tmp/pip-i8ev0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:14:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:14:18 INFO - Running setup.py (path:/tmp/pip-4NQbn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:14:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:14:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:14:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:14:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:14:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:14:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:14:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:20 INFO - Downloading blessings-1.6.tar.gz 16:14:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:14:20 INFO - Installing collected packages: blessings 16:14:20 INFO - Running setup.py install for blessings 16:14:20 INFO - Successfully installed blessings 16:14:20 INFO - Cleaning up... 16:14:20 INFO - Return code: 0 16:14:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:14:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:14:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:14:20 INFO - Reading from file tmpfile_stdout 16:14:20 INFO - Current package versions: 16:14:20 INFO - argparse == 1.2.1 16:14:20 INFO - blessings == 1.6 16:14:20 INFO - blobuploader == 1.2.4 16:14:20 INFO - docopt == 0.6.1 16:14:20 INFO - manifestparser == 1.1 16:14:20 INFO - mozInstall == 1.12 16:14:20 INFO - mozcrash == 0.17 16:14:20 INFO - mozdebug == 0.1 16:14:20 INFO - mozdevice == 0.48 16:14:20 INFO - mozfile == 1.2 16:14:20 INFO - mozhttpd == 0.7 16:14:20 INFO - mozinfo == 0.9 16:14:20 INFO - mozleak == 0.1 16:14:20 INFO - mozlog == 3.2 16:14:20 INFO - moznetwork == 0.27 16:14:20 INFO - mozprocess == 0.22 16:14:20 INFO - mozprofile == 0.28 16:14:20 INFO - mozrunner == 6.11 16:14:20 INFO - mozscreenshot == 0.1 16:14:20 INFO - mozsystemmonitor == 0.3 16:14:20 INFO - moztest == 0.7 16:14:20 INFO - mozversion == 1.4 16:14:20 INFO - psutil == 3.1.1 16:14:20 INFO - requests == 1.2.3 16:14:20 INFO - wsgiref == 0.1.2 16:14:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:14:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:14:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:20 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 0x7ffac7cbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aa9c0>, '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 0x21ab8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21abd50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464650019.146245-389341864', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:14:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:14:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:14:20 INFO - Using env: {'DISPLAY': ':0', 16:14:20 INFO - 'HOME': '/home/cltbld', 16:14:20 INFO - 'LANG': 'en_US.UTF-8', 16:14:20 INFO - 'LANGUAGE': 'en_US:en', 16:14:20 INFO - 'LOGNAME': 'cltbld', 16:14:20 INFO - 'MAIL': '/var/mail/cltbld', 16:14:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:20 INFO - 'MOZ_NO_REMOTE': '1', 16:14:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:20 INFO - 'NO_EM_RESTART': '1', 16:14:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:20 INFO - 'PWD': '/builds/slave/test', 16:14:20 INFO - 'SHELL': '/bin/bash', 16:14:20 INFO - 'SHLVL': '1', 16:14:20 INFO - 'TERM': 'linux', 16:14:20 INFO - 'TMOUT': '86400', 16:14:20 INFO - 'USER': 'cltbld', 16:14:20 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464650019.146245-389341864', 16:14:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:20 INFO - '_': '/tools/buildbot/bin/python'} 16:14:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:14:20 INFO - Cleaning up... 16:14:20 INFO - Return code: 0 16:14:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:14:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:14:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:20 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 0x7ffac7cbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aa9c0>, '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 0x21ab8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21abd50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464650019.146245-389341864', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:14:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:14:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:14:20 INFO - Using env: {'DISPLAY': ':0', 16:14:20 INFO - 'HOME': '/home/cltbld', 16:14:20 INFO - 'LANG': 'en_US.UTF-8', 16:14:20 INFO - 'LANGUAGE': 'en_US:en', 16:14:20 INFO - 'LOGNAME': 'cltbld', 16:14:20 INFO - 'MAIL': '/var/mail/cltbld', 16:14:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:20 INFO - 'MOZ_NO_REMOTE': '1', 16:14:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:20 INFO - 'NO_EM_RESTART': '1', 16:14:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:20 INFO - 'PWD': '/builds/slave/test', 16:14:20 INFO - 'SHELL': '/bin/bash', 16:14:20 INFO - 'SHLVL': '1', 16:14:20 INFO - 'TERM': 'linux', 16:14:20 INFO - 'TMOUT': '86400', 16:14:20 INFO - 'USER': 'cltbld', 16:14:20 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464650019.146245-389341864', 16:14:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:20 INFO - '_': '/tools/buildbot/bin/python'} 16:14:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:20 INFO - Downloading/unpacking jsonschema 16:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:14:22 INFO - Downloading/unpacking functools32 (from jsonschema) 16:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:23 INFO - Downloading functools32-3.2.3-2.tar.gz 16:14:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:14:23 INFO - warning: no files found matching '*.txt' 16:14:23 INFO - no previously-included directories found matching 'build' 16:14:23 INFO - no previously-included directories found matching 'dist' 16:14:23 INFO - no previously-included directories found matching '.git*' 16:14:23 INFO - Installing collected packages: jsonschema, functools32 16:14:23 INFO - Running setup.py install for functools32 16:14:23 INFO - warning: no files found matching '*.txt' 16:14:23 INFO - no previously-included directories found matching 'build' 16:14:23 INFO - no previously-included directories found matching 'dist' 16:14:23 INFO - no previously-included directories found matching '.git*' 16:14:23 INFO - Successfully installed jsonschema functools32 16:14:23 INFO - Cleaning up... 16:14:23 INFO - Return code: 0 16:14:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:14:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:14:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:23 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 0x7ffac7cbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aa9c0>, '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 0x21ab8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21abd50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464650019.146245-389341864', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:14:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:14:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:14:23 INFO - Using env: {'DISPLAY': ':0', 16:14:23 INFO - 'HOME': '/home/cltbld', 16:14:23 INFO - 'LANG': 'en_US.UTF-8', 16:14:23 INFO - 'LANGUAGE': 'en_US:en', 16:14:23 INFO - 'LOGNAME': 'cltbld', 16:14:23 INFO - 'MAIL': '/var/mail/cltbld', 16:14:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:23 INFO - 'MOZ_NO_REMOTE': '1', 16:14:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:23 INFO - 'NO_EM_RESTART': '1', 16:14:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:23 INFO - 'PWD': '/builds/slave/test', 16:14:23 INFO - 'SHELL': '/bin/bash', 16:14:23 INFO - 'SHLVL': '1', 16:14:23 INFO - 'TERM': 'linux', 16:14:23 INFO - 'TMOUT': '86400', 16:14:23 INFO - 'USER': 'cltbld', 16:14:23 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464650019.146245-389341864', 16:14:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:23 INFO - '_': '/tools/buildbot/bin/python'} 16:14:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:23 INFO - Downloading/unpacking flake8 16:14: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 16:14: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 16:14: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 16:14: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 16:14: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 16:14: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 16:14:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:14:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:14:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:14:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:14:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:14:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:14:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:14:26 INFO - no previously-included directories found matching 'docs/_build' 16:14:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:14:26 INFO - Running setup.py install for pep8 16:14:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:14:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:14:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:14:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:14:26 INFO - no previously-included directories found matching 'docs/_build' 16:14:26 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:14:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:14:26 INFO - Cleaning up... 16:14:26 INFO - Return code: 0 16:14:26 INFO - Running post-action listener: _resource_record_post_action 16:14:26 INFO - Running post-action listener: _start_resource_monitoring 16:14:26 INFO - Starting resource monitoring. 16:14:26 INFO - ##### 16:14:26 INFO - ##### Finished create-virtualenv step (success) 16:14:26 INFO - ##### 16:14:26 INFO - ##### 16:14:26 INFO - ##### Running install step. 16:14:26 INFO - ##### 16:14:26 INFO - Running pre-action listener: _resource_record_pre_action 16:14:26 INFO - Running main action method: install 16:14:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:14:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:14:26 INFO - Reading from file tmpfile_stdout 16:14:26 INFO - Detecting whether we're running mozinstall >=1.0... 16:14:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:14:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:14:26 INFO - Reading from file tmpfile_stdout 16:14:26 INFO - Output received: 16:14:26 INFO - Usage: mozinstall [options] installer 16:14:26 INFO - Options: 16:14:26 INFO - -h, --help show this help message and exit 16:14:26 INFO - -d DEST, --destination=DEST 16:14:26 INFO - Directory to install application into. [default: 16:14:26 INFO - "/builds/slave/test"] 16:14:26 INFO - --app=APP Application being installed. [default: firefox] 16:14:26 INFO - mkdir: /builds/slave/test/build/application 16:14:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:14:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:14:43 INFO - Reading from file tmpfile_stdout 16:14:43 INFO - Output received: 16:14:43 INFO - /builds/slave/test/build/application/firefox/firefox 16:14:43 INFO - Running post-action listener: _resource_record_post_action 16:14:43 INFO - ##### 16:14:43 INFO - ##### Finished install step (success) 16:14:43 INFO - ##### 16:14:43 INFO - ##### 16:14:43 INFO - ##### Running run-tests step. 16:14:43 INFO - ##### 16:14:43 INFO - Running pre-action listener: _resource_record_pre_action 16:14:43 INFO - Running main action method: run_tests 16:14:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:14:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:14:43 INFO - Python 2.7.3 16:14:43 INFO - Return code: 0 16:14:43 INFO - grabbing minidump binary from tooltool 16:14:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:14:43 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 0x21aa9c0>, '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 0x21ab8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21abd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:14:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:14:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:14:43 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:14:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:14:43 INFO - Return code: 0 16:14:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:14:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:14:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:14:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:14:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:14:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:14:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:14:44 INFO - Return code: 0 16:14:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 16:14:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 16:14:44 INFO - Using env: {'DISPLAY': ':0', 16:14:44 INFO - 'HOME': '/home/cltbld', 16:14:44 INFO - 'LANG': 'en_US.UTF-8', 16:14:44 INFO - 'LANGUAGE': 'en_US:en', 16:14:44 INFO - 'LOGNAME': 'cltbld', 16:14:44 INFO - 'MAIL': '/var/mail/cltbld', 16:14:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:14:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:14:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:44 INFO - 'MOZ_NO_REMOTE': '1', 16:14:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:14:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:44 INFO - 'NO_EM_RESTART': '1', 16:14:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:44 INFO - 'PWD': '/builds/slave/test', 16:14:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:14:44 INFO - 'SHELL': '/bin/bash', 16:14:44 INFO - 'SHLVL': '1', 16:14:44 INFO - 'TERM': 'linux', 16:14:44 INFO - 'TMOUT': '86400', 16:14:44 INFO - 'USER': 'cltbld', 16:14:44 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464650019.146245-389341864', 16:14:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:44 INFO - '_': '/tools/buildbot/bin/python'} 16:14:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 16:14:45 INFO - mozversion application_buildid: 20160530133025 16:14:45 INFO - mozversion application_changeset: 09d0d424f914d064e30071fd85fc890e482fc79c 16:14:45 INFO - mozversion application_display_name: Nightly 16:14:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:14:45 INFO - mozversion application_name: Firefox 16:14:45 INFO - mozversion application_remotingname: firefox 16:14:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:14:45 INFO - mozversion application_vendor: Mozilla 16:14:45 INFO - mozversion application_version: 49.0a1 16:14:45 INFO - mozversion platform_buildid: 20160530133025 16:14:45 INFO - mozversion platform_changeset: 09d0d424f914d064e30071fd85fc890e482fc79c 16:14:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:14:45 INFO - mozversion platform_version: 49.0a1 16:14:45 INFO - using testdate: 1464650085 16:14:45 INFO - actual date: 1464650085 16:14:45 INFO - starting webserver on 'localhost:60596' 16:14:45 INFO - SUITE-START | Running 2 tests 16:14:45 INFO - TEST-START | dromaeo_css 16:14:45 INFO - operating with platform_type : linux_ 16:14:45 INFO - Initialising browser for dromaeo_css test... 16:14:45 INFO - TEST-INFO | started process 3292 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKJzpo_/profile http://localhost:60596/getInfo.html) 16:14:51 INFO - PROCESS | 3292 | __metrics Screen width/height:1600/1200 16:14:51 INFO - PROCESS | 3292 | colorDepth:24 16:14:51 INFO - PROCESS | 3292 | Browser inner width/height: 1024/697 16:14:51 INFO - PROCESS | 3292 | __metrics 16:14:52 ERROR - PROCESS | 3292 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 16:14:52 INFO - TEST-INFO | 3292: exit 0 16:14:52 INFO - Browser initialized. 16:14:52 INFO - Running cycle 1/1 for dromaeo_css test... 16:14:52 INFO - TEST-INFO | started process 3413 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKJzpo_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:15:04 INFO - PROCESS | 3413 | RSS: Main: 166711296 16:15:04 INFO - PROCESS | 3413 | 16:15:54 INFO - PROCESS | 3413 | 1464650154414 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:18:01 INFO - PROCESS | 3413 | Cycle 1(1): loaded http://localhost:60596/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60596/tests/dromaeo/cssquery-ext.html) 16:18:02 INFO - PROCESS | 3413 | RSS: Main: 170237952 16:18:02 INFO - PROCESS | 3413 | 16:21:04 INFO - PROCESS | 3413 | Cycle 1(1): loaded http://localhost:60596/tests/dromaeo/cssquery-ext.html (next: http://localhost:60596/tests/dromaeo/cssquery-jquery.html) 16:21:05 INFO - PROCESS | 3413 | RSS: Main: 169787392 16:21:05 INFO - PROCESS | 3413 | 16:24:07 INFO - PROCESS | 3413 | Cycle 1(1): loaded http://localhost:60596/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60596/tests/dromaeo/cssquery-mootools.html) 16:24:08 INFO - PROCESS | 3413 | RSS: Main: 171573248 16:24:08 INFO - PROCESS | 3413 | 16:27:09 INFO - PROCESS | 3413 | Cycle 1(1): loaded http://localhost:60596/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60596/tests/dromaeo/cssquery-prototype.html) 16:27:10 INFO - PROCESS | 3413 | RSS: Main: 168419328 16:27:10 INFO - PROCESS | 3413 | 16:30:12 INFO - PROCESS | 3413 | Cycle 1(1): loaded http://localhost:60596/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60596/tests/dromaeo/cssquery-yui.html) 16:30:13 INFO - PROCESS | 3413 | RSS: Main: 170696704 16:30:13 INFO - PROCESS | 3413 | 16:33:16 INFO - PROCESS | 3413 | Cycle 1(1): loaded http://localhost:60596/tests/dromaeo/cssquery-yui.html (next: http://localhost:60596/tests/dromaeo/cssquery-dojo.html) 16:33:16 INFO - PROCESS | 3413 | RSS: Main: 172150784 16:33:16 INFO - PROCESS | 3413 | 16:33:16 INFO - PROCESS | 3413 | __start_tp_report 16:33:16 INFO - PROCESS | 3413 | _x_x_mozilla_page_load 16:33:16 INFO - PROCESS | 3413 | _x_x_mozilla_page_load_details 16:33:16 INFO - PROCESS | 3413 | |i|pagename|runs| 16:33:16 INFO - PROCESS | 3413 | |0;dojo.html;3067.8772849086035;3077.26145725026;3122;3125.23431759219;3127.046250893478;5269.525742683162;5366.865828354288;5374.811881584141;5391.029614669358;5408.945910540893;5224.503672151149;5275.577953763699;5277.023750606131;5303.7348132593315;5375.516203541681;4734.999999999992;4769.809207631691;4867.318575399447;4898.853034408956;4944.233643785219;941.4966641778459;4721.716696998191;4766.9284960725445;4832.081904438145;4969.925451118236;4835.468098509161;4842.1042107210105;4849.927251091236;4860.8055677772845;4862.975685121552;4940.851774446773;4945.604351651859;4946.851594452172;4947.03532811102;4984.900301993976;4714.057188562301;4846.709197448165;4867.829625963074;4913.778879950375;4946.703197808143;5342.492463216027;5344.14493681013;5345.946540534623;5368.382635996872;5425.050616142159;5498.642588231752;5883.735231914574;5885.941140588582;5892.410758924116;5894.764209431618;5644.774209031675;5685.772569097231;5712.22884910536;5713.400092990218;5755.453231943001;5365.248865158881;5375.247465354853;5388.703621300866;5405.405405405402;5420.783168673288;5677.347105082886;5856.824295271149;5887.4406931341455;5902;5914.940850591525;5650.604457688005;5661.037623603997;5672.716364181774;5683.920055189584;5741.684207368635;5760.049591817387;5769.278840144982;5771.105478650816;5783.450572195635;5798.072308430631;5499.257600223918;5639.774409023676;5676.971615141898;5725.971370143123;5774.595778295563;5727.513161381329;5745.425457454221;5749.3963133871175;5764.106563482667;5789.913151302734;4331.0904710011255;4334.089841133335;4345.065810850619;4348.130373925228;4383.101464199895;3787.981060094682;3840.7887566184127;3842.538895332522;3873.341531939577;3900.531936167621;5280.3663560373;5403.83788486346;5450.863728406822;5459.918101228484;5474.671519708831;5785.305763308345;5807.651540907559;5836.737346819404;5844.561657875592;5847.532197424196;5290.338707661543;5456.61803673739;5490.91763623538;5515.558755299567;5525.502704756591;4983.950160498421;4992.2511623256805;5017.849464515997;5031.396232452129;5050.49495050492;5940.940590594125;5952.8809423812145;5970.925233457932;5973.313068997121;6024.518038556905;5541.196526503715;5751.827445176651;5779.768809247583;5782.884342313214;5846.035404158436;5930.406959304035;5964.731587078505;5968.313643931004;5983.37174596661;5992.0712289595185;5502.58730595199;5681.886362272814;5686.09022556389;5692.829215123553;5700.372958974426;5705.486506214461;5710.200571920018;5771.047777116729;5781.4507621775865;5784.392638773036;5642.633228840113;5644.125160600113;5644.181593668977;5644.435556444323;5660.660360378391;5442.210879422382;5577.525910297508;5627.8874422512135;5631.521320687787;5633.943660563342;5571.4428557143965;5582.078956972054;5628.324601047737;5639.718014099197;5692.5730570208225;5714.542836573148;5717.514011308919;5728.742206600797;5730.255066841284;5745.080787074048;5358.035553600389;5462.481064298885;5467.7266136692215;5620.915686264628;5638.407967163553 16:33:16 INFO - PROCESS | 3413 | |1;ext.html;581.6393835821789;627.0907184582355;631.1447987976292;643.9291677915428;658.6772481484074;37388.439173412386;42043;42496;42720.786396067975;42735.78632106839;43575.78212108935;44293.33559996595;44387.77806110973;44643.33035004477;44680;8625.48247105174;8731.650733970633;8776.64893404263;8782.341324400664;8806.911930880706;8647.092055334193;8747.868781968276;8756.868646970268;8760.12398760122;8760.299176065899;8721.171488708562;8763.474191548528;8775.912240877606;8790.780230494256;8799.428037177595;8701.260392866614;8753.824923501526;8790.6923257686;8841.381103322705;8851.203391694746;8597.785055373603;8662.566871656392;8663.566821658955;8702.825943481159;8714.782130446789;40390.59609403898;40886.79556602198;41005.79497102525;41258.793706031574;41379.7931010343;3036.620422447194;3215.630202526716;3309.8841540546205;3395.4906763985355;3473.531073305097;30417.695823041708;31151.376972460424;31265.8436707815;31282.21794455134;31398.68601314003;4070.6743460523385;4093.692973027035;4179.623833854967;4300.677449191292;4317.827286908519;285624;289507;291386;291525.42372881057;291676;33454.498182527284;34307.828460857534;34559.4816077759;34928;35206.471902921476;36713;36921.63078369182;37103.81448092742;37110.44334334933;37112.25775484475;14131.15213087218;14133;14229.92885035589;14265.286735663176;14266;11889.464974076187;11947.880521194676;11966.700832479084;11974.101942354358;11976.041916646647;8215.876761848576;8240.887480190217;8246.175382461826;8294.129116442808;8396.202360775716;3224.290656055664;3232.8383580821337;3287.2439338952177;3300.702936735657;3312.089175476715;999.2655398282257;1019.3017782818793;1023.889080347816;1044.8014877173314;1058.9470526473644;31622.209444763605;31677.366452670816;31909.840450797597;32075;32472.512912306334;1073.1039581949003;1080.1682704317632;1110.3892858927557;1129.5481807277156;1152.844366010578;16185.364000759631;16604;16671.583210419838;16736.330546778237;16937.32250709958;517937;518939;522662;522815;523594;55670.72164639151;57200.71399643058;57264;57736.71131644399;57808;1307.2875282970804;1400.6008287638178;1427.9000469967002;1430.227677054379;1433.8924580656492;30117.548236776027;35403.46894796529;35440.29119417649;36145.63854361423;36997.44503832391;54790.45209547853;55904;55912.720436397554;59063.40936590579;59462.40537594569;479715;482168;486776;488231;488795;44226.019658230915;45106.77446612746;46532.534674654176;46581.30128048014;46633.533664664275;49466.50533494763;49481.50518494913;49532.25701614551;49821.252681210535;50169;41396.586034139276;43907;43952.56047439612;44045.55954440415;44068.55931440773;41792.3731144027;42428;42443.15113697647;42458.363124553776;43269.5384369256;40905;41696;41983.580164199186;42084.36873446962;42527.14945701007;35835.46246806248;37488.25023499569;37756.43365349577;37948.430773538974;38575.42136867893;28555.571666425436;28663;28863.7113628861;29087.7091229085;29204 16:33:16 INFO - PROCESS | 3413 | |2;jquery.html;373.8971782759742;376.02046668428744;393.65161831778875;401.03550959941333;410.0343690608619;16941.237644306006;18624.72062919057;19673.31143409983;19771.308004219856;19774.11016504257;10924.508397122128;11536.826947595793;18367.816321836777;18722.81277187228;18777.530561735963;5134.614903882214;5287.048331300364;5288.629795914288;5310.548603368718;5316.38861530925;3866.130120722829;5494.587905907073;5768.855778605526;5784.13238014297;5867.031939729939;5776.364599894008;5844.152597873327;5845.415458454163;5857.560682948774;5860.472557469827;5676.943230567683;5786.450287222707;5803.361630220694;5817.214676018768;5818.330891947417;5476.58925580579;5618.859528511779;5618.971905140448;5756.597038207327;5758;13309.33633295838;13407.530736424276;16263.674726505522;22850.200242991414;23021.88489057544;2154.859934104278;2229.108356657334;2252.977470225293;2261.9886900565557;2462.372095115734;9894.703158905244;9972;10044.397336159855;10086.89913100867;10254.7436314092;1873.8594605404649;1926.2872737087368;1927.152053096633;1962.5976674781778;1968.8326492248177;79820.60089699572;82271;82965;83097;83663;10323;10626.574937002433;10724.571017159225;10839.403832789114;10982.505787239594;15072.698546029238;15085.24573771329;15209.6197595061;15248.390064397521;15274.465393711389;7703.114141873644;8025.839483210303;8032.718854840053;8079.838403231903;8154.510729356258;7521.398288136936;7694.807629809299;7696.576688282086;7751.147373788879;8016.599170041474;4524.321351797257;4568.33759104928;4631.5642150932645;4633.4208223972;4745.786439610226;1631.575790294532;1659.6016955930731;1714.6999275126802;1720.1055451165573;1729.7805047441523;910.717677519971;974.7611835100446;984.1831280037552;1106.6808523331706;1164.2548768787983;18291.359802407118;18836.81163188378;18973.146208420654;19103.140358683893;19224.423267302005;990.3661656539821;990.9752256193509;1015.2690063154517;1050.8318669012922;1061.9681409557725;10654.467276636136;10949.726256843642;11055;11088.168387370979;11098.889011109786;221816;222727;226362;227123;459903;61084;76195.61902190454;91025.54487227522;100296;100614;1020.3469779341227;1027.5067967375553;1064.3081996702206;1066.1470823341297;1072.6245813965206;17387.391441299493;17833.821661783735;18019.81980180234;18164.45506634803;18347.26610935601;41820.58179418167;42731.931701707705;43251.78374108109;43809.12381752411;43914.12171756483;49286.50713492819;49791;51066.48933510618;58082.4191758077;58514.14858514114;8362.958185209034;8715;8736.694215702673;8751.518666473405;8791.34064945119;11005.229633925548;12446.751064978831;12619.621411357673;12634;13145.474181032652;10930.344179349264;10991.835122473009;11033.172512061788;11039;11060.292713967445;11018;11038.11695064409;11063.391513466515;11206.271592346471;11241.213115081866;8732.956335218283;11092.223544351818;11409.657710268706;11468.598599048993;11496.827547586625;8607.526586037828;8718.346124040596;8781.912180878366;8858.98121716011;9036.81926361456;10386.792264154827;11114.888851111386;11115.833262500908;11308;11318.26431281964 16:33:16 INFO - PROCESS | 3413 | |3;mootools.html;1504.593759684885;1532.5555588879226;1665.5752783040323;1798.9460316190518;1813.138759089432;7425.108986921577;7902.802429939255;8047.315978141858;8563.61463734132;8587.65649374025;7909.367250619951;8078.838423231532;8146.26683598476;8172.468789528676;8190.9590452047805;2254.1884921428273;2282.4864405508793;2285.371522831218;2288.4622113803243;2293.9655905161435;2188.9562208755897;2193.7257842769654;2226;2238.5746708125403;2244.36035729817;2197.9560408791813;2205.7353117625908;2207.701960235364;2215.590115828577;2224.1992882562263;2095.738032745907;2102.2536999365157;2106.2838634864142;2112.10235649849;2119.9788002120013;2148.602508535926;2154.0199209359703;2184.541246338271;2233.274185889576;2235.3294011796397;8027.478213916077;8115;8130.959345203295;8139.633716482773;8140.959295203486;5166.43169251382;5238.1618940969265;5293.444188360244;5297.073012222884;5299.5760339172775;3183.761217908643;3264.3308121834966;3356.16095976006;3376.5272861799367;3417.40195465795;1110.545185806596;1138.8861113888545;1147.65570328901;1150.0626989003936;1175.4534141624101;12268.263904165779;12312.26126432408;12313.384330783514;12314.261144331369;12326.568570100093;4578.931316030262;4643.628509719214;4704.012157446974;4718.504557021532;4755.785989630475;10300.896991030144;10324.174066074696;10333.638322658671;10338.172946164439;10347.327423717434;5211.905499844999;5277.577793776489;5284.630075894651;5300.390455097713;5321.920171197435;4107.97946010274;4604.654650901196;4754.263089221176;4883.99878025004;4889.119958407449;3861.4014827701753;3925.74482658632;3969.960300397017;3991.940120898189;4158.604932531404;1251.3117785218094;1283.1723538317733;1291.8514370847286;1299.7075657977068;1299.8440187177598;898.4025622960788;908.2280061947292;919.3334832246568;925.6528801699362;934.4173763977885;5561.165825126182;5703.686297253691;5706.28671416073;5744.080947048536;5861.120831875252;889.8798662180652;961.4519723757392;973.2700474644017;992.3252188511881;1019.2875968373204;3700.2599480104086;3796.4495148203355;3876.5154355705536;3880.049387899983;3916.7649941003633;10729.463526823627;11043.447827608587;11073.280236784743;11077.058450031676;11103.5558577656;10221.591136354611;10625.415602141957;10950.233483656228;10956;11087.778244435067;8180.427370084156;8228.83542329162;8255.752327430188;8300.252977232078;8316.126806685332;5441.564674826083;5594.0769772987005;5599.300087489064;5696.11710184922;5748.770049198152;10230.28388012832;10276.434796085989;10296.948515257376;10336.17310615134;10389.272750907365;10193;10267.281290309607;10519.94740026295;10592.311499752492;10593.09958653523;7743.961280193563;7848.097468791162;7930.762077137695;8161.265486106279;8174.141715120065;8287.632540630728;8535.189157030072;8540.829183416172;8584.91415085841;8592.269657079218;7458.105027396748;7689.653965571674;7707.306342429209;7735.729249476241;7871;7514.248575142442;7549.490101979516;7575.318221360104;7652.273034061755;7657.693692252247;6628.337166283333;6750.25747167821;6765.221999470124;6771.661416929035;6804.353586409283;4586.243269860569;4894.975525122351;4937.092844000142;4961.751912404293;4968.478309777422;4901;4955.331030310862;4987.9002419950675;5036.697798132123;5065.3161823153405 16:33:16 INFO - PROCESS | 3413 | |4;prototype.html;332.0768264225453;333.08401894789324;334.5466892360851;341.8273771745268;342.967418095281;5653.692589834946;5667;5689.971550142254;5703.486686198241;5703.885922281552;5614.568285087297;5617.517139373584;5623.437656234374;5638.323401191852;5638.605297629158;4156.999999999993;4260.467441569804;4341.261985462479;4370.169667763115;4379.277419225824;4319.848805291816;4323.1353729254115;4341.633809573774;4348.956510434903;4354.97822510887;4301;4339.32740425233;4342.696011279212;4349.630281426083;4352.804123814436;4241.681873859442;4255.97486777748;4308.46144231971;4325.891852703676;4335.176316499855;3774.414965680324;3789.810509474543;3801.3727734923705;3819.675327597158;3856.67218286446;5339.305890234284;5360.597955153379;5370.462953704638;5370.624056316059;5386.353637563518;4979.502049794992;4987.301777751118;4996.800127994876;5010.173321401964;5038.924416133761;5790.85738276836;5834.27071616048;5859.882802343972;5871.236739223917;5904;4228.957710422918;4243.384709217146;4255.234057869582;4301.44081269433;4306.720063195882;5835.912461313083;6159.815205543796;6179.81460556184;6186.84532886677;6190.473809726179;4233.936490952577;4241;4242.384854196186;4257.106007738348;4259.8083086261195;4311.719738217006;4324.2648749712625;4328.43730315057;4330.2638551446325;4348.543402942709;4814.735189564538;5013.473585273494;5052.671576347526;5069.290299358093;5070.645054846199;5998.760049598054;6000.369961154103;6019.428154325332;6048.969755151196;6053.303870054912;1532.2262257560085;1532.8390518995568;1548.9544557423694;1555.3389809330988;1560.134125560325;949.1789601994225;971.155095067296;994.0506815990711;1032.9721926682998;1052.8262836632023;5605.159226116115;5619.595101224694;5621.15682647598;5643.548516118701;5652.236948012048;5967.910481342783;5982.880342393128;5994.310654274727;6021.819345419644;6040.063790112539;5480.7533660985355;5652.123920792284;5695.259616249861;5740.13897915316;5791.218185544982;3208.8716451341684;3226.370857682776;3266.118148100047;3269.199046233688;3281.278118813857;6207.255129384503;6280.811575652738;6334.778282760081;6351.491880649629;6396.744130234832;6174.38256174379;6251.406116419024;6283.183186185766;6356.555041147075;6363.268224154282;6045.516358691294;6234.381559744918;6315.55791094619;6426.646534440557;6430.839229019312;6148.262208534826;6156.538259630635;6157.4458298753325;6163.322034576104;6192.504599631929;5950.018246989372;6046.516278697782;6083.69581520931;6166.599171053867;6211.223597050369;6040.1543783871175;6329.892268853025;6346.746130154742;6396.520260980538;6403.839904002437;4260.339647354665;4261.339492378686;4276.615104640598;4299.204647140289;4308.698391112592;5901.468867801918;6127.908081378694;6133.907991380043;6190.350013248724;6252.499800016079;5989.460948514655;6005.249343832021;6009.587746879567;6066.302375226729;6075.756969721162;5998.550108741774;6013.406447291559;6036.879262414815;6057.42454466825;6091.908621370594;5532.755130095697;5749.770009199585;5898.498627616701;5907.645541267538;5921.3782552831335;6082.330943596113;6087.234701936566;6100.847478813065;6102.643546049566;6156.630602163885;5600.299962504687;5879.911801323069;5901.940980590139;5910.586258961831;6011 16:33:16 INFO - PROCESS | 3413 | |5;yui.html;743.5427212264459;768.5657603454048;787.5786454246977;794.7575989323261;818.3289702443997;13493.122947008438;14452.5664230073;14456.927715361422;14488.348024338904;14515.637109072279;12585.119041667087;12618.684532886682;12642.620721378373;12653.17754345967;12668.493260269579;645.3353046362255;750.9662065207051;768.9807754806119;785.1520358013361;785.2971590426565;762.79785856748;776.596169991604;778.1440415542914;778.4122987144698;781.2031727637806;830.6054624053587;830.983380332393;831.2269589281965;832.4256263178418;835.0730688935276;815.9306458950996;821.0516853034754;824.9051359093721;826.1944604011101;826.8222332198576;600.8407771940439;601.0293376197453;602.921620189377;604.2899592978276;605.9212302400704;13972.860271397258;14089.64775880601;14122.92938535311;14129.929350353183;14134.646633834236;14026.158430494203;14153.858461415357;14199.361028753627;14252.144871307755;14342.92828535861;11312.490937907814;11436.085113190924;11539.826902596467;11642.359670218135;11683.299002059819;3665.816709164531;3702.4631428442726;3714.0714821294678;3736.196717705679;3823.7323387362894;52400;52616.999999999614;53095;53238.46761532374;53446;10471.68584942453;10494.475276236157;10687.786244275227;10768.569257229623;11155.72110697239;18295.45113646566;18393.172307246205;18400.079996000146;18434.170462329228;18516;8113.350931925432;8315.085340612528;8415.158484151536;8429.157084291644;8545.188207120314;4549.977250113729;4590.540945905383;4596.655250856199;4680.087382960358;4815.253635686474;3158.1630867820045;3221.098092534094;3255.6093268807895;3256.0720194744385;3258.038878530839;591.5799782154633;603.8580933480629;609.4027852704374;618.4001518527022;618.4526693875952;644.3942693867749;645.9031145328238;730.2004305285703;754.3738696881685;776.6582703610393;8514.191151840565;8586.527740974307;8691.391602587884;8969.775755606162;9207.95396023029;701.6351497221416;716.126325882433;758.3023618271204;759.5518644000066;764.5145332713766;3991.3214753491975;4096.508418989741;4308.80610372534;4323.6757243206885;4369.169857727022;63621;64103.67948160323;64133.679331603045;64622.67688661526;65085.67457162779;28550.571741423897;28558;45857.541424585324;59259.40740592539;60162.699186503785;54759;54927.450725493036;54947.450525494234;55026.17460738092;55093.72453137789;8365.749027529184;8551.57242137903;8588.22705956467;8609.87085193735;8633.421325026105;34916;36054.8197259012;36214.27571448503;36664.26671466609;37440;43719.56280437282;47445.762771185924;48120.27819582779;48367.51632483771;48391;11014.229003969645;11093.278936869077;11380.54477820878;11636.12729045342;11754.647360579196;12703.745925081632;12738.363081846055;12868.806967895302;12967.675808104495;13041;11563.537458501565;11578.421078946187;11840.644780656594;12165.452554634885;12202.14584979043;11843.11176661771;12079.094067945114;12122.212056216318;12178;12318.445669944695;11463.828042579535;11561.323608076613;11770.411479426166;11974.042076634023;12037.75924481523;9078.954605226932;9229.574077117353;9308.906910931075;9405.764855878384;9473.52632368365;9478.857817132886;9693.70918872435;9865.852012219966;9894.703158905244;9935.453550054528 16:33:16 INFO - PROCESS | 3413 | __end_tp_report 16:33:16 INFO - PROCESS | 3413 | __start_cc_report 16:33:16 INFO - PROCESS | 3413 | _x_x_mozilla_cycle_collect,332 16:33:16 INFO - PROCESS | 3413 | __end_cc_report 16:33:16 INFO - PROCESS | 3413 | __startTimestamp1464651196298__endTimestamp 16:33:16 INFO - PROCESS | 3413 | 16:33:16 INFO - PROCESS | 3413 | ------- Summary: start ------- 16:33:16 INFO - PROCESS | 3413 | Number of tests: 6 16:33:16 INFO - PROCESS | 3413 | 16:33:16 INFO - PROCESS | 3413 | [#0] dojo.html Cycles:165 Average:5314.61 Median:5571.44 stddev:708.29 (12.7%) stddev-sans-first:688.18 16:33:16 INFO - PROCESS | 3413 | Values: 3067.9 3077.3 3122.0 3125.2 3127.0 5269.5 5366.9 5374.8 5391.0 5408.9 5224.5 5275.6 5277.0 5303.7 5375.5 4735.0 4769.8 4867.3 4898.9 4944.2 941.5 4721.7 4766.9 4832.1 4969.9 4835.5 4842.1 4849.9 4860.8 4863.0 4940.9 4945.6 4946.9 4947.0 4984.9 4714.1 4846.7 4867.8 4913.8 4946.7 5342.5 5344.1 5345.9 5368.4 5425.1 5498.6 5883.7 5885.9 5892.4 5894.8 5644.8 5685.8 5712.2 5713.4 5755.5 5365.2 5375.2 5388.7 5405.4 5420.8 5677.3 5856.8 5887.4 5902.0 5914.9 5650.6 5661.0 5672.7 5683.9 5741.7 5760.0 5769.3 5771.1 5783.5 5798.1 5499.3 5639.8 5677.0 5726.0 5774.6 5727.5 5745.4 5749.4 5764.1 5789.9 4331.1 4334.1 4345.1 4348.1 4383.1 3788.0 3840.8 3842.5 3873.3 3900.5 5280.4 5403.8 5450.9 5459.9 5474.7 5785.3 5807.7 5836.7 5844.6 5847.5 5290.3 5456.6 5490.9 5515.6 5525.5 4984.0 4992.3 5017.8 5031.4 5050.5 5940.9 5952.9 5970.9 5973.3 6024.5 5541.2 5751.8 5779.8 5782.9 5846.0 5930.4 5964.7 5968.3 5983.4 5992.1 5502.6 5681.9 5686.1 5692.8 5700.4 5705.5 5710.2 5771.0 5781.5 5784.4 5642.6 5644.1 5644.2 5644.4 5660.7 5442.2 5577.5 5627.9 5631.5 5633.9 5571.4 5582.1 5628.3 5639.7 5692.6 5714.5 5717.5 5728.7 5730.3 5745.1 5358.0 5462.5 5467.7 5620.9 5638.4 16:33:16 INFO - PROCESS | 3413 | 16:33:16 INFO - PROCESS | 3413 | [#1] ext.html Cycles:180 Average:58498.61 Median:22986.00 stddev:118052.21 (513.6%) stddev-sans-first:118303.29 16:33:16 INFO - PROCESS | 3413 | Values: 581.6 627.1 631.1 643.9 658.7 37388.4 42043.0 42496.0 42720.8 42735.8 43575.8 44293.3 44387.8 44643.3 44680.0 8625.5 8731.7 8776.6 8782.3 8806.9 8647.1 8747.9 8756.9 8760.1 8760.3 8721.2 8763.5 8775.9 8790.8 8799.4 8701.3 8753.8 8790.7 8841.4 8851.2 8597.8 8662.6 8663.6 8702.8 8714.8 40390.6 40886.8 41005.8 41258.8 41379.8 3036.6 3215.6 3309.9 3395.5 3473.5 30417.7 31151.4 31265.8 31282.2 31398.7 4070.7 4093.7 4179.6 4300.7 4317.8 285624.0 289507.0 291386.0 291525.4 291676.0 33454.5 34307.8 34559.5 34928.0 35206.5 36713.0 36921.6 37103.8 37110.4 37112.3 14131.2 14133.0 14229.9 14265.3 14266.0 11889.5 11947.9 11966.7 11974.1 11976.0 8215.9 8240.9 8246.2 8294.1 8396.2 3224.3 3232.8 3287.2 3300.7 3312.1 999.3 1019.3 1023.9 1044.8 1058.9 31622.2 31677.4 31909.8 32075.0 32472.5 1073.1 1080.2 1110.4 1129.5 1152.8 16185.4 16604.0 16671.6 16736.3 16937.3 517937.0 518939.0 522662.0 522815.0 523594.0 55670.7 57200.7 57264.0 57736.7 57808.0 1307.3 1400.6 1427.9 1430.2 1433.9 30117.5 35403.5 35440.3 36145.6 36997.4 54790.5 55904.0 55912.7 59063.4 59462.4 479715.0 482168.0 486776.0 488231.0 488795.0 44226.0 45106.8 46532.5 46581.3 46633.5 49466.5 49481.5 49532.3 49821.3 50169.0 41396.6 43907.0 43952.6 44045.6 44068.6 41792.4 42428.0 42443.2 42458.4 43269.5 40905.0 41696.0 41983.6 42084.4 42527.1 35835.5 37488.3 37756.4 37948.4 38575.4 28555.6 28663.0 28863.7 29087.7 29204.0 16:33:16 INFO - PROCESS | 3413 | 16:33:16 INFO - PROCESS | 3413 | [#2] jquery.html Cycles:180 Average:22329.37 Median:2241.04 stddev:49323.68 (2200.9%) stddev-sans-first:49434.50 16:33:16 INFO - PROCESS | 3413 | Values: 373.9 376.0 393.7 401.0 410.0 16941.2 18624.7 19673.3 19771.3 19774.1 10924.5 11536.8 18367.8 18722.8 18777.5 5134.6 5287.0 5288.6 5310.5 5316.4 3866.1 5494.6 5768.9 5784.1 5867.0 5776.4 5844.2 5845.4 5857.6 5860.5 5676.9 5786.5 5803.4 5817.2 5818.3 5476.6 5618.9 5619.0 5756.6 5758.0 13309.3 13407.5 16263.7 22850.2 23021.9 2154.9 2229.1 2253.0 2262.0 2462.4 9894.7 9972.0 10044.4 10086.9 10254.7 1873.9 1926.3 1927.2 1962.6 1968.8 79820.6 82271.0 82965.0 83097.0 83663.0 10323.0 10626.6 10724.6 10839.4 10982.5 15072.7 15085.2 15209.6 15248.4 15274.5 7703.1 8025.8 8032.7 8079.8 8154.5 7521.4 7694.8 7696.6 7751.1 8016.6 4524.3 4568.3 4631.6 4633.4 4745.8 1631.6 1659.6 1714.7 1720.1 1729.8 910.7 974.8 984.2 1106.7 1164.3 18291.4 18836.8 18973.1 19103.1 19224.4 990.4 991.0 1015.3 1050.8 1062.0 10654.5 10949.7 11055.0 11088.2 11098.9 221816.0 222727.0 226362.0 227123.0 459903.0 61084.0 76195.6 91025.5 100296.0 100614.0 1020.3 1027.5 1064.3 1066.1 1072.6 17387.4 17833.8 18019.8 18164.5 18347.3 41820.6 42731.9 43251.8 43809.1 43914.1 49286.5 49791.0 51066.5 58082.4 58514.1 8363.0 8715.0 8736.7 8751.5 8791.3 11005.2 12446.8 12619.6 12634.0 13145.5 10930.3 10991.8 11033.2 11039.0 11060.3 11018.0 11038.1 11063.4 11206.3 11241.2 8733.0 11092.2 11409.7 11468.6 11496.8 8607.5 8718.3 8781.9 8859.0 9036.8 10386.8 11114.9 11115.8 11308.0 11318.3 16:33:16 INFO - PROCESS | 3413 | 16:33:16 INFO - PROCESS | 3413 | [#3] mootools.html Cycles:180 Average:5705.64 Median:4673.82 stddev:3290.16 (70.4%) stddev-sans-first:3284.25 16:33:16 INFO - PROCESS | 3413 | Values: 1504.6 1532.6 1665.6 1798.9 1813.1 7425.1 7902.8 8047.3 8563.6 8587.7 7909.4 8078.8 8146.3 8172.5 8191.0 2254.2 2282.5 2285.4 2288.5 2294.0 2189.0 2193.7 2226.0 2238.6 2244.4 2198.0 2205.7 2207.7 2215.6 2224.2 2095.7 2102.3 2106.3 2112.1 2120.0 2148.6 2154.0 2184.5 2233.3 2235.3 8027.5 8115.0 8131.0 8139.6 8141.0 5166.4 5238.2 5293.4 5297.1 5299.6 3183.8 3264.3 3356.2 3376.5 3417.4 1110.5 1138.9 1147.7 1150.1 1175.5 12268.3 12312.3 12313.4 12314.3 12326.6 4578.9 4643.6 4704.0 4718.5 4755.8 10300.9 10324.2 10333.6 10338.2 10347.3 5211.9 5277.6 5284.6 5300.4 5321.9 4108.0 4604.7 4754.3 4884.0 4889.1 3861.4 3925.7 3970.0 3991.9 4158.6 1251.3 1283.2 1291.9 1299.7 1299.8 898.4 908.2 919.3 925.7 934.4 5561.2 5703.7 5706.3 5744.1 5861.1 889.9 961.5 973.3 992.3 1019.3 3700.3 3796.4 3876.5 3880.0 3916.8 10729.5 11043.4 11073.3 11077.1 11103.6 10221.6 10625.4 10950.2 10956.0 11087.8 8180.4 8228.8 8255.8 8300.3 8316.1 5441.6 5594.1 5599.3 5696.1 5748.8 10230.3 10276.4 10296.9 10336.2 10389.3 10193.0 10267.3 10519.9 10592.3 10593.1 7744.0 7848.1 7930.8 8161.3 8174.1 8287.6 8535.2 8540.8 8584.9 8592.3 7458.1 7689.7 7707.3 7735.7 7871.0 7514.2 7549.5 7575.3 7652.3 7657.7 6628.3 6750.3 6765.2 6771.7 6804.4 4586.2 4895.0 4937.1 4961.8 4968.5 4901.0 4955.3 4987.9 5036.7 5065.3 16:33:16 INFO - PROCESS | 3413 | 16:33:16 INFO - PROCESS | 3413 | [#4] prototype.html Cycles:180 Average:4992.06 Median:5652.96 stddev:1489.33 (26.3%) stddev-sans-first:1451.86 16:33:16 INFO - PROCESS | 3413 | Values: 332.1 333.1 334.5 341.8 343.0 5653.7 5667.0 5690.0 5703.5 5703.9 5614.6 5617.5 5623.4 5638.3 5638.6 4157.0 4260.5 4341.3 4370.2 4379.3 4319.8 4323.1 4341.6 4349.0 4355.0 4301.0 4339.3 4342.7 4349.6 4352.8 4241.7 4256.0 4308.5 4325.9 4335.2 3774.4 3789.8 3801.4 3819.7 3856.7 5339.3 5360.6 5370.5 5370.6 5386.4 4979.5 4987.3 4996.8 5010.2 5038.9 5790.9 5834.3 5859.9 5871.2 5904.0 4229.0 4243.4 4255.2 4301.4 4306.7 5835.9 6159.8 6179.8 6186.8 6190.5 4233.9 4241.0 4242.4 4257.1 4259.8 4311.7 4324.3 4328.4 4330.3 4348.5 4814.7 5013.5 5052.7 5069.3 5070.6 5998.8 6000.4 6019.4 6049.0 6053.3 1532.2 1532.8 1549.0 1555.3 1560.1 949.2 971.2 994.1 1033.0 1052.8 5605.2 5619.6 5621.2 5643.5 5652.2 5967.9 5982.9 5994.3 6021.8 6040.1 5480.8 5652.1 5695.3 5740.1 5791.2 3208.9 3226.4 3266.1 3269.2 3281.3 6207.3 6280.8 6334.8 6351.5 6396.7 6174.4 6251.4 6283.2 6356.6 6363.3 6045.5 6234.4 6315.6 6426.6 6430.8 6148.3 6156.5 6157.4 6163.3 6192.5 5950.0 6046.5 6083.7 6166.6 6211.2 6040.2 6329.9 6346.7 6396.5 6403.8 4260.3 4261.3 4276.6 4299.2 4308.7 5901.5 6127.9 6133.9 6190.4 6252.5 5989.5 6005.2 6009.6 6066.3 6075.8 5998.6 6013.4 6036.9 6057.4 6091.9 5532.8 5749.8 5898.5 5907.6 5921.4 6082.3 6087.2 6100.8 6102.6 6156.6 5600.3 5879.9 5901.9 5910.6 6011.0 16:33:16 INFO - PROCESS | 3413 | 16:33:16 INFO - PROCESS | 3413 | [#5] yui.html Cycles:180 Average:14533.83 Median:26591.38 stddev:17222.76 (64.8%) stddev-sans-first:17239.94 16:33:16 INFO - PROCESS | 3413 | Values: 743.5 768.6 787.6 794.8 818.3 13493.1 14452.6 14456.9 14488.3 14515.6 12585.1 12618.7 12642.6 12653.2 12668.5 645.3 751.0 769.0 785.2 785.3 762.8 776.6 778.1 778.4 781.2 830.6 831.0 831.2 832.4 835.1 815.9 821.1 824.9 826.2 826.8 600.8 601.0 602.9 604.3 605.9 13972.9 14089.6 14122.9 14129.9 14134.6 14026.2 14153.9 14199.4 14252.1 14342.9 11312.5 11436.1 11539.8 11642.4 11683.3 3665.8 3702.5 3714.1 3736.2 3823.7 52400.0 52617.0 53095.0 53238.5 53446.0 10471.7 10494.5 10687.8 10768.6 11155.7 18295.5 18393.2 18400.1 18434.2 18516.0 8113.4 8315.1 8415.2 8429.2 8545.2 4550.0 4590.5 4596.7 4680.1 4815.3 3158.2 3221.1 3255.6 3256.1 3258.0 591.6 603.9 609.4 618.4 618.5 644.4 645.9 730.2 754.4 776.7 8514.2 8586.5 8691.4 8969.8 9208.0 701.6 716.1 758.3 759.6 764.5 3991.3 4096.5 4308.8 4323.7 4369.2 63621.0 64103.7 64133.7 64622.7 65085.7 28550.6 28558.0 45857.5 59259.4 60162.7 54759.0 54927.5 54947.5 55026.2 55093.7 8365.7 8551.6 8588.2 8609.9 8633.4 34916.0 36054.8 36214.3 36664.3 37440.0 43719.6 47445.8 48120.3 48367.5 48391.0 11014.2 11093.3 11380.5 11636.1 11754.6 12703.7 12738.4 12868.8 12967.7 13041.0 11563.5 11578.4 11840.6 12165.5 12202.1 11843.1 12079.1 12122.2 12178.0 12318.4 11463.8 11561.3 11770.4 11974.0 12037.8 9079.0 9229.6 9308.9 9405.8 9473.5 9478.9 9693.7 9865.9 9894.7 9935.5 16:33:16 INFO - PROCESS | 3413 | -------- Summary: end -------- 16:33:16 INFO - PROCESS | 3413 | 16:33:16 INFO - TEST-INFO | 3413: exit 0 16:33:16 INFO - TEST-OK | dromaeo_css | took 1111867ms 16:33:16 INFO - TEST-START | kraken 16:33:16 INFO - operating with platform_type : linux_ 16:33:16 INFO - Initialising browser for kraken test... 16:33:17 INFO - TEST-INFO | started process 3652 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOPFNy2/profile http://localhost:60596/getInfo.html) 16:33:21 INFO - PROCESS | 3652 | __metrics Screen width/height:1600/1200 16:33:21 INFO - PROCESS | 3652 | colorDepth:24 16:33:21 INFO - PROCESS | 3652 | Browser inner width/height: 1024/697 16:33:21 INFO - PROCESS | 3652 | __metrics 16:33:22 ERROR - PROCESS | 3652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 16:33:23 INFO - TEST-INFO | 3652: exit 0 16:33:23 INFO - Browser initialized. 16:33:23 INFO - Running cycle 1/1 for kraken test... 16:33:23 INFO - TEST-INFO | started process 3770 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOPFNy2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:33:34 INFO - PROCESS | 3770 | RSS: Main: 166469632 16:33:34 INFO - PROCESS | 3770 | 16:33:37 INFO - PROCESS | 3770 | Cycle 1(1): loaded http://localhost:60596/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60596/tests/kraken/driver.html?testName=audio-beat-detection) 16:33:38 INFO - PROCESS | 3770 | RSS: Main: 172056576 16:33:38 INFO - PROCESS | 3770 | 16:33:41 INFO - PROCESS | 3770 | Cycle 1(1): loaded http://localhost:60596/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60596/tests/kraken/driver.html?testName=audio-dft) 16:33:41 INFO - PROCESS | 3770 | RSS: Main: 171614208 16:33:41 INFO - PROCESS | 3770 | 16:33:44 INFO - PROCESS | 3770 | Cycle 1(1): loaded http://localhost:60596/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60596/tests/kraken/driver.html?testName=audio-fft) 16:33:45 INFO - PROCESS | 3770 | RSS: Main: 166141952 16:33:45 INFO - PROCESS | 3770 | 16:33:47 INFO - PROCESS | 3770 | Cycle 1(1): loaded http://localhost:60596/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60596/tests/kraken/driver.html?testName=audio-oscillator) 16:33:48 INFO - PROCESS | 3770 | RSS: Main: 166883328 16:33:48 INFO - PROCESS | 3770 | 16:33:50 INFO - PROCESS | 3770 | Cycle 1(1): loaded http://localhost:60596/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60596/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:33:50 INFO - PROCESS | 3770 | RSS: Main: 167321600 16:33:50 INFO - PROCESS | 3770 | 16:33:54 INFO - PROCESS | 3770 | Cycle 1(1): loaded http://localhost:60596/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60596/tests/kraken/driver.html?testName=imaging-darkroom) 16:33:54 INFO - PROCESS | 3770 | RSS: Main: 167575552 16:33:54 INFO - PROCESS | 3770 | 16:33:58 INFO - PROCESS | 3770 | Cycle 1(1): loaded http://localhost:60596/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60596/tests/kraken/driver.html?testName=imaging-desaturate) 16:33:58 INFO - PROCESS | 3770 | RSS: Main: 165048320 16:33:58 INFO - PROCESS | 3770 | 16:34:01 INFO - PROCESS | 3770 | Cycle 1(1): loaded http://localhost:60596/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60596/tests/kraken/driver.html?testName=json-parse-financial) 16:34:02 INFO - PROCESS | 3770 | RSS: Main: 166690816 16:34:02 INFO - PROCESS | 3770 | 16:34:03 INFO - PROCESS | 3770 | Cycle 1(1): loaded http://localhost:60596/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60596/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:34:04 INFO - PROCESS | 3770 | RSS: Main: 166985728 16:34:04 INFO - PROCESS | 3770 | 16:34:06 INFO - PROCESS | 3770 | Cycle 1(1): loaded http://localhost:60596/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60596/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:34:06 INFO - PROCESS | 3770 | RSS: Main: 167395328 16:34:06 INFO - PROCESS | 3770 | 16:34:08 INFO - PROCESS | 3770 | Cycle 1(1): loaded http://localhost:60596/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60596/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:34:09 INFO - PROCESS | 3770 | RSS: Main: 167723008 16:34:09 INFO - PROCESS | 3770 | 16:34:12 INFO - PROCESS | 3770 | Cycle 1(1): loaded http://localhost:60596/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60596/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:34:12 INFO - PROCESS | 3770 | RSS: Main: 167452672 16:34:12 INFO - PROCESS | 3770 | 16:34:15 INFO - PROCESS | 3770 | Cycle 1(1): loaded http://localhost:60596/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60596/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:34:16 INFO - PROCESS | 3770 | RSS: Main: 167698432 16:34:16 INFO - PROCESS | 3770 | 16:34:17 INFO - PROCESS | 3770 | Cycle 1(1): loaded http://localhost:60596/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60596/tests/kraken/driver.html?testName=ai-astar) 16:34:18 INFO - PROCESS | 3770 | RSS: Main: 168714240 16:34:18 INFO - PROCESS | 3770 | 16:34:18 INFO - PROCESS | 3770 | __start_tp_report 16:34:18 INFO - PROCESS | 3770 | _x_x_mozilla_page_load 16:34:18 INFO - PROCESS | 3770 | _x_x_mozilla_page_load_details 16:34:18 INFO - PROCESS | 3770 | |i|pagename|runs| 16:34:18 INFO - PROCESS | 3770 | |0;ai-astar;112;105;111;110;113;111;111;111;111;112 16:34:18 INFO - PROCESS | 3770 | |1;audio-beat-detection;151;123;167;187;135;150;159;132;178;126 16:34:18 INFO - PROCESS | 3770 | |2;audio-dft;163;161;165;163;163;168;170;160;160;160 16:34:18 INFO - PROCESS | 3770 | |3;audio-fft;74;75;76;157;74;78;75;75;168;77 16:34:18 INFO - PROCESS | 3770 | |4;audio-oscillator;83;87;148;84;84;85;137;84;83;141 16:34:18 INFO - PROCESS | 3770 | |5;imaging-gaussian-blur;117;119;117;118;118;117;117;117;118;118 16:34:18 INFO - PROCESS | 3770 | |6;imaging-darkroom;147;148;148;147;149;147;147;146;147;147 16:34:18 INFO - PROCESS | 3770 | |7;imaging-desaturate;96;96;96;96;96;96;95;96;96;101 16:34:18 INFO - PROCESS | 3770 | |8;json-parse-financial;55;59;54;55;54;56;63;53;61;55 16:34:18 INFO - PROCESS | 3770 | |9;json-stringify-tinderbox;61;62;62;61;62;62;62;62;63;62 16:34:18 INFO - PROCESS | 3770 | |10;stanford-crypto-aes;82;85;79;81;80;88;83;82;114;86 16:34:18 INFO - PROCESS | 3770 | |11;stanford-crypto-ccm;139;122;131;130;132;125;139;122;133;125 16:34:18 INFO - PROCESS | 3770 | |12;stanford-crypto-pbkdf2;169;164;166;158;161;170;161;159;158;159 16:34:18 INFO - PROCESS | 3770 | |13;stanford-crypto-sha256-iterative;69;62;64;63;62;66;63;63;63;61 16:34:18 INFO - PROCESS | 3770 | __end_tp_report 16:34:18 INFO - PROCESS | 3770 | __start_cc_report 16:34:18 INFO - PROCESS | 3770 | _x_x_mozilla_cycle_collect,867 16:34:18 INFO - PROCESS | 3770 | __end_cc_report 16:34:18 INFO - PROCESS | 3770 | __startTimestamp1464651258110__endTimestamp 16:34:18 INFO - PROCESS | 3770 | 16:34:18 INFO - PROCESS | 3770 | ------- Summary: start ------- 16:34:18 INFO - PROCESS | 3770 | Number of tests: 14 16:34:18 INFO - PROCESS | 3770 | 16:34:18 INFO - PROCESS | 3770 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:2.16 (1.9%) stddev-sans-first:2.24 16:34:18 INFO - PROCESS | 3770 | Values: 112.0 105.0 111.0 110.0 113.0 111.0 111.0 111.0 111.0 112.0 16:34:18 INFO - PROCESS | 3770 | 16:34:18 INFO - PROCESS | 3770 | [#1] audio-beat-detection Cycles:10 Average:150.80 Median:155.00 stddev:22.04 (14.2%) stddev-sans-first:23.38 16:34:18 INFO - PROCESS | 3770 | Values: 151.0 123.0 167.0 187.0 135.0 150.0 159.0 132.0 178.0 126.0 16:34:18 INFO - PROCESS | 3770 | 16:34:18 INFO - PROCESS | 3770 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.00 stddev:3.47 (2.1%) stddev-sans-first:3.67 16:34:18 INFO - PROCESS | 3770 | Values: 163.0 161.0 165.0 163.0 163.0 168.0 170.0 160.0 160.0 160.0 16:34:18 INFO - PROCESS | 3770 | 16:34:18 INFO - PROCESS | 3770 | [#3] audio-fft Cycles:10 Average:92.90 Median:75.00 stddev:36.80 (49.1%) stddev-sans-first:38.39 16:34:18 INFO - PROCESS | 3770 | Values: 74.0 75.0 76.0 157.0 74.0 78.0 75.0 75.0 168.0 77.0 16:34:18 INFO - PROCESS | 3770 | 16:34:18 INFO - PROCESS | 3770 | [#4] audio-oscillator Cycles:10 Average:101.60 Median:84.00 stddev:28.02 (33.4%) stddev-sans-first:28.91 16:34:18 INFO - PROCESS | 3770 | Values: 83.0 87.0 148.0 84.0 84.0 85.0 137.0 84.0 83.0 141.0 16:34:18 INFO - PROCESS | 3770 | 16:34:18 INFO - PROCESS | 3770 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 16:34:18 INFO - PROCESS | 3770 | Values: 117.0 119.0 117.0 118.0 118.0 117.0 117.0 117.0 118.0 118.0 16:34:18 INFO - PROCESS | 3770 | 16:34:18 INFO - PROCESS | 3770 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 16:34:18 INFO - PROCESS | 3770 | Values: 147.0 148.0 148.0 147.0 149.0 147.0 147.0 146.0 147.0 147.0 16:34:18 INFO - PROCESS | 3770 | 16:34:18 INFO - PROCESS | 3770 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:1.65 (1.7%) stddev-sans-first:1.74 16:34:18 INFO - PROCESS | 3770 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 101.0 16:34:18 INFO - PROCESS | 3770 | 16:34:18 INFO - PROCESS | 3770 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:55.50 stddev:3.34 (6.0%) stddev-sans-first:3.50 16:34:18 INFO - PROCESS | 3770 | Values: 55.0 59.0 54.0 55.0 54.0 56.0 63.0 53.0 61.0 55.0 16:34:18 INFO - PROCESS | 3770 | 16:34:18 INFO - PROCESS | 3770 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 16:34:18 INFO - PROCESS | 3770 | Values: 61.0 62.0 62.0 61.0 62.0 62.0 62.0 62.0 63.0 62.0 16:34:18 INFO - PROCESS | 3770 | 16:34:18 INFO - PROCESS | 3770 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:82.50 stddev:10.22 (12.4%) stddev-sans-first:10.74 16:34:18 INFO - PROCESS | 3770 | Values: 82.0 85.0 79.0 81.0 80.0 88.0 83.0 82.0 114.0 86.0 16:34:18 INFO - PROCESS | 3770 | 16:34:18 INFO - PROCESS | 3770 | [#11] stanford-crypto-ccm Cycles:10 Average:129.80 Median:131.50 stddev:6.27 (4.8%) stddev-sans-first:5.70 16:34:18 INFO - PROCESS | 3770 | Values: 139.0 122.0 131.0 130.0 132.0 125.0 139.0 122.0 133.0 125.0 16:34:18 INFO - PROCESS | 3770 | 16:34:18 INFO - PROCESS | 3770 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.50 Median:162.50 stddev:4.50 (2.8%) stddev-sans-first:4.12 16:34:18 INFO - PROCESS | 3770 | Values: 169.0 164.0 166.0 158.0 161.0 170.0 161.0 159.0 158.0 159.0 16:34:18 INFO - PROCESS | 3770 | 16:34:18 INFO - PROCESS | 3770 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:63.00 stddev:2.32 (3.7%) stddev-sans-first:1.41 16:34:18 INFO - PROCESS | 3770 | Values: 69.0 62.0 64.0 63.0 62.0 66.0 63.0 63.0 63.0 61.0 16:34:18 INFO - PROCESS | 3770 | -------- Summary: end -------- 16:34:18 INFO - PROCESS | 3770 | 16:34:19 INFO - TEST-INFO | 3770: exit 0 16:34:19 INFO - TEST-OK | kraken | took 62092ms 16:34:19 INFO - SUITE-END | took 1173s 16:34:19 INFO - Completed test suite (00:19:34) 16:34:19 INFO - javascript benchmark 16:34:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6998.557736330719, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3067.8772849086035, 3077.26145725026, 3122.0, 3125.23431759219, 3127.046250893478, 5269.525742683162, 5366.865828354288, 5374.811881584141, 5391.029614669358, 5408.945910540893, 5224.503672151149, 5275.577953763699, 5277.023750606131, 5303.7348132593315, 5375.516203541681, 4734.999999999992, 4769.809207631691, 4867.318575399447, 4898.853034408956, 4944.233643785219, 941.4966641778459, 4721.716696998191, 4766.9284960725445, 4832.081904438145, 4969.925451118236, 4835.468098509161, 4842.1042107210105, 4849.927251091236, 4860.8055677772845, 4862.975685121552, 4940.851774446773, 4945.604351651859, 4946.851594452172, 4947.03532811102, 4984.900301993976, 4714.057188562301, 4846.709197448165, 4867.829625963074, 4913.778879950375, 4946.703197808143, 5342.492463216027, 5344.14493681013, 5345.946540534623, 5368.382635996872, 5425.050616142159, 5498.642588231752, 5883.735231914574, 5885.941140588582, 5892.410758924116, 5894.764209431618, 5644.774209031675, 5685.772569097231, 5712.22884910536, 5713.400092990218, 5755.453231943001, 5365.248865158881, 5375.247465354853, 5388.703621300866, 5405.405405405402, 5420.783168673288, 5677.347105082886, 5856.824295271149, 5887.4406931341455, 5902.0, 5914.940850591525, 5650.604457688005, 5661.037623603997, 5672.716364181774, 5683.920055189584, 5741.684207368635, 5760.049591817387, 5769.278840144982, 5771.105478650816, 5783.450572195635, 5798.072308430631, 5499.257600223918, 5639.774409023676, 5676.971615141898, 5725.971370143123, 5774.595778295563, 5727.513161381329, 5745.425457454221, 5749.3963133871175, 5764.106563482667, 5789.913151302734, 4331.0904710011255, 4334.089841133335, 4345.065810850619, 4348.130373925228, 4383.101464199895, 3787.981060094682, 3840.7887566184127, 3842.538895332522, 3873.341531939577, 3900.531936167621, 5280.3663560373, 5403.83788486346, 5450.863728406822, 5459.918101228484, 5474.671519708831, 5785.305763308345, 5807.651540907559, 5836.737346819404, 5844.561657875592, 5847.532197424196, 5290.338707661543, 5456.61803673739, 5490.91763623538, 5515.558755299567, 5525.502704756591, 4983.950160498421, 4992.2511623256805, 5017.849464515997, 5031.396232452129, 5050.49495050492, 5940.940590594125, 5952.8809423812145, 5970.925233457932, 5973.313068997121, 6024.518038556905, 5541.196526503715, 5751.827445176651, 5779.768809247583, 5782.884342313214, 5846.035404158436, 5930.406959304035, 5964.731587078505, 5968.313643931004, 5983.37174596661, 5992.0712289595185, 5502.58730595199, 5681.886362272814, 5686.09022556389, 5692.829215123553, 5700.372958974426, 5705.486506214461, 5710.200571920018, 5771.047777116729, 5781.4507621775865, 5784.392638773036, 5642.633228840113, 5644.125160600113, 5644.181593668977, 5644.435556444323, 5660.660360378391, 5442.210879422382, 5577.525910297508, 5627.8874422512135, 5631.521320687787, 5633.943660563342, 5571.4428557143965, 5582.078956972054, 5628.324601047737, 5639.718014099197, 5692.5730570208225, 5714.542836573148, 5717.514011308919, 5728.742206600797, 5730.255066841284, 5745.080787074048, 5358.035553600389, 5462.481064298885, 5467.7266136692215, 5620.915686264628, 5638.407967163553], "value": 5267.186417830258, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.6393835821789, 627.0907184582355, 631.1447987976292, 643.9291677915428, 658.6772481484074, 37388.439173412386, 42043.0, 42496.0, 42720.786396067975, 42735.78632106839, 43575.78212108935, 44293.33559996595, 44387.77806110973, 44643.33035004477, 44680.0, 8625.48247105174, 8731.650733970633, 8776.64893404263, 8782.341324400664, 8806.911930880706, 8647.092055334193, 8747.868781968276, 8756.868646970268, 8760.12398760122, 8760.299176065899, 8721.171488708562, 8763.474191548528, 8775.912240877606, 8790.780230494256, 8799.428037177595, 8701.260392866614, 8753.824923501526, 8790.6923257686, 8841.381103322705, 8851.203391694746, 8597.785055373603, 8662.566871656392, 8663.566821658955, 8702.825943481159, 8714.782130446789, 40390.59609403898, 40886.79556602198, 41005.79497102525, 41258.793706031574, 41379.7931010343, 3036.620422447194, 3215.630202526716, 3309.8841540546205, 3395.4906763985355, 3473.531073305097, 30417.695823041708, 31151.376972460424, 31265.8436707815, 31282.21794455134, 31398.68601314003, 4070.6743460523385, 4093.692973027035, 4179.623833854967, 4300.677449191292, 4317.827286908519, 285624.0, 289507.0, 291386.0, 291525.42372881057, 291676.0, 33454.498182527284, 34307.828460857534, 34559.4816077759, 34928.0, 35206.471902921476, 36713.0, 36921.63078369182, 37103.81448092742, 37110.44334334933, 37112.25775484475, 14131.15213087218, 14133.0, 14229.92885035589, 14265.286735663176, 14266.0, 11889.464974076187, 11947.880521194676, 11966.700832479084, 11974.101942354358, 11976.041916646647, 8215.876761848576, 8240.887480190217, 8246.175382461826, 8294.129116442808, 8396.202360775716, 3224.290656055664, 3232.8383580821337, 3287.2439338952177, 3300.702936735657, 3312.089175476715, 999.2655398282257, 1019.3017782818793, 1023.889080347816, 1044.8014877173314, 1058.9470526473644, 31622.209444763605, 31677.366452670816, 31909.840450797597, 32075.0, 32472.512912306334, 1073.1039581949003, 1080.1682704317632, 1110.3892858927557, 1129.5481807277156, 1152.844366010578, 16185.364000759631, 16604.0, 16671.583210419838, 16736.330546778237, 16937.32250709958, 517937.0, 518939.0, 522662.0, 522815.0, 523594.0, 55670.72164639151, 57200.71399643058, 57264.0, 57736.71131644399, 57808.0, 1307.2875282970804, 1400.6008287638178, 1427.9000469967002, 1430.227677054379, 1433.8924580656492, 30117.548236776027, 35403.46894796529, 35440.29119417649, 36145.63854361423, 36997.44503832391, 54790.45209547853, 55904.0, 55912.720436397554, 59063.40936590579, 59462.40537594569, 479715.0, 482168.0, 486776.0, 488231.0, 488795.0, 44226.019658230915, 45106.77446612746, 46532.534674654176, 46581.30128048014, 46633.533664664275, 49466.50533494763, 49481.50518494913, 49532.25701614551, 49821.252681210535, 50169.0, 41396.586034139276, 43907.0, 43952.56047439612, 44045.55954440415, 44068.55931440773, 41792.3731144027, 42428.0, 42443.15113697647, 42458.363124553776, 43269.5384369256, 40905.0, 41696.0, 41983.580164199186, 42084.36873446962, 42527.14945701007, 35835.46246806248, 37488.25023499569, 37756.43365349577, 37948.430773538974, 38575.42136867893, 28555.571666425436, 28663.0, 28863.7113628861, 29087.7091229085, 29204.0], "value": 18853.84658372057, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.8971782759742, 376.02046668428744, 393.65161831778875, 401.03550959941333, 410.0343690608619, 16941.237644306006, 18624.72062919057, 19673.31143409983, 19771.308004219856, 19774.11016504257, 10924.508397122128, 11536.826947595793, 18367.816321836777, 18722.81277187228, 18777.530561735963, 5134.614903882214, 5287.048331300364, 5288.629795914288, 5310.548603368718, 5316.38861530925, 3866.130120722829, 5494.587905907073, 5768.855778605526, 5784.13238014297, 5867.031939729939, 5776.364599894008, 5844.152597873327, 5845.415458454163, 5857.560682948774, 5860.472557469827, 5676.943230567683, 5786.450287222707, 5803.361630220694, 5817.214676018768, 5818.330891947417, 5476.58925580579, 5618.859528511779, 5618.971905140448, 5756.597038207327, 5758.0, 13309.33633295838, 13407.530736424276, 16263.674726505522, 22850.200242991414, 23021.88489057544, 2154.859934104278, 2229.108356657334, 2252.977470225293, 2261.9886900565557, 2462.372095115734, 9894.703158905244, 9972.0, 10044.397336159855, 10086.89913100867, 10254.7436314092, 1873.8594605404649, 1926.2872737087368, 1927.152053096633, 1962.5976674781778, 1968.8326492248177, 79820.60089699572, 82271.0, 82965.0, 83097.0, 83663.0, 10323.0, 10626.574937002433, 10724.571017159225, 10839.403832789114, 10982.505787239594, 15072.698546029238, 15085.24573771329, 15209.6197595061, 15248.390064397521, 15274.465393711389, 7703.114141873644, 8025.839483210303, 8032.718854840053, 8079.838403231903, 8154.510729356258, 7521.398288136936, 7694.807629809299, 7696.576688282086, 7751.147373788879, 8016.599170041474, 4524.321351797257, 4568.33759104928, 4631.5642150932645, 4633.4208223972, 4745.786439610226, 1631.575790294532, 1659.6016955930731, 1714.6999275126802, 1720.1055451165573, 1729.7805047441523, 910.717677519971, 974.7611835100446, 984.1831280037552, 1106.6808523331706, 1164.2548768787983, 18291.359802407118, 18836.81163188378, 18973.146208420654, 19103.140358683893, 19224.423267302005, 990.3661656539821, 990.9752256193509, 1015.2690063154517, 1050.8318669012922, 1061.9681409557725, 10654.467276636136, 10949.726256843642, 11055.0, 11088.168387370979, 11098.889011109786, 221816.0, 222727.0, 226362.0, 227123.0, 459903.0, 61084.0, 76195.61902190454, 91025.54487227522, 100296.0, 100614.0, 1020.3469779341227, 1027.5067967375553, 1064.3081996702206, 1066.1470823341297, 1072.6245813965206, 17387.391441299493, 17833.821661783735, 18019.81980180234, 18164.45506634803, 18347.26610935601, 41820.58179418167, 42731.931701707705, 43251.78374108109, 43809.12381752411, 43914.12171756483, 49286.50713492819, 49791.0, 51066.48933510618, 58082.4191758077, 58514.14858514114, 8362.958185209034, 8715.0, 8736.694215702673, 8751.518666473405, 8791.34064945119, 11005.229633925548, 12446.751064978831, 12619.621411357673, 12634.0, 13145.474181032652, 10930.344179349264, 10991.835122473009, 11033.172512061788, 11039.0, 11060.292713967445, 11018.0, 11038.11695064409, 11063.391513466515, 11206.271592346471, 11241.213115081866, 8732.956335218283, 11092.223544351818, 11409.657710268706, 11468.598599048993, 11496.827547586625, 8607.526586037828, 8718.346124040596, 8781.912180878366, 8858.98121716011, 9036.81926361456, 10386.792264154827, 11114.888851111386, 11115.833262500908, 11308.0, 11318.26431281964], "value": 8791.361049249608, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1504.593759684885, 1532.5555588879226, 1665.5752783040323, 1798.9460316190518, 1813.138759089432, 7425.108986921577, 7902.802429939255, 8047.315978141858, 8563.61463734132, 8587.65649374025, 7909.367250619951, 8078.838423231532, 8146.26683598476, 8172.468789528676, 8190.9590452047805, 2254.1884921428273, 2282.4864405508793, 2285.371522831218, 2288.4622113803243, 2293.9655905161435, 2188.9562208755897, 2193.7257842769654, 2226.0, 2238.5746708125403, 2244.36035729817, 2197.9560408791813, 2205.7353117625908, 2207.701960235364, 2215.590115828577, 2224.1992882562263, 2095.738032745907, 2102.2536999365157, 2106.2838634864142, 2112.10235649849, 2119.9788002120013, 2148.602508535926, 2154.0199209359703, 2184.541246338271, 2233.274185889576, 2235.3294011796397, 8027.478213916077, 8115.0, 8130.959345203295, 8139.633716482773, 8140.959295203486, 5166.43169251382, 5238.1618940969265, 5293.444188360244, 5297.073012222884, 5299.5760339172775, 3183.761217908643, 3264.3308121834966, 3356.16095976006, 3376.5272861799367, 3417.40195465795, 1110.545185806596, 1138.8861113888545, 1147.65570328901, 1150.0626989003936, 1175.4534141624101, 12268.263904165779, 12312.26126432408, 12313.384330783514, 12314.261144331369, 12326.568570100093, 4578.931316030262, 4643.628509719214, 4704.012157446974, 4718.504557021532, 4755.785989630475, 10300.896991030144, 10324.174066074696, 10333.638322658671, 10338.172946164439, 10347.327423717434, 5211.905499844999, 5277.577793776489, 5284.630075894651, 5300.390455097713, 5321.920171197435, 4107.97946010274, 4604.654650901196, 4754.263089221176, 4883.99878025004, 4889.119958407449, 3861.4014827701753, 3925.74482658632, 3969.960300397017, 3991.940120898189, 4158.604932531404, 1251.3117785218094, 1283.1723538317733, 1291.8514370847286, 1299.7075657977068, 1299.8440187177598, 898.4025622960788, 908.2280061947292, 919.3334832246568, 925.6528801699362, 934.4173763977885, 5561.165825126182, 5703.686297253691, 5706.28671416073, 5744.080947048536, 5861.120831875252, 889.8798662180652, 961.4519723757392, 973.2700474644017, 992.3252188511881, 1019.2875968373204, 3700.2599480104086, 3796.4495148203355, 3876.5154355705536, 3880.049387899983, 3916.7649941003633, 10729.463526823627, 11043.447827608587, 11073.280236784743, 11077.058450031676, 11103.5558577656, 10221.591136354611, 10625.415602141957, 10950.233483656228, 10956.0, 11087.778244435067, 8180.427370084156, 8228.83542329162, 8255.752327430188, 8300.252977232078, 8316.126806685332, 5441.564674826083, 5594.0769772987005, 5599.300087489064, 5696.11710184922, 5748.770049198152, 10230.28388012832, 10276.434796085989, 10296.948515257376, 10336.17310615134, 10389.272750907365, 10193.0, 10267.281290309607, 10519.94740026295, 10592.311499752492, 10593.09958653523, 7743.961280193563, 7848.097468791162, 7930.762077137695, 8161.265486106279, 8174.141715120065, 8287.632540630728, 8535.189157030072, 8540.829183416172, 8584.91415085841, 8592.269657079218, 7458.105027396748, 7689.653965571674, 7707.306342429209, 7735.729249476241, 7871.0, 7514.248575142442, 7549.490101979516, 7575.318221360104, 7652.273034061755, 7657.693692252247, 6628.337166283333, 6750.25747167821, 6765.221999470124, 6771.661416929035, 6804.353586409283, 4586.243269860569, 4894.975525122351, 4937.092844000142, 4961.751912404293, 4968.478309777422, 4901.0, 4955.331030310862, 4987.9002419950675, 5036.697798132123, 5065.3161823153405], "value": 4555.579644763472, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.0768264225453, 333.08401894789324, 334.5466892360851, 341.8273771745268, 342.967418095281, 5653.692589834946, 5667.0, 5689.971550142254, 5703.486686198241, 5703.885922281552, 5614.568285087297, 5617.517139373584, 5623.437656234374, 5638.323401191852, 5638.605297629158, 4156.999999999993, 4260.467441569804, 4341.261985462479, 4370.169667763115, 4379.277419225824, 4319.848805291816, 4323.1353729254115, 4341.633809573774, 4348.956510434903, 4354.97822510887, 4301.0, 4339.32740425233, 4342.696011279212, 4349.630281426083, 4352.804123814436, 4241.681873859442, 4255.97486777748, 4308.46144231971, 4325.891852703676, 4335.176316499855, 3774.414965680324, 3789.810509474543, 3801.3727734923705, 3819.675327597158, 3856.67218286446, 5339.305890234284, 5360.597955153379, 5370.462953704638, 5370.624056316059, 5386.353637563518, 4979.502049794992, 4987.301777751118, 4996.800127994876, 5010.173321401964, 5038.924416133761, 5790.85738276836, 5834.27071616048, 5859.882802343972, 5871.236739223917, 5904.0, 4228.957710422918, 4243.384709217146, 4255.234057869582, 4301.44081269433, 4306.720063195882, 5835.912461313083, 6159.815205543796, 6179.81460556184, 6186.84532886677, 6190.473809726179, 4233.936490952577, 4241.0, 4242.384854196186, 4257.106007738348, 4259.8083086261195, 4311.719738217006, 4324.2648749712625, 4328.43730315057, 4330.2638551446325, 4348.543402942709, 4814.735189564538, 5013.473585273494, 5052.671576347526, 5069.290299358093, 5070.645054846199, 5998.760049598054, 6000.369961154103, 6019.428154325332, 6048.969755151196, 6053.303870054912, 1532.2262257560085, 1532.8390518995568, 1548.9544557423694, 1555.3389809330988, 1560.134125560325, 949.1789601994225, 971.155095067296, 994.0506815990711, 1032.9721926682998, 1052.8262836632023, 5605.159226116115, 5619.595101224694, 5621.15682647598, 5643.548516118701, 5652.236948012048, 5967.910481342783, 5982.880342393128, 5994.310654274727, 6021.819345419644, 6040.063790112539, 5480.7533660985355, 5652.123920792284, 5695.259616249861, 5740.13897915316, 5791.218185544982, 3208.8716451341684, 3226.370857682776, 3266.118148100047, 3269.199046233688, 3281.278118813857, 6207.255129384503, 6280.811575652738, 6334.778282760081, 6351.491880649629, 6396.744130234832, 6174.38256174379, 6251.406116419024, 6283.183186185766, 6356.555041147075, 6363.268224154282, 6045.516358691294, 6234.381559744918, 6315.55791094619, 6426.646534440557, 6430.839229019312, 6148.262208534826, 6156.538259630635, 6157.4458298753325, 6163.322034576104, 6192.504599631929, 5950.018246989372, 6046.516278697782, 6083.69581520931, 6166.599171053867, 6211.223597050369, 6040.1543783871175, 6329.892268853025, 6346.746130154742, 6396.520260980538, 6403.839904002437, 4260.339647354665, 4261.339492378686, 4276.615104640598, 4299.204647140289, 4308.698391112592, 5901.468867801918, 6127.908081378694, 6133.907991380043, 6190.350013248724, 6252.499800016079, 5989.460948514655, 6005.249343832021, 6009.587746879567, 6066.302375226729, 6075.756969721162, 5998.550108741774, 6013.406447291559, 6036.879262414815, 6057.42454466825, 6091.908621370594, 5532.755130095697, 5749.770009199585, 5898.498627616701, 5907.645541267538, 5921.3782552831335, 6082.330943596113, 6087.234701936566, 6100.847478813065, 6102.643546049566, 6156.630602163885, 5600.299962504687, 5879.911801323069, 5901.940980590139, 5910.586258961831, 6011.0], "value": 4513.719528867587, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.5427212264459, 768.5657603454048, 787.5786454246977, 794.7575989323261, 818.3289702443997, 13493.122947008438, 14452.5664230073, 14456.927715361422, 14488.348024338904, 14515.637109072279, 12585.119041667087, 12618.684532886682, 12642.620721378373, 12653.17754345967, 12668.493260269579, 645.3353046362255, 750.9662065207051, 768.9807754806119, 785.1520358013361, 785.2971590426565, 762.79785856748, 776.596169991604, 778.1440415542914, 778.4122987144698, 781.2031727637806, 830.6054624053587, 830.983380332393, 831.2269589281965, 832.4256263178418, 835.0730688935276, 815.9306458950996, 821.0516853034754, 824.9051359093721, 826.1944604011101, 826.8222332198576, 600.8407771940439, 601.0293376197453, 602.921620189377, 604.2899592978276, 605.9212302400704, 13972.860271397258, 14089.64775880601, 14122.92938535311, 14129.929350353183, 14134.646633834236, 14026.158430494203, 14153.858461415357, 14199.361028753627, 14252.144871307755, 14342.92828535861, 11312.490937907814, 11436.085113190924, 11539.826902596467, 11642.359670218135, 11683.299002059819, 3665.816709164531, 3702.4631428442726, 3714.0714821294678, 3736.196717705679, 3823.7323387362894, 52400.0, 52616.999999999614, 53095.0, 53238.46761532374, 53446.0, 10471.68584942453, 10494.475276236157, 10687.786244275227, 10768.569257229623, 11155.72110697239, 18295.45113646566, 18393.172307246205, 18400.079996000146, 18434.170462329228, 18516.0, 8113.350931925432, 8315.085340612528, 8415.158484151536, 8429.157084291644, 8545.188207120314, 4549.977250113729, 4590.540945905383, 4596.655250856199, 4680.087382960358, 4815.253635686474, 3158.1630867820045, 3221.098092534094, 3255.6093268807895, 3256.0720194744385, 3258.038878530839, 591.5799782154633, 603.8580933480629, 609.4027852704374, 618.4001518527022, 618.4526693875952, 644.3942693867749, 645.9031145328238, 730.2004305285703, 754.3738696881685, 776.6582703610393, 8514.191151840565, 8586.527740974307, 8691.391602587884, 8969.775755606162, 9207.95396023029, 701.6351497221416, 716.126325882433, 758.3023618271204, 759.5518644000066, 764.5145332713766, 3991.3214753491975, 4096.508418989741, 4308.80610372534, 4323.6757243206885, 4369.169857727022, 63621.0, 64103.67948160323, 64133.679331603045, 64622.67688661526, 65085.67457162779, 28550.571741423897, 28558.0, 45857.541424585324, 59259.40740592539, 60162.699186503785, 54759.0, 54927.450725493036, 54947.450525494234, 55026.17460738092, 55093.72453137789, 8365.749027529184, 8551.57242137903, 8588.22705956467, 8609.87085193735, 8633.421325026105, 34916.0, 36054.8197259012, 36214.27571448503, 36664.26671466609, 37440.0, 43719.56280437282, 47445.762771185924, 48120.27819582779, 48367.51632483771, 48391.0, 11014.229003969645, 11093.278936869077, 11380.54477820878, 11636.12729045342, 11754.647360579196, 12703.745925081632, 12738.363081846055, 12868.806967895302, 12967.675808104495, 13041.0, 11563.537458501565, 11578.421078946187, 11840.644780656594, 12165.452554634885, 12202.14584979043, 11843.11176661771, 12079.094067945114, 12122.212056216318, 12178.0, 12318.445669944695, 11463.828042579535, 11561.323608076613, 11770.411479426166, 11974.042076634023, 12037.75924481523, 9078.954605226932, 9229.574077117353, 9308.906910931075, 9405.764855878384, 9473.52632368365, 9478.857817132886, 9693.70918872435, 9865.852012219966, 9894.703158905244, 9935.453550054528], "value": 6544.8222642969995, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1540.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 111.0, 110.0, 113.0, 111.0, 111.0, 111.0, 111.0, 112.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 123.0, 167.0, 187.0, 135.0, 150.0, 159.0, 132.0, 178.0, 126.0], "value": 150.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 165.0, 163.0, 163.0, 168.0, 170.0, 160.0, 160.0, 160.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 157.0, 74.0, 78.0, 75.0, 75.0, 168.0, 77.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 87.0, 148.0, 84.0, 84.0, 85.0, 137.0, 84.0, 83.0, 141.0], "value": 101.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 147.0, 149.0, 147.0, 147.0, 146.0, 147.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 101.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 59.0, 54.0, 55.0, 54.0, 56.0, 63.0, 53.0, 61.0, 55.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 61.0, 62.0, 62.0, 62.0, 62.0, 63.0, 62.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 79.0, 81.0, 80.0, 88.0, 83.0, 82.0, 114.0, 86.0], "value": 86.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 122.0, 131.0, 130.0, 132.0, 125.0, 139.0, 122.0, 133.0, 125.0], "value": 129.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 164.0, 166.0, 158.0, 161.0, 170.0, 161.0, 159.0, 158.0, 159.0], "value": 162.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 62.0, 64.0, 63.0, 62.0, 66.0, 63.0, 63.0, 63.0, 61.0], "value": 63.6, "unit": "score"}]}]} 16:34:19 INFO - Return code: 0 16:34:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:34:19 ERROR - # TBPL SUCCESS # 16:34:19 INFO - Running post-action listener: _resource_record_post_action 16:34:19 INFO - ##### 16:34:19 INFO - ##### Finished run-tests step (success) 16:34:19 INFO - ##### 16:34:19 INFO - Running post-run listener: _resource_record_post_run 16:34:19 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 7847936; Write bytes: 444067840; Read time: 2168; Write time: 509308 16:34:19 INFO - TinderboxPrint: CPU usage
13.4% 16:34:19 INFO - TinderboxPrint: I/O read bytes / time
7,847,936 / 2,168 16:34:19 INFO - TinderboxPrint: I/O write bytes / time
444,067,840 / 509,308 16:34:19 INFO - TinderboxPrint: CPU idle
8,230.3 (86.5%) 16:34:19 INFO - TinderboxPrint: CPU user
1,223.2 (12.9%) 16:34:19 INFO - TinderboxPrint: Swap in / out
0 / 0 16:34:19 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 16502784; Read time: 0; Write time: 2188 16:34:19 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 6082560; Write bytes: 402190336; Read time: 2024; Write time: 497572 16:34:20 INFO - Running post-run listener: _upload_blobber_files 16:34:20 INFO - Blob upload gear active. 16:34:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:34:20 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 16:34:20 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:34:20 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:34:20 INFO - (blobuploader) - INFO - Open directory for files ... 16:34:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:34:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:34:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:34:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:34:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:34:21 INFO - (blobuploader) - INFO - Done attempting. 16:34:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:34:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:34:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:34:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:34:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:34:24 INFO - (blobuploader) - INFO - Done attempting. 16:34:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:34:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:34:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:34:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:34:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:34:25 INFO - (blobuploader) - INFO - Done attempting. 16:34:25 INFO - (blobuploader) - INFO - Iteration through files over. 16:34:25 INFO - Return code: 0 16:34:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:34:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:34:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c3709941b7d28023f779fa4c6fa906f8f41e506f82f227c0c1c7e18b36cfd7f214ab26694f096b39dc258bb9b099348c7da364dcbdd8b61257eb4f1a20e784a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9ce37f8d07c8aba50f1c2febe4aec8ec0d1c05a70bf3f9896f110835da86bbd5fcfd9a58451498426008066e0699dfe8da74fd59213330efb64a5a814b674bcf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9da6b8525a0256f4990288e18ffd15f4b2affe2d521f33e4f051d65f84d0155fed3c896b7569e5f7407465dc9e8b5f407497e291dd93352175251f2e18ba5f0f"} 16:34:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:34:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:34:25 INFO - Contents: 16:34:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c3709941b7d28023f779fa4c6fa906f8f41e506f82f227c0c1c7e18b36cfd7f214ab26694f096b39dc258bb9b099348c7da364dcbdd8b61257eb4f1a20e784a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9ce37f8d07c8aba50f1c2febe4aec8ec0d1c05a70bf3f9896f110835da86bbd5fcfd9a58451498426008066e0699dfe8da74fd59213330efb64a5a814b674bcf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9da6b8525a0256f4990288e18ffd15f4b2affe2d521f33e4f051d65f84d0155fed3c896b7569e5f7407465dc9e8b5f407497e291dd93352175251f2e18ba5f0f"} 16:34:25 INFO - Running post-run listener: copy_logs_to_upload_dir 16:34:25 INFO - Copying logs to upload dir... 16:34:25 INFO - mkdir: /builds/slave/test/build/upload/logs 16:34:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.306570 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-05-30 16:34:25.772337) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 16:34:25.778061) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1464650019.146245-389341864 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/Mozilla-Inbound/sha512/c3709941b7d28023f779fa4c6fa906f8f41e506f82f227c0c1c7e18b36cfd7f214ab26694f096b39dc258bb9b099348c7da364dcbdd8b61257eb4f1a20e784a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9ce37f8d07c8aba50f1c2febe4aec8ec0d1c05a70bf3f9896f110835da86bbd5fcfd9a58451498426008066e0699dfe8da74fd59213330efb64a5a814b674bcf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9da6b8525a0256f4990288e18ffd15f4b2affe2d521f33e4f051d65f84d0155fed3c896b7569e5f7407465dc9e8b5f407497e291dd93352175251f2e18ba5f0f"} build_url:https://queue.taskcluster.net/v1/task/HpMi7oRlRcuEb4KefIHLrQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011401 build_url: 'https://queue.taskcluster.net/v1/task/HpMi7oRlRcuEb4KefIHLrQ/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/Mozilla-Inbound/sha512/c3709941b7d28023f779fa4c6fa906f8f41e506f82f227c0c1c7e18b36cfd7f214ab26694f096b39dc258bb9b099348c7da364dcbdd8b61257eb4f1a20e784a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9ce37f8d07c8aba50f1c2febe4aec8ec0d1c05a70bf3f9896f110835da86bbd5fcfd9a58451498426008066e0699dfe8da74fd59213330efb64a5a814b674bcf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9da6b8525a0256f4990288e18ffd15f4b2affe2d521f33e4f051d65f84d0155fed3c896b7569e5f7407465dc9e8b5f407497e291dd93352175251f2e18ba5f0f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 16:34:25.803385) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:34:25.803742) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1464650019.146245-389341864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004377 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:34:25.886483) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 16:34:25.886828) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 16:34:25.887140) ========= ========= Total master_lag: 0.12 =========