builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-058 starttime: 1469737165.07 results: success (0) buildid: 20160728103010 builduid: 43f26c4df9e3404986c21cdb2e4f831c revision: 9ec789c0ee5bd3a5e765513c21027fdad953b022 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 13:19:25.072692) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 13:19:25.073167) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 13:19:25.073513) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 13:19:25.091287) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 13:19:25.091688) ========= 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=0e2a256762fed810e2f0f810000001b3-1469737162.615521-1545804640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-28 13:19:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.1M=0s 2016-07-28 13:19:25 (46.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.078596 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 13:19:25.184940) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 13:19:25.185267) ========= 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=0e2a256762fed810e2f0f810000001b3-1469737162.615521-1545804640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013679 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 13:19:25.235383) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 13:19:25.235751) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9ec789c0ee5bd3a5e765513c21027fdad953b022 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 9ec789c0ee5bd3a5e765513c21027fdad953b022 --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=0e2a256762fed810e2f0f810000001b3-1469737162.615521-1545804640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-28 13:19:25,424 truncating revision to first 12 chars 2016-07-28 13:19:25,424 Setting DEBUG logging. 2016-07-28 13:19:25,424 attempt 1/10 2016-07-28 13:19:25,424 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9ec789c0ee5b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-28 13:19:25,740 unpacking tar archive at: mozilla-central-9ec789c0ee5b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.658151 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 13:19:25.907610) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 13:19:25.907916) ========= script_repo_revision: 9ec789c0ee5bd3a5e765513c21027fdad953b022 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 13:19:25.908326) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 13:19:25.908609) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 13:19:25.917601) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-07-28 13:19:25.918062) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=0e2a256762fed810e2f0f810000001b3-1469737162.615521-1545804640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:19:26 INFO - MultiFileLogger online at 20160728 13:19:26 in /builds/slave/test 13:19:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 13:19:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:19:26 INFO - {'append_to_log': False, 13:19:26 INFO - 'base_work_dir': '/builds/slave/test', 13:19:26 INFO - 'blob_upload_branch': 'Firefox', 13:19:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:19:26 INFO - 'branch': 'Firefox', 13:19:26 INFO - 'buildbot_json_path': 'buildprops.json', 13:19:26 INFO - 'config_files': ('talos/linux_config.py',), 13:19:26 INFO - 'default_actions': ('clobber', 13:19:26 INFO - 'read-buildbot-config', 13:19:26 INFO - 'download-and-extract', 13:19:26 INFO - 'populate-webroot', 13:19:26 INFO - 'create-virtualenv', 13:19:26 INFO - 'install', 13:19:26 INFO - 'run-tests'), 13:19:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:19:26 INFO - 'download_minidump_stackwalk': True, 13:19:26 INFO - 'download_symbols': 'ondemand', 13:19:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:19:26 INFO - 'tooltool.py': '/tools/tooltool.py', 13:19:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:19:26 INFO - '/tools/misc-python/virtualenv.py')}, 13:19:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:19:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:19:26 INFO - 'installer_path': 'installer.exe', 13:19:26 INFO - 'log_level': 'info', 13:19:26 INFO - 'log_name': 'talos', 13:19:26 INFO - 'log_to_console': True, 13:19:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:19:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:19:26 INFO - 'opt_config_files': (), 13:19:26 INFO - 'pip_index': False, 13:19:26 INFO - 'sps_profile': False, 13:19:26 INFO - 'sps_profile_interval': 0, 13:19:26 INFO - 'suite': 'dromaeojs', 13:19:26 INFO - 'system_bits': '32', 13:19:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:19:26 INFO - 'title': 'talos-linux64-ix-058', 13:19:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:19:26 INFO - 'use_talos_json': True, 13:19:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:19:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:19:26 INFO - 'work_dir': 'build'} 13:19:26 INFO - [mozharness: 2016-07-28 20:19:26.206196Z] Running clobber step. 13:19:26 INFO - Running pre-action listener: _resource_record_pre_action 13:19:26 INFO - Running main action method: clobber 13:19:26 INFO - rmtree: /builds/slave/test/build 13:19:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:19:26 INFO - Running post-action listener: _resource_record_post_action 13:19:26 INFO - [mozharness: 2016-07-28 20:19:26.678082Z] Finished clobber step (success) 13:19:26 INFO - [mozharness: 2016-07-28 20:19:26.678185Z] Running read-buildbot-config step. 13:19:26 INFO - Running pre-action listener: _resource_record_pre_action 13:19:26 INFO - Running main action method: read_buildbot_config 13:19:26 INFO - Using buildbot properties: 13:19:26 INFO - { 13:19:26 INFO - "project": "", 13:19:26 INFO - "product": "firefox", 13:19:26 INFO - "script_repo_revision": "production", 13:19:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 13:19:26 INFO - "repository": "", 13:19:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 13:19:26 INFO - "buildid": "20160728103010", 13:19:26 INFO - "pgo_build": "True", 13:19:26 INFO - "basedir": "/builds/slave/test", 13:19:26 INFO - "buildnumber": 810, 13:19:26 INFO - "slavename": "talos-linux64-ix-058", 13:19:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:19:26 INFO - "platform": "ubuntu64_hw", 13:19:26 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 13:19:26 INFO - "branch": "mozilla-central", 13:19:26 INFO - "repo_path": "mozilla-central", 13:19:26 INFO - "revision": "9ec789c0ee5bd3a5e765513c21027fdad953b022", 13:19:26 INFO - "stage_platform": "linux64-pgo", 13:19:26 INFO - "builduid": "43f26c4df9e3404986c21cdb2e4f831c", 13:19:26 INFO - "slavebuilddir": "test" 13:19:26 INFO - } 13:19:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/eULIeu5uRjOSaN3sqn-OCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:19:26 INFO - Running post-action listener: _resource_record_post_action 13:19:26 INFO - [mozharness: 2016-07-28 20:19:26.680633Z] Finished read-buildbot-config step (success) 13:19:26 INFO - [mozharness: 2016-07-28 20:19:26.680723Z] Running download-and-extract step. 13:19:26 INFO - Running pre-action listener: _resource_record_pre_action 13:19:26 INFO - Running main action method: download_and_extract 13:19:26 INFO - mkdir: /builds/slave/test/build/tests 13:19:26 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')]} 13:19:26 INFO - https://queue.taskcluster.net/v1/task/eULIeu5uRjOSaN3sqn-OCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:19:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eULIeu5uRjOSaN3sqn-OCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:19:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eULIeu5uRjOSaN3sqn-OCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:19:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eULIeu5uRjOSaN3sqn-OCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:19:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eULIeu5uRjOSaN3sqn-OCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:19:27 INFO - Downloaded 1361 bytes. 13:19:27 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:19:27 INFO - Using the following test package requirements: 13:19:27 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:19:27 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:19:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:19:27 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:19:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:19:27 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:19:27 INFO - u'jsshell-linux-x86_64.zip'], 13:19:27 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:19:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:19:27 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:19:27 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:19:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:19:27 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:19:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:19:27 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:19:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:19:27 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:19:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:19:27 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:27 INFO - https://queue.taskcluster.net/v1/task/eULIeu5uRjOSaN3sqn-OCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:19:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eULIeu5uRjOSaN3sqn-OCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:19:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eULIeu5uRjOSaN3sqn-OCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:19:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eULIeu5uRjOSaN3sqn-OCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:19:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eULIeu5uRjOSaN3sqn-OCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:19:28 INFO - Downloaded 24321382 bytes. 13:19:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:19:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:19:29 INFO - Return code: 0 13:19:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:19:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:29 INFO - https://queue.taskcluster.net/v1/task/eULIeu5uRjOSaN3sqn-OCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:19:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eULIeu5uRjOSaN3sqn-OCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:19:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eULIeu5uRjOSaN3sqn-OCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:19:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eULIeu5uRjOSaN3sqn-OCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:19:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eULIeu5uRjOSaN3sqn-OCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:19:30 INFO - Downloaded 24321382 bytes. 13:19:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:19:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:19:31 INFO - Return code: 0 13:19:31 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')]} 13:19:31 INFO - https://queue.taskcluster.net/v1/task/eULIeu5uRjOSaN3sqn-OCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:19:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eULIeu5uRjOSaN3sqn-OCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:19:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eULIeu5uRjOSaN3sqn-OCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:19:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eULIeu5uRjOSaN3sqn-OCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:19:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eULIeu5uRjOSaN3sqn-OCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:19:33 INFO - Downloaded 14413725 bytes. 13:19:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:19:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:19:33 INFO - Return code: 0 13:19:33 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')]} 13:19:33 INFO - https://queue.taskcluster.net/v1/task/eULIeu5uRjOSaN3sqn-OCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:19:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eULIeu5uRjOSaN3sqn-OCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:19:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eULIeu5uRjOSaN3sqn-OCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:19:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eULIeu5uRjOSaN3sqn-OCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:19:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eULIeu5uRjOSaN3sqn-OCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:19:35 INFO - Downloaded 61016503 bytes. 13:19:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eULIeu5uRjOSaN3sqn-OCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:19:35 INFO - mkdir: /builds/slave/test/properties 13:19:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:19:35 INFO - Writing to file /builds/slave/test/properties/build_url 13:19:35 INFO - Contents: 13:19:35 INFO - build_url:https://queue.taskcluster.net/v1/task/eULIeu5uRjOSaN3sqn-OCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:19:35 INFO - Running post-action listener: _resource_record_post_action 13:19:35 INFO - Running post-action listener: set_extra_try_arguments 13:19:35 INFO - [mozharness: 2016-07-28 20:19:35.720889Z] Finished download-and-extract step (success) 13:19:35 INFO - [mozharness: 2016-07-28 20:19:35.721212Z] Running populate-webroot step. 13:19:35 INFO - Running pre-action listener: _resource_record_pre_action 13:19:35 INFO - Running main action method: populate_webroot 13:19:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:19:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:19:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:19:35 INFO - '--tppagecycles', 13:19:35 INFO - '7'], 13:19:35 INFO - 'tests': ['tsvgm']}}, 13:19:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:19:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:19:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:19:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:19:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:19:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:19:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:35 INFO - 'talos_options': ['--disable-e10s'], 13:19:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:19:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:19:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:35 INFO - 'talos_options': ['--disable-e10s'], 13:19:35 INFO - 'tests': ['damp', 'tps']}, 13:19:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:35 INFO - 'tests': ['damp', 'tps']}, 13:19:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:19:35 INFO - 'tests': ['dromaeo_dom']}, 13:19:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:19:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:19:35 INFO - 'tests': ['basic_compositor_video']}, 13:19:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:19:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:19:35 INFO - 'tests': ['a11yr', 13:19:35 INFO - 'ts_paint', 13:19:35 INFO - 'tpaint', 13:19:35 INFO - 'sessionrestore', 13:19:35 INFO - 'sessionrestore_no_auto_restore', 13:19:35 INFO - 'tabpaint']}, 13:19:35 INFO - 'other-e10s': {'tests': ['a11yr', 13:19:35 INFO - 'ts_paint', 13:19:35 INFO - 'tpaint', 13:19:35 INFO - 'sessionrestore', 13:19:35 INFO - 'sessionrestore_no_auto_restore', 13:19:35 INFO - 'tabpaint']}, 13:19:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:19:35 INFO - 'ts_paint', 13:19:35 INFO - 'tpaint', 13:19:35 INFO - 'sessionrestore', 13:19:35 INFO - 'sessionrestore_no_auto_restore', 13:19:35 INFO - 'tabpaint']}, 13:19:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:19:35 INFO - 'ts_paint', 13:19:35 INFO - 'tpaint', 13:19:35 INFO - 'sessionrestore', 13:19:35 INFO - 'sessionrestore_no_auto_restore', 13:19:35 INFO - 'tabpaint']}, 13:19:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:19:35 INFO - 'tests': ['a11yr', 13:19:35 INFO - 'ts_paint', 13:19:35 INFO - 'tpaint', 13:19:35 INFO - 'sessionrestore', 13:19:35 INFO - 'sessionrestore_no_auto_restore', 13:19:35 INFO - 'tabpaint']}, 13:19:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:19:35 INFO - 'tests': ['a11yr', 13:19:35 INFO - 'ts_paint', 13:19:35 INFO - 'tpaint', 13:19:35 INFO - 'sessionrestore', 13:19:35 INFO - 'sessionrestore_no_auto_restore', 13:19:35 INFO - 'tabpaint']}, 13:19:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:19:35 INFO - 'tests': ['tsvgx', 13:19:35 INFO - 'tsvgr_opacity', 13:19:35 INFO - 'tart', 13:19:35 INFO - 'tscrollx', 13:19:35 INFO - 'cart']}, 13:19:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:19:35 INFO - 'tsvgr_opacity', 13:19:35 INFO - 'tart', 13:19:35 INFO - 'tscrollx', 13:19:35 INFO - 'cart']}, 13:19:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:35 INFO - 'talos_options': ['--disable-e10s'], 13:19:35 INFO - 'tests': ['tp5o']}, 13:19:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:35 INFO - 'tests': ['tp5o']}, 13:19:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:35 INFO - 'talos_options': ['--disable-e10s', 13:19:35 INFO - '--xperf_path', 13:19:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:19:35 INFO - 'tests': ['tp5n']}, 13:19:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:35 INFO - 'talos_options': ['--xperf_path', 13:19:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:19:35 INFO - 'tests': ['tp5n']}}, 13:19:35 INFO - 'talos.zip': {'path': '', 13:19:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:19:35 INFO - Running post-action listener: _resource_record_post_action 13:19:35 INFO - [mozharness: 2016-07-28 20:19:35.743340Z] Finished populate-webroot step (success) 13:19:35 INFO - [mozharness: 2016-07-28 20:19:35.743430Z] Running create-virtualenv step. 13:19:35 INFO - Running pre-action listener: _resource_record_pre_action 13:19:35 INFO - Running main action method: create_virtualenv 13:19:35 INFO - Creating virtualenv /builds/slave/test/build/venv 13:19:35 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 13:19:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:19:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:19:35 INFO - Using real prefix '/usr' 13:19:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:19:36 INFO - Installing distribute.............................................................................................................................................................................................done. 13:19:38 INFO - Installing pip.................done. 13:19:38 INFO - Return code: 0 13:19:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:19:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:38 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 0x1519030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17da180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d83b0>, '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 0x17d92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d9740>, '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': '0e2a256762fed810e2f0f810000001b3-1469737162.615521-1545804640', '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 13:19:38 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 13:19:38 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 13:19:38 INFO - Using env: {'DISPLAY': ':0', 13:19:38 INFO - 'HOME': '/home/cltbld', 13:19:38 INFO - 'LANG': 'en_US.UTF-8', 13:19:38 INFO - 'LANGUAGE': 'en_US:en', 13:19:38 INFO - 'LOGNAME': 'cltbld', 13:19:38 INFO - 'MAIL': '/var/mail/cltbld', 13:19:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:38 INFO - 'MOZ_NO_REMOTE': '1', 13:19:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:38 INFO - 'NO_EM_RESTART': '1', 13:19:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:38 INFO - 'PWD': '/builds/slave/test', 13:19:38 INFO - 'SHELL': '/bin/bash', 13:19:38 INFO - 'SHLVL': '1', 13:19:38 INFO - 'TERM': 'linux', 13:19:38 INFO - 'TMOUT': '86400', 13:19:38 INFO - 'USER': 'cltbld', 13:19:38 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469737162.615521-1545804640', 13:19:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:38 INFO - '_': '/tools/buildbot/bin/python'} 13:19:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:38 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 13:19:38 INFO - Cleaning up... 13:19:38 INFO - Return code: 0 13:19:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:19:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:38 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 0x1519030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17da180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d83b0>, '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 0x17d92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d9740>, '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': '0e2a256762fed810e2f0f810000001b3-1469737162.615521-1545804640', '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 13:19:38 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 13:19:38 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 13:19:38 INFO - Using env: {'DISPLAY': ':0', 13:19:38 INFO - 'HOME': '/home/cltbld', 13:19:38 INFO - 'LANG': 'en_US.UTF-8', 13:19:38 INFO - 'LANGUAGE': 'en_US:en', 13:19:38 INFO - 'LOGNAME': 'cltbld', 13:19:38 INFO - 'MAIL': '/var/mail/cltbld', 13:19:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:38 INFO - 'MOZ_NO_REMOTE': '1', 13:19:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:38 INFO - 'NO_EM_RESTART': '1', 13:19:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:38 INFO - 'PWD': '/builds/slave/test', 13:19:38 INFO - 'SHELL': '/bin/bash', 13:19:38 INFO - 'SHLVL': '1', 13:19:38 INFO - 'TERM': 'linux', 13:19:38 INFO - 'TMOUT': '86400', 13:19:38 INFO - 'USER': 'cltbld', 13:19:38 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469737162.615521-1545804640', 13:19:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:38 INFO - '_': '/tools/buildbot/bin/python'} 13:19:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:38 INFO - Downloading/unpacking psutil>=3.1.1 13:19:38 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 13:19:38 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 13:19:38 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 13:19:38 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 13:19:38 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 13:19:38 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 13:19:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:19:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:19:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:19:40 INFO - Installing collected packages: psutil 13:19:40 INFO - Running setup.py install for psutil 13:19:40 INFO - building 'psutil._psutil_linux' extension 13:19:40 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 13:19:41 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 13:19:41 INFO - building 'psutil._psutil_posix' extension 13:19:41 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 13:19:41 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 13:19:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:19:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:19:41 INFO - Successfully installed psutil 13:19:41 INFO - Cleaning up... 13:19:41 INFO - Return code: 0 13:19:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:19:41 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')]} 13:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:41 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')]} 13:19:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:41 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 0x1519030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17da180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d83b0>, '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 0x17d92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d9740>, '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': '0e2a256762fed810e2f0f810000001b3-1469737162.615521-1545804640', '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 13:19:41 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 13:19:41 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 13:19:41 INFO - Using env: {'DISPLAY': ':0', 13:19:41 INFO - 'HOME': '/home/cltbld', 13:19:41 INFO - 'LANG': 'en_US.UTF-8', 13:19:41 INFO - 'LANGUAGE': 'en_US:en', 13:19:41 INFO - 'LOGNAME': 'cltbld', 13:19:41 INFO - 'MAIL': '/var/mail/cltbld', 13:19:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:41 INFO - 'MOZ_NO_REMOTE': '1', 13:19:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:41 INFO - 'NO_EM_RESTART': '1', 13:19:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:41 INFO - 'PWD': '/builds/slave/test', 13:19:41 INFO - 'SHELL': '/bin/bash', 13:19:41 INFO - 'SHLVL': '1', 13:19:41 INFO - 'TERM': 'linux', 13:19:41 INFO - 'TMOUT': '86400', 13:19:41 INFO - 'USER': 'cltbld', 13:19:41 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469737162.615521-1545804640', 13:19:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:41 INFO - '_': '/tools/buildbot/bin/python'} 13:19:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:19:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:19:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:19:43 INFO - Installing collected packages: mozsystemmonitor 13:19:43 INFO - Running setup.py install for mozsystemmonitor 13:19:43 INFO - Successfully installed mozsystemmonitor 13:19:43 INFO - Cleaning up... 13:19:43 INFO - Return code: 0 13:19:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:19: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')]} 13:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19: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')]} 13:19:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1519030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17da180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d83b0>, '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 0x17d92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d9740>, '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': '0e2a256762fed810e2f0f810000001b3-1469737162.615521-1545804640', '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 13:19:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:19:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:19:43 INFO - Using env: {'DISPLAY': ':0', 13:19:43 INFO - 'HOME': '/home/cltbld', 13:19:43 INFO - 'LANG': 'en_US.UTF-8', 13:19:43 INFO - 'LANGUAGE': 'en_US:en', 13:19:43 INFO - 'LOGNAME': 'cltbld', 13:19:43 INFO - 'MAIL': '/var/mail/cltbld', 13:19:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:43 INFO - 'MOZ_NO_REMOTE': '1', 13:19:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:43 INFO - 'NO_EM_RESTART': '1', 13:19:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:43 INFO - 'PWD': '/builds/slave/test', 13:19:43 INFO - 'SHELL': '/bin/bash', 13:19:43 INFO - 'SHLVL': '1', 13:19:43 INFO - 'TERM': 'linux', 13:19:43 INFO - 'TMOUT': '86400', 13:19:43 INFO - 'USER': 'cltbld', 13:19:43 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469737162.615521-1545804640', 13:19:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:43 INFO - '_': '/tools/buildbot/bin/python'} 13:19:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:43 INFO - Downloading/unpacking jsonschema==2.5.1 13:19:43 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 13:19:43 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 13:19:43 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 13:19:43 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 13:19:43 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 13:19:43 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 13:19:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:19:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:19:45 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 13:19:45 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 13:19:45 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 13:19:45 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 13:19:45 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 13:19:45 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 13:19:45 INFO - Downloading functools32-3.2.3-2.tar.gz 13:19:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:19:46 INFO - warning: no files found matching '*.txt' 13:19:46 INFO - no previously-included directories found matching 'build' 13:19:46 INFO - no previously-included directories found matching 'dist' 13:19:46 INFO - no previously-included directories found matching '.git*' 13:19:46 INFO - Installing collected packages: jsonschema, functools32 13:19:46 INFO - Running setup.py install for functools32 13:19:46 INFO - warning: no files found matching '*.txt' 13:19:46 INFO - no previously-included directories found matching 'build' 13:19:46 INFO - no previously-included directories found matching 'dist' 13:19:46 INFO - no previously-included directories found matching '.git*' 13:19:46 INFO - Successfully installed jsonschema functools32 13:19:46 INFO - Cleaning up... 13:19:46 INFO - Return code: 0 13:19:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:19:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1519030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17da180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d83b0>, '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 0x17d92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d9740>, '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': '0e2a256762fed810e2f0f810000001b3-1469737162.615521-1545804640', '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 13:19:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:19:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:19:46 INFO - Using env: {'DISPLAY': ':0', 13:19:46 INFO - 'HOME': '/home/cltbld', 13:19:46 INFO - 'LANG': 'en_US.UTF-8', 13:19:46 INFO - 'LANGUAGE': 'en_US:en', 13:19:46 INFO - 'LOGNAME': 'cltbld', 13:19:46 INFO - 'MAIL': '/var/mail/cltbld', 13:19:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:46 INFO - 'MOZ_NO_REMOTE': '1', 13:19:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:46 INFO - 'NO_EM_RESTART': '1', 13:19:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:46 INFO - 'PWD': '/builds/slave/test', 13:19:46 INFO - 'SHELL': '/bin/bash', 13:19:46 INFO - 'SHLVL': '1', 13:19:46 INFO - 'TERM': 'linux', 13:19:46 INFO - 'TMOUT': '86400', 13:19:46 INFO - 'USER': 'cltbld', 13:19:46 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469737162.615521-1545804640', 13:19:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:46 INFO - '_': '/tools/buildbot/bin/python'} 13:19:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:19:46 INFO - Cleaning up... 13:19:46 INFO - Return code: 0 13:19:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:19:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1519030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17da180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d83b0>, '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 0x17d92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d9740>, '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': '0e2a256762fed810e2f0f810000001b3-1469737162.615521-1545804640', '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 13:19:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:19:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:19:46 INFO - Using env: {'DISPLAY': ':0', 13:19:46 INFO - 'HOME': '/home/cltbld', 13:19:46 INFO - 'LANG': 'en_US.UTF-8', 13:19:46 INFO - 'LANGUAGE': 'en_US:en', 13:19:46 INFO - 'LOGNAME': 'cltbld', 13:19:46 INFO - 'MAIL': '/var/mail/cltbld', 13:19:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:46 INFO - 'MOZ_NO_REMOTE': '1', 13:19:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:46 INFO - 'NO_EM_RESTART': '1', 13:19:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:46 INFO - 'PWD': '/builds/slave/test', 13:19:46 INFO - 'SHELL': '/bin/bash', 13:19:46 INFO - 'SHLVL': '1', 13:19:46 INFO - 'TERM': 'linux', 13:19:46 INFO - 'TMOUT': '86400', 13:19:46 INFO - 'USER': 'cltbld', 13:19:46 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469737162.615521-1545804640', 13:19:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:46 INFO - '_': '/tools/buildbot/bin/python'} 13:19:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:46 INFO - Downloading/unpacking blobuploader==1.2.4 13:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:48 INFO - Downloading blobuploader-1.2.4.tar.gz 13:19:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:19:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:19:48 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 13:19:48 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 13:19:48 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 13:19:48 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 13:19:48 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 13:19:48 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 13:19:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:19:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:49 INFO - Downloading docopt-0.6.1.tar.gz 13:19:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:19:49 INFO - Installing collected packages: blobuploader, requests, docopt 13:19:49 INFO - Running setup.py install for blobuploader 13:19:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:19:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:19:49 INFO - Running setup.py install for requests 13:19:49 INFO - Running setup.py install for docopt 13:19:49 INFO - Successfully installed blobuploader requests docopt 13:19:49 INFO - Cleaning up... 13:19:49 INFO - Return code: 0 13:19:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:19:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:49 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 0x1519030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17da180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d83b0>, '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 0x17d92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d9740>, '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': '0e2a256762fed810e2f0f810000001b3-1469737162.615521-1545804640', '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 13:19:49 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 13:19:49 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 13:19:49 INFO - Using env: {'DISPLAY': ':0', 13:19:49 INFO - 'HOME': '/home/cltbld', 13:19:49 INFO - 'LANG': 'en_US.UTF-8', 13:19:49 INFO - 'LANGUAGE': 'en_US:en', 13:19:49 INFO - 'LOGNAME': 'cltbld', 13:19:49 INFO - 'MAIL': '/var/mail/cltbld', 13:19:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:49 INFO - 'MOZ_NO_REMOTE': '1', 13:19:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:49 INFO - 'NO_EM_RESTART': '1', 13:19:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:49 INFO - 'PWD': '/builds/slave/test', 13:19:49 INFO - 'SHELL': '/bin/bash', 13:19:49 INFO - 'SHLVL': '1', 13:19:49 INFO - 'TERM': 'linux', 13:19:49 INFO - 'TMOUT': '86400', 13:19:49 INFO - 'USER': 'cltbld', 13:19:49 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469737162.615521-1545804640', 13:19:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:49 INFO - '_': '/tools/buildbot/bin/python'} 13:19:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:19:50 INFO - Running setup.py (path:/tmp/pip-cF0WBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:19:50 INFO - Running setup.py (path:/tmp/pip-b7A3v_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:19:50 INFO - Running setup.py (path:/tmp/pip-w9SIu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:19:50 INFO - Running setup.py (path:/tmp/pip-xeeh1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:19:50 INFO - Running setup.py (path:/tmp/pip-Rv_zjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:19:50 INFO - Running setup.py (path:/tmp/pip-68m57y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:19:50 INFO - Running setup.py (path:/tmp/pip-cOguzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:19:50 INFO - Running setup.py (path:/tmp/pip-Le6dMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:19:50 INFO - Running setup.py (path:/tmp/pip-wjkinh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:19:50 INFO - Running setup.py (path:/tmp/pip-clyohi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:19:50 INFO - Running setup.py (path:/tmp/pip-XovmL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:19:50 INFO - Running setup.py (path:/tmp/pip-gaE3ku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:19:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:19:51 INFO - Running setup.py (path:/tmp/pip-OWndpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:19:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:19:51 INFO - Running setup.py (path:/tmp/pip-_FFtBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:19:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:19:51 INFO - Running setup.py (path:/tmp/pip-9PZv3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:19:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:19:51 INFO - Running setup.py (path:/tmp/pip-hF90Tq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:19:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:19:51 INFO - Running setup.py (path:/tmp/pip-tCOQqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:19:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:19:51 INFO - Running setup.py install for manifestparser 13:19:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:19:51 INFO - Running setup.py install for mozcrash 13:19:51 INFO - Running setup.py install for mozdebug 13:19:51 INFO - Running setup.py install for mozdevice 13:19:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:19:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:19:51 INFO - Running setup.py install for mozfile 13:19:51 INFO - Running setup.py install for mozhttpd 13:19:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:19:51 INFO - Running setup.py install for mozinfo 13:19:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:19:52 INFO - Running setup.py install for mozInstall 13:19:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:19:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:19:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:19:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:19:52 INFO - Running setup.py install for mozleak 13:19:52 INFO - Running setup.py install for mozlog 13:19:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:19:52 INFO - Running setup.py install for moznetwork 13:19:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:19:52 INFO - Running setup.py install for mozprocess 13:19:52 INFO - Running setup.py install for mozprofile 13:19:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:19:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:19:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:19:52 INFO - Running setup.py install for mozrunner 13:19:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:19:52 INFO - Running setup.py install for mozscreenshot 13:19:52 INFO - Running setup.py install for moztest 13:19:53 INFO - Running setup.py install for mozversion 13:19:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:19:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:19:53 INFO - Cleaning up... 13:19:53 INFO - Return code: 0 13:19:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:19:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:53 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 0x1519030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17da180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d83b0>, '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 0x17d92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d9740>, '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': '0e2a256762fed810e2f0f810000001b3-1469737162.615521-1545804640', '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 13:19:53 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 13:19:53 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 13:19:53 INFO - Using env: {'DISPLAY': ':0', 13:19:53 INFO - 'HOME': '/home/cltbld', 13:19:53 INFO - 'LANG': 'en_US.UTF-8', 13:19:53 INFO - 'LANGUAGE': 'en_US:en', 13:19:53 INFO - 'LOGNAME': 'cltbld', 13:19:53 INFO - 'MAIL': '/var/mail/cltbld', 13:19:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:53 INFO - 'MOZ_NO_REMOTE': '1', 13:19:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:53 INFO - 'NO_EM_RESTART': '1', 13:19:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:53 INFO - 'PWD': '/builds/slave/test', 13:19:53 INFO - 'SHELL': '/bin/bash', 13:19:53 INFO - 'SHLVL': '1', 13:19:53 INFO - 'TERM': 'linux', 13:19:53 INFO - 'TMOUT': '86400', 13:19:53 INFO - 'USER': 'cltbld', 13:19:53 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469737162.615521-1545804640', 13:19:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:53 INFO - '_': '/tools/buildbot/bin/python'} 13:19:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:19:53 INFO - Running setup.py (path:/tmp/pip-yRijhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:19:53 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)) 13:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:19:53 INFO - Running setup.py (path:/tmp/pip-NPsWc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:19:53 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)) 13:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:19:53 INFO - Running setup.py (path:/tmp/pip-JGXHfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:19:53 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)) 13:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:19:53 INFO - Running setup.py (path:/tmp/pip-KJyNFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:19:53 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)) 13:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:19:53 INFO - Running setup.py (path:/tmp/pip-2llsNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:19:53 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)) 13:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:19:53 INFO - Running setup.py (path:/tmp/pip-dWyovX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:19:53 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)) 13:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:19:53 INFO - Running setup.py (path:/tmp/pip-UVCOMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:19:53 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)) 13:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:19:53 INFO - Running setup.py (path:/tmp/pip-04YmWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:19:53 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)) 13:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:19:53 INFO - Running setup.py (path:/tmp/pip-hOl1Y_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:19:54 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)) 13:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:19:54 INFO - Running setup.py (path:/tmp/pip-N3HplY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:19:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 13:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:19:54 INFO - Running setup.py (path:/tmp/pip-I7UqSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:19:54 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)) 13:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:19:54 INFO - Running setup.py (path:/tmp/pip-RtiwUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:19:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 13:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:19:54 INFO - Running setup.py (path:/tmp/pip-bx3XA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:19:54 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)) 13:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:19:54 INFO - Running setup.py (path:/tmp/pip-2Aw3dS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:19:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 13:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:19:54 INFO - Running setup.py (path:/tmp/pip-MxMPuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:19:54 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)) 13:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:19:54 INFO - Running setup.py (path:/tmp/pip-QEtr5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:19:54 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)) 13:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:19:54 INFO - Running setup.py (path:/tmp/pip-N57dqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:19:54 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)) 13:19:54 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)) 13:19:54 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)) 13:19:54 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)) 13:19:54 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)) 13:19:54 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)) 13:19:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:56 INFO - Downloading blessings-1.6.tar.gz 13:19:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:19:56 INFO - Installing collected packages: blessings 13:19:56 INFO - Running setup.py install for blessings 13:19:56 INFO - Successfully installed blessings 13:19:56 INFO - Cleaning up... 13:19:56 INFO - Return code: 0 13:19:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:19:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:19:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:19:57 INFO - Reading from file tmpfile_stdout 13:19:57 INFO - Current package versions: 13:19:57 INFO - argparse == 1.2.1 13:19:57 INFO - blessings == 1.6 13:19:57 INFO - blobuploader == 1.2.4 13:19:57 INFO - docopt == 0.6.1 13:19:57 INFO - functools32 == 3.2.3-2 13:19:57 INFO - jsonschema == 2.5.1 13:19:57 INFO - manifestparser == 1.1 13:19:57 INFO - mozInstall == 1.12 13:19:57 INFO - mozcrash == 0.17 13:19:57 INFO - mozdebug == 0.1 13:19:57 INFO - mozdevice == 0.48 13:19:57 INFO - mozfile == 1.2 13:19:57 INFO - mozhttpd == 0.7 13:19:57 INFO - mozinfo == 0.9 13:19:57 INFO - mozleak == 0.1 13:19:57 INFO - mozlog == 3.3 13:19:57 INFO - moznetwork == 0.27 13:19:57 INFO - mozprocess == 0.23 13:19:57 INFO - mozprofile == 0.28 13:19:57 INFO - mozrunner == 6.12 13:19:57 INFO - mozscreenshot == 0.1 13:19:57 INFO - mozsystemmonitor == 0.3 13:19:57 INFO - moztest == 0.7 13:19:57 INFO - mozversion == 1.4 13:19:57 INFO - psutil == 3.1.1 13:19:57 INFO - requests == 1.2.3 13:19:57 INFO - wsgiref == 0.1.2 13:19:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:19:57 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')]} 13:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:57 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')]} 13:19:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:57 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 0x1519030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17da180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d83b0>, '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 0x17d92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d9740>, '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': '0e2a256762fed810e2f0f810000001b3-1469737162.615521-1545804640', '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 13:19:57 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 13:19:57 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 13:19:57 INFO - Using env: {'DISPLAY': ':0', 13:19:57 INFO - 'HOME': '/home/cltbld', 13:19:57 INFO - 'LANG': 'en_US.UTF-8', 13:19:57 INFO - 'LANGUAGE': 'en_US:en', 13:19:57 INFO - 'LOGNAME': 'cltbld', 13:19:57 INFO - 'MAIL': '/var/mail/cltbld', 13:19:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:57 INFO - 'MOZ_NO_REMOTE': '1', 13:19:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:57 INFO - 'NO_EM_RESTART': '1', 13:19:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:57 INFO - 'PWD': '/builds/slave/test', 13:19:57 INFO - 'SHELL': '/bin/bash', 13:19:57 INFO - 'SHLVL': '1', 13:19:57 INFO - 'TERM': 'linux', 13:19:57 INFO - 'TMOUT': '86400', 13:19:57 INFO - 'USER': 'cltbld', 13:19:57 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469737162.615521-1545804640', 13:19:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:57 INFO - '_': '/tools/buildbot/bin/python'} 13:19:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:57 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)) 13:19:57 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)) 13:19:57 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)) 13:19:57 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)) 13:19:57 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)) 13:19:57 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)) 13:19:57 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)) 13:19:57 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)) 13:19:57 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)) 13:19:57 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)) 13:19:57 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)) 13:19:57 INFO - Cleaning up... 13:19:57 INFO - Return code: 0 13:19:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:19:57 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')]} 13:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:57 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')]} 13:19:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:57 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 0x1519030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17da180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d83b0>, '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 0x17d92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d9740>, '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': '0e2a256762fed810e2f0f810000001b3-1469737162.615521-1545804640', '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 13:19:57 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 13:19:57 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 13:19:57 INFO - Using env: {'DISPLAY': ':0', 13:19:57 INFO - 'HOME': '/home/cltbld', 13:19:57 INFO - 'LANG': 'en_US.UTF-8', 13:19:57 INFO - 'LANGUAGE': 'en_US:en', 13:19:57 INFO - 'LOGNAME': 'cltbld', 13:19:57 INFO - 'MAIL': '/var/mail/cltbld', 13:19:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:57 INFO - 'MOZ_NO_REMOTE': '1', 13:19:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:57 INFO - 'NO_EM_RESTART': '1', 13:19:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:57 INFO - 'PWD': '/builds/slave/test', 13:19:57 INFO - 'SHELL': '/bin/bash', 13:19:57 INFO - 'SHLVL': '1', 13:19:57 INFO - 'TERM': 'linux', 13:19:57 INFO - 'TMOUT': '86400', 13:19:57 INFO - 'USER': 'cltbld', 13:19:57 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469737162.615521-1545804640', 13:19:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:57 INFO - '_': '/tools/buildbot/bin/python'} 13:19:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:19:57 INFO - Cleaning up... 13:19:57 INFO - Return code: 0 13:19:57 INFO - Running post-action listener: _resource_record_post_action 13:19:57 INFO - Running post-action listener: _start_resource_monitoring 13:19:57 INFO - Starting resource monitoring. 13:19:57 INFO - [mozharness: 2016-07-28 20:19:57.530107Z] Finished create-virtualenv step (success) 13:19:57 INFO - [mozharness: 2016-07-28 20:19:57.530548Z] Running install step. 13:19:57 INFO - Running pre-action listener: _resource_record_pre_action 13:19:57 INFO - Running main action method: install 13:19:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:19:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:19:57 INFO - Reading from file tmpfile_stdout 13:19:57 INFO - Detecting whether we're running mozinstall >=1.0... 13:19:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:19:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:19:57 INFO - Reading from file tmpfile_stdout 13:19:57 INFO - Output received: 13:19:57 INFO - Usage: mozinstall [options] installer 13:19:57 INFO - Options: 13:19:57 INFO - -h, --help show this help message and exit 13:19:57 INFO - -d DEST, --destination=DEST 13:19:57 INFO - Directory to install application into. [default: 13:19:57 INFO - "/builds/slave/test"] 13:19:57 INFO - --app=APP Application being installed. [default: firefox] 13:19:57 INFO - mkdir: /builds/slave/test/build/application 13:19:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:19:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:20:15 INFO - Reading from file tmpfile_stdout 13:20:15 INFO - Output received: 13:20:15 INFO - /builds/slave/test/build/application/firefox/firefox 13:20:15 INFO - Running post-action listener: _resource_record_post_action 13:20:15 INFO - [mozharness: 2016-07-28 20:20:15.121232Z] Finished install step (success) 13:20:15 INFO - [mozharness: 2016-07-28 20:20:15.121579Z] Running run-tests step. 13:20:15 INFO - Running pre-action listener: _resource_record_pre_action 13:20:15 INFO - Running main action method: run_tests 13:20:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:20:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:20:15 INFO - Python 2.7.3 13:20:15 INFO - Return code: 0 13:20:15 INFO - grabbing minidump binary from tooltool 13:20:15 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')]} 13:20:15 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 0x17d83b0>, '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 0x17d92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d9740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:20:15 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 13:20:15 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 13:20:15 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 13:20:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:20:15 INFO - Return code: 0 13:20:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:20:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:20:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:20:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:20:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:20:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eULIeu5uRjOSaN3sqn-OCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:20:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eULIeu5uRjOSaN3sqn-OCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:20:15 INFO - Using env: {'DISPLAY': ':0', 13:20:15 INFO - 'HOME': '/home/cltbld', 13:20:15 INFO - 'LANG': 'en_US.UTF-8', 13:20:15 INFO - 'LANGUAGE': 'en_US:en', 13:20:15 INFO - 'LOGNAME': 'cltbld', 13:20:15 INFO - 'MAIL': '/var/mail/cltbld', 13:20:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:20:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:20:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:15 INFO - 'MOZ_NO_REMOTE': '1', 13:20:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:20:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:20:15 INFO - 'NO_EM_RESTART': '1', 13:20:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:20:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:15 INFO - 'PWD': '/builds/slave/test', 13:20:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:20:15 INFO - 'SHELL': '/bin/bash', 13:20:15 INFO - 'SHLVL': '1', 13:20:15 INFO - 'TERM': 'linux', 13:20:15 INFO - 'TMOUT': '86400', 13:20:15 INFO - 'USER': 'cltbld', 13:20:15 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469737162.615521-1545804640', 13:20:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:15 INFO - '_': '/tools/buildbot/bin/python'} 13:20:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eULIeu5uRjOSaN3sqn-OCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:20:15 INFO - mozversion application_buildid: 20160728103010 13:20:15 INFO - mozversion application_changeset: 9ec789c0ee5bd3a5e765513c21027fdad953b022 13:20:15 INFO - mozversion application_display_name: Nightly 13:20:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:20:15 INFO - mozversion application_name: Firefox 13:20:15 INFO - mozversion application_remotingname: firefox 13:20:15 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:20:15 INFO - mozversion application_vendor: Mozilla 13:20:15 INFO - mozversion application_version: 50.0a1 13:20:15 INFO - mozversion platform_buildid: 20160728103010 13:20:15 INFO - mozversion platform_changeset: 9ec789c0ee5bd3a5e765513c21027fdad953b022 13:20:15 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:20:15 INFO - mozversion platform_version: 50.0a1 13:20:15 INFO - using testdate: 1469737215 13:20:15 INFO - actual date: 1469737215 13:20:15 INFO - starting webserver on 'localhost:43529' 13:20:15 INFO - SUITE-START | Running 2 tests 13:20:15 INFO - TEST-START | dromaeo_css 13:20:15 INFO - operating with platform_type : linux_ 13:20:15 INFO - Initialising browser for dromaeo_css test... 13:20:15 INFO - TEST-INFO | started process 319 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9tSfCf/profile http://localhost:43529/getInfo.html) 13:20:18 INFO - PROCESS | 319 | JavaScript error: , line 0: uncaught exception: undefined 13:20:19 INFO - PROCESS | 319 | __metrics Screen width/height:1600/1200 13:20:19 INFO - PROCESS | 319 | colorDepth:24 13:20:19 INFO - PROCESS | 319 | Browser inner width/height: 1024/697 13:20:19 INFO - PROCESS | 319 | __metrics 13:20:20 INFO - PROCESS | 319 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:20:20 INFO - PROCESS | 319 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:20:21 INFO - TEST-INFO | 319: exit 0 13:20:21 INFO - Browser initialized. 13:20:21 INFO - Running cycle 1/1 for dromaeo_css test... 13:20:21 INFO - TEST-INFO | started process 401 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9tSfCf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:20:32 INFO - PROCESS | 401 | RSS: Main: 158208000 13:20:32 INFO - PROCESS | 401 | 13:21:23 INFO - PROCESS | 401 | 1469737283640 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] 13:23:32 INFO - PROCESS | 401 | Cycle 1(1): loaded http://localhost:43529/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43529/tests/dromaeo/cssquery-ext.html) 13:23:33 INFO - PROCESS | 401 | RSS: Main: 267259904 13:23:33 INFO - PROCESS | 401 | 13:26:36 INFO - PROCESS | 401 | Cycle 1(1): loaded http://localhost:43529/tests/dromaeo/cssquery-ext.html (next: http://localhost:43529/tests/dromaeo/cssquery-jquery.html) 13:26:36 INFO - PROCESS | 401 | RSS: Main: 251486208 13:26:36 INFO - PROCESS | 401 | 13:29:38 INFO - PROCESS | 401 | Cycle 1(1): loaded http://localhost:43529/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43529/tests/dromaeo/cssquery-mootools.html) 13:29:39 INFO - PROCESS | 401 | RSS: Main: 229830656 13:29:39 INFO - PROCESS | 401 | 13:32:41 INFO - PROCESS | 401 | Cycle 1(1): loaded http://localhost:43529/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43529/tests/dromaeo/cssquery-prototype.html) 13:32:41 INFO - PROCESS | 401 | RSS: Main: 215474176 13:32:41 INFO - PROCESS | 401 | 13:35:44 INFO - PROCESS | 401 | Cycle 1(1): loaded http://localhost:43529/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43529/tests/dromaeo/cssquery-yui.html) 13:35:45 INFO - PROCESS | 401 | RSS: Main: 188989440 13:35:45 INFO - PROCESS | 401 | 13:38:48 INFO - PROCESS | 401 | Cycle 1(1): loaded http://localhost:43529/tests/dromaeo/cssquery-yui.html (next: http://localhost:43529/tests/dromaeo/cssquery-dojo.html) 13:38:48 INFO - PROCESS | 401 | RSS: Main: 275083264 13:38:48 INFO - PROCESS | 401 | 13:38:48 INFO - PROCESS | 401 | __start_tp_report 13:38:48 INFO - PROCESS | 401 | _x_x_mozilla_page_load 13:38:48 INFO - PROCESS | 401 | _x_x_mozilla_page_load_details 13:38:48 INFO - PROCESS | 401 | |i|pagename|runs| 13:38:48 INFO - PROCESS | 401 | |0;dojo.html;3016.592759977403;3026.4249792539404;3040.787144899857;3046.7714921380903;3087.4288256672503;5233.764480598373;5279.973600131999;5343.839684809453;5396.055690254209;5401.027814993305;5281.260623512711;5298.178782288742;5326.227696983935;5326.840194794153;5394.271773310602;4787.042591481701;4821.855344339676;4864.854054378375;4866.148424025799;5000.574951129159;4936.555709986101;4946;4985.576226020793;4990.251462280668;4996.475370086143;4712.717236965793;4772.117158325721;4804.5916097131785;4816.566509014188;4826.203676393391;4773.665843390964;4781.211100168468;4811.374521312207;4920.237363208708;4952.950470495321;4773.451053128865;4799.592034677056;4804.279358096313;4820.662553621248;4859.659823812334;5146.305248791403;5165.793368265265;5296.496832800878;5340.706261155635;5344.465553444663;5545.334559852803;5572.164175373686;5621.578381621354;5630.4369563043365;5640.605157638967;5589.776408943638;5637.7181140942785;5657.57568182388;5662.745176467069;5666.12175112854;5131.2559678846355;5227.634065615371;5237.266782650432;5273.103572392664;5276.944611077762;5895.233619629421;5906.173135760997;5937.406259374028;5939.851503712442;5968.46283834457;5634.7182640867795;5640.576956728261;5683.914741278884;5684.431556844283;5689.573282003867;5376.46235376467;5672.773089076473;5722.971385143048;5767.019606666877;5769.221155144086;5699.857503562361;5727.0836666134055;5748.252727145528;5767.653940763567;5787.971060144672;5680.261565996394;5714.514266287412;5737.684427356536;5737.8565535861935;5777.277840269966;4226.260404429213;4292.720973136736;4349.652027837766;4412.0955204183065;4449.176902273025;3911.3741801311653;3924.2151569685607;3924.941125883114;3965.1673148638533;3986.262541429845;5356.517913387814;5364.91952620711;5395.271638328853;5406.02691515531;5406.053940560386;5558.221848941152;5561.221428999943;5614.719264036864;5798.449147330997;5852.619579727304;5303.973480132575;5306.548943339782;5310;5327;5345.091334473149;4825.541573550507;4848.80604775805;4862.41651001882;4867.099586576494;4909.509049095133;5775.133729940542;5796.855078623068;5839.649621022667;5839.824805255849;5843.2403787507355;5652.208690783212;5654.208410822571;5671.574631902541;5684.971575142098;5707;5848.298204215522;5851.180834683063;5854.882902341844;5858.9121163181735;5860.238169037998;5413.621046526705;5525.281713377235;5544.528715059265;5545.223668686306;5553.194786755978;5689.800856969986;5778.913316300343;5782;5797;5800;5604.747786349542;5614.915776263278;5618.606697531133;5619.100943848965;5619.80330688424;5389.973050134724;5393.6224464287125;5453.672779633234;5524.447555244444;5539.639923404966;5434.049041417815;5446.618736688394;5447.754851031634;5488.231647569263;5493.176023596492;5496.477834605706;5502.944970550403;5548.029094908456;5553.08374118266;5570.080936645408;5290.338707661543;5388.218708287355;5389.137737961907;5428.945710542844;5505.504504594605 13:38:48 INFO - PROCESS | 401 | |1;ext.html;598.1058317814867;599.7391134856338;627.1690010735775;637.4008432073847;644.7131026693118;44550.55449445505;45778.54221457784;45876.311855322194;45885.31172032422;49404;47072.529274707245;47546;47579;47585.28622070663;47664.52335476653;8991.505467199318;9145.359824812265;9150;9150.49672268025;9156.130167634064;9028.954855225747;9129.315301352392;9137.634494620208;9139.908600914005;9141.222996045311;9130.954345228298;9141.542922853863;9173.95413022934;9178.908210917905;9186.724398268063;9110.908890911072;9114.908850911506;9147;9153.771155721093;9153.862692059658;8919.910800892038;8990.685326013558;9001.23489503393;9001.50491722955;9002.639894404216;43996.780016099714;44267.33598996018;44300.556994429964;44354;44386;3507.82487866565;3634.8727794527063;4023.6982226333143;4171.874843754692;4358.5205627380965;33074.3385132296;33241.83379083113;33248.501272480935;33261.6673833261;33366.33267334664;4250.659947204216;4379.802908869076;4558;4625.537446255347;4627.097715945392;336507;336976;337350;337839;338897.30551347334;59895;60499.09251361233;60531;60574.394256057756;60598;62493;63071.36928630747;63312;63415.36584634187;63521;16418.83581164173;16689.833101668828;16695.49913502597;16696.578996045748;16704.331826726793;12371.195872268274;12375.443105060114;12409.813852792215;12417.31704756229;12429.378531073591;16526.586835329213;17453.82546174522;17573.824261757476;17639.206235719168;17758.37845675395;6206.72069756862;6343.302236753953;6410.583312084699;6570.671466426659;6596.934030659728;999.2855108597388;1106.5186643809968;1128.3004537186996;1129.5368898751472;1134.393099691661;31530.211744706106;33177.50233746496;33313.83343083269;33433.33133337319;33933.15167120842;1098.1105304703055;1112.404863398078;1120.2662256222188;1181.3561608922985;1231.4027696567157;17280.868817161445;17340.47978560645;17642.911785440992;17700.056154369875;17723.202455889517;493574;539030;544595;545847.812282816;818781;59660.70169649124;60306.69846650738;60424.77026608095;60654;60755.39244607586;1238.8575313839024;1352.1076089780502;1379.2069560003038;1382.315753701924;1423.8504956979575;30690.84654576713;34389;34401.48397773985;34483.13792155216;34512.48231276583;51621;52394.73802630963;52395.73802130965;52491.800655948195;52519.73740131275;391241;393956;394895;395268;395516;25201.87399062993;25976.22071337863;25993.350166245997;28459.43081138324;28774.568381474714;36789.10721956389;42662.57337426586;50458;51975.48024519706;52082.218766719285;41317.58682413137;42218.15563688648;42398.788006059774;42518.14963700647;44080.33879491746;42042.789786050875;42336.364954526325;42369.36445953252;42917;44058.77970610127;34000.48999264964;34595.82702086474;34816.82591587026;34820.65179348174;34857;33812;37050.44424333691;37618.811905940296;37656.623433765315;38116.428253575665;28220.12131810462;28343.716562834106;28442.71557284401;28447.715522844508;28708.712912870604 13:38:48 INFO - PROCESS | 401 | |2;jquery.html;376.9811509424528;381.4000268872083;395.55500062429775;397.41778294798127;413.45630495897893;14423.5672929812;16561;17973.28106875725;19659.213631454742;19708.90145549272;18667.25330986762;18671.439856804285;18847.340343087995;18910.338138165167;19630.705539416886;5449.863753406157;5792.189093526909;5792.478676919077;5796.65220086794;5806.825795226129;4102.692298077656;5703.657780533161;5776.797812076578;6167.938320616781;6463.870722585545;6462.22453305604;6506.089147519351;6509.869802603945;6518.51111166662;6518.902216466757;6265;6398.648074355909;6426;6433.131527243809;6435.806925792233;5506.91739623906;5672.773089076432;5675.9432405675825;5678.0915053591225;5681.204631351614;23100.42248943773;23454.296371108892;23582.41043973897;23808.76191238083;23936.760632393627;2264.547090581874;2280.669302951063;2327.6043072677517;2409.807215422762;2467.506498700267;14086.859131408657;14693.706125877423;14694.632634184123;14723.484678036217;14778.852211477855;1865.6082222733241;1898.1078892920304;1928.0552529260701;1991.332903477337;2058.763242227148;78528.60735696285;80135;80328;81880.59059704722;82437.17562824415;10283.434411107311;10376.066154046172;10500.159987201005;10641.787164256826;10800.945995269973;14746.483873064391;14770.630734231516;14771.039882407824;14799.556013319618;14803.519648035326;7807.609619519001;7970.4819186752675;8076.676932922617;8092.433529652868;8213.712520061768;7783.844323113506;7919.960400197962;7949.165337639581;8097.35221182304;8177.386695997824;6490.383413575797;6568.113304703899;6587.242467116247;6633.237177724527;6756.763513277012;1869.5793446474706;1894.422201228611;1901.8573606979533;1911.550785565391;1962.5191828001946;406.42896730094265;419.65797874731993;421.1576846307385;432.61065041462933;1056.5087234436023;11108.389038602954;11501.13741469393;11738.06095512357;11930.284182948877;12023.098267629963;446.4352593968632;449.0256144167165;450.3020318506302;451.1000553895;451.3342819341511;10689;11231.775364492665;11451.427428628534;11809.468573914195;12251.816222756666;476900;478077.92493487813;481542;486189;486400;57887.710561446926;70944;73427.63286183534;97241;100224.49887750515;971.5870754929268;1006.0342071611188;1036.7304500829687;1053.1837825685002;1054.9683509494728;13436.798448023483;17728.91135544314;17758.644827103642;18884.244630215187;18962.24151033943;36464.453033205056;42853.78573107115;43421;43455.782721086194;44169.77915110404;57271.713641431525;58586;58606;58608.41391586029;58683.413165867794;8081.272685458337;8402.705905293285;8412.831743365221;8531.8720219198;8823.867641985247;10563.788724225626;12630.873691263338;12800.6799830005;13290.80806318974;13713.862861371259;11218.719532011439;11436.67014769526;11585.942070289595;11831.526738930346;12251.326177060348;7118.394936430462;11049.28179668319;11065.944670276918;11192.664220073411;11614.6515604532;11459;11784.70538236551;11786.646400607995;11852.585159519376;11874.346910919983;8112.959435202786;8282.296004839414;8360.372972027244;8456.32349412058;8729.25801306896;10819.783604327711;10833.86244444322;11600.767984640092;11657.76684466289;11866.584669536525 13:38:48 INFO - PROCESS | 401 | |3;mootools.html;1330.0888891109591;1427.885769138469;1502.519193857965;1761.409927674229;1779.466160151955;7997.6001199940065;8525.744227673164;8528.70149544766;8534.317254619631;8546.230839224469;7288.744893928713;7739.651715672794;7963;7987.20127987201;8346.83306333873;2245.360072379372;2266.9773302267013;2270.886455677218;2271.2618399020303;2281.7604151564096;2265.592193405186;2271.5116250006326;2304.3087073877855;2318.7797159269844;2326.1742081561056;2312.3409828198965;2329.5923213437663;2331.3821837213154;2332.615118505453;2341.3912382780513;2235.362921567362;2247.674087257347;2248.1794145136987;2252.842301038928;2256.8420210585264;2251.819854411643;2252;2256.9322920312416;2257.356653353803;2259.6949411829523;8249.381296402793;8273.544955027472;8299.377546684023;8307.958460207721;8318.292945099674;4970.925436118461;5065.645404821664;5078.568321692624;5105.795768169269;5106.336176297094;3226.161198088514;3264.67353264674;3483.7038851697635;3492.1444246159854;3496.7727097738566;1199.0467578275293;1215.7568486302775;2131.2434085899436;2178.531615702616;2187.1798075721604;10937.890621093768;11418.486168122454;11447.942760286145;11468.254563453349;11470.082393408507;4276.8289268429535;4332.35014747784;4386.232409328355;4421.756803375845;4564.863054108382;9723.222142228604;9724.367916085432;9733.172680322252;9743.61025558984;9744.07431294026;5083.262926875583;5090.03289375025;5092.872678183075;5093.18509038552;5094.61790365724;4079.5716449772344;4556.157110934488;4633.907321853544;4669.533046695371;4702.811887524529;3921.4117882317883;3922.5096862892137;4034.0519977805193;4052.8378864845668;4059.878203653895;1254.2913254011455;1255.334672623511;1256.58532684214;1268.8794564516356;1270.275942712645;841.9789505262418;988.5946761827616;989.1592146675268;990.980180396388;1029.5109822834095;5727.8568035799435;5865.178874957509;5968.283805943314;5968.880622387528;6093.96953015241;425.083944100464;436.9781510924441;442.8095918754966;447.24192493722825;451.0505386162147;4042;4125.711200216017;4138.772367519755;4163.188178305201;4184.330507118846;10204.846927296096;10485.9475702621;10538.894611053945;10571.15430765537;10622.46887655614;10396.220283478619;10452;10501;10516.894831051744;10583;7626.58053807046;7889.0927543333255;7960.522368657899;7967.760967170994;7975.720849770346;5942.227510423617;5984.581079324405;6009.489193418608;6062.575619706755;6102.908456373069;9121.77195570116;9536.189423899046;9548.045195480396;9576.186024187744;9649.614015439303;9651.613935442503;9737.415755054719;9763.121319081316;9835.60657573689;9911.207103431563;6885.655717214019;6924.688389022405;6945.583265004116;7565.2812982766545;7684.807879802826;7588.506747061423;7647;7647.885281720667;7652.234776522303;7655.655495502604;6749.392554670103;6849.691763870538;6866.279040700654;6879.759208427681;7049.859002819812;6659.101021362248;6662.367075127855;6674.966625166843;6688.197416310074;6695.363940425652;6149.907751383822;6190.566660333733;6198.907016394667;6214.25428948529;6596.340365963365;5124.615653826053;5139.100657385017;5200.60995425337;5204.297419848272;5363.436839131991;5223.399309079505;5229.320188375486;5250.291210686509;5309.65487243328;5386.007177344408 13:38:48 INFO - PROCESS | 401 | |4;prototype.html;298.4463819614613;311.12418541804817;314.3132256020594;315.4290733771873;316.3641081426333;5265.657732247406;5283.626257173134;5316.840494785153;5319.3084898963125;5340.198970154479;4916.4837692042265;5041.84874453766;5105.897882042357;5158.484151584849;5205.193195054772;4095.262852686515;4105.404716316132;4117.485314335708;4138.606832350929;4152.4394206782;4065.8983525411804;4098.241825262321;4115.670746340285;4150.3566947123245;4154.418381426588;3850.8074596270076;3906.0430194602363;4064.654504367132;4064.8780536583804;4085.407615895693;4064.252371480277;4068.328725760246;4092.529359123709;4093.4678491796176;4097.487814023247;3549.0949807798847;3606.549181352331;3618.8371523281253;3622.5471816022996;3630.1832087780303;4847.587955023827;5003.849884503435;5144.099782538078;5146.433892271847;5152.92270615941;4608.193566125948;4615.515370886076;4622.768861556942;4633.582977532038;4639.628829693616;5413.404525502192;5434.64674796137;5491.258680078218;5493.2034854945805;5505.449455054502;3790.90522736931;3900.4929359183407;3919.7648141111627;3920.764754114734;3927.2734544109144;5634.281544129039;5640.576956728261;5657.010023245915;5661.575381846378;5684.4315568443235;4062.5171812288895;4066.8576599818866;4088.1823635273063;4095.1604920991126;4103.384492326175;4035.9394609080887;4133.04939863833;4136.358864376027;4158.4178215049915;4160.646345060643;4624.982503849148;4630.6758526902795;4685.508021657677;4711.552402521755;4730;5363.973180134074;5422.91865622016;5431.34823821144;5455;5473.741039560923;1374.8625137486172;1398.3497673581833;1413.1662319231702;1415.3843078260988;1417.5322143692556;915.0849150849151;929.330881765128;931.8415869302235;936.7330310861372;938.2822141062093;4675.906481870344;4688.531146885284;4714;4721.409823772028;4787.473377928425;5000.74996250186;5014.172661510883;5018.996200759862;5034.219695947061;5099.796008159707;4695.708680112928;4743.241081426955;4868.3427737255015;5297.470252974672;5302.1781623848365;2952.4980753271993;2968.792184547104;2983.3287510310006;2984.388200418909;2986.6416030076093;5695.772169113189;5850.385709500526;5852.7658893643775;5869.970650146722;5870.708444142368;5693.516051135617;5700.971495142498;5707.429257074343;5728.28151554532;5734.971325143431;5806.44838740319;5840.620359676607;5859.296884373903;5891.1457838612305;5891.852703682356;5386.48828361305;5588.30146231721;5627.296587926509;5659.717014149193;5678.659280443187;5541.307336582927;5562.415946325739;5576.888462230814;5584.050711379156;5585.860353491195;5774.697151077112;5840.883182336414;5842.591018628656;5847.649141051551;5861.912071319019;3817.25563515123;3943.6253555912144;3972.165845172546;3986.382110772835;3993.900152496211;5290.44450332725;5475.6440831345835;5582.609217354909;5656.236408084856;5673.177389278614;5447.564194864481;5456.172182318967;5488.737590354161;5492.395836457907;5550.167474878801;5450.672959622435;5462.126059830408;5467.699276539828;5499.340079190522;5501.614886958035;5216.37403511581;5387.191921211849;5392.568594512508;5400.918986215132;5406.567474602101;5490.258815059916;5502.779888804403;5510.1459273812625;5514.503694667499;5520.779168833202;5264.2630031794815;5356.339534744242;5382.73086345689;5389.547755771193;5422.15956526739 13:38:48 INFO - PROCESS | 401 | |5;yui.html;781.8983532140822;783.5768684910149;811.6956141446957;857.6697971281055;883.1698203688536;15010.099394036351;15021.39914403424;15204.619884502892;15246.085234885886;15606.063636181823;15353.84646153541;15505.224738763072;15642.921785391085;15702.450414235504;15957.52127436176;801.3829351399434;814.4828034198297;818.2880893622556;819.0253598218102;820.3478234803316;677.2854638356532;793.9880901786478;812.2851890336495;815.5514467043132;828.4987582512583;880.2341962492641;887.6227603268617;889.2308153447286;889.4885440871492;889.7686601483629;880.5465185429509;881.1100788203896;881.1496905486205;881.5107615273521;881.5415983688478;518.1010946008672;621.9222597175353;633.0441034038635;640.9391107844747;641.1248645598771;15610.76583851243;15709.21453927299;15726.56238283068;15728.842711572852;15752.369905203777;14266.429342826275;14500.927495362455;14536.273186340746;14827.184504852228;14852.62868428298;13252.403641836141;13437.529686460926;13487.595372138852;13650.863491365059;14139.858601413956;4279.700420970534;4386.451693538308;4390.912181756347;4424.845130420452;4436.401085853401;72401;72737.6363118181;74425;75096;75435.62282188554;11063.336199827874;11210.439478026066;11380;11412.372319522507;11414.942925285486;21110;21126.683099753514;21137.78862211389;21144.682829757567;21165.68251476229;8239.958800206081;8257.917420825836;8372.832543349099;8380.916190838136;8412.537310447984;4517.593416592523;4536.342230376643;4587.357769912215;4609.3086037094035;4723.4331880174595;3183.060997005889;3237.8866739664;3268.3953468608383;3279.475283954556;3295.2256219788333;575.6977586766981;588.6497533967282;597.856514436532;599.9590710117942;617.197643064015;590.4331841432187;638.0110828216247;663.6283681138482;664.4020381656451;695.0339028750042;9307.348485605942;9462.858057129148;9536.570854311572;9733.659321923698;9759.804803903882;705.9375639662276;715.0918333716152;723.2116992478224;732.2969948849164;734.7832389445019;4400.163968845973;4527.841525546656;4608.879281510075;4686.484486706459;4735.810567577259;97609;100336.49831750794;101563;116299.41850290695;117355.41322293333;95887.52056239813;95925.52037239769;96737.03262967421;97469;99050;54736.90526189454;56139;66882;71267;85352.14647853567;10282.383057016603;10300.172764885365;10422.374657520573;10589.835118137153;10599.682009539727;51528.48471515237;52700;52967.47032529779;54018.729906351786;54236;44078;45225.32162017506;62353.68823155855;74550;76030;13255.66860828487;13475.595732128051;13637.727245455233;13668.31658417095;13687.863121368659;13041.543545975845;13437.260950647416;13673.726525469634;13937.118723603844;14205.644858878612;12896.742065158833;12912.806307905577;13228.933855331046;13556.525521606696;13576.86423135756;12803.167794093353;12858.614241572768;13015.804762928754;13222.140560863512;13574.185548867099;12479.93760031194;12663.493460261854;12807.295598741786;12910.612681619567;13250.947454167197;10508.894911050791;10641.733956651145;10647.574097036031;11094.889051109385;11541.249818761753;10971;11563.826542602035;11960.10299227544;12223.755524889275;12508.374581270718 13:38:48 INFO - PROCESS | 401 | __end_tp_report 13:38:48 INFO - PROCESS | 401 | __start_cc_report 13:38:48 INFO - PROCESS | 401 | _x_x_mozilla_cycle_collect,935 13:38:48 INFO - PROCESS | 401 | __end_cc_report 13:38:48 INFO - PROCESS | 401 | __startTimestamp1469738328504__endTimestamp 13:38:48 INFO - PROCESS | 401 | 13:38:48 INFO - PROCESS | 401 | ------- Summary: start ------- 13:38:48 INFO - PROCESS | 401 | Number of tests: 6 13:38:48 INFO - PROCESS | 401 | 13:38:48 INFO - PROCESS | 401 | [#0] dojo.html Cycles:165 Average:5275.43 Median:5428.95 stddev:597.94 (11.0%) stddev-sans-first:572.92 13:38:48 INFO - PROCESS | 401 | Values: 3016.6 3026.4 3040.8 3046.8 3087.4 5233.8 5280.0 5343.8 5396.1 5401.0 5281.3 5298.2 5326.2 5326.8 5394.3 4787.0 4821.9 4864.9 4866.1 5000.6 4936.6 4946.0 4985.6 4990.3 4996.5 4712.7 4772.1 4804.6 4816.6 4826.2 4773.7 4781.2 4811.4 4920.2 4953.0 4773.5 4799.6 4804.3 4820.7 4859.7 5146.3 5165.8 5296.5 5340.7 5344.5 5545.3 5572.2 5621.6 5630.4 5640.6 5589.8 5637.7 5657.6 5662.7 5666.1 5131.3 5227.6 5237.3 5273.1 5276.9 5895.2 5906.2 5937.4 5939.9 5968.5 5634.7 5640.6 5683.9 5684.4 5689.6 5376.5 5672.8 5723.0 5767.0 5769.2 5699.9 5727.1 5748.3 5767.7 5788.0 5680.3 5714.5 5737.7 5737.9 5777.3 4226.3 4292.7 4349.7 4412.1 4449.2 3911.4 3924.2 3924.9 3965.2 3986.3 5356.5 5364.9 5395.3 5406.0 5406.1 5558.2 5561.2 5614.7 5798.4 5852.6 5304.0 5306.5 5310.0 5327.0 5345.1 4825.5 4848.8 4862.4 4867.1 4909.5 5775.1 5796.9 5839.6 5839.8 5843.2 5652.2 5654.2 5671.6 5685.0 5707.0 5848.3 5851.2 5854.9 5858.9 5860.2 5413.6 5525.3 5544.5 5545.2 5553.2 5689.8 5778.9 5782.0 5797.0 5800.0 5604.7 5614.9 5618.6 5619.1 5619.8 5390.0 5393.6 5453.7 5524.4 5539.6 5434.0 5446.6 5447.8 5488.2 5493.2 5496.5 5502.9 5548.0 5553.1 5570.1 5290.3 5388.2 5389.1 5428.9 5505.5 13:38:48 INFO - PROCESS | 401 | 13:38:48 INFO - PROCESS | 401 | [#1] ext.html Cycles:180 Average:60603.71 Median:23384.40 stddev:121914.33 (521.3%) stddev-sans-first:122173.08 13:38:48 INFO - PROCESS | 401 | Values: 598.1 599.7 627.2 637.4 644.7 44550.6 45778.5 45876.3 45885.3 49404.0 47072.5 47546.0 47579.0 47585.3 47664.5 8991.5 9145.4 9150.0 9150.5 9156.1 9029.0 9129.3 9137.6 9139.9 9141.2 9131.0 9141.5 9174.0 9178.9 9186.7 9110.9 9114.9 9147.0 9153.8 9153.9 8919.9 8990.7 9001.2 9001.5 9002.6 43996.8 44267.3 44300.6 44354.0 44386.0 3507.8 3634.9 4023.7 4171.9 4358.5 33074.3 33241.8 33248.5 33261.7 33366.3 4250.7 4379.8 4558.0 4625.5 4627.1 336507.0 336976.0 337350.0 337839.0 338897.3 59895.0 60499.1 60531.0 60574.4 60598.0 62493.0 63071.4 63312.0 63415.4 63521.0 16418.8 16689.8 16695.5 16696.6 16704.3 12371.2 12375.4 12409.8 12417.3 12429.4 16526.6 17453.8 17573.8 17639.2 17758.4 6206.7 6343.3 6410.6 6570.7 6596.9 999.3 1106.5 1128.3 1129.5 1134.4 31530.2 33177.5 33313.8 33433.3 33933.2 1098.1 1112.4 1120.3 1181.4 1231.4 17280.9 17340.5 17642.9 17700.1 17723.2 493574.0 539030.0 544595.0 545847.8 818781.0 59660.7 60306.7 60424.8 60654.0 60755.4 1238.9 1352.1 1379.2 1382.3 1423.9 30690.8 34389.0 34401.5 34483.1 34512.5 51621.0 52394.7 52395.7 52491.8 52519.7 391241.0 393956.0 394895.0 395268.0 395516.0 25201.9 25976.2 25993.4 28459.4 28774.6 36789.1 42662.6 50458.0 51975.5 52082.2 41317.6 42218.2 42398.8 42518.1 44080.3 42042.8 42336.4 42369.4 42917.0 44058.8 34000.5 34595.8 34816.8 34820.7 34857.0 33812.0 37050.4 37618.8 37656.6 38116.4 28220.1 28343.7 28442.7 28447.7 28708.7 13:38:48 INFO - PROCESS | 401 | 13:38:48 INFO - PROCESS | 401 | [#2] jquery.html Cycles:180 Average:28311.34 Median:18420.72 stddev:79310.90 (430.6%) stddev-sans-first:79505.66 13:38:48 INFO - PROCESS | 401 | Values: 377.0 381.4 395.6 397.4 413.5 14423.6 16561.0 17973.3 19659.2 19708.9 18667.3 18671.4 18847.3 18910.3 19630.7 5449.9 5792.2 5792.5 5796.7 5806.8 4102.7 5703.7 5776.8 6167.9 6463.9 6462.2 6506.1 6509.9 6518.5 6518.9 6265.0 6398.6 6426.0 6433.1 6435.8 5506.9 5672.8 5675.9 5678.1 5681.2 23100.4 23454.3 23582.4 23808.8 23936.8 2264.5 2280.7 2327.6 2409.8 2467.5 14086.9 14693.7 14694.6 14723.5 14778.9 1865.6 1898.1 1928.1 1991.3 2058.8 78528.6 80135.0 80328.0 81880.6 82437.2 10283.4 10376.1 10500.2 10641.8 10800.9 14746.5 14770.6 14771.0 14799.6 14803.5 7807.6 7970.5 8076.7 8092.4 8213.7 7783.8 7920.0 7949.2 8097.4 8177.4 6490.4 6568.1 6587.2 6633.2 6756.8 1869.6 1894.4 1901.9 1911.6 1962.5 406.4 419.7 421.2 432.6 1056.5 11108.4 11501.1 11738.1 11930.3 12023.1 446.4 449.0 450.3 451.1 451.3 10689.0 11231.8 11451.4 11809.5 12251.8 476900.0 478077.9 481542.0 486189.0 486400.0 57887.7 70944.0 73427.6 97241.0 100224.5 971.6 1006.0 1036.7 1053.2 1055.0 13436.8 17728.9 17758.6 18884.2 18962.2 36464.5 42853.8 43421.0 43455.8 44169.8 57271.7 58586.0 58606.0 58608.4 58683.4 8081.3 8402.7 8412.8 8531.9 8823.9 10563.8 12630.9 12800.7 13290.8 13713.9 11218.7 11436.7 11585.9 11831.5 12251.3 7118.4 11049.3 11065.9 11192.7 11614.7 11459.0 11784.7 11786.6 11852.6 11874.3 8113.0 8282.3 8360.4 8456.3 8729.3 10819.8 10833.9 11600.8 11657.8 11866.6 13:38:48 INFO - PROCESS | 401 | 13:38:48 INFO - PROCESS | 401 | [#3] mootools.html Cycles:180 Average:5524.91 Median:5091.45 stddev:3049.12 (59.9%) stddev-sans-first:3041.38 13:38:48 INFO - PROCESS | 401 | Values: 1330.1 1427.9 1502.5 1761.4 1779.5 7997.6 8525.7 8528.7 8534.3 8546.2 7288.7 7739.7 7963.0 7987.2 8346.8 2245.4 2267.0 2270.9 2271.3 2281.8 2265.6 2271.5 2304.3 2318.8 2326.2 2312.3 2329.6 2331.4 2332.6 2341.4 2235.4 2247.7 2248.2 2252.8 2256.8 2251.8 2252.0 2256.9 2257.4 2259.7 8249.4 8273.5 8299.4 8308.0 8318.3 4970.9 5065.6 5078.6 5105.8 5106.3 3226.2 3264.7 3483.7 3492.1 3496.8 1199.0 1215.8 2131.2 2178.5 2187.2 10937.9 11418.5 11447.9 11468.3 11470.1 4276.8 4332.4 4386.2 4421.8 4564.9 9723.2 9724.4 9733.2 9743.6 9744.1 5083.3 5090.0 5092.9 5093.2 5094.6 4079.6 4556.2 4633.9 4669.5 4702.8 3921.4 3922.5 4034.1 4052.8 4059.9 1254.3 1255.3 1256.6 1268.9 1270.3 842.0 988.6 989.2 991.0 1029.5 5727.9 5865.2 5968.3 5968.9 6094.0 425.1 437.0 442.8 447.2 451.1 4042.0 4125.7 4138.8 4163.2 4184.3 10204.8 10485.9 10538.9 10571.2 10622.5 10396.2 10452.0 10501.0 10516.9 10583.0 7626.6 7889.1 7960.5 7967.8 7975.7 5942.2 5984.6 6009.5 6062.6 6102.9 9121.8 9536.2 9548.0 9576.2 9649.6 9651.6 9737.4 9763.1 9835.6 9911.2 6885.7 6924.7 6945.6 7565.3 7684.8 7588.5 7647.0 7647.9 7652.2 7655.7 6749.4 6849.7 6866.3 6879.8 7049.9 6659.1 6662.4 6675.0 6688.2 6695.4 6149.9 6190.6 6198.9 6214.3 6596.3 5124.6 5139.1 5200.6 5204.3 5363.4 5223.4 5229.3 5250.3 5309.7 5386.0 13:38:48 INFO - PROCESS | 401 | 13:38:48 INFO - PROCESS | 401 | [#4] prototype.html Cycles:180 Average:4576.13 Median:5155.70 stddev:1341.39 (26.0%) stddev-sans-first:1306.16 13:38:48 INFO - PROCESS | 401 | Values: 298.4 311.1 314.3 315.4 316.4 5265.7 5283.6 5316.8 5319.3 5340.2 4916.5 5041.8 5105.9 5158.5 5205.2 4095.3 4105.4 4117.5 4138.6 4152.4 4065.9 4098.2 4115.7 4150.4 4154.4 3850.8 3906.0 4064.7 4064.9 4085.4 4064.3 4068.3 4092.5 4093.5 4097.5 3549.1 3606.5 3618.8 3622.5 3630.2 4847.6 5003.8 5144.1 5146.4 5152.9 4608.2 4615.5 4622.8 4633.6 4639.6 5413.4 5434.6 5491.3 5493.2 5505.4 3790.9 3900.5 3919.8 3920.8 3927.3 5634.3 5640.6 5657.0 5661.6 5684.4 4062.5 4066.9 4088.2 4095.2 4103.4 4035.9 4133.0 4136.4 4158.4 4160.6 4625.0 4630.7 4685.5 4711.6 4730.0 5364.0 5422.9 5431.3 5455.0 5473.7 1374.9 1398.3 1413.2 1415.4 1417.5 915.1 929.3 931.8 936.7 938.3 4675.9 4688.5 4714.0 4721.4 4787.5 5000.7 5014.2 5019.0 5034.2 5099.8 4695.7 4743.2 4868.3 5297.5 5302.2 2952.5 2968.8 2983.3 2984.4 2986.6 5695.8 5850.4 5852.8 5870.0 5870.7 5693.5 5701.0 5707.4 5728.3 5735.0 5806.4 5840.6 5859.3 5891.1 5891.9 5386.5 5588.3 5627.3 5659.7 5678.7 5541.3 5562.4 5576.9 5584.1 5585.9 5774.7 5840.9 5842.6 5847.6 5861.9 3817.3 3943.6 3972.2 3986.4 3993.9 5290.4 5475.6 5582.6 5656.2 5673.2 5447.6 5456.2 5488.7 5492.4 5550.2 5450.7 5462.1 5467.7 5499.3 5501.6 5216.4 5387.2 5392.6 5400.9 5406.6 5490.3 5502.8 5510.1 5514.5 5520.8 5264.3 5356.3 5382.7 5389.5 5422.2 13:38:48 INFO - PROCESS | 401 | 13:38:48 INFO - PROCESS | 401 | [#5] yui.html Cycles:180 Average:19618.67 Median:4477.00 stddev:27422.39 (612.5%) stddev-sans-first:27462.84 13:38:48 INFO - PROCESS | 401 | Values: 781.9 783.6 811.7 857.7 883.2 15010.1 15021.4 15204.6 15246.1 15606.1 15353.8 15505.2 15642.9 15702.5 15957.5 801.4 814.5 818.3 819.0 820.3 677.3 794.0 812.3 815.6 828.5 880.2 887.6 889.2 889.5 889.8 880.5 881.1 881.1 881.5 881.5 518.1 621.9 633.0 640.9 641.1 15610.8 15709.2 15726.6 15728.8 15752.4 14266.4 14500.9 14536.3 14827.2 14852.6 13252.4 13437.5 13487.6 13650.9 14139.9 4279.7 4386.5 4390.9 4424.8 4436.4 72401.0 72737.6 74425.0 75096.0 75435.6 11063.3 11210.4 11380.0 11412.4 11414.9 21110.0 21126.7 21137.8 21144.7 21165.7 8240.0 8257.9 8372.8 8380.9 8412.5 4517.6 4536.3 4587.4 4609.3 4723.4 3183.1 3237.9 3268.4 3279.5 3295.2 575.7 588.6 597.9 600.0 617.2 590.4 638.0 663.6 664.4 695.0 9307.3 9462.9 9536.6 9733.7 9759.8 705.9 715.1 723.2 732.3 734.8 4400.2 4527.8 4608.9 4686.5 4735.8 97609.0 100336.5 101563.0 116299.4 117355.4 95887.5 95925.5 96737.0 97469.0 99050.0 54736.9 56139.0 66882.0 71267.0 85352.1 10282.4 10300.2 10422.4 10589.8 10599.7 51528.5 52700.0 52967.5 54018.7 54236.0 44078.0 45225.3 62353.7 74550.0 76030.0 13255.7 13475.6 13637.7 13668.3 13687.9 13041.5 13437.3 13673.7 13937.1 14205.6 12896.7 12912.8 13228.9 13556.5 13576.9 12803.2 12858.6 13015.8 13222.1 13574.2 12479.9 12663.5 12807.3 12910.6 13250.9 10508.9 10641.7 10647.6 11094.9 11541.2 10971.0 11563.8 11960.1 12223.8 12508.4 13:38:48 INFO - PROCESS | 401 | -------- Summary: end -------- 13:38:48 INFO - PROCESS | 401 | 13:38:49 INFO - TEST-INFO | 401: exit 0 13:38:49 INFO - TEST-OK | dromaeo_css | took 1113898ms 13:38:49 INFO - TEST-START | kraken 13:38:49 INFO - operating with platform_type : linux_ 13:38:49 INFO - Initialising browser for kraken test... 13:38:49 INFO - TEST-INFO | started process 594 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp65Zjik/profile http://localhost:43529/getInfo.html) 13:38:52 INFO - PROCESS | 594 | JavaScript error: , line 0: uncaught exception: undefined 13:38:53 INFO - PROCESS | 594 | __metrics Screen width/height:1600/1200 13:38:53 INFO - PROCESS | 594 | colorDepth:24 13:38:53 INFO - PROCESS | 594 | Browser inner width/height: 1024/697 13:38:53 INFO - PROCESS | 594 | __metrics 13:38:54 INFO - PROCESS | 594 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:38:54 INFO - PROCESS | 594 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:38:54 INFO - PROCESS | 594 | console.error: PushService: 13:38:54 INFO - PROCESS | 594 | stateChangeProcessEnqueue: Error transitioning state 13:38:54 INFO - PROCESS | 594 | UnknownError 13:38:54 INFO - TEST-INFO | 594: exit 0 13:38:54 INFO - Browser initialized. 13:38:54 INFO - Running cycle 1/1 for kraken test... 13:38:54 INFO - TEST-INFO | started process 675 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp65Zjik/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:39:06 INFO - PROCESS | 675 | RSS: Main: 157818880 13:39:06 INFO - PROCESS | 675 | 13:39:09 INFO - PROCESS | 675 | Cycle 1(1): loaded http://localhost:43529/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43529/tests/kraken/driver.html?testName=audio-beat-detection) 13:39:10 INFO - PROCESS | 675 | RSS: Main: 214679552 13:39:10 INFO - PROCESS | 675 | 13:39:12 INFO - PROCESS | 675 | Cycle 1(1): loaded http://localhost:43529/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43529/tests/kraken/driver.html?testName=audio-dft) 13:39:13 INFO - PROCESS | 675 | RSS: Main: 189104128 13:39:13 INFO - PROCESS | 675 | 13:39:16 INFO - PROCESS | 675 | Cycle 1(1): loaded http://localhost:43529/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43529/tests/kraken/driver.html?testName=audio-fft) 13:39:17 INFO - PROCESS | 675 | RSS: Main: 270667776 13:39:17 INFO - PROCESS | 675 | 13:39:19 INFO - PROCESS | 675 | Cycle 1(1): loaded http://localhost:43529/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43529/tests/kraken/driver.html?testName=audio-oscillator) 13:39:19 INFO - PROCESS | 675 | RSS: Main: 182001664 13:39:19 INFO - PROCESS | 675 | 13:39:22 INFO - PROCESS | 675 | Cycle 1(1): loaded http://localhost:43529/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43529/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:39:22 INFO - PROCESS | 675 | RSS: Main: 186470400 13:39:22 INFO - PROCESS | 675 | 13:39:25 INFO - PROCESS | 675 | Cycle 1(1): loaded http://localhost:43529/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43529/tests/kraken/driver.html?testName=imaging-darkroom) 13:39:26 INFO - PROCESS | 675 | RSS: Main: 222076928 13:39:26 INFO - PROCESS | 675 | 13:39:29 INFO - PROCESS | 675 | Cycle 1(1): loaded http://localhost:43529/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43529/tests/kraken/driver.html?testName=imaging-desaturate) 13:39:30 INFO - PROCESS | 675 | RSS: Main: 221396992 13:39:30 INFO - PROCESS | 675 | 13:39:33 INFO - PROCESS | 675 | Cycle 1(1): loaded http://localhost:43529/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43529/tests/kraken/driver.html?testName=json-parse-financial) 13:39:33 INFO - PROCESS | 675 | RSS: Main: 221016064 13:39:33 INFO - PROCESS | 675 | 13:39:35 INFO - PROCESS | 675 | Cycle 1(1): loaded http://localhost:43529/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43529/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:39:35 INFO - PROCESS | 675 | RSS: Main: 185249792 13:39:35 INFO - PROCESS | 675 | 13:39:37 INFO - PROCESS | 675 | Cycle 1(1): loaded http://localhost:43529/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43529/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:39:38 INFO - PROCESS | 675 | RSS: Main: 190136320 13:39:38 INFO - PROCESS | 675 | 13:39:40 INFO - PROCESS | 675 | Cycle 1(1): loaded http://localhost:43529/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43529/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:39:40 INFO - PROCESS | 675 | RSS: Main: 196149248 13:39:40 INFO - PROCESS | 675 | 13:39:43 INFO - PROCESS | 675 | Cycle 1(1): loaded http://localhost:43529/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43529/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:39:44 INFO - PROCESS | 675 | RSS: Main: 190681088 13:39:44 INFO - PROCESS | 675 | 13:39:46 INFO - PROCESS | 675 | Cycle 1(1): loaded http://localhost:43529/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43529/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:39:47 INFO - PROCESS | 675 | RSS: Main: 193576960 13:39:47 INFO - PROCESS | 675 | 13:39:48 INFO - PROCESS | 675 | Cycle 1(1): loaded http://localhost:43529/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43529/tests/kraken/driver.html?testName=ai-astar) 13:39:49 INFO - PROCESS | 675 | RSS: Main: 244097024 13:39:49 INFO - PROCESS | 675 | 13:39:49 INFO - PROCESS | 675 | __start_tp_report 13:39:49 INFO - PROCESS | 675 | _x_x_mozilla_page_load 13:39:49 INFO - PROCESS | 675 | _x_x_mozilla_page_load_details 13:39:49 INFO - PROCESS | 675 | |i|pagename|runs| 13:39:49 INFO - PROCESS | 675 | |0;ai-astar;103;112;111;111;112;112;110;111;109;112 13:39:49 INFO - PROCESS | 675 | |1;audio-beat-detection;164;122;149;164;118;118;154;119;190;118 13:39:49 INFO - PROCESS | 675 | |2;audio-dft;161;161;161;160;163;161;163;161;162;161 13:39:49 INFO - PROCESS | 675 | |3;audio-fft;76;79;74;109;77;76;75;76;109;74 13:39:49 INFO - PROCESS | 675 | |4;audio-oscillator;84;83;121;84;84;84;125;83;85;135 13:39:49 INFO - PROCESS | 675 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 13:39:49 INFO - PROCESS | 675 | |6;imaging-darkroom;147;147;146;146;146;147;146;146;146;145 13:39:49 INFO - PROCESS | 675 | |7;imaging-desaturate;94;95;95;95;96;95;96;95;95;96 13:39:49 INFO - PROCESS | 675 | |8;json-parse-financial;52;52;52;53;52;51;53;52;52;52 13:39:49 INFO - PROCESS | 675 | |9;json-stringify-tinderbox;64;63;63;63;64;63;63;63;63;64 13:39:49 INFO - PROCESS | 675 | |10;stanford-crypto-aes;78;77;76;76;76;77;75;76;75;80 13:39:49 INFO - PROCESS | 675 | |11;stanford-crypto-ccm;127;123;122;123;127;136;120;123;165;128 13:39:49 INFO - PROCESS | 675 | |12;stanford-crypto-pbkdf2;161;162;158;157;160;161;163;158;158;156 13:39:49 INFO - PROCESS | 675 | |13;stanford-crypto-sha256-iterative;67;65;65;65;64;64;74;63;63;62 13:39:49 INFO - PROCESS | 675 | __end_tp_report 13:39:49 INFO - PROCESS | 675 | __start_cc_report 13:39:49 INFO - PROCESS | 675 | _x_x_mozilla_cycle_collect,1696 13:39:49 INFO - PROCESS | 675 | __end_cc_report 13:39:49 INFO - PROCESS | 675 | __startTimestamp1469738389244__endTimestamp 13:39:49 INFO - PROCESS | 675 | 13:39:49 INFO - PROCESS | 675 | ------- Summary: start ------- 13:39:49 INFO - PROCESS | 675 | Number of tests: 14 13:39:49 INFO - PROCESS | 675 | 13:39:49 INFO - PROCESS | 675 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.50 stddev:2.75 (2.5%) stddev-sans-first:1.05 13:39:49 INFO - PROCESS | 675 | Values: 103.0 112.0 111.0 111.0 112.0 112.0 110.0 111.0 109.0 112.0 13:39:49 INFO - PROCESS | 675 | 13:39:49 INFO - PROCESS | 675 | [#1] audio-beat-detection Cycles:10 Average:141.60 Median:151.50 stddev:26.08 (17.2%) stddev-sans-first:26.37 13:39:49 INFO - PROCESS | 675 | Values: 164.0 122.0 149.0 164.0 118.0 118.0 154.0 119.0 190.0 118.0 13:39:49 INFO - PROCESS | 675 | 13:39:49 INFO - PROCESS | 675 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 13:39:49 INFO - PROCESS | 675 | Values: 161.0 161.0 161.0 160.0 163.0 161.0 163.0 161.0 162.0 161.0 13:39:49 INFO - PROCESS | 675 | 13:39:49 INFO - PROCESS | 675 | [#3] audio-fft Cycles:10 Average:82.50 Median:76.00 stddev:14.04 (18.5%) stddev-sans-first:14.70 13:39:49 INFO - PROCESS | 675 | Values: 76.0 79.0 74.0 109.0 77.0 76.0 75.0 76.0 109.0 74.0 13:39:49 INFO - PROCESS | 675 | 13:39:49 INFO - PROCESS | 675 | [#4] audio-oscillator Cycles:10 Average:96.80 Median:84.00 stddev:21.12 (25.1%) stddev-sans-first:21.89 13:39:49 INFO - PROCESS | 675 | Values: 84.0 83.0 121.0 84.0 84.0 84.0 125.0 83.0 85.0 135.0 13:39:49 INFO - PROCESS | 675 | 13:39:49 INFO - PROCESS | 675 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 13:39:49 INFO - PROCESS | 675 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 13:39:49 INFO - PROCESS | 675 | 13:39:49 INFO - PROCESS | 675 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 13:39:49 INFO - PROCESS | 675 | Values: 147.0 147.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 145.0 13:39:49 INFO - PROCESS | 675 | 13:39:49 INFO - PROCESS | 675 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 13:39:49 INFO - PROCESS | 675 | Values: 94.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 96.0 13:39:49 INFO - PROCESS | 675 | 13:39:49 INFO - PROCESS | 675 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.00 stddev:0.57 (1.1%) stddev-sans-first:0.60 13:39:49 INFO - PROCESS | 675 | Values: 52.0 52.0 52.0 53.0 52.0 51.0 53.0 52.0 52.0 52.0 13:39:49 INFO - PROCESS | 675 | 13:39:49 INFO - PROCESS | 675 | [#9] json-stringify-tinderbox Cycles:10 Average:63.30 Median:63.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 13:39:49 INFO - PROCESS | 675 | Values: 64.0 63.0 63.0 63.0 64.0 63.0 63.0 63.0 63.0 64.0 13:39:49 INFO - PROCESS | 675 | 13:39:49 INFO - PROCESS | 675 | [#10] stanford-crypto-aes Cycles:10 Average:76.60 Median:76.50 stddev:1.51 (2.0%) stddev-sans-first:1.51 13:39:49 INFO - PROCESS | 675 | Values: 78.0 77.0 76.0 76.0 76.0 77.0 75.0 76.0 75.0 80.0 13:39:49 INFO - PROCESS | 675 | 13:39:49 INFO - PROCESS | 675 | [#11] stanford-crypto-ccm Cycles:10 Average:129.40 Median:127.00 stddev:13.29 (10.5%) stddev-sans-first:14.07 13:39:49 INFO - PROCESS | 675 | Values: 127.0 123.0 122.0 123.0 127.0 136.0 120.0 123.0 165.0 128.0 13:39:49 INFO - PROCESS | 675 | 13:39:49 INFO - PROCESS | 675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.40 Median:160.50 stddev:2.32 (1.4%) stddev-sans-first:2.39 13:39:49 INFO - PROCESS | 675 | Values: 161.0 162.0 158.0 157.0 160.0 161.0 163.0 158.0 158.0 156.0 13:39:49 INFO - PROCESS | 675 | 13:39:49 INFO - PROCESS | 675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.00 stddev:3.39 (5.2%) stddev-sans-first:3.54 13:39:49 INFO - PROCESS | 675 | Values: 67.0 65.0 65.0 65.0 64.0 64.0 74.0 63.0 63.0 62.0 13:39:49 INFO - PROCESS | 675 | -------- Summary: end -------- 13:39:49 INFO - PROCESS | 675 | 13:39:50 INFO - TEST-INFO | 675: exit 0 13:39:50 INFO - TEST-OK | kraken | took 61006ms 13:39:50 INFO - SUITE-END | took 1174s 13:39:50 INFO - Completed test suite (00:19:35) 13:39:50 INFO - javascript benchmark 13:39:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3016.592759977403, 3026.4249792539404, 3040.787144899857, 3046.7714921380903, 3087.4288256672503, 5233.764480598373, 5279.973600131999, 5343.839684809453, 5396.055690254209, 5401.027814993305, 5281.260623512711, 5298.178782288742, 5326.227696983935, 5326.840194794153, 5394.271773310602, 4787.042591481701, 4821.855344339676, 4864.854054378375, 4866.148424025799, 5000.574951129159, 4936.555709986101, 4946.0, 4985.576226020793, 4990.251462280668, 4996.475370086143, 4712.717236965793, 4772.117158325721, 4804.5916097131785, 4816.566509014188, 4826.203676393391, 4773.665843390964, 4781.211100168468, 4811.374521312207, 4920.237363208708, 4952.950470495321, 4773.451053128865, 4799.592034677056, 4804.279358096313, 4820.662553621248, 4859.659823812334, 5146.305248791403, 5165.793368265265, 5296.496832800878, 5340.706261155635, 5344.465553444663, 5545.334559852803, 5572.164175373686, 5621.578381621354, 5630.4369563043365, 5640.605157638967, 5589.776408943638, 5637.7181140942785, 5657.57568182388, 5662.745176467069, 5666.12175112854, 5131.2559678846355, 5227.634065615371, 5237.266782650432, 5273.103572392664, 5276.944611077762, 5895.233619629421, 5906.173135760997, 5937.406259374028, 5939.851503712442, 5968.46283834457, 5634.7182640867795, 5640.576956728261, 5683.914741278884, 5684.431556844283, 5689.573282003867, 5376.46235376467, 5672.773089076473, 5722.971385143048, 5767.019606666877, 5769.221155144086, 5699.857503562361, 5727.0836666134055, 5748.252727145528, 5767.653940763567, 5787.971060144672, 5680.261565996394, 5714.514266287412, 5737.684427356536, 5737.8565535861935, 5777.277840269966, 4226.260404429213, 4292.720973136736, 4349.652027837766, 4412.0955204183065, 4449.176902273025, 3911.3741801311653, 3924.2151569685607, 3924.941125883114, 3965.1673148638533, 3986.262541429845, 5356.517913387814, 5364.91952620711, 5395.271638328853, 5406.02691515531, 5406.053940560386, 5558.221848941152, 5561.221428999943, 5614.719264036864, 5798.449147330997, 5852.619579727304, 5303.973480132575, 5306.548943339782, 5310.0, 5327.0, 5345.091334473149, 4825.541573550507, 4848.80604775805, 4862.41651001882, 4867.099586576494, 4909.509049095133, 5775.133729940542, 5796.855078623068, 5839.649621022667, 5839.824805255849, 5843.2403787507355, 5652.208690783212, 5654.208410822571, 5671.574631902541, 5684.971575142098, 5707.0, 5848.298204215522, 5851.180834683063, 5854.882902341844, 5858.9121163181735, 5860.238169037998, 5413.621046526705, 5525.281713377235, 5544.528715059265, 5545.223668686306, 5553.194786755978, 5689.800856969986, 5778.913316300343, 5782.0, 5797.0, 5800.0, 5604.747786349542, 5614.915776263278, 5618.606697531133, 5619.100943848965, 5619.80330688424, 5389.973050134724, 5393.6224464287125, 5453.672779633234, 5524.447555244444, 5539.639923404966, 5434.049041417815, 5446.618736688394, 5447.754851031634, 5488.231647569263, 5493.176023596492, 5496.477834605706, 5502.944970550403, 5548.029094908456, 5553.08374118266, 5570.080936645408, 5290.338707661543, 5388.218708287355, 5389.137737961907, 5428.945710542844, 5505.504504594605], "value": 5235.0889669278595, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.1058317814867, 599.7391134856338, 627.1690010735775, 637.4008432073847, 644.7131026693118, 44550.55449445505, 45778.54221457784, 45876.311855322194, 45885.31172032422, 49404.0, 47072.529274707245, 47546.0, 47579.0, 47585.28622070663, 47664.52335476653, 8991.505467199318, 9145.359824812265, 9150.0, 9150.49672268025, 9156.130167634064, 9028.954855225747, 9129.315301352392, 9137.634494620208, 9139.908600914005, 9141.222996045311, 9130.954345228298, 9141.542922853863, 9173.95413022934, 9178.908210917905, 9186.724398268063, 9110.908890911072, 9114.908850911506, 9147.0, 9153.771155721093, 9153.862692059658, 8919.910800892038, 8990.685326013558, 9001.23489503393, 9001.50491722955, 9002.639894404216, 43996.780016099714, 44267.33598996018, 44300.556994429964, 44354.0, 44386.0, 3507.82487866565, 3634.8727794527063, 4023.6982226333143, 4171.874843754692, 4358.5205627380965, 33074.3385132296, 33241.83379083113, 33248.501272480935, 33261.6673833261, 33366.33267334664, 4250.659947204216, 4379.802908869076, 4558.0, 4625.537446255347, 4627.097715945392, 336507.0, 336976.0, 337350.0, 337839.0, 338897.30551347334, 59895.0, 60499.09251361233, 60531.0, 60574.394256057756, 60598.0, 62493.0, 63071.36928630747, 63312.0, 63415.36584634187, 63521.0, 16418.83581164173, 16689.833101668828, 16695.49913502597, 16696.578996045748, 16704.331826726793, 12371.195872268274, 12375.443105060114, 12409.813852792215, 12417.31704756229, 12429.378531073591, 16526.586835329213, 17453.82546174522, 17573.824261757476, 17639.206235719168, 17758.37845675395, 6206.72069756862, 6343.302236753953, 6410.583312084699, 6570.671466426659, 6596.934030659728, 999.2855108597388, 1106.5186643809968, 1128.3004537186996, 1129.5368898751472, 1134.393099691661, 31530.211744706106, 33177.50233746496, 33313.83343083269, 33433.33133337319, 33933.15167120842, 1098.1105304703055, 1112.404863398078, 1120.2662256222188, 1181.3561608922985, 1231.4027696567157, 17280.868817161445, 17340.47978560645, 17642.911785440992, 17700.056154369875, 17723.202455889517, 493574.0, 539030.0, 544595.0, 545847.812282816, 818781.0, 59660.70169649124, 60306.69846650738, 60424.77026608095, 60654.0, 60755.39244607586, 1238.8575313839024, 1352.1076089780502, 1379.2069560003038, 1382.315753701924, 1423.8504956979575, 30690.84654576713, 34389.0, 34401.48397773985, 34483.13792155216, 34512.48231276583, 51621.0, 52394.73802630963, 52395.73802130965, 52491.800655948195, 52519.73740131275, 391241.0, 393956.0, 394895.0, 395268.0, 395516.0, 25201.87399062993, 25976.22071337863, 25993.350166245997, 28459.43081138324, 28774.568381474714, 36789.10721956389, 42662.57337426586, 50458.0, 51975.48024519706, 52082.218766719285, 41317.58682413137, 42218.15563688648, 42398.788006059774, 42518.14963700647, 44080.33879491746, 42042.789786050875, 42336.364954526325, 42369.36445953252, 42917.0, 44058.77970610127, 34000.48999264964, 34595.82702086474, 34816.82591587026, 34820.65179348174, 34857.0, 33812.0, 37050.44424333691, 37618.811905940296, 37656.623433765315, 38116.428253575665, 28220.12131810462, 28343.716562834106, 28442.71557284401, 28447.715522844508, 28708.712912870604], "value": 20376.659318551614, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.9811509424528, 381.4000268872083, 395.55500062429775, 397.41778294798127, 413.45630495897893, 14423.5672929812, 16561.0, 17973.28106875725, 19659.213631454742, 19708.90145549272, 18667.25330986762, 18671.439856804285, 18847.340343087995, 18910.338138165167, 19630.705539416886, 5449.863753406157, 5792.189093526909, 5792.478676919077, 5796.65220086794, 5806.825795226129, 4102.692298077656, 5703.657780533161, 5776.797812076578, 6167.938320616781, 6463.870722585545, 6462.22453305604, 6506.089147519351, 6509.869802603945, 6518.51111166662, 6518.902216466757, 6265.0, 6398.648074355909, 6426.0, 6433.131527243809, 6435.806925792233, 5506.91739623906, 5672.773089076432, 5675.9432405675825, 5678.0915053591225, 5681.204631351614, 23100.42248943773, 23454.296371108892, 23582.41043973897, 23808.76191238083, 23936.760632393627, 2264.547090581874, 2280.669302951063, 2327.6043072677517, 2409.807215422762, 2467.506498700267, 14086.859131408657, 14693.706125877423, 14694.632634184123, 14723.484678036217, 14778.852211477855, 1865.6082222733241, 1898.1078892920304, 1928.0552529260701, 1991.332903477337, 2058.763242227148, 78528.60735696285, 80135.0, 80328.0, 81880.59059704722, 82437.17562824415, 10283.434411107311, 10376.066154046172, 10500.159987201005, 10641.787164256826, 10800.945995269973, 14746.483873064391, 14770.630734231516, 14771.039882407824, 14799.556013319618, 14803.519648035326, 7807.609619519001, 7970.4819186752675, 8076.676932922617, 8092.433529652868, 8213.712520061768, 7783.844323113506, 7919.960400197962, 7949.165337639581, 8097.35221182304, 8177.386695997824, 6490.383413575797, 6568.113304703899, 6587.242467116247, 6633.237177724527, 6756.763513277012, 1869.5793446474706, 1894.422201228611, 1901.8573606979533, 1911.550785565391, 1962.5191828001946, 406.42896730094265, 419.65797874731993, 421.1576846307385, 432.61065041462933, 1056.5087234436023, 11108.389038602954, 11501.13741469393, 11738.06095512357, 11930.284182948877, 12023.098267629963, 446.4352593968632, 449.0256144167165, 450.3020318506302, 451.1000553895, 451.3342819341511, 10689.0, 11231.775364492665, 11451.427428628534, 11809.468573914195, 12251.816222756666, 476900.0, 478077.92493487813, 481542.0, 486189.0, 486400.0, 57887.710561446926, 70944.0, 73427.63286183534, 97241.0, 100224.49887750515, 971.5870754929268, 1006.0342071611188, 1036.7304500829687, 1053.1837825685002, 1054.9683509494728, 13436.798448023483, 17728.91135544314, 17758.644827103642, 18884.244630215187, 18962.24151033943, 36464.453033205056, 42853.78573107115, 43421.0, 43455.782721086194, 44169.77915110404, 57271.713641431525, 58586.0, 58606.0, 58608.41391586029, 58683.413165867794, 8081.272685458337, 8402.705905293285, 8412.831743365221, 8531.8720219198, 8823.867641985247, 10563.788724225626, 12630.873691263338, 12800.6799830005, 13290.80806318974, 13713.862861371259, 11218.719532011439, 11436.67014769526, 11585.942070289595, 11831.526738930346, 12251.326177060348, 7118.394936430462, 11049.28179668319, 11065.944670276918, 11192.664220073411, 11614.6515604532, 11459.0, 11784.70538236551, 11786.646400607995, 11852.585159519376, 11874.346910919983, 8112.959435202786, 8282.296004839414, 8360.372972027244, 8456.32349412058, 8729.25801306896, 10819.783604327711, 10833.86244444322, 11600.767984640092, 11657.76684466289, 11866.584669536525], "value": 8861.116941329508, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1330.0888891109591, 1427.885769138469, 1502.519193857965, 1761.409927674229, 1779.466160151955, 7997.6001199940065, 8525.744227673164, 8528.70149544766, 8534.317254619631, 8546.230839224469, 7288.744893928713, 7739.651715672794, 7963.0, 7987.20127987201, 8346.83306333873, 2245.360072379372, 2266.9773302267013, 2270.886455677218, 2271.2618399020303, 2281.7604151564096, 2265.592193405186, 2271.5116250006326, 2304.3087073877855, 2318.7797159269844, 2326.1742081561056, 2312.3409828198965, 2329.5923213437663, 2331.3821837213154, 2332.615118505453, 2341.3912382780513, 2235.362921567362, 2247.674087257347, 2248.1794145136987, 2252.842301038928, 2256.8420210585264, 2251.819854411643, 2252.0, 2256.9322920312416, 2257.356653353803, 2259.6949411829523, 8249.381296402793, 8273.544955027472, 8299.377546684023, 8307.958460207721, 8318.292945099674, 4970.925436118461, 5065.645404821664, 5078.568321692624, 5105.795768169269, 5106.336176297094, 3226.161198088514, 3264.67353264674, 3483.7038851697635, 3492.1444246159854, 3496.7727097738566, 1199.0467578275293, 1215.7568486302775, 2131.2434085899436, 2178.531615702616, 2187.1798075721604, 10937.890621093768, 11418.486168122454, 11447.942760286145, 11468.254563453349, 11470.082393408507, 4276.8289268429535, 4332.35014747784, 4386.232409328355, 4421.756803375845, 4564.863054108382, 9723.222142228604, 9724.367916085432, 9733.172680322252, 9743.61025558984, 9744.07431294026, 5083.262926875583, 5090.03289375025, 5092.872678183075, 5093.18509038552, 5094.61790365724, 4079.5716449772344, 4556.157110934488, 4633.907321853544, 4669.533046695371, 4702.811887524529, 3921.4117882317883, 3922.5096862892137, 4034.0519977805193, 4052.8378864845668, 4059.878203653895, 1254.2913254011455, 1255.334672623511, 1256.58532684214, 1268.8794564516356, 1270.275942712645, 841.9789505262418, 988.5946761827616, 989.1592146675268, 990.980180396388, 1029.5109822834095, 5727.8568035799435, 5865.178874957509, 5968.283805943314, 5968.880622387528, 6093.96953015241, 425.083944100464, 436.9781510924441, 442.8095918754966, 447.24192493722825, 451.0505386162147, 4042.0, 4125.711200216017, 4138.772367519755, 4163.188178305201, 4184.330507118846, 10204.846927296096, 10485.9475702621, 10538.894611053945, 10571.15430765537, 10622.46887655614, 10396.220283478619, 10452.0, 10501.0, 10516.894831051744, 10583.0, 7626.58053807046, 7889.0927543333255, 7960.522368657899, 7967.760967170994, 7975.720849770346, 5942.227510423617, 5984.581079324405, 6009.489193418608, 6062.575619706755, 6102.908456373069, 9121.77195570116, 9536.189423899046, 9548.045195480396, 9576.186024187744, 9649.614015439303, 9651.613935442503, 9737.415755054719, 9763.121319081316, 9835.60657573689, 9911.207103431563, 6885.655717214019, 6924.688389022405, 6945.583265004116, 7565.2812982766545, 7684.807879802826, 7588.506747061423, 7647.0, 7647.885281720667, 7652.234776522303, 7655.655495502604, 6749.392554670103, 6849.691763870538, 6866.279040700654, 6879.759208427681, 7049.859002819812, 6659.101021362248, 6662.367075127855, 6674.966625166843, 6688.197416310074, 6695.363940425652, 6149.907751383822, 6190.566660333733, 6198.907016394667, 6214.25428948529, 6596.340365963365, 5124.615653826053, 5139.100657385017, 5200.60995425337, 5204.297419848272, 5363.436839131991, 5223.399309079505, 5229.320188375486, 5250.291210686509, 5309.65487243328, 5386.007177344408], "value": 4439.531360648092, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.4463819614613, 311.12418541804817, 314.3132256020594, 315.4290733771873, 316.3641081426333, 5265.657732247406, 5283.626257173134, 5316.840494785153, 5319.3084898963125, 5340.198970154479, 4916.4837692042265, 5041.84874453766, 5105.897882042357, 5158.484151584849, 5205.193195054772, 4095.262852686515, 4105.404716316132, 4117.485314335708, 4138.606832350929, 4152.4394206782, 4065.8983525411804, 4098.241825262321, 4115.670746340285, 4150.3566947123245, 4154.418381426588, 3850.8074596270076, 3906.0430194602363, 4064.654504367132, 4064.8780536583804, 4085.407615895693, 4064.252371480277, 4068.328725760246, 4092.529359123709, 4093.4678491796176, 4097.487814023247, 3549.0949807798847, 3606.549181352331, 3618.8371523281253, 3622.5471816022996, 3630.1832087780303, 4847.587955023827, 5003.849884503435, 5144.099782538078, 5146.433892271847, 5152.92270615941, 4608.193566125948, 4615.515370886076, 4622.768861556942, 4633.582977532038, 4639.628829693616, 5413.404525502192, 5434.64674796137, 5491.258680078218, 5493.2034854945805, 5505.449455054502, 3790.90522736931, 3900.4929359183407, 3919.7648141111627, 3920.764754114734, 3927.2734544109144, 5634.281544129039, 5640.576956728261, 5657.010023245915, 5661.575381846378, 5684.4315568443235, 4062.5171812288895, 4066.8576599818866, 4088.1823635273063, 4095.1604920991126, 4103.384492326175, 4035.9394609080887, 4133.04939863833, 4136.358864376027, 4158.4178215049915, 4160.646345060643, 4624.982503849148, 4630.6758526902795, 4685.508021657677, 4711.552402521755, 4730.0, 5363.973180134074, 5422.91865622016, 5431.34823821144, 5455.0, 5473.741039560923, 1374.8625137486172, 1398.3497673581833, 1413.1662319231702, 1415.3843078260988, 1417.5322143692556, 915.0849150849151, 929.330881765128, 931.8415869302235, 936.7330310861372, 938.2822141062093, 4675.906481870344, 4688.531146885284, 4714.0, 4721.409823772028, 4787.473377928425, 5000.74996250186, 5014.172661510883, 5018.996200759862, 5034.219695947061, 5099.796008159707, 4695.708680112928, 4743.241081426955, 4868.3427737255015, 5297.470252974672, 5302.1781623848365, 2952.4980753271993, 2968.792184547104, 2983.3287510310006, 2984.388200418909, 2986.6416030076093, 5695.772169113189, 5850.385709500526, 5852.7658893643775, 5869.970650146722, 5870.708444142368, 5693.516051135617, 5700.971495142498, 5707.429257074343, 5728.28151554532, 5734.971325143431, 5806.44838740319, 5840.620359676607, 5859.296884373903, 5891.1457838612305, 5891.852703682356, 5386.48828361305, 5588.30146231721, 5627.296587926509, 5659.717014149193, 5678.659280443187, 5541.307336582927, 5562.415946325739, 5576.888462230814, 5584.050711379156, 5585.860353491195, 5774.697151077112, 5840.883182336414, 5842.591018628656, 5847.649141051551, 5861.912071319019, 3817.25563515123, 3943.6253555912144, 3972.165845172546, 3986.382110772835, 3993.900152496211, 5290.44450332725, 5475.6440831345835, 5582.609217354909, 5656.236408084856, 5673.177389278614, 5447.564194864481, 5456.172182318967, 5488.737590354161, 5492.395836457907, 5550.167474878801, 5450.672959622435, 5462.126059830408, 5467.699276539828, 5499.340079190522, 5501.614886958035, 5216.37403511581, 5387.191921211849, 5392.568594512508, 5400.918986215132, 5406.567474602101, 5490.258815059916, 5502.779888804403, 5510.1459273812625, 5514.503694667499, 5520.779168833202, 5264.2630031794815, 5356.339534744242, 5382.73086345689, 5389.547755771193, 5422.15956526739], "value": 4145.554953686418, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [781.8983532140822, 783.5768684910149, 811.6956141446957, 857.6697971281055, 883.1698203688536, 15010.099394036351, 15021.39914403424, 15204.619884502892, 15246.085234885886, 15606.063636181823, 15353.84646153541, 15505.224738763072, 15642.921785391085, 15702.450414235504, 15957.52127436176, 801.3829351399434, 814.4828034198297, 818.2880893622556, 819.0253598218102, 820.3478234803316, 677.2854638356532, 793.9880901786478, 812.2851890336495, 815.5514467043132, 828.4987582512583, 880.2341962492641, 887.6227603268617, 889.2308153447286, 889.4885440871492, 889.7686601483629, 880.5465185429509, 881.1100788203896, 881.1496905486205, 881.5107615273521, 881.5415983688478, 518.1010946008672, 621.9222597175353, 633.0441034038635, 640.9391107844747, 641.1248645598771, 15610.76583851243, 15709.21453927299, 15726.56238283068, 15728.842711572852, 15752.369905203777, 14266.429342826275, 14500.927495362455, 14536.273186340746, 14827.184504852228, 14852.62868428298, 13252.403641836141, 13437.529686460926, 13487.595372138852, 13650.863491365059, 14139.858601413956, 4279.700420970534, 4386.451693538308, 4390.912181756347, 4424.845130420452, 4436.401085853401, 72401.0, 72737.6363118181, 74425.0, 75096.0, 75435.62282188554, 11063.336199827874, 11210.439478026066, 11380.0, 11412.372319522507, 11414.942925285486, 21110.0, 21126.683099753514, 21137.78862211389, 21144.682829757567, 21165.68251476229, 8239.958800206081, 8257.917420825836, 8372.832543349099, 8380.916190838136, 8412.537310447984, 4517.593416592523, 4536.342230376643, 4587.357769912215, 4609.3086037094035, 4723.4331880174595, 3183.060997005889, 3237.8866739664, 3268.3953468608383, 3279.475283954556, 3295.2256219788333, 575.6977586766981, 588.6497533967282, 597.856514436532, 599.9590710117942, 617.197643064015, 590.4331841432187, 638.0110828216247, 663.6283681138482, 664.4020381656451, 695.0339028750042, 9307.348485605942, 9462.858057129148, 9536.570854311572, 9733.659321923698, 9759.804803903882, 705.9375639662276, 715.0918333716152, 723.2116992478224, 732.2969948849164, 734.7832389445019, 4400.163968845973, 4527.841525546656, 4608.879281510075, 4686.484486706459, 4735.810567577259, 97609.0, 100336.49831750794, 101563.0, 116299.41850290695, 117355.41322293333, 95887.52056239813, 95925.52037239769, 96737.03262967421, 97469.0, 99050.0, 54736.90526189454, 56139.0, 66882.0, 71267.0, 85352.14647853567, 10282.383057016603, 10300.172764885365, 10422.374657520573, 10589.835118137153, 10599.682009539727, 51528.48471515237, 52700.0, 52967.47032529779, 54018.729906351786, 54236.0, 44078.0, 45225.32162017506, 62353.68823155855, 74550.0, 76030.0, 13255.66860828487, 13475.595732128051, 13637.727245455233, 13668.31658417095, 13687.863121368659, 13041.543545975845, 13437.260950647416, 13673.726525469634, 13937.118723603844, 14205.644858878612, 12896.742065158833, 12912.806307905577, 13228.933855331046, 13556.525521606696, 13576.86423135756, 12803.167794093353, 12858.614241572768, 13015.804762928754, 13222.140560863512, 13574.185548867099, 12479.93760031194, 12663.493460261854, 12807.295598741786, 12910.612681619567, 13250.947454167197, 10508.894911050791, 10641.733956651145, 10647.574097036031, 11094.889051109385, 11541.249818761753, 10971.0, 11563.826542602035, 11960.10299227544, 12223.755524889275, 12508.374581270718], "value": 7469.582061449341, "unit": "score"}], "name": "dromaeo_css", "value": 7117.075657059499, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 111.0, 111.0, 112.0, 112.0, 110.0, 111.0, 109.0, 112.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 122.0, 149.0, 164.0, 118.0, 118.0, 154.0, 119.0, 190.0, 118.0], "value": 141.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 160.0, 163.0, 161.0, 163.0, 161.0, 162.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 79.0, 74.0, 109.0, 77.0, 76.0, 75.0, 76.0, 109.0, 74.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 121.0, 84.0, 84.0, 84.0, 125.0, 83.0, 85.0, 135.0], "value": 96.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 145.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 52.0, 53.0, 52.0, 51.0, 53.0, 52.0, 52.0, 52.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 63.0, 64.0, 63.0, 63.0, 63.0, 63.0, 64.0], "value": 63.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 76.0, 76.0, 76.0, 77.0, 75.0, 76.0, 75.0, 80.0], "value": 76.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 123.0, 122.0, 123.0, 127.0, 136.0, 120.0, 123.0, 165.0, 128.0], "value": 129.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 158.0, 157.0, 160.0, 161.0, 163.0, 158.0, 158.0, 156.0], "value": 159.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 65.0, 65.0, 64.0, 64.0, 74.0, 63.0, 63.0, 62.0], "value": 65.2, "unit": "score"}], "name": "kraken", "value": 1497.0000000000002, "alertThreshold": 2.0}]} 13:39:50 INFO - Return code: 0 13:39:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:39:50 INFO - # TBPL SUCCESS # 13:39:50 INFO - Running post-action listener: _resource_record_post_action 13:39:50 INFO - [mozharness: 2016-07-28 20:39:50.565821Z] Finished run-tests step (success) 13:39:50 INFO - Running post-run listener: _resource_record_post_run 13:39:50 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 554958848; Read time: 12; Write time: 461816 13:39:50 INFO - TinderboxPrint: CPU usage
13.0% 13:39:50 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 13:39:50 INFO - TinderboxPrint: I/O write bytes / time
554,958,848 / 461,816 13:39:50 INFO - TinderboxPrint: CPU idle
8,273.3 (87.0%) 13:39:50 INFO - TinderboxPrint: CPU user
1,195.1 (12.6%) 13:39:50 INFO - TinderboxPrint: Swap in / out
0 / 0 13:39:50 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 264146944; Read time: 0; Write time: 266076 13:39:50 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 290811904; Read time: 0; Write time: 195740 13:39:51 INFO - Running post-run listener: _upload_blobber_files 13:39:51 INFO - Blob upload gear active. 13:39:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:39:51 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 13:39:51 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:39:51 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:39:51 INFO - (blobuploader) - INFO - Open directory for files ... 13:39:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:39:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:39:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:39:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:39:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:39:52 INFO - (blobuploader) - INFO - Done attempting. 13:39:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:39:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:39:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:39:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:39:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:39:53 INFO - (blobuploader) - INFO - Done attempting. 13:39:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:39:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:39:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:40:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:40:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:40:02 INFO - (blobuploader) - INFO - Done attempting. 13:40:02 INFO - (blobuploader) - INFO - Iteration through files over. 13:40:02 INFO - Return code: 0 13:40:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:40:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:40:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc9a20865c26c6b68d529d2c880b97821383159d21e8e99b25213a97897c1af27ca0ea181c199ca43f058b752fc6aacdde587d7dcb6290f806e4a6e2d18185ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b925953f211f78b51d6f0e6b3d8b9fa7496750e106f3f7e24e8a4f6579d2deef598d0212e5f3ea41d7daad1637e224a54bf46b0799fe75381ed93d7d7362937", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60042368d064acc22d9aa8046a2b7dc720b118de871e6b0d3f996f9aa00ae3a65e77389b33a3585bea27661eaa90b4e2995485fbdfb912d3c819cc048bda2297"} 13:40:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:40:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:40:02 INFO - Contents: 13:40:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc9a20865c26c6b68d529d2c880b97821383159d21e8e99b25213a97897c1af27ca0ea181c199ca43f058b752fc6aacdde587d7dcb6290f806e4a6e2d18185ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b925953f211f78b51d6f0e6b3d8b9fa7496750e106f3f7e24e8a4f6579d2deef598d0212e5f3ea41d7daad1637e224a54bf46b0799fe75381ed93d7d7362937", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60042368d064acc22d9aa8046a2b7dc720b118de871e6b0d3f996f9aa00ae3a65e77389b33a3585bea27661eaa90b4e2995485fbdfb912d3c819cc048bda2297"} 13:40:02 INFO - Running post-run listener: copy_logs_to_upload_dir 13:40:02 INFO - Copying logs to upload dir... 13:40:02 INFO - mkdir: /builds/slave/test/build/upload/logs 13:40:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.930566 ========= master_lag: 0.46 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-07-28 13:40:03.304878) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 13:40:03.308883) ========= 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=0e2a256762fed810e2f0f810000001b3-1469737162.615521-1545804640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc9a20865c26c6b68d529d2c880b97821383159d21e8e99b25213a97897c1af27ca0ea181c199ca43f058b752fc6aacdde587d7dcb6290f806e4a6e2d18185ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b925953f211f78b51d6f0e6b3d8b9fa7496750e106f3f7e24e8a4f6579d2deef598d0212e5f3ea41d7daad1637e224a54bf46b0799fe75381ed93d7d7362937", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60042368d064acc22d9aa8046a2b7dc720b118de871e6b0d3f996f9aa00ae3a65e77389b33a3585bea27661eaa90b4e2995485fbdfb912d3c819cc048bda2297"} build_url:https://queue.taskcluster.net/v1/task/eULIeu5uRjOSaN3sqn-OCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011315 build_url: 'https://queue.taskcluster.net/v1/task/eULIeu5uRjOSaN3sqn-OCw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc9a20865c26c6b68d529d2c880b97821383159d21e8e99b25213a97897c1af27ca0ea181c199ca43f058b752fc6aacdde587d7dcb6290f806e4a6e2d18185ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b925953f211f78b51d6f0e6b3d8b9fa7496750e106f3f7e24e8a4f6579d2deef598d0212e5f3ea41d7daad1637e224a54bf46b0799fe75381ed93d7d7362937", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60042368d064acc22d9aa8046a2b7dc720b118de871e6b0d3f996f9aa00ae3a65e77389b33a3585bea27661eaa90b4e2995485fbdfb912d3c819cc048bda2297"}' ========= master_lag: 0.24 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 13:40:03.555768) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 13:40:03.556116) ========= 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=0e2a256762fed810e2f0f810000001b3-1469737162.615521-1545804640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004576 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 13:40:03.572518) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 13:40:03.572798) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 13:40:03.573163) ========= ========= Total master_lag: 0.77 =========