builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-014 starttime: 1469441097.62 results: success (0) buildid: 20160725015026 builduid: c11cf115701e465f95d303f679a69972 revision: cde1abb38839b442944b5fb0f07b5543defb078b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 03:04:57.620165) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 03:04:57.620661) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 03:04:57.620971) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 03:04:57.645898) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 03:04:57.646180) ========= 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=31acecf42b6a79ec49471d4a000001bb-1469440043.521273-711304373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-25 03:04:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-07-25 03:04:58 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.212255 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 03:04:57.876853) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 03:04:57.877214) ========= 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=31acecf42b6a79ec49471d4a000001bb-1469440043.521273-711304373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015881 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 03:04:57.928892) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 03:04:57.929293) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev cde1abb38839b442944b5fb0f07b5543defb078b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev cde1abb38839b442944b5fb0f07b5543defb078b --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=31acecf42b6a79ec49471d4a000001bb-1469440043.521273-711304373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-25 03:04:58,228 truncating revision to first 12 chars 2016-07-25 03:04:58,228 Setting DEBUG logging. 2016-07-25 03:04:58,228 attempt 1/10 2016-07-25 03:04:58,228 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/cde1abb38839?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-25 03:04:58,768 unpacking tar archive at: autoland-cde1abb38839/testing/mozharness/ program finished with exit code 0 elapsedTime=0.874674 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 03:04:58.822324) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 03:04:58.823047) ========= script_repo_revision: cde1abb38839b442944b5fb0f07b5543defb078b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 03:04:58.823643) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 03:04:58.823951) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 03:04:58.835484) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-07-25 03:04:58.836031) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1469440043.521273-711304373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:04:59 INFO - MultiFileLogger online at 20160725 03:04:59 in /builds/slave/test 03:04:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 03:04:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:04:59 INFO - {'append_to_log': False, 03:04:59 INFO - 'base_work_dir': '/builds/slave/test', 03:04:59 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 03:04:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:04:59 INFO - 'branch': 'Autoland-Non-PGO', 03:04:59 INFO - 'buildbot_json_path': 'buildprops.json', 03:04:59 INFO - 'config_files': ('talos/linux_config.py',), 03:04:59 INFO - 'default_actions': ('clobber', 03:04:59 INFO - 'read-buildbot-config', 03:04:59 INFO - 'download-and-extract', 03:04:59 INFO - 'populate-webroot', 03:04:59 INFO - 'create-virtualenv', 03:04:59 INFO - 'install', 03:04:59 INFO - 'run-tests'), 03:04:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:04:59 INFO - 'download_minidump_stackwalk': True, 03:04:59 INFO - 'download_symbols': 'ondemand', 03:04:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:04:59 INFO - 'tooltool.py': '/tools/tooltool.py', 03:04:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:04:59 INFO - '/tools/misc-python/virtualenv.py')}, 03:04:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:04:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:04:59 INFO - 'installer_path': 'installer.exe', 03:04:59 INFO - 'log_level': 'info', 03:04:59 INFO - 'log_name': 'talos', 03:04:59 INFO - 'log_to_console': True, 03:04:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:04:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:04:59 INFO - 'opt_config_files': (), 03:04:59 INFO - 'pip_index': False, 03:04:59 INFO - 'sps_profile': False, 03:04:59 INFO - 'sps_profile_interval': 0, 03:04:59 INFO - 'suite': 'dromaeojs', 03:04:59 INFO - 'system_bits': '32', 03:04:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:04:59 INFO - 'title': 'talos-linux64-ix-014', 03:04:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:04:59 INFO - 'use_talos_json': True, 03:04:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:04:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:04:59 INFO - 'work_dir': 'build'} 03:04:59 INFO - [mozharness: 2016-07-25 10:04:59.226622Z] Running clobber step. 03:04:59 INFO - Running pre-action listener: _resource_record_pre_action 03:04:59 INFO - Running main action method: clobber 03:04:59 INFO - rmtree: /builds/slave/test/build 03:04:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:04:59 INFO - Running post-action listener: _resource_record_post_action 03:04:59 INFO - [mozharness: 2016-07-25 10:04:59.696567Z] Finished clobber step (success) 03:04:59 INFO - [mozharness: 2016-07-25 10:04:59.696670Z] Running read-buildbot-config step. 03:04:59 INFO - Running pre-action listener: _resource_record_pre_action 03:04:59 INFO - Running main action method: read_buildbot_config 03:04:59 INFO - Using buildbot properties: 03:04:59 INFO - { 03:04:59 INFO - "project": "", 03:04:59 INFO - "product": "firefox", 03:04:59 INFO - "script_repo_revision": "production", 03:04:59 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 03:04:59 INFO - "repository": "", 03:04:59 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 03:04:59 INFO - "buildid": "20160725015026", 03:04:59 INFO - "pgo_build": "False", 03:04:59 INFO - "basedir": "/builds/slave/test", 03:04:59 INFO - "buildnumber": 96, 03:04:59 INFO - "slavename": "talos-linux64-ix-014", 03:04:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:04:59 INFO - "platform": "ubuntu64_hw", 03:04:59 INFO - "scheduler": "tests-autoland-linux64-talos", 03:04:59 INFO - "branch": "autoland", 03:04:59 INFO - "repo_path": "integration/autoland", 03:04:59 INFO - "revision": "cde1abb38839b442944b5fb0f07b5543defb078b", 03:04:59 INFO - "stage_platform": "linux64", 03:04:59 INFO - "builduid": "c11cf115701e465f95d303f679a69972", 03:04:59 INFO - "slavebuilddir": "test" 03:04:59 INFO - } 03:04:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/Mh7OTCL7Qvmi2Otybg3DXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 03:04:59 INFO - Running post-action listener: _resource_record_post_action 03:04:59 INFO - [mozharness: 2016-07-25 10:04:59.699107Z] Finished read-buildbot-config step (success) 03:04:59 INFO - [mozharness: 2016-07-25 10:04:59.699196Z] Running download-and-extract step. 03:04:59 INFO - Running pre-action listener: _resource_record_pre_action 03:04:59 INFO - Running main action method: download_and_extract 03:04:59 INFO - mkdir: /builds/slave/test/build/tests 03:04:59 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')]} 03:04:59 INFO - https://queue.taskcluster.net/v1/task/Mh7OTCL7Qvmi2Otybg3DXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:04:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mh7OTCL7Qvmi2Otybg3DXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:04:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mh7OTCL7Qvmi2Otybg3DXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:04:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mh7OTCL7Qvmi2Otybg3DXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:04:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mh7OTCL7Qvmi2Otybg3DXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:05:01 INFO - Downloaded 1361 bytes. 03:05:01 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:05:01 INFO - Using the following test package requirements: 03:05:01 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:05:01 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:05:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:05:01 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:05:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:05:01 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:05:01 INFO - u'jsshell-linux-x86_64.zip'], 03:05:01 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:05:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:05:01 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:05:01 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:05:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:05:01 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:05:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:05:01 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:05:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:05:01 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:05:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:05:01 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:05:01 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')]} 03:05:01 INFO - https://queue.taskcluster.net/v1/task/Mh7OTCL7Qvmi2Otybg3DXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:05:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mh7OTCL7Qvmi2Otybg3DXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:05:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mh7OTCL7Qvmi2Otybg3DXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:05:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mh7OTCL7Qvmi2Otybg3DXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:05:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mh7OTCL7Qvmi2Otybg3DXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:05:03 INFO - Downloaded 22737746 bytes. 03:05:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:05:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:05:05 INFO - Return code: 0 03:05:05 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:05:05 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')]} 03:05:05 INFO - https://queue.taskcluster.net/v1/task/Mh7OTCL7Qvmi2Otybg3DXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:05:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mh7OTCL7Qvmi2Otybg3DXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:05:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mh7OTCL7Qvmi2Otybg3DXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:05:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mh7OTCL7Qvmi2Otybg3DXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:05:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mh7OTCL7Qvmi2Otybg3DXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:05:06 INFO - Downloaded 22737746 bytes. 03:05:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:05:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:05:07 INFO - Return code: 0 03:05: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')]} 03:05:07 INFO - https://queue.taskcluster.net/v1/task/Mh7OTCL7Qvmi2Otybg3DXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:05:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mh7OTCL7Qvmi2Otybg3DXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:05:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mh7OTCL7Qvmi2Otybg3DXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:05:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mh7OTCL7Qvmi2Otybg3DXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:05:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mh7OTCL7Qvmi2Otybg3DXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:05:08 INFO - Downloaded 14403248 bytes. 03:05:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:05:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:05:09 INFO - Return code: 0 03:05:09 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')]} 03:05:09 INFO - https://queue.taskcluster.net/v1/task/Mh7OTCL7Qvmi2Otybg3DXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:05:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mh7OTCL7Qvmi2Otybg3DXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:05:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mh7OTCL7Qvmi2Otybg3DXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:05:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mh7OTCL7Qvmi2Otybg3DXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:05:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mh7OTCL7Qvmi2Otybg3DXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:05:12 INFO - Downloaded 57161517 bytes. 03:05:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Mh7OTCL7Qvmi2Otybg3DXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:05:12 INFO - mkdir: /builds/slave/test/properties 03:05:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:05:12 INFO - Writing to file /builds/slave/test/properties/build_url 03:05:12 INFO - Contents: 03:05:12 INFO - build_url:https://queue.taskcluster.net/v1/task/Mh7OTCL7Qvmi2Otybg3DXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:05:13 INFO - Running post-action listener: _resource_record_post_action 03:05:13 INFO - Running post-action listener: set_extra_try_arguments 03:05:13 INFO - [mozharness: 2016-07-25 10:05:13.299903Z] Finished download-and-extract step (success) 03:05:13 INFO - [mozharness: 2016-07-25 10:05:13.300138Z] Running populate-webroot step. 03:05:13 INFO - Running pre-action listener: _resource_record_pre_action 03:05:13 INFO - Running main action method: populate_webroot 03:05:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:05:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:05:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:05:13 INFO - '--tppagecycles', 03:05:13 INFO - '7'], 03:05:13 INFO - 'tests': ['tsvgm']}}, 03:05:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:05:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:05:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:05:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:05:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:05:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:05:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:05:13 INFO - 'talos_options': ['--disable-e10s'], 03:05:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:05:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:05:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:05:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:05:13 INFO - 'talos_options': ['--disable-e10s'], 03:05:13 INFO - 'tests': ['damp', 'tps']}, 03:05:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:05:13 INFO - 'tests': ['damp', 'tps']}, 03:05:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:05:13 INFO - 'tests': ['dromaeo_dom']}, 03:05:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:05:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:05:13 INFO - 'tests': ['basic_compositor_video']}, 03:05:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:05:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:05:13 INFO - 'tests': ['a11yr', 03:05:13 INFO - 'ts_paint', 03:05:13 INFO - 'tpaint', 03:05:13 INFO - 'sessionrestore', 03:05:13 INFO - 'sessionrestore_no_auto_restore', 03:05:13 INFO - 'tabpaint']}, 03:05:13 INFO - 'other-e10s': {'tests': ['a11yr', 03:05:13 INFO - 'ts_paint', 03:05:13 INFO - 'tpaint', 03:05:13 INFO - 'sessionrestore', 03:05:13 INFO - 'sessionrestore_no_auto_restore', 03:05:13 INFO - 'tabpaint']}, 03:05:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:05:13 INFO - 'ts_paint', 03:05:13 INFO - 'tpaint', 03:05:13 INFO - 'sessionrestore', 03:05:13 INFO - 'sessionrestore_no_auto_restore', 03:05:13 INFO - 'tabpaint']}, 03:05:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:05:13 INFO - 'ts_paint', 03:05:13 INFO - 'tpaint', 03:05:13 INFO - 'sessionrestore', 03:05:13 INFO - 'sessionrestore_no_auto_restore', 03:05:13 INFO - 'tabpaint']}, 03:05:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:05:13 INFO - 'tests': ['a11yr', 03:05:13 INFO - 'ts_paint', 03:05:13 INFO - 'tpaint', 03:05:13 INFO - 'sessionrestore', 03:05:13 INFO - 'sessionrestore_no_auto_restore', 03:05:13 INFO - 'tabpaint']}, 03:05:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:05:13 INFO - 'tests': ['a11yr', 03:05:13 INFO - 'ts_paint', 03:05:13 INFO - 'tpaint', 03:05:13 INFO - 'sessionrestore', 03:05:13 INFO - 'sessionrestore_no_auto_restore', 03:05:13 INFO - 'tabpaint']}, 03:05:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:05:13 INFO - 'tests': ['tsvgx', 03:05:13 INFO - 'tsvgr_opacity', 03:05:13 INFO - 'tart', 03:05:13 INFO - 'tscrollx', 03:05:13 INFO - 'cart']}, 03:05:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:05:13 INFO - 'tsvgr_opacity', 03:05:13 INFO - 'tart', 03:05:13 INFO - 'tscrollx', 03:05:13 INFO - 'cart']}, 03:05:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:05:13 INFO - 'talos_options': ['--disable-e10s'], 03:05:13 INFO - 'tests': ['tp5o']}, 03:05:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:05:13 INFO - 'tests': ['tp5o']}, 03:05:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:05:13 INFO - 'talos_options': ['--disable-e10s', 03:05:13 INFO - '--xperf_path', 03:05:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:05:13 INFO - 'tests': ['tp5n']}, 03:05:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:05:13 INFO - 'talos_options': ['--xperf_path', 03:05:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:05:13 INFO - 'tests': ['tp5n']}}, 03:05:13 INFO - 'talos.zip': {'path': '', 03:05:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:05:13 INFO - Running post-action listener: _resource_record_post_action 03:05:13 INFO - [mozharness: 2016-07-25 10:05:13.322291Z] Finished populate-webroot step (success) 03:05:13 INFO - [mozharness: 2016-07-25 10:05:13.322380Z] Running create-virtualenv step. 03:05:13 INFO - Running pre-action listener: _resource_record_pre_action 03:05:13 INFO - Running main action method: create_virtualenv 03:05:13 INFO - Creating virtualenv /builds/slave/test/build/venv 03:05:13 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:05:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:05:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:05:13 INFO - Using real prefix '/usr' 03:05:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:05:13 INFO - Installing distribute.............................................................................................................................................................................................done. 03:05:15 INFO - Installing pip.................done. 03:05:15 INFO - Return code: 0 03:05:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:05: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')]} 03:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05: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')]} 03:05:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:15 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 0x2068030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2329180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23273b0>, '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 0x23282b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2328740>, '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': '31acecf42b6a79ec49471d4a000001bb-1469440043.521273-711304373', '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 03:05:15 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 03:05:15 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 03:05:15 INFO - Using env: {'DISPLAY': ':0', 03:05:15 INFO - 'HOME': '/home/cltbld', 03:05:15 INFO - 'LANG': 'en_US.UTF-8', 03:05:15 INFO - 'LANGUAGE': 'en_US:en', 03:05:15 INFO - 'LOGNAME': 'cltbld', 03:05:15 INFO - 'MAIL': '/var/mail/cltbld', 03:05:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:15 INFO - 'MOZ_NO_REMOTE': '1', 03:05:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:15 INFO - 'NO_EM_RESTART': '1', 03:05:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:15 INFO - 'PWD': '/builds/slave/test', 03:05:15 INFO - 'SHELL': '/bin/bash', 03:05:15 INFO - 'SHLVL': '1', 03:05:15 INFO - 'TERM': 'linux', 03:05:15 INFO - 'TMOUT': '86400', 03:05:15 INFO - 'USER': 'cltbld', 03:05:15 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469440043.521273-711304373', 03:05:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:15 INFO - '_': '/tools/buildbot/bin/python'} 03:05:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:05:16 INFO - Cleaning up... 03:05:16 INFO - Return code: 0 03:05:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:05:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:05:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:05:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2068030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2329180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23273b0>, '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 0x23282b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2328740>, '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': '31acecf42b6a79ec49471d4a000001bb-1469440043.521273-711304373', '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 03:05:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:05:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:05:16 INFO - Using env: {'DISPLAY': ':0', 03:05:16 INFO - 'HOME': '/home/cltbld', 03:05:16 INFO - 'LANG': 'en_US.UTF-8', 03:05:16 INFO - 'LANGUAGE': 'en_US:en', 03:05:16 INFO - 'LOGNAME': 'cltbld', 03:05:16 INFO - 'MAIL': '/var/mail/cltbld', 03:05:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:16 INFO - 'MOZ_NO_REMOTE': '1', 03:05:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:16 INFO - 'NO_EM_RESTART': '1', 03:05:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:16 INFO - 'PWD': '/builds/slave/test', 03:05:16 INFO - 'SHELL': '/bin/bash', 03:05:16 INFO - 'SHLVL': '1', 03:05:16 INFO - 'TERM': 'linux', 03:05:16 INFO - 'TMOUT': '86400', 03:05:16 INFO - 'USER': 'cltbld', 03:05:16 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469440043.521273-711304373', 03:05:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:16 INFO - '_': '/tools/buildbot/bin/python'} 03:05:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:16 INFO - Downloading/unpacking psutil>=3.1.1 03:05:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:05:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:05:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:05:18 INFO - Installing collected packages: psutil 03:05:18 INFO - Running setup.py install for psutil 03:05:18 INFO - building 'psutil._psutil_linux' extension 03:05:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:05:18 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 03:05:18 INFO - building 'psutil._psutil_posix' extension 03:05:18 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 03:05:18 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 03:05:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:05:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:05:18 INFO - Successfully installed psutil 03:05:18 INFO - Cleaning up... 03:05:18 INFO - Return code: 0 03:05:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:05:18 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')]} 03:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:18 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')]} 03:05:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:18 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 0x2068030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2329180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23273b0>, '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 0x23282b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2328740>, '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': '31acecf42b6a79ec49471d4a000001bb-1469440043.521273-711304373', '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 03:05:18 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 03:05:18 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 03:05:18 INFO - Using env: {'DISPLAY': ':0', 03:05:18 INFO - 'HOME': '/home/cltbld', 03:05:18 INFO - 'LANG': 'en_US.UTF-8', 03:05:18 INFO - 'LANGUAGE': 'en_US:en', 03:05:18 INFO - 'LOGNAME': 'cltbld', 03:05:18 INFO - 'MAIL': '/var/mail/cltbld', 03:05:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:18 INFO - 'MOZ_NO_REMOTE': '1', 03:05:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:18 INFO - 'NO_EM_RESTART': '1', 03:05:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:18 INFO - 'PWD': '/builds/slave/test', 03:05:18 INFO - 'SHELL': '/bin/bash', 03:05:18 INFO - 'SHLVL': '1', 03:05:18 INFO - 'TERM': 'linux', 03:05:18 INFO - 'TMOUT': '86400', 03:05:18 INFO - 'USER': 'cltbld', 03:05:18 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469440043.521273-711304373', 03:05:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:18 INFO - '_': '/tools/buildbot/bin/python'} 03:05:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:05:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:05:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:05:21 INFO - Installing collected packages: mozsystemmonitor 03:05:21 INFO - Running setup.py install for mozsystemmonitor 03:05:21 INFO - Successfully installed mozsystemmonitor 03:05:21 INFO - Cleaning up... 03:05:21 INFO - Return code: 0 03:05:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:05:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2068030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2329180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23273b0>, '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 0x23282b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2328740>, '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': '31acecf42b6a79ec49471d4a000001bb-1469440043.521273-711304373', '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 03:05:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:05:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:05:21 INFO - Using env: {'DISPLAY': ':0', 03:05:21 INFO - 'HOME': '/home/cltbld', 03:05:21 INFO - 'LANG': 'en_US.UTF-8', 03:05:21 INFO - 'LANGUAGE': 'en_US:en', 03:05:21 INFO - 'LOGNAME': 'cltbld', 03:05:21 INFO - 'MAIL': '/var/mail/cltbld', 03:05:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:21 INFO - 'MOZ_NO_REMOTE': '1', 03:05:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:21 INFO - 'NO_EM_RESTART': '1', 03:05:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:21 INFO - 'PWD': '/builds/slave/test', 03:05:21 INFO - 'SHELL': '/bin/bash', 03:05:21 INFO - 'SHLVL': '1', 03:05:21 INFO - 'TERM': 'linux', 03:05:21 INFO - 'TMOUT': '86400', 03:05:21 INFO - 'USER': 'cltbld', 03:05:21 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469440043.521273-711304373', 03:05:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:21 INFO - '_': '/tools/buildbot/bin/python'} 03:05:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:21 INFO - Downloading/unpacking jsonschema==2.5.1 03:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:05:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:05: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 03:05: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 03:05: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 03:05: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 03:05: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 03:05: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 03:05:23 INFO - Downloading functools32-3.2.3-2.tar.gz 03:05:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:05:23 INFO - warning: no files found matching '*.txt' 03:05:23 INFO - no previously-included directories found matching 'build' 03:05:23 INFO - no previously-included directories found matching 'dist' 03:05:23 INFO - no previously-included directories found matching '.git*' 03:05:23 INFO - Installing collected packages: jsonschema, functools32 03:05:23 INFO - Running setup.py install for functools32 03:05:23 INFO - warning: no files found matching '*.txt' 03:05:23 INFO - no previously-included directories found matching 'build' 03:05:23 INFO - no previously-included directories found matching 'dist' 03:05:23 INFO - no previously-included directories found matching '.git*' 03:05:23 INFO - Successfully installed jsonschema functools32 03:05:23 INFO - Cleaning up... 03:05:23 INFO - Return code: 0 03:05:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:05:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:05:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2068030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2329180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23273b0>, '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 0x23282b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2328740>, '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': '31acecf42b6a79ec49471d4a000001bb-1469440043.521273-711304373', '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 03:05:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:05:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:05:23 INFO - Using env: {'DISPLAY': ':0', 03:05:23 INFO - 'HOME': '/home/cltbld', 03:05:23 INFO - 'LANG': 'en_US.UTF-8', 03:05:23 INFO - 'LANGUAGE': 'en_US:en', 03:05:23 INFO - 'LOGNAME': 'cltbld', 03:05:23 INFO - 'MAIL': '/var/mail/cltbld', 03:05:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:23 INFO - 'MOZ_NO_REMOTE': '1', 03:05:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:23 INFO - 'NO_EM_RESTART': '1', 03:05:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:23 INFO - 'PWD': '/builds/slave/test', 03:05:23 INFO - 'SHELL': '/bin/bash', 03:05:23 INFO - 'SHLVL': '1', 03:05:23 INFO - 'TERM': 'linux', 03:05:23 INFO - 'TMOUT': '86400', 03:05:23 INFO - 'USER': 'cltbld', 03:05:23 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469440043.521273-711304373', 03:05:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:23 INFO - '_': '/tools/buildbot/bin/python'} 03:05:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:05:24 INFO - Cleaning up... 03:05:24 INFO - Return code: 0 03:05:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:05:24 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')]} 03:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:24 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')]} 03:05:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:24 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 0x2068030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2329180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23273b0>, '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 0x23282b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2328740>, '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': '31acecf42b6a79ec49471d4a000001bb-1469440043.521273-711304373', '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 03:05:24 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 03:05:24 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 03:05:24 INFO - Using env: {'DISPLAY': ':0', 03:05:24 INFO - 'HOME': '/home/cltbld', 03:05:24 INFO - 'LANG': 'en_US.UTF-8', 03:05:24 INFO - 'LANGUAGE': 'en_US:en', 03:05:24 INFO - 'LOGNAME': 'cltbld', 03:05:24 INFO - 'MAIL': '/var/mail/cltbld', 03:05:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:24 INFO - 'MOZ_NO_REMOTE': '1', 03:05:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:24 INFO - 'NO_EM_RESTART': '1', 03:05:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:24 INFO - 'PWD': '/builds/slave/test', 03:05:24 INFO - 'SHELL': '/bin/bash', 03:05:24 INFO - 'SHLVL': '1', 03:05:24 INFO - 'TERM': 'linux', 03:05:24 INFO - 'TMOUT': '86400', 03:05:24 INFO - 'USER': 'cltbld', 03:05:24 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469440043.521273-711304373', 03:05:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:24 INFO - '_': '/tools/buildbot/bin/python'} 03:05:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:24 INFO - Downloading/unpacking blobuploader==1.2.4 03:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:26 INFO - Downloading blobuploader-1.2.4.tar.gz 03:05:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:05:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:05:26 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 03:05:26 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 03:05:26 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 03:05:26 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 03:05:26 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 03:05:26 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 03:05:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:05:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:05:26 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 03:05:26 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 03:05:26 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 03:05:26 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 03:05:26 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 03:05:26 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 03:05:27 INFO - Downloading docopt-0.6.1.tar.gz 03:05:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:05:27 INFO - Installing collected packages: blobuploader, requests, docopt 03:05:27 INFO - Running setup.py install for blobuploader 03:05:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:05:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:05:27 INFO - Running setup.py install for requests 03:05:27 INFO - Running setup.py install for docopt 03:05:27 INFO - Successfully installed blobuploader requests docopt 03:05:27 INFO - Cleaning up... 03:05:27 INFO - Return code: 0 03:05:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:05: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')]} 03:05:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05: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')]} 03:05:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:27 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 0x2068030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2329180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23273b0>, '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 0x23282b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2328740>, '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': '31acecf42b6a79ec49471d4a000001bb-1469440043.521273-711304373', '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 03:05:27 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 03:05:27 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 03:05:27 INFO - Using env: {'DISPLAY': ':0', 03:05:27 INFO - 'HOME': '/home/cltbld', 03:05:27 INFO - 'LANG': 'en_US.UTF-8', 03:05:27 INFO - 'LANGUAGE': 'en_US:en', 03:05:27 INFO - 'LOGNAME': 'cltbld', 03:05:27 INFO - 'MAIL': '/var/mail/cltbld', 03:05:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:27 INFO - 'MOZ_NO_REMOTE': '1', 03:05:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:27 INFO - 'NO_EM_RESTART': '1', 03:05:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:27 INFO - 'PWD': '/builds/slave/test', 03:05:27 INFO - 'SHELL': '/bin/bash', 03:05:27 INFO - 'SHLVL': '1', 03:05:27 INFO - 'TERM': 'linux', 03:05:27 INFO - 'TMOUT': '86400', 03:05:27 INFO - 'USER': 'cltbld', 03:05:27 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469440043.521273-711304373', 03:05:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:27 INFO - '_': '/tools/buildbot/bin/python'} 03:05:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:05:27 INFO - Running setup.py (path:/tmp/pip-DYWwQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:05:28 INFO - Running setup.py (path:/tmp/pip-shpJUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:05:28 INFO - Running setup.py (path:/tmp/pip-BTPVlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:05:28 INFO - Running setup.py (path:/tmp/pip-85tJHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:05:28 INFO - Running setup.py (path:/tmp/pip-xekx8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:05:28 INFO - Running setup.py (path:/tmp/pip-RaZIGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:05:28 INFO - Running setup.py (path:/tmp/pip-fzO5s2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:05:28 INFO - Running setup.py (path:/tmp/pip-abSwsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:05:28 INFO - Running setup.py (path:/tmp/pip-rU11ym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:05:28 INFO - Running setup.py (path:/tmp/pip-lU4DCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:05:28 INFO - Running setup.py (path:/tmp/pip-b1c6hU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:05:28 INFO - Running setup.py (path:/tmp/pip-x4KJrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:05:28 INFO - Running setup.py (path:/tmp/pip-n6RdCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:05:28 INFO - Running setup.py (path:/tmp/pip-75QhvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:05:28 INFO - Running setup.py (path:/tmp/pip-IXccmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:05:29 INFO - Running setup.py (path:/tmp/pip-3Nvmuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:05:29 INFO - Running setup.py (path:/tmp/pip-MuD_w7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:05:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:05:29 INFO - Running setup.py install for manifestparser 03:05:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:05:29 INFO - Running setup.py install for mozcrash 03:05:29 INFO - Running setup.py install for mozdebug 03:05:29 INFO - Running setup.py install for mozdevice 03:05:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:05:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:05:29 INFO - Running setup.py install for mozfile 03:05:29 INFO - Running setup.py install for mozhttpd 03:05:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:05:29 INFO - Running setup.py install for mozinfo 03:05:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:05:29 INFO - Running setup.py install for mozInstall 03:05:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:05:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:05:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:05:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:05:30 INFO - Running setup.py install for mozleak 03:05:30 INFO - Running setup.py install for mozlog 03:05:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:05:30 INFO - Running setup.py install for moznetwork 03:05:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:05:30 INFO - Running setup.py install for mozprocess 03:05:30 INFO - Running setup.py install for mozprofile 03:05:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:05:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:05:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:05:30 INFO - Running setup.py install for mozrunner 03:05:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:05:30 INFO - Running setup.py install for mozscreenshot 03:05:30 INFO - Running setup.py install for moztest 03:05:30 INFO - Running setup.py install for mozversion 03:05:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:05:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:05:31 INFO - Cleaning up... 03:05:31 INFO - Return code: 0 03:05:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:05: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')]} 03:05:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05: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')]} 03:05:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:31 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 0x2068030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2329180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23273b0>, '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 0x23282b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2328740>, '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': '31acecf42b6a79ec49471d4a000001bb-1469440043.521273-711304373', '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 03:05:31 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 03:05:31 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 03:05:31 INFO - Using env: {'DISPLAY': ':0', 03:05:31 INFO - 'HOME': '/home/cltbld', 03:05:31 INFO - 'LANG': 'en_US.UTF-8', 03:05:31 INFO - 'LANGUAGE': 'en_US:en', 03:05:31 INFO - 'LOGNAME': 'cltbld', 03:05:31 INFO - 'MAIL': '/var/mail/cltbld', 03:05:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:31 INFO - 'MOZ_NO_REMOTE': '1', 03:05:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:31 INFO - 'NO_EM_RESTART': '1', 03:05:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:31 INFO - 'PWD': '/builds/slave/test', 03:05:31 INFO - 'SHELL': '/bin/bash', 03:05:31 INFO - 'SHLVL': '1', 03:05:31 INFO - 'TERM': 'linux', 03:05:31 INFO - 'TMOUT': '86400', 03:05:31 INFO - 'USER': 'cltbld', 03:05:31 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469440043.521273-711304373', 03:05:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:31 INFO - '_': '/tools/buildbot/bin/python'} 03:05:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:05:31 INFO - Running setup.py (path:/tmp/pip-SNvZpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:05:31 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)) 03:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:05:31 INFO - Running setup.py (path:/tmp/pip-YpyeEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:05:31 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)) 03:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:05:31 INFO - Running setup.py (path:/tmp/pip-Kap9Vc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:05:31 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)) 03:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:05:31 INFO - Running setup.py (path:/tmp/pip-d2aMxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:05:31 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)) 03:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:05:31 INFO - Running setup.py (path:/tmp/pip-hfmTEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:05:31 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)) 03:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:05:31 INFO - Running setup.py (path:/tmp/pip-VbupD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:05:31 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)) 03:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:05:31 INFO - Running setup.py (path:/tmp/pip-AoJdnc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:05:31 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)) 03:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:05:31 INFO - Running setup.py (path:/tmp/pip-3sGLMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:05:31 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)) 03:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:05:31 INFO - Running setup.py (path:/tmp/pip-4Jc2uD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:05:31 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)) 03:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:05:31 INFO - Running setup.py (path:/tmp/pip-cyXbfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:05:31 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)) 03:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:05:31 INFO - Running setup.py (path:/tmp/pip-UxJUxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:05:32 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)) 03:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:05:32 INFO - Running setup.py (path:/tmp/pip-TarQ3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:05:32 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)) 03:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:05:32 INFO - Running setup.py (path:/tmp/pip-j5LO5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:05:32 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)) 03:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:05:32 INFO - Running setup.py (path:/tmp/pip-Jm2BNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:05:32 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)) 03:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:05:32 INFO - Running setup.py (path:/tmp/pip-a26_fK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:05:32 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)) 03:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:05:32 INFO - Running setup.py (path:/tmp/pip-HUcY5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:05:32 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)) 03:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:05:32 INFO - Running setup.py (path:/tmp/pip-Rwt4je-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:05:32 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)) 03:05:32 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)) 03:05:32 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)) 03:05:32 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)) 03:05:32 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)) 03:05:32 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)) 03:05:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:05:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:34 INFO - Downloading blessings-1.6.tar.gz 03:05:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:05:34 INFO - Installing collected packages: blessings 03:05:34 INFO - Running setup.py install for blessings 03:05:34 INFO - Successfully installed blessings 03:05:34 INFO - Cleaning up... 03:05:34 INFO - Return code: 0 03:05:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:05:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:05:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:05:34 INFO - Reading from file tmpfile_stdout 03:05:34 INFO - Current package versions: 03:05:34 INFO - argparse == 1.2.1 03:05:34 INFO - blessings == 1.6 03:05:34 INFO - blobuploader == 1.2.4 03:05:34 INFO - docopt == 0.6.1 03:05:34 INFO - functools32 == 3.2.3-2 03:05:34 INFO - jsonschema == 2.5.1 03:05:34 INFO - manifestparser == 1.1 03:05:34 INFO - mozInstall == 1.12 03:05:34 INFO - mozcrash == 0.17 03:05:34 INFO - mozdebug == 0.1 03:05:34 INFO - mozdevice == 0.48 03:05:34 INFO - mozfile == 1.2 03:05:34 INFO - mozhttpd == 0.7 03:05:34 INFO - mozinfo == 0.9 03:05:34 INFO - mozleak == 0.1 03:05:34 INFO - mozlog == 3.3 03:05:34 INFO - moznetwork == 0.27 03:05:34 INFO - mozprocess == 0.23 03:05:34 INFO - mozprofile == 0.28 03:05:34 INFO - mozrunner == 6.12 03:05:34 INFO - mozscreenshot == 0.1 03:05:34 INFO - mozsystemmonitor == 0.3 03:05:34 INFO - moztest == 0.7 03:05:34 INFO - mozversion == 1.4 03:05:34 INFO - psutil == 3.1.1 03:05:34 INFO - requests == 1.2.3 03:05:34 INFO - wsgiref == 0.1.2 03:05:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:05: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')]} 03:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05: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')]} 03:05:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:34 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 0x2068030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2329180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23273b0>, '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 0x23282b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2328740>, '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': '31acecf42b6a79ec49471d4a000001bb-1469440043.521273-711304373', '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 03:05:34 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 03:05:34 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 03:05:34 INFO - Using env: {'DISPLAY': ':0', 03:05:34 INFO - 'HOME': '/home/cltbld', 03:05:34 INFO - 'LANG': 'en_US.UTF-8', 03:05:34 INFO - 'LANGUAGE': 'en_US:en', 03:05:34 INFO - 'LOGNAME': 'cltbld', 03:05:34 INFO - 'MAIL': '/var/mail/cltbld', 03:05:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:34 INFO - 'MOZ_NO_REMOTE': '1', 03:05:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:34 INFO - 'NO_EM_RESTART': '1', 03:05:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:34 INFO - 'PWD': '/builds/slave/test', 03:05:34 INFO - 'SHELL': '/bin/bash', 03:05:34 INFO - 'SHLVL': '1', 03:05:34 INFO - 'TERM': 'linux', 03:05:34 INFO - 'TMOUT': '86400', 03:05:34 INFO - 'USER': 'cltbld', 03:05:34 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469440043.521273-711304373', 03:05:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:34 INFO - '_': '/tools/buildbot/bin/python'} 03:05:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:35 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)) 03:05:35 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)) 03:05:35 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)) 03:05:35 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)) 03:05:35 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)) 03:05:35 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)) 03:05:35 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)) 03:05:35 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)) 03:05:35 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)) 03:05:35 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)) 03:05:35 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)) 03:05:35 INFO - Cleaning up... 03:05:35 INFO - Return code: 0 03:05:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:05:35 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')]} 03:05:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:35 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')]} 03:05:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:35 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 0x2068030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2329180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23273b0>, '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 0x23282b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2328740>, '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': '31acecf42b6a79ec49471d4a000001bb-1469440043.521273-711304373', '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 03:05:35 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 03:05:35 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 03:05:35 INFO - Using env: {'DISPLAY': ':0', 03:05:35 INFO - 'HOME': '/home/cltbld', 03:05:35 INFO - 'LANG': 'en_US.UTF-8', 03:05:35 INFO - 'LANGUAGE': 'en_US:en', 03:05:35 INFO - 'LOGNAME': 'cltbld', 03:05:35 INFO - 'MAIL': '/var/mail/cltbld', 03:05:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:35 INFO - 'MOZ_NO_REMOTE': '1', 03:05:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:35 INFO - 'NO_EM_RESTART': '1', 03:05:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:35 INFO - 'PWD': '/builds/slave/test', 03:05:35 INFO - 'SHELL': '/bin/bash', 03:05:35 INFO - 'SHLVL': '1', 03:05:35 INFO - 'TERM': 'linux', 03:05:35 INFO - 'TMOUT': '86400', 03:05:35 INFO - 'USER': 'cltbld', 03:05:35 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469440043.521273-711304373', 03:05:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:35 INFO - '_': '/tools/buildbot/bin/python'} 03:05:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:05:35 INFO - Cleaning up... 03:05:35 INFO - Return code: 0 03:05:35 INFO - Running post-action listener: _resource_record_post_action 03:05:35 INFO - Running post-action listener: _start_resource_monitoring 03:05:35 INFO - Starting resource monitoring. 03:05:35 INFO - [mozharness: 2016-07-25 10:05:35.350857Z] Finished create-virtualenv step (success) 03:05:35 INFO - [mozharness: 2016-07-25 10:05:35.351339Z] Running install step. 03:05:35 INFO - Running pre-action listener: _resource_record_pre_action 03:05:35 INFO - Running main action method: install 03:05:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:05:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:05:35 INFO - Reading from file tmpfile_stdout 03:05:35 INFO - Detecting whether we're running mozinstall >=1.0... 03:05:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:05:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:05:35 INFO - Reading from file tmpfile_stdout 03:05:35 INFO - Output received: 03:05:35 INFO - Usage: mozinstall [options] installer 03:05:35 INFO - Options: 03:05:35 INFO - -h, --help show this help message and exit 03:05:35 INFO - -d DEST, --destination=DEST 03:05:35 INFO - Directory to install application into. [default: 03:05:35 INFO - "/builds/slave/test"] 03:05:35 INFO - --app=APP Application being installed. [default: firefox] 03:05:35 INFO - mkdir: /builds/slave/test/build/application 03:05:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:05:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:05:52 INFO - Reading from file tmpfile_stdout 03:05:52 INFO - Output received: 03:05:52 INFO - /builds/slave/test/build/application/firefox/firefox 03:05:52 INFO - Running post-action listener: _resource_record_post_action 03:05:52 INFO - [mozharness: 2016-07-25 10:05:52.019376Z] Finished install step (success) 03:05:52 INFO - [mozharness: 2016-07-25 10:05:52.019649Z] Running run-tests step. 03:05:52 INFO - Running pre-action listener: _resource_record_pre_action 03:05:52 INFO - Running main action method: run_tests 03:05:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:05:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:05:52 INFO - Python 2.7.3 03:05:52 INFO - Return code: 0 03:05:52 INFO - grabbing minidump binary from tooltool 03:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:05:52 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 0x23273b0>, '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 0x23282b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2328740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:05:52 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 03:05:52 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 03:05:52 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 03:05:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:05:52 INFO - Return code: 0 03:05:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:05:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:05:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:05:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:05:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:05:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Mh7OTCL7Qvmi2Otybg3DXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 03:05:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Mh7OTCL7Qvmi2Otybg3DXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --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 03:05:52 INFO - Using env: {'DISPLAY': ':0', 03:05:52 INFO - 'HOME': '/home/cltbld', 03:05:52 INFO - 'LANG': 'en_US.UTF-8', 03:05:52 INFO - 'LANGUAGE': 'en_US:en', 03:05:52 INFO - 'LOGNAME': 'cltbld', 03:05:52 INFO - 'MAIL': '/var/mail/cltbld', 03:05:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:05:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:52 INFO - 'MOZ_NO_REMOTE': '1', 03:05:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:05:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:52 INFO - 'NO_EM_RESTART': '1', 03:05:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:52 INFO - 'PWD': '/builds/slave/test', 03:05:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:05:52 INFO - 'SHELL': '/bin/bash', 03:05:52 INFO - 'SHLVL': '1', 03:05:52 INFO - 'TERM': 'linux', 03:05:52 INFO - 'TMOUT': '86400', 03:05:52 INFO - 'USER': 'cltbld', 03:05:52 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469440043.521273-711304373', 03:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:52 INFO - '_': '/tools/buildbot/bin/python'} 03:05:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Mh7OTCL7Qvmi2Otybg3DXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 03:05:52 INFO - mozversion application_buildid: 20160725015026 03:05:52 INFO - mozversion application_changeset: cde1abb38839b442944b5fb0f07b5543defb078b 03:05:52 INFO - mozversion application_display_name: Nightly 03:05:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:05:52 INFO - mozversion application_name: Firefox 03:05:52 INFO - mozversion application_remotingname: firefox 03:05:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 03:05:52 INFO - mozversion application_vendor: Mozilla 03:05:52 INFO - mozversion application_version: 50.0a1 03:05:52 INFO - mozversion platform_buildid: 20160725015026 03:05:52 INFO - mozversion platform_changeset: cde1abb38839b442944b5fb0f07b5543defb078b 03:05:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 03:05:52 INFO - mozversion platform_version: 50.0a1 03:05:52 INFO - using testdate: 1469441152 03:05:52 INFO - actual date: 1469441152 03:05:52 INFO - starting webserver on 'localhost:38298' 03:05:52 INFO - SUITE-START | Running 2 tests 03:05:52 INFO - TEST-START | dromaeo_css 03:05:52 INFO - operating with platform_type : linux_ 03:05:52 INFO - Initialising browser for dromaeo_css test... 03:05:52 INFO - TEST-INFO | started process 26360 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPwRfJE/profile http://localhost:38298/getInfo.html) 03:05:55 INFO - PROCESS | 26360 | JavaScript error: , line 0: uncaught exception: undefined 03:05:56 INFO - PROCESS | 26360 | __metrics Screen width/height:1600/1200 03:05:56 INFO - PROCESS | 26360 | colorDepth:24 03:05:56 INFO - PROCESS | 26360 | Browser inner width/height: 1024/697 03:05:56 INFO - PROCESS | 26360 | __metrics 03:05:57 INFO - PROCESS | 26360 | 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" 03:05:57 INFO - PROCESS | 26360 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:05:58 INFO - TEST-INFO | 26360: exit 0 03:05:58 INFO - Browser initialized. 03:05:58 INFO - Running cycle 1/1 for dromaeo_css test... 03:05:58 INFO - TEST-INFO | started process 26439 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPwRfJE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:06:10 INFO - PROCESS | 26439 | RSS: Main: 159264768 03:06:10 INFO - PROCESS | 26439 | 03:07:02 INFO - PROCESS | 26439 | 1469441222032 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] 03:09:13 INFO - PROCESS | 26439 | Cycle 1(1): loaded http://localhost:38298/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38298/tests/dromaeo/cssquery-ext.html) 03:09:15 INFO - PROCESS | 26439 | RSS: Main: 236539904 03:09:15 INFO - PROCESS | 26439 | 03:12:17 INFO - PROCESS | 26439 | Cycle 1(1): loaded http://localhost:38298/tests/dromaeo/cssquery-ext.html (next: http://localhost:38298/tests/dromaeo/cssquery-jquery.html) 03:12:18 INFO - PROCESS | 26439 | RSS: Main: 250044416 03:12:18 INFO - PROCESS | 26439 | 03:15:20 INFO - PROCESS | 26439 | Cycle 1(1): loaded http://localhost:38298/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38298/tests/dromaeo/cssquery-mootools.html) 03:15:20 INFO - PROCESS | 26439 | RSS: Main: 243675136 03:15:20 INFO - PROCESS | 26439 | 03:18:23 INFO - PROCESS | 26439 | Cycle 1(1): loaded http://localhost:38298/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38298/tests/dromaeo/cssquery-prototype.html) 03:18:23 INFO - PROCESS | 26439 | RSS: Main: 241905664 03:18:23 INFO - PROCESS | 26439 | 03:21:26 INFO - PROCESS | 26439 | Cycle 1(1): loaded http://localhost:38298/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38298/tests/dromaeo/cssquery-yui.html) 03:21:27 INFO - PROCESS | 26439 | RSS: Main: 190849024 03:21:27 INFO - PROCESS | 26439 | 03:24:30 INFO - PROCESS | 26439 | Cycle 1(1): loaded http://localhost:38298/tests/dromaeo/cssquery-yui.html (next: http://localhost:38298/tests/dromaeo/cssquery-dojo.html) 03:24:30 INFO - PROCESS | 26439 | RSS: Main: 282755072 03:24:30 INFO - PROCESS | 26439 | 03:24:30 INFO - PROCESS | 26439 | __start_tp_report 03:24:30 INFO - PROCESS | 26439 | _x_x_mozilla_page_load 03:24:30 INFO - PROCESS | 26439 | _x_x_mozilla_page_load_details 03:24:30 INFO - PROCESS | 26439 | |i|pagename|runs| 03:24:30 INFO - PROCESS | 26439 | |0;dojo.html;2586.8318559293643;2588.327034970907;2618.1752747884416;2622.9344266393327;2628.7502687244705;4623.953760462395;4735.171345014617;4740;4757.0723708876785;4758.2862570614425;4699.788509517071;4757.595604373632;4763.595094416979;4792.83225087122;4852.660313778037;4295.570442955711;4319.913601727979;4361.323994780814;4397.296432570789;4500.234960056782;4320.395144679747;4421.867343979686;4446.088551846879;4451.465824101097;4502.594766471017;4277.786110694453;4325.394444777734;4379.890502737425;4393.231184542692;4445.84439544616;4276.444062271885;4342.044750154961;4356.847510337123;4363.934540981888;4404.69167158299;4313.245182093121;4335.848245311399;4338.739675619473;4369.6722745794195;4379.364992076131;4641.976790116061;4750.239961606127;4750.4299484061785;4775.952240477585;4823.083614113307;5036.395632524084;5077.746112694351;5103.336566246401;5183.196604526304;5184.585233181374;5159.17453207485;5205.24523944026;5212.609054320903;5222;5223.608229382811;4812.326274321597;4824.855254342376;4860.756962151878;4875.829345972909;4877.073356062408;5029.4719054498755;5082.186850103965;5147;5190.766415511311;5207.817726379559;5010.674306170087;5019.498050195024;5056.646034777604;5065.214891691794;5068.619853511002;5094.898102037939;5141.357330333708;5145.4597267287145;5151.175811870157;5152.02111598795;4900.607951363882;4998.050370429607;5024.095662780662;5037.69773813565;5057.291979122926;5046.066477701637;5053.69677819332;5054.671446355975;5056.772445239973;5091.210862316347;4270.48754149504;4308.849190278388;4309.181255561433;4344.869653910388;4355.063661312833;3665.486831843544;3721.5348081489815;3728.515293011891;3752.4558938954247;3754.662080412776;4402.581754733295;4407.074514351958;4432.268675668543;4438.911221775611;4456.376107344974;5130.300056294785;5136;5142.074426603247;5146.2280657900865;5175.06848767218;4217.8523751668545;4338.262495375794;4368.170047690928;4392.363107349481;4451.488078870972;4561.908761824745;4582.495925448198;4609.492955774862;4626.560476754703;4632.536746325341;4816.060868130821;4817.662763606514;4818.301346304836;4823.397075365579;4869.342638743866;4943.530364615356;4988.5260900214425;5030.496950304941;5093.083245015932;5099.209622508517;4767.547083027107;4798.184308667465;4807.567318941312;4813.518648135158;4820.8794780130775;4992.950070499249;4996.075725990703;4996.480297152907;4997.150484417731;5040.395152581567;4927.01459708067;5061.9493805061475;5077.543021128116;5080.771365288497;5125.7693403796175;4846.80612775485;4873.293372460902;4895.33912921751;4919.458859525378;4963.354763880672;4899.926501102557;4916.655834091579;4917.483664215349;4919.2129259318335;4964.255361695775;4723.409573803275;4832.927506087482;4838.491958344323;4848.296996935495;4898.632602554751;4885.731284779371;4933.506649335038;4957.231629097496;4961.8015279389865;5033.773480193473;4865.927011094907;4870.805167793249;4872.098661747588;4872.878178045436;4923.606111510999 03:24:30 INFO - PROCESS | 26439 | |1;ext.html;569.8746275819319;572.7708916433426;586.2554555714246;587.3480436715246;594.1651978969546;26995.865020674893;29593;29730.55404168934;29743.702562974362;29769.255768605795;30284.09147725566;40432;41379.17241655165;41462.792686036526;44930.550694493126;7576.77269681909;7686;7691.077070751489;7692.423068269874;7693.30760231579;7660.463767536275;7743.148253692118;7749.186335434782;7752.147263800977;7756.146823849372;7651.502652327608;7680.231976802303;7680.8094745314565;7715.614219289013;7724.6137693115115;7592.886106708376;7631.427642926803;7638.236176382373;7640.885386719176;7648.502847314907;7588.544687318723;7647.770566883002;7680.231976802275;7689.5001824881765;7697.461177717562;38371.424428633596;38400.807995960124;38449;38812;38846.80576597127;2977.136630377188;3007.6090108286003;3445.5176275321473;3481.756277060607;3602.4056030754896;28343;28733.42533149346;29164.562531562042;29199.708002920124;29295.85352073226;3418.1625501751982;3542.468629705539;3597.964020359789;3623.2572322673786;3650.9269814603826;242526;242565;243922;244367;244638;51882.48117518852;52260.738696306275;52266;52440;52472.47527524676;54002.459975399746;54324.72837635787;54469.45530544644;54546;54554.727226364404;13877.167369957835;13932;14020.298985050707;14031.508897188549;14041.087329323562;11199.608013719644;11211.831822522669;11238.269512481662;11262.605808796652;11267.54929802815;16192.514224573282;16203.136639286397;16350.509484715478;16507.752383714254;16605.252763625667;5510.1459273812625;5613.775448982076;5657.8019769307875;5742.483176514133;5810.854728631733;777.6345117794627;869.4305230074311;870.0516437083609;874.2961915657829;892.5269607108243;26588;28061.719382806317;28263.43473130526;28650.570241446396;28739.712602873704;775.9806004849924;949.159993405827;985.1380042462845;1001.8246806808925;1013.6198925402974;14371.78442323366;15018;15263.923680381527;15465.536033919001;15528.5341439757;383992;385581;385698;387577;388323;50483.49516504861;50920.49079509157;50928.74535627298;51171.48828511742;51231.48768512267;1038.7143535527791;1108.9611863584735;1147.0995268714018;1162.7093226693328;1191.9642410727517;25701.3574660635;28821.42357152887;29418.09378642463;29465;29979.550306745852;41439.7928010358;41513.1697366045;41771;41800.79099604482;41829.372559412244;295913;298059;298187;298318;298354;24272;24911.62632560549;25171;26488.205353838646;34652.65347346595;41214.38178427386;41246;41821.58178418177;42447.3632895513;42811.7859410701;36214.27571448503;36337;36411.08972275714;36757.63242367542;37317.81341093277;36133.63866361408;36563.63436365602;37842;38447;40762.59237407588;34368.312633747686;34452.82773586116;35205;36168.81915590405;36541.08647283839;30764.538531922488;33461.665383345855;33477.83261083679;33620;33848.49227261544;24635.876820615784;24830.25509234726;24950.750492494844;25102;25218.24345269645 03:24:30 INFO - PROCESS | 26439 | |2;jquery.html;343.82583477424595;364.9324874898144;369.80585192773776;374.2925870105501;393.2312329396031;12674.42965066572;15963.361465541378;16244.350225990976;16304.103274319908;17291.567710807205;16179.271932763024;16849.241784119713;17634.82365176348;17772;17836.821631783678;4953.603711703073;4964.70211787293;5100.15847385181;5119.641625086246;5120.334356533645;3742.4573436851642;5062.9240561391425;5143.3570803649545;5576.275084239063;5882.5588080893895;5863.208466856962;5877.089051197071;5880.088586269114;5906.23218981534;5908.4091590841;5079.568236699885;5355.250264962909;5383.73081345935;5387.515123638852;5881.2354393928945;5241.659292145999;5247.317848679685;5281.260623512711;5287.074761916688;5292.470752924715;11479.48342324589;16159.596010099724;21014;21200.045997929978;21539.8923005384;1823.3709370267236;1901.7052356884706;1956.7064940258933;1976.7924367941446;2301.9309420717404;8814.955925220396;8822.955885220597;9231.076892310783;9385.202257808094;9424.670136545257;1691.9492415227562;1745.380389961558;1748.4055421156868;1752.2640490993813;1756.5696404381008;66974.66512667455;69580.6520967397;71718.18677225655;73247.63376183138;74984.25015749827;9459.337846350689;9502.762430939281;9965.252606054575;9983.101520863158;10041.497925103715;13566.796498052538;13769;13769.105008174436;13850.307484625728;13873.306334683226;7048.224695283515;7141.296575832265;7170.354668079898;7221.89167162493;7245.203027666952;6607.174103237096;6962.582245065312;7064.646767661597;7331.706731730671;7378.704851805975;4199.9370009449885;4345.261305578059;4365.672574556857;4482.327650852399;4507.121111383249;1806.4219449776208;1828.3052440072688;1828.8628352873322;1873.5222518258029;1881.5296175956012;671.2649648634737;707.9929200707927;792.8850316704046;807.2250639386255;847.9660813567389;15404.229788510529;16240.51278461648;16326.428574999818;16504.83495165057;16702.749458758128;810.5541951926534;835.8035861572525;840.9369297302604;864.4813112132796;886.8802711633847;9451.621935122517;9610.231181505464;9816.36193647425;9842.458664773363;9991.550380232908;357258;380557;392368;393144;394652;46635;47988;48535.51464485381;64513.677431612545;79751.60124199458;873.2315562305131;889.5596679643618;890.5947793753827;890.9599068041954;894.1639567004871;14575;14904.850951490347;15117.16855572954;15154;15769.44806931752;37284.25431491301;38339.04152396212;39255.2148957025;39449.0413219004;39660.80169599134;48902.26646600233;52353;53576.19635705546;54085.72957135189;54172.18741718956;10080.294379393665;10495.790084198426;10911.454427278763;11064.225504214628;11320.830187547028;12505.187162834387;12535;12589.874101259236;12672.176308539916;12841.871581284067;10992.340459572451;11002.669919902415;11114.555417783198;11367.943160284145;11541.942290288494;10341.224408169266;11065.612703555336;11158.274712143684;11298.548058077586;11349.546018159512;11123.555057797921;11229;11275.210735248455;11559.711007224887;11685.123615728684;10808.45957702096;10870.021698047214;10945.781084378108;11001.17491188148;11634.360110193682;7499.850003000019;7643.5796031218815;7826.608669566385;7946.125926148235;11479.885201147881 03:24:30 INFO - PROCESS | 26439 | |3;mootools.html;1332.6401871494693;1402.256803893936;1408.3451195194236;1631.5676345768381;1669.9916500417503;7672.271134242245;8266.4626799258;8269.131741167173;8273.710420135296;8290.461120027201;6953.756618518353;7192.3167299106635;7665.8850117248285;7975.680972761083;8103.473274237185;2222.9888850555767;2252.5720113178527;2253.481699209183;2254.8083412909923;2255.785700358463;2214.1364867701527;2240.305505293364;2242.663600459936;2244.9663255051187;2252.4594097416666;1849.4451664500664;2106.1575369852103;2182.2471247419617;2183.3122566391617;2184.7159869217057;2216.958029726034;2239.955200895989;2258.4241018540333;2259.819214462839;2261.2424837679396;2202.7246594175726;2208.436848603612;2208.4810069633786;2213.8118259947923;2213.822894168463;7973.601319934038;8008.919910800876;8011.399145064085;8017.158198389144;8020.759377218635;4560.817567297304;4657.4411070671395;4678.836240731592;4733.715977041354;4740.952590474086;2889.1477014280836;3038.270815004383;3040.6047213862275;3042.3306872488015;3049.573059771634;869.8738682891009;920.098303662408;923.2152670230317;933.5938866593053;945.8202941441104;11124.38815865127;11150.66548003553;11155.442227888572;11166.944165279121;11175.776484470265;4074.8166332515107;4290.935635965463;4424.6902716810155;4429.822807087745;4437.423134992495;9526.761830954143;9532.618695252113;9537.093976072261;9539.666111686196;9544.713658590254;4823.903521929542;4825.9034819303415;4826;4827.565519103227;4829.73436460998;4320.783960801948;4373.343998400265;4382.802773875183;4385.035292235703;4398.186335527937;3595.658412450813;3609.8917032489067;3708.072981754561;3727.422249551324;3753.9624603753614;1197.4072833947253;1224.7856625090574;1226.816122441848;1233.7039110613568;1248.5005997601031;613.828128124126;701.5019336271305;706.9469789765789;782.1787123520281;819.4223072733708;4847.3698419205275;4874.5856602189215;4926.581240594518;5002.924956125661;5057.988402319551;836.7198186774245;837.459838404238;840.878072679458;849.541247726221;862.7325529086004;3397.11674964511;3589.8743543975834;3590.784552926833;3670.46778217157;3679.742418030712;9280.535973201313;10098.848517272247;10113.797724045626;10120.949395252977;10148.188144948534;9835.409875407498;10040.949795250977;10071.848922266172;10088.49557522121;10099.899001009895;7155.427565794724;7177.89233161503;7178.533395329287;7227.494075414776;7233.782986510413;4996.675216110941;5028.661672322388;5119.667221630582;5208.765605547836;5218.843434696965;9144.405613635092;9169.862452063091;9204.125608067223;9280.95359523198;9306.208972237166;9311.510158374627;9453.101955314234;9464.858027129736;9470.19503342196;9521.095495927875;6824.522283440111;6829.351211634887;6843.692033858588;6865.176178858569;6916.20463646687;7620.657070431733;7687.769366919001;7689.9615501922135;7697.846043079219;7707.152213256425;6853.417459515797;6941.271166527442;6998.860022799618;7014.473914456538;7220.350168484862;6669.266380698216;6813;6814.488913331619;6821.2155602106395;6822.795316140524;6450.387213214737;6470.352964703492;6549;6607;6615.106960560455;4415.492218394926;4639.141758774503;4652.837150699709;4667.836625718083;4824.831130910401;4541.704789188824;4584.564466375689;4613.769311534477;4800.5199480051715;4834.927476087792 03:24:30 INFO - PROCESS | 26439 | |4;prototype.html;288.6363182390188;288.86134655365413;302.12835968231644;303.31450920918746;311.71789530474916;4661.277501987189;4796.376471058767;4816.181249187638;4838.758062096895;4848.587870031047;4588.77056147193;4727.243641017438;4736.786844591993;4767.761611919407;4803.111424386491;3804.5624753153465;3812.4471951567007;3818.904527386817;3819.2049736623744;3819.7776711452348;3610.620884807097;3614.493970844084;3810.6951443884564;3819.3698039823394;3819.8472061117523;3776.8678096266635;3782.186829831586;3783.735138540303;3785.129420233348;3802.1065049713297;3760.5863355030924;3770.1140232045445;3771.1326394929183;3776.603456637055;3777.4333849922455;3334.299797042624;3339.1151344893624;3340.04607304727;3345.5483509726364;3352.2122301259183;4579.977100114512;4688.765561721934;4696.084263568606;4697.694649847783;4700.670953033289;4264.317709166549;4280.186764514763;4301.075268817203;4305.052888364586;4314.870553883357;5008.824691135793;5014.824481143142;5015.297858299841;5024.03581886685;5030.8239211627415;3555.2356243407535;3606.647507184806;3619.0952261934517;3656.945145822815;3666.6699997000396;5227.869303267411;5230.529252367267;5234.7644356004075;5244.239585260116;5249.002689489023;3724.273766615484;3737.383331750285;3737.719671024684;3738.27103714773;3745.250949810049;3787.6401741834484;3789.8673546425744;3794.2790869734663;3829.1384438501113;3841.2893614681375;4206.8737937861915;4254.510731265882;4267.850625228102;4280.229558679468;4334.9783251083545;4981.850544483671;4982.202847544376;4982.451930287665;5021.874453138701;5022.874428139326;1241.8323526323832;1267.8225048493218;1297.4356155072574;1310.194230548225;1323.2854258700386;893.5130353957109;914.6615752171606;918.6004088221645;920.1718453391867;921.9769505762409;4368.322909948963;4374.693771435969;4386.385905973167;4408.801603927831;4431.8448854289945;5129.999650068201;5140.46025167352;5142.280080788692;5147.56245719118;5155.407128180307;4271.654428854963;4372.366006929041;4386.385905973167;4413.404190434315;4420.403245561873;2387.7970372518184;2408.9156879509133;2432.2581612608324;2433.282181756351;2435.829491935583;4272.850450234289;4291.635211007099;4304.612584867377;4315.417418648505;4340.739555626673;4363.3018717005125;4636.327732478839;4665.95334046662;4670.322803193586;4678.7660616969015;4290.249206388869;4308.849190278325;4309.870703878889;4325.978370108192;4340.350666746616;4522.208613492559;4565.406497155349;4581.5647513486165;4585.234684646502;4616.8614941551805;4298.333758267474;4444.4666640002115;4464.955350446454;4465.240909045405;4528.388667529973;4288.892777680583;4300.268954277718;4304.849330273551;4307.39696442492;4311.913761724811;3345.314210586775;3366.4781958796425;3375.561177046968;3379.2396710739886;3408.6080100787735;4342.869713908588;4527.52563833721;4537.478190008192;4540.250858608425;4552.135094332067;4397.274449715761;4425.601695847389;4460.353248778844;4476.753778542081;4480.820767169277;4400.69195156336;4432.778361081998;4438.312061630452;4446.48819401405;4476.216662084187;4350.390945267728;4368.759718215529;4398;4721.763911804464;4867.70793752376;4975.114433628559;5052.8989420210655;5070.239464080418;5071.797128114834;5086.872828179326;4978.415540810611;4991.9500804991485;4992.80028798844;4996.700197987987;5000.499950004971 03:24:30 INFO - PROCESS | 26439 | |5;yui.html;611.6421893192482;626.7618305044083;631.6241836107514;717.5192620943967;721.2318880392378;11938.880611193885;12982.09125361225;12999.74000519989;13051.673708157288;13081.869181308184;12491.687707807308;12624.873751262485;12638.936805315983;12653.17754345967;12655.873441265585;614.8370681769335;719.9784006479814;743.0414764953204;750.0774047921046;771.7106085218044;749.9100107987022;757.9658915348823;758.4614923404389;758.4842307231081;758.962051897403;798.6805277888833;801.310872649521;802.8033131882697;806.6249194124731;806.8628333183343;632.9208848893911;765.8659734546432;791.8020494876281;794.8171920458298;796.4106561144769;583.4777873802923;585.9238299021142;586.8180863932153;593.5904226084032;596.3470000349611;12307.815382769266;12312.81530777039;12343.876561234363;12347.506099756;12348.012159027256;11643.534258629645;11742.354170520617;11986.64040078799;12185.207961482476;12419.254844709347;11233.775324493465;11358.60244891425;11478.483468243949;11613.419329033515;11635;4005.2790497710403;4026.476558047435;4046.7167298289132;4089.2434899543678;4115.855945041939;58418.70790646062;58718.41281587172;58833;58888;59123.704381478245;9244.95377523108;9249.12133347331;9272.814543709088;9327.207187389147;9469.156378806263;18097.909510452628;18308.725369119475;18394.816051839578;18557.90721046386;18613.627727445375;6115.052166914135;6152.477039451696;6210.347913469021;6356.523260755462;6365.267994180728;3550.2012047289154;3565.6612621800887;3583.3549961006747;3588.8743893963588;3601.837917293728;2735.179446166182;2829.773618110546;2835.050258163497;3254.7558933080113;3428.6057103432927;578.3955766224306;580.5413723158741;581.7265885034027;591.9223525425787;595.1429940885198;443.8379991303216;515.7859488312383;527.1776029394157;531.9601029922771;537.965032272901;7069.92930070703;7073.82315442118;7443.627818609156;7531.435142364345;7779.533228006338;559.0914763509297;563.9407862174413;566.9574781891292;579.8347470970754;589.8911391774424;3521.9471707924404;3682.797446140434;3694.538182727159;3725.6790406850128;3865.6520913117392;59653.10520342198;61199.08201376983;61635;62104.37895621076;62251.377486225465;89554;89616;91772;93431;94118;50423.71398431101;80799;81230.59384703157;81855.9999999988;82718.58640706878;6879.484038697017;6995.148333731036;7156.570605763671;7270.200277969313;7314.469561936278;45859.54140458553;47227.29159062685;47244;47630.761846191934;48673;63215.6839215801;63390.68304658447;70130.29869701237;70360.64819675869;71059.28940710734;9449.763755905882;9800.264980126376;9927.851082233628;10078.244131690299;10195.490225488547;11054.613088541862;11086.556537738723;11605.361705106301;11689.298642081503;11728.76542469163;9151.496667683341;9447.716568502956;9554.713358599252;9755.122039016522;9790.608375664893;10024.14794742455;10195.949020254851;10442.63450779219;10468.110210632181;10732.087772539422;9487.525623718648;9513.857292140485;9606.855897161407;9745.756356091155;9976.900230997597;8740.91259087401;8936.642534298815;8950.194482496607;8956.507392093497;8981.730548083568;8172.632231549475;8552.102029286836;8621.310295176245;8628.439151455135;8765.66009483404 03:24:30 INFO - PROCESS | 26439 | __end_tp_report 03:24:30 INFO - PROCESS | 26439 | __start_cc_report 03:24:30 INFO - PROCESS | 26439 | _x_x_mozilla_cycle_collect,1134 03:24:30 INFO - PROCESS | 26439 | __end_cc_report 03:24:30 INFO - PROCESS | 26439 | __startTimestamp1469442270300__endTimestamp 03:24:30 INFO - PROCESS | 26439 | 03:24:30 INFO - PROCESS | 26439 | ------- Summary: start ------- 03:24:30 INFO - PROCESS | 26439 | Number of tests: 6 03:24:30 INFO - PROCESS | 26439 | 03:24:30 INFO - PROCESS | 26439 | [#0] dojo.html Cycles:165 Average:4698.34 Median:4838.49 stddev:500.34 (10.3%) stddev-sans-first:473.67 03:24:30 INFO - PROCESS | 26439 | Values: 2586.8 2588.3 2618.2 2622.9 2628.8 4624.0 4735.2 4740.0 4757.1 4758.3 4699.8 4757.6 4763.6 4792.8 4852.7 4295.6 4319.9 4361.3 4397.3 4500.2 4320.4 4421.9 4446.1 4451.5 4502.6 4277.8 4325.4 4379.9 4393.2 4445.8 4276.4 4342.0 4356.8 4363.9 4404.7 4313.2 4335.8 4338.7 4369.7 4379.4 4642.0 4750.2 4750.4 4776.0 4823.1 5036.4 5077.7 5103.3 5183.2 5184.6 5159.2 5205.2 5212.6 5222.0 5223.6 4812.3 4824.9 4860.8 4875.8 4877.1 5029.5 5082.2 5147.0 5190.8 5207.8 5010.7 5019.5 5056.6 5065.2 5068.6 5094.9 5141.4 5145.5 5151.2 5152.0 4900.6 4998.1 5024.1 5037.7 5057.3 5046.1 5053.7 5054.7 5056.8 5091.2 4270.5 4308.8 4309.2 4344.9 4355.1 3665.5 3721.5 3728.5 3752.5 3754.7 4402.6 4407.1 4432.3 4438.9 4456.4 5130.3 5136.0 5142.1 5146.2 5175.1 4217.9 4338.3 4368.2 4392.4 4451.5 4561.9 4582.5 4609.5 4626.6 4632.5 4816.1 4817.7 4818.3 4823.4 4869.3 4943.5 4988.5 5030.5 5093.1 5099.2 4767.5 4798.2 4807.6 4813.5 4820.9 4993.0 4996.1 4996.5 4997.2 5040.4 4927.0 5061.9 5077.5 5080.8 5125.8 4846.8 4873.3 4895.3 4919.5 4963.4 4899.9 4916.7 4917.5 4919.2 4964.3 4723.4 4832.9 4838.5 4848.3 4898.6 4885.7 4933.5 4957.2 4961.8 5033.8 4865.9 4870.8 4872.1 4872.9 4923.6 03:24:30 INFO - PROCESS | 26439 | 03:24:30 INFO - PROCESS | 26439 | [#1] ext.html Cycles:180 Average:46334.30 Median:20096.01 stddev:82850.75 (412.3%) stddev-sans-first:83011.92 03:24:30 INFO - PROCESS | 26439 | Values: 569.9 572.8 586.3 587.3 594.2 26995.9 29593.0 29730.6 29743.7 29769.3 30284.1 40432.0 41379.2 41462.8 44930.6 7576.8 7686.0 7691.1 7692.4 7693.3 7660.5 7743.1 7749.2 7752.1 7756.1 7651.5 7680.2 7680.8 7715.6 7724.6 7592.9 7631.4 7638.2 7640.9 7648.5 7588.5 7647.8 7680.2 7689.5 7697.5 38371.4 38400.8 38449.0 38812.0 38846.8 2977.1 3007.6 3445.5 3481.8 3602.4 28343.0 28733.4 29164.6 29199.7 29295.9 3418.2 3542.5 3598.0 3623.3 3650.9 242526.0 242565.0 243922.0 244367.0 244638.0 51882.5 52260.7 52266.0 52440.0 52472.5 54002.5 54324.7 54469.5 54546.0 54554.7 13877.2 13932.0 14020.3 14031.5 14041.1 11199.6 11211.8 11238.3 11262.6 11267.5 16192.5 16203.1 16350.5 16507.8 16605.3 5510.1 5613.8 5657.8 5742.5 5810.9 777.6 869.4 870.1 874.3 892.5 26588.0 28061.7 28263.4 28650.6 28739.7 776.0 949.2 985.1 1001.8 1013.6 14371.8 15018.0 15263.9 15465.5 15528.5 383992.0 385581.0 385698.0 387577.0 388323.0 50483.5 50920.5 50928.7 51171.5 51231.5 1038.7 1109.0 1147.1 1162.7 1192.0 25701.4 28821.4 29418.1 29465.0 29979.6 41439.8 41513.2 41771.0 41800.8 41829.4 295913.0 298059.0 298187.0 298318.0 298354.0 24272.0 24911.6 25171.0 26488.2 34652.7 41214.4 41246.0 41821.6 42447.4 42811.8 36214.3 36337.0 36411.1 36757.6 37317.8 36133.6 36563.6 37842.0 38447.0 40762.6 34368.3 34452.8 35205.0 36168.8 36541.1 30764.5 33461.7 33477.8 33620.0 33848.5 24635.9 24830.3 24950.8 25102.0 25218.2 03:24:30 INFO - PROCESS | 26439 | 03:24:30 INFO - PROCESS | 26439 | [#2] jquery.html Cycles:180 Average:23864.51 Median:217050.52 stddev:63126.64 (29.1%) stddev-sans-first:63279.02 03:24:30 INFO - PROCESS | 26439 | Values: 343.8 364.9 369.8 374.3 393.2 12674.4 15963.4 16244.4 16304.1 17291.6 16179.3 16849.2 17634.8 17772.0 17836.8 4953.6 4964.7 5100.2 5119.6 5120.3 3742.5 5062.9 5143.4 5576.3 5882.6 5863.2 5877.1 5880.1 5906.2 5908.4 5079.6 5355.3 5383.7 5387.5 5881.2 5241.7 5247.3 5281.3 5287.1 5292.5 11479.5 16159.6 21014.0 21200.0 21539.9 1823.4 1901.7 1956.7 1976.8 2301.9 8815.0 8823.0 9231.1 9385.2 9424.7 1691.9 1745.4 1748.4 1752.3 1756.6 66974.7 69580.7 71718.2 73247.6 74984.3 9459.3 9502.8 9965.3 9983.1 10041.5 13566.8 13769.0 13769.1 13850.3 13873.3 7048.2 7141.3 7170.4 7221.9 7245.2 6607.2 6962.6 7064.6 7331.7 7378.7 4199.9 4345.3 4365.7 4482.3 4507.1 1806.4 1828.3 1828.9 1873.5 1881.5 671.3 708.0 792.9 807.2 848.0 15404.2 16240.5 16326.4 16504.8 16702.7 810.6 835.8 840.9 864.5 886.9 9451.6 9610.2 9816.4 9842.5 9991.6 357258.0 380557.0 392368.0 393144.0 394652.0 46635.0 47988.0 48535.5 64513.7 79751.6 873.2 889.6 890.6 891.0 894.2 14575.0 14904.9 15117.2 15154.0 15769.4 37284.3 38339.0 39255.2 39449.0 39660.8 48902.3 52353.0 53576.2 54085.7 54172.2 10080.3 10495.8 10911.5 11064.2 11320.8 12505.2 12535.0 12589.9 12672.2 12841.9 10992.3 11002.7 11114.6 11367.9 11541.9 10341.2 11065.6 11158.3 11298.5 11349.5 11123.6 11229.0 11275.2 11559.7 11685.1 10808.5 10870.0 10945.8 11001.2 11634.4 7499.9 7643.6 7826.6 7946.1 11479.9 03:24:30 INFO - PROCESS | 26439 | 03:24:30 INFO - PROCESS | 26439 | [#3] mootools.html Cycles:180 Average:5256.65 Median:4828.65 stddev:2995.91 (62.0%) stddev-sans-first:2989.80 03:24:30 INFO - PROCESS | 26439 | Values: 1332.6 1402.3 1408.3 1631.6 1670.0 7672.3 8266.5 8269.1 8273.7 8290.5 6953.8 7192.3 7665.9 7975.7 8103.5 2223.0 2252.6 2253.5 2254.8 2255.8 2214.1 2240.3 2242.7 2245.0 2252.5 1849.4 2106.2 2182.2 2183.3 2184.7 2217.0 2240.0 2258.4 2259.8 2261.2 2202.7 2208.4 2208.5 2213.8 2213.8 7973.6 8008.9 8011.4 8017.2 8020.8 4560.8 4657.4 4678.8 4733.7 4741.0 2889.1 3038.3 3040.6 3042.3 3049.6 869.9 920.1 923.2 933.6 945.8 11124.4 11150.7 11155.4 11166.9 11175.8 4074.8 4290.9 4424.7 4429.8 4437.4 9526.8 9532.6 9537.1 9539.7 9544.7 4823.9 4825.9 4826.0 4827.6 4829.7 4320.8 4373.3 4382.8 4385.0 4398.2 3595.7 3609.9 3708.1 3727.4 3754.0 1197.4 1224.8 1226.8 1233.7 1248.5 613.8 701.5 706.9 782.2 819.4 4847.4 4874.6 4926.6 5002.9 5058.0 836.7 837.5 840.9 849.5 862.7 3397.1 3589.9 3590.8 3670.5 3679.7 9280.5 10098.8 10113.8 10120.9 10148.2 9835.4 10040.9 10071.8 10088.5 10099.9 7155.4 7177.9 7178.5 7227.5 7233.8 4996.7 5028.7 5119.7 5208.8 5218.8 9144.4 9169.9 9204.1 9281.0 9306.2 9311.5 9453.1 9464.9 9470.2 9521.1 6824.5 6829.4 6843.7 6865.2 6916.2 7620.7 7687.8 7690.0 7697.8 7707.2 6853.4 6941.3 6998.9 7014.5 7220.4 6669.3 6813.0 6814.5 6821.2 6822.8 6450.4 6470.4 6549.0 6607.0 6615.1 4415.5 4639.1 4652.8 4667.8 4824.8 4541.7 4584.6 4613.8 4800.5 4834.9 03:24:30 INFO - PROCESS | 26439 | 03:24:30 INFO - PROCESS | 26439 | [#4] prototype.html Cycles:180 Average:4009.41 Median:4368.54 stddev:1128.39 (25.8%) stddev-sans-first:1096.46 03:24:30 INFO - PROCESS | 26439 | Values: 288.6 288.9 302.1 303.3 311.7 4661.3 4796.4 4816.2 4838.8 4848.6 4588.8 4727.2 4736.8 4767.8 4803.1 3804.6 3812.4 3818.9 3819.2 3819.8 3610.6 3614.5 3810.7 3819.4 3819.8 3776.9 3782.2 3783.7 3785.1 3802.1 3760.6 3770.1 3771.1 3776.6 3777.4 3334.3 3339.1 3340.0 3345.5 3352.2 4580.0 4688.8 4696.1 4697.7 4700.7 4264.3 4280.2 4301.1 4305.1 4314.9 5008.8 5014.8 5015.3 5024.0 5030.8 3555.2 3606.6 3619.1 3656.9 3666.7 5227.9 5230.5 5234.8 5244.2 5249.0 3724.3 3737.4 3737.7 3738.3 3745.3 3787.6 3789.9 3794.3 3829.1 3841.3 4206.9 4254.5 4267.9 4280.2 4335.0 4981.9 4982.2 4982.5 5021.9 5022.9 1241.8 1267.8 1297.4 1310.2 1323.3 893.5 914.7 918.6 920.2 922.0 4368.3 4374.7 4386.4 4408.8 4431.8 5130.0 5140.5 5142.3 5147.6 5155.4 4271.7 4372.4 4386.4 4413.4 4420.4 2387.8 2408.9 2432.3 2433.3 2435.8 4272.9 4291.6 4304.6 4315.4 4340.7 4363.3 4636.3 4666.0 4670.3 4678.8 4290.2 4308.8 4309.9 4326.0 4340.4 4522.2 4565.4 4581.6 4585.2 4616.9 4298.3 4444.5 4465.0 4465.2 4528.4 4288.9 4300.3 4304.8 4307.4 4311.9 3345.3 3366.5 3375.6 3379.2 3408.6 4342.9 4527.5 4537.5 4540.3 4552.1 4397.3 4425.6 4460.4 4476.8 4480.8 4400.7 4432.8 4438.3 4446.5 4476.2 4350.4 4368.8 4398.0 4721.8 4867.7 4975.1 5052.9 5070.2 5071.8 5086.9 4978.4 4992.0 4992.8 4996.7 5000.5 03:24:30 INFO - PROCESS | 26439 | 03:24:30 INFO - PROCESS | 26439 | [#5] yui.html Cycles:180 Average:16682.24 Median:594.37 stddev:23834.27 (4010.0%) stddev-sans-first:23870.58 03:24:30 INFO - PROCESS | 26439 | Values: 611.6 626.8 631.6 717.5 721.2 11938.9 12982.1 12999.7 13051.7 13081.9 12491.7 12624.9 12638.9 12653.2 12655.9 614.8 720.0 743.0 750.1 771.7 749.9 758.0 758.5 758.5 759.0 798.7 801.3 802.8 806.6 806.9 632.9 765.9 791.8 794.8 796.4 583.5 585.9 586.8 593.6 596.3 12307.8 12312.8 12343.9 12347.5 12348.0 11643.5 11742.4 11986.6 12185.2 12419.3 11233.8 11358.6 11478.5 11613.4 11635.0 4005.3 4026.5 4046.7 4089.2 4115.9 58418.7 58718.4 58833.0 58888.0 59123.7 9245.0 9249.1 9272.8 9327.2 9469.2 18097.9 18308.7 18394.8 18557.9 18613.6 6115.1 6152.5 6210.3 6356.5 6365.3 3550.2 3565.7 3583.4 3588.9 3601.8 2735.2 2829.8 2835.1 3254.8 3428.6 578.4 580.5 581.7 591.9 595.1 443.8 515.8 527.2 532.0 538.0 7069.9 7073.8 7443.6 7531.4 7779.5 559.1 563.9 567.0 579.8 589.9 3521.9 3682.8 3694.5 3725.7 3865.7 59653.1 61199.1 61635.0 62104.4 62251.4 89554.0 89616.0 91772.0 93431.0 94118.0 50423.7 80799.0 81230.6 81856.0 82718.6 6879.5 6995.1 7156.6 7270.2 7314.5 45859.5 47227.3 47244.0 47630.8 48673.0 63215.7 63390.7 70130.3 70360.6 71059.3 9449.8 9800.3 9927.9 10078.2 10195.5 11054.6 11086.6 11605.4 11689.3 11728.8 9151.5 9447.7 9554.7 9755.1 9790.6 10024.1 10195.9 10442.6 10468.1 10732.1 9487.5 9513.9 9606.9 9745.8 9976.9 8740.9 8936.6 8950.2 8956.5 8981.7 8172.6 8552.1 8621.3 8628.4 8765.7 03:24:30 INFO - PROCESS | 26439 | -------- Summary: end -------- 03:24:30 INFO - PROCESS | 26439 | 03:24:31 INFO - TEST-INFO | 26439: exit 0 03:24:31 INFO - TEST-OK | dromaeo_css | took 1118876ms 03:24:31 INFO - TEST-START | kraken 03:24:31 INFO - operating with platform_type : linux_ 03:24:31 INFO - Initialising browser for kraken test... 03:24:31 INFO - TEST-INFO | started process 26629 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbY6Qa1/profile http://localhost:38298/getInfo.html) 03:24:34 INFO - PROCESS | 26629 | JavaScript error: , line 0: uncaught exception: undefined 03:24:35 INFO - PROCESS | 26629 | __metrics Screen width/height:1600/1200 03:24:35 INFO - PROCESS | 26629 | colorDepth:24 03:24:35 INFO - PROCESS | 26629 | Browser inner width/height: 1024/697 03:24:35 INFO - PROCESS | 26629 | __metrics 03:24:35 INFO - PROCESS | 26629 | 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" 03:24:35 INFO - PROCESS | 26629 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:24:36 INFO - TEST-INFO | 26629: exit 0 03:24:36 INFO - Browser initialized. 03:24:36 INFO - Running cycle 1/1 for kraken test... 03:24:36 INFO - TEST-INFO | started process 26709 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbY6Qa1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:24:48 INFO - PROCESS | 26709 | RSS: Main: 159150080 03:24:48 INFO - PROCESS | 26709 | 03:24:51 INFO - PROCESS | 26709 | Cycle 1(1): loaded http://localhost:38298/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38298/tests/kraken/driver.html?testName=audio-beat-detection) 03:24:52 INFO - PROCESS | 26709 | RSS: Main: 215220224 03:24:52 INFO - PROCESS | 26709 | 03:24:55 INFO - PROCESS | 26709 | Cycle 1(1): loaded http://localhost:38298/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38298/tests/kraken/driver.html?testName=audio-dft) 03:24:55 INFO - PROCESS | 26709 | RSS: Main: 189513728 03:24:55 INFO - PROCESS | 26709 | 03:24:58 INFO - PROCESS | 26709 | Cycle 1(1): loaded http://localhost:38298/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38298/tests/kraken/driver.html?testName=audio-fft) 03:24:59 INFO - PROCESS | 26709 | RSS: Main: 272261120 03:24:59 INFO - PROCESS | 26709 | 03:25:01 INFO - PROCESS | 26709 | Cycle 1(1): loaded http://localhost:38298/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38298/tests/kraken/driver.html?testName=audio-oscillator) 03:25:02 INFO - PROCESS | 26709 | RSS: Main: 182296576 03:25:02 INFO - PROCESS | 26709 | 03:25:04 INFO - PROCESS | 26709 | Cycle 1(1): loaded http://localhost:38298/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38298/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:25:05 INFO - PROCESS | 26709 | RSS: Main: 185868288 03:25:05 INFO - PROCESS | 26709 | 03:25:08 INFO - PROCESS | 26709 | Cycle 1(1): loaded http://localhost:38298/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38298/tests/kraken/driver.html?testName=imaging-darkroom) 03:25:09 INFO - PROCESS | 26709 | RSS: Main: 223178752 03:25:09 INFO - PROCESS | 26709 | 03:25:12 INFO - PROCESS | 26709 | Cycle 1(1): loaded http://localhost:38298/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38298/tests/kraken/driver.html?testName=imaging-desaturate) 03:25:13 INFO - PROCESS | 26709 | RSS: Main: 216547328 03:25:13 INFO - PROCESS | 26709 | 03:25:16 INFO - PROCESS | 26709 | Cycle 1(1): loaded http://localhost:38298/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38298/tests/kraken/driver.html?testName=json-parse-financial) 03:25:16 INFO - PROCESS | 26709 | RSS: Main: 219955200 03:25:16 INFO - PROCESS | 26709 | 03:25:18 INFO - PROCESS | 26709 | Cycle 1(1): loaded http://localhost:38298/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38298/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:25:18 INFO - PROCESS | 26709 | RSS: Main: 185692160 03:25:18 INFO - PROCESS | 26709 | 03:25:20 INFO - PROCESS | 26709 | Cycle 1(1): loaded http://localhost:38298/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38298/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:25:21 INFO - PROCESS | 26709 | RSS: Main: 191209472 03:25:21 INFO - PROCESS | 26709 | 03:25:23 INFO - PROCESS | 26709 | Cycle 1(1): loaded http://localhost:38298/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38298/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:25:24 INFO - PROCESS | 26709 | RSS: Main: 195661824 03:25:24 INFO - PROCESS | 26709 | 03:25:27 INFO - PROCESS | 26709 | Cycle 1(1): loaded http://localhost:38298/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38298/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:25:27 INFO - PROCESS | 26709 | RSS: Main: 190578688 03:25:27 INFO - PROCESS | 26709 | 03:25:30 INFO - PROCESS | 26709 | Cycle 1(1): loaded http://localhost:38298/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38298/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:25:31 INFO - PROCESS | 26709 | RSS: Main: 194174976 03:25:31 INFO - PROCESS | 26709 | 03:25:32 INFO - PROCESS | 26709 | Cycle 1(1): loaded http://localhost:38298/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38298/tests/kraken/driver.html?testName=ai-astar) 03:25:33 INFO - PROCESS | 26709 | RSS: Main: 244301824 03:25:33 INFO - PROCESS | 26709 | 03:25:33 INFO - PROCESS | 26709 | __start_tp_report 03:25:33 INFO - PROCESS | 26709 | _x_x_mozilla_page_load 03:25:33 INFO - PROCESS | 26709 | _x_x_mozilla_page_load_details 03:25:33 INFO - PROCESS | 26709 | |i|pagename|runs| 03:25:33 INFO - PROCESS | 26709 | |0;ai-astar;103;113;112;113;112;113;112;113;114;113 03:25:33 INFO - PROCESS | 26709 | |1;audio-beat-detection;143;122;124;174;123;127;149;124;161;122 03:25:33 INFO - PROCESS | 26709 | |2;audio-dft;160;162;160;162;162;163;161;161;161;161 03:25:33 INFO - PROCESS | 26709 | |3;audio-fft;76;77;76;118;75;78;75;76;105;74 03:25:33 INFO - PROCESS | 26709 | |4;audio-oscillator;86;84;125;85;87;86;123;85;85;135 03:25:33 INFO - PROCESS | 26709 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;117;116;117 03:25:33 INFO - PROCESS | 26709 | |6;imaging-darkroom;146;148;146;145;146;147;147;147;146;147 03:25:33 INFO - PROCESS | 26709 | |7;imaging-desaturate;95;94;95;95;95;95;96;95;95;95 03:25:33 INFO - PROCESS | 26709 | |8;json-parse-financial;63;62;62;62;62;63;61;62;61;61 03:25:33 INFO - PROCESS | 26709 | |9;json-stringify-tinderbox;66;65;65;65;66;66;65;66;66;67 03:25:33 INFO - PROCESS | 26709 | |10;stanford-crypto-aes;82;79;81;80;80;80;79;80;86;83 03:25:33 INFO - PROCESS | 26709 | |11;stanford-crypto-ccm;132;128;134;130;132;131;131;131;179;132 03:25:33 INFO - PROCESS | 26709 | |12;stanford-crypto-pbkdf2;168;163;166;164;166;161;166;165;164;169 03:25:33 INFO - PROCESS | 26709 | |13;stanford-crypto-sha256-iterative;66;68;68;67;65;66;67;66;65;65 03:25:33 INFO - PROCESS | 26709 | __end_tp_report 03:25:33 INFO - PROCESS | 26709 | __start_cc_report 03:25:33 INFO - PROCESS | 26709 | _x_x_mozilla_cycle_collect,1943 03:25:33 INFO - PROCESS | 26709 | __end_cc_report 03:25:33 INFO - PROCESS | 26709 | __startTimestamp1469442333164__endTimestamp 03:25:33 INFO - PROCESS | 26709 | 03:25:33 INFO - PROCESS | 26709 | ------- Summary: start ------- 03:25:33 INFO - PROCESS | 26709 | Number of tests: 14 03:25:33 INFO - PROCESS | 26709 | 03:25:33 INFO - PROCESS | 26709 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.00 stddev:3.16 (2.8%) stddev-sans-first:0.67 03:25:33 INFO - PROCESS | 26709 | Values: 103.0 113.0 112.0 113.0 112.0 113.0 112.0 113.0 114.0 113.0 03:25:33 INFO - PROCESS | 26709 | 03:25:33 INFO - PROCESS | 26709 | [#1] audio-beat-detection Cycles:10 Average:136.90 Median:135.00 stddev:18.88 (14.0%) stddev-sans-first:19.90 03:25:33 INFO - PROCESS | 26709 | Values: 143.0 122.0 124.0 174.0 123.0 127.0 149.0 124.0 161.0 122.0 03:25:33 INFO - PROCESS | 26709 | 03:25:33 INFO - PROCESS | 26709 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:0.88 03:25:33 INFO - PROCESS | 26709 | Values: 160.0 162.0 160.0 162.0 162.0 163.0 161.0 161.0 161.0 161.0 03:25:33 INFO - PROCESS | 26709 | 03:25:33 INFO - PROCESS | 26709 | [#3] audio-fft Cycles:10 Average:83.00 Median:76.00 stddev:15.37 (20.2%) stddev-sans-first:16.09 03:25:33 INFO - PROCESS | 26709 | Values: 76.0 77.0 76.0 118.0 75.0 78.0 75.0 76.0 105.0 74.0 03:25:33 INFO - PROCESS | 26709 | 03:25:33 INFO - PROCESS | 26709 | [#4] audio-oscillator Cycles:10 Average:98.10 Median:85.00 stddev:20.64 (24.3%) stddev-sans-first:21.42 03:25:33 INFO - PROCESS | 26709 | Values: 86.0 84.0 125.0 85.0 87.0 86.0 123.0 85.0 85.0 135.0 03:25:33 INFO - PROCESS | 26709 | 03:25:33 INFO - PROCESS | 26709 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:25:33 INFO - PROCESS | 26709 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 03:25:33 INFO - PROCESS | 26709 | 03:25:33 INFO - PROCESS | 26709 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 03:25:33 INFO - PROCESS | 26709 | Values: 146.0 148.0 146.0 145.0 146.0 147.0 147.0 147.0 146.0 147.0 03:25:33 INFO - PROCESS | 26709 | 03:25:33 INFO - PROCESS | 26709 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 03:25:33 INFO - PROCESS | 26709 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 03:25:33 INFO - PROCESS | 26709 | 03:25:33 INFO - PROCESS | 26709 | [#8] json-parse-financial Cycles:10 Average:61.90 Median:62.00 stddev:0.74 (1.2%) stddev-sans-first:0.67 03:25:33 INFO - PROCESS | 26709 | Values: 63.0 62.0 62.0 62.0 62.0 63.0 61.0 62.0 61.0 61.0 03:25:33 INFO - PROCESS | 26709 | 03:25:33 INFO - PROCESS | 26709 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 03:25:33 INFO - PROCESS | 26709 | Values: 66.0 65.0 65.0 65.0 66.0 66.0 65.0 66.0 66.0 67.0 03:25:33 INFO - PROCESS | 26709 | 03:25:33 INFO - PROCESS | 26709 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:80.50 stddev:2.16 (2.7%) stddev-sans-first:2.26 03:25:33 INFO - PROCESS | 26709 | Values: 82.0 79.0 81.0 80.0 80.0 80.0 79.0 80.0 86.0 83.0 03:25:33 INFO - PROCESS | 26709 | 03:25:33 INFO - PROCESS | 26709 | [#11] stanford-crypto-ccm Cycles:10 Average:136.00 Median:132.00 stddev:15.19 (11.5%) stddev-sans-first:16.04 03:25:33 INFO - PROCESS | 26709 | Values: 132.0 128.0 134.0 130.0 132.0 131.0 131.0 131.0 179.0 132.0 03:25:33 INFO - PROCESS | 26709 | 03:25:33 INFO - PROCESS | 26709 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.20 Median:166.00 stddev:2.35 (1.4%) stddev-sans-first:2.26 03:25:33 INFO - PROCESS | 26709 | Values: 168.0 163.0 166.0 164.0 166.0 161.0 166.0 165.0 164.0 169.0 03:25:33 INFO - PROCESS | 26709 | 03:25:33 INFO - PROCESS | 26709 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.50 stddev:1.16 (1.7%) stddev-sans-first:1.22 03:25:33 INFO - PROCESS | 26709 | Values: 66.0 68.0 68.0 67.0 65.0 66.0 67.0 66.0 65.0 65.0 03:25:33 INFO - PROCESS | 26709 | -------- Summary: end -------- 03:25:33 INFO - PROCESS | 26709 | 03:25:34 INFO - TEST-INFO | 26709: exit 0 03:25:34 INFO - TEST-OK | kraken | took 63131ms 03:25:34 INFO - SUITE-END | took 1182s 03:25:34 INFO - Completed test suite (00:19:42) 03:25:34 INFO - javascript benchmark 03:25:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2586.8318559293643, 2588.327034970907, 2618.1752747884416, 2622.9344266393327, 2628.7502687244705, 4623.953760462395, 4735.171345014617, 4740.0, 4757.0723708876785, 4758.2862570614425, 4699.788509517071, 4757.595604373632, 4763.595094416979, 4792.83225087122, 4852.660313778037, 4295.570442955711, 4319.913601727979, 4361.323994780814, 4397.296432570789, 4500.234960056782, 4320.395144679747, 4421.867343979686, 4446.088551846879, 4451.465824101097, 4502.594766471017, 4277.786110694453, 4325.394444777734, 4379.890502737425, 4393.231184542692, 4445.84439544616, 4276.444062271885, 4342.044750154961, 4356.847510337123, 4363.934540981888, 4404.69167158299, 4313.245182093121, 4335.848245311399, 4338.739675619473, 4369.6722745794195, 4379.364992076131, 4641.976790116061, 4750.239961606127, 4750.4299484061785, 4775.952240477585, 4823.083614113307, 5036.395632524084, 5077.746112694351, 5103.336566246401, 5183.196604526304, 5184.585233181374, 5159.17453207485, 5205.24523944026, 5212.609054320903, 5222.0, 5223.608229382811, 4812.326274321597, 4824.855254342376, 4860.756962151878, 4875.829345972909, 4877.073356062408, 5029.4719054498755, 5082.186850103965, 5147.0, 5190.766415511311, 5207.817726379559, 5010.674306170087, 5019.498050195024, 5056.646034777604, 5065.214891691794, 5068.619853511002, 5094.898102037939, 5141.357330333708, 5145.4597267287145, 5151.175811870157, 5152.02111598795, 4900.607951363882, 4998.050370429607, 5024.095662780662, 5037.69773813565, 5057.291979122926, 5046.066477701637, 5053.69677819332, 5054.671446355975, 5056.772445239973, 5091.210862316347, 4270.48754149504, 4308.849190278388, 4309.181255561433, 4344.869653910388, 4355.063661312833, 3665.486831843544, 3721.5348081489815, 3728.515293011891, 3752.4558938954247, 3754.662080412776, 4402.581754733295, 4407.074514351958, 4432.268675668543, 4438.911221775611, 4456.376107344974, 5130.300056294785, 5136.0, 5142.074426603247, 5146.2280657900865, 5175.06848767218, 4217.8523751668545, 4338.262495375794, 4368.170047690928, 4392.363107349481, 4451.488078870972, 4561.908761824745, 4582.495925448198, 4609.492955774862, 4626.560476754703, 4632.536746325341, 4816.060868130821, 4817.662763606514, 4818.301346304836, 4823.397075365579, 4869.342638743866, 4943.530364615356, 4988.5260900214425, 5030.496950304941, 5093.083245015932, 5099.209622508517, 4767.547083027107, 4798.184308667465, 4807.567318941312, 4813.518648135158, 4820.8794780130775, 4992.950070499249, 4996.075725990703, 4996.480297152907, 4997.150484417731, 5040.395152581567, 4927.01459708067, 5061.9493805061475, 5077.543021128116, 5080.771365288497, 5125.7693403796175, 4846.80612775485, 4873.293372460902, 4895.33912921751, 4919.458859525378, 4963.354763880672, 4899.926501102557, 4916.655834091579, 4917.483664215349, 4919.2129259318335, 4964.255361695775, 4723.409573803275, 4832.927506087482, 4838.491958344323, 4848.296996935495, 4898.632602554751, 4885.731284779371, 4933.506649335038, 4957.231629097496, 4961.8015279389865, 5033.773480193473, 4865.927011094907, 4870.805167793249, 4872.098661747588, 4872.878178045436, 4923.606111510999], "value": 4665.505984917654, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.8746275819319, 572.7708916433426, 586.2554555714246, 587.3480436715246, 594.1651978969546, 26995.865020674893, 29593.0, 29730.55404168934, 29743.702562974362, 29769.255768605795, 30284.09147725566, 40432.0, 41379.17241655165, 41462.792686036526, 44930.550694493126, 7576.77269681909, 7686.0, 7691.077070751489, 7692.423068269874, 7693.30760231579, 7660.463767536275, 7743.148253692118, 7749.186335434782, 7752.147263800977, 7756.146823849372, 7651.502652327608, 7680.231976802303, 7680.8094745314565, 7715.614219289013, 7724.6137693115115, 7592.886106708376, 7631.427642926803, 7638.236176382373, 7640.885386719176, 7648.502847314907, 7588.544687318723, 7647.770566883002, 7680.231976802275, 7689.5001824881765, 7697.461177717562, 38371.424428633596, 38400.807995960124, 38449.0, 38812.0, 38846.80576597127, 2977.136630377188, 3007.6090108286003, 3445.5176275321473, 3481.756277060607, 3602.4056030754896, 28343.0, 28733.42533149346, 29164.562531562042, 29199.708002920124, 29295.85352073226, 3418.1625501751982, 3542.468629705539, 3597.964020359789, 3623.2572322673786, 3650.9269814603826, 242526.0, 242565.0, 243922.0, 244367.0, 244638.0, 51882.48117518852, 52260.738696306275, 52266.0, 52440.0, 52472.47527524676, 54002.459975399746, 54324.72837635787, 54469.45530544644, 54546.0, 54554.727226364404, 13877.167369957835, 13932.0, 14020.298985050707, 14031.508897188549, 14041.087329323562, 11199.608013719644, 11211.831822522669, 11238.269512481662, 11262.605808796652, 11267.54929802815, 16192.514224573282, 16203.136639286397, 16350.509484715478, 16507.752383714254, 16605.252763625667, 5510.1459273812625, 5613.775448982076, 5657.8019769307875, 5742.483176514133, 5810.854728631733, 777.6345117794627, 869.4305230074311, 870.0516437083609, 874.2961915657829, 892.5269607108243, 26588.0, 28061.719382806317, 28263.43473130526, 28650.570241446396, 28739.712602873704, 775.9806004849924, 949.159993405827, 985.1380042462845, 1001.8246806808925, 1013.6198925402974, 14371.78442323366, 15018.0, 15263.923680381527, 15465.536033919001, 15528.5341439757, 383992.0, 385581.0, 385698.0, 387577.0, 388323.0, 50483.49516504861, 50920.49079509157, 50928.74535627298, 51171.48828511742, 51231.48768512267, 1038.7143535527791, 1108.9611863584735, 1147.0995268714018, 1162.7093226693328, 1191.9642410727517, 25701.3574660635, 28821.42357152887, 29418.09378642463, 29465.0, 29979.550306745852, 41439.7928010358, 41513.1697366045, 41771.0, 41800.79099604482, 41829.372559412244, 295913.0, 298059.0, 298187.0, 298318.0, 298354.0, 24272.0, 24911.62632560549, 25171.0, 26488.205353838646, 34652.65347346595, 41214.38178427386, 41246.0, 41821.58178418177, 42447.3632895513, 42811.7859410701, 36214.27571448503, 36337.0, 36411.08972275714, 36757.63242367542, 37317.81341093277, 36133.63866361408, 36563.63436365602, 37842.0, 38447.0, 40762.59237407588, 34368.312633747686, 34452.82773586116, 35205.0, 36168.81915590405, 36541.08647283839, 30764.538531922488, 33461.665383345855, 33477.83261083679, 33620.0, 33848.49227261544, 24635.876820615784, 24830.25509234726, 24950.750492494844, 25102.0, 25218.24345269645], "value": 17197.146133462982, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.82583477424595, 364.9324874898144, 369.80585192773776, 374.2925870105501, 393.2312329396031, 12674.42965066572, 15963.361465541378, 16244.350225990976, 16304.103274319908, 17291.567710807205, 16179.271932763024, 16849.241784119713, 17634.82365176348, 17772.0, 17836.821631783678, 4953.603711703073, 4964.70211787293, 5100.15847385181, 5119.641625086246, 5120.334356533645, 3742.4573436851642, 5062.9240561391425, 5143.3570803649545, 5576.275084239063, 5882.5588080893895, 5863.208466856962, 5877.089051197071, 5880.088586269114, 5906.23218981534, 5908.4091590841, 5079.568236699885, 5355.250264962909, 5383.73081345935, 5387.515123638852, 5881.2354393928945, 5241.659292145999, 5247.317848679685, 5281.260623512711, 5287.074761916688, 5292.470752924715, 11479.48342324589, 16159.596010099724, 21014.0, 21200.045997929978, 21539.8923005384, 1823.3709370267236, 1901.7052356884706, 1956.7064940258933, 1976.7924367941446, 2301.9309420717404, 8814.955925220396, 8822.955885220597, 9231.076892310783, 9385.202257808094, 9424.670136545257, 1691.9492415227562, 1745.380389961558, 1748.4055421156868, 1752.2640490993813, 1756.5696404381008, 66974.66512667455, 69580.6520967397, 71718.18677225655, 73247.63376183138, 74984.25015749827, 9459.337846350689, 9502.762430939281, 9965.252606054575, 9983.101520863158, 10041.497925103715, 13566.796498052538, 13769.0, 13769.105008174436, 13850.307484625728, 13873.306334683226, 7048.224695283515, 7141.296575832265, 7170.354668079898, 7221.89167162493, 7245.203027666952, 6607.174103237096, 6962.582245065312, 7064.646767661597, 7331.706731730671, 7378.704851805975, 4199.9370009449885, 4345.261305578059, 4365.672574556857, 4482.327650852399, 4507.121111383249, 1806.4219449776208, 1828.3052440072688, 1828.8628352873322, 1873.5222518258029, 1881.5296175956012, 671.2649648634737, 707.9929200707927, 792.8850316704046, 807.2250639386255, 847.9660813567389, 15404.229788510529, 16240.51278461648, 16326.428574999818, 16504.83495165057, 16702.749458758128, 810.5541951926534, 835.8035861572525, 840.9369297302604, 864.4813112132796, 886.8802711633847, 9451.621935122517, 9610.231181505464, 9816.36193647425, 9842.458664773363, 9991.550380232908, 357258.0, 380557.0, 392368.0, 393144.0, 394652.0, 46635.0, 47988.0, 48535.51464485381, 64513.677431612545, 79751.60124199458, 873.2315562305131, 889.5596679643618, 890.5947793753827, 890.9599068041954, 894.1639567004871, 14575.0, 14904.850951490347, 15117.16855572954, 15154.0, 15769.44806931752, 37284.25431491301, 38339.04152396212, 39255.2148957025, 39449.0413219004, 39660.80169599134, 48902.26646600233, 52353.0, 53576.19635705546, 54085.72957135189, 54172.18741718956, 10080.294379393665, 10495.790084198426, 10911.454427278763, 11064.225504214628, 11320.830187547028, 12505.187162834387, 12535.0, 12589.874101259236, 12672.176308539916, 12841.871581284067, 10992.340459572451, 11002.669919902415, 11114.555417783198, 11367.943160284145, 11541.942290288494, 10341.224408169266, 11065.612703555336, 11158.274712143684, 11298.548058077586, 11349.546018159512, 11123.555057797921, 11229.0, 11275.210735248455, 11559.711007224887, 11685.123615728684, 10808.45957702096, 10870.021698047214, 10945.781084378108, 11001.17491188148, 11634.360110193682, 7499.850003000019, 7643.5796031218815, 7826.608669566385, 7946.125926148235, 11479.885201147881], "value": 8275.406492115742, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1332.6401871494693, 1402.256803893936, 1408.3451195194236, 1631.5676345768381, 1669.9916500417503, 7672.271134242245, 8266.4626799258, 8269.131741167173, 8273.710420135296, 8290.461120027201, 6953.756618518353, 7192.3167299106635, 7665.8850117248285, 7975.680972761083, 8103.473274237185, 2222.9888850555767, 2252.5720113178527, 2253.481699209183, 2254.8083412909923, 2255.785700358463, 2214.1364867701527, 2240.305505293364, 2242.663600459936, 2244.9663255051187, 2252.4594097416666, 1849.4451664500664, 2106.1575369852103, 2182.2471247419617, 2183.3122566391617, 2184.7159869217057, 2216.958029726034, 2239.955200895989, 2258.4241018540333, 2259.819214462839, 2261.2424837679396, 2202.7246594175726, 2208.436848603612, 2208.4810069633786, 2213.8118259947923, 2213.822894168463, 7973.601319934038, 8008.919910800876, 8011.399145064085, 8017.158198389144, 8020.759377218635, 4560.817567297304, 4657.4411070671395, 4678.836240731592, 4733.715977041354, 4740.952590474086, 2889.1477014280836, 3038.270815004383, 3040.6047213862275, 3042.3306872488015, 3049.573059771634, 869.8738682891009, 920.098303662408, 923.2152670230317, 933.5938866593053, 945.8202941441104, 11124.38815865127, 11150.66548003553, 11155.442227888572, 11166.944165279121, 11175.776484470265, 4074.8166332515107, 4290.935635965463, 4424.6902716810155, 4429.822807087745, 4437.423134992495, 9526.761830954143, 9532.618695252113, 9537.093976072261, 9539.666111686196, 9544.713658590254, 4823.903521929542, 4825.9034819303415, 4826.0, 4827.565519103227, 4829.73436460998, 4320.783960801948, 4373.343998400265, 4382.802773875183, 4385.035292235703, 4398.186335527937, 3595.658412450813, 3609.8917032489067, 3708.072981754561, 3727.422249551324, 3753.9624603753614, 1197.4072833947253, 1224.7856625090574, 1226.816122441848, 1233.7039110613568, 1248.5005997601031, 613.828128124126, 701.5019336271305, 706.9469789765789, 782.1787123520281, 819.4223072733708, 4847.3698419205275, 4874.5856602189215, 4926.581240594518, 5002.924956125661, 5057.988402319551, 836.7198186774245, 837.459838404238, 840.878072679458, 849.541247726221, 862.7325529086004, 3397.11674964511, 3589.8743543975834, 3590.784552926833, 3670.46778217157, 3679.742418030712, 9280.535973201313, 10098.848517272247, 10113.797724045626, 10120.949395252977, 10148.188144948534, 9835.409875407498, 10040.949795250977, 10071.848922266172, 10088.49557522121, 10099.899001009895, 7155.427565794724, 7177.89233161503, 7178.533395329287, 7227.494075414776, 7233.782986510413, 4996.675216110941, 5028.661672322388, 5119.667221630582, 5208.765605547836, 5218.843434696965, 9144.405613635092, 9169.862452063091, 9204.125608067223, 9280.95359523198, 9306.208972237166, 9311.510158374627, 9453.101955314234, 9464.858027129736, 9470.19503342196, 9521.095495927875, 6824.522283440111, 6829.351211634887, 6843.692033858588, 6865.176178858569, 6916.20463646687, 7620.657070431733, 7687.769366919001, 7689.9615501922135, 7697.846043079219, 7707.152213256425, 6853.417459515797, 6941.271166527442, 6998.860022799618, 7014.473914456538, 7220.350168484862, 6669.266380698216, 6813.0, 6814.488913331619, 6821.2155602106395, 6822.795316140524, 6450.387213214737, 6470.352964703492, 6549.0, 6607.0, 6615.106960560455, 4415.492218394926, 4639.141758774503, 4652.837150699709, 4667.836625718083, 4824.831130910401, 4541.704789188824, 4584.564466375689, 4613.769311534477, 4800.5199480051715, 4834.927476087792], "value": 4199.135421177, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.6363182390188, 288.86134655365413, 302.12835968231644, 303.31450920918746, 311.71789530474916, 4661.277501987189, 4796.376471058767, 4816.181249187638, 4838.758062096895, 4848.587870031047, 4588.77056147193, 4727.243641017438, 4736.786844591993, 4767.761611919407, 4803.111424386491, 3804.5624753153465, 3812.4471951567007, 3818.904527386817, 3819.2049736623744, 3819.7776711452348, 3610.620884807097, 3614.493970844084, 3810.6951443884564, 3819.3698039823394, 3819.8472061117523, 3776.8678096266635, 3782.186829831586, 3783.735138540303, 3785.129420233348, 3802.1065049713297, 3760.5863355030924, 3770.1140232045445, 3771.1326394929183, 3776.603456637055, 3777.4333849922455, 3334.299797042624, 3339.1151344893624, 3340.04607304727, 3345.5483509726364, 3352.2122301259183, 4579.977100114512, 4688.765561721934, 4696.084263568606, 4697.694649847783, 4700.670953033289, 4264.317709166549, 4280.186764514763, 4301.075268817203, 4305.052888364586, 4314.870553883357, 5008.824691135793, 5014.824481143142, 5015.297858299841, 5024.03581886685, 5030.8239211627415, 3555.2356243407535, 3606.647507184806, 3619.0952261934517, 3656.945145822815, 3666.6699997000396, 5227.869303267411, 5230.529252367267, 5234.7644356004075, 5244.239585260116, 5249.002689489023, 3724.273766615484, 3737.383331750285, 3737.719671024684, 3738.27103714773, 3745.250949810049, 3787.6401741834484, 3789.8673546425744, 3794.2790869734663, 3829.1384438501113, 3841.2893614681375, 4206.8737937861915, 4254.510731265882, 4267.850625228102, 4280.229558679468, 4334.9783251083545, 4981.850544483671, 4982.202847544376, 4982.451930287665, 5021.874453138701, 5022.874428139326, 1241.8323526323832, 1267.8225048493218, 1297.4356155072574, 1310.194230548225, 1323.2854258700386, 893.5130353957109, 914.6615752171606, 918.6004088221645, 920.1718453391867, 921.9769505762409, 4368.322909948963, 4374.693771435969, 4386.385905973167, 4408.801603927831, 4431.8448854289945, 5129.999650068201, 5140.46025167352, 5142.280080788692, 5147.56245719118, 5155.407128180307, 4271.654428854963, 4372.366006929041, 4386.385905973167, 4413.404190434315, 4420.403245561873, 2387.7970372518184, 2408.9156879509133, 2432.2581612608324, 2433.282181756351, 2435.829491935583, 4272.850450234289, 4291.635211007099, 4304.612584867377, 4315.417418648505, 4340.739555626673, 4363.3018717005125, 4636.327732478839, 4665.95334046662, 4670.322803193586, 4678.7660616969015, 4290.249206388869, 4308.849190278325, 4309.870703878889, 4325.978370108192, 4340.350666746616, 4522.208613492559, 4565.406497155349, 4581.5647513486165, 4585.234684646502, 4616.8614941551805, 4298.333758267474, 4444.4666640002115, 4464.955350446454, 4465.240909045405, 4528.388667529973, 4288.892777680583, 4300.268954277718, 4304.849330273551, 4307.39696442492, 4311.913761724811, 3345.314210586775, 3366.4781958796425, 3375.561177046968, 3379.2396710739886, 3408.6080100787735, 4342.869713908588, 4527.52563833721, 4537.478190008192, 4540.250858608425, 4552.135094332067, 4397.274449715761, 4425.601695847389, 4460.353248778844, 4476.753778542081, 4480.820767169277, 4400.69195156336, 4432.778361081998, 4438.312061630452, 4446.48819401405, 4476.216662084187, 4350.390945267728, 4368.759718215529, 4398.0, 4721.763911804464, 4867.70793752376, 4975.114433628559, 5052.8989420210655, 5070.239464080418, 5071.797128114834, 5086.872828179326, 4978.415540810611, 4991.9500804991485, 4992.80028798844, 4996.700197987987, 5000.499950004971], "value": 3660.2237523787567, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.6421893192482, 626.7618305044083, 631.6241836107514, 717.5192620943967, 721.2318880392378, 11938.880611193885, 12982.09125361225, 12999.74000519989, 13051.673708157288, 13081.869181308184, 12491.687707807308, 12624.873751262485, 12638.936805315983, 12653.17754345967, 12655.873441265585, 614.8370681769335, 719.9784006479814, 743.0414764953204, 750.0774047921046, 771.7106085218044, 749.9100107987022, 757.9658915348823, 758.4614923404389, 758.4842307231081, 758.962051897403, 798.6805277888833, 801.310872649521, 802.8033131882697, 806.6249194124731, 806.8628333183343, 632.9208848893911, 765.8659734546432, 791.8020494876281, 794.8171920458298, 796.4106561144769, 583.4777873802923, 585.9238299021142, 586.8180863932153, 593.5904226084032, 596.3470000349611, 12307.815382769266, 12312.81530777039, 12343.876561234363, 12347.506099756, 12348.012159027256, 11643.534258629645, 11742.354170520617, 11986.64040078799, 12185.207961482476, 12419.254844709347, 11233.775324493465, 11358.60244891425, 11478.483468243949, 11613.419329033515, 11635.0, 4005.2790497710403, 4026.476558047435, 4046.7167298289132, 4089.2434899543678, 4115.855945041939, 58418.70790646062, 58718.41281587172, 58833.0, 58888.0, 59123.704381478245, 9244.95377523108, 9249.12133347331, 9272.814543709088, 9327.207187389147, 9469.156378806263, 18097.909510452628, 18308.725369119475, 18394.816051839578, 18557.90721046386, 18613.627727445375, 6115.052166914135, 6152.477039451696, 6210.347913469021, 6356.523260755462, 6365.267994180728, 3550.2012047289154, 3565.6612621800887, 3583.3549961006747, 3588.8743893963588, 3601.837917293728, 2735.179446166182, 2829.773618110546, 2835.050258163497, 3254.7558933080113, 3428.6057103432927, 578.3955766224306, 580.5413723158741, 581.7265885034027, 591.9223525425787, 595.1429940885198, 443.8379991303216, 515.7859488312383, 527.1776029394157, 531.9601029922771, 537.965032272901, 7069.92930070703, 7073.82315442118, 7443.627818609156, 7531.435142364345, 7779.533228006338, 559.0914763509297, 563.9407862174413, 566.9574781891292, 579.8347470970754, 589.8911391774424, 3521.9471707924404, 3682.797446140434, 3694.538182727159, 3725.6790406850128, 3865.6520913117392, 59653.10520342198, 61199.08201376983, 61635.0, 62104.37895621076, 62251.377486225465, 89554.0, 89616.0, 91772.0, 93431.0, 94118.0, 50423.71398431101, 80799.0, 81230.59384703157, 81855.9999999988, 82718.58640706878, 6879.484038697017, 6995.148333731036, 7156.570605763671, 7270.200277969313, 7314.469561936278, 45859.54140458553, 47227.29159062685, 47244.0, 47630.761846191934, 48673.0, 63215.6839215801, 63390.68304658447, 70130.29869701237, 70360.64819675869, 71059.28940710734, 9449.763755905882, 9800.264980126376, 9927.851082233628, 10078.244131690299, 10195.490225488547, 11054.613088541862, 11086.556537738723, 11605.361705106301, 11689.298642081503, 11728.76542469163, 9151.496667683341, 9447.716568502956, 9554.713358599252, 9755.122039016522, 9790.608375664893, 10024.14794742455, 10195.949020254851, 10442.63450779219, 10468.110210632181, 10732.087772539422, 9487.525623718648, 9513.857292140485, 9606.855897161407, 9745.756356091155, 9976.900230997597, 8740.91259087401, 8936.642534298815, 8950.194482496607, 8956.507392093497, 8981.730548083568, 8172.632231549475, 8552.102029286836, 8621.310295176245, 8628.439151455135, 8765.66009483404], "value": 6215.150569516027, "unit": "score"}], "name": "dromaeo_css", "value": 6315.178486991182, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 112.0, 113.0, 112.0, 113.0, 112.0, 113.0, 114.0, 113.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 122.0, 124.0, 174.0, 123.0, 127.0, 149.0, 124.0, 161.0, 122.0], "value": 136.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 160.0, 162.0, 162.0, 163.0, 161.0, 161.0, 161.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 118.0, 75.0, 78.0, 75.0, 76.0, 105.0, 74.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 125.0, 85.0, 87.0, 86.0, 123.0, 85.0, 85.0, 135.0], "value": 98.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 145.0, 146.0, 147.0, 147.0, 147.0, 146.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 62.0, 62.0, 63.0, 61.0, 62.0, 61.0, 61.0], "value": 61.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 65.0, 66.0, 66.0, 65.0, 66.0, 66.0, 67.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 79.0, 81.0, 80.0, 80.0, 80.0, 79.0, 80.0, 86.0, 83.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 128.0, 134.0, 130.0, 132.0, 131.0, 131.0, 131.0, 179.0, 132.0], "value": 136.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 163.0, 166.0, 164.0, 166.0, 161.0, 166.0, 165.0, 164.0, 169.0], "value": 165.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 68.0, 67.0, 65.0, 66.0, 67.0, 66.0, 65.0, 65.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1525.5, "alertThreshold": 2.0}]} 03:25:34 INFO - Return code: 0 03:25:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:25:34 INFO - # TBPL SUCCESS # 03:25:34 INFO - Running post-action listener: _resource_record_post_action 03:25:34 INFO - [mozharness: 2016-07-25 10:25:34.450387Z] Finished run-tests step (success) 03:25:34 INFO - Running post-run listener: _resource_record_post_run 03:25:34 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 542773248; Read time: 4; Write time: 441252 03:25:34 INFO - TinderboxPrint: CPU usage
13.0% 03:25:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 03:25:34 INFO - TinderboxPrint: I/O write bytes / time
542,773,248 / 441,252 03:25:34 INFO - TinderboxPrint: CPU idle
8,320.2 (86.9%) 03:25:34 INFO - TinderboxPrint: CPU user
1,204.5 (12.6%) 03:25:34 INFO - TinderboxPrint: Swap in / out
0 / 0 03:25:34 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 254050304; Read time: 0; Write time: 226468 03:25:34 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 288722944; Read time: 0; Write time: 214784 03:25:35 INFO - Running post-run listener: _upload_blobber_files 03:25:35 INFO - Blob upload gear active. 03:25:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:25:35 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 03:25:35 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:25:35 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:25:35 INFO - (blobuploader) - INFO - Open directory for files ... 03:25:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:25:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:25:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:25:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:25:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:25:36 INFO - (blobuploader) - INFO - Done attempting. 03:25:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:25:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:25:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:26:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:26:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:26:02 INFO - (blobuploader) - INFO - Done attempting. 03:26:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:26:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:26:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:26:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:26:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:26:03 INFO - (blobuploader) - INFO - Done attempting. 03:26:03 INFO - (blobuploader) - INFO - Iteration through files over. 03:26:03 INFO - Return code: 0 03:26:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:26:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:26:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f9f1d6e68c4991e6075048fc3fbe70b855345071107281aa1f16711e28b66eebea6252b6a4e30e81564173042b0056c95a721a2671957b1eb6b2cb96e06fb689", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6e0d0edb8a672287297a4c87d1fb3781d2f0f5426cf00e1a831b067ed3c369982fc28393ecbcd2adfd7ed001547da152a098a59bf05d271f8a8778e546c7bafb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/73341af34b853c1677839508346d5164e368bedfd1f04d4978c794200067fb9be591be82e8880f0c945a81546c6d4b512b3782a64a8035c7646d5d84774bd66b"} 03:26:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:26:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:26:03 INFO - Contents: 03:26:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f9f1d6e68c4991e6075048fc3fbe70b855345071107281aa1f16711e28b66eebea6252b6a4e30e81564173042b0056c95a721a2671957b1eb6b2cb96e06fb689", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6e0d0edb8a672287297a4c87d1fb3781d2f0f5426cf00e1a831b067ed3c369982fc28393ecbcd2adfd7ed001547da152a098a59bf05d271f8a8778e546c7bafb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/73341af34b853c1677839508346d5164e368bedfd1f04d4978c794200067fb9be591be82e8880f0c945a81546c6d4b512b3782a64a8035c7646d5d84774bd66b"} 03:26:03 INFO - Running post-run listener: copy_logs_to_upload_dir 03:26:03 INFO - Copying logs to upload dir... 03:26:03 INFO - mkdir: /builds/slave/test/build/upload/logs 03:26:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.177137 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-07-25 03:26:03.053554) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 03:26:03.056818) ========= 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=31acecf42b6a79ec49471d4a000001bb-1469440043.521273-711304373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f9f1d6e68c4991e6075048fc3fbe70b855345071107281aa1f16711e28b66eebea6252b6a4e30e81564173042b0056c95a721a2671957b1eb6b2cb96e06fb689", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6e0d0edb8a672287297a4c87d1fb3781d2f0f5426cf00e1a831b067ed3c369982fc28393ecbcd2adfd7ed001547da152a098a59bf05d271f8a8778e546c7bafb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/73341af34b853c1677839508346d5164e368bedfd1f04d4978c794200067fb9be591be82e8880f0c945a81546c6d4b512b3782a64a8035c7646d5d84774bd66b"} build_url:https://queue.taskcluster.net/v1/task/Mh7OTCL7Qvmi2Otybg3DXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011253 build_url: 'https://queue.taskcluster.net/v1/task/Mh7OTCL7Qvmi2Otybg3DXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f9f1d6e68c4991e6075048fc3fbe70b855345071107281aa1f16711e28b66eebea6252b6a4e30e81564173042b0056c95a721a2671957b1eb6b2cb96e06fb689", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6e0d0edb8a672287297a4c87d1fb3781d2f0f5426cf00e1a831b067ed3c369982fc28393ecbcd2adfd7ed001547da152a098a59bf05d271f8a8778e546c7bafb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/73341af34b853c1677839508346d5164e368bedfd1f04d4978c794200067fb9be591be82e8880f0c945a81546c6d4b512b3782a64a8035c7646d5d84774bd66b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 03:26:03.085317) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 03:26:03.085696) ========= 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=31acecf42b6a79ec49471d4a000001bb-1469440043.521273-711304373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004429 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 03:26:03.166998) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 03:26:03.167315) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 03:26:03.170685) ========= ========= Total master_lag: 0.21 =========