builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-046 starttime: 1469573514.54 results: success (0) buildid: 20160726130804 builduid: 509f013c286a422d98c4a0595a681091 revision: efc0b2d797abeb7624071731e6cb25704b502bae ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 15:51:54.540683) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 15:51:54.541160) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 15:51:54.541486) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 15:51:54.560907) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 15:51:54.561161) ========= 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=652eb03db935cfc1c15ebda0000001ad-1469573423.216979-763374323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-26 15:51:54-- 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% 21.2M=0.001s 2016-07-26 15:51:54 (21.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094886 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 15:51:54.671062) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 15:51:54.671400) ========= 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=652eb03db935cfc1c15ebda0000001ad-1469573423.216979-763374323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015553 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 15:51:54.721329) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 15:51:54.723409) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev efc0b2d797abeb7624071731e6cb25704b502bae --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 efc0b2d797abeb7624071731e6cb25704b502bae --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=652eb03db935cfc1c15ebda0000001ad-1469573423.216979-763374323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-26 15:51:54,961 truncating revision to first 12 chars 2016-07-26 15:51:54,961 Setting DEBUG logging. 2016-07-26 15:51:54,961 attempt 1/10 2016-07-26 15:51:54,961 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/efc0b2d797ab?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-26 15:51:55,590 unpacking tar archive at: autoland-efc0b2d797ab/testing/mozharness/ program finished with exit code 0 elapsedTime=0.944151 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 15:51:55.681183) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 15:51:55.681570) ========= script_repo_revision: efc0b2d797abeb7624071731e6cb25704b502bae ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 15:51:55.681972) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 15:51:55.683066) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 15:51:55.693058) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-26 15:51:55.693385) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=652eb03db935cfc1c15ebda0000001ad-1469573423.216979-763374323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:51:56 INFO - MultiFileLogger online at 20160726 15:51:56 in /builds/slave/test 15:51:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 15:51:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:51:56 INFO - {'append_to_log': False, 15:51:56 INFO - 'base_work_dir': '/builds/slave/test', 15:51:56 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 15:51:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:51:56 INFO - 'branch': 'Autoland-Non-PGO', 15:51:56 INFO - 'buildbot_json_path': 'buildprops.json', 15:51:56 INFO - 'config_files': ('talos/linux_config.py',), 15:51:56 INFO - 'default_actions': ('clobber', 15:51:56 INFO - 'read-buildbot-config', 15:51:56 INFO - 'download-and-extract', 15:51:56 INFO - 'populate-webroot', 15:51:56 INFO - 'create-virtualenv', 15:51:56 INFO - 'install', 15:51:56 INFO - 'run-tests'), 15:51:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:51:56 INFO - 'download_minidump_stackwalk': True, 15:51:56 INFO - 'download_symbols': 'ondemand', 15:51:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:51:56 INFO - 'tooltool.py': '/tools/tooltool.py', 15:51:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:51:56 INFO - '/tools/misc-python/virtualenv.py')}, 15:51:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:51:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:51:56 INFO - 'installer_path': 'installer.exe', 15:51:56 INFO - 'log_level': 'info', 15:51:56 INFO - 'log_name': 'talos', 15:51:56 INFO - 'log_to_console': True, 15:51:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:51:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:51:56 INFO - 'opt_config_files': (), 15:51:56 INFO - 'pip_index': False, 15:51:56 INFO - 'sps_profile': False, 15:51:56 INFO - 'sps_profile_interval': 0, 15:51:56 INFO - 'suite': 'dromaeojs-e10s', 15:51:56 INFO - 'system_bits': '32', 15:51:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:51:56 INFO - 'title': 'talos-linux64-ix-046', 15:51:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:51:56 INFO - 'use_talos_json': True, 15:51:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:51:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:51:56 INFO - 'work_dir': 'build'} 15:51:56 INFO - [mozharness: 2016-07-26 22:51:56.014992Z] Running clobber step. 15:51:56 INFO - Running pre-action listener: _resource_record_pre_action 15:51:56 INFO - Running main action method: clobber 15:51:56 INFO - rmtree: /builds/slave/test/build 15:51:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:51:56 INFO - Running post-action listener: _resource_record_post_action 15:51:56 INFO - [mozharness: 2016-07-26 22:51:56.491378Z] Finished clobber step (success) 15:51:56 INFO - [mozharness: 2016-07-26 22:51:56.491477Z] Running read-buildbot-config step. 15:51:56 INFO - Running pre-action listener: _resource_record_pre_action 15:51:56 INFO - Running main action method: read_buildbot_config 15:51:56 INFO - Using buildbot properties: 15:51:56 INFO - { 15:51:56 INFO - "project": "", 15:51:56 INFO - "product": "firefox", 15:51:56 INFO - "script_repo_revision": "production", 15:51:56 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 15:51:56 INFO - "repository": "", 15:51:56 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 15:51:56 INFO - "buildid": "20160726130804", 15:51:56 INFO - "pgo_build": "False", 15:51:56 INFO - "basedir": "/builds/slave/test", 15:51:56 INFO - "buildnumber": 192, 15:51:56 INFO - "slavename": "talos-linux64-ix-046", 15:51:56 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:51:56 INFO - "platform": "ubuntu64_hw", 15:51:56 INFO - "scheduler": "tests-autoland-linux64-talos", 15:51:56 INFO - "branch": "autoland", 15:51:56 INFO - "repo_path": "integration/autoland", 15:51:56 INFO - "revision": "efc0b2d797abeb7624071731e6cb25704b502bae", 15:51:56 INFO - "stage_platform": "linux64", 15:51:56 INFO - "builduid": "509f013c286a422d98c4a0595a681091", 15:51:56 INFO - "slavebuilddir": "test" 15:51:56 INFO - } 15:51:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/bHSlaVTgTZirJK64MneoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 15:51:56 INFO - Running post-action listener: _resource_record_post_action 15:51:56 INFO - [mozharness: 2016-07-26 22:51:56.493921Z] Finished read-buildbot-config step (success) 15:51:56 INFO - [mozharness: 2016-07-26 22:51:56.494011Z] Running download-and-extract step. 15:51:56 INFO - Running pre-action listener: _resource_record_pre_action 15:51:56 INFO - Running main action method: download_and_extract 15:51:56 INFO - mkdir: /builds/slave/test/build/tests 15:51:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:56 INFO - https://queue.taskcluster.net/v1/task/bHSlaVTgTZirJK64MneoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:51:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHSlaVTgTZirJK64MneoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:51:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHSlaVTgTZirJK64MneoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:51:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHSlaVTgTZirJK64MneoKg/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 15:51:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHSlaVTgTZirJK64MneoKg/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 15:51:57 INFO - Downloaded 1361 bytes. 15:51:57 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:51:57 INFO - Using the following test package requirements: 15:51:57 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:51:57 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:51:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:51:57 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:51:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:51:57 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:51:57 INFO - u'jsshell-linux-x86_64.zip'], 15:51:57 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:51:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:51:57 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:51:57 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:51:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:51:57 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:51:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:51:57 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:51:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:51:57 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:51:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:51:57 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:51:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:57 INFO - https://queue.taskcluster.net/v1/task/bHSlaVTgTZirJK64MneoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:51:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHSlaVTgTZirJK64MneoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:51:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHSlaVTgTZirJK64MneoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:51:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHSlaVTgTZirJK64MneoKg/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 15:51:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHSlaVTgTZirJK64MneoKg/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 15:51:58 INFO - Downloaded 22742267 bytes. 15:51:58 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'] 15:51:58 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 15:51:59 INFO - Return code: 0 15:51:59 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 15:51: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')]} 15:51:59 INFO - https://queue.taskcluster.net/v1/task/bHSlaVTgTZirJK64MneoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:51:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHSlaVTgTZirJK64MneoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:51:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHSlaVTgTZirJK64MneoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:51:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHSlaVTgTZirJK64MneoKg/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 15:51:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHSlaVTgTZirJK64MneoKg/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 15:52:02 INFO - Downloaded 22742267 bytes. 15:52:02 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'] 15:52:02 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 15:52:03 INFO - Return code: 0 15:52:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:03 INFO - https://queue.taskcluster.net/v1/task/bHSlaVTgTZirJK64MneoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:52:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHSlaVTgTZirJK64MneoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:52:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHSlaVTgTZirJK64MneoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:52:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHSlaVTgTZirJK64MneoKg/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 15:52:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHSlaVTgTZirJK64MneoKg/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 15:52:04 INFO - Downloaded 14413725 bytes. 15:52:04 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'] 15:52:04 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 15:52:05 INFO - Return code: 0 15:52: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')]} 15:52:05 INFO - https://queue.taskcluster.net/v1/task/bHSlaVTgTZirJK64MneoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:52:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHSlaVTgTZirJK64MneoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:52:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHSlaVTgTZirJK64MneoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:52:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHSlaVTgTZirJK64MneoKg/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 15:52:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHSlaVTgTZirJK64MneoKg/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 15:52:06 INFO - Downloaded 57167918 bytes. 15:52:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bHSlaVTgTZirJK64MneoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:52:06 INFO - mkdir: /builds/slave/test/properties 15:52:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:52:06 INFO - Writing to file /builds/slave/test/properties/build_url 15:52:06 INFO - Contents: 15:52:06 INFO - build_url:https://queue.taskcluster.net/v1/task/bHSlaVTgTZirJK64MneoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:52:06 INFO - Running post-action listener: _resource_record_post_action 15:52:06 INFO - Running post-action listener: set_extra_try_arguments 15:52:06 INFO - [mozharness: 2016-07-26 22:52:06.988728Z] Finished download-and-extract step (success) 15:52:06 INFO - [mozharness: 2016-07-26 22:52:06.988959Z] Running populate-webroot step. 15:52:06 INFO - Running pre-action listener: _resource_record_pre_action 15:52:06 INFO - Running main action method: populate_webroot 15:52:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:52:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:52:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:52:06 INFO - '--tppagecycles', 15:52:06 INFO - '7'], 15:52:06 INFO - 'tests': ['tsvgm']}}, 15:52:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:52:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:52:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:52:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:52:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:52:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:52:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:06 INFO - 'talos_options': ['--disable-e10s'], 15:52:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:52:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:52:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:06 INFO - 'talos_options': ['--disable-e10s'], 15:52:06 INFO - 'tests': ['damp', 'tps']}, 15:52:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:06 INFO - 'tests': ['damp', 'tps']}, 15:52:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:52:06 INFO - 'tests': ['dromaeo_dom']}, 15:52:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:52:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:52:07 INFO - 'tests': ['basic_compositor_video']}, 15:52:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:52:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:52:07 INFO - 'tests': ['a11yr', 15:52:07 INFO - 'ts_paint', 15:52:07 INFO - 'tpaint', 15:52:07 INFO - 'sessionrestore', 15:52:07 INFO - 'sessionrestore_no_auto_restore', 15:52:07 INFO - 'tabpaint']}, 15:52:07 INFO - 'other-e10s': {'tests': ['a11yr', 15:52:07 INFO - 'ts_paint', 15:52:07 INFO - 'tpaint', 15:52:07 INFO - 'sessionrestore', 15:52:07 INFO - 'sessionrestore_no_auto_restore', 15:52:07 INFO - 'tabpaint']}, 15:52:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:52:07 INFO - 'ts_paint', 15:52:07 INFO - 'tpaint', 15:52:07 INFO - 'sessionrestore', 15:52:07 INFO - 'sessionrestore_no_auto_restore', 15:52:07 INFO - 'tabpaint']}, 15:52:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:52:07 INFO - 'ts_paint', 15:52:07 INFO - 'tpaint', 15:52:07 INFO - 'sessionrestore', 15:52:07 INFO - 'sessionrestore_no_auto_restore', 15:52:07 INFO - 'tabpaint']}, 15:52:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:52:07 INFO - 'tests': ['a11yr', 15:52:07 INFO - 'ts_paint', 15:52:07 INFO - 'tpaint', 15:52:07 INFO - 'sessionrestore', 15:52:07 INFO - 'sessionrestore_no_auto_restore', 15:52:07 INFO - 'tabpaint']}, 15:52:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:52:07 INFO - 'tests': ['a11yr', 15:52:07 INFO - 'ts_paint', 15:52:07 INFO - 'tpaint', 15:52:07 INFO - 'sessionrestore', 15:52:07 INFO - 'sessionrestore_no_auto_restore', 15:52:07 INFO - 'tabpaint']}, 15:52:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:52:07 INFO - 'tests': ['tsvgx', 15:52:07 INFO - 'tsvgr_opacity', 15:52:07 INFO - 'tart', 15:52:07 INFO - 'tscrollx', 15:52:07 INFO - 'cart']}, 15:52:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:52:07 INFO - 'tsvgr_opacity', 15:52:07 INFO - 'tart', 15:52:07 INFO - 'tscrollx', 15:52:07 INFO - 'cart']}, 15:52:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:07 INFO - 'talos_options': ['--disable-e10s'], 15:52:07 INFO - 'tests': ['tp5o']}, 15:52:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:07 INFO - 'tests': ['tp5o']}, 15:52:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:07 INFO - 'talos_options': ['--disable-e10s', 15:52:07 INFO - '--xperf_path', 15:52:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:52:07 INFO - 'tests': ['tp5n']}, 15:52:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:07 INFO - 'talos_options': ['--xperf_path', 15:52:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:52:07 INFO - 'tests': ['tp5n']}}, 15:52:07 INFO - 'talos.zip': {'path': '', 15:52:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:52:07 INFO - Running post-action listener: _resource_record_post_action 15:52:07 INFO - [mozharness: 2016-07-26 22:52:07.005242Z] Finished populate-webroot step (success) 15:52:07 INFO - [mozharness: 2016-07-26 22:52:07.005361Z] Running create-virtualenv step. 15:52:07 INFO - Running pre-action listener: _resource_record_pre_action 15:52:07 INFO - Running main action method: create_virtualenv 15:52:07 INFO - Creating virtualenv /builds/slave/test/build/venv 15:52:07 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 15:52:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:52:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:52:07 INFO - Using real prefix '/usr' 15:52:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:52:07 INFO - Installing distribute.............................................................................................................................................................................................done. 15:52:09 INFO - Installing pip.................done. 15:52:09 INFO - Return code: 0 15:52:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:52: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')]} 15:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52: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')]} 15:52:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:09 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 0x2aa7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d65570>, '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 0x2d66470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d66900>, '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': '652eb03db935cfc1c15ebda0000001ad-1469573423.216979-763374323', '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 15:52:09 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 15:52:09 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 15:52:09 INFO - Using env: {'DISPLAY': ':0', 15:52:09 INFO - 'HOME': '/home/cltbld', 15:52:09 INFO - 'LANG': 'en_US.UTF-8', 15:52:09 INFO - 'LANGUAGE': 'en_US:en', 15:52:09 INFO - 'LOGNAME': 'cltbld', 15:52:09 INFO - 'MAIL': '/var/mail/cltbld', 15:52:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:09 INFO - 'MOZ_NO_REMOTE': '1', 15:52:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:09 INFO - 'NO_EM_RESTART': '1', 15:52:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:09 INFO - 'PWD': '/builds/slave/test', 15:52:09 INFO - 'SHELL': '/bin/bash', 15:52:09 INFO - 'SHLVL': '1', 15:52:09 INFO - 'TERM': 'linux', 15:52:09 INFO - 'TMOUT': '86400', 15:52:09 INFO - 'USER': 'cltbld', 15:52:09 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1469573423.216979-763374323', 15:52:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:09 INFO - '_': '/tools/buildbot/bin/python'} 15:52:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:09 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 15:52:09 INFO - Cleaning up... 15:52:09 INFO - Return code: 0 15:52:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:52: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')]} 15:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52: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')]} 15:52:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:09 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 0x2aa7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d65570>, '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 0x2d66470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d66900>, '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': '652eb03db935cfc1c15ebda0000001ad-1469573423.216979-763374323', '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 15:52:09 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 15:52:09 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 15:52:09 INFO - Using env: {'DISPLAY': ':0', 15:52:09 INFO - 'HOME': '/home/cltbld', 15:52:09 INFO - 'LANG': 'en_US.UTF-8', 15:52:09 INFO - 'LANGUAGE': 'en_US:en', 15:52:09 INFO - 'LOGNAME': 'cltbld', 15:52:09 INFO - 'MAIL': '/var/mail/cltbld', 15:52:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:09 INFO - 'MOZ_NO_REMOTE': '1', 15:52:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:09 INFO - 'NO_EM_RESTART': '1', 15:52:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:09 INFO - 'PWD': '/builds/slave/test', 15:52:09 INFO - 'SHELL': '/bin/bash', 15:52:09 INFO - 'SHLVL': '1', 15:52:09 INFO - 'TERM': 'linux', 15:52:09 INFO - 'TMOUT': '86400', 15:52:09 INFO - 'USER': 'cltbld', 15:52:09 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1469573423.216979-763374323', 15:52:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:09 INFO - '_': '/tools/buildbot/bin/python'} 15:52:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:10 INFO - Downloading/unpacking psutil>=3.1.1 15:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:52:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:52:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:52:12 INFO - Installing collected packages: psutil 15:52:12 INFO - Running setup.py install for psutil 15:52:12 INFO - building 'psutil._psutil_linux' extension 15:52:12 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 15:52:12 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 15:52:12 INFO - building 'psutil._psutil_posix' extension 15:52:12 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 15:52:12 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 15:52:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:52:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:52:12 INFO - Successfully installed psutil 15:52:12 INFO - Cleaning up... 15:52:12 INFO - Return code: 0 15:52:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:52:12 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')]} 15:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:12 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')]} 15:52:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:12 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 0x2aa7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d65570>, '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 0x2d66470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d66900>, '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': '652eb03db935cfc1c15ebda0000001ad-1469573423.216979-763374323', '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 15:52:12 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 15:52:12 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 15:52:12 INFO - Using env: {'DISPLAY': ':0', 15:52:12 INFO - 'HOME': '/home/cltbld', 15:52:12 INFO - 'LANG': 'en_US.UTF-8', 15:52:12 INFO - 'LANGUAGE': 'en_US:en', 15:52:12 INFO - 'LOGNAME': 'cltbld', 15:52:12 INFO - 'MAIL': '/var/mail/cltbld', 15:52:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:12 INFO - 'MOZ_NO_REMOTE': '1', 15:52:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:12 INFO - 'NO_EM_RESTART': '1', 15:52:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:12 INFO - 'PWD': '/builds/slave/test', 15:52:12 INFO - 'SHELL': '/bin/bash', 15:52:12 INFO - 'SHLVL': '1', 15:52:12 INFO - 'TERM': 'linux', 15:52:12 INFO - 'TMOUT': '86400', 15:52:12 INFO - 'USER': 'cltbld', 15:52:12 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1469573423.216979-763374323', 15:52:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:12 INFO - '_': '/tools/buildbot/bin/python'} 15:52:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:52:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:52:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:52:14 INFO - Installing collected packages: mozsystemmonitor 15:52:14 INFO - Running setup.py install for mozsystemmonitor 15:52:14 INFO - Successfully installed mozsystemmonitor 15:52:14 INFO - Cleaning up... 15:52:14 INFO - Return code: 0 15:52:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:52:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:14 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 0x2aa7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d65570>, '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 0x2d66470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d66900>, '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': '652eb03db935cfc1c15ebda0000001ad-1469573423.216979-763374323', '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 15:52:14 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 15:52:14 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 15:52:14 INFO - Using env: {'DISPLAY': ':0', 15:52:14 INFO - 'HOME': '/home/cltbld', 15:52:14 INFO - 'LANG': 'en_US.UTF-8', 15:52:14 INFO - 'LANGUAGE': 'en_US:en', 15:52:14 INFO - 'LOGNAME': 'cltbld', 15:52:14 INFO - 'MAIL': '/var/mail/cltbld', 15:52:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:14 INFO - 'MOZ_NO_REMOTE': '1', 15:52:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:14 INFO - 'NO_EM_RESTART': '1', 15:52:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:14 INFO - 'PWD': '/builds/slave/test', 15:52:14 INFO - 'SHELL': '/bin/bash', 15:52:14 INFO - 'SHLVL': '1', 15:52:14 INFO - 'TERM': 'linux', 15:52:14 INFO - 'TMOUT': '86400', 15:52:14 INFO - 'USER': 'cltbld', 15:52:14 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1469573423.216979-763374323', 15:52:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:14 INFO - '_': '/tools/buildbot/bin/python'} 15:52:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:15 INFO - Downloading/unpacking jsonschema==2.5.1 15:52:15 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 15:52:15 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 15:52:15 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 15:52:15 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 15:52:15 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 15:52:15 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 15:52:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:52:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:52:17 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 15:52:17 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 15:52:17 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 15:52:17 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 15:52:17 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 15:52:17 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 15:52:17 INFO - Downloading functools32-3.2.3-2.tar.gz 15:52:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:52:17 INFO - warning: no files found matching '*.txt' 15:52:17 INFO - no previously-included directories found matching 'build' 15:52:17 INFO - no previously-included directories found matching 'dist' 15:52:17 INFO - no previously-included directories found matching '.git*' 15:52:17 INFO - Installing collected packages: jsonschema, functools32 15:52:17 INFO - Running setup.py install for functools32 15:52:17 INFO - warning: no files found matching '*.txt' 15:52:17 INFO - no previously-included directories found matching 'build' 15:52:17 INFO - no previously-included directories found matching 'dist' 15:52:17 INFO - no previously-included directories found matching '.git*' 15:52:17 INFO - Successfully installed jsonschema functools32 15:52:17 INFO - Cleaning up... 15:52:17 INFO - Return code: 0 15:52:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:52:17 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')]} 15:52:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:17 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')]} 15:52:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:17 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 0x2aa7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d65570>, '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 0x2d66470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d66900>, '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': '652eb03db935cfc1c15ebda0000001ad-1469573423.216979-763374323', '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 15:52:17 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 15:52:17 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 15:52:17 INFO - Using env: {'DISPLAY': ':0', 15:52:17 INFO - 'HOME': '/home/cltbld', 15:52:17 INFO - 'LANG': 'en_US.UTF-8', 15:52:17 INFO - 'LANGUAGE': 'en_US:en', 15:52:17 INFO - 'LOGNAME': 'cltbld', 15:52:17 INFO - 'MAIL': '/var/mail/cltbld', 15:52:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:17 INFO - 'MOZ_NO_REMOTE': '1', 15:52:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:17 INFO - 'NO_EM_RESTART': '1', 15:52:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:17 INFO - 'PWD': '/builds/slave/test', 15:52:17 INFO - 'SHELL': '/bin/bash', 15:52:17 INFO - 'SHLVL': '1', 15:52:17 INFO - 'TERM': 'linux', 15:52:17 INFO - 'TMOUT': '86400', 15:52:17 INFO - 'USER': 'cltbld', 15:52:17 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1469573423.216979-763374323', 15:52:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:17 INFO - '_': '/tools/buildbot/bin/python'} 15:52:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:52:17 INFO - Cleaning up... 15:52:17 INFO - Return code: 0 15:52:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:52:17 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')]} 15:52:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:17 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')]} 15:52:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:17 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 0x2aa7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d65570>, '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 0x2d66470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d66900>, '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': '652eb03db935cfc1c15ebda0000001ad-1469573423.216979-763374323', '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 15:52:17 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 15:52:17 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 15:52:17 INFO - Using env: {'DISPLAY': ':0', 15:52:17 INFO - 'HOME': '/home/cltbld', 15:52:17 INFO - 'LANG': 'en_US.UTF-8', 15:52:17 INFO - 'LANGUAGE': 'en_US:en', 15:52:17 INFO - 'LOGNAME': 'cltbld', 15:52:17 INFO - 'MAIL': '/var/mail/cltbld', 15:52:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:17 INFO - 'MOZ_NO_REMOTE': '1', 15:52:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:17 INFO - 'NO_EM_RESTART': '1', 15:52:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:17 INFO - 'PWD': '/builds/slave/test', 15:52:17 INFO - 'SHELL': '/bin/bash', 15:52:17 INFO - 'SHLVL': '1', 15:52:17 INFO - 'TERM': 'linux', 15:52:17 INFO - 'TMOUT': '86400', 15:52:17 INFO - 'USER': 'cltbld', 15:52:17 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1469573423.216979-763374323', 15:52:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:17 INFO - '_': '/tools/buildbot/bin/python'} 15:52:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:17 INFO - Downloading/unpacking blobuploader==1.2.4 15:52:17 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 15:52:17 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 15:52:17 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 15:52:17 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 15:52:17 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 15:52:17 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 15:52:19 INFO - Downloading blobuploader-1.2.4.tar.gz 15:52:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:52:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:52:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:52:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:20 INFO - Downloading docopt-0.6.1.tar.gz 15:52:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:52:20 INFO - Installing collected packages: blobuploader, requests, docopt 15:52:20 INFO - Running setup.py install for blobuploader 15:52:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:52:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:52:20 INFO - Running setup.py install for requests 15:52:21 INFO - Running setup.py install for docopt 15:52:21 INFO - Successfully installed blobuploader requests docopt 15:52:21 INFO - Cleaning up... 15:52:21 INFO - Return code: 0 15:52:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:52: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')]} 15:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52: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')]} 15:52:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:21 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 0x2aa7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d65570>, '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 0x2d66470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d66900>, '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': '652eb03db935cfc1c15ebda0000001ad-1469573423.216979-763374323', '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 15:52:21 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 15:52:21 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 15:52:21 INFO - Using env: {'DISPLAY': ':0', 15:52:21 INFO - 'HOME': '/home/cltbld', 15:52:21 INFO - 'LANG': 'en_US.UTF-8', 15:52:21 INFO - 'LANGUAGE': 'en_US:en', 15:52:21 INFO - 'LOGNAME': 'cltbld', 15:52:21 INFO - 'MAIL': '/var/mail/cltbld', 15:52:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:21 INFO - 'MOZ_NO_REMOTE': '1', 15:52:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:21 INFO - 'NO_EM_RESTART': '1', 15:52:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:21 INFO - 'PWD': '/builds/slave/test', 15:52:21 INFO - 'SHELL': '/bin/bash', 15:52:21 INFO - 'SHLVL': '1', 15:52:21 INFO - 'TERM': 'linux', 15:52:21 INFO - 'TMOUT': '86400', 15:52:21 INFO - 'USER': 'cltbld', 15:52:21 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1469573423.216979-763374323', 15:52:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:21 INFO - '_': '/tools/buildbot/bin/python'} 15:52:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:52:21 INFO - Running setup.py (path:/tmp/pip-N_a6GN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:52:21 INFO - Running setup.py (path:/tmp/pip-px8gpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:52:21 INFO - Running setup.py (path:/tmp/pip-uskz4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:52:21 INFO - Running setup.py (path:/tmp/pip-h_kmQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:52:21 INFO - Running setup.py (path:/tmp/pip-DF3cSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:52:21 INFO - Running setup.py (path:/tmp/pip-7YQwkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:52:21 INFO - Running setup.py (path:/tmp/pip-NieE77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:52:21 INFO - Running setup.py (path:/tmp/pip-nxUN4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:52:21 INFO - Running setup.py (path:/tmp/pip-TJ2zKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:52:22 INFO - Running setup.py (path:/tmp/pip-xSk1wK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:52:22 INFO - Running setup.py (path:/tmp/pip-PMp_iw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:52:22 INFO - Running setup.py (path:/tmp/pip-_UyGOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:52:22 INFO - Running setup.py (path:/tmp/pip-T_ccqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:52:22 INFO - Running setup.py (path:/tmp/pip-rGYl0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:52:22 INFO - Running setup.py (path:/tmp/pip-eIz_mH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:52:22 INFO - Running setup.py (path:/tmp/pip-2g65pD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:52:22 INFO - Running setup.py (path:/tmp/pip-kmLKtc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:52:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:52:22 INFO - Running setup.py install for manifestparser 15:52:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:52:22 INFO - Running setup.py install for mozcrash 15:52:22 INFO - Running setup.py install for mozdebug 15:52:22 INFO - Running setup.py install for mozdevice 15:52:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:52:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:52:23 INFO - Running setup.py install for mozfile 15:52:23 INFO - Running setup.py install for mozhttpd 15:52:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:52:23 INFO - Running setup.py install for mozinfo 15:52:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:52:23 INFO - Running setup.py install for mozInstall 15:52:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:52:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:52:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:52:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:52:23 INFO - Running setup.py install for mozleak 15:52:23 INFO - Running setup.py install for mozlog 15:52:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:52:23 INFO - Running setup.py install for moznetwork 15:52:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:52:23 INFO - Running setup.py install for mozprocess 15:52:23 INFO - Running setup.py install for mozprofile 15:52:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:52:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:52:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:52:24 INFO - Running setup.py install for mozrunner 15:52:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:52:24 INFO - Running setup.py install for mozscreenshot 15:52:24 INFO - Running setup.py install for moztest 15:52:24 INFO - Running setup.py install for mozversion 15:52:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:52:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:52:24 INFO - Cleaning up... 15:52:24 INFO - Return code: 0 15:52:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:52: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')]} 15:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52: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')]} 15:52:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:24 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 0x2aa7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d65570>, '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 0x2d66470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d66900>, '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': '652eb03db935cfc1c15ebda0000001ad-1469573423.216979-763374323', '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 15:52:24 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 15:52:24 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 15:52:24 INFO - Using env: {'DISPLAY': ':0', 15:52:24 INFO - 'HOME': '/home/cltbld', 15:52:24 INFO - 'LANG': 'en_US.UTF-8', 15:52:24 INFO - 'LANGUAGE': 'en_US:en', 15:52:24 INFO - 'LOGNAME': 'cltbld', 15:52:24 INFO - 'MAIL': '/var/mail/cltbld', 15:52:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:24 INFO - 'MOZ_NO_REMOTE': '1', 15:52:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:24 INFO - 'NO_EM_RESTART': '1', 15:52:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:24 INFO - 'PWD': '/builds/slave/test', 15:52:24 INFO - 'SHELL': '/bin/bash', 15:52:24 INFO - 'SHLVL': '1', 15:52:24 INFO - 'TERM': 'linux', 15:52:24 INFO - 'TMOUT': '86400', 15:52:24 INFO - 'USER': 'cltbld', 15:52:24 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1469573423.216979-763374323', 15:52:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:24 INFO - '_': '/tools/buildbot/bin/python'} 15:52:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:52:24 INFO - Running setup.py (path:/tmp/pip-UgSLOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:52:24 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)) 15:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:52:24 INFO - Running setup.py (path:/tmp/pip-5_E8fs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:52:24 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)) 15:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:52:24 INFO - Running setup.py (path:/tmp/pip-IQY5M4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:52:24 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)) 15:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:52:24 INFO - Running setup.py (path:/tmp/pip-1x1yV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:52:24 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)) 15:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:52:24 INFO - Running setup.py (path:/tmp/pip-DIP9I5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:52:25 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)) 15:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:52:25 INFO - Running setup.py (path:/tmp/pip-IfkR6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:52:25 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)) 15:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:52:25 INFO - Running setup.py (path:/tmp/pip-tDTJis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:52:25 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)) 15:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:52:25 INFO - Running setup.py (path:/tmp/pip-nAAqTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:52:25 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)) 15:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:52:25 INFO - Running setup.py (path:/tmp/pip-S0buMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:52:25 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)) 15:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:52:25 INFO - Running setup.py (path:/tmp/pip-CWBdRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:52:25 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)) 15:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:52:25 INFO - Running setup.py (path:/tmp/pip-U0zgVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:52:25 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)) 15:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:52:25 INFO - Running setup.py (path:/tmp/pip-7EWKoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:52:25 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)) 15:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:52:25 INFO - Running setup.py (path:/tmp/pip-wjr2pJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:52:25 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)) 15:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:52:25 INFO - Running setup.py (path:/tmp/pip-pa9UZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:52:25 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)) 15:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:52:25 INFO - Running setup.py (path:/tmp/pip-sIno38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:52:25 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)) 15:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:52:25 INFO - Running setup.py (path:/tmp/pip-8ySw26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:52:25 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)) 15:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:52:25 INFO - Running setup.py (path:/tmp/pip-tV5sZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:52:25 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)) 15:52:25 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)) 15:52:25 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)) 15:52:25 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)) 15:52:25 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)) 15:52:25 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)) 15:52:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:52:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:27 INFO - Downloading blessings-1.6.tar.gz 15:52:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:52:27 INFO - Installing collected packages: blessings 15:52:27 INFO - Running setup.py install for blessings 15:52:27 INFO - Successfully installed blessings 15:52:27 INFO - Cleaning up... 15:52:28 INFO - Return code: 0 15:52:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:52:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:52:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:52:28 INFO - Reading from file tmpfile_stdout 15:52:28 INFO - Current package versions: 15:52:28 INFO - argparse == 1.2.1 15:52:28 INFO - blessings == 1.6 15:52:28 INFO - blobuploader == 1.2.4 15:52:28 INFO - docopt == 0.6.1 15:52:28 INFO - functools32 == 3.2.3-2 15:52:28 INFO - jsonschema == 2.5.1 15:52:28 INFO - manifestparser == 1.1 15:52:28 INFO - mozInstall == 1.12 15:52:28 INFO - mozcrash == 0.17 15:52:28 INFO - mozdebug == 0.1 15:52:28 INFO - mozdevice == 0.48 15:52:28 INFO - mozfile == 1.2 15:52:28 INFO - mozhttpd == 0.7 15:52:28 INFO - mozinfo == 0.9 15:52:28 INFO - mozleak == 0.1 15:52:28 INFO - mozlog == 3.3 15:52:28 INFO - moznetwork == 0.27 15:52:28 INFO - mozprocess == 0.23 15:52:28 INFO - mozprofile == 0.28 15:52:28 INFO - mozrunner == 6.12 15:52:28 INFO - mozscreenshot == 0.1 15:52:28 INFO - mozsystemmonitor == 0.3 15:52:28 INFO - moztest == 0.7 15:52:28 INFO - mozversion == 1.4 15:52:28 INFO - psutil == 3.1.1 15:52:28 INFO - requests == 1.2.3 15:52:28 INFO - wsgiref == 0.1.2 15:52:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:28 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 0x2aa7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d65570>, '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 0x2d66470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d66900>, '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': '652eb03db935cfc1c15ebda0000001ad-1469573423.216979-763374323', '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 15:52:28 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 15:52:28 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 15:52:28 INFO - Using env: {'DISPLAY': ':0', 15:52:28 INFO - 'HOME': '/home/cltbld', 15:52:28 INFO - 'LANG': 'en_US.UTF-8', 15:52:28 INFO - 'LANGUAGE': 'en_US:en', 15:52:28 INFO - 'LOGNAME': 'cltbld', 15:52:28 INFO - 'MAIL': '/var/mail/cltbld', 15:52:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:28 INFO - 'MOZ_NO_REMOTE': '1', 15:52:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:28 INFO - 'NO_EM_RESTART': '1', 15:52:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:28 INFO - 'PWD': '/builds/slave/test', 15:52:28 INFO - 'SHELL': '/bin/bash', 15:52:28 INFO - 'SHLVL': '1', 15:52:28 INFO - 'TERM': 'linux', 15:52:28 INFO - 'TMOUT': '86400', 15:52:28 INFO - 'USER': 'cltbld', 15:52:28 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1469573423.216979-763374323', 15:52:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:28 INFO - '_': '/tools/buildbot/bin/python'} 15:52:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:28 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)) 15:52:28 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)) 15:52:28 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)) 15:52:28 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)) 15:52:28 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)) 15:52:28 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)) 15:52:28 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)) 15:52:28 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)) 15:52:28 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)) 15:52:28 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)) 15:52:28 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)) 15:52:28 INFO - Cleaning up... 15:52:28 INFO - Return code: 0 15:52:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:28 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 0x2aa7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d65570>, '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 0x2d66470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d66900>, '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': '652eb03db935cfc1c15ebda0000001ad-1469573423.216979-763374323', '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 15:52:28 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 15:52:28 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 15:52:28 INFO - Using env: {'DISPLAY': ':0', 15:52:28 INFO - 'HOME': '/home/cltbld', 15:52:28 INFO - 'LANG': 'en_US.UTF-8', 15:52:28 INFO - 'LANGUAGE': 'en_US:en', 15:52:28 INFO - 'LOGNAME': 'cltbld', 15:52:28 INFO - 'MAIL': '/var/mail/cltbld', 15:52:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:28 INFO - 'MOZ_NO_REMOTE': '1', 15:52:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:28 INFO - 'NO_EM_RESTART': '1', 15:52:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:28 INFO - 'PWD': '/builds/slave/test', 15:52:28 INFO - 'SHELL': '/bin/bash', 15:52:28 INFO - 'SHLVL': '1', 15:52:28 INFO - 'TERM': 'linux', 15:52:28 INFO - 'TMOUT': '86400', 15:52:28 INFO - 'USER': 'cltbld', 15:52:28 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1469573423.216979-763374323', 15:52:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:28 INFO - '_': '/tools/buildbot/bin/python'} 15:52:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:52:28 INFO - Cleaning up... 15:52:28 INFO - Return code: 0 15:52:28 INFO - Running post-action listener: _resource_record_post_action 15:52:28 INFO - Running post-action listener: _start_resource_monitoring 15:52:28 INFO - Starting resource monitoring. 15:52:28 INFO - [mozharness: 2016-07-26 22:52:28.742509Z] Finished create-virtualenv step (success) 15:52:28 INFO - [mozharness: 2016-07-26 22:52:28.742982Z] Running install step. 15:52:28 INFO - Running pre-action listener: _resource_record_pre_action 15:52:28 INFO - Running main action method: install 15:52:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:52:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:52:28 INFO - Reading from file tmpfile_stdout 15:52:28 INFO - Detecting whether we're running mozinstall >=1.0... 15:52:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:52:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:52:29 INFO - Reading from file tmpfile_stdout 15:52:29 INFO - Output received: 15:52:29 INFO - Usage: mozinstall [options] installer 15:52:29 INFO - Options: 15:52:29 INFO - -h, --help show this help message and exit 15:52:29 INFO - -d DEST, --destination=DEST 15:52:29 INFO - Directory to install application into. [default: 15:52:29 INFO - "/builds/slave/test"] 15:52:29 INFO - --app=APP Application being installed. [default: firefox] 15:52:29 INFO - mkdir: /builds/slave/test/build/application 15:52:29 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'] 15:52:29 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 15:52:45 INFO - Reading from file tmpfile_stdout 15:52:45 INFO - Output received: 15:52:45 INFO - /builds/slave/test/build/application/firefox/firefox 15:52:45 INFO - Running post-action listener: _resource_record_post_action 15:52:45 INFO - [mozharness: 2016-07-26 22:52:45.490981Z] Finished install step (success) 15:52:45 INFO - [mozharness: 2016-07-26 22:52:45.491261Z] Running run-tests step. 15:52:45 INFO - Running pre-action listener: _resource_record_pre_action 15:52:45 INFO - Running main action method: run_tests 15:52:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:52:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:52:45 INFO - Python 2.7.3 15:52:45 INFO - Return code: 0 15:52:45 INFO - grabbing minidump binary from tooltool 15:52:45 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')]} 15:52:45 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 0x2d65570>, '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 0x2d66470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d66900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:52:45 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 15:52:45 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 15:52:45 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 15:52:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:52:45 INFO - Return code: 0 15:52:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:52:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:52:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:52:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:52:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:52:45 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bHSlaVTgTZirJK64MneoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:52:45 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bHSlaVTgTZirJK64MneoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:52:45 INFO - Using env: {'DISPLAY': ':0', 15:52:45 INFO - 'HOME': '/home/cltbld', 15:52:45 INFO - 'LANG': 'en_US.UTF-8', 15:52:45 INFO - 'LANGUAGE': 'en_US:en', 15:52:45 INFO - 'LOGNAME': 'cltbld', 15:52:45 INFO - 'MAIL': '/var/mail/cltbld', 15:52:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:52:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:52:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:45 INFO - 'MOZ_NO_REMOTE': '1', 15:52:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:52:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:45 INFO - 'NO_EM_RESTART': '1', 15:52:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:45 INFO - 'PWD': '/builds/slave/test', 15:52:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:52:45 INFO - 'SHELL': '/bin/bash', 15:52:45 INFO - 'SHLVL': '1', 15:52:45 INFO - 'TERM': 'linux', 15:52:45 INFO - 'TMOUT': '86400', 15:52:45 INFO - 'USER': 'cltbld', 15:52:45 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1469573423.216979-763374323', 15:52:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:45 INFO - '_': '/tools/buildbot/bin/python'} 15:52:45 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bHSlaVTgTZirJK64MneoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:52:45 INFO - mozversion application_buildid: 20160726130804 15:52:45 INFO - mozversion application_changeset: efc0b2d797abeb7624071731e6cb25704b502bae 15:52:45 INFO - mozversion application_display_name: Nightly 15:52:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:52:45 INFO - mozversion application_name: Firefox 15:52:45 INFO - mozversion application_remotingname: firefox 15:52:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 15:52:45 INFO - mozversion application_vendor: Mozilla 15:52:45 INFO - mozversion application_version: 50.0a1 15:52:45 INFO - mozversion platform_buildid: 20160726130804 15:52:45 INFO - mozversion platform_changeset: efc0b2d797abeb7624071731e6cb25704b502bae 15:52:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 15:52:45 INFO - mozversion platform_version: 50.0a1 15:52:45 INFO - using testdate: 1469573565 15:52:45 INFO - actual date: 1469573565 15:52:45 INFO - starting webserver on 'localhost:41743' 15:52:45 INFO - SUITE-START | Running 2 tests 15:52:45 INFO - TEST-START | dromaeo_css 15:52:45 INFO - operating with platform_type : linux_ 15:52:45 INFO - Initialising browser for dromaeo_css test... 15:52:45 INFO - TEST-INFO | started process 25539 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT_j56j/profile http://localhost:41743/getInfo.html) 15:52:49 INFO - PROCESS | 25539 | JavaScript error: , line 0: uncaught exception: undefined 15:52:50 INFO - PROCESS | 25539 | __metrics Screen width/height:1600/1200 15:52:50 INFO - PROCESS | 25539 | colorDepth:24 15:52:50 INFO - PROCESS | 25539 | Browser inner width/height: 1024/697 15:52:50 INFO - PROCESS | 25539 | __metrics 15:52:51 ERROR - PROCESS | 25539 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 15:52:52 INFO - TEST-INFO | 25539: exit 0 15:52:52 INFO - Browser initialized. 15:52:52 INFO - Running cycle 1/1 for dromaeo_css test... 15:52:52 INFO - TEST-INFO | started process 25659 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT_j56j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:53:04 INFO - PROCESS | 25659 | RSS: Main: 165638144 15:53:04 INFO - PROCESS | 25659 | 15:53:53 INFO - PROCESS | 25659 | 1469573633874 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] 15:56:06 INFO - PROCESS | 25659 | Cycle 1(1): loaded http://localhost:41743/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41743/tests/dromaeo/cssquery-ext.html) 15:56:07 INFO - PROCESS | 25659 | RSS: Main: 168349696 15:56:07 INFO - PROCESS | 25659 | 15:59:10 INFO - PROCESS | 25659 | Cycle 1(1): loaded http://localhost:41743/tests/dromaeo/cssquery-ext.html (next: http://localhost:41743/tests/dromaeo/cssquery-jquery.html) 15:59:10 INFO - PROCESS | 25659 | RSS: Main: 167567360 15:59:10 INFO - PROCESS | 25659 | 16:02:12 INFO - PROCESS | 25659 | Cycle 1(1): loaded http://localhost:41743/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41743/tests/dromaeo/cssquery-mootools.html) 16:02:13 INFO - PROCESS | 25659 | RSS: Main: 171143168 16:02:13 INFO - PROCESS | 25659 | 16:05:15 INFO - PROCESS | 25659 | Cycle 1(1): loaded http://localhost:41743/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41743/tests/dromaeo/cssquery-prototype.html) 16:05:15 INFO - PROCESS | 25659 | RSS: Main: 165744640 16:05:15 INFO - PROCESS | 25659 | 16:08:18 INFO - PROCESS | 25659 | Cycle 1(1): loaded http://localhost:41743/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41743/tests/dromaeo/cssquery-yui.html) 16:08:19 INFO - PROCESS | 25659 | RSS: Main: 167202816 16:08:19 INFO - PROCESS | 25659 | 16:11:22 INFO - PROCESS | 25659 | Cycle 1(1): loaded http://localhost:41743/tests/dromaeo/cssquery-yui.html (next: http://localhost:41743/tests/dromaeo/cssquery-dojo.html) 16:11:22 INFO - PROCESS | 25659 | RSS: Main: 171106304 16:11:22 INFO - PROCESS | 25659 | 16:11:22 INFO - PROCESS | 25659 | __start_tp_report 16:11:22 INFO - PROCESS | 25659 | _x_x_mozilla_page_load 16:11:22 INFO - PROCESS | 25659 | _x_x_mozilla_page_load_details 16:11:22 INFO - PROCESS | 25659 | |i|pagename|runs| 16:11:22 INFO - PROCESS | 25659 | |0;dojo.html;2668.426288348005;2682.8792704328303;2704.364474348528;2707.6073969274457;2722.305812017936;4770.6422018348585;4842.201036828919;4877.244027175789;4905.239687848385;4921.70469771814;4688.85933421997;4741.146593613148;4770.570648641621;4802.06359759847;4824.61403087753;4319.179355922364;4349.456317960255;4426.822927082912;4427.335899615067;4533.387992621004;4441.244988351972;4451.443569553806;4473.932891006638;4484.910301793962;4536.296873984521;4375.78121093944;4431.512533621299;4435.756033418161;4455.532169122261;4471.463424389094;4505.189065968125;4512.12013657337;4519.367288579601;4541.704789188725;4557.0885822835235;4455.532169122228;4480.081583275421;4483.708558943658;4487.955120448786;4494.9325760113625;4717.080169366975;4740.07568524138;4751.263554149113;4753.881152971168;4813.975930120362;5113.795448182068;5127.7948882044675;5134.383873935114;5148.382194136728;5160.329157209576;5124.92312615311;5150.098732721759;5160.92258616121;5178;5196.948030519722;4664.743439110814;4696.459907110658;4747.501512341223;4776.785044672998;4777.307290442901;5242.7378631068295;5245.370555533361;5258.290130832365;5267.762950667229;5296.973515132399;5019.899602007939;5023.271625614266;5052.166392545262;5066.392032955995;5123.205903085028;5029.974850125726;5124.692518448905;5147.305113809588;5163.199704045879;5166.509181627739;5112.437631860493;5119.87200319995;5146.433892271847;5158.123119069767;5176.974115129476;5118;5127.282180494733;5142.100132476801;5169.586433085344;5174.896502069938;4350.630196433275;4424.933625995613;4470.418845550123;4492.146492166543;4540.477845047862;3855.8014052830667;3880.359740642819;3881.4565960765517;3916.118873253495;3916.823742931575;4467.530909254481;4472.888177795516;4484.865454036384;4487.259602165606;4541.841035563805;5092.898142037138;5234.869128271747;5243.659162154448;5271.103912334912;5331.040412725747;4486.775661216926;4494.70784399013;4509.075639493896;4515.864524064284;4556.2937744649635;4704.576588107018;4729.503402142795;4745.501722319176;4754.144254034238;4789.521047895182;4672.299155126758;4752.643551733634;4777.498362672009;4782.808687652455;4862.124817532878;5138.486151384832;5171.586273098068;5175.534201921845;5183.611229157904;5203.19350500673;4829.710217386968;4830.372051633265;4832.371791667061;4846.127697014571;4886.9022619546695;5009.649324547247;5044.495550444926;5045.8738531537;5057.216131499624;5119.795208191631;5156.896862062663;5159.071367153948;5159.122949098737;5168.664036837594;5172.353455818023;4997.575206107522;4998.975005124951;5015.648904576645;5021.49785021495;5021.6484846061885;4934.136526107988;4996.375453068366;5028.572571331478;5057.924131138109;5109.565686916654;4965.726885021359;4969.801207951641;4979.626528010342;5017.397912250553;5065.4428012917815;5118.053160165381;5123.129068058513;5129.230615407719;5136.280920671034;5140.640155189101;4881.48744381849;4941.678790878582;4990.076835785246;5021.799128034838;5077.847664570068 16:11:22 INFO - PROCESS | 25659 | |1;ext.html;558.7178474870187;561.1974875927424;574.4198359656747;576.1703147467646;585.81546812754;34911.27218195451;38033.80983095084;38154.23691526171;38351.42472862909;38356.808215958954;39325.60674393255;39569.61506347278;39730.404043939365;39773.40339894904;39893.800530997374;7658.54048757075;7778.805529861742;7800.80497987552;7800.843983120362;7812.257835505618;7658.770236892902;7663.118741344761;7716.807079823021;7740.148583655793;7754.263344982218;7764.534127952313;7779.649915753805;7806.804829879242;7807.4144439167;7821.178776228499;7694.5383277003275;7710.689182838874;7731.652075656609;7736.032995875516;7758.961205193994;7614.657340419694;7644.694212231504;7698.1916898725385;7703.46075774696;7741.419393545507;36910.630893690985;36994;37263.81368093169;37515.24969500595;37611;2854.51473249546;3033.9544906826413;3087.4442600332154;3134.7648926330617;3428.862845486178;28971.710282897322;29283.560746588817;29305.853470732724;29607.407851843058;29644.555331670043;3044.2693753499;3071.370369074357;3208.6470488246273;3227.725643320297;3233.2240262337104;271503;273636;274634;274830.62584687147;275271;31384.529232061537;32132.19669508281;54640.45359546433;54814.72592637091;55437.44562554404;33233.83383083069;33451.49822752661;33516.162095947795;33564.832175838965;33564.832175838965;13659.385327660279;13760.793588096187;13814.447422103003;13838.792418113737;13858.307084645727;11266.43667816606;11353;11396.829047564293;11431.542738290542;11436.370999594936;7794.883076753853;7803.609819509002;7818.179091195457;7878.960605196938;7931.048274207132;3005.0984704588536;3073.585066016059;3097.4579448596855;3113.3617608390227;3129.7809153359503;837.9078301386843;886.6807949138305;889.7686601483531;917.5366439947784;958.9547393341152;27607.30981725473;27973.02094426726;28002.719972800012;28482.145535633965;28888.133355999355;912.5665308978182;929.5445231836487;940.3370623710268;977.452626529146;987.6740675577042;14127.576172714835;14829.146326943615;14887.47893823711;15033.699326013637;15094;398304;400615;401788;402415;404673;50083.499165008616;50084.248736268986;50465.49534504682;50575.24137137946;50591.49408505868;1204.8430741274742;1214.313912639356;1226.2887525235342;1235.7528494301175;1237.127824883455;26391.944322226896;27552.724472755017;28586.42827143404;28973.985910493033;29166.708332916398;42417.36373954331;43131.78434107809;43215;43272.321852642875;43326.566734333515;353179;355116;355336;357096;359221;23344.832758362354;23620.645690314315;24931.37671558153;25710.357241069123;25879.61180582255;41212.38181427221;41299.793501032305;41807.118679660096;42148.789256053526;42895.7855210722;34547;35341.46987795237;35649;35944.820275899496;36088.4586731194;35940.56237750565;36117.27765444729;36188.819055904554;36380.454293185096;36554.268914621025;32599.674003259664;34537.65462345345;35051.82474087613;36823.26353472969;37633;30980.535291970187;33212;33224.1693957653;33307;33337;25282.747172528037;25566.488670226863;26109.477810443306;26211.344716382242;26346.868265658548 16:11:22 INFO - PROCESS | 25659 | |2;jquery.html;362.0712871484642;376.6309017163182;377.12695110818464;377.4018181182825;385.6914468425261;16036.358545658175;17017.14914254287;17608.91195544024;17624.911875440637;17729.822701772977;16467.34130634776;16980.915095424538;17363.09006009341;17450.30198792047;17498.475045748648;4751.857444276678;4914.189158788796;4917.754112294371;4918.409790825106;4920.065187614342;3766.2655782122497;5073.137566613685;5734.856628584298;6016.187814645033;6043.7280322385595;5996.940030599703;6133.846653833645;6141.416565426277;6155.230596175478;6157.7536898524;6286.685665716719;6574.2110946686225;6620.337966203389;6813.080234168373;6816.556923799937;6508.121403610499;6514.250861150934;6520.380563846475;6549.869002619921;6570.113034740297;22502.887485562467;23347.182848600387;23881.522369552684;24032;24036.879815600983;1846.1784505894882;1877.6244751049844;2021.191523390641;2084.8749075055543;2653.4295126547886;13734.725305493934;14570.708585828224;15111;15172.24138793067;15179;1869.5980364221757;1872.5880306332585;1886.9339573114876;1919.3282351177115;1931.381957773513;80454.59772701157;82339;82554;83896.58051709764;84261.57869210615;8434.367422443342;8838.690645827364;8950.731478055668;9171.770705732277;9174.541272936327;11919.52321907114;11983.940080299542;12002.339871306987;12004.579839705742;12019.399030048462;6705.195376554844;6806.4554835613035;6944.166699996033;7107.8933815992805;7195.100612423447;6609.768658096944;6700.698468568926;6779.49153813466;7031.0859588254225;7102.218755936843;3554.7689400188906;3570.2680950405106;3640.6177351378255;3662.102784817737;3710.4601590339707;1654.9007059576463;1689.4762623586728;1769.7079981803115;1830.9271799352632;1838.2463190092265;787.3189690917316;818.1981657975217;827.0736774812128;841.848467275884;877.6182360673128;16720.331186752635;16889.32442702278;17138.657226855394;17635.911820441073;17770.378036768652;819.512390127873;836.9707060252983;843.4475418600827;843.9620217090246;892.4243862708516;7695.692172313156;9620.422774633544;9708.466034368177;9821.705348839403;9851.901480985242;287107;294457;294847;384520;388840;59451.405485945455;85781.14218857732;90436.54781726049;91310;91507.54246228727;887.3433659092225;906.4561263242002;928.4382948316306;940.5532372123323;942.472215559289;15657.217139143226;15673.529794106194;15846.12846293465;15947.36210551565;16756;38309.23381532409;39448.802755986035;39560.802195988836;39596.2080758389;40641.18717625572;55605.721971391504;55938.72030639821;57012.42987570071;57177;57197;6463.095166676763;6572.539922205399;6753.898691519729;6757.189137303555;6912.135983002125;8739.126087391463;11428.371439570903;11806.763864722829;12171.75656486883;12175.695607609527;9970.252231082843;10149.137323327599;10420.166386689198;10421.218408619536;10475.790484190426;10568.313059651098;10570.365778053341;10598.25812193139;10845.457727113771;10929.18031147683;10241.180705543688;10249.538770755185;10289.691309260734;10357.326773759682;10437.895621043692;6938.202106757585;7175.748848790267;7193.136823581203;7304;7405;8527.872081918653;9907.356021858555;10087.949560252151;10132.544035518273;10462.947685261524 16:11:22 INFO - PROCESS | 25659 | |3;mootools.html;1368.2201145347153;1401.887848972082;1460.685952520208;1634.7302695055316;1713.443130982431;6862.931370686291;7557.735479258227;7679.308862202401;8294.668213271461;8314.83370332593;7723.652435640395;7757.844843103135;7773.2615401536905;7787.766367008999;7801.92198078019;2142.3251675722177;2179.574982878339;2180.6838008488758;2181.596404665142;2184.595849767798;2127.638301488743;2177.3794468576457;2186.278528085736;2193.2104442400723;2197.494576247464;2154.63371226891;2181.836362272828;2187.9562408751817;2188.1794327127327;2196.516766311409;2130.2331160782105;2138.2088627207954;2142.646463333548;2143.721316228896;2145.914163433461;2064.1743302678897;2105.9578808423744;2112.197365001305;2119.788021197883;2121.4908421978766;7804.648790804427;7805.141434442206;7812.179721129256;7822.921770782276;7836.490628109154;4643.141018911512;4714.811407543694;4728.787204575802;4748.430188377382;4758.595519380857;2645.933851653705;2685.342091187652;2693.4343787804582;2719.5920611908173;2747.615333853262;805.295366554265;831.8211584509299;833.1918039501674;846.4794151596785;852.1052894460792;10957.83563246544;10958.835617465744;10980.505877235544;10999.395033273167;11025.283356581796;4084.2852500812237;4223.936640950388;4357.694961352739;4363.956360436355;4382.035952090535;9212.769680757901;9342.439453632804;9344.953275233716;9376.437413755197;9382.483963381943;4751.738654374042;4761.928571071437;4781.043791241696;4799.736014519235;4800.4719480857075;3736.7010639148803;4109.3425051991535;4283.357496375506;4355.1725172217175;4361.825526978949;3709.9072523187137;3743.1016556026357;3778.7543809652284;3843.788591627487;3861.5366156061455;1199.3103965220034;1209.8548174218975;1242.4222736427605;1248.6753444104418;1253.367049639926;740.5889731199128;743.8661041012562;777.9027621547307;803.1687203744096;839.6473481137937;5111.744412779346;5137;5162.896742065138;5198.506141916512;5283.282933046775;403.6831087596223;407.08812260536183;409.39818466853677;416.40662056569874;419.93910882921807;3444.621091679913;3476.1657202271776;3496.423090190141;3528.7177025837873;3594.5506811648543;9488.952555237318;9735.9026409735;9818.116369526777;9899.752506187402;9902.950485247671;9833.704988850346;9862.605495780232;9864.210863130933;9881.802363952824;9884.703458896245;7050.435965122778;7235.819104522429;7275.963620181865;7308.853822923512;7377.188509264084;5132.409772876167;5221.060209162387;5241.842744717665;5244.921326180034;5381.515663590296;8869.201771840308;9040.773980650536;9083.18251357381;9089.091090891123;9104.453732776055;9092.545372731205;9142.542872856464;9149.359544832065;9264.351495395527;9367.578458969227;6238.968805156127;6695.397414232548;6780.762673306411;6940.063091482585;7091.468139889632;7342.045534080536;7412.851742965218;7451.962740186264;7463.850722985401;7479.663415146223;6539.574927629689;6556.770513032212;6624.8012559623285;6698.66506674674;6893.276205998298;6638.535302528777;6657.101291325609;6677;6755.493337999571;6775.390214880685;6341.619502829845;6423.582467139621;6426.132472116205;6430.7749228776765;6439.774607888701;4264.4456220692355;4300.397944287864;4318.762468064161;4329.631981281626;4354.107407981292;4154.4183814266635;4177.91644167121;4191.182719369694;4205.957940420557;4219.113986062961 16:11:22 INFO - PROCESS | 25659 | |4;prototype.html;295.9334149816291;298.1651376146788;302.1991721936867;303.6341208843344;304.1969201308547;5042.52096050875;5117.897642047157;5121.308623335854;5128.53843154116;5131;5021.573166280861;5038.370203724535;5054;5054.685781696758;5059.723124593929;3713.9229623409246;3824.445455408964;3904.882853514399;3943.895709201414;3952.426898099788;3934.0361611405247;3942.6254505821903;3946.506686664167;3955.7737101498483;3970.424288478169;3914.354131568288;3925.411188321746;3925.450436938831;3928.2536318099615;3935.8709825688647;3821.426785982097;3909.960900390988;3930.351492003816;3934.3082474535936;3937.763734175944;3451;3454.222799870034;3462.5844898612077;3467.219875527986;3470.3753324401596;4887.853364399074;4895.461499235082;4896.1186986342445;4922.75386230687;4931.087748766454;4314.892127696801;4455.46534415869;4480.977595112004;4487.214737420938;4490.865274041784;5210.348706411699;5212.192110222922;5256;5256.369235691704;5270.947290527084;3731.7574357666936;3733.7386382953205;3736.9439458408146;3742.7941463219513;3748.306563285801;5341.839744807623;5534.1975413565215;5537.307836520435;5540.722963851791;5563.082091454905;3830.138218900725;3838.673712734449;3854.3062248795486;3859.556151042666;3865.4781604483596;3913.7064720146104;3915.686745060388;3916.9216615668097;3924.823382947774;3938.783366914847;4446.644268458515;4452.30989196675;4462.419885414875;4476.529964353696;4497.168023915586;4981.551660350586;5268.92096618551;5306.946930530722;5316.175992721134;5330.440303768049;1317.4598414649947;1327.7410904873457;1331.261150061725;1332.1740520877117;1334.726381091874;799.5122974985254;826.3636999510344;838.2958315015417;839.2279103224926;841.9139310289657;4434.911301773946;4503.211937910918;4602.88492787683;4655.627549796008;4658.905157288034;5481.479259470344;5492.752826122834;5495.477929596682;5515.586331025189;5516.448355164532;4625.907481850344;4646.233371493733;4666.183417901853;4668.323093151474;4668.929966050512;2765.7510824025935;2908.2874695699265;2914.3151359430517;2933.691962343923;2936.6329208848892;5070.721110338966;5091.592672586258;5133.589312855037;5140.434552199255;5143.588512919032;5369.516743493026;5614.438556144353;5624.887502249932;5634.661920284714;5647.463490968352;5121.897562048813;5124.180131179068;5128.256402821645;5136.691798492177;5139.563137133386;5499.477549632778;5511.173324001432;5515.917261241005;5538.889222215453;5549.611527193058;5206.271122042993;5432.809851655173;5433.310511296775;5433.646812957145;5486.670799752028;5108.846734597968;5112.156494178419;5122.487751224848;5126.512981266774;5152.510511501551;3757.8496860125288;3778.981105094457;3784.110733977568;3784.735068545175;3809.561900381492;5403.9459605403445;5422.945770542244;5484.862878428071;5500.944990550203;5554.777808887599;5328.49379308965;5332.840014799563;5335.733213339395;5349.625526213128;5360.16917377807;5333.359996800254;5339.626226164131;5360.65155764874;5363.766333743339;5371.274877891435;5093.974530127326;5257.868553286198;5266.526012658879;5283;5294.867628309323;5086.720230387216;5202.401723801811;5334.333208348957;5367.302250707383;5375.59683023767;5202.531772140525;5232.869178270574;5253.13323301651;5253.50091741284;5255.737213139404 16:11:22 INFO - PROCESS | 25659 | |5;yui.html;592.3325837766687;641.871625674865;653.1411194279522;655.9245686746019;658.298911659083;12854.421551030202;12863.935680321609;13467.326633668326;13498.257595832238;13510.189388636689;13180.20918744876;13539.796903046463;13553.186808791479;13556.728865422685;13564.186148831051;636.293713977487;754.8829931360648;780.3094261578487;780.9336206422432;781.1056340490136;754.7547047209652;762.4205603741169;762.4815125714512;776.6737970052563;779.5790273252466;816.9264766171043;817.8200795824908;819.3404309530825;819.6270696832956;822.5845947796355;814.3078383374144;814.5112932240668;818.0796603820702;820.9014918209853;822.5517093184199;599.5713065158433;599.601265158669;600.5975996082635;600.7506884642868;601.8465291350722;13096.541621043218;13112.803307950388;13114.672133196651;13137.60587182386;13153.671158221025;12700.682482937907;12774.425150868234;12842.807357889638;12943.158694684815;13106.60680179596;10508.283826246285;10528.315659482108;10555.155587553054;10600.681979540626;10627.36235825853;3206.88775892845;3224.9032529024166;3241.8865339712997;3261.2336101016244;3367.6800703933086;61719;62839.6858015707;64357.67821160864;64370.67814660943;65675.3432465674;9441;9692.660756873476;9852.11330980201;9878.802423951625;9942.552585133686;20162.29431969874;20244.493887652632;20311.695324570144;20536.38390848277;20638.484037899172;6367.204099487564;6527.934720652827;6638.4689224861895;6723.22682891464;6740.921452567565;3801.4487899255005;3805.790681512488;3814.2048661581903;3815.9236815264094;3852.9036774080873;2714.6742390912823;2853.4150499147627;2859.442408730319;2865.28367908023;2866.2834291427143;499.83505443203654;500.8847964968078;505.26736232463077;507.6142131979722;513.2070950381669;475.64564399521885;510.2346480279581;547.3213215612691;561.332014902265;564.2608183279916;6943.270956549591;7711.0746710395115;7826.726064587712;7833.686652533835;8131.308838748654;466.46589654845013;534.6150771444632;547.805529037186;562.3841893127019;567.6820980251073;3445.672661097192;3502.5446691929887;3513.8945831624583;3515.57813062429;3578.588462326814;53002.20496692553;53126.734366327924;53660.46339536633;54211.18683219755;86689.1331086681;83168;83426;84264;85592.57203714066;87763.56118219368;73459;73824.63087684635;74516.62741686366;76262.61868690621;77423.61288193523;6637.867242655023;6719.764808231688;6759.526833121831;6944.930550694428;6965.895511567432;46809.765951170026;47094.52905470901;47193.76403117963;47274.290885637434;49397;54422.45577544174;55366.72316638391;57480.13779793223;57666.42333576611;61142.38857611367;11447.97236078343;11477.08183345347;11812.82280765772;11841.881581184078;11861.169718119649;12782.424790884246;12990.610281691565;13135.146215495963;13140.934295328461;13270.27013514266;11870.881291187323;12659.430325635552;12703.872961270268;12758.48966041348;12912;12008.219465734699;12531.561395351118;12590.496380144692;12922.483100675867;13037.348132593143;10461.215408844519;10631.202659800701;12076.939615301868;12465.688357791129;12468.376581170724;10028.398296102258;10346;10475.580976760844;10572.577096916037;10708;9054.864177037218;9630.47032413224;10198.643047493302;10607.650863146073;10742.462876855969 16:11:22 INFO - PROCESS | 25659 | __end_tp_report 16:11:22 INFO - PROCESS | 25659 | __start_cc_report 16:11:22 INFO - PROCESS | 25659 | _x_x_mozilla_cycle_collect,367 16:11:22 INFO - PROCESS | 25659 | __end_cc_report 16:11:22 INFO - PROCESS | 25659 | __startTimestamp1469574682453__endTimestamp 16:11:22 INFO - PROCESS | 25659 | 16:11:22 INFO - PROCESS | 25659 | ------- Summary: start ------- 16:11:22 INFO - PROCESS | 25659 | Number of tests: 6 16:11:22 INFO - PROCESS | 25659 | 16:11:22 INFO - PROCESS | 25659 | [#0] dojo.html Cycles:165 Average:4777.64 Median:4881.49 stddev:488.81 (10.0%) stddev-sans-first:461.45 16:11:22 INFO - PROCESS | 25659 | Values: 2668.4 2682.9 2704.4 2707.6 2722.3 4770.6 4842.2 4877.2 4905.2 4921.7 4688.9 4741.1 4770.6 4802.1 4824.6 4319.2 4349.5 4426.8 4427.3 4533.4 4441.2 4451.4 4473.9 4484.9 4536.3 4375.8 4431.5 4435.8 4455.5 4471.5 4505.2 4512.1 4519.4 4541.7 4557.1 4455.5 4480.1 4483.7 4488.0 4494.9 4717.1 4740.1 4751.3 4753.9 4814.0 5113.8 5127.8 5134.4 5148.4 5160.3 5124.9 5150.1 5160.9 5178.0 5196.9 4664.7 4696.5 4747.5 4776.8 4777.3 5242.7 5245.4 5258.3 5267.8 5297.0 5019.9 5023.3 5052.2 5066.4 5123.2 5030.0 5124.7 5147.3 5163.2 5166.5 5112.4 5119.9 5146.4 5158.1 5177.0 5118.0 5127.3 5142.1 5169.6 5174.9 4350.6 4424.9 4470.4 4492.1 4540.5 3855.8 3880.4 3881.5 3916.1 3916.8 4467.5 4472.9 4484.9 4487.3 4541.8 5092.9 5234.9 5243.7 5271.1 5331.0 4486.8 4494.7 4509.1 4515.9 4556.3 4704.6 4729.5 4745.5 4754.1 4789.5 4672.3 4752.6 4777.5 4782.8 4862.1 5138.5 5171.6 5175.5 5183.6 5203.2 4829.7 4830.4 4832.4 4846.1 4886.9 5009.6 5044.5 5045.9 5057.2 5119.8 5156.9 5159.1 5159.1 5168.7 5172.4 4997.6 4999.0 5015.6 5021.5 5021.6 4934.1 4996.4 5028.6 5057.9 5109.6 4965.7 4969.8 4979.6 5017.4 5065.4 5118.1 5123.1 5129.2 5136.3 5140.6 4881.5 4941.7 4990.1 5021.8 5077.8 16:11:22 INFO - PROCESS | 25659 | 16:11:22 INFO - PROCESS | 25659 | [#1] ext.html Cycles:180 Average:48225.28 Median:36016.64 stddev:91960.20 (255.3%) stddev-sans-first:92148.53 16:11:22 INFO - PROCESS | 25659 | Values: 558.7 561.2 574.4 576.2 585.8 34911.3 38033.8 38154.2 38351.4 38356.8 39325.6 39569.6 39730.4 39773.4 39893.8 7658.5 7778.8 7800.8 7800.8 7812.3 7658.8 7663.1 7716.8 7740.1 7754.3 7764.5 7779.6 7806.8 7807.4 7821.2 7694.5 7710.7 7731.7 7736.0 7759.0 7614.7 7644.7 7698.2 7703.5 7741.4 36910.6 36994.0 37263.8 37515.2 37611.0 2854.5 3034.0 3087.4 3134.8 3428.9 28971.7 29283.6 29305.9 29607.4 29644.6 3044.3 3071.4 3208.6 3227.7 3233.2 271503.0 273636.0 274634.0 274830.6 275271.0 31384.5 32132.2 54640.5 54814.7 55437.4 33233.8 33451.5 33516.2 33564.8 33564.8 13659.4 13760.8 13814.4 13838.8 13858.3 11266.4 11353.0 11396.8 11431.5 11436.4 7794.9 7803.6 7818.2 7879.0 7931.0 3005.1 3073.6 3097.5 3113.4 3129.8 837.9 886.7 889.8 917.5 959.0 27607.3 27973.0 28002.7 28482.1 28888.1 912.6 929.5 940.3 977.5 987.7 14127.6 14829.1 14887.5 15033.7 15094.0 398304.0 400615.0 401788.0 402415.0 404673.0 50083.5 50084.2 50465.5 50575.2 50591.5 1204.8 1214.3 1226.3 1235.8 1237.1 26391.9 27552.7 28586.4 28974.0 29166.7 42417.4 43131.8 43215.0 43272.3 43326.6 353179.0 355116.0 355336.0 357096.0 359221.0 23344.8 23620.6 24931.4 25710.4 25879.6 41212.4 41299.8 41807.1 42148.8 42895.8 34547.0 35341.5 35649.0 35944.8 36088.5 35940.6 36117.3 36188.8 36380.5 36554.3 32599.7 34537.7 35051.8 36823.3 37633.0 30980.5 33212.0 33224.2 33307.0 33337.0 25282.7 25566.5 26109.5 26211.3 26346.9 16:11:22 INFO - PROCESS | 25659 | 16:11:22 INFO - PROCESS | 25659 | [#2] jquery.html Cycles:180 Average:23624.57 Median:40118.70 stddev:56149.69 (140.0%) stddev-sans-first:56280.04 16:11:22 INFO - PROCESS | 25659 | Values: 362.1 376.6 377.1 377.4 385.7 16036.4 17017.1 17608.9 17624.9 17729.8 16467.3 16980.9 17363.1 17450.3 17498.5 4751.9 4914.2 4917.8 4918.4 4920.1 3766.3 5073.1 5734.9 6016.2 6043.7 5996.9 6133.8 6141.4 6155.2 6157.8 6286.7 6574.2 6620.3 6813.1 6816.6 6508.1 6514.3 6520.4 6549.9 6570.1 22502.9 23347.2 23881.5 24032.0 24036.9 1846.2 1877.6 2021.2 2084.9 2653.4 13734.7 14570.7 15111.0 15172.2 15179.0 1869.6 1872.6 1886.9 1919.3 1931.4 80454.6 82339.0 82554.0 83896.6 84261.6 8434.4 8838.7 8950.7 9171.8 9174.5 11919.5 11983.9 12002.3 12004.6 12019.4 6705.2 6806.5 6944.2 7107.9 7195.1 6609.8 6700.7 6779.5 7031.1 7102.2 3554.8 3570.3 3640.6 3662.1 3710.5 1654.9 1689.5 1769.7 1830.9 1838.2 787.3 818.2 827.1 841.8 877.6 16720.3 16889.3 17138.7 17635.9 17770.4 819.5 837.0 843.4 844.0 892.4 7695.7 9620.4 9708.5 9821.7 9851.9 287107.0 294457.0 294847.0 384520.0 388840.0 59451.4 85781.1 90436.5 91310.0 91507.5 887.3 906.5 928.4 940.6 942.5 15657.2 15673.5 15846.1 15947.4 16756.0 38309.2 39448.8 39560.8 39596.2 40641.2 55605.7 55938.7 57012.4 57177.0 57197.0 6463.1 6572.5 6753.9 6757.2 6912.1 8739.1 11428.4 11806.8 12171.8 12175.7 9970.3 10149.1 10420.2 10421.2 10475.8 10568.3 10570.4 10598.3 10845.5 10929.2 10241.2 10249.5 10289.7 10357.3 10437.9 6938.2 7175.7 7193.1 7304.0 7405.0 8527.9 9907.4 10087.9 10132.5 10462.9 16:11:22 INFO - PROCESS | 25659 | 16:11:22 INFO - PROCESS | 25659 | [#3] mootools.html Cycles:180 Average:5142.84 Median:5122.08 stddev:2962.32 (57.8%) stddev-sans-first:2957.05 16:11:22 INFO - PROCESS | 25659 | Values: 1368.2 1401.9 1460.7 1634.7 1713.4 6862.9 7557.7 7679.3 8294.7 8314.8 7723.7 7757.8 7773.3 7787.8 7801.9 2142.3 2179.6 2180.7 2181.6 2184.6 2127.6 2177.4 2186.3 2193.2 2197.5 2154.6 2181.8 2188.0 2188.2 2196.5 2130.2 2138.2 2142.6 2143.7 2145.9 2064.2 2106.0 2112.2 2119.8 2121.5 7804.6 7805.1 7812.2 7822.9 7836.5 4643.1 4714.8 4728.8 4748.4 4758.6 2645.9 2685.3 2693.4 2719.6 2747.6 805.3 831.8 833.2 846.5 852.1 10957.8 10958.8 10980.5 10999.4 11025.3 4084.3 4223.9 4357.7 4364.0 4382.0 9212.8 9342.4 9345.0 9376.4 9382.5 4751.7 4761.9 4781.0 4799.7 4800.5 3736.7 4109.3 4283.4 4355.2 4361.8 3709.9 3743.1 3778.8 3843.8 3861.5 1199.3 1209.9 1242.4 1248.7 1253.4 740.6 743.9 777.9 803.2 839.6 5111.7 5137.0 5162.9 5198.5 5283.3 403.7 407.1 409.4 416.4 419.9 3444.6 3476.2 3496.4 3528.7 3594.6 9489.0 9735.9 9818.1 9899.8 9903.0 9833.7 9862.6 9864.2 9881.8 9884.7 7050.4 7235.8 7276.0 7308.9 7377.2 5132.4 5221.1 5241.8 5244.9 5381.5 8869.2 9040.8 9083.2 9089.1 9104.5 9092.5 9142.5 9149.4 9264.4 9367.6 6239.0 6695.4 6780.8 6940.1 7091.5 7342.0 7412.9 7452.0 7463.9 7479.7 6539.6 6556.8 6624.8 6698.7 6893.3 6638.5 6657.1 6677.0 6755.5 6775.4 6341.6 6423.6 6426.1 6430.8 6439.8 4264.4 4300.4 4318.8 4329.6 4354.1 4154.4 4177.9 4191.2 4206.0 4219.1 16:11:22 INFO - PROCESS | 25659 | 16:11:22 INFO - PROCESS | 25659 | [#4] prototype.html Cycles:180 Average:4395.32 Median:5057.20 stddev:1294.60 (25.6%) stddev-sans-first:1261.14 16:11:22 INFO - PROCESS | 25659 | Values: 295.9 298.2 302.2 303.6 304.2 5042.5 5117.9 5121.3 5128.5 5131.0 5021.6 5038.4 5054.0 5054.7 5059.7 3713.9 3824.4 3904.9 3943.9 3952.4 3934.0 3942.6 3946.5 3955.8 3970.4 3914.4 3925.4 3925.5 3928.3 3935.9 3821.4 3910.0 3930.4 3934.3 3937.8 3451.0 3454.2 3462.6 3467.2 3470.4 4887.9 4895.5 4896.1 4922.8 4931.1 4314.9 4455.5 4481.0 4487.2 4490.9 5210.3 5212.2 5256.0 5256.4 5270.9 3731.8 3733.7 3736.9 3742.8 3748.3 5341.8 5534.2 5537.3 5540.7 5563.1 3830.1 3838.7 3854.3 3859.6 3865.5 3913.7 3915.7 3916.9 3924.8 3938.8 4446.6 4452.3 4462.4 4476.5 4497.2 4981.6 5268.9 5306.9 5316.2 5330.4 1317.5 1327.7 1331.3 1332.2 1334.7 799.5 826.4 838.3 839.2 841.9 4434.9 4503.2 4602.9 4655.6 4658.9 5481.5 5492.8 5495.5 5515.6 5516.4 4625.9 4646.2 4666.2 4668.3 4668.9 2765.8 2908.3 2914.3 2933.7 2936.6 5070.7 5091.6 5133.6 5140.4 5143.6 5369.5 5614.4 5624.9 5634.7 5647.5 5121.9 5124.2 5128.3 5136.7 5139.6 5499.5 5511.2 5515.9 5538.9 5549.6 5206.3 5432.8 5433.3 5433.6 5486.7 5108.8 5112.2 5122.5 5126.5 5152.5 3757.8 3779.0 3784.1 3784.7 3809.6 5403.9 5422.9 5484.9 5500.9 5554.8 5328.5 5332.8 5335.7 5349.6 5360.2 5333.4 5339.6 5360.7 5363.8 5371.3 5094.0 5257.9 5266.5 5283.0 5294.9 5086.7 5202.4 5334.3 5367.3 5375.6 5202.5 5232.9 5253.1 5253.5 5255.7 16:11:22 INFO - PROCESS | 25659 | 16:11:22 INFO - PROCESS | 25659 | [#5] yui.html Cycles:180 Average:16794.00 Median:500.36 stddev:22782.92 (4553.3%) stddev-sans-first:22814.35 16:11:22 INFO - PROCESS | 25659 | Values: 592.3 641.9 653.1 655.9 658.3 12854.4 12863.9 13467.3 13498.3 13510.2 13180.2 13539.8 13553.2 13556.7 13564.2 636.3 754.9 780.3 780.9 781.1 754.8 762.4 762.5 776.7 779.6 816.9 817.8 819.3 819.6 822.6 814.3 814.5 818.1 820.9 822.6 599.6 599.6 600.6 600.8 601.8 13096.5 13112.8 13114.7 13137.6 13153.7 12700.7 12774.4 12842.8 12943.2 13106.6 10508.3 10528.3 10555.2 10600.7 10627.4 3206.9 3224.9 3241.9 3261.2 3367.7 61719.0 62839.7 64357.7 64370.7 65675.3 9441.0 9692.7 9852.1 9878.8 9942.6 20162.3 20244.5 20311.7 20536.4 20638.5 6367.2 6527.9 6638.5 6723.2 6740.9 3801.4 3805.8 3814.2 3815.9 3852.9 2714.7 2853.4 2859.4 2865.3 2866.3 499.8 500.9 505.3 507.6 513.2 475.6 510.2 547.3 561.3 564.3 6943.3 7711.1 7826.7 7833.7 8131.3 466.5 534.6 547.8 562.4 567.7 3445.7 3502.5 3513.9 3515.6 3578.6 53002.2 53126.7 53660.5 54211.2 86689.1 83168.0 83426.0 84264.0 85592.6 87763.6 73459.0 73824.6 74516.6 76262.6 77423.6 6637.9 6719.8 6759.5 6944.9 6965.9 46809.8 47094.5 47193.8 47274.3 49397.0 54422.5 55366.7 57480.1 57666.4 61142.4 11448.0 11477.1 11812.8 11841.9 11861.2 12782.4 12990.6 13135.1 13140.9 13270.3 11870.9 12659.4 12703.9 12758.5 12912.0 12008.2 12531.6 12590.5 12922.5 13037.3 10461.2 10631.2 12076.9 12465.7 12468.4 10028.4 10346.0 10475.6 10572.6 10708.0 9054.9 9630.5 10198.6 10607.7 10742.5 16:11:22 INFO - PROCESS | 25659 | -------- Summary: end -------- 16:11:22 INFO - PROCESS | 25659 | 16:11:23 INFO - TEST-INFO | 25659: exit 0 16:11:23 INFO - TEST-OK | dromaeo_css | took 1117491ms 16:11:23 INFO - TEST-START | kraken 16:11:23 INFO - operating with platform_type : linux_ 16:11:23 INFO - Initialising browser for kraken test... 16:11:23 INFO - TEST-INFO | started process 25903 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDzz1Sr/profile http://localhost:41743/getInfo.html) 16:11:26 INFO - PROCESS | 25903 | JavaScript error: , line 0: uncaught exception: undefined 16:11:27 INFO - PROCESS | 25903 | __metrics Screen width/height:1600/1200 16:11:27 INFO - PROCESS | 25903 | colorDepth:24 16:11:27 INFO - PROCESS | 25903 | Browser inner width/height: 1024/697 16:11:27 INFO - PROCESS | 25903 | __metrics 16:11:28 ERROR - PROCESS | 25903 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 16:11:29 INFO - TEST-INFO | 25903: exit 0 16:11:29 INFO - Browser initialized. 16:11:29 INFO - Running cycle 1/1 for kraken test... 16:11:29 INFO - TEST-INFO | started process 26025 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDzz1Sr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:11:41 INFO - PROCESS | 26025 | RSS: Main: 165797888 16:11:41 INFO - PROCESS | 26025 | 16:11:44 INFO - PROCESS | 26025 | Cycle 1(1): loaded http://localhost:41743/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41743/tests/kraken/driver.html?testName=audio-beat-detection) 16:11:45 INFO - PROCESS | 26025 | RSS: Main: 171241472 16:11:45 INFO - PROCESS | 26025 | 16:11:47 INFO - PROCESS | 26025 | Cycle 1(1): loaded http://localhost:41743/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41743/tests/kraken/driver.html?testName=audio-dft) 16:11:48 INFO - PROCESS | 26025 | RSS: Main: 170057728 16:11:48 INFO - PROCESS | 26025 | 16:11:51 INFO - PROCESS | 26025 | Cycle 1(1): loaded http://localhost:41743/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41743/tests/kraken/driver.html?testName=audio-fft) 16:11:52 INFO - PROCESS | 26025 | RSS: Main: 166330368 16:11:52 INFO - PROCESS | 26025 | 16:11:54 INFO - PROCESS | 26025 | Cycle 1(1): loaded http://localhost:41743/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41743/tests/kraken/driver.html?testName=audio-oscillator) 16:11:54 INFO - PROCESS | 26025 | RSS: Main: 167297024 16:11:54 INFO - PROCESS | 26025 | 16:11:57 INFO - PROCESS | 26025 | Cycle 1(1): loaded http://localhost:41743/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41743/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:11:57 INFO - PROCESS | 26025 | RSS: Main: 167903232 16:11:57 INFO - PROCESS | 26025 | 16:12:01 INFO - PROCESS | 26025 | Cycle 1(1): loaded http://localhost:41743/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41743/tests/kraken/driver.html?testName=imaging-darkroom) 16:12:01 INFO - PROCESS | 26025 | RSS: Main: 167780352 16:12:01 INFO - PROCESS | 26025 | 16:12:05 INFO - PROCESS | 26025 | Cycle 1(1): loaded http://localhost:41743/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41743/tests/kraken/driver.html?testName=imaging-desaturate) 16:12:05 INFO - PROCESS | 26025 | RSS: Main: 164933632 16:12:05 INFO - PROCESS | 26025 | 16:12:08 INFO - PROCESS | 26025 | Cycle 1(1): loaded http://localhost:41743/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41743/tests/kraken/driver.html?testName=json-parse-financial) 16:12:09 INFO - PROCESS | 26025 | RSS: Main: 166785024 16:12:09 INFO - PROCESS | 26025 | 16:12:11 INFO - PROCESS | 26025 | Cycle 1(1): loaded http://localhost:41743/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41743/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:12:11 INFO - PROCESS | 26025 | RSS: Main: 167137280 16:12:11 INFO - PROCESS | 26025 | 16:12:13 INFO - PROCESS | 26025 | Cycle 1(1): loaded http://localhost:41743/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41743/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:12:14 INFO - PROCESS | 26025 | RSS: Main: 167493632 16:12:14 INFO - PROCESS | 26025 | 16:12:16 INFO - PROCESS | 26025 | Cycle 1(1): loaded http://localhost:41743/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41743/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:12:17 INFO - PROCESS | 26025 | RSS: Main: 167825408 16:12:17 INFO - PROCESS | 26025 | 16:12:20 INFO - PROCESS | 26025 | Cycle 1(1): loaded http://localhost:41743/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41743/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:12:20 INFO - PROCESS | 26025 | RSS: Main: 168017920 16:12:20 INFO - PROCESS | 26025 | 16:12:23 INFO - PROCESS | 26025 | Cycle 1(1): loaded http://localhost:41743/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41743/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:12:24 INFO - PROCESS | 26025 | RSS: Main: 168628224 16:12:24 INFO - PROCESS | 26025 | 16:12:26 INFO - PROCESS | 26025 | Cycle 1(1): loaded http://localhost:41743/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41743/tests/kraken/driver.html?testName=ai-astar) 16:12:26 INFO - PROCESS | 26025 | RSS: Main: 169299968 16:12:26 INFO - PROCESS | 26025 | 16:12:26 INFO - PROCESS | 26025 | __start_tp_report 16:12:26 INFO - PROCESS | 26025 | _x_x_mozilla_page_load 16:12:26 INFO - PROCESS | 26025 | _x_x_mozilla_page_load_details 16:12:26 INFO - PROCESS | 26025 | |i|pagename|runs| 16:12:26 INFO - PROCESS | 26025 | |0;ai-astar;108;120;111;116;115;114;116;114;114;115 16:12:26 INFO - PROCESS | 26025 | |1;audio-beat-detection;149;127;150;190;125;149;158;125;203;124 16:12:26 INFO - PROCESS | 26025 | |2;audio-dft;163;163;167;173;161;164;163;164;162;162 16:12:26 INFO - PROCESS | 26025 | |3;audio-fft;76;76;77;178;79;76;76;79;160;77 16:12:26 INFO - PROCESS | 26025 | |4;audio-oscillator;87;85;148;85;87;86;147;86;86;140 16:12:26 INFO - PROCESS | 26025 | |5;imaging-gaussian-blur;118;118;117;118;117;118;118;119;118;118 16:12:26 INFO - PROCESS | 26025 | |6;imaging-darkroom;150;147;149;148;149;148;147;148;148;148 16:12:26 INFO - PROCESS | 26025 | |7;imaging-desaturate;95;95;100;96;96;97;96;96;96;96 16:12:26 INFO - PROCESS | 26025 | |8;json-parse-financial;61;67;62;62;63;61;62;61;60;62 16:12:26 INFO - PROCESS | 26025 | |9;json-stringify-tinderbox;67;66;67;66;66;66;67;66;66;66 16:12:26 INFO - PROCESS | 26025 | |10;stanford-crypto-aes;80;80;82;80;94;79;80;80;85;81 16:12:26 INFO - PROCESS | 26025 | |11;stanford-crypto-ccm;137;130;148;134;131;131;132;140;175;140 16:12:26 INFO - PROCESS | 26025 | |12;stanford-crypto-pbkdf2;171;170;174;173;171;179;170;169;170;167 16:12:26 INFO - PROCESS | 26025 | |13;stanford-crypto-sha256-iterative;74;70;69;76;69;68;67;67;67;68 16:12:26 INFO - PROCESS | 26025 | __end_tp_report 16:12:26 INFO - PROCESS | 26025 | __start_cc_report 16:12:26 INFO - PROCESS | 26025 | _x_x_mozilla_cycle_collect,945 16:12:26 INFO - PROCESS | 26025 | __end_cc_report 16:12:26 INFO - PROCESS | 26025 | __startTimestamp1469574746256__endTimestamp 16:12:26 INFO - PROCESS | 26025 | 16:12:26 INFO - PROCESS | 26025 | ------- Summary: start ------- 16:12:26 INFO - PROCESS | 26025 | Number of tests: 14 16:12:26 INFO - PROCESS | 26025 | 16:12:26 INFO - PROCESS | 26025 | [#0] ai-astar Cycles:10 Average:114.30 Median:115.00 stddev:3.16 (2.8%) stddev-sans-first:2.40 16:12:26 INFO - PROCESS | 26025 | Values: 108.0 120.0 111.0 116.0 115.0 114.0 116.0 114.0 114.0 115.0 16:12:26 INFO - PROCESS | 26025 | 16:12:26 INFO - PROCESS | 26025 | [#1] audio-beat-detection Cycles:10 Average:150.00 Median:149.50 stddev:27.75 (18.6%) stddev-sans-first:29.43 16:12:26 INFO - PROCESS | 26025 | Values: 149.0 127.0 150.0 190.0 125.0 149.0 158.0 125.0 203.0 124.0 16:12:26 INFO - PROCESS | 26025 | 16:12:26 INFO - PROCESS | 26025 | [#2] audio-dft Cycles:10 Average:164.20 Median:163.50 stddev:3.49 (2.1%) stddev-sans-first:3.67 16:12:26 INFO - PROCESS | 26025 | Values: 163.0 163.0 167.0 173.0 161.0 164.0 163.0 164.0 162.0 162.0 16:12:26 INFO - PROCESS | 26025 | 16:12:26 INFO - PROCESS | 26025 | [#3] audio-fft Cycles:10 Average:95.40 Median:76.50 stddev:39.04 (51.0%) stddev-sans-first:40.77 16:12:26 INFO - PROCESS | 26025 | Values: 76.0 76.0 77.0 178.0 79.0 76.0 76.0 79.0 160.0 77.0 16:12:26 INFO - PROCESS | 26025 | 16:12:26 INFO - PROCESS | 26025 | [#4] audio-oscillator Cycles:10 Average:103.70 Median:86.00 stddev:28.58 (33.2%) stddev-sans-first:29.67 16:12:26 INFO - PROCESS | 26025 | Values: 87.0 85.0 148.0 85.0 87.0 86.0 147.0 86.0 86.0 140.0 16:12:26 INFO - PROCESS | 26025 | 16:12:26 INFO - PROCESS | 26025 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 16:12:26 INFO - PROCESS | 26025 | Values: 118.0 118.0 117.0 118.0 117.0 118.0 118.0 119.0 118.0 118.0 16:12:26 INFO - PROCESS | 26025 | 16:12:26 INFO - PROCESS | 26025 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:0.92 (0.6%) stddev-sans-first:0.71 16:12:26 INFO - PROCESS | 26025 | Values: 150.0 147.0 149.0 148.0 149.0 148.0 147.0 148.0 148.0 148.0 16:12:26 INFO - PROCESS | 26025 | 16:12:26 INFO - PROCESS | 26025 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:1.42 (1.5%) stddev-sans-first:1.42 16:12:26 INFO - PROCESS | 26025 | Values: 95.0 95.0 100.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 16:12:26 INFO - PROCESS | 26025 | 16:12:26 INFO - PROCESS | 26025 | [#8] json-parse-financial Cycles:10 Average:62.10 Median:62.00 stddev:1.91 (3.1%) stddev-sans-first:1.99 16:12:26 INFO - PROCESS | 26025 | Values: 61.0 67.0 62.0 62.0 63.0 61.0 62.0 61.0 60.0 62.0 16:12:26 INFO - PROCESS | 26025 | 16:12:26 INFO - PROCESS | 26025 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 16:12:26 INFO - PROCESS | 26025 | Values: 67.0 66.0 67.0 66.0 66.0 66.0 67.0 66.0 66.0 66.0 16:12:26 INFO - PROCESS | 26025 | 16:12:26 INFO - PROCESS | 26025 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:80.50 stddev:4.51 (5.6%) stddev-sans-first:4.72 16:12:26 INFO - PROCESS | 26025 | Values: 80.0 80.0 82.0 80.0 94.0 79.0 80.0 80.0 85.0 81.0 16:12:26 INFO - PROCESS | 26025 | 16:12:26 INFO - PROCESS | 26025 | [#11] stanford-crypto-ccm Cycles:10 Average:139.80 Median:138.50 stddev:13.58 (9.8%) stddev-sans-first:14.37 16:12:26 INFO - PROCESS | 26025 | Values: 137.0 130.0 148.0 134.0 131.0 131.0 132.0 140.0 175.0 140.0 16:12:26 INFO - PROCESS | 26025 | 16:12:26 INFO - PROCESS | 26025 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.40 Median:171.00 stddev:3.31 (1.9%) stddev-sans-first:3.50 16:12:26 INFO - PROCESS | 26025 | Values: 171.0 170.0 174.0 173.0 171.0 179.0 170.0 169.0 170.0 167.0 16:12:26 INFO - PROCESS | 26025 | 16:12:26 INFO - PROCESS | 26025 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:69.00 stddev:3.10 (4.5%) stddev-sans-first:2.83 16:12:26 INFO - PROCESS | 26025 | Values: 74.0 70.0 69.0 76.0 69.0 68.0 67.0 67.0 67.0 68.0 16:12:26 INFO - PROCESS | 26025 | -------- Summary: end -------- 16:12:26 INFO - PROCESS | 26025 | 16:12:27 INFO - TEST-INFO | 26025: exit 0 16:12:27 INFO - TEST-OK | kraken | took 64087ms 16:12:27 INFO - SUITE-END | took 1181s 16:12:27 INFO - Completed test suite (00:19:41) 16:12:27 INFO - javascript benchmark 16:12:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6380.126988208448, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2668.426288348005, 2682.8792704328303, 2704.364474348528, 2707.6073969274457, 2722.305812017936, 4770.6422018348585, 4842.201036828919, 4877.244027175789, 4905.239687848385, 4921.70469771814, 4688.85933421997, 4741.146593613148, 4770.570648641621, 4802.06359759847, 4824.61403087753, 4319.179355922364, 4349.456317960255, 4426.822927082912, 4427.335899615067, 4533.387992621004, 4441.244988351972, 4451.443569553806, 4473.932891006638, 4484.910301793962, 4536.296873984521, 4375.78121093944, 4431.512533621299, 4435.756033418161, 4455.532169122261, 4471.463424389094, 4505.189065968125, 4512.12013657337, 4519.367288579601, 4541.704789188725, 4557.0885822835235, 4455.532169122228, 4480.081583275421, 4483.708558943658, 4487.955120448786, 4494.9325760113625, 4717.080169366975, 4740.07568524138, 4751.263554149113, 4753.881152971168, 4813.975930120362, 5113.795448182068, 5127.7948882044675, 5134.383873935114, 5148.382194136728, 5160.329157209576, 5124.92312615311, 5150.098732721759, 5160.92258616121, 5178.0, 5196.948030519722, 4664.743439110814, 4696.459907110658, 4747.501512341223, 4776.785044672998, 4777.307290442901, 5242.7378631068295, 5245.370555533361, 5258.290130832365, 5267.762950667229, 5296.973515132399, 5019.899602007939, 5023.271625614266, 5052.166392545262, 5066.392032955995, 5123.205903085028, 5029.974850125726, 5124.692518448905, 5147.305113809588, 5163.199704045879, 5166.509181627739, 5112.437631860493, 5119.87200319995, 5146.433892271847, 5158.123119069767, 5176.974115129476, 5118.0, 5127.282180494733, 5142.100132476801, 5169.586433085344, 5174.896502069938, 4350.630196433275, 4424.933625995613, 4470.418845550123, 4492.146492166543, 4540.477845047862, 3855.8014052830667, 3880.359740642819, 3881.4565960765517, 3916.118873253495, 3916.823742931575, 4467.530909254481, 4472.888177795516, 4484.865454036384, 4487.259602165606, 4541.841035563805, 5092.898142037138, 5234.869128271747, 5243.659162154448, 5271.103912334912, 5331.040412725747, 4486.775661216926, 4494.70784399013, 4509.075639493896, 4515.864524064284, 4556.2937744649635, 4704.576588107018, 4729.503402142795, 4745.501722319176, 4754.144254034238, 4789.521047895182, 4672.299155126758, 4752.643551733634, 4777.498362672009, 4782.808687652455, 4862.124817532878, 5138.486151384832, 5171.586273098068, 5175.534201921845, 5183.611229157904, 5203.19350500673, 4829.710217386968, 4830.372051633265, 4832.371791667061, 4846.127697014571, 4886.9022619546695, 5009.649324547247, 5044.495550444926, 5045.8738531537, 5057.216131499624, 5119.795208191631, 5156.896862062663, 5159.071367153948, 5159.122949098737, 5168.664036837594, 5172.353455818023, 4997.575206107522, 4998.975005124951, 5015.648904576645, 5021.49785021495, 5021.6484846061885, 4934.136526107988, 4996.375453068366, 5028.572571331478, 5057.924131138109, 5109.565686916654, 4965.726885021359, 4969.801207951641, 4979.626528010342, 5017.397912250553, 5065.4428012917815, 5118.053160165381, 5123.129068058513, 5129.230615407719, 5136.280920671034, 5140.640155189101, 4881.48744381849, 4941.678790878582, 4990.076835785246, 5021.799128034838, 5077.847664570068], "value": 4746.883991599016, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.7178474870187, 561.1974875927424, 574.4198359656747, 576.1703147467646, 585.81546812754, 34911.27218195451, 38033.80983095084, 38154.23691526171, 38351.42472862909, 38356.808215958954, 39325.60674393255, 39569.61506347278, 39730.404043939365, 39773.40339894904, 39893.800530997374, 7658.54048757075, 7778.805529861742, 7800.80497987552, 7800.843983120362, 7812.257835505618, 7658.770236892902, 7663.118741344761, 7716.807079823021, 7740.148583655793, 7754.263344982218, 7764.534127952313, 7779.649915753805, 7806.804829879242, 7807.4144439167, 7821.178776228499, 7694.5383277003275, 7710.689182838874, 7731.652075656609, 7736.032995875516, 7758.961205193994, 7614.657340419694, 7644.694212231504, 7698.1916898725385, 7703.46075774696, 7741.419393545507, 36910.630893690985, 36994.0, 37263.81368093169, 37515.24969500595, 37611.0, 2854.51473249546, 3033.9544906826413, 3087.4442600332154, 3134.7648926330617, 3428.862845486178, 28971.710282897322, 29283.560746588817, 29305.853470732724, 29607.407851843058, 29644.555331670043, 3044.2693753499, 3071.370369074357, 3208.6470488246273, 3227.725643320297, 3233.2240262337104, 271503.0, 273636.0, 274634.0, 274830.62584687147, 275271.0, 31384.529232061537, 32132.19669508281, 54640.45359546433, 54814.72592637091, 55437.44562554404, 33233.83383083069, 33451.49822752661, 33516.162095947795, 33564.832175838965, 33564.832175838965, 13659.385327660279, 13760.793588096187, 13814.447422103003, 13838.792418113737, 13858.307084645727, 11266.43667816606, 11353.0, 11396.829047564293, 11431.542738290542, 11436.370999594936, 7794.883076753853, 7803.609819509002, 7818.179091195457, 7878.960605196938, 7931.048274207132, 3005.0984704588536, 3073.585066016059, 3097.4579448596855, 3113.3617608390227, 3129.7809153359503, 837.9078301386843, 886.6807949138305, 889.7686601483531, 917.5366439947784, 958.9547393341152, 27607.30981725473, 27973.02094426726, 28002.719972800012, 28482.145535633965, 28888.133355999355, 912.5665308978182, 929.5445231836487, 940.3370623710268, 977.452626529146, 987.6740675577042, 14127.576172714835, 14829.146326943615, 14887.47893823711, 15033.699326013637, 15094.0, 398304.0, 400615.0, 401788.0, 402415.0, 404673.0, 50083.499165008616, 50084.248736268986, 50465.49534504682, 50575.24137137946, 50591.49408505868, 1204.8430741274742, 1214.313912639356, 1226.2887525235342, 1235.7528494301175, 1237.127824883455, 26391.944322226896, 27552.724472755017, 28586.42827143404, 28973.985910493033, 29166.708332916398, 42417.36373954331, 43131.78434107809, 43215.0, 43272.321852642875, 43326.566734333515, 353179.0, 355116.0, 355336.0, 357096.0, 359221.0, 23344.832758362354, 23620.645690314315, 24931.37671558153, 25710.357241069123, 25879.61180582255, 41212.38181427221, 41299.793501032305, 41807.118679660096, 42148.789256053526, 42895.7855210722, 34547.0, 35341.46987795237, 35649.0, 35944.820275899496, 36088.4586731194, 35940.56237750565, 36117.27765444729, 36188.819055904554, 36380.454293185096, 36554.268914621025, 32599.674003259664, 34537.65462345345, 35051.82474087613, 36823.26353472969, 37633.0, 30980.535291970187, 33212.0, 33224.1693957653, 33307.0, 33337.0, 25282.747172528037, 25566.488670226863, 26109.477810443306, 26211.344716382242, 26346.868265658548], "value": 16456.052171224394, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.0712871484642, 376.6309017163182, 377.12695110818464, 377.4018181182825, 385.6914468425261, 16036.358545658175, 17017.14914254287, 17608.91195544024, 17624.911875440637, 17729.822701772977, 16467.34130634776, 16980.915095424538, 17363.09006009341, 17450.30198792047, 17498.475045748648, 4751.857444276678, 4914.189158788796, 4917.754112294371, 4918.409790825106, 4920.065187614342, 3766.2655782122497, 5073.137566613685, 5734.856628584298, 6016.187814645033, 6043.7280322385595, 5996.940030599703, 6133.846653833645, 6141.416565426277, 6155.230596175478, 6157.7536898524, 6286.685665716719, 6574.2110946686225, 6620.337966203389, 6813.080234168373, 6816.556923799937, 6508.121403610499, 6514.250861150934, 6520.380563846475, 6549.869002619921, 6570.113034740297, 22502.887485562467, 23347.182848600387, 23881.522369552684, 24032.0, 24036.879815600983, 1846.1784505894882, 1877.6244751049844, 2021.191523390641, 2084.8749075055543, 2653.4295126547886, 13734.725305493934, 14570.708585828224, 15111.0, 15172.24138793067, 15179.0, 1869.5980364221757, 1872.5880306332585, 1886.9339573114876, 1919.3282351177115, 1931.381957773513, 80454.59772701157, 82339.0, 82554.0, 83896.58051709764, 84261.57869210615, 8434.367422443342, 8838.690645827364, 8950.731478055668, 9171.770705732277, 9174.541272936327, 11919.52321907114, 11983.940080299542, 12002.339871306987, 12004.579839705742, 12019.399030048462, 6705.195376554844, 6806.4554835613035, 6944.166699996033, 7107.8933815992805, 7195.100612423447, 6609.768658096944, 6700.698468568926, 6779.49153813466, 7031.0859588254225, 7102.218755936843, 3554.7689400188906, 3570.2680950405106, 3640.6177351378255, 3662.102784817737, 3710.4601590339707, 1654.9007059576463, 1689.4762623586728, 1769.7079981803115, 1830.9271799352632, 1838.2463190092265, 787.3189690917316, 818.1981657975217, 827.0736774812128, 841.848467275884, 877.6182360673128, 16720.331186752635, 16889.32442702278, 17138.657226855394, 17635.911820441073, 17770.378036768652, 819.512390127873, 836.9707060252983, 843.4475418600827, 843.9620217090246, 892.4243862708516, 7695.692172313156, 9620.422774633544, 9708.466034368177, 9821.705348839403, 9851.901480985242, 287107.0, 294457.0, 294847.0, 384520.0, 388840.0, 59451.405485945455, 85781.14218857732, 90436.54781726049, 91310.0, 91507.54246228727, 887.3433659092225, 906.4561263242002, 928.4382948316306, 940.5532372123323, 942.472215559289, 15657.217139143226, 15673.529794106194, 15846.12846293465, 15947.36210551565, 16756.0, 38309.23381532409, 39448.802755986035, 39560.802195988836, 39596.2080758389, 40641.18717625572, 55605.721971391504, 55938.72030639821, 57012.42987570071, 57177.0, 57197.0, 6463.095166676763, 6572.539922205399, 6753.898691519729, 6757.189137303555, 6912.135983002125, 8739.126087391463, 11428.371439570903, 11806.763864722829, 12171.75656486883, 12175.695607609527, 9970.252231082843, 10149.137323327599, 10420.166386689198, 10421.218408619536, 10475.790484190426, 10568.313059651098, 10570.365778053341, 10598.25812193139, 10845.457727113771, 10929.18031147683, 10241.180705543688, 10249.538770755185, 10289.691309260734, 10357.326773759682, 10437.895621043692, 6938.202106757585, 7175.748848790267, 7193.136823581203, 7304.0, 7405.0, 8527.872081918653, 9907.356021858555, 10087.949560252151, 10132.544035518273, 10462.947685261524], "value": 8386.321304088875, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1368.2201145347153, 1401.887848972082, 1460.685952520208, 1634.7302695055316, 1713.443130982431, 6862.931370686291, 7557.735479258227, 7679.308862202401, 8294.668213271461, 8314.83370332593, 7723.652435640395, 7757.844843103135, 7773.2615401536905, 7787.766367008999, 7801.92198078019, 2142.3251675722177, 2179.574982878339, 2180.6838008488758, 2181.596404665142, 2184.595849767798, 2127.638301488743, 2177.3794468576457, 2186.278528085736, 2193.2104442400723, 2197.494576247464, 2154.63371226891, 2181.836362272828, 2187.9562408751817, 2188.1794327127327, 2196.516766311409, 2130.2331160782105, 2138.2088627207954, 2142.646463333548, 2143.721316228896, 2145.914163433461, 2064.1743302678897, 2105.9578808423744, 2112.197365001305, 2119.788021197883, 2121.4908421978766, 7804.648790804427, 7805.141434442206, 7812.179721129256, 7822.921770782276, 7836.490628109154, 4643.141018911512, 4714.811407543694, 4728.787204575802, 4748.430188377382, 4758.595519380857, 2645.933851653705, 2685.342091187652, 2693.4343787804582, 2719.5920611908173, 2747.615333853262, 805.295366554265, 831.8211584509299, 833.1918039501674, 846.4794151596785, 852.1052894460792, 10957.83563246544, 10958.835617465744, 10980.505877235544, 10999.395033273167, 11025.283356581796, 4084.2852500812237, 4223.936640950388, 4357.694961352739, 4363.956360436355, 4382.035952090535, 9212.769680757901, 9342.439453632804, 9344.953275233716, 9376.437413755197, 9382.483963381943, 4751.738654374042, 4761.928571071437, 4781.043791241696, 4799.736014519235, 4800.4719480857075, 3736.7010639148803, 4109.3425051991535, 4283.357496375506, 4355.1725172217175, 4361.825526978949, 3709.9072523187137, 3743.1016556026357, 3778.7543809652284, 3843.788591627487, 3861.5366156061455, 1199.3103965220034, 1209.8548174218975, 1242.4222736427605, 1248.6753444104418, 1253.367049639926, 740.5889731199128, 743.8661041012562, 777.9027621547307, 803.1687203744096, 839.6473481137937, 5111.744412779346, 5137.0, 5162.896742065138, 5198.506141916512, 5283.282933046775, 403.6831087596223, 407.08812260536183, 409.39818466853677, 416.40662056569874, 419.93910882921807, 3444.621091679913, 3476.1657202271776, 3496.423090190141, 3528.7177025837873, 3594.5506811648543, 9488.952555237318, 9735.9026409735, 9818.116369526777, 9899.752506187402, 9902.950485247671, 9833.704988850346, 9862.605495780232, 9864.210863130933, 9881.802363952824, 9884.703458896245, 7050.435965122778, 7235.819104522429, 7275.963620181865, 7308.853822923512, 7377.188509264084, 5132.409772876167, 5221.060209162387, 5241.842744717665, 5244.921326180034, 5381.515663590296, 8869.201771840308, 9040.773980650536, 9083.18251357381, 9089.091090891123, 9104.453732776055, 9092.545372731205, 9142.542872856464, 9149.359544832065, 9264.351495395527, 9367.578458969227, 6238.968805156127, 6695.397414232548, 6780.762673306411, 6940.063091482585, 7091.468139889632, 7342.045534080536, 7412.851742965218, 7451.962740186264, 7463.850722985401, 7479.663415146223, 6539.574927629689, 6556.770513032212, 6624.8012559623285, 6698.66506674674, 6893.276205998298, 6638.535302528777, 6657.101291325609, 6677.0, 6755.493337999571, 6775.390214880685, 6341.619502829845, 6423.582467139621, 6426.132472116205, 6430.7749228776765, 6439.774607888701, 4264.4456220692355, 4300.397944287864, 4318.762468064161, 4329.631981281626, 4354.107407981292, 4154.4183814266635, 4177.91644167121, 4191.182719369694, 4205.957940420557, 4219.113986062961], "value": 4038.1535038103707, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.9334149816291, 298.1651376146788, 302.1991721936867, 303.6341208843344, 304.1969201308547, 5042.52096050875, 5117.897642047157, 5121.308623335854, 5128.53843154116, 5131.0, 5021.573166280861, 5038.370203724535, 5054.0, 5054.685781696758, 5059.723124593929, 3713.9229623409246, 3824.445455408964, 3904.882853514399, 3943.895709201414, 3952.426898099788, 3934.0361611405247, 3942.6254505821903, 3946.506686664167, 3955.7737101498483, 3970.424288478169, 3914.354131568288, 3925.411188321746, 3925.450436938831, 3928.2536318099615, 3935.8709825688647, 3821.426785982097, 3909.960900390988, 3930.351492003816, 3934.3082474535936, 3937.763734175944, 3451.0, 3454.222799870034, 3462.5844898612077, 3467.219875527986, 3470.3753324401596, 4887.853364399074, 4895.461499235082, 4896.1186986342445, 4922.75386230687, 4931.087748766454, 4314.892127696801, 4455.46534415869, 4480.977595112004, 4487.214737420938, 4490.865274041784, 5210.348706411699, 5212.192110222922, 5256.0, 5256.369235691704, 5270.947290527084, 3731.7574357666936, 3733.7386382953205, 3736.9439458408146, 3742.7941463219513, 3748.306563285801, 5341.839744807623, 5534.1975413565215, 5537.307836520435, 5540.722963851791, 5563.082091454905, 3830.138218900725, 3838.673712734449, 3854.3062248795486, 3859.556151042666, 3865.4781604483596, 3913.7064720146104, 3915.686745060388, 3916.9216615668097, 3924.823382947774, 3938.783366914847, 4446.644268458515, 4452.30989196675, 4462.419885414875, 4476.529964353696, 4497.168023915586, 4981.551660350586, 5268.92096618551, 5306.946930530722, 5316.175992721134, 5330.440303768049, 1317.4598414649947, 1327.7410904873457, 1331.261150061725, 1332.1740520877117, 1334.726381091874, 799.5122974985254, 826.3636999510344, 838.2958315015417, 839.2279103224926, 841.9139310289657, 4434.911301773946, 4503.211937910918, 4602.88492787683, 4655.627549796008, 4658.905157288034, 5481.479259470344, 5492.752826122834, 5495.477929596682, 5515.586331025189, 5516.448355164532, 4625.907481850344, 4646.233371493733, 4666.183417901853, 4668.323093151474, 4668.929966050512, 2765.7510824025935, 2908.2874695699265, 2914.3151359430517, 2933.691962343923, 2936.6329208848892, 5070.721110338966, 5091.592672586258, 5133.589312855037, 5140.434552199255, 5143.588512919032, 5369.516743493026, 5614.438556144353, 5624.887502249932, 5634.661920284714, 5647.463490968352, 5121.897562048813, 5124.180131179068, 5128.256402821645, 5136.691798492177, 5139.563137133386, 5499.477549632778, 5511.173324001432, 5515.917261241005, 5538.889222215453, 5549.611527193058, 5206.271122042993, 5432.809851655173, 5433.310511296775, 5433.646812957145, 5486.670799752028, 5108.846734597968, 5112.156494178419, 5122.487751224848, 5126.512981266774, 5152.510511501551, 3757.8496860125288, 3778.981105094457, 3784.110733977568, 3784.735068545175, 3809.561900381492, 5403.9459605403445, 5422.945770542244, 5484.862878428071, 5500.944990550203, 5554.777808887599, 5328.49379308965, 5332.840014799563, 5335.733213339395, 5349.625526213128, 5360.16917377807, 5333.359996800254, 5339.626226164131, 5360.65155764874, 5363.766333743339, 5371.274877891435, 5093.974530127326, 5257.868553286198, 5266.526012658879, 5283.0, 5294.867628309323, 5086.720230387216, 5202.401723801811, 5334.333208348957, 5367.302250707383, 5375.59683023767, 5202.531772140525, 5232.869178270574, 5253.13323301651, 5253.50091741284, 5255.737213139404], "value": 3974.4817356799354, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.3325837766687, 641.871625674865, 653.1411194279522, 655.9245686746019, 658.298911659083, 12854.421551030202, 12863.935680321609, 13467.326633668326, 13498.257595832238, 13510.189388636689, 13180.20918744876, 13539.796903046463, 13553.186808791479, 13556.728865422685, 13564.186148831051, 636.293713977487, 754.8829931360648, 780.3094261578487, 780.9336206422432, 781.1056340490136, 754.7547047209652, 762.4205603741169, 762.4815125714512, 776.6737970052563, 779.5790273252466, 816.9264766171043, 817.8200795824908, 819.3404309530825, 819.6270696832956, 822.5845947796355, 814.3078383374144, 814.5112932240668, 818.0796603820702, 820.9014918209853, 822.5517093184199, 599.5713065158433, 599.601265158669, 600.5975996082635, 600.7506884642868, 601.8465291350722, 13096.541621043218, 13112.803307950388, 13114.672133196651, 13137.60587182386, 13153.671158221025, 12700.682482937907, 12774.425150868234, 12842.807357889638, 12943.158694684815, 13106.60680179596, 10508.283826246285, 10528.315659482108, 10555.155587553054, 10600.681979540626, 10627.36235825853, 3206.88775892845, 3224.9032529024166, 3241.8865339712997, 3261.2336101016244, 3367.6800703933086, 61719.0, 62839.6858015707, 64357.67821160864, 64370.67814660943, 65675.3432465674, 9441.0, 9692.660756873476, 9852.11330980201, 9878.802423951625, 9942.552585133686, 20162.29431969874, 20244.493887652632, 20311.695324570144, 20536.38390848277, 20638.484037899172, 6367.204099487564, 6527.934720652827, 6638.4689224861895, 6723.22682891464, 6740.921452567565, 3801.4487899255005, 3805.790681512488, 3814.2048661581903, 3815.9236815264094, 3852.9036774080873, 2714.6742390912823, 2853.4150499147627, 2859.442408730319, 2865.28367908023, 2866.2834291427143, 499.83505443203654, 500.8847964968078, 505.26736232463077, 507.6142131979722, 513.2070950381669, 475.64564399521885, 510.2346480279581, 547.3213215612691, 561.332014902265, 564.2608183279916, 6943.270956549591, 7711.0746710395115, 7826.726064587712, 7833.686652533835, 8131.308838748654, 466.46589654845013, 534.6150771444632, 547.805529037186, 562.3841893127019, 567.6820980251073, 3445.672661097192, 3502.5446691929887, 3513.8945831624583, 3515.57813062429, 3578.588462326814, 53002.20496692553, 53126.734366327924, 53660.46339536633, 54211.18683219755, 86689.1331086681, 83168.0, 83426.0, 84264.0, 85592.57203714066, 87763.56118219368, 73459.0, 73824.63087684635, 74516.62741686366, 76262.61868690621, 77423.61288193523, 6637.867242655023, 6719.764808231688, 6759.526833121831, 6944.930550694428, 6965.895511567432, 46809.765951170026, 47094.52905470901, 47193.76403117963, 47274.290885637434, 49397.0, 54422.45577544174, 55366.72316638391, 57480.13779793223, 57666.42333576611, 61142.38857611367, 11447.97236078343, 11477.08183345347, 11812.82280765772, 11841.881581184078, 11861.169718119649, 12782.424790884246, 12990.610281691565, 13135.146215495963, 13140.934295328461, 13270.27013514266, 11870.881291187323, 12659.430325635552, 12703.872961270268, 12758.48966041348, 12912.0, 12008.219465734699, 12531.561395351118, 12590.496380144692, 12922.483100675867, 13037.348132593143, 10461.215408844519, 10631.202659800701, 12076.939615301868, 12465.688357791129, 12468.376581170724, 10028.398296102258, 10346.0, 10475.580976760844, 10572.577096916037, 10708.0, 9054.864177037218, 9630.47032413224, 10198.643047493302, 10607.650863146073, 10742.462876855969], "value": 6414.474428979482, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1581.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 120.0, 111.0, 116.0, 115.0, 114.0, 116.0, 114.0, 114.0, 115.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 127.0, 150.0, 190.0, 125.0, 149.0, 158.0, 125.0, 203.0, 124.0], "value": 150.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 167.0, 173.0, 161.0, 164.0, 163.0, 164.0, 162.0, 162.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 178.0, 79.0, 76.0, 76.0, 79.0, 160.0, 77.0], "value": 95.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 148.0, 85.0, 87.0, 86.0, 147.0, 86.0, 86.0, 140.0], "value": 103.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 119.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 147.0, 149.0, 148.0, 149.0, 148.0, 147.0, 148.0, 148.0, 148.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 100.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 67.0, 62.0, 62.0, 63.0, 61.0, 62.0, 61.0, 60.0, 62.0], "value": 62.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 66.0, 66.0, 66.0, 67.0, 66.0, 66.0, 66.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 82.0, 80.0, 94.0, 79.0, 80.0, 80.0, 85.0, 81.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 130.0, 148.0, 134.0, 131.0, 131.0, 132.0, 140.0, 175.0, 140.0], "value": 139.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 170.0, 174.0, 173.0, 171.0, 179.0, 170.0, 169.0, 170.0, 167.0], "value": 171.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 70.0, 69.0, 76.0, 69.0, 68.0, 67.0, 67.0, 67.0, 68.0], "value": 69.5, "unit": "score"}]}]} 16:12:27 INFO - Return code: 0 16:12:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:12:27 ERROR - # TBPL SUCCESS # 16:12:27 INFO - Running post-action listener: _resource_record_post_action 16:12:27 INFO - [mozharness: 2016-07-26 23:12:27.576653Z] Finished run-tests step (success) 16:12:27 INFO - Running post-run listener: _resource_record_post_run 16:12:27 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 547377152; Read time: 12; Write time: 524804 16:12:27 INFO - TinderboxPrint: CPU usage
13.3% 16:12:27 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 16:12:27 INFO - TinderboxPrint: I/O write bytes / time
547,377,152 / 524,804 16:12:27 INFO - TinderboxPrint: CPU idle
8,283.9 (86.6%) 16:12:27 INFO - TinderboxPrint: CPU user
1,218.2 (12.7%) 16:12:27 INFO - TinderboxPrint: Swap in / out
0 / 0 16:12:27 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 254332928; Read time: 0; Write time: 219980 16:12:27 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289214464; Read time: 12; Write time: 304220 16:12:28 INFO - Running post-run listener: _upload_blobber_files 16:12:28 INFO - Blob upload gear active. 16:12:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:12:28 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:12:28 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'] 16:12:28 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 16:12:28 INFO - (blobuploader) - INFO - Open directory for files ... 16:12:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:12:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:12:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:12:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:12:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:12:29 INFO - (blobuploader) - INFO - Done attempting. 16:12:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:12:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:12:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:12:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:12:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:12:30 INFO - (blobuploader) - INFO - Done attempting. 16:12:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:12:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:12:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:12:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:12:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:12:35 INFO - (blobuploader) - INFO - Done attempting. 16:12:35 INFO - (blobuploader) - INFO - Iteration through files over. 16:12:35 INFO - Return code: 0 16:12:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:12:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:12:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/86bfbcbaafdbf717855a51e41ade25ff5cb4fdce7441b4dc7425782eda5e5bb9d0a8383377b1ffbd4f048149880c57713b7f4db8256c7f59ecccc5cb6f11b520", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e832b984957d65b8de267bc531d944ec5a174e28fa986c92bf91f2558376e8a487199ed84b20d10a8bf41fe38210b0002f42e3f2610a9a47ee877e2c46e1c0a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/495943b861d490d1ee4a8e6f8b955d43bcfecf8e2ccf9be988e7ab4655bbb1047795fbf7385752adc8f26e9fa37bf4f70cb8aef3adf44def1fa5f6e810fb251e"} 16:12:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:12:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:12:35 INFO - Contents: 16:12:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/86bfbcbaafdbf717855a51e41ade25ff5cb4fdce7441b4dc7425782eda5e5bb9d0a8383377b1ffbd4f048149880c57713b7f4db8256c7f59ecccc5cb6f11b520", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e832b984957d65b8de267bc531d944ec5a174e28fa986c92bf91f2558376e8a487199ed84b20d10a8bf41fe38210b0002f42e3f2610a9a47ee877e2c46e1c0a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/495943b861d490d1ee4a8e6f8b955d43bcfecf8e2ccf9be988e7ab4655bbb1047795fbf7385752adc8f26e9fa37bf4f70cb8aef3adf44def1fa5f6e810fb251e"} 16:12:35 INFO - Running post-run listener: copy_logs_to_upload_dir 16:12:35 INFO - Copying logs to upload dir... 16:12:35 INFO - mkdir: /builds/slave/test/build/upload/logs 16:12:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.006120 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-26 16:12:35.734787) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 16:12:35.739027) ========= 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=652eb03db935cfc1c15ebda0000001ad-1469573423.216979-763374323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/86bfbcbaafdbf717855a51e41ade25ff5cb4fdce7441b4dc7425782eda5e5bb9d0a8383377b1ffbd4f048149880c57713b7f4db8256c7f59ecccc5cb6f11b520", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e832b984957d65b8de267bc531d944ec5a174e28fa986c92bf91f2558376e8a487199ed84b20d10a8bf41fe38210b0002f42e3f2610a9a47ee877e2c46e1c0a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/495943b861d490d1ee4a8e6f8b955d43bcfecf8e2ccf9be988e7ab4655bbb1047795fbf7385752adc8f26e9fa37bf4f70cb8aef3adf44def1fa5f6e810fb251e"} build_url:https://queue.taskcluster.net/v1/task/bHSlaVTgTZirJK64MneoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011336 build_url: 'https://queue.taskcluster.net/v1/task/bHSlaVTgTZirJK64MneoKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/86bfbcbaafdbf717855a51e41ade25ff5cb4fdce7441b4dc7425782eda5e5bb9d0a8383377b1ffbd4f048149880c57713b7f4db8256c7f59ecccc5cb6f11b520", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e832b984957d65b8de267bc531d944ec5a174e28fa986c92bf91f2558376e8a487199ed84b20d10a8bf41fe38210b0002f42e3f2610a9a47ee877e2c46e1c0a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/495943b861d490d1ee4a8e6f8b955d43bcfecf8e2ccf9be988e7ab4655bbb1047795fbf7385752adc8f26e9fa37bf4f70cb8aef3adf44def1fa5f6e810fb251e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 16:12:35.766847) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 16:12:35.767370) ========= 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=652eb03db935cfc1c15ebda0000001ad-1469573423.216979-763374323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004368 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 16:12:35.849355) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 16:12:35.849695) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 16:12:35.849994) ========= ========= Total master_lag: 0.19 =========