builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-021 starttime: 1470315480.42 results: success (0) buildid: 20160804030441 builduid: df03c968a23e4011bdfa4408a4126014 revision: 1576e7bc1bec7232e9e4ba78cce62526b1a6380b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 05:58:00.425163) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 05:58:00.425632) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 05:58:00.425995) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 05:58:00.512491) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 05:58:00.512801) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1470313013.938769-1767820074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-04 05:58:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.5M=0s 2016-08-04 05:58:01 (42.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.188410 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 05:58:00.722844) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 05:58:00.723161) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1470313013.938769-1767820074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022704 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 05:58:00.775162) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 05:58:00.775811) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1576e7bc1bec7232e9e4ba78cce62526b1a6380b --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 1576e7bc1bec7232e9e4ba78cce62526b1a6380b --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1470313013.938769-1767820074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-04 05:58:01,419 truncating revision to first 12 chars 2016-08-04 05:58:01,419 Setting DEBUG logging. 2016-08-04 05:58:01,419 attempt 1/10 2016-08-04 05:58:01,419 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1576e7bc1bec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-04 05:58:01,727 unpacking tar archive at: mozilla-central-1576e7bc1bec/testing/mozharness/ program finished with exit code 0 elapsedTime=0.604480 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 05:58:01.396389) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 05:58:01.396758) ========= script_repo_revision: 1576e7bc1bec7232e9e4ba78cce62526b1a6380b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 05:58:01.397256) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 05:58:01.397603) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 05:58:01.409078) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-04 05:58:01.409442) ========= /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=df17445c3590ff7897617a0e00000225-1470313013.938769-1767820074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:58:02 INFO - MultiFileLogger online at 20160804 05:58:02 in /builds/slave/test 05:58:02 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 05:58:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:58:02 INFO - {'append_to_log': False, 05:58:02 INFO - 'base_work_dir': '/builds/slave/test', 05:58:02 INFO - 'blob_upload_branch': 'Firefox', 05:58:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:58:02 INFO - 'branch': 'Firefox', 05:58:02 INFO - 'buildbot_json_path': 'buildprops.json', 05:58:02 INFO - 'config_files': ('talos/linux_config.py',), 05:58:02 INFO - 'default_actions': ('clobber', 05:58:02 INFO - 'read-buildbot-config', 05:58:02 INFO - 'download-and-extract', 05:58:02 INFO - 'populate-webroot', 05:58:02 INFO - 'create-virtualenv', 05:58:02 INFO - 'install', 05:58:02 INFO - 'run-tests'), 05:58:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:58:02 INFO - 'download_minidump_stackwalk': True, 05:58:02 INFO - 'download_symbols': 'ondemand', 05:58:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:58:02 INFO - 'tooltool.py': '/tools/tooltool.py', 05:58:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:58:02 INFO - '/tools/misc-python/virtualenv.py')}, 05:58:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:58:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:58:02 INFO - 'installer_path': 'installer.exe', 05:58:02 INFO - 'log_level': 'info', 05:58:02 INFO - 'log_name': 'talos', 05:58:02 INFO - 'log_to_console': True, 05:58:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:58:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:58:02 INFO - 'opt_config_files': (), 05:58:02 INFO - 'pip_index': False, 05:58:02 INFO - 'sps_profile': False, 05:58:02 INFO - 'sps_profile_interval': 0, 05:58:02 INFO - 'suite': 'dromaeojs', 05:58:02 INFO - 'system_bits': '32', 05:58:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:58:02 INFO - 'title': 'talos-linux64-ix-021', 05:58:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:58:02 INFO - 'use_talos_json': True, 05:58:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:58:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:58:02 INFO - 'work_dir': 'build'} 05:58:02 INFO - [mozharness: 2016-08-04 12:58:02.142426Z] Running clobber step. 05:58:02 INFO - Running pre-action listener: _resource_record_pre_action 05:58:02 INFO - Running main action method: clobber 05:58:02 INFO - rmtree: /builds/slave/test/build 05:58:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:58:02 INFO - Running post-action listener: _resource_record_post_action 05:58:02 INFO - [mozharness: 2016-08-04 12:58:02.603453Z] Finished clobber step (success) 05:58:02 INFO - [mozharness: 2016-08-04 12:58:02.603555Z] Running read-buildbot-config step. 05:58:02 INFO - Running pre-action listener: _resource_record_pre_action 05:58:02 INFO - Running main action method: read_buildbot_config 05:58:02 INFO - Using buildbot properties: 05:58:02 INFO - { 05:58:02 INFO - "project": "", 05:58:02 INFO - "product": "firefox", 05:58:02 INFO - "script_repo_revision": "production", 05:58:02 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:58:02 INFO - "repository": "", 05:58:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:58:02 INFO - "buildid": "20160804030441", 05:58:02 INFO - "stage_platform": "linux64-pgo", 05:58:02 INFO - "basedir": "/builds/slave/test", 05:58:02 INFO - "nightly_build": "True", 05:58:02 INFO - "buildnumber": 413, 05:58:02 INFO - "slavename": "talos-linux64-ix-021", 05:58:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:58:02 INFO - "platform": "ubuntu64_hw", 05:58:02 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:58:02 INFO - "branch": "mozilla-central", 05:58:02 INFO - "repo_path": "mozilla-central", 05:58:02 INFO - "revision": "1576e7bc1bec7232e9e4ba78cce62526b1a6380b", 05:58:02 INFO - "pgo_build": "True", 05:58:02 INFO - "builduid": "df03c968a23e4011bdfa4408a4126014", 05:58:02 INFO - "slavebuilddir": "test" 05:58:02 INFO - } 05:58:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/YDPqjYXNR1awAtZJ_GvmCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 05:58:02 INFO - Running post-action listener: _resource_record_post_action 05:58:02 INFO - [mozharness: 2016-08-04 12:58:02.606093Z] Finished read-buildbot-config step (success) 05:58:02 INFO - [mozharness: 2016-08-04 12:58:02.606183Z] Running download-and-extract step. 05:58:02 INFO - Running pre-action listener: _resource_record_pre_action 05:58:02 INFO - Running main action method: download_and_extract 05:58:02 INFO - mkdir: /builds/slave/test/build/tests 05:58:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:02 INFO - https://queue.taskcluster.net/v1/task/YDPqjYXNR1awAtZJ_GvmCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:58:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YDPqjYXNR1awAtZJ_GvmCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:58:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YDPqjYXNR1awAtZJ_GvmCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:58:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YDPqjYXNR1awAtZJ_GvmCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:58:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YDPqjYXNR1awAtZJ_GvmCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:58:04 INFO - Downloaded 1361 bytes. 05:58:04 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:58:04 INFO - Using the following test package requirements: 05:58:04 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:58:04 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:04 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:58:04 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:04 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:58:04 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:04 INFO - u'jsshell-linux-x86_64.zip'], 05:58:04 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:04 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:58:04 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:58:04 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:04 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:58:04 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:04 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:58:04 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:04 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:58:04 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:04 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:58:04 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:58:04 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')]} 05:58:04 INFO - https://queue.taskcluster.net/v1/task/YDPqjYXNR1awAtZJ_GvmCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:58:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YDPqjYXNR1awAtZJ_GvmCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:58:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YDPqjYXNR1awAtZJ_GvmCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:58:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YDPqjYXNR1awAtZJ_GvmCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:58:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YDPqjYXNR1awAtZJ_GvmCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:58:06 INFO - Downloaded 21811640 bytes. 05:58:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:58:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:58:07 INFO - Return code: 0 05:58:07 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:58:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:07 INFO - https://queue.taskcluster.net/v1/task/YDPqjYXNR1awAtZJ_GvmCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:58:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YDPqjYXNR1awAtZJ_GvmCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:58:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YDPqjYXNR1awAtZJ_GvmCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:58:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YDPqjYXNR1awAtZJ_GvmCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:58:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YDPqjYXNR1awAtZJ_GvmCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:58:12 INFO - Downloaded 21811640 bytes. 05:58:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:58:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:58:14 INFO - Return code: 0 05:58:14 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')]} 05:58:14 INFO - https://queue.taskcluster.net/v1/task/YDPqjYXNR1awAtZJ_GvmCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:58:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YDPqjYXNR1awAtZJ_GvmCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:58:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YDPqjYXNR1awAtZJ_GvmCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:58:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YDPqjYXNR1awAtZJ_GvmCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:58:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YDPqjYXNR1awAtZJ_GvmCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:58:14 INFO - Downloaded 14413723 bytes. 05:58:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:58:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:58:15 INFO - Return code: 0 05:58: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')]} 05:58:15 INFO - https://queue.taskcluster.net/v1/task/YDPqjYXNR1awAtZJ_GvmCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:58:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YDPqjYXNR1awAtZJ_GvmCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:58:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YDPqjYXNR1awAtZJ_GvmCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:58:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YDPqjYXNR1awAtZJ_GvmCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:58:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YDPqjYXNR1awAtZJ_GvmCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:58:16 INFO - Downloaded 59329309 bytes. 05:58:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YDPqjYXNR1awAtZJ_GvmCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:58:16 INFO - mkdir: /builds/slave/test/properties 05:58:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:58:16 INFO - Writing to file /builds/slave/test/properties/build_url 05:58:16 INFO - Contents: 05:58:16 INFO - build_url:https://queue.taskcluster.net/v1/task/YDPqjYXNR1awAtZJ_GvmCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:58:16 INFO - Running post-action listener: _resource_record_post_action 05:58:16 INFO - Running post-action listener: set_extra_try_arguments 05:58:16 INFO - [mozharness: 2016-08-04 12:58:16.960412Z] Finished download-and-extract step (success) 05:58:16 INFO - [mozharness: 2016-08-04 12:58:16.960646Z] Running populate-webroot step. 05:58:16 INFO - Running pre-action listener: _resource_record_pre_action 05:58:16 INFO - Running main action method: populate_webroot 05:58:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:58:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:58:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:58:16 INFO - '--tppagecycles', 05:58:16 INFO - '7'], 05:58:16 INFO - 'tests': ['tsvgm']}}, 05:58:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:58:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:58:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:58:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:58:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:58:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:58:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:16 INFO - 'talos_options': ['--disable-e10s'], 05:58:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:58:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:58:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:16 INFO - 'talos_options': ['--disable-e10s'], 05:58:16 INFO - 'tests': ['damp', 'tps']}, 05:58:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:16 INFO - 'tests': ['damp', 'tps']}, 05:58:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:58:16 INFO - 'tests': ['dromaeo_dom']}, 05:58:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:58:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:58:16 INFO - 'tests': ['basic_compositor_video']}, 05:58:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:58:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:58:16 INFO - 'tests': ['a11yr', 05:58:16 INFO - 'ts_paint', 05:58:16 INFO - 'tpaint', 05:58:16 INFO - 'sessionrestore', 05:58:16 INFO - 'sessionrestore_no_auto_restore', 05:58:16 INFO - 'tabpaint']}, 05:58:16 INFO - 'other-e10s': {'tests': ['a11yr', 05:58:16 INFO - 'ts_paint', 05:58:16 INFO - 'tpaint', 05:58:16 INFO - 'sessionrestore', 05:58:16 INFO - 'sessionrestore_no_auto_restore', 05:58:16 INFO - 'tabpaint']}, 05:58:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:58:16 INFO - 'ts_paint', 05:58:16 INFO - 'tpaint', 05:58:16 INFO - 'sessionrestore', 05:58:16 INFO - 'sessionrestore_no_auto_restore', 05:58:16 INFO - 'tabpaint']}, 05:58:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:58:16 INFO - 'ts_paint', 05:58:16 INFO - 'tpaint', 05:58:16 INFO - 'sessionrestore', 05:58:16 INFO - 'sessionrestore_no_auto_restore', 05:58:16 INFO - 'tabpaint']}, 05:58:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:58:16 INFO - 'tests': ['a11yr', 05:58:16 INFO - 'ts_paint', 05:58:16 INFO - 'tpaint', 05:58:16 INFO - 'sessionrestore', 05:58:16 INFO - 'sessionrestore_no_auto_restore', 05:58:16 INFO - 'tabpaint']}, 05:58:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:58:16 INFO - 'tests': ['a11yr', 05:58:16 INFO - 'ts_paint', 05:58:16 INFO - 'tpaint', 05:58:16 INFO - 'sessionrestore', 05:58:16 INFO - 'sessionrestore_no_auto_restore', 05:58:16 INFO - 'tabpaint']}, 05:58:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:58:16 INFO - 'tests': ['tsvgx', 05:58:16 INFO - 'tsvgr_opacity', 05:58:16 INFO - 'tart', 05:58:16 INFO - 'tscrollx', 05:58:16 INFO - 'cart']}, 05:58:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:58:16 INFO - 'tsvgr_opacity', 05:58:16 INFO - 'tart', 05:58:16 INFO - 'tscrollx', 05:58:16 INFO - 'cart']}, 05:58:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:16 INFO - 'talos_options': ['--disable-e10s'], 05:58:16 INFO - 'tests': ['tp5o']}, 05:58:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:16 INFO - 'tests': ['tp5o']}, 05:58:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:16 INFO - 'talos_options': ['--disable-e10s', 05:58:16 INFO - '--xperf_path', 05:58:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:58:16 INFO - 'tests': ['tp5n']}, 05:58:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:16 INFO - 'talos_options': ['--xperf_path', 05:58:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:58:16 INFO - 'tests': ['tp5n']}}, 05:58:16 INFO - 'talos.zip': {'path': '', 05:58:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:58:16 INFO - Running post-action listener: _resource_record_post_action 05:58:16 INFO - [mozharness: 2016-08-04 12:58:16.982723Z] Finished populate-webroot step (success) 05:58:16 INFO - [mozharness: 2016-08-04 12:58:16.982823Z] Running create-virtualenv step. 05:58:16 INFO - Running pre-action listener: _resource_record_pre_action 05:58:16 INFO - Running main action method: create_virtualenv 05:58:16 INFO - Creating virtualenv /builds/slave/test/build/venv 05:58:16 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 05:58:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:58:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:58:17 INFO - Using real prefix '/usr' 05:58:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:58:17 INFO - Installing distribute.............................................................................................................................................................................................done. 05:58:19 INFO - Installing pip.................done. 05:58:19 INFO - Return code: 0 05:58:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:58:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c82180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c803b0>, '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 0x1c812b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c81740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470313013.938769-1767820074', '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 05:58:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:58:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:58:19 INFO - Using env: {'DISPLAY': ':0', 05:58:19 INFO - 'HOME': '/home/cltbld', 05:58:19 INFO - 'LANG': 'en_US.UTF-8', 05:58:19 INFO - 'LANGUAGE': 'en_US:en', 05:58:19 INFO - 'LOGNAME': 'cltbld', 05:58:19 INFO - 'MAIL': '/var/mail/cltbld', 05:58:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:19 INFO - 'MOZ_NO_REMOTE': '1', 05:58:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:19 INFO - 'NO_EM_RESTART': '1', 05:58:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:19 INFO - 'PWD': '/builds/slave/test', 05:58:19 INFO - 'SHELL': '/bin/bash', 05:58:19 INFO - 'SHLVL': '1', 05:58:19 INFO - 'TERM': 'linux', 05:58:19 INFO - 'TMOUT': '86400', 05:58:19 INFO - 'USER': 'cltbld', 05:58:19 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470313013.938769-1767820074', 05:58:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:19 INFO - '_': '/tools/buildbot/bin/python'} 05:58:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:20 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 05:58:20 INFO - Cleaning up... 05:58:20 INFO - Return code: 0 05:58:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:58:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x19c1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c82180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c803b0>, '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 0x1c812b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c81740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470313013.938769-1767820074', '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 05:58:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:58:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:58:20 INFO - Using env: {'DISPLAY': ':0', 05:58:20 INFO - 'HOME': '/home/cltbld', 05:58:20 INFO - 'LANG': 'en_US.UTF-8', 05:58:20 INFO - 'LANGUAGE': 'en_US:en', 05:58:20 INFO - 'LOGNAME': 'cltbld', 05:58:20 INFO - 'MAIL': '/var/mail/cltbld', 05:58:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:20 INFO - 'MOZ_NO_REMOTE': '1', 05:58:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:20 INFO - 'NO_EM_RESTART': '1', 05:58:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:20 INFO - 'PWD': '/builds/slave/test', 05:58:20 INFO - 'SHELL': '/bin/bash', 05:58:20 INFO - 'SHLVL': '1', 05:58:20 INFO - 'TERM': 'linux', 05:58:20 INFO - 'TMOUT': '86400', 05:58:20 INFO - 'USER': 'cltbld', 05:58:20 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470313013.938769-1767820074', 05:58:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:20 INFO - '_': '/tools/buildbot/bin/python'} 05:58:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:20 INFO - Downloading/unpacking psutil>=3.1.1 05:58:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:58:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:58:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:58:22 INFO - Installing collected packages: psutil 05:58:22 INFO - Running setup.py install for psutil 05:58:22 INFO - building 'psutil._psutil_linux' extension 05:58:22 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 05:58:22 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 05:58:22 INFO - building 'psutil._psutil_posix' extension 05:58:22 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 05:58:22 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 05:58:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:58:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:58:22 INFO - Successfully installed psutil 05:58:22 INFO - Cleaning up... 05:58:22 INFO - Return code: 0 05:58:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:58:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:22 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 0x19c1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c82180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c803b0>, '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 0x1c812b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c81740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470313013.938769-1767820074', '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 05:58:22 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 05:58:22 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 05:58:22 INFO - Using env: {'DISPLAY': ':0', 05:58:22 INFO - 'HOME': '/home/cltbld', 05:58:22 INFO - 'LANG': 'en_US.UTF-8', 05:58:22 INFO - 'LANGUAGE': 'en_US:en', 05:58:22 INFO - 'LOGNAME': 'cltbld', 05:58:22 INFO - 'MAIL': '/var/mail/cltbld', 05:58:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:22 INFO - 'MOZ_NO_REMOTE': '1', 05:58:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:22 INFO - 'NO_EM_RESTART': '1', 05:58:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:22 INFO - 'PWD': '/builds/slave/test', 05:58:22 INFO - 'SHELL': '/bin/bash', 05:58:22 INFO - 'SHLVL': '1', 05:58:22 INFO - 'TERM': 'linux', 05:58:22 INFO - 'TMOUT': '86400', 05:58:22 INFO - 'USER': 'cltbld', 05:58:22 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470313013.938769-1767820074', 05:58:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:22 INFO - '_': '/tools/buildbot/bin/python'} 05:58:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:58:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:58:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:58:24 INFO - Installing collected packages: mozsystemmonitor 05:58:24 INFO - Running setup.py install for mozsystemmonitor 05:58:25 INFO - Successfully installed mozsystemmonitor 05:58:25 INFO - Cleaning up... 05:58:25 INFO - Return code: 0 05:58:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:58:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:25 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 0x19c1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c82180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c803b0>, '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 0x1c812b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c81740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470313013.938769-1767820074', '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 05:58:25 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 05:58:25 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 05:58:25 INFO - Using env: {'DISPLAY': ':0', 05:58:25 INFO - 'HOME': '/home/cltbld', 05:58:25 INFO - 'LANG': 'en_US.UTF-8', 05:58:25 INFO - 'LANGUAGE': 'en_US:en', 05:58:25 INFO - 'LOGNAME': 'cltbld', 05:58:25 INFO - 'MAIL': '/var/mail/cltbld', 05:58:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:25 INFO - 'MOZ_NO_REMOTE': '1', 05:58:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:25 INFO - 'NO_EM_RESTART': '1', 05:58:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:25 INFO - 'PWD': '/builds/slave/test', 05:58:25 INFO - 'SHELL': '/bin/bash', 05:58:25 INFO - 'SHLVL': '1', 05:58:25 INFO - 'TERM': 'linux', 05:58:25 INFO - 'TMOUT': '86400', 05:58:25 INFO - 'USER': 'cltbld', 05:58:25 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470313013.938769-1767820074', 05:58:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:25 INFO - '_': '/tools/buildbot/bin/python'} 05:58:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:25 INFO - Downloading/unpacking jsonschema==2.5.1 05:58:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:58:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:58:27 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 05:58:27 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 05:58:27 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 05:58:27 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 05:58:27 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 05:58:27 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 05:58:27 INFO - Downloading functools32-3.2.3-2.tar.gz 05:58:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:58:27 INFO - warning: no files found matching '*.txt' 05:58:27 INFO - no previously-included directories found matching 'build' 05:58:27 INFO - no previously-included directories found matching 'dist' 05:58:27 INFO - no previously-included directories found matching '.git*' 05:58:27 INFO - Installing collected packages: jsonschema, functools32 05:58:27 INFO - Running setup.py install for functools32 05:58:27 INFO - warning: no files found matching '*.txt' 05:58:27 INFO - no previously-included directories found matching 'build' 05:58:27 INFO - no previously-included directories found matching 'dist' 05:58:27 INFO - no previously-included directories found matching '.git*' 05:58:27 INFO - Successfully installed jsonschema functools32 05:58:27 INFO - Cleaning up... 05:58:27 INFO - Return code: 0 05:58:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:58: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')]} 05:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58: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')]} 05:58:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:27 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 0x19c1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c82180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c803b0>, '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 0x1c812b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c81740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470313013.938769-1767820074', '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 05:58:27 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 05:58:27 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 05:58:27 INFO - Using env: {'DISPLAY': ':0', 05:58:27 INFO - 'HOME': '/home/cltbld', 05:58:27 INFO - 'LANG': 'en_US.UTF-8', 05:58:27 INFO - 'LANGUAGE': 'en_US:en', 05:58:27 INFO - 'LOGNAME': 'cltbld', 05:58:27 INFO - 'MAIL': '/var/mail/cltbld', 05:58:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:27 INFO - 'MOZ_NO_REMOTE': '1', 05:58:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:27 INFO - 'NO_EM_RESTART': '1', 05:58:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:27 INFO - 'PWD': '/builds/slave/test', 05:58:27 INFO - 'SHELL': '/bin/bash', 05:58:27 INFO - 'SHLVL': '1', 05:58:27 INFO - 'TERM': 'linux', 05:58:27 INFO - 'TMOUT': '86400', 05:58:27 INFO - 'USER': 'cltbld', 05:58:27 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470313013.938769-1767820074', 05:58:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:27 INFO - '_': '/tools/buildbot/bin/python'} 05:58:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:58:27 INFO - Cleaning up... 05:58:27 INFO - Return code: 0 05:58:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:58: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')]} 05:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58: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')]} 05:58:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:27 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 0x19c1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c82180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c803b0>, '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 0x1c812b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c81740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470313013.938769-1767820074', '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 05:58:27 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 05:58:27 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 05:58:27 INFO - Using env: {'DISPLAY': ':0', 05:58:27 INFO - 'HOME': '/home/cltbld', 05:58:27 INFO - 'LANG': 'en_US.UTF-8', 05:58:27 INFO - 'LANGUAGE': 'en_US:en', 05:58:27 INFO - 'LOGNAME': 'cltbld', 05:58:27 INFO - 'MAIL': '/var/mail/cltbld', 05:58:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:27 INFO - 'MOZ_NO_REMOTE': '1', 05:58:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:27 INFO - 'NO_EM_RESTART': '1', 05:58:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:27 INFO - 'PWD': '/builds/slave/test', 05:58:27 INFO - 'SHELL': '/bin/bash', 05:58:27 INFO - 'SHLVL': '1', 05:58:27 INFO - 'TERM': 'linux', 05:58:27 INFO - 'TMOUT': '86400', 05:58:27 INFO - 'USER': 'cltbld', 05:58:27 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470313013.938769-1767820074', 05:58:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:27 INFO - '_': '/tools/buildbot/bin/python'} 05:58:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:28 INFO - Downloading/unpacking blobuploader==1.2.4 05:58:28 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 05:58:28 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 05:58:28 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 05:58:28 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 05:58:28 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 05:58:28 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 05:58:29 INFO - Downloading blobuploader-1.2.4.tar.gz 05:58:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:58:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:58:30 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 05:58:30 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 05:58:30 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 05:58:30 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 05:58:30 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 05:58:30 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 05:58:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:58:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:58:30 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 05:58:30 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 05:58:30 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 05:58:30 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 05:58:30 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 05:58:30 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 05:58:30 INFO - Downloading docopt-0.6.1.tar.gz 05:58:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:58:30 INFO - Installing collected packages: blobuploader, requests, docopt 05:58:30 INFO - Running setup.py install for blobuploader 05:58:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:58:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:58:30 INFO - Running setup.py install for requests 05:58:31 INFO - Running setup.py install for docopt 05:58:31 INFO - Successfully installed blobuploader requests docopt 05:58:31 INFO - Cleaning up... 05:58:31 INFO - Return code: 0 05:58:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58: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')]} 05:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58: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')]} 05:58:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:31 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 0x19c1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c82180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c803b0>, '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 0x1c812b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c81740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470313013.938769-1767820074', '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 05:58:31 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 05:58:31 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 05:58:31 INFO - Using env: {'DISPLAY': ':0', 05:58:31 INFO - 'HOME': '/home/cltbld', 05:58:31 INFO - 'LANG': 'en_US.UTF-8', 05:58:31 INFO - 'LANGUAGE': 'en_US:en', 05:58:31 INFO - 'LOGNAME': 'cltbld', 05:58:31 INFO - 'MAIL': '/var/mail/cltbld', 05:58:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:31 INFO - 'MOZ_NO_REMOTE': '1', 05:58:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:31 INFO - 'NO_EM_RESTART': '1', 05:58:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:31 INFO - 'PWD': '/builds/slave/test', 05:58:31 INFO - 'SHELL': '/bin/bash', 05:58:31 INFO - 'SHLVL': '1', 05:58:31 INFO - 'TERM': 'linux', 05:58:31 INFO - 'TMOUT': '86400', 05:58:31 INFO - 'USER': 'cltbld', 05:58:31 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470313013.938769-1767820074', 05:58:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:31 INFO - '_': '/tools/buildbot/bin/python'} 05:58:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:58:31 INFO - Running setup.py (path:/tmp/pip-bcWkSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:58:31 INFO - Running setup.py (path:/tmp/pip-Ef6rDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:58:31 INFO - Running setup.py (path:/tmp/pip-Vb41HA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:58:31 INFO - Running setup.py (path:/tmp/pip-ujVRTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:58:31 INFO - Running setup.py (path:/tmp/pip-K0kIj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:58:31 INFO - Running setup.py (path:/tmp/pip-rk7__j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:58:32 INFO - Running setup.py (path:/tmp/pip-BZxEb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:58:32 INFO - Running setup.py (path:/tmp/pip-iHNTmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:58:32 INFO - Running setup.py (path:/tmp/pip-4Nqpij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:58:32 INFO - Running setup.py (path:/tmp/pip-WF6ekj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:58:32 INFO - Running setup.py (path:/tmp/pip-QWRVxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:58:32 INFO - Running setup.py (path:/tmp/pip-YdGKoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:58:32 INFO - Running setup.py (path:/tmp/pip-wOa1Au-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:58:32 INFO - Running setup.py (path:/tmp/pip-xwbrCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:32 INFO - Running setup.py (path:/tmp/pip-kUqZlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:58:32 INFO - Running setup.py (path:/tmp/pip-vH8K73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:58:32 INFO - Running setup.py (path:/tmp/pip-zU6NN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:58:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:58:32 INFO - Running setup.py install for manifestparser 05:58:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:58:32 INFO - Running setup.py install for mozcrash 05:58:33 INFO - Running setup.py install for mozdebug 05:58:33 INFO - Running setup.py install for mozdevice 05:58:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:58:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:58:33 INFO - Running setup.py install for mozfile 05:58:33 INFO - Running setup.py install for mozhttpd 05:58:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:58:33 INFO - Running setup.py install for mozinfo 05:58:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:58:33 INFO - Running setup.py install for mozInstall 05:58:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:58:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:58:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:58:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:58:33 INFO - Running setup.py install for mozleak 05:58:33 INFO - Running setup.py install for mozlog 05:58:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:58:33 INFO - Running setup.py install for moznetwork 05:58:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:58:33 INFO - Running setup.py install for mozprocess 05:58:34 INFO - Running setup.py install for mozprofile 05:58:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:58:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:58:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:58:34 INFO - Running setup.py install for mozrunner 05:58:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:58:34 INFO - Running setup.py install for mozscreenshot 05:58:34 INFO - Running setup.py install for moztest 05:58:34 INFO - Running setup.py install for mozversion 05:58:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:58:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:58:34 INFO - Cleaning up... 05:58:34 INFO - Return code: 0 05:58:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:34 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 0x19c1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c82180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c803b0>, '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 0x1c812b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c81740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470313013.938769-1767820074', '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 05:58:34 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 05:58:34 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 05:58:34 INFO - Using env: {'DISPLAY': ':0', 05:58:34 INFO - 'HOME': '/home/cltbld', 05:58:34 INFO - 'LANG': 'en_US.UTF-8', 05:58:34 INFO - 'LANGUAGE': 'en_US:en', 05:58:34 INFO - 'LOGNAME': 'cltbld', 05:58:34 INFO - 'MAIL': '/var/mail/cltbld', 05:58:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:34 INFO - 'MOZ_NO_REMOTE': '1', 05:58:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:34 INFO - 'NO_EM_RESTART': '1', 05:58:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:34 INFO - 'PWD': '/builds/slave/test', 05:58:34 INFO - 'SHELL': '/bin/bash', 05:58:34 INFO - 'SHLVL': '1', 05:58:34 INFO - 'TERM': 'linux', 05:58:34 INFO - 'TMOUT': '86400', 05:58:34 INFO - 'USER': 'cltbld', 05:58:34 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470313013.938769-1767820074', 05:58:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:34 INFO - '_': '/tools/buildbot/bin/python'} 05:58:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:58:34 INFO - Running setup.py (path:/tmp/pip-9lmi6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:58:34 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)) 05:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:58:34 INFO - Running setup.py (path:/tmp/pip-xIiExW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:58:34 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)) 05:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:58:34 INFO - Running setup.py (path:/tmp/pip-_mQoep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:58:35 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)) 05:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:58:35 INFO - Running setup.py (path:/tmp/pip-ijXZ8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:58:35 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)) 05:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:58:35 INFO - Running setup.py (path:/tmp/pip-fND2rc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:58:35 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)) 05:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:58:35 INFO - Running setup.py (path:/tmp/pip-HShijt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:58:35 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)) 05:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:58:35 INFO - Running setup.py (path:/tmp/pip-6686em-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:58:35 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)) 05:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:58:35 INFO - Running setup.py (path:/tmp/pip-QMLfrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:58:35 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)) 05:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:58:35 INFO - Running setup.py (path:/tmp/pip-VWEOni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:58:35 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)) 05:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:58:35 INFO - Running setup.py (path:/tmp/pip-Na7URw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:58:35 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)) 05:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:58:35 INFO - Running setup.py (path:/tmp/pip-wz66Tf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:58:35 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)) 05:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:58:35 INFO - Running setup.py (path:/tmp/pip-rjqWkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:58:35 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)) 05:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:58:35 INFO - Running setup.py (path:/tmp/pip-9RfPBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:58:35 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)) 05:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:58:35 INFO - Running setup.py (path:/tmp/pip-y9uj_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:58:35 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)) 05:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:35 INFO - Running setup.py (path:/tmp/pip-Emwx0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:35 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)) 05:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:58:35 INFO - Running setup.py (path:/tmp/pip-8JJwk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:58:35 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)) 05:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:58:35 INFO - Running setup.py (path:/tmp/pip-VWUdLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:58:36 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)) 05:58:36 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)) 05:58:36 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)) 05:58:36 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)) 05:58:36 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)) 05:58:36 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)) 05:58:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:58:36 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 05:58:36 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 05:58:36 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 05:58:36 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 05:58:36 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 05:58:36 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 05:58:37 INFO - Downloading blessings-1.6.tar.gz 05:58:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:58:37 INFO - Installing collected packages: blessings 05:58:37 INFO - Running setup.py install for blessings 05:58:38 INFO - Successfully installed blessings 05:58:38 INFO - Cleaning up... 05:58:38 INFO - Return code: 0 05:58:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:58:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:58:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:58:38 INFO - Reading from file tmpfile_stdout 05:58:38 INFO - Current package versions: 05:58:38 INFO - argparse == 1.2.1 05:58:38 INFO - blessings == 1.6 05:58:38 INFO - blobuploader == 1.2.4 05:58:38 INFO - docopt == 0.6.1 05:58:38 INFO - functools32 == 3.2.3-2 05:58:38 INFO - jsonschema == 2.5.1 05:58:38 INFO - manifestparser == 1.1 05:58:38 INFO - mozInstall == 1.12 05:58:38 INFO - mozcrash == 0.17 05:58:38 INFO - mozdebug == 0.1 05:58:38 INFO - mozdevice == 0.48 05:58:38 INFO - mozfile == 1.2 05:58:38 INFO - mozhttpd == 0.7 05:58:38 INFO - mozinfo == 0.9 05:58:38 INFO - mozleak == 0.1 05:58:38 INFO - mozlog == 3.3 05:58:38 INFO - moznetwork == 0.27 05:58:38 INFO - mozprocess == 0.23 05:58:38 INFO - mozprofile == 0.28 05:58:38 INFO - mozrunner == 6.12 05:58:38 INFO - mozscreenshot == 0.1 05:58:38 INFO - mozsystemmonitor == 0.3 05:58:38 INFO - moztest == 0.7 05:58:38 INFO - mozversion == 1.4 05:58:38 INFO - psutil == 3.1.1 05:58:38 INFO - requests == 1.2.3 05:58:38 INFO - wsgiref == 0.1.2 05:58:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58: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')]} 05:58:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58: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')]} 05:58:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:38 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 0x19c1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c82180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c803b0>, '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 0x1c812b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c81740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470313013.938769-1767820074', '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 05:58:38 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 05:58:38 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 05:58:38 INFO - Using env: {'DISPLAY': ':0', 05:58:38 INFO - 'HOME': '/home/cltbld', 05:58:38 INFO - 'LANG': 'en_US.UTF-8', 05:58:38 INFO - 'LANGUAGE': 'en_US:en', 05:58:38 INFO - 'LOGNAME': 'cltbld', 05:58:38 INFO - 'MAIL': '/var/mail/cltbld', 05:58:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:38 INFO - 'MOZ_NO_REMOTE': '1', 05:58:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:38 INFO - 'NO_EM_RESTART': '1', 05:58:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:38 INFO - 'PWD': '/builds/slave/test', 05:58:38 INFO - 'SHELL': '/bin/bash', 05:58:38 INFO - 'SHLVL': '1', 05:58:38 INFO - 'TERM': 'linux', 05:58:38 INFO - 'TMOUT': '86400', 05:58:38 INFO - 'USER': 'cltbld', 05:58:38 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470313013.938769-1767820074', 05:58:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:38 INFO - '_': '/tools/buildbot/bin/python'} 05:58:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:38 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)) 05:58:38 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)) 05:58:38 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)) 05:58:38 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)) 05:58:38 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)) 05:58:38 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)) 05:58:38 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)) 05:58:38 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)) 05:58:38 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)) 05:58:38 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)) 05:58:38 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)) 05:58:38 INFO - Cleaning up... 05:58:38 INFO - Return code: 0 05:58:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:58: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')]} 05:58:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58: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')]} 05:58:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c82180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c803b0>, '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 0x1c812b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c81740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470313013.938769-1767820074', '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 05:58: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', 'jsonschema'] in /builds/slave/test/build 05:58: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 jsonschema 05:58:38 INFO - Using env: {'DISPLAY': ':0', 05:58:38 INFO - 'HOME': '/home/cltbld', 05:58:38 INFO - 'LANG': 'en_US.UTF-8', 05:58:38 INFO - 'LANGUAGE': 'en_US:en', 05:58:38 INFO - 'LOGNAME': 'cltbld', 05:58:38 INFO - 'MAIL': '/var/mail/cltbld', 05:58:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:38 INFO - 'MOZ_NO_REMOTE': '1', 05:58:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:38 INFO - 'NO_EM_RESTART': '1', 05:58:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:38 INFO - 'PWD': '/builds/slave/test', 05:58:38 INFO - 'SHELL': '/bin/bash', 05:58:38 INFO - 'SHLVL': '1', 05:58:38 INFO - 'TERM': 'linux', 05:58:38 INFO - 'TMOUT': '86400', 05:58:38 INFO - 'USER': 'cltbld', 05:58:38 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470313013.938769-1767820074', 05:58:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:38 INFO - '_': '/tools/buildbot/bin/python'} 05:58:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:58:38 INFO - Cleaning up... 05:58:38 INFO - Return code: 0 05:58:38 INFO - Running post-action listener: _resource_record_post_action 05:58:38 INFO - Running post-action listener: _start_resource_monitoring 05:58:38 INFO - Starting resource monitoring. 05:58:38 INFO - [mozharness: 2016-08-04 12:58:38.832022Z] Finished create-virtualenv step (success) 05:58:38 INFO - [mozharness: 2016-08-04 12:58:38.832493Z] Running install step. 05:58:38 INFO - Running pre-action listener: _resource_record_pre_action 05:58:38 INFO - Running main action method: install 05:58:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:58:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:58:39 INFO - Reading from file tmpfile_stdout 05:58:39 INFO - Detecting whether we're running mozinstall >=1.0... 05:58:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:58:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:58:39 INFO - Reading from file tmpfile_stdout 05:58:39 INFO - Output received: 05:58:39 INFO - Usage: mozinstall [options] installer 05:58:39 INFO - Options: 05:58:39 INFO - -h, --help show this help message and exit 05:58:39 INFO - -d DEST, --destination=DEST 05:58:39 INFO - Directory to install application into. [default: 05:58:39 INFO - "/builds/slave/test"] 05:58:39 INFO - --app=APP Application being installed. [default: firefox] 05:58:39 INFO - mkdir: /builds/slave/test/build/application 05:58:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:58:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:58:56 INFO - Reading from file tmpfile_stdout 05:58:56 INFO - Output received: 05:58:56 INFO - /builds/slave/test/build/application/firefox/firefox 05:58:56 INFO - Running post-action listener: _resource_record_post_action 05:58:56 INFO - [mozharness: 2016-08-04 12:58:56.159407Z] Finished install step (success) 05:58:56 INFO - [mozharness: 2016-08-04 12:58:56.159681Z] Running run-tests step. 05:58:56 INFO - Running pre-action listener: _resource_record_pre_action 05:58:56 INFO - Running main action method: run_tests 05:58:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:58:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:58:56 INFO - Python 2.7.3 05:58:56 INFO - Return code: 0 05:58:56 INFO - grabbing minidump binary from tooltool 05:58:56 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')]} 05:58:56 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 0x1c803b0>, '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 0x1c812b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c81740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:58:56 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 05:58:56 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 05:58:56 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 05:58:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:58:56 INFO - Return code: 0 05:58:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:58:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:58:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:58:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:58:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:58:56 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/YDPqjYXNR1awAtZJ_GvmCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:58:56 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/YDPqjYXNR1awAtZJ_GvmCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:58:56 INFO - Using env: {'DISPLAY': ':0', 05:58:56 INFO - 'HOME': '/home/cltbld', 05:58:56 INFO - 'LANG': 'en_US.UTF-8', 05:58:56 INFO - 'LANGUAGE': 'en_US:en', 05:58:56 INFO - 'LOGNAME': 'cltbld', 05:58:56 INFO - 'MAIL': '/var/mail/cltbld', 05:58:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:58:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:58:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:56 INFO - 'MOZ_NO_REMOTE': '1', 05:58:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:58:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:56 INFO - 'NO_EM_RESTART': '1', 05:58:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:56 INFO - 'PWD': '/builds/slave/test', 05:58:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:58:56 INFO - 'SHELL': '/bin/bash', 05:58:56 INFO - 'SHLVL': '1', 05:58:56 INFO - 'TERM': 'linux', 05:58:56 INFO - 'TMOUT': '86400', 05:58:56 INFO - 'USER': 'cltbld', 05:58:56 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470313013.938769-1767820074', 05:58:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:56 INFO - '_': '/tools/buildbot/bin/python'} 05:58:56 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/YDPqjYXNR1awAtZJ_GvmCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:58:56 INFO - mozversion application_buildid: 20160804030441 05:58:56 INFO - mozversion application_changeset: 1576e7bc1bec7232e9e4ba78cce62526b1a6380b 05:58:56 INFO - mozversion application_display_name: Nightly 05:58:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:58:56 INFO - mozversion application_name: Firefox 05:58:56 INFO - mozversion application_remotingname: firefox 05:58:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:58:56 INFO - mozversion application_vendor: Mozilla 05:58:56 INFO - mozversion application_version: 51.0a1 05:58:56 INFO - mozversion platform_buildid: 20160804030441 05:58:56 INFO - mozversion platform_changeset: 1576e7bc1bec7232e9e4ba78cce62526b1a6380b 05:58:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:58:56 INFO - mozversion platform_version: 51.0a1 05:58:56 INFO - using testdate: 1470315536 05:58:56 INFO - actual date: 1470315536 05:58:56 INFO - starting webserver on 'localhost:46903' 05:58:56 INFO - SUITE-START | Running 2 tests 05:58:56 INFO - TEST-START | dromaeo_css 05:58:56 INFO - operating with platform_type : linux_ 05:58:56 INFO - Initialising browser for dromaeo_css test... 05:58:56 INFO - TEST-INFO | started process 7745 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeYKUbV/profile http://localhost:46903/getInfo.html) 05:59:01 INFO - PROCESS | 7745 | __metrics Screen width/height:1600/1200 05:59:01 INFO - PROCESS | 7745 | colorDepth:24 05:59:01 INFO - PROCESS | 7745 | Browser inner width/height: 1024/697 05:59:01 INFO - PROCESS | 7745 | __metrics 05:59:02 INFO - PROCESS | 7745 | 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" 05:59:02 INFO - PROCESS | 7745 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:59:03 INFO - TEST-INFO | 7745: exit 0 05:59:03 INFO - Browser initialized. 05:59:03 INFO - Running cycle 1/1 for dromaeo_css test... 05:59:03 INFO - TEST-INFO | started process 7823 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeYKUbV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:59:15 INFO - PROCESS | 7823 | RSS: Main: 156598272 05:59:15 INFO - PROCESS | 7823 | 06:00:06 INFO - PROCESS | 7823 | 1470315606705 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] 06:02:16 INFO - PROCESS | 7823 | Cycle 1(1): loaded http://localhost:46903/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46903/tests/dromaeo/cssquery-ext.html) 06:02:17 INFO - PROCESS | 7823 | RSS: Main: 265572352 06:02:17 INFO - PROCESS | 7823 | 06:05:19 INFO - PROCESS | 7823 | Cycle 1(1): loaded http://localhost:46903/tests/dromaeo/cssquery-ext.html (next: http://localhost:46903/tests/dromaeo/cssquery-jquery.html) 06:05:20 INFO - PROCESS | 7823 | RSS: Main: 239595520 06:05:20 INFO - PROCESS | 7823 | 06:08:22 INFO - PROCESS | 7823 | Cycle 1(1): loaded http://localhost:46903/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46903/tests/dromaeo/cssquery-mootools.html) 06:08:22 INFO - PROCESS | 7823 | RSS: Main: 213794816 06:08:22 INFO - PROCESS | 7823 | 06:11:24 INFO - PROCESS | 7823 | Cycle 1(1): loaded http://localhost:46903/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46903/tests/dromaeo/cssquery-prototype.html) 06:11:25 INFO - PROCESS | 7823 | RSS: Main: 226996224 06:11:25 INFO - PROCESS | 7823 | 06:14:27 INFO - PROCESS | 7823 | Cycle 1(1): loaded http://localhost:46903/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46903/tests/dromaeo/cssquery-yui.html) 06:14:28 INFO - PROCESS | 7823 | RSS: Main: 184991744 06:14:28 INFO - PROCESS | 7823 | 06:17:31 INFO - PROCESS | 7823 | Cycle 1(1): loaded http://localhost:46903/tests/dromaeo/cssquery-yui.html (next: http://localhost:46903/tests/dromaeo/cssquery-dojo.html) 06:17:31 INFO - PROCESS | 7823 | RSS: Main: 271822848 06:17:31 INFO - PROCESS | 7823 | 06:17:31 INFO - PROCESS | 7823 | __start_tp_report 06:17:31 INFO - PROCESS | 7823 | _x_x_mozilla_page_load 06:17:31 INFO - PROCESS | 7823 | _x_x_mozilla_page_load_details 06:17:31 INFO - PROCESS | 7823 | |i|pagename|runs| 06:17:31 INFO - PROCESS | 7823 | |0;dojo.html;2983.582298478212;3015.4119946610413;3026.6670666226696;3029.500132478142;3040.331127152027;5149.665271757333;5189.766460509286;5265.86835329117;5319.867003324914;5336.866578335544;5267.39424966129;5270.49930256625;5313.840584782462;5322;5384.703841288728;4716.198246298129;4784.593309568673;4801.951980480186;4811.446683631375;4937.851864444073;4870.732109733964;4897.314375987365;4907.975460122694;4916;4933.703977761345;4705.388299521074;4711.528847115295;4771.260454629538;4773.737444440554;4812.278158276269;4764.618830493552;4781.876259079114;4784.473707892129;4854.514548545118;4870.805167793319;4793.44875339337;4821.614270858323;4824.782884770194;4854.684445511066;4889.779959901813;5117.283580298761;5199.1161502544655;5293.04725149473;5318.867028324285;5350.759215835296;5704.286964129484;5713.914291285634;5751.309842818889;5756.481916627524;5759.856003599902;5736.139579063174;5750.827475175752;5794.420557944214;5802.506786923117;5803.883922321572;5084.923726144074;5155.072087024334;5186.481351864783;5195.272661827272;5411.648242864201;5721.628094173865;5741.081426971748;5747.252857128547;5783.595148339576;5783.971080144656;5494.120940649477;5513.558915286768;5548.9722551387795;5552.666839989613;5565.610407271533;5491.780328786804;5550.306211723535;5617.550595952314;5621.49406553404;5625.409332020161;5631.802886898939;5645.5483561314995;5648.322201335866;5652.434756524314;5692.260006199168;5592.412796656374;5652.039153343859;5661.801836935688;5662.603617746719;5677.971610142005;4216.810243539048;4248.129133527619;4320.719153255029;4365.650747940221;4380.145871555016;3879.903002424962;3885.630865067814;3918.6669133123432;3922.9019274518364;3944.783036932939;5363.731813409314;5366.248725178478;5378.381486129067;5380.973095134499;5426.240326354314;5538.196961440649;5574.637648552831;5598.692071936082;5710.029295019856;5726.9713651431475;5331;5331.253624492574;5332.2801421808335;5349.946500534945;5353.491418315254;4917.901641967141;4919.803207871717;4920.3603531541385;4922.950770492249;4961.3798275215595;5735.655860648374;5826.825195244234;5878.147668588031;5881.411858814085;5895.498882594856;5719.828405147852;5720.685362305113;5721.799737009184;5756.30924289088;5770.336411312753;5932.406759324033;5935.376785437467;5942.10868369748;5945.732442040032;5950.7917222896995;5338.4127745947135;5395.406505284494;5404.081306177881;5621.887562248814;5630.95827271956;5551.583631227755;5581.051221292471;5585.860353491195;5616.6068375213345;5634.464725851038;5455.481729235717;5459.808906688247;5464.672119672832;5469.097598896137;5537.529310008695;5402;5429;5490.670559766427;5519.503244707996;5560.5829562783765;5487.917681234705;5495.807646732345;5503.834884953458;5539.030669632879;5560;5587.916181257366;5603.74783134768;5631.408702086222;5633.0705433603;5634.661920284796;5378.97310513445;5424.620276580601;5435.130379139318;5467.398586155599;5484.040292948798 06:17:31 INFO - PROCESS | 7823 | |1;ext.html;597.6892016151601;599.8080614203454;602.3584882100564;613.941675540824;618.1284389011495;31398.52902206466;42851.14297714044;43104.137917241635;43138;43280;44292.3356149658;44656.55343446565;44844.32733509;44871.77564112175;44989;9001.819963600741;9135.862962055575;9154.86267705985;9155.954220228923;9160.40457370272;8996.550172491381;9085.772855678628;9088.818223635524;9100.408473449204;9101.271898248124;9108.407953483036;9145.314101442385;9150;9163.633454661805;9169.862452063224;9069.637214511411;9107.726768196964;9108;9115.68095116671;9117;8907.599158037903;8925.19673229406;8975;8987.101289871025;8993.595288212045;41509.79245103785;41668.37497437541;41736.16527669429;41747.165056698694;41885.79057104695;3288.8520016599073;3333.7833040852265;3402.2174899772945;3442.9827850860834;4266.1254442839145;32272.193195170075;32821;33430.83284583586;33456.665433345595;34421.6557834421;4422.447194100738;4479.216137175981;4484.506704262529;4626.375439315717;4670.1126785910565;346597;347571;347604;348506;348970;49838.50161498338;55967;56380.59048523738;56428.717856410454;56495.435045649014;58056;59436.40563594395;59529;64386.67806660937;64543.677281613294;17137.91431042837;17290.827091728923;17299.481015569552;17309.22108505095;17361.13194340278;11889;13333.066685332127;13432;13458.798118028237;13511.256880871646;15345.9232703838;15757.68484630301;15766.448174313844;15804.762928556082;16010.359585616445;5894.764209431661;5898.882022359615;5906.350301466835;5965.077112214984;6016.909746353808;953.8283109040301;1027.994860025695;1096.5065720425841;1097.2538673701958;1118.2842980492492;32483;32731.672683272864;32894.17764555857;33056.40533461318;33169.170770730445;1075.9246852720391;1080.7301420830493;1082.9241953063367;1144.3648774929993;1228.668259569929;16220.104297788233;17039.40362087321;17332.82667173337;17362.39231626912;17447.65104697899;552777;557014;557303;558496;561695;57920;58175;58244.7087764567;58291.12563311554;58321;1239.7706424311532;1289.6711338608595;1297.0596317669615;1353.864613538658;1355.4171706166246;29869.103926882228;33601.66398335985;33615.66384336125;33976.15059623529;34739.65260347465;51821.7408912953;52664.73667631637;52704.736476317375;52793.47206527885;52821.207681884036;487246;492456;492651;492955;493021;39001.414978774774;39194.80402597969;39199.80400097981;40050.1989960205;44410;48785.268220976;49184.508154917996;49222;49415.50584494109;49644.50355496399;41279;41477.377839333036;42822.14355712806;43052.56947430611;43169.784151079046;42257;42422;42463;43272.783636081615;43748.34377484404;41525;42055.7897210512;42392;42535.787321063195;42840;34322.65677343195;36621;37264;37607.811960940024;37754;28123.156305310873;28212.85893570519;28444.715552844205;28519.581279556816;28775.424491510472 06:17:31 INFO - PROCESS | 7823 | |2;jquery.html;362.25375726004415;378.7446893946529;383.14558534468136;385.75504554607824;397.78917173897827;17842.82157178428;19516.21935122595;19519;19758.30845920393;20644.1742330307;17832.821671783277;18272.360467383645;18312.633747325046;18323.083845807723;18479.90760046201;5605.915911261334;5723.51350135239;5808.796692115777;5818.243628328311;5819.738111784959;5879.147523609074;6047.455728984391;6055.9394406056035;6065.939340606582;6066.787662431816;5803.332616749086;5805.245318108661;5879.706014699269;6054.243219597551;6061.66660833654;5816.389279125694;5845.41545845412;5853.32686741026;5853.678047707374;5858.794942177004;5546.140348246028;5676.829695109153;5850.444207800252;5873.882522349529;5883.411658834125;14593.635159121;14624.853751462455;14805.777913331309;24248.515029699483;24644.260672179862;2188.9452763681034;2320.6983092197906;2437.536867995075;2482.441450673602;2781.860906954644;10302.433366164858;10546.736331591695;10608.15134789215;10672.946635266851;10910;1797.5236562310997;1802.9008404537744;1836.9816301836945;1871.167330537911;1902.286642509059;78324;82646;82847.17152828455;83219;86046.56976715139;11185.552577896793;11239.94380028111;11305.773884522428;11444;11551.653450396334;15740.527784166494;15745.291461884242;15755.921220394053;15764;15764.448244311394;8377.162283771697;8560.272376847914;8574.785630359167;8686.913130868737;8749.343799215085;7629.3133617974645;7744.612769361622;7794.22057794216;7979.800504987422;8502.489850608983;4767.332573439721;4881;4897.730624815598;4910.361652985089;5050.166722490748;1936.7772706138692;1957.3540731558837;1992.7907569705262;2028.3712049264775;2042.601692669915;881.2905610983092;931.6040682709821;963.9974426596261;988.7182153086479;1001.7195185348114;18889.338873139375;20749;20880.37358879236;20947.00970525515;20964.47588810292;948.7865230323122;963.393062370702;975.2100798353357;998.7353351361895;1014.3964341216964;10613.204009699304;11555.2489088209;11575.826362604568;11590.71023224426;11606.70983225426;491967;493461;500101;507725;510694;55298.72350638221;73332;90336.09663903277;91358.54320728354;91614.54192729127;943.5282358820727;970.5729479029204;985;989.1690979577189;992.1764935103846;17527;18225.726614100535;18403.631927361646;18409.263629455207;18547.350842720978;43165.352519712855;44547.77726111478;44573.55426445694;45015.77492112519;45973.31040034469;57300.42699572951;60258.39741602528;61352.38647613645;62187;64882;8449.788755281168;8722.869156962777;8836.293096552132;8982.236509896731;9072.183503484717;12834.935825320814;13524.12093213938;13665.521706740217;13801.102928309629;13880;11530.308181509135;11692.883071169179;11780.410979451164;11791.823122653339;12342.654895569813;10703.571857125628;11202.831957520806;11333.943330283295;11839.112066595211;12258.754824903273;6826;7631.893375460638;10498.685039448828;12233.755324893275;12389.442475088823;8616.870746938675;8649.56752162402;8714.607842646968;8734.388592798443;9120.589573469342;8854.77863053403;11812.645620631394;11814.232074915102;11831.881681183422;11922.76154476923 06:17:31 INFO - PROCESS | 7823 | |3;mootools.html;1280.705437749318;1296.753616812805;1368.2543014057337;1409.4784929576056;1640.9097499637514;7823.960880195598;8197;8240.711575094872;8247.958760206198;8420.747377578682;8054.315383192421;8230.42387032908;8432.620532076056;8443.366747493947;8447.746567602966;2307.5038866643667;2349.1777877742825;2350.976490235101;2351.8588884666974;2353.352827972304;2292.060255295329;2327.662488939103;2330.021391015769;2330.3707998840305;2330.4057465346314;2311.768823117683;2330.1727886600265;2339.7309309429465;2350.318407661776;2352.623580227164;2251.6509940959177;2275.340151356113;2280.45269135408;2283.360659015478;2311.780380863815;2257.1761307122947;2260.4122928038664;2263.7283525976823;2265.4902646904316;2265.524239909621;8232.382571307176;8270.669173233064;8287.917120828835;8344.207300306462;8351.8329633407;5057.9494205057845;5223;5229;5231.764570594332;5237.502437268454;3207.3585282943272;3209.245827230599;3231.4829627259523;3266.1018219989455;3270.5257737627912;1140.931544107356;1172.6657902497832;1175.1949914308725;1194.6296648039136;1202.5730865542694;10910.5090270938;10961.232713710044;10965.50655220517;10992.945035274772;11008.669739907815;4166.979165104216;4348;4506.121306345297;4621.792019359137;4625.537446255347;9435.056494350647;9447.574859131355;9466.905330946602;9488.620455181715;9498.90501094994;4906.215005599087;4923.606111511071;4937.8271760488215;4939.2097264438235;4939.555440010345;4246.44796176495;4303.483581970184;4353.10761293934;4534.614557762628;4547.113312904018;3914.099757055893;3927.6072392760493;4034.495688038995;4046.959530404717;4175.707700460938;1192.3025030357337;1249.3565813606;1266.8416447944007;1268.61307301274;1272.179444258448;959.1942768074712;979.6669132494986;986.3785814936545;987.129578136166;995.746084748399;5809.215755872988;5906.734196961147;5922.437368449991;5957.344692083867;5974.312954010257;437.79204877682844;446.5199910096659;447.7492604141691;448.6948874765191;466.89728259782794;4039.313316736162;4193.748375097504;4197.706160568731;4228.323468245066;4229.133027729308;10034.397936123856;10396.844047339297;10406.58373665045;10416;10417.687469375931;10251.948740256401;10318.484075796181;10320.690379288633;10340.37957722539;10366.481675916173;7716.691332346643;7873.173316801768;7970.601469926596;8017.959910200411;8124.63439145228;5651.519620832111;5734.913976290442;5810.360860305447;5813.970930145322;5837.737301821343;9306.441613503212;9698.70903872885;9709.223262139154;9742.9025709742;9761.170300524534;9886.357386769838;9939.65211217604;9942.552585133542;9984.101430871257;10035.297529172887;7477.962610187132;7532.284432978859;7560.092788865371;7670.539767613961;7685.769426917202;8232.382571307056;8248.175182481944;8270.2556769891;8280.296174824967;8286.129956354496;7206.207317195209;7343.8898416522725;7345.926540734738;7364.3372096511575;7466.029416175862;7320.16109737622;7414.184439711519;7457.962710186414;7592.354649854603;7704.383649308154;6758.86482270342;6771.153605799275;6818.556793808387;6824.52228344031;6830.487713421414;4932.506749325039;5029.094762942559;5125.43620201785;5198.090334191425;5226.503482169188;5175.275461435327;5184.740762961912;5307.4692530746615;5374.758135883816;5382.461753824587 06:17:31 INFO - PROCESS | 7823 | |4;prototype.html;313.41391597712266;322.7305200157868;332.0768264225453;332.5560376896843;334.51161304495434;5102.846914592559;5198.40218374887;5257.815976440826;5295.973520132394;5308.92036619451;5209.921851172236;5234.214867769827;5248.212768084789;5248.9266739637915;5280.445553216915;4147.979260103695;4158.14962341758;4160.251154792136;4168.6665066794585;4226.513950895655;3936.9803150984203;4112.403701463286;4212.431321771553;4213.452251207339;4229.640480559141;4092.631663150316;4097.856575019875;4106.568810274908;4120.670346372283;4123.773192474413;4082.326416141333;4087.691938579656;4089.20260549193;4098.200850834073;4107.486564179478;3626.5493802478954;3627;3631.618680038611;3632.110133017401;3641.253543023674;5065.46812584677;5077.974610126963;5102.36220472441;5148.815772372338;5152.639315247934;4643.931895663983;4655.2784318430695;4656.231721765938;4684.992726563805;4685.929711054337;5385.5960802939935;5417.3747875637155;5420.485053919911;5420.972895135538;5453.23654688344;3786.807155745931;3919.2553414851086;3926.2147570486018;3928.8428462861452;3939.719591132893;5630.352509461382;5634.225219055984;5666.178404131378;5668.659880407189;5675.4608312210685;4009.7594144351433;4029.959700403017;4042.818073186655;4054.8986275342763;4059.512858456945;3978.8209530571194;4052.959470405317;4069.8575549855614;4090.9181816364103;4106.917861642751;4616.722996620214;4631.305304204397;4639.976800115978;4652.116097941381;4661.394018777605;5465.754041068161;5477.643953143033;5508.421615730371;5526.696031718214;5552.750126244248;1324.5761356366063;1367.3436750359883;1378.9586312410643;1387.777955527131;1396.748585254664;929.7954450020984;948.7817801905462;958.9260028767825;969.5733877094056;975.9365641233297;5230.163173892159;5264.473552644705;5266.183741520071;5271.973640131775;5276.577873770089;5553.83369492403;5561.4716601922755;5576.609637325349;5581.609287349927;5585.245991791137;5171.844844654666;5178.766955487012;5285.973570132125;5335.493128152819;5340.519353258225;2633.789296856247;2639.722829102955;2654.522186006499;2658.3752818087733;2665.36031352474;5041.546260836469;5071.185492051873;5087.2449005093185;5102.744862756847;5119.846404607868;4827.95172048275;5032.220005899091;5049.873753156127;5060.5698515625845;5076.796928122908;5003.924941125813;5021.5229553192385;5027.497250275016;5041.798328066836;5044.949550504448;4879;4896.706197628154;4920.950790492049;4956.603471722182;4958.834673851714;4669.836555720533;4810.244260844836;4822.7829747662145;4856.805727770849;4956.925646115239;5029.270755740324;5074.238864170404;5098.821541246039;5152.948470515247;5155.742212889416;3672;3675.963240367562;3676.4669122977552;3691.427828686558;3691.557013158438;4648.9772250104925;4971.701697898137;4977.153883839684;4978.352814134139;5425.945740542544;5318.7340632967425;5496.835094947158;5498.257735205696;5499.130295699481;5552.278793574005;5479.232907393048;5482.616216864782;5508.614396992172;5524.530414914777;5538.889222215614;5185.455527169744;5336.252924590638;5347.705876176692;5448.520922979956;5467.5625949923115;5488.5334746545395;5497.8075767347955;5512.6968016759465;5537.501624853782;5547.694876781816;5358.866028349166;5401.217598192666;5432.750467392443;5449.618526703092;5461.5357694596405 06:17:31 INFO - PROCESS | 7823 | |5;yui.html;738.3797610007592;773.5242825662216;788.2708494642458;816.4488969945286;830.4311546590586;14785.186814725186;16123.83876161238;16156.676866462663;16216.594585135377;16234.350625974947;15340.156291403968;15620.921895390535;15622.218889055559;15628.21858907053;15644.217789110557;659.4394764450227;782.3271986091956;799.3365506629498;800.2517646000979;826.6775957376628;809.4576633655436;811.8457493076326;817.9222973817477;818.9631466584018;819.315871247509;843.5318398288947;852;854.7563944275882;854.8931383577053;855.1662129423793;676.9018492318611;820.0733171516149;844.5988155626089;844.7001314533344;851.1488511488511;626.3923993726079;626.5332327416058;627.1314229791726;627.5387590121258;627.8587317853492;14386.712265754732;14514.056586321854;14538.345774440175;14556.199409032499;14580.416783328654;13658.385372658255;13855;14164.787528187086;14409.639759006004;14593.78109328361;12515.624531264077;12877.806832897513;12943.741125177443;12947.158434701714;13476.797848032189;4450.688451808374;4485;4496.145732310851;4569.748663823489;4606.378138951266;83276.58361708213;86823.13176868214;86841;86856.6971495428;87347.12652873453;11780.880816322435;11795.705107372385;11818.40907954616;12010.219335743148;12024.098192635587;22881.313560593208;22926.885365573064;22943;22962.19632312861;23220.65169022466;8209.507429554245;8299.128591497927;8300.08699043117;8399.37004724648;8540.103289154673;3936.4488971544006;4083.999420142084;4110.547839737626;4361.520232774392;4482.5069242383315;3626.9818650906577;3763.5295588051495;3766.8116594170183;3767.7362584618813;3769.133099387156;594.4560726934806;603.5015037743744;606.4632799972056;610.2311088029027;611.703323887914;573.1402895656515;587.5740088435936;592.7865968251426;637.719403462475;648.6367634124905;8542.18849209324;8867.73396798097;9016.909830901739;9101.135392137736;9255.305852061123;568.528121659022;586.3286536915208;612.6140531465237;640.9583377080475;688.8906485073989;4192.979035104866;4371.147626212858;4386;4441.800118994653;4450.443694538183;121599.39200303942;128025;129598.35200823935;129750;130146;100213.4967975481;109895;111090.44454777674;113367.43316283365;115888;89209.55395223112;89407;90823;91473.54263228641;91849.54075229581;8271.710490132817;8358.791030224293;8538.573071346284;8539.487630742175;8759.868601970848;54455.45544544662;55789;56310.7184464075;57040.71479642575;58263.70868145632;75171.24828751643;75483.62258188674;80594.59702701449;83688.58155709182;86310.56844715988;13423;13565.321733913068;13709.794353084912;14050.718985620435;14174.716505669623;14865.810735141378;14885.776713349092;14963.401463941756;15202.543923682308;15340.30968606393;13078.476860925457;13294.534691285759;13491.392887319898;13691.383887724876;13692;13844.673866690244;13918.09532380392;14066.78899816524;14636.41454341857;15077.095374277578;12964;13039.282839443542;13664.795028074786;13770.65573360674;13884.236366999912;10830.945845270724;11128.1653875958;11154.553817847196;11301.830472542753;11616.593419230287;11597.420128993685;12058.276503409823;12191.573294934635;12253.75492490163;12411.255324680547 06:17:31 INFO - PROCESS | 7823 | __end_tp_report 06:17:31 INFO - PROCESS | 7823 | __start_cc_report 06:17:31 INFO - PROCESS | 7823 | _x_x_mozilla_cycle_collect,977 06:17:31 INFO - PROCESS | 7823 | __end_cc_report 06:17:31 INFO - PROCESS | 7823 | __startTimestamp1470316651342__endTimestamp 06:17:31 INFO - PROCESS | 7823 | 06:17:31 INFO - PROCESS | 7823 | ------- Summary: start ------- 06:17:31 INFO - PROCESS | 7823 | Number of tests: 6 06:17:31 INFO - PROCESS | 7823 | 06:17:31 INFO - PROCESS | 7823 | [#0] dojo.html Cycles:165 Average:5256.90 Median:5435.13 stddev:600.11 (11.0%) stddev-sans-first:574.84 06:17:31 INFO - PROCESS | 7823 | Values: 2983.6 3015.4 3026.7 3029.5 3040.3 5149.7 5189.8 5265.9 5319.9 5336.9 5267.4 5270.5 5313.8 5322.0 5384.7 4716.2 4784.6 4802.0 4811.4 4937.9 4870.7 4897.3 4908.0 4916.0 4933.7 4705.4 4711.5 4771.3 4773.7 4812.3 4764.6 4781.9 4784.5 4854.5 4870.8 4793.4 4821.6 4824.8 4854.7 4889.8 5117.3 5199.1 5293.0 5318.9 5350.8 5704.3 5713.9 5751.3 5756.5 5759.9 5736.1 5750.8 5794.4 5802.5 5803.9 5084.9 5155.1 5186.5 5195.3 5411.6 5721.6 5741.1 5747.3 5783.6 5784.0 5494.1 5513.6 5549.0 5552.7 5565.6 5491.8 5550.3 5617.6 5621.5 5625.4 5631.8 5645.5 5648.3 5652.4 5692.3 5592.4 5652.0 5661.8 5662.6 5678.0 4216.8 4248.1 4320.7 4365.7 4380.1 3879.9 3885.6 3918.7 3922.9 3944.8 5363.7 5366.2 5378.4 5381.0 5426.2 5538.2 5574.6 5598.7 5710.0 5727.0 5331.0 5331.3 5332.3 5349.9 5353.5 4917.9 4919.8 4920.4 4923.0 4961.4 5735.7 5826.8 5878.1 5881.4 5895.5 5719.8 5720.7 5721.8 5756.3 5770.3 5932.4 5935.4 5942.1 5945.7 5950.8 5338.4 5395.4 5404.1 5621.9 5631.0 5551.6 5581.1 5585.9 5616.6 5634.5 5455.5 5459.8 5464.7 5469.1 5537.5 5402.0 5429.0 5490.7 5519.5 5560.6 5487.9 5495.8 5503.8 5539.0 5560.0 5587.9 5603.7 5631.4 5633.1 5634.7 5379.0 5424.6 5435.1 5467.4 5484.0 06:17:31 INFO - PROCESS | 7823 | 06:17:31 INFO - PROCESS | 7823 | [#1] ext.html Cycles:180 Average:62760.93 Median:42951.86 stddev:125791.81 (292.9%) stddev-sans-first:126058.10 06:17:31 INFO - PROCESS | 7823 | Values: 597.7 599.8 602.4 613.9 618.1 31398.5 42851.1 43104.1 43138.0 43280.0 44292.3 44656.6 44844.3 44871.8 44989.0 9001.8 9135.9 9154.9 9156.0 9160.4 8996.6 9085.8 9088.8 9100.4 9101.3 9108.4 9145.3 9150.0 9163.6 9169.9 9069.6 9107.7 9108.0 9115.7 9117.0 8907.6 8925.2 8975.0 8987.1 8993.6 41509.8 41668.4 41736.2 41747.2 41885.8 3288.9 3333.8 3402.2 3443.0 4266.1 32272.2 32821.0 33430.8 33456.7 34421.7 4422.4 4479.2 4484.5 4626.4 4670.1 346597.0 347571.0 347604.0 348506.0 348970.0 49838.5 55967.0 56380.6 56428.7 56495.4 58056.0 59436.4 59529.0 64386.7 64543.7 17137.9 17290.8 17299.5 17309.2 17361.1 11889.0 13333.1 13432.0 13458.8 13511.3 15345.9 15757.7 15766.4 15804.8 16010.4 5894.8 5898.9 5906.4 5965.1 6016.9 953.8 1028.0 1096.5 1097.3 1118.3 32483.0 32731.7 32894.2 33056.4 33169.2 1075.9 1080.7 1082.9 1144.4 1228.7 16220.1 17039.4 17332.8 17362.4 17447.7 552777.0 557014.0 557303.0 558496.0 561695.0 57920.0 58175.0 58244.7 58291.1 58321.0 1239.8 1289.7 1297.1 1353.9 1355.4 29869.1 33601.7 33615.7 33976.2 34739.7 51821.7 52664.7 52704.7 52793.5 52821.2 487246.0 492456.0 492651.0 492955.0 493021.0 39001.4 39194.8 39199.8 40050.2 44410.0 48785.3 49184.5 49222.0 49415.5 49644.5 41279.0 41477.4 42822.1 43052.6 43169.8 42257.0 42422.0 42463.0 43272.8 43748.3 41525.0 42055.8 42392.0 42535.8 42840.0 34322.7 36621.0 37264.0 37607.8 37754.0 28123.2 28212.9 28444.7 28519.6 28775.4 06:17:31 INFO - PROCESS | 7823 | 06:17:31 INFO - PROCESS | 7823 | [#2] jquery.html Cycles:180 Average:29155.89 Median:44560.67 stddev:82409.79 (184.9%) stddev-sans-first:82612.61 06:17:31 INFO - PROCESS | 7823 | Values: 362.3 378.7 383.1 385.8 397.8 17842.8 19516.2 19519.0 19758.3 20644.2 17832.8 18272.4 18312.6 18323.1 18479.9 5605.9 5723.5 5808.8 5818.2 5819.7 5879.1 6047.5 6055.9 6065.9 6066.8 5803.3 5805.2 5879.7 6054.2 6061.7 5816.4 5845.4 5853.3 5853.7 5858.8 5546.1 5676.8 5850.4 5873.9 5883.4 14593.6 14624.9 14805.8 24248.5 24644.3 2188.9 2320.7 2437.5 2482.4 2781.9 10302.4 10546.7 10608.2 10672.9 10910.0 1797.5 1802.9 1837.0 1871.2 1902.3 78324.0 82646.0 82847.2 83219.0 86046.6 11185.6 11239.9 11305.8 11444.0 11551.7 15740.5 15745.3 15755.9 15764.0 15764.4 8377.2 8560.3 8574.8 8686.9 8749.3 7629.3 7744.6 7794.2 7979.8 8502.5 4767.3 4881.0 4897.7 4910.4 5050.2 1936.8 1957.4 1992.8 2028.4 2042.6 881.3 931.6 964.0 988.7 1001.7 18889.3 20749.0 20880.4 20947.0 20964.5 948.8 963.4 975.2 998.7 1014.4 10613.2 11555.2 11575.8 11590.7 11606.7 491967.0 493461.0 500101.0 507725.0 510694.0 55298.7 73332.0 90336.1 91358.5 91614.5 943.5 970.6 985.0 989.2 992.2 17527.0 18225.7 18403.6 18409.3 18547.4 43165.4 44547.8 44573.6 45015.8 45973.3 57300.4 60258.4 61352.4 62187.0 64882.0 8449.8 8722.9 8836.3 8982.2 9072.2 12834.9 13524.1 13665.5 13801.1 13880.0 11530.3 11692.9 11780.4 11791.8 12342.7 10703.6 11202.8 11333.9 11839.1 12258.8 6826.0 7631.9 10498.7 12233.8 12389.4 8616.9 8649.6 8714.6 8734.4 9120.6 8854.8 11812.6 11814.2 11831.9 11922.8 06:17:31 INFO - PROCESS | 7823 | 06:17:31 INFO - PROCESS | 7823 | [#3] mootools.html Cycles:180 Average:5561.44 Median:4939.38 stddev:3091.30 (62.6%) stddev-sans-first:3083.23 06:17:31 INFO - PROCESS | 7823 | Values: 1280.7 1296.8 1368.3 1409.5 1640.9 7824.0 8197.0 8240.7 8248.0 8420.7 8054.3 8230.4 8432.6 8443.4 8447.7 2307.5 2349.2 2351.0 2351.9 2353.4 2292.1 2327.7 2330.0 2330.4 2330.4 2311.8 2330.2 2339.7 2350.3 2352.6 2251.7 2275.3 2280.5 2283.4 2311.8 2257.2 2260.4 2263.7 2265.5 2265.5 8232.4 8270.7 8287.9 8344.2 8351.8 5057.9 5223.0 5229.0 5231.8 5237.5 3207.4 3209.2 3231.5 3266.1 3270.5 1140.9 1172.7 1175.2 1194.6 1202.6 10910.5 10961.2 10965.5 10992.9 11008.7 4167.0 4348.0 4506.1 4621.8 4625.5 9435.1 9447.6 9466.9 9488.6 9498.9 4906.2 4923.6 4937.8 4939.2 4939.6 4246.4 4303.5 4353.1 4534.6 4547.1 3914.1 3927.6 4034.5 4047.0 4175.7 1192.3 1249.4 1266.8 1268.6 1272.2 959.2 979.7 986.4 987.1 995.7 5809.2 5906.7 5922.4 5957.3 5974.3 437.8 446.5 447.7 448.7 466.9 4039.3 4193.7 4197.7 4228.3 4229.1 10034.4 10396.8 10406.6 10416.0 10417.7 10251.9 10318.5 10320.7 10340.4 10366.5 7716.7 7873.2 7970.6 8018.0 8124.6 5651.5 5734.9 5810.4 5814.0 5837.7 9306.4 9698.7 9709.2 9742.9 9761.2 9886.4 9939.7 9942.6 9984.1 10035.3 7478.0 7532.3 7560.1 7670.5 7685.8 8232.4 8248.2 8270.3 8280.3 8286.1 7206.2 7343.9 7345.9 7364.3 7466.0 7320.2 7414.2 7458.0 7592.4 7704.4 6758.9 6771.2 6818.6 6824.5 6830.5 4932.5 5029.1 5125.4 5198.1 5226.5 5175.3 5184.7 5307.5 5374.8 5382.5 06:17:31 INFO - PROCESS | 7823 | 06:17:31 INFO - PROCESS | 7823 | [#4] prototype.html Cycles:180 Average:4470.73 Median:5041.67 stddev:1288.07 (25.5%) stddev-sans-first:1253.32 06:17:31 INFO - PROCESS | 7823 | Values: 313.4 322.7 332.1 332.6 334.5 5102.8 5198.4 5257.8 5296.0 5308.9 5209.9 5234.2 5248.2 5248.9 5280.4 4148.0 4158.1 4160.3 4168.7 4226.5 3937.0 4112.4 4212.4 4213.5 4229.6 4092.6 4097.9 4106.6 4120.7 4123.8 4082.3 4087.7 4089.2 4098.2 4107.5 3626.5 3627.0 3631.6 3632.1 3641.3 5065.5 5078.0 5102.4 5148.8 5152.6 4643.9 4655.3 4656.2 4685.0 4685.9 5385.6 5417.4 5420.5 5421.0 5453.2 3786.8 3919.3 3926.2 3928.8 3939.7 5630.4 5634.2 5666.2 5668.7 5675.5 4009.8 4030.0 4042.8 4054.9 4059.5 3978.8 4053.0 4069.9 4090.9 4106.9 4616.7 4631.3 4640.0 4652.1 4661.4 5465.8 5477.6 5508.4 5526.7 5552.8 1324.6 1367.3 1379.0 1387.8 1396.7 929.8 948.8 958.9 969.6 975.9 5230.2 5264.5 5266.2 5272.0 5276.6 5553.8 5561.5 5576.6 5581.6 5585.2 5171.8 5178.8 5286.0 5335.5 5340.5 2633.8 2639.7 2654.5 2658.4 2665.4 5041.5 5071.2 5087.2 5102.7 5119.8 4828.0 5032.2 5049.9 5060.6 5076.8 5003.9 5021.5 5027.5 5041.8 5044.9 4879.0 4896.7 4921.0 4956.6 4958.8 4669.8 4810.2 4822.8 4856.8 4956.9 5029.3 5074.2 5098.8 5152.9 5155.7 3672.0 3676.0 3676.5 3691.4 3691.6 4649.0 4971.7 4977.2 4978.4 5425.9 5318.7 5496.8 5498.3 5499.1 5552.3 5479.2 5482.6 5508.6 5524.5 5538.9 5185.5 5336.3 5347.7 5448.5 5467.6 5488.5 5497.8 5512.7 5537.5 5547.7 5358.9 5401.2 5432.8 5449.6 5461.5 06:17:31 INFO - PROCESS | 7823 | 06:17:31 INFO - PROCESS | 7823 | [#5] yui.html Cycles:180 Average:22271.06 Median:4378.57 stddev:33097.69 (755.9%) stddev-sans-first:33151.05 06:17:31 INFO - PROCESS | 7823 | Values: 738.4 773.5 788.3 816.4 830.4 14785.2 16123.8 16156.7 16216.6 16234.4 15340.2 15620.9 15622.2 15628.2 15644.2 659.4 782.3 799.3 800.3 826.7 809.5 811.8 817.9 819.0 819.3 843.5 852.0 854.8 854.9 855.2 676.9 820.1 844.6 844.7 851.1 626.4 626.5 627.1 627.5 627.9 14386.7 14514.1 14538.3 14556.2 14580.4 13658.4 13855.0 14164.8 14409.6 14593.8 12515.6 12877.8 12943.7 12947.2 13476.8 4450.7 4485.0 4496.1 4569.7 4606.4 83276.6 86823.1 86841.0 86856.7 87347.1 11780.9 11795.7 11818.4 12010.2 12024.1 22881.3 22926.9 22943.0 22962.2 23220.7 8209.5 8299.1 8300.1 8399.4 8540.1 3936.4 4084.0 4110.5 4361.5 4482.5 3627.0 3763.5 3766.8 3767.7 3769.1 594.5 603.5 606.5 610.2 611.7 573.1 587.6 592.8 637.7 648.6 8542.2 8867.7 9016.9 9101.1 9255.3 568.5 586.3 612.6 641.0 688.9 4193.0 4371.1 4386.0 4441.8 4450.4 121599.4 128025.0 129598.4 129750.0 130146.0 100213.5 109895.0 111090.4 113367.4 115888.0 89209.6 89407.0 90823.0 91473.5 91849.5 8271.7 8358.8 8538.6 8539.5 8759.9 54455.5 55789.0 56310.7 57040.7 58263.7 75171.2 75483.6 80594.6 83688.6 86310.6 13423.0 13565.3 13709.8 14050.7 14174.7 14865.8 14885.8 14963.4 15202.5 15340.3 13078.5 13294.5 13491.4 13691.4 13692.0 13844.7 13918.1 14066.8 14636.4 15077.1 12964.0 13039.3 13664.8 13770.7 13884.2 10830.9 11128.2 11154.6 11301.8 11616.6 11597.4 12058.3 12191.6 12253.8 12411.3 06:17:31 INFO - PROCESS | 7823 | -------- Summary: end -------- 06:17:31 INFO - PROCESS | 7823 | 06:17:32 INFO - TEST-INFO | 7823: exit 0 06:17:32 INFO - TEST-OK | dromaeo_css | took 1115625ms 06:17:32 INFO - TEST-START | kraken 06:17:32 INFO - operating with platform_type : linux_ 06:17:32 INFO - Initialising browser for kraken test... 06:17:32 INFO - TEST-INFO | started process 8017 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsyOkwD/profile http://localhost:46903/getInfo.html) 06:17:36 INFO - PROCESS | 8017 | __metrics Screen width/height:1600/1200 06:17:36 INFO - PROCESS | 8017 | colorDepth:24 06:17:36 INFO - PROCESS | 8017 | Browser inner width/height: 1024/697 06:17:36 INFO - PROCESS | 8017 | __metrics 06:17:37 INFO - PROCESS | 8017 | 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" 06:17:37 INFO - PROCESS | 8017 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:17:38 INFO - TEST-INFO | 8017: exit 0 06:17:38 INFO - Browser initialized. 06:17:38 INFO - Running cycle 1/1 for kraken test... 06:17:38 INFO - TEST-INFO | started process 8096 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsyOkwD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:17:50 INFO - PROCESS | 8096 | RSS: Main: 156241920 06:17:50 INFO - PROCESS | 8096 | 06:17:53 INFO - PROCESS | 8096 | Cycle 1(1): loaded http://localhost:46903/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46903/tests/kraken/driver.html?testName=audio-beat-detection) 06:17:54 INFO - PROCESS | 8096 | RSS: Main: 213417984 06:17:54 INFO - PROCESS | 8096 | 06:17:56 INFO - PROCESS | 8096 | Cycle 1(1): loaded http://localhost:46903/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46903/tests/kraken/driver.html?testName=audio-dft) 06:17:57 INFO - PROCESS | 8096 | RSS: Main: 191774720 06:17:57 INFO - PROCESS | 8096 | 06:18:00 INFO - PROCESS | 8096 | Cycle 1(1): loaded http://localhost:46903/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46903/tests/kraken/driver.html?testName=audio-fft) 06:18:00 INFO - PROCESS | 8096 | RSS: Main: 269021184 06:18:00 INFO - PROCESS | 8096 | 06:18:03 INFO - PROCESS | 8096 | Cycle 1(1): loaded http://localhost:46903/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46903/tests/kraken/driver.html?testName=audio-oscillator) 06:18:03 INFO - PROCESS | 8096 | RSS: Main: 180047872 06:18:03 INFO - PROCESS | 8096 | 06:18:05 INFO - PROCESS | 8096 | Cycle 1(1): loaded http://localhost:46903/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46903/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:18:06 INFO - PROCESS | 8096 | RSS: Main: 184438784 06:18:06 INFO - PROCESS | 8096 | 06:18:09 INFO - PROCESS | 8096 | Cycle 1(1): loaded http://localhost:46903/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46903/tests/kraken/driver.html?testName=imaging-darkroom) 06:18:09 INFO - PROCESS | 8096 | RSS: Main: 219185152 06:18:09 INFO - PROCESS | 8096 | 06:18:13 INFO - PROCESS | 8096 | Cycle 1(1): loaded http://localhost:46903/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46903/tests/kraken/driver.html?testName=imaging-desaturate) 06:18:13 INFO - PROCESS | 8096 | RSS: Main: 220467200 06:18:13 INFO - PROCESS | 8096 | 06:18:16 INFO - PROCESS | 8096 | Cycle 1(1): loaded http://localhost:46903/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46903/tests/kraken/driver.html?testName=json-parse-financial) 06:18:17 INFO - PROCESS | 8096 | RSS: Main: 220127232 06:18:17 INFO - PROCESS | 8096 | 06:18:18 INFO - PROCESS | 8096 | Cycle 1(1): loaded http://localhost:46903/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46903/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:18:19 INFO - PROCESS | 8096 | RSS: Main: 184115200 06:18:19 INFO - PROCESS | 8096 | 06:18:21 INFO - PROCESS | 8096 | Cycle 1(1): loaded http://localhost:46903/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46903/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:18:21 INFO - PROCESS | 8096 | RSS: Main: 190771200 06:18:21 INFO - PROCESS | 8096 | 06:18:23 INFO - PROCESS | 8096 | Cycle 1(1): loaded http://localhost:46903/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46903/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:18:24 INFO - PROCESS | 8096 | RSS: Main: 194240512 06:18:24 INFO - PROCESS | 8096 | 06:18:26 INFO - PROCESS | 8096 | Cycle 1(1): loaded http://localhost:46903/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46903/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:18:27 INFO - PROCESS | 8096 | RSS: Main: 187392000 06:18:27 INFO - PROCESS | 8096 | 06:18:30 INFO - PROCESS | 8096 | Cycle 1(1): loaded http://localhost:46903/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46903/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:18:30 INFO - PROCESS | 8096 | RSS: Main: 192684032 06:18:30 INFO - PROCESS | 8096 | 06:18:32 INFO - PROCESS | 8096 | Cycle 1(1): loaded http://localhost:46903/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46903/tests/kraken/driver.html?testName=ai-astar) 06:18:32 INFO - PROCESS | 8096 | RSS: Main: 242638848 06:18:32 INFO - PROCESS | 8096 | 06:18:32 INFO - PROCESS | 8096 | __start_tp_report 06:18:32 INFO - PROCESS | 8096 | _x_x_mozilla_page_load 06:18:32 INFO - PROCESS | 8096 | _x_x_mozilla_page_load_details 06:18:32 INFO - PROCESS | 8096 | |i|pagename|runs| 06:18:32 INFO - PROCESS | 8096 | |0;ai-astar;103;113;111;111;111;113;111;111;111;112 06:18:32 INFO - PROCESS | 8096 | |1;audio-beat-detection;148;117;118;177;122;119;141;117;173;117 06:18:32 INFO - PROCESS | 8096 | |2;audio-dft;160;160;160;160;161;160;160;161;160;160 06:18:32 INFO - PROCESS | 8096 | |3;audio-fft;75;75;75;111;74;75;83;75;103;75 06:18:32 INFO - PROCESS | 8096 | |4;audio-oscillator;83;83;113;84;84;85;128;83;83;130 06:18:32 INFO - PROCESS | 8096 | |5;imaging-gaussian-blur;117;117;116;117;117;116;117;117;116;116 06:18:32 INFO - PROCESS | 8096 | |6;imaging-darkroom;145;145;145;146;145;146;146;145;146;145 06:18:32 INFO - PROCESS | 8096 | |7;imaging-desaturate;95;95;95;95;96;95;95;95;95;95 06:18:32 INFO - PROCESS | 8096 | |8;json-parse-financial;51;50;50;50;49;51;50;49;49;50 06:18:32 INFO - PROCESS | 8096 | |9;json-stringify-tinderbox;62;61;62;62;62;62;61;61;61;61 06:18:32 INFO - PROCESS | 8096 | |10;stanford-crypto-aes;77;76;75;75;76;75;78;75;75;85 06:18:32 INFO - PROCESS | 8096 | |11;stanford-crypto-ccm;128;123;122;149;140;121;135;121;162;121 06:18:32 INFO - PROCESS | 8096 | |12;stanford-crypto-pbkdf2;155;160;159;156;155;156;158;155;156;159 06:18:32 INFO - PROCESS | 8096 | |13;stanford-crypto-sha256-iterative;66;63;63;63;67;63;62;62;63;62 06:18:32 INFO - PROCESS | 8096 | __end_tp_report 06:18:32 INFO - PROCESS | 8096 | __start_cc_report 06:18:32 INFO - PROCESS | 8096 | _x_x_mozilla_cycle_collect,1627 06:18:32 INFO - PROCESS | 8096 | __end_cc_report 06:18:32 INFO - PROCESS | 8096 | __startTimestamp1470316712758__endTimestamp 06:18:32 INFO - PROCESS | 8096 | 06:18:32 INFO - PROCESS | 8096 | ------- Summary: start ------- 06:18:32 INFO - PROCESS | 8096 | Number of tests: 14 06:18:32 INFO - PROCESS | 8096 | 06:18:32 INFO - PROCESS | 8096 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:2.83 (2.5%) stddev-sans-first:0.88 06:18:32 INFO - PROCESS | 8096 | Values: 103.0 113.0 111.0 111.0 111.0 113.0 111.0 111.0 111.0 112.0 06:18:32 INFO - PROCESS | 8096 | 06:18:32 INFO - PROCESS | 8096 | [#1] audio-beat-detection Cycles:10 Average:134.90 Median:131.50 stddev:23.80 (18.1%) stddev-sans-first:24.77 06:18:32 INFO - PROCESS | 8096 | Values: 148.0 117.0 118.0 177.0 122.0 119.0 141.0 117.0 173.0 117.0 06:18:32 INFO - PROCESS | 8096 | 06:18:32 INFO - PROCESS | 8096 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 06:18:32 INFO - PROCESS | 8096 | Values: 160.0 160.0 160.0 160.0 161.0 160.0 160.0 161.0 160.0 160.0 06:18:32 INFO - PROCESS | 8096 | 06:18:32 INFO - PROCESS | 8096 | [#3] audio-fft Cycles:10 Average:82.10 Median:75.00 stddev:13.50 (18.0%) stddev-sans-first:14.08 06:18:32 INFO - PROCESS | 8096 | Values: 75.0 75.0 75.0 111.0 74.0 75.0 83.0 75.0 103.0 75.0 06:18:32 INFO - PROCESS | 8096 | 06:18:32 INFO - PROCESS | 8096 | [#4] audio-oscillator Cycles:10 Average:95.60 Median:83.00 stddev:19.87 (23.9%) stddev-sans-first:20.54 06:18:32 INFO - PROCESS | 8096 | Values: 83.0 83.0 113.0 84.0 84.0 85.0 128.0 83.0 83.0 130.0 06:18:32 INFO - PROCESS | 8096 | 06:18:32 INFO - PROCESS | 8096 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 06:18:32 INFO - PROCESS | 8096 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 116.0 116.0 06:18:32 INFO - PROCESS | 8096 | 06:18:32 INFO - PROCESS | 8096 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 06:18:32 INFO - PROCESS | 8096 | Values: 145.0 145.0 145.0 146.0 145.0 146.0 146.0 145.0 146.0 145.0 06:18:32 INFO - PROCESS | 8096 | 06:18:32 INFO - PROCESS | 8096 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 06:18:32 INFO - PROCESS | 8096 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 06:18:32 INFO - PROCESS | 8096 | 06:18:32 INFO - PROCESS | 8096 | [#8] json-parse-financial Cycles:10 Average:49.90 Median:50.00 stddev:0.74 (1.5%) stddev-sans-first:0.67 06:18:32 INFO - PROCESS | 8096 | Values: 51.0 50.0 50.0 50.0 49.0 51.0 50.0 49.0 49.0 50.0 06:18:32 INFO - PROCESS | 8096 | 06:18:32 INFO - PROCESS | 8096 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:62.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 06:18:32 INFO - PROCESS | 8096 | Values: 62.0 61.0 62.0 62.0 62.0 62.0 61.0 61.0 61.0 61.0 06:18:32 INFO - PROCESS | 8096 | 06:18:32 INFO - PROCESS | 8096 | [#10] stanford-crypto-aes Cycles:10 Average:76.70 Median:76.00 stddev:3.09 (4.1%) stddev-sans-first:3.28 06:18:32 INFO - PROCESS | 8096 | Values: 77.0 76.0 75.0 75.0 76.0 75.0 78.0 75.0 75.0 85.0 06:18:32 INFO - PROCESS | 8096 | 06:18:32 INFO - PROCESS | 8096 | [#11] stanford-crypto-ccm Cycles:10 Average:132.20 Median:131.50 stddev:14.23 (10.8%) stddev-sans-first:15.01 06:18:32 INFO - PROCESS | 8096 | Values: 128.0 123.0 122.0 149.0 140.0 121.0 135.0 121.0 162.0 121.0 06:18:32 INFO - PROCESS | 8096 | 06:18:32 INFO - PROCESS | 8096 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.90 Median:157.00 stddev:1.91 (1.2%) stddev-sans-first:1.90 06:18:32 INFO - PROCESS | 8096 | Values: 155.0 160.0 159.0 156.0 155.0 156.0 158.0 155.0 156.0 159.0 06:18:32 INFO - PROCESS | 8096 | 06:18:32 INFO - PROCESS | 8096 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.00 stddev:1.71 (2.7%) stddev-sans-first:1.54 06:18:32 INFO - PROCESS | 8096 | Values: 66.0 63.0 63.0 63.0 67.0 63.0 62.0 62.0 63.0 62.0 06:18:32 INFO - PROCESS | 8096 | -------- Summary: end -------- 06:18:32 INFO - PROCESS | 8096 | 06:18:33 INFO - TEST-INFO | 8096: exit 0 06:18:33 INFO - TEST-OK | kraken | took 61830ms 06:18:33 INFO - SUITE-END | took 1177s 06:18:33 INFO - Completed test suite (00:19:37) 06:18:33 INFO - javascript benchmark 06:18:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2983.582298478212, 3015.4119946610413, 3026.6670666226696, 3029.500132478142, 3040.331127152027, 5149.665271757333, 5189.766460509286, 5265.86835329117, 5319.867003324914, 5336.866578335544, 5267.39424966129, 5270.49930256625, 5313.840584782462, 5322.0, 5384.703841288728, 4716.198246298129, 4784.593309568673, 4801.951980480186, 4811.446683631375, 4937.851864444073, 4870.732109733964, 4897.314375987365, 4907.975460122694, 4916.0, 4933.703977761345, 4705.388299521074, 4711.528847115295, 4771.260454629538, 4773.737444440554, 4812.278158276269, 4764.618830493552, 4781.876259079114, 4784.473707892129, 4854.514548545118, 4870.805167793319, 4793.44875339337, 4821.614270858323, 4824.782884770194, 4854.684445511066, 4889.779959901813, 5117.283580298761, 5199.1161502544655, 5293.04725149473, 5318.867028324285, 5350.759215835296, 5704.286964129484, 5713.914291285634, 5751.309842818889, 5756.481916627524, 5759.856003599902, 5736.139579063174, 5750.827475175752, 5794.420557944214, 5802.506786923117, 5803.883922321572, 5084.923726144074, 5155.072087024334, 5186.481351864783, 5195.272661827272, 5411.648242864201, 5721.628094173865, 5741.081426971748, 5747.252857128547, 5783.595148339576, 5783.971080144656, 5494.120940649477, 5513.558915286768, 5548.9722551387795, 5552.666839989613, 5565.610407271533, 5491.780328786804, 5550.306211723535, 5617.550595952314, 5621.49406553404, 5625.409332020161, 5631.802886898939, 5645.5483561314995, 5648.322201335866, 5652.434756524314, 5692.260006199168, 5592.412796656374, 5652.039153343859, 5661.801836935688, 5662.603617746719, 5677.971610142005, 4216.810243539048, 4248.129133527619, 4320.719153255029, 4365.650747940221, 4380.145871555016, 3879.903002424962, 3885.630865067814, 3918.6669133123432, 3922.9019274518364, 3944.783036932939, 5363.731813409314, 5366.248725178478, 5378.381486129067, 5380.973095134499, 5426.240326354314, 5538.196961440649, 5574.637648552831, 5598.692071936082, 5710.029295019856, 5726.9713651431475, 5331.0, 5331.253624492574, 5332.2801421808335, 5349.946500534945, 5353.491418315254, 4917.901641967141, 4919.803207871717, 4920.3603531541385, 4922.950770492249, 4961.3798275215595, 5735.655860648374, 5826.825195244234, 5878.147668588031, 5881.411858814085, 5895.498882594856, 5719.828405147852, 5720.685362305113, 5721.799737009184, 5756.30924289088, 5770.336411312753, 5932.406759324033, 5935.376785437467, 5942.10868369748, 5945.732442040032, 5950.7917222896995, 5338.4127745947135, 5395.406505284494, 5404.081306177881, 5621.887562248814, 5630.95827271956, 5551.583631227755, 5581.051221292471, 5585.860353491195, 5616.6068375213345, 5634.464725851038, 5455.481729235717, 5459.808906688247, 5464.672119672832, 5469.097598896137, 5537.529310008695, 5402.0, 5429.0, 5490.670559766427, 5519.503244707996, 5560.5829562783765, 5487.917681234705, 5495.807646732345, 5503.834884953458, 5539.030669632879, 5560.0, 5587.916181257366, 5603.74783134768, 5631.408702086222, 5633.0705433603, 5634.661920284796, 5378.97310513445, 5424.620276580601, 5435.130379139318, 5467.398586155599, 5484.040292948798], "value": 5215.977342514078, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.6892016151601, 599.8080614203454, 602.3584882100564, 613.941675540824, 618.1284389011495, 31398.52902206466, 42851.14297714044, 43104.137917241635, 43138.0, 43280.0, 44292.3356149658, 44656.55343446565, 44844.32733509, 44871.77564112175, 44989.0, 9001.819963600741, 9135.862962055575, 9154.86267705985, 9155.954220228923, 9160.40457370272, 8996.550172491381, 9085.772855678628, 9088.818223635524, 9100.408473449204, 9101.271898248124, 9108.407953483036, 9145.314101442385, 9150.0, 9163.633454661805, 9169.862452063224, 9069.637214511411, 9107.726768196964, 9108.0, 9115.68095116671, 9117.0, 8907.599158037903, 8925.19673229406, 8975.0, 8987.101289871025, 8993.595288212045, 41509.79245103785, 41668.37497437541, 41736.16527669429, 41747.165056698694, 41885.79057104695, 3288.8520016599073, 3333.7833040852265, 3402.2174899772945, 3442.9827850860834, 4266.1254442839145, 32272.193195170075, 32821.0, 33430.83284583586, 33456.665433345595, 34421.6557834421, 4422.447194100738, 4479.216137175981, 4484.506704262529, 4626.375439315717, 4670.1126785910565, 346597.0, 347571.0, 347604.0, 348506.0, 348970.0, 49838.50161498338, 55967.0, 56380.59048523738, 56428.717856410454, 56495.435045649014, 58056.0, 59436.40563594395, 59529.0, 64386.67806660937, 64543.677281613294, 17137.91431042837, 17290.827091728923, 17299.481015569552, 17309.22108505095, 17361.13194340278, 11889.0, 13333.066685332127, 13432.0, 13458.798118028237, 13511.256880871646, 15345.9232703838, 15757.68484630301, 15766.448174313844, 15804.762928556082, 16010.359585616445, 5894.764209431661, 5898.882022359615, 5906.350301466835, 5965.077112214984, 6016.909746353808, 953.8283109040301, 1027.994860025695, 1096.5065720425841, 1097.2538673701958, 1118.2842980492492, 32483.0, 32731.672683272864, 32894.17764555857, 33056.40533461318, 33169.170770730445, 1075.9246852720391, 1080.7301420830493, 1082.9241953063367, 1144.3648774929993, 1228.668259569929, 16220.104297788233, 17039.40362087321, 17332.82667173337, 17362.39231626912, 17447.65104697899, 552777.0, 557014.0, 557303.0, 558496.0, 561695.0, 57920.0, 58175.0, 58244.7087764567, 58291.12563311554, 58321.0, 1239.7706424311532, 1289.6711338608595, 1297.0596317669615, 1353.864613538658, 1355.4171706166246, 29869.103926882228, 33601.66398335985, 33615.66384336125, 33976.15059623529, 34739.65260347465, 51821.7408912953, 52664.73667631637, 52704.736476317375, 52793.47206527885, 52821.207681884036, 487246.0, 492456.0, 492651.0, 492955.0, 493021.0, 39001.414978774774, 39194.80402597969, 39199.80400097981, 40050.1989960205, 44410.0, 48785.268220976, 49184.508154917996, 49222.0, 49415.50584494109, 49644.50355496399, 41279.0, 41477.377839333036, 42822.14355712806, 43052.56947430611, 43169.784151079046, 42257.0, 42422.0, 42463.0, 43272.783636081615, 43748.34377484404, 41525.0, 42055.7897210512, 42392.0, 42535.787321063195, 42840.0, 34322.65677343195, 36621.0, 37264.0, 37607.811960940024, 37754.0, 28123.156305310873, 28212.85893570519, 28444.715552844205, 28519.581279556816, 28775.424491510472], "value": 20425.141910168164, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.25375726004415, 378.7446893946529, 383.14558534468136, 385.75504554607824, 397.78917173897827, 17842.82157178428, 19516.21935122595, 19519.0, 19758.30845920393, 20644.1742330307, 17832.821671783277, 18272.360467383645, 18312.633747325046, 18323.083845807723, 18479.90760046201, 5605.915911261334, 5723.51350135239, 5808.796692115777, 5818.243628328311, 5819.738111784959, 5879.147523609074, 6047.455728984391, 6055.9394406056035, 6065.939340606582, 6066.787662431816, 5803.332616749086, 5805.245318108661, 5879.706014699269, 6054.243219597551, 6061.66660833654, 5816.389279125694, 5845.41545845412, 5853.32686741026, 5853.678047707374, 5858.794942177004, 5546.140348246028, 5676.829695109153, 5850.444207800252, 5873.882522349529, 5883.411658834125, 14593.635159121, 14624.853751462455, 14805.777913331309, 24248.515029699483, 24644.260672179862, 2188.9452763681034, 2320.6983092197906, 2437.536867995075, 2482.441450673602, 2781.860906954644, 10302.433366164858, 10546.736331591695, 10608.15134789215, 10672.946635266851, 10910.0, 1797.5236562310997, 1802.9008404537744, 1836.9816301836945, 1871.167330537911, 1902.286642509059, 78324.0, 82646.0, 82847.17152828455, 83219.0, 86046.56976715139, 11185.552577896793, 11239.94380028111, 11305.773884522428, 11444.0, 11551.653450396334, 15740.527784166494, 15745.291461884242, 15755.921220394053, 15764.0, 15764.448244311394, 8377.162283771697, 8560.272376847914, 8574.785630359167, 8686.913130868737, 8749.343799215085, 7629.3133617974645, 7744.612769361622, 7794.22057794216, 7979.800504987422, 8502.489850608983, 4767.332573439721, 4881.0, 4897.730624815598, 4910.361652985089, 5050.166722490748, 1936.7772706138692, 1957.3540731558837, 1992.7907569705262, 2028.3712049264775, 2042.601692669915, 881.2905610983092, 931.6040682709821, 963.9974426596261, 988.7182153086479, 1001.7195185348114, 18889.338873139375, 20749.0, 20880.37358879236, 20947.00970525515, 20964.47588810292, 948.7865230323122, 963.393062370702, 975.2100798353357, 998.7353351361895, 1014.3964341216964, 10613.204009699304, 11555.2489088209, 11575.826362604568, 11590.71023224426, 11606.70983225426, 491967.0, 493461.0, 500101.0, 507725.0, 510694.0, 55298.72350638221, 73332.0, 90336.09663903277, 91358.54320728354, 91614.54192729127, 943.5282358820727, 970.5729479029204, 985.0, 989.1690979577189, 992.1764935103846, 17527.0, 18225.726614100535, 18403.631927361646, 18409.263629455207, 18547.350842720978, 43165.352519712855, 44547.77726111478, 44573.55426445694, 45015.77492112519, 45973.31040034469, 57300.42699572951, 60258.39741602528, 61352.38647613645, 62187.0, 64882.0, 8449.788755281168, 8722.869156962777, 8836.293096552132, 8982.236509896731, 9072.183503484717, 12834.935825320814, 13524.12093213938, 13665.521706740217, 13801.102928309629, 13880.0, 11530.308181509135, 11692.883071169179, 11780.410979451164, 11791.823122653339, 12342.654895569813, 10703.571857125628, 11202.831957520806, 11333.943330283295, 11839.112066595211, 12258.754824903273, 6826.0, 7631.893375460638, 10498.685039448828, 12233.755324893275, 12389.442475088823, 8616.870746938675, 8649.56752162402, 8714.607842646968, 8734.388592798443, 9120.589573469342, 8854.77863053403, 11812.645620631394, 11814.232074915102, 11831.881681183422, 11922.76154476923], "value": 9227.835251378665, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1280.705437749318, 1296.753616812805, 1368.2543014057337, 1409.4784929576056, 1640.9097499637514, 7823.960880195598, 8197.0, 8240.711575094872, 8247.958760206198, 8420.747377578682, 8054.315383192421, 8230.42387032908, 8432.620532076056, 8443.366747493947, 8447.746567602966, 2307.5038866643667, 2349.1777877742825, 2350.976490235101, 2351.8588884666974, 2353.352827972304, 2292.060255295329, 2327.662488939103, 2330.021391015769, 2330.3707998840305, 2330.4057465346314, 2311.768823117683, 2330.1727886600265, 2339.7309309429465, 2350.318407661776, 2352.623580227164, 2251.6509940959177, 2275.340151356113, 2280.45269135408, 2283.360659015478, 2311.780380863815, 2257.1761307122947, 2260.4122928038664, 2263.7283525976823, 2265.4902646904316, 2265.524239909621, 8232.382571307176, 8270.669173233064, 8287.917120828835, 8344.207300306462, 8351.8329633407, 5057.9494205057845, 5223.0, 5229.0, 5231.764570594332, 5237.502437268454, 3207.3585282943272, 3209.245827230599, 3231.4829627259523, 3266.1018219989455, 3270.5257737627912, 1140.931544107356, 1172.6657902497832, 1175.1949914308725, 1194.6296648039136, 1202.5730865542694, 10910.5090270938, 10961.232713710044, 10965.50655220517, 10992.945035274772, 11008.669739907815, 4166.979165104216, 4348.0, 4506.121306345297, 4621.792019359137, 4625.537446255347, 9435.056494350647, 9447.574859131355, 9466.905330946602, 9488.620455181715, 9498.90501094994, 4906.215005599087, 4923.606111511071, 4937.8271760488215, 4939.2097264438235, 4939.555440010345, 4246.44796176495, 4303.483581970184, 4353.10761293934, 4534.614557762628, 4547.113312904018, 3914.099757055893, 3927.6072392760493, 4034.495688038995, 4046.959530404717, 4175.707700460938, 1192.3025030357337, 1249.3565813606, 1266.8416447944007, 1268.61307301274, 1272.179444258448, 959.1942768074712, 979.6669132494986, 986.3785814936545, 987.129578136166, 995.746084748399, 5809.215755872988, 5906.734196961147, 5922.437368449991, 5957.344692083867, 5974.312954010257, 437.79204877682844, 446.5199910096659, 447.7492604141691, 448.6948874765191, 466.89728259782794, 4039.313316736162, 4193.748375097504, 4197.706160568731, 4228.323468245066, 4229.133027729308, 10034.397936123856, 10396.844047339297, 10406.58373665045, 10416.0, 10417.687469375931, 10251.948740256401, 10318.484075796181, 10320.690379288633, 10340.37957722539, 10366.481675916173, 7716.691332346643, 7873.173316801768, 7970.601469926596, 8017.959910200411, 8124.63439145228, 5651.519620832111, 5734.913976290442, 5810.360860305447, 5813.970930145322, 5837.737301821343, 9306.441613503212, 9698.70903872885, 9709.223262139154, 9742.9025709742, 9761.170300524534, 9886.357386769838, 9939.65211217604, 9942.552585133542, 9984.101430871257, 10035.297529172887, 7477.962610187132, 7532.284432978859, 7560.092788865371, 7670.539767613961, 7685.769426917202, 8232.382571307056, 8248.175182481944, 8270.2556769891, 8280.296174824967, 8286.129956354496, 7206.207317195209, 7343.8898416522725, 7345.926540734738, 7364.3372096511575, 7466.029416175862, 7320.16109737622, 7414.184439711519, 7457.962710186414, 7592.354649854603, 7704.383649308154, 6758.86482270342, 6771.153605799275, 6818.556793808387, 6824.52228344031, 6830.487713421414, 4932.506749325039, 5029.094762942559, 5125.43620201785, 5198.090334191425, 5226.503482169188, 5175.275461435327, 5184.740762961912, 5307.4692530746615, 5374.758135883816, 5382.461753824587], "value": 4417.284409798712, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.41391597712266, 322.7305200157868, 332.0768264225453, 332.5560376896843, 334.51161304495434, 5102.846914592559, 5198.40218374887, 5257.815976440826, 5295.973520132394, 5308.92036619451, 5209.921851172236, 5234.214867769827, 5248.212768084789, 5248.9266739637915, 5280.445553216915, 4147.979260103695, 4158.14962341758, 4160.251154792136, 4168.6665066794585, 4226.513950895655, 3936.9803150984203, 4112.403701463286, 4212.431321771553, 4213.452251207339, 4229.640480559141, 4092.631663150316, 4097.856575019875, 4106.568810274908, 4120.670346372283, 4123.773192474413, 4082.326416141333, 4087.691938579656, 4089.20260549193, 4098.200850834073, 4107.486564179478, 3626.5493802478954, 3627.0, 3631.618680038611, 3632.110133017401, 3641.253543023674, 5065.46812584677, 5077.974610126963, 5102.36220472441, 5148.815772372338, 5152.639315247934, 4643.931895663983, 4655.2784318430695, 4656.231721765938, 4684.992726563805, 4685.929711054337, 5385.5960802939935, 5417.3747875637155, 5420.485053919911, 5420.972895135538, 5453.23654688344, 3786.807155745931, 3919.2553414851086, 3926.2147570486018, 3928.8428462861452, 3939.719591132893, 5630.352509461382, 5634.225219055984, 5666.178404131378, 5668.659880407189, 5675.4608312210685, 4009.7594144351433, 4029.959700403017, 4042.818073186655, 4054.8986275342763, 4059.512858456945, 3978.8209530571194, 4052.959470405317, 4069.8575549855614, 4090.9181816364103, 4106.917861642751, 4616.722996620214, 4631.305304204397, 4639.976800115978, 4652.116097941381, 4661.394018777605, 5465.754041068161, 5477.643953143033, 5508.421615730371, 5526.696031718214, 5552.750126244248, 1324.5761356366063, 1367.3436750359883, 1378.9586312410643, 1387.777955527131, 1396.748585254664, 929.7954450020984, 948.7817801905462, 958.9260028767825, 969.5733877094056, 975.9365641233297, 5230.163173892159, 5264.473552644705, 5266.183741520071, 5271.973640131775, 5276.577873770089, 5553.83369492403, 5561.4716601922755, 5576.609637325349, 5581.609287349927, 5585.245991791137, 5171.844844654666, 5178.766955487012, 5285.973570132125, 5335.493128152819, 5340.519353258225, 2633.789296856247, 2639.722829102955, 2654.522186006499, 2658.3752818087733, 2665.36031352474, 5041.546260836469, 5071.185492051873, 5087.2449005093185, 5102.744862756847, 5119.846404607868, 4827.95172048275, 5032.220005899091, 5049.873753156127, 5060.5698515625845, 5076.796928122908, 5003.924941125813, 5021.5229553192385, 5027.497250275016, 5041.798328066836, 5044.949550504448, 4879.0, 4896.706197628154, 4920.950790492049, 4956.603471722182, 4958.834673851714, 4669.836555720533, 4810.244260844836, 4822.7829747662145, 4856.805727770849, 4956.925646115239, 5029.270755740324, 5074.238864170404, 5098.821541246039, 5152.948470515247, 5155.742212889416, 3672.0, 3675.963240367562, 3676.4669122977552, 3691.427828686558, 3691.557013158438, 4648.9772250104925, 4971.701697898137, 4977.153883839684, 4978.352814134139, 5425.945740542544, 5318.7340632967425, 5496.835094947158, 5498.257735205696, 5499.130295699481, 5552.278793574005, 5479.232907393048, 5482.616216864782, 5508.614396992172, 5524.530414914777, 5538.889222215614, 5185.455527169744, 5336.252924590638, 5347.705876176692, 5448.520922979956, 5467.5625949923115, 5488.5334746545395, 5497.8075767347955, 5512.6968016759465, 5537.501624853782, 5547.694876781816, 5358.866028349166, 5401.217598192666, 5432.750467392443, 5449.618526703092, 5461.5357694596405], "value": 4064.3300178368904, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [738.3797610007592, 773.5242825662216, 788.2708494642458, 816.4488969945286, 830.4311546590586, 14785.186814725186, 16123.83876161238, 16156.676866462663, 16216.594585135377, 16234.350625974947, 15340.156291403968, 15620.921895390535, 15622.218889055559, 15628.21858907053, 15644.217789110557, 659.4394764450227, 782.3271986091956, 799.3365506629498, 800.2517646000979, 826.6775957376628, 809.4576633655436, 811.8457493076326, 817.9222973817477, 818.9631466584018, 819.315871247509, 843.5318398288947, 852.0, 854.7563944275882, 854.8931383577053, 855.1662129423793, 676.9018492318611, 820.0733171516149, 844.5988155626089, 844.7001314533344, 851.1488511488511, 626.3923993726079, 626.5332327416058, 627.1314229791726, 627.5387590121258, 627.8587317853492, 14386.712265754732, 14514.056586321854, 14538.345774440175, 14556.199409032499, 14580.416783328654, 13658.385372658255, 13855.0, 14164.787528187086, 14409.639759006004, 14593.78109328361, 12515.624531264077, 12877.806832897513, 12943.741125177443, 12947.158434701714, 13476.797848032189, 4450.688451808374, 4485.0, 4496.145732310851, 4569.748663823489, 4606.378138951266, 83276.58361708213, 86823.13176868214, 86841.0, 86856.6971495428, 87347.12652873453, 11780.880816322435, 11795.705107372385, 11818.40907954616, 12010.219335743148, 12024.098192635587, 22881.313560593208, 22926.885365573064, 22943.0, 22962.19632312861, 23220.65169022466, 8209.507429554245, 8299.128591497927, 8300.08699043117, 8399.37004724648, 8540.103289154673, 3936.4488971544006, 4083.999420142084, 4110.547839737626, 4361.520232774392, 4482.5069242383315, 3626.9818650906577, 3763.5295588051495, 3766.8116594170183, 3767.7362584618813, 3769.133099387156, 594.4560726934806, 603.5015037743744, 606.4632799972056, 610.2311088029027, 611.703323887914, 573.1402895656515, 587.5740088435936, 592.7865968251426, 637.719403462475, 648.6367634124905, 8542.18849209324, 8867.73396798097, 9016.909830901739, 9101.135392137736, 9255.305852061123, 568.528121659022, 586.3286536915208, 612.6140531465237, 640.9583377080475, 688.8906485073989, 4192.979035104866, 4371.147626212858, 4386.0, 4441.800118994653, 4450.443694538183, 121599.39200303942, 128025.0, 129598.35200823935, 129750.0, 130146.0, 100213.4967975481, 109895.0, 111090.44454777674, 113367.43316283365, 115888.0, 89209.55395223112, 89407.0, 90823.0, 91473.54263228641, 91849.54075229581, 8271.710490132817, 8358.791030224293, 8538.573071346284, 8539.487630742175, 8759.868601970848, 54455.45544544662, 55789.0, 56310.7184464075, 57040.71479642575, 58263.70868145632, 75171.24828751643, 75483.62258188674, 80594.59702701449, 83688.58155709182, 86310.56844715988, 13423.0, 13565.321733913068, 13709.794353084912, 14050.718985620435, 14174.716505669623, 14865.810735141378, 14885.776713349092, 14963.401463941756, 15202.543923682308, 15340.30968606393, 13078.476860925457, 13294.534691285759, 13491.392887319898, 13691.383887724876, 13692.0, 13844.673866690244, 13918.09532380392, 14066.78899816524, 14636.41454341857, 15077.095374277578, 12964.0, 13039.282839443542, 13664.795028074786, 13770.65573360674, 13884.236366999912, 10830.945845270724, 11128.1653875958, 11154.553817847196, 11301.830472542753, 11616.593419230287, 11597.420128993685, 12058.276503409823, 12191.573294934635, 12253.75492490163, 12411.255324680547], "value": 7645.493181416723, "unit": "score"}], "name": "dromaeo_css", "value": 7161.984228245388, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 111.0, 111.0, 111.0, 113.0, 111.0, 111.0, 111.0, 112.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 117.0, 118.0, 177.0, 122.0, 119.0, 141.0, 117.0, 173.0, 117.0], "value": 134.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 160.0, 161.0, 160.0, 160.0, 161.0, 160.0, 160.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 111.0, 74.0, 75.0, 83.0, 75.0, 103.0, 75.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 113.0, 84.0, 84.0, 85.0, 128.0, 83.0, 83.0, 130.0], "value": 95.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 50.0, 50.0, 49.0, 51.0, 50.0, 49.0, 49.0, 50.0], "value": 49.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 62.0, 62.0, 62.0, 62.0, 61.0, 61.0, 61.0, 61.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 75.0, 76.0, 75.0, 78.0, 75.0, 75.0, 85.0], "value": 76.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 123.0, 122.0, 149.0, 140.0, 121.0, 135.0, 121.0, 162.0, 121.0], "value": 132.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 160.0, 159.0, 156.0, 155.0, 156.0, 158.0, 155.0, 156.0, 159.0], "value": 156.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 63.0, 63.0, 67.0, 63.0, 62.0, 62.0, 63.0, 62.0], "value": 63.4, "unit": "score"}], "name": "kraken", "value": 1481.2000000000003, "alertThreshold": 2.0}]} 06:18:33 INFO - Return code: 0 06:18:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:18:34 INFO - # TBPL SUCCESS # 06:18:34 INFO - Running post-action listener: _resource_record_post_action 06:18:34 INFO - [mozharness: 2016-08-04 13:18:34.055939Z] Finished run-tests step (success) 06:18:34 INFO - Running post-run listener: _resource_record_post_run 06:18:34 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 553177088; Read time: 16; Write time: 1587536 06:18:34 INFO - TinderboxPrint: CPU usage
13.1% 06:18:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 06:18:34 INFO - TinderboxPrint: I/O write bytes / time
553,177,088 / 1,587,536 06:18:34 INFO - TinderboxPrint: CPU idle
8,284.4 (86.9%) 06:18:34 INFO - TinderboxPrint: CPU user
1,194.3 (12.5%) 06:18:34 INFO - TinderboxPrint: Swap in / out
0 / 0 06:18:34 INFO - install - Wall time: 17s; CPU: 20.0%; Read bytes: 0; Write bytes: 260509696; Read time: 0; Write time: 1141208 06:18:34 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 292098048; Read time: 0; Write time: 446284 06:18:34 INFO - Running post-run listener: _upload_blobber_files 06:18:34 INFO - Blob upload gear active. 06:18:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:18:34 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 06:18:34 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'] 06:18:34 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 06:18:35 INFO - (blobuploader) - INFO - Open directory for files ... 06:18:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:18:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:18:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:39 INFO - (blobuploader) - INFO - Done attempting. 06:18:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:18:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:18:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:40 INFO - (blobuploader) - INFO - Done attempting. 06:18:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:18:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:18:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:40 INFO - (blobuploader) - INFO - Done attempting. 06:18:40 INFO - (blobuploader) - INFO - Iteration through files over. 06:18:40 INFO - Return code: 0 06:18:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:18:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:18:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce40a6a6f918d371ba4612ec2f83ec7c19bb0671066a50e820356e66dda7238cbcb997da775847b33041f07aa596589758d95f672d81e34b691812734e33ce86", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/29ac64300f2cff6e9120482f781641c046e4240373bc989841d8ec22b51fb03c291c723a6e7c5003c03a49462d48a254b8f35a430b853a3b1cd88c5958f6feb8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1af8f9d0ea6686032dc7afec9f2dc03c69d150ae5ece204584059f333d0c1ec330d6387035777d15936dd793f530a94f31bd1084821dacaceb02ab7136dcc234"} 06:18:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:18:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:18:40 INFO - Contents: 06:18:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce40a6a6f918d371ba4612ec2f83ec7c19bb0671066a50e820356e66dda7238cbcb997da775847b33041f07aa596589758d95f672d81e34b691812734e33ce86", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/29ac64300f2cff6e9120482f781641c046e4240373bc989841d8ec22b51fb03c291c723a6e7c5003c03a49462d48a254b8f35a430b853a3b1cd88c5958f6feb8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1af8f9d0ea6686032dc7afec9f2dc03c69d150ae5ece204584059f333d0c1ec330d6387035777d15936dd793f530a94f31bd1084821dacaceb02ab7136dcc234"} 06:18:40 INFO - Running post-run listener: copy_logs_to_upload_dir 06:18:40 INFO - Copying logs to upload dir... 06:18:40 INFO - mkdir: /builds/slave/test/build/upload/logs 06:18:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.737749 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-04 06:18:40.175998) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 06:18:40.179885) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1470313013.938769-1767820074 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/ce40a6a6f918d371ba4612ec2f83ec7c19bb0671066a50e820356e66dda7238cbcb997da775847b33041f07aa596589758d95f672d81e34b691812734e33ce86", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/29ac64300f2cff6e9120482f781641c046e4240373bc989841d8ec22b51fb03c291c723a6e7c5003c03a49462d48a254b8f35a430b853a3b1cd88c5958f6feb8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1af8f9d0ea6686032dc7afec9f2dc03c69d150ae5ece204584059f333d0c1ec330d6387035777d15936dd793f530a94f31bd1084821dacaceb02ab7136dcc234"} build_url:https://queue.taskcluster.net/v1/task/YDPqjYXNR1awAtZJ_GvmCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011186 build_url: 'https://queue.taskcluster.net/v1/task/YDPqjYXNR1awAtZJ_GvmCQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce40a6a6f918d371ba4612ec2f83ec7c19bb0671066a50e820356e66dda7238cbcb997da775847b33041f07aa596589758d95f672d81e34b691812734e33ce86", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/29ac64300f2cff6e9120482f781641c046e4240373bc989841d8ec22b51fb03c291c723a6e7c5003c03a49462d48a254b8f35a430b853a3b1cd88c5958f6feb8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1af8f9d0ea6686032dc7afec9f2dc03c69d150ae5ece204584059f333d0c1ec330d6387035777d15936dd793f530a94f31bd1084821dacaceb02ab7136dcc234"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 06:18:40.207993) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 06:18:40.208550) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1470313013.938769-1767820074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004467 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 06:18:40.291043) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 06:18:40.291402) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 06:18:40.291685) ========= ========= Total master_lag: 0.19 =========