builder: autoland_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-057 starttime: 1470002756.75 results: success (0) buildid: 20160731123002 builduid: 2e9bde487c454ddcb68d8984514d6a4b revision: 4a18b5cacb1b21a3e8b4b1dada6b2dd3dba51cb1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-31 15:05:56.750998) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-31 15:05:56.751457) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-31 15:05:56.751766) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-31 15:05:56.800933) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 15:05:56.801404) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1470002444.886704-475043275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-31 15:05:58-- 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% 229M=0s 2016-07-31 15:05:58 (229 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123748 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 15:05:56.952564) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 15:05:56.952886) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1470002444.886704-475043275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018172 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 15:05:57.011089) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 15:05:57.011886) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 4a18b5cacb1b21a3e8b4b1dada6b2dd3dba51cb1 --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 4a18b5cacb1b21a3e8b4b1dada6b2dd3dba51cb1 --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=934fc3100db09dcb9af4d4b6000001ab-1470002444.886704-475043275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-31 15:05:58,409 truncating revision to first 12 chars 2016-07-31 15:05:58,409 Setting DEBUG logging. 2016-07-31 15:05:58,409 attempt 1/10 2016-07-31 15:05:58,409 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/4a18b5cacb1b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-31 15:05:58,821 unpacking tar archive at: autoland-4a18b5cacb1b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.755278 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 15:05:57.785149) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-31 15:05:57.785485) ========= script_repo_revision: 4a18b5cacb1b21a3e8b4b1dada6b2dd3dba51cb1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-31 15:05:57.785897) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-31 15:05:57.786205) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-31 15:05:57.797104) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-07-31 15:05:57.797420) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=934fc3100db09dcb9af4d4b6000001ab-1470002444.886704-475043275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:05:59 INFO - MultiFileLogger online at 20160731 15:05:59 in /builds/slave/test 15:05:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 15:05:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:05:59 INFO - {'append_to_log': False, 15:05:59 INFO - 'base_work_dir': '/builds/slave/test', 15:05:59 INFO - 'blob_upload_branch': 'Autoland', 15:05:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:05:59 INFO - 'branch': 'Autoland', 15:05:59 INFO - 'buildbot_json_path': 'buildprops.json', 15:05:59 INFO - 'config_files': ('talos/linux_config.py',), 15:05:59 INFO - 'default_actions': ('clobber', 15:05:59 INFO - 'read-buildbot-config', 15:05:59 INFO - 'download-and-extract', 15:05:59 INFO - 'populate-webroot', 15:05:59 INFO - 'create-virtualenv', 15:05:59 INFO - 'install', 15:05:59 INFO - 'run-tests'), 15:05:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:05:59 INFO - 'download_minidump_stackwalk': True, 15:05:59 INFO - 'download_symbols': 'ondemand', 15:05:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:05:59 INFO - 'tooltool.py': '/tools/tooltool.py', 15:05:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:05:59 INFO - '/tools/misc-python/virtualenv.py')}, 15:05:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:05:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:05:59 INFO - 'installer_path': 'installer.exe', 15:05:59 INFO - 'log_level': 'info', 15:05:59 INFO - 'log_name': 'talos', 15:05:59 INFO - 'log_to_console': True, 15:05:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:05:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:05:59 INFO - 'opt_config_files': (), 15:05:59 INFO - 'pip_index': False, 15:05:59 INFO - 'sps_profile': False, 15:05:59 INFO - 'sps_profile_interval': 0, 15:05:59 INFO - 'suite': 'dromaeojs-e10s', 15:05:59 INFO - 'system_bits': '32', 15:05:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:05:59 INFO - 'title': 'talos-linux64-ix-057', 15:05:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:05:59 INFO - 'use_talos_json': True, 15:05:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:05:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:05:59 INFO - 'work_dir': 'build'} 15:05:59 INFO - [mozharness: 2016-07-31 22:05:59.277870Z] Running clobber step. 15:05:59 INFO - Running pre-action listener: _resource_record_pre_action 15:05:59 INFO - Running main action method: clobber 15:05:59 INFO - rmtree: /builds/slave/test/build 15:05:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:05:59 INFO - Running post-action listener: _resource_record_post_action 15:05:59 INFO - [mozharness: 2016-07-31 22:05:59.740800Z] Finished clobber step (success) 15:05:59 INFO - [mozharness: 2016-07-31 22:05:59.740903Z] Running read-buildbot-config step. 15:05:59 INFO - Running pre-action listener: _resource_record_pre_action 15:05:59 INFO - Running main action method: read_buildbot_config 15:05:59 INFO - Using buildbot properties: 15:05:59 INFO - { 15:05:59 INFO - "project": "", 15:05:59 INFO - "product": "firefox", 15:05:59 INFO - "script_repo_revision": "production", 15:05:59 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 15:05:59 INFO - "repository": "", 15:05:59 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs-e10s", 15:05:59 INFO - "buildid": "20160731123002", 15:05:59 INFO - "pgo_build": "True", 15:05:59 INFO - "basedir": "/builds/slave/test", 15:05:59 INFO - "buildnumber": 86, 15:05:59 INFO - "slavename": "talos-linux64-ix-057", 15:05:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:05:59 INFO - "platform": "ubuntu64_hw", 15:05:59 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 15:05:59 INFO - "branch": "autoland", 15:05:59 INFO - "repo_path": "integration/autoland", 15:05:59 INFO - "revision": "4a18b5cacb1b21a3e8b4b1dada6b2dd3dba51cb1", 15:05:59 INFO - "stage_platform": "linux64-pgo", 15:05:59 INFO - "builduid": "2e9bde487c454ddcb68d8984514d6a4b", 15:05:59 INFO - "slavebuilddir": "test" 15:05:59 INFO - } 15:05:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/WvYYCjK6R0G3eYmLbYFreA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 15:05:59 INFO - Running post-action listener: _resource_record_post_action 15:05:59 INFO - [mozharness: 2016-07-31 22:05:59.743405Z] Finished read-buildbot-config step (success) 15:05:59 INFO - [mozharness: 2016-07-31 22:05:59.743494Z] Running download-and-extract step. 15:05:59 INFO - Running pre-action listener: _resource_record_pre_action 15:05:59 INFO - Running main action method: download_and_extract 15:05:59 INFO - mkdir: /builds/slave/test/build/tests 15:05: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:05:59 INFO - https://queue.taskcluster.net/v1/task/WvYYCjK6R0G3eYmLbYFreA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:05:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WvYYCjK6R0G3eYmLbYFreA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:05:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WvYYCjK6R0G3eYmLbYFreA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:05:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WvYYCjK6R0G3eYmLbYFreA/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:05:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WvYYCjK6R0G3eYmLbYFreA/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:06:01 INFO - Downloaded 1361 bytes. 15:06:01 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:06:01 INFO - Using the following test package requirements: 15:06:01 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:06:01 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:06:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:06:01 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:06:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:06:01 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:06:01 INFO - u'jsshell-linux-x86_64.zip'], 15:06:01 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:06:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:06:01 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:06:01 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:06:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:06:01 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:06:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:06:01 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:06:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:06:01 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:06:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:06:01 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:06:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:01 INFO - https://queue.taskcluster.net/v1/task/WvYYCjK6R0G3eYmLbYFreA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:06:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WvYYCjK6R0G3eYmLbYFreA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:06:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WvYYCjK6R0G3eYmLbYFreA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:06:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WvYYCjK6R0G3eYmLbYFreA/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:06:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WvYYCjK6R0G3eYmLbYFreA/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:06:09 INFO - Downloaded 21807816 bytes. 15:06:09 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:06:09 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:06:10 INFO - Return code: 0 15:06:10 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:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:10 INFO - https://queue.taskcluster.net/v1/task/WvYYCjK6R0G3eYmLbYFreA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:06:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WvYYCjK6R0G3eYmLbYFreA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:06:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WvYYCjK6R0G3eYmLbYFreA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:06:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WvYYCjK6R0G3eYmLbYFreA/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:06:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WvYYCjK6R0G3eYmLbYFreA/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:06:16 INFO - Downloaded 21807816 bytes. 15:06:16 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:06:16 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:06:17 INFO - Return code: 0 15:06: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:06:17 INFO - https://queue.taskcluster.net/v1/task/WvYYCjK6R0G3eYmLbYFreA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:06:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WvYYCjK6R0G3eYmLbYFreA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:06:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WvYYCjK6R0G3eYmLbYFreA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:06:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WvYYCjK6R0G3eYmLbYFreA/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:06:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WvYYCjK6R0G3eYmLbYFreA/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:06:18 INFO - Downloaded 14413723 bytes. 15:06:18 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:06:18 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:06:18 INFO - Return code: 0 15:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:18 INFO - https://queue.taskcluster.net/v1/task/WvYYCjK6R0G3eYmLbYFreA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:06:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WvYYCjK6R0G3eYmLbYFreA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:06:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WvYYCjK6R0G3eYmLbYFreA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:06:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WvYYCjK6R0G3eYmLbYFreA/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:06:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WvYYCjK6R0G3eYmLbYFreA/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:06:20 INFO - Downloaded 59390830 bytes. 15:06:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WvYYCjK6R0G3eYmLbYFreA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:06:20 INFO - mkdir: /builds/slave/test/properties 15:06:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:06:20 INFO - Writing to file /builds/slave/test/properties/build_url 15:06:20 INFO - Contents: 15:06:20 INFO - build_url:https://queue.taskcluster.net/v1/task/WvYYCjK6R0G3eYmLbYFreA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:06:20 INFO - Running post-action listener: _resource_record_post_action 15:06:20 INFO - Running post-action listener: set_extra_try_arguments 15:06:20 INFO - [mozharness: 2016-07-31 22:06:20.677035Z] Finished download-and-extract step (success) 15:06:20 INFO - [mozharness: 2016-07-31 22:06:20.677364Z] Running populate-webroot step. 15:06:20 INFO - Running pre-action listener: _resource_record_pre_action 15:06:20 INFO - Running main action method: populate_webroot 15:06:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:06:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:06:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:06:20 INFO - '--tppagecycles', 15:06:20 INFO - '7'], 15:06:20 INFO - 'tests': ['tsvgm']}}, 15:06:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:06:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:06:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:06:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:06:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:06:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:06:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:06:20 INFO - 'talos_options': ['--disable-e10s'], 15:06:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:06:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:06:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:06:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:06:20 INFO - 'talos_options': ['--disable-e10s'], 15:06:20 INFO - 'tests': ['damp', 'tps']}, 15:06:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:06:20 INFO - 'tests': ['damp', 'tps']}, 15:06:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:06:20 INFO - 'tests': ['dromaeo_dom']}, 15:06:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:06:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:06:20 INFO - 'tests': ['basic_compositor_video']}, 15:06:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:06:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:06:20 INFO - 'tests': ['a11yr', 15:06:20 INFO - 'ts_paint', 15:06:20 INFO - 'tpaint', 15:06:20 INFO - 'sessionrestore', 15:06:20 INFO - 'sessionrestore_no_auto_restore', 15:06:20 INFO - 'tabpaint']}, 15:06:20 INFO - 'other-e10s': {'tests': ['a11yr', 15:06:20 INFO - 'ts_paint', 15:06:20 INFO - 'tpaint', 15:06:20 INFO - 'sessionrestore', 15:06:20 INFO - 'sessionrestore_no_auto_restore', 15:06:20 INFO - 'tabpaint']}, 15:06:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:06:20 INFO - 'ts_paint', 15:06:20 INFO - 'tpaint', 15:06:20 INFO - 'sessionrestore', 15:06:20 INFO - 'sessionrestore_no_auto_restore', 15:06:20 INFO - 'tabpaint']}, 15:06:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:06:20 INFO - 'ts_paint', 15:06:20 INFO - 'tpaint', 15:06:20 INFO - 'sessionrestore', 15:06:20 INFO - 'sessionrestore_no_auto_restore', 15:06:20 INFO - 'tabpaint']}, 15:06:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:06:20 INFO - 'tests': ['a11yr', 15:06:20 INFO - 'ts_paint', 15:06:20 INFO - 'tpaint', 15:06:20 INFO - 'sessionrestore', 15:06:20 INFO - 'sessionrestore_no_auto_restore', 15:06:20 INFO - 'tabpaint']}, 15:06:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:06:20 INFO - 'tests': ['a11yr', 15:06:20 INFO - 'ts_paint', 15:06:20 INFO - 'tpaint', 15:06:20 INFO - 'sessionrestore', 15:06:20 INFO - 'sessionrestore_no_auto_restore', 15:06:20 INFO - 'tabpaint']}, 15:06:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:06:20 INFO - 'tests': ['tsvgx', 15:06:20 INFO - 'tsvgr_opacity', 15:06:20 INFO - 'tart', 15:06:20 INFO - 'tscrollx', 15:06:20 INFO - 'cart']}, 15:06:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:06:20 INFO - 'tsvgr_opacity', 15:06:20 INFO - 'tart', 15:06:20 INFO - 'tscrollx', 15:06:20 INFO - 'cart']}, 15:06:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:06:20 INFO - 'talos_options': ['--disable-e10s'], 15:06:20 INFO - 'tests': ['tp5o']}, 15:06:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:06:20 INFO - 'tests': ['tp5o']}, 15:06:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:06:20 INFO - 'talos_options': ['--disable-e10s', 15:06:20 INFO - '--xperf_path', 15:06:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:06:20 INFO - 'tests': ['tp5n']}, 15:06:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:06:20 INFO - 'talos_options': ['--xperf_path', 15:06:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:06:20 INFO - 'tests': ['tp5n']}}, 15:06:20 INFO - 'talos.zip': {'path': '', 15:06:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:06:20 INFO - Running post-action listener: _resource_record_post_action 15:06:20 INFO - [mozharness: 2016-07-31 22:06:20.696140Z] Finished populate-webroot step (success) 15:06:20 INFO - [mozharness: 2016-07-31 22:06:20.696229Z] Running create-virtualenv step. 15:06:20 INFO - Running pre-action listener: _resource_record_pre_action 15:06:20 INFO - Running main action method: create_virtualenv 15:06:20 INFO - Creating virtualenv /builds/slave/test/build/venv 15:06:20 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:06:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:06:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:06:20 INFO - Using real prefix '/usr' 15:06:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:06:21 INFO - Installing distribute.............................................................................................................................................................................................done. 15:06:23 INFO - Installing pip.................done. 15:06:23 INFO - Return code: 0 15:06:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:06:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baf3b0>, '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 0x1bb02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb0740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470002444.886704-475043275', '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:06:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:06:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:06:23 INFO - Using env: {'DISPLAY': ':0', 15:06:23 INFO - 'HOME': '/home/cltbld', 15:06:23 INFO - 'LANG': 'en_US.UTF-8', 15:06:23 INFO - 'LANGUAGE': 'en_US:en', 15:06:23 INFO - 'LOGNAME': 'cltbld', 15:06:23 INFO - 'MAIL': '/var/mail/cltbld', 15:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:23 INFO - 'MOZ_NO_REMOTE': '1', 15:06:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:23 INFO - 'NO_EM_RESTART': '1', 15:06:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:23 INFO - 'PWD': '/builds/slave/test', 15:06:23 INFO - 'SHELL': '/bin/bash', 15:06:23 INFO - 'SHLVL': '1', 15:06:23 INFO - 'TERM': 'linux', 15:06:23 INFO - 'TMOUT': '86400', 15:06:23 INFO - 'USER': 'cltbld', 15:06:23 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470002444.886704-475043275', 15:06:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:23 INFO - '_': '/tools/buildbot/bin/python'} 15:06:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:23 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:06:23 INFO - Cleaning up... 15:06:23 INFO - Return code: 0 15:06:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:06:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x18f0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baf3b0>, '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 0x1bb02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb0740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470002444.886704-475043275', '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:06:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:06:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:06:23 INFO - Using env: {'DISPLAY': ':0', 15:06:23 INFO - 'HOME': '/home/cltbld', 15:06:23 INFO - 'LANG': 'en_US.UTF-8', 15:06:23 INFO - 'LANGUAGE': 'en_US:en', 15:06:23 INFO - 'LOGNAME': 'cltbld', 15:06:23 INFO - 'MAIL': '/var/mail/cltbld', 15:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:23 INFO - 'MOZ_NO_REMOTE': '1', 15:06:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:23 INFO - 'NO_EM_RESTART': '1', 15:06:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:23 INFO - 'PWD': '/builds/slave/test', 15:06:23 INFO - 'SHELL': '/bin/bash', 15:06:23 INFO - 'SHLVL': '1', 15:06:23 INFO - 'TERM': 'linux', 15:06:23 INFO - 'TMOUT': '86400', 15:06:23 INFO - 'USER': 'cltbld', 15:06:23 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470002444.886704-475043275', 15:06:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:23 INFO - '_': '/tools/buildbot/bin/python'} 15:06:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:23 INFO - Downloading/unpacking psutil>=3.1.1 15:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:06:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:06:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:06:25 INFO - Installing collected packages: psutil 15:06:25 INFO - Running setup.py install for psutil 15:06:25 INFO - building 'psutil._psutil_linux' extension 15:06:25 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:06:25 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:06:25 INFO - building 'psutil._psutil_posix' extension 15:06:25 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:06:26 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:06:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:06:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:06:26 INFO - Successfully installed psutil 15:06:26 INFO - Cleaning up... 15:06:26 INFO - Return code: 0 15:06:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:26 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 0x18f0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baf3b0>, '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 0x1bb02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb0740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470002444.886704-475043275', '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:06:26 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:06:26 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:06:26 INFO - Using env: {'DISPLAY': ':0', 15:06:26 INFO - 'HOME': '/home/cltbld', 15:06:26 INFO - 'LANG': 'en_US.UTF-8', 15:06:26 INFO - 'LANGUAGE': 'en_US:en', 15:06:26 INFO - 'LOGNAME': 'cltbld', 15:06:26 INFO - 'MAIL': '/var/mail/cltbld', 15:06:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:26 INFO - 'MOZ_NO_REMOTE': '1', 15:06:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:26 INFO - 'NO_EM_RESTART': '1', 15:06:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:26 INFO - 'PWD': '/builds/slave/test', 15:06:26 INFO - 'SHELL': '/bin/bash', 15:06:26 INFO - 'SHLVL': '1', 15:06:26 INFO - 'TERM': 'linux', 15:06:26 INFO - 'TMOUT': '86400', 15:06:26 INFO - 'USER': 'cltbld', 15:06:26 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470002444.886704-475043275', 15:06:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:26 INFO - '_': '/tools/buildbot/bin/python'} 15:06:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:06:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:06:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:06:28 INFO - Installing collected packages: mozsystemmonitor 15:06:28 INFO - Running setup.py install for mozsystemmonitor 15:06:28 INFO - Successfully installed mozsystemmonitor 15:06:28 INFO - Cleaning up... 15:06:28 INFO - Return code: 0 15:06:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:06: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:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06: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:06:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baf3b0>, '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 0x1bb02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb0740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470002444.886704-475043275', '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:06: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==2.5.1'] in /builds/slave/test/build 15:06: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==2.5.1 15:06:28 INFO - Using env: {'DISPLAY': ':0', 15:06:28 INFO - 'HOME': '/home/cltbld', 15:06:28 INFO - 'LANG': 'en_US.UTF-8', 15:06:28 INFO - 'LANGUAGE': 'en_US:en', 15:06:28 INFO - 'LOGNAME': 'cltbld', 15:06:28 INFO - 'MAIL': '/var/mail/cltbld', 15:06:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:28 INFO - 'MOZ_NO_REMOTE': '1', 15:06:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:28 INFO - 'NO_EM_RESTART': '1', 15:06:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:28 INFO - 'PWD': '/builds/slave/test', 15:06:28 INFO - 'SHELL': '/bin/bash', 15:06:28 INFO - 'SHLVL': '1', 15:06:28 INFO - 'TERM': 'linux', 15:06:28 INFO - 'TMOUT': '86400', 15:06:28 INFO - 'USER': 'cltbld', 15:06:28 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470002444.886704-475043275', 15:06:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:28 INFO - '_': '/tools/buildbot/bin/python'} 15:06:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:28 INFO - Downloading/unpacking jsonschema==2.5.1 15:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:06:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:30 INFO - Downloading functools32-3.2.3-2.tar.gz 15:06:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:06:30 INFO - warning: no files found matching '*.txt' 15:06:30 INFO - no previously-included directories found matching 'build' 15:06:30 INFO - no previously-included directories found matching 'dist' 15:06:30 INFO - no previously-included directories found matching '.git*' 15:06:30 INFO - Installing collected packages: jsonschema, functools32 15:06:30 INFO - Running setup.py install for functools32 15:06:31 INFO - warning: no files found matching '*.txt' 15:06:31 INFO - no previously-included directories found matching 'build' 15:06:31 INFO - no previously-included directories found matching 'dist' 15:06:31 INFO - no previously-included directories found matching '.git*' 15:06:31 INFO - Successfully installed jsonschema functools32 15:06:31 INFO - Cleaning up... 15:06:31 INFO - Return code: 0 15:06:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:06:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:31 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 0x18f0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baf3b0>, '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 0x1bb02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb0740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470002444.886704-475043275', '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:06:31 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:06:31 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:06:31 INFO - Using env: {'DISPLAY': ':0', 15:06:31 INFO - 'HOME': '/home/cltbld', 15:06:31 INFO - 'LANG': 'en_US.UTF-8', 15:06:31 INFO - 'LANGUAGE': 'en_US:en', 15:06:31 INFO - 'LOGNAME': 'cltbld', 15:06:31 INFO - 'MAIL': '/var/mail/cltbld', 15:06:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:31 INFO - 'MOZ_NO_REMOTE': '1', 15:06:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:31 INFO - 'NO_EM_RESTART': '1', 15:06:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:31 INFO - 'PWD': '/builds/slave/test', 15:06:31 INFO - 'SHELL': '/bin/bash', 15:06:31 INFO - 'SHLVL': '1', 15:06:31 INFO - 'TERM': 'linux', 15:06:31 INFO - 'TMOUT': '86400', 15:06:31 INFO - 'USER': 'cltbld', 15:06:31 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470002444.886704-475043275', 15:06:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:31 INFO - '_': '/tools/buildbot/bin/python'} 15:06:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:06:31 INFO - Cleaning up... 15:06:31 INFO - Return code: 0 15:06:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:06:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:31 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 0x18f0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baf3b0>, '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 0x1bb02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb0740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470002444.886704-475043275', '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:06:31 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:06:31 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:06:31 INFO - Using env: {'DISPLAY': ':0', 15:06:31 INFO - 'HOME': '/home/cltbld', 15:06:31 INFO - 'LANG': 'en_US.UTF-8', 15:06:31 INFO - 'LANGUAGE': 'en_US:en', 15:06:31 INFO - 'LOGNAME': 'cltbld', 15:06:31 INFO - 'MAIL': '/var/mail/cltbld', 15:06:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:31 INFO - 'MOZ_NO_REMOTE': '1', 15:06:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:31 INFO - 'NO_EM_RESTART': '1', 15:06:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:31 INFO - 'PWD': '/builds/slave/test', 15:06:31 INFO - 'SHELL': '/bin/bash', 15:06:31 INFO - 'SHLVL': '1', 15:06:31 INFO - 'TERM': 'linux', 15:06:31 INFO - 'TMOUT': '86400', 15:06:31 INFO - 'USER': 'cltbld', 15:06:31 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470002444.886704-475043275', 15:06:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:31 INFO - '_': '/tools/buildbot/bin/python'} 15:06:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:31 INFO - Downloading/unpacking blobuploader==1.2.4 15:06:31 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:06:31 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:06:31 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:06:31 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:06:31 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:06:31 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:06:33 INFO - Downloading blobuploader-1.2.4.tar.gz 15:06:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:06:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:06:33 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:06:33 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:06:33 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:06:33 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:06:33 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:06:33 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:06:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:06:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:06:33 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:06:33 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:06:33 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:06:33 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:06:33 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:06:33 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:06:34 INFO - Downloading docopt-0.6.1.tar.gz 15:06:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:06:34 INFO - Installing collected packages: blobuploader, requests, docopt 15:06:34 INFO - Running setup.py install for blobuploader 15:06:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:06:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:06:34 INFO - Running setup.py install for requests 15:06:34 INFO - Running setup.py install for docopt 15:06:34 INFO - Successfully installed blobuploader requests docopt 15:06:34 INFO - Cleaning up... 15:06:34 INFO - Return code: 0 15:06:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:06:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:34 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 0x18f0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baf3b0>, '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 0x1bb02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb0740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470002444.886704-475043275', '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:06:34 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:06:34 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:06:34 INFO - Using env: {'DISPLAY': ':0', 15:06:34 INFO - 'HOME': '/home/cltbld', 15:06:34 INFO - 'LANG': 'en_US.UTF-8', 15:06:34 INFO - 'LANGUAGE': 'en_US:en', 15:06:34 INFO - 'LOGNAME': 'cltbld', 15:06:34 INFO - 'MAIL': '/var/mail/cltbld', 15:06:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:34 INFO - 'MOZ_NO_REMOTE': '1', 15:06:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:34 INFO - 'NO_EM_RESTART': '1', 15:06:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:34 INFO - 'PWD': '/builds/slave/test', 15:06:34 INFO - 'SHELL': '/bin/bash', 15:06:34 INFO - 'SHLVL': '1', 15:06:34 INFO - 'TERM': 'linux', 15:06:34 INFO - 'TMOUT': '86400', 15:06:34 INFO - 'USER': 'cltbld', 15:06:34 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470002444.886704-475043275', 15:06:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:34 INFO - '_': '/tools/buildbot/bin/python'} 15:06:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:06:35 INFO - Running setup.py (path:/tmp/pip-3RPXgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:06:35 INFO - Running setup.py (path:/tmp/pip-WoS7lI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:06:35 INFO - Running setup.py (path:/tmp/pip-bQvfHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:06:35 INFO - Running setup.py (path:/tmp/pip-4BaQRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:06:35 INFO - Running setup.py (path:/tmp/pip-MWxhny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:06:35 INFO - Running setup.py (path:/tmp/pip-AnsLIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:06:35 INFO - Running setup.py (path:/tmp/pip-iAJc7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:06:35 INFO - Running setup.py (path:/tmp/pip-JicJrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:06:35 INFO - Running setup.py (path:/tmp/pip-EdiLCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:06:35 INFO - Running setup.py (path:/tmp/pip-vSnONk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:06:35 INFO - Running setup.py (path:/tmp/pip-Q4zbxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:06:35 INFO - Running setup.py (path:/tmp/pip-eNSGtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:06:35 INFO - Running setup.py (path:/tmp/pip-zmxsnP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:06:35 INFO - Running setup.py (path:/tmp/pip-O9LcOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:06:36 INFO - Running setup.py (path:/tmp/pip-5c6In3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:06:36 INFO - Running setup.py (path:/tmp/pip-iPK0al-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:06:36 INFO - Running setup.py (path:/tmp/pip-YNmX36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:06:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:06:36 INFO - Running setup.py install for manifestparser 15:06:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:06:36 INFO - Running setup.py install for mozcrash 15:06:36 INFO - Running setup.py install for mozdebug 15:06:36 INFO - Running setup.py install for mozdevice 15:06:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:06:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:06:36 INFO - Running setup.py install for mozfile 15:06:36 INFO - Running setup.py install for mozhttpd 15:06:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:06:36 INFO - Running setup.py install for mozinfo 15:06:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:06:36 INFO - Running setup.py install for mozInstall 15:06:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:06:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:06:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:06:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:06:37 INFO - Running setup.py install for mozleak 15:06:37 INFO - Running setup.py install for mozlog 15:06:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:06:37 INFO - Running setup.py install for moznetwork 15:06:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:06:37 INFO - Running setup.py install for mozprocess 15:06:37 INFO - Running setup.py install for mozprofile 15:06:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:06:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:06:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:06:37 INFO - Running setup.py install for mozrunner 15:06:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:06:37 INFO - Running setup.py install for mozscreenshot 15:06:37 INFO - Running setup.py install for moztest 15:06:37 INFO - Running setup.py install for mozversion 15:06:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:06:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:06:38 INFO - Cleaning up... 15:06:38 INFO - Return code: 0 15:06:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:06:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:38 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 0x18f0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baf3b0>, '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 0x1bb02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb0740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470002444.886704-475043275', '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:06:38 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:06:38 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:06:38 INFO - Using env: {'DISPLAY': ':0', 15:06:38 INFO - 'HOME': '/home/cltbld', 15:06:38 INFO - 'LANG': 'en_US.UTF-8', 15:06:38 INFO - 'LANGUAGE': 'en_US:en', 15:06:38 INFO - 'LOGNAME': 'cltbld', 15:06:38 INFO - 'MAIL': '/var/mail/cltbld', 15:06:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:38 INFO - 'MOZ_NO_REMOTE': '1', 15:06:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:38 INFO - 'NO_EM_RESTART': '1', 15:06:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:38 INFO - 'PWD': '/builds/slave/test', 15:06:38 INFO - 'SHELL': '/bin/bash', 15:06:38 INFO - 'SHLVL': '1', 15:06:38 INFO - 'TERM': 'linux', 15:06:38 INFO - 'TMOUT': '86400', 15:06:38 INFO - 'USER': 'cltbld', 15:06:38 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470002444.886704-475043275', 15:06:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:38 INFO - '_': '/tools/buildbot/bin/python'} 15:06:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:06:38 INFO - Running setup.py (path:/tmp/pip-gRFscV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:06:38 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:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:06:38 INFO - Running setup.py (path:/tmp/pip-sOZr_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:06:38 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:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:06:38 INFO - Running setup.py (path:/tmp/pip-1GuDV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:06:38 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:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:06:38 INFO - Running setup.py (path:/tmp/pip-sFzFg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:06:38 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:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:06:38 INFO - Running setup.py (path:/tmp/pip-NG7Tg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:06:38 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:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:06:38 INFO - Running setup.py (path:/tmp/pip-MCXfC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:06:38 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:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:06:38 INFO - Running setup.py (path:/tmp/pip-ne21RZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:06:38 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:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:06:38 INFO - Running setup.py (path:/tmp/pip-6gB0SW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:06:38 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:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:06:38 INFO - Running setup.py (path:/tmp/pip-N9LwAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:06:38 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:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:06:38 INFO - Running setup.py (path:/tmp/pip-htEtRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:06:38 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:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:06:38 INFO - Running setup.py (path:/tmp/pip-DOpvB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:06:39 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:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:06:39 INFO - Running setup.py (path:/tmp/pip-qvdm8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:06:39 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:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:06:39 INFO - Running setup.py (path:/tmp/pip-u3rgbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:06:39 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:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:06:39 INFO - Running setup.py (path:/tmp/pip-8IlmA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:06:39 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:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:06:39 INFO - Running setup.py (path:/tmp/pip-GK8SUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:06:39 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:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:06:39 INFO - Running setup.py (path:/tmp/pip-HovM_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:06:39 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:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:06:39 INFO - Running setup.py (path:/tmp/pip-KZ8eXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:06:39 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:06:39 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:06:39 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:06:39 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:06:39 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:06:39 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:06:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:06:39 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:06:39 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:06:39 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:06:39 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:06:39 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:06:39 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:06:41 INFO - Downloading blessings-1.6.tar.gz 15:06:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:06:41 INFO - Installing collected packages: blessings 15:06:41 INFO - Running setup.py install for blessings 15:06:41 INFO - Successfully installed blessings 15:06:41 INFO - Cleaning up... 15:06:41 INFO - Return code: 0 15:06:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:06:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:06:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:06:41 INFO - Reading from file tmpfile_stdout 15:06:41 INFO - Current package versions: 15:06:41 INFO - argparse == 1.2.1 15:06:41 INFO - blessings == 1.6 15:06:41 INFO - blobuploader == 1.2.4 15:06:41 INFO - docopt == 0.6.1 15:06:41 INFO - functools32 == 3.2.3-2 15:06:41 INFO - jsonschema == 2.5.1 15:06:41 INFO - manifestparser == 1.1 15:06:41 INFO - mozInstall == 1.12 15:06:41 INFO - mozcrash == 0.17 15:06:41 INFO - mozdebug == 0.1 15:06:41 INFO - mozdevice == 0.48 15:06:41 INFO - mozfile == 1.2 15:06:41 INFO - mozhttpd == 0.7 15:06:41 INFO - mozinfo == 0.9 15:06:41 INFO - mozleak == 0.1 15:06:41 INFO - mozlog == 3.3 15:06:41 INFO - moznetwork == 0.27 15:06:41 INFO - mozprocess == 0.23 15:06:41 INFO - mozprofile == 0.28 15:06:41 INFO - mozrunner == 6.12 15:06:41 INFO - mozscreenshot == 0.1 15:06:41 INFO - mozsystemmonitor == 0.3 15:06:41 INFO - moztest == 0.7 15:06:41 INFO - mozversion == 1.4 15:06:41 INFO - psutil == 3.1.1 15:06:41 INFO - requests == 1.2.3 15:06:41 INFO - wsgiref == 0.1.2 15:06:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:41 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 0x18f0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baf3b0>, '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 0x1bb02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb0740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470002444.886704-475043275', '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:06:41 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:06:41 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:06:41 INFO - Using env: {'DISPLAY': ':0', 15:06:41 INFO - 'HOME': '/home/cltbld', 15:06:41 INFO - 'LANG': 'en_US.UTF-8', 15:06:41 INFO - 'LANGUAGE': 'en_US:en', 15:06:41 INFO - 'LOGNAME': 'cltbld', 15:06:41 INFO - 'MAIL': '/var/mail/cltbld', 15:06:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:41 INFO - 'MOZ_NO_REMOTE': '1', 15:06:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:41 INFO - 'NO_EM_RESTART': '1', 15:06:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:41 INFO - 'PWD': '/builds/slave/test', 15:06:41 INFO - 'SHELL': '/bin/bash', 15:06:41 INFO - 'SHLVL': '1', 15:06:41 INFO - 'TERM': 'linux', 15:06:41 INFO - 'TMOUT': '86400', 15:06:41 INFO - 'USER': 'cltbld', 15:06:41 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470002444.886704-475043275', 15:06:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:41 INFO - '_': '/tools/buildbot/bin/python'} 15:06:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:42 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:06:42 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:06:42 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:06:42 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:06:42 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:06:42 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:06:42 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:06:42 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:06:42 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:06:42 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:06:42 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:06:42 INFO - Cleaning up... 15:06:42 INFO - Return code: 0 15:06:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:06:42 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:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:42 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:06:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:42 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 0x18f0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baf3b0>, '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 0x1bb02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb0740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470002444.886704-475043275', '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:06:42 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:06:42 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:06:42 INFO - Using env: {'DISPLAY': ':0', 15:06:42 INFO - 'HOME': '/home/cltbld', 15:06:42 INFO - 'LANG': 'en_US.UTF-8', 15:06:42 INFO - 'LANGUAGE': 'en_US:en', 15:06:42 INFO - 'LOGNAME': 'cltbld', 15:06:42 INFO - 'MAIL': '/var/mail/cltbld', 15:06:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:42 INFO - 'MOZ_NO_REMOTE': '1', 15:06:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:42 INFO - 'NO_EM_RESTART': '1', 15:06:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:42 INFO - 'PWD': '/builds/slave/test', 15:06:42 INFO - 'SHELL': '/bin/bash', 15:06:42 INFO - 'SHLVL': '1', 15:06:42 INFO - 'TERM': 'linux', 15:06:42 INFO - 'TMOUT': '86400', 15:06:42 INFO - 'USER': 'cltbld', 15:06:42 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470002444.886704-475043275', 15:06:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:42 INFO - '_': '/tools/buildbot/bin/python'} 15:06:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:06:42 INFO - Cleaning up... 15:06:42 INFO - Return code: 0 15:06:42 INFO - Running post-action listener: _resource_record_post_action 15:06:42 INFO - Running post-action listener: _start_resource_monitoring 15:06:42 INFO - Starting resource monitoring. 15:06:42 INFO - [mozharness: 2016-07-31 22:06:42.337080Z] Finished create-virtualenv step (success) 15:06:42 INFO - [mozharness: 2016-07-31 22:06:42.337523Z] Running install step. 15:06:42 INFO - Running pre-action listener: _resource_record_pre_action 15:06:42 INFO - Running main action method: install 15:06:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:06:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:06:42 INFO - Reading from file tmpfile_stdout 15:06:42 INFO - Detecting whether we're running mozinstall >=1.0... 15:06:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:06:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:06:42 INFO - Reading from file tmpfile_stdout 15:06:42 INFO - Output received: 15:06:42 INFO - Usage: mozinstall [options] installer 15:06:42 INFO - Options: 15:06:42 INFO - -h, --help show this help message and exit 15:06:42 INFO - -d DEST, --destination=DEST 15:06:42 INFO - Directory to install application into. [default: 15:06:42 INFO - "/builds/slave/test"] 15:06:42 INFO - --app=APP Application being installed. [default: firefox] 15:06:42 INFO - mkdir: /builds/slave/test/build/application 15:06:42 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:06:42 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:06:59 INFO - Reading from file tmpfile_stdout 15:06:59 INFO - Output received: 15:06:59 INFO - /builds/slave/test/build/application/firefox/firefox 15:06:59 INFO - Running post-action listener: _resource_record_post_action 15:06:59 INFO - [mozharness: 2016-07-31 22:06:59.527438Z] Finished install step (success) 15:06:59 INFO - [mozharness: 2016-07-31 22:06:59.527715Z] Running run-tests step. 15:06:59 INFO - Running pre-action listener: _resource_record_pre_action 15:06:59 INFO - Running main action method: run_tests 15:06:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:06:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:06:59 INFO - Python 2.7.3 15:06:59 INFO - Return code: 0 15:06:59 INFO - grabbing minidump binary from tooltool 15:06: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:06:59 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 0x1baf3b0>, '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 0x1bb02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb0740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:06:59 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:06:59 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:06:59 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:06:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:06:59 INFO - Return code: 0 15:06:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:06:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:06:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:06:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:06:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:06:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WvYYCjK6R0G3eYmLbYFreA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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:06:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WvYYCjK6R0G3eYmLbYFreA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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:06:59 INFO - Using env: {'DISPLAY': ':0', 15:06:59 INFO - 'HOME': '/home/cltbld', 15:06:59 INFO - 'LANG': 'en_US.UTF-8', 15:06:59 INFO - 'LANGUAGE': 'en_US:en', 15:06:59 INFO - 'LOGNAME': 'cltbld', 15:06:59 INFO - 'MAIL': '/var/mail/cltbld', 15:06:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:06:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:06:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:59 INFO - 'MOZ_NO_REMOTE': '1', 15:06:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:06:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:59 INFO - 'NO_EM_RESTART': '1', 15:06:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:59 INFO - 'PWD': '/builds/slave/test', 15:06:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:06:59 INFO - 'SHELL': '/bin/bash', 15:06:59 INFO - 'SHLVL': '1', 15:06:59 INFO - 'TERM': 'linux', 15:06:59 INFO - 'TMOUT': '86400', 15:06:59 INFO - 'USER': 'cltbld', 15:06:59 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470002444.886704-475043275', 15:06:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:59 INFO - '_': '/tools/buildbot/bin/python'} 15:06:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WvYYCjK6R0G3eYmLbYFreA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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:06:59 INFO - mozversion application_buildid: 20160731123002 15:06:59 INFO - mozversion application_changeset: 4a18b5cacb1b21a3e8b4b1dada6b2dd3dba51cb1 15:06:59 INFO - mozversion application_display_name: Nightly 15:06:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:06:59 INFO - mozversion application_name: Firefox 15:06:59 INFO - mozversion application_remotingname: firefox 15:06:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 15:06:59 INFO - mozversion application_vendor: Mozilla 15:06:59 INFO - mozversion application_version: 50.0a1 15:06:59 INFO - mozversion platform_buildid: 20160731123002 15:06:59 INFO - mozversion platform_changeset: 4a18b5cacb1b21a3e8b4b1dada6b2dd3dba51cb1 15:06:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 15:06:59 INFO - mozversion platform_version: 50.0a1 15:06:59 INFO - using testdate: 1470002819 15:06:59 INFO - actual date: 1470002819 15:06:59 INFO - starting webserver on 'localhost:46025' 15:06:59 INFO - SUITE-START | Running 2 tests 15:06:59 INFO - TEST-START | dromaeo_css 15:06:59 INFO - operating with platform_type : linux_ 15:06:59 INFO - Initialising browser for dromaeo_css test... 15:06:59 INFO - TEST-INFO | started process 2632 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0Yl4sE/profile http://localhost:46025/getInfo.html) 15:07:04 INFO - PROCESS | 2632 | __metrics Screen width/height:1600/1200 15:07:04 INFO - PROCESS | 2632 | colorDepth:24 15:07:04 INFO - PROCESS | 2632 | Browser inner width/height: 1024/697 15:07:04 INFO - PROCESS | 2632 | __metrics 15:07:05 ERROR - PROCESS | 2632 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 15:07:05 INFO - TEST-INFO | 2632: exit 0 15:07:05 INFO - Browser initialized. 15:07:05 INFO - Running cycle 1/1 for dromaeo_css test... 15:07:05 INFO - TEST-INFO | started process 2807 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0Yl4sE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:07:17 INFO - PROCESS | 2807 | RSS: Main: 163319808 15:07:17 INFO - PROCESS | 2807 | 15:08:07 INFO - PROCESS | 2807 | 1470002887304 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:10:14 INFO - PROCESS | 2807 | Cycle 1(1): loaded http://localhost:46025/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46025/tests/dromaeo/cssquery-ext.html) 15:10:16 INFO - PROCESS | 2807 | RSS: Main: 168181760 15:10:16 INFO - PROCESS | 2807 | 15:13:18 INFO - PROCESS | 2807 | Cycle 1(1): loaded http://localhost:46025/tests/dromaeo/cssquery-ext.html (next: http://localhost:46025/tests/dromaeo/cssquery-jquery.html) 15:13:18 INFO - PROCESS | 2807 | RSS: Main: 165744640 15:13:18 INFO - PROCESS | 2807 | 15:16:20 INFO - PROCESS | 2807 | Cycle 1(1): loaded http://localhost:46025/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46025/tests/dromaeo/cssquery-mootools.html) 15:16:21 INFO - PROCESS | 2807 | RSS: Main: 169889792 15:16:21 INFO - PROCESS | 2807 | 15:19:23 INFO - PROCESS | 2807 | Cycle 1(1): loaded http://localhost:46025/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46025/tests/dromaeo/cssquery-prototype.html) 15:19:23 INFO - PROCESS | 2807 | RSS: Main: 163966976 15:19:23 INFO - PROCESS | 2807 | 15:22:26 INFO - PROCESS | 2807 | Cycle 1(1): loaded http://localhost:46025/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46025/tests/dromaeo/cssquery-yui.html) 15:22:26 INFO - PROCESS | 2807 | RSS: Main: 166039552 15:22:26 INFO - PROCESS | 2807 | 15:25:29 INFO - PROCESS | 2807 | Cycle 1(1): loaded http://localhost:46025/tests/dromaeo/cssquery-yui.html (next: http://localhost:46025/tests/dromaeo/cssquery-dojo.html) 15:25:30 INFO - PROCESS | 2807 | RSS: Main: 169398272 15:25:30 INFO - PROCESS | 2807 | 15:25:30 INFO - PROCESS | 2807 | __start_tp_report 15:25:30 INFO - PROCESS | 2807 | _x_x_mozilla_page_load 15:25:30 INFO - PROCESS | 2807 | _x_x_mozilla_page_load_details 15:25:30 INFO - PROCESS | 2807 | |i|pagename|runs| 15:25:30 INFO - PROCESS | 2807 | |0;dojo.html;3072.6466456357516;3086.891958781443;3102.441560519107;3116.392303500817;3121.1416860363397;5266.078436273656;5342.572594192465;5348.598855085869;5383.300170977773;5479.671219726819;5319.388270348911;5344.652597581155;5384.1923711443305;5387.919181212285;5414.214938833867;4845.709257444556;4853.684510506806;4908.877278068059;4941.728204948744;4997.0505603935135;4902.852914412556;5032.169692000815;5032.723200223986;5037.5718063964605;5086.516780905827;396.47587840755796;4932.383452068491;4956.207006878882;5025.3718285214345;5026.346574945252;4863.975680121577;4872.464028956847;4886.486918873503;4919.7540122993705;4926.359573255454;4769.618430525585;4817.710937343771;4829.275608658694;4835.637327200474;4882;5136.512031357015;5240.711760853152;5247.2653828464045;5350.491703288181;5366.785328586851;5622.156676498517;5695.857603559903;5705.657660540381;5740.856478588027;5758.48173664368;5735.4551317624755;5736.196932429463;5744.741486633112;5746.655200687972;5755.079187330049;5282.234076058989;5317.8936421271355;5346.545543628797;5354.812581559666;5359.196120581905;5866.325372582122;5937.6734279614175;5940.762369505172;5948;5985.102234664835;5619.325680918234;5637.013522633605;5662.462066103713;5662.915056274159;5679.943200568024;5638.718064096779;5714.371419143891;5739.368669446358;5740;5764.769409223584;5701.828945131652;5742.822721342115;5785.623934444247;5831.183634291203;5831.591788574844;5782.335031471351;5784.4504772046585;5786.537077033827;5806.767729290866;5812.796552120655;4344.978275108668;4392.450943632046;4451.154280686659;4475.849270069415;4495.168393847149;3949.19041596472;3962.4254483100367;3976.1451287973223;4001.559828418872;4008.238434697398;5565.499105080562;5588.133839254922;5597.132444471032;5601.215829783833;5615.466530679579;5641.717914104278;5767.394423585547;5777.30672319316;5840.1239814027385;5844;5516.834494965157;5535.501804837584;5559.999200143932;5560.332760068818;5607.80372686954;5011.198208286657;5016.949830501721;5018.774155163026;5024.447310795809;5068.619853511002;5847.590668653239;5968.671723055187;5974.820755377345;5986.910196347058;5990.9101363479585;5844.47399734026;5845.444682755132;5854.180414741854;5855.619384739978;5882.49998750111;6000.339962604197;6021.157038014594;6053.697315134314;6067.848303792264;6068.51451883857;5552.472515111058;5640.633358831663;5663.943360566342;5706.743196556248;5750.712464376848;5844.357120716632;5845.503132233808;5847.1229315603;5852.239208902815;5879.559033072451;5681.460261275172;5684;5684.147377893184;5684.545236380997;5692.686902220417;5489;5614.242077319673;5638.830835074954;5660.85847853807;5665.0935850265405;5604.131359639263;5607.327120745536;5609.691466969192;5619.7752089917585;5624;5728.054870946414;5731.742071606871;5748.166515855261;5761.56788240892;5763.682997435181;5422.674639521641;5569.916451253153;5589.105743081088;5609.411011843861;5631.577631677558 15:25:30 INFO - PROCESS | 2807 | |1;ext.html;576.7174084698496;577.5841394196179;589.3634874335718;593.3621357041181;628.2555172121034;38346.23307533851;42445.78777106118;42674.78662606682;43186.568134318644;43210.78394608023;43084.56915430845;43443.13113737731;43465.348019779725;43616;43715.78142109293;8796.516191609442;9051.094890510962;9077.137671921157;9088.54557272137;9103.772405689877;8879.733607991739;8975.281977441822;8998.055204203563;9013.774655633597;9070.727878163632;9029.864552031724;9040.41237319572;9052.728418147466;9098.454092754422;9107.772305692344;9027.458352498837;9060.048694887073;9076.546172691373;9079.182873541413;9089.181973622339;8966.506842123681;8981.775455613597;8991.865122023175;9024.77438064047;9031.729048128567;40103.19793604111;40791.388129178085;40810.79594602008;40843.18313633741;40852;3179.364127174574;3362.5628668272966;3424.7773894697016;3483.3381657484997;3697.4268988306853;29992;30838.22904427385;30922.53616195759;31120.812677449918;31969.52045719316;3651.1054791575966;3732.346839303111;3756.77459352437;3756.812159392047;3862.343401621731;311112;313581;315114.99999999773;316120;316785;34049.48925766115;34061.48907766386;34065.48901766475;34103.147421314665;34111.488327675106;35051.123721907155;35347.64652353495;36010.81994590063;36015.4597681035;37914;16831.663366732842;16965;16975.151242437827;16999.150042497826;17018.914905425394;12804.295763733084;12810.743785124245;12862.485500579873;12865.549705760253;12886;18965.146568404456;19001.23995040183;19010.144543495575;19049.238030478624;19139;6825.419839313615;7087.291270872975;7115.82210444743;7153.785386438415;7262.709491620276;932.2355668351886;1091.247039542713;1094.6332978452149;1116.5290078614853;1190.0717440396504;32622.67377326244;32897.17757056045;33385.332293354;33488.665113349045;33615.83192084073;1056.5351245451977;1068.4657671164418;1086.6739978006567;1100.2133474565724;1127.6617014895498;16338;16547.255373508222;16648.667026659397;16681.499555013368;16711.164441777863;551581;552966;553338;555056;557221;55715;55735.44264557303;56300.43699563034;56357.71821140868;56365.7181714097;1326.674964633671;1358.436248956672;1393.1084106171854;1399.139529189541;1401.222321611495;29523.557146642386;30861.537076943416;30937.535936960514;31011.379772403976;31479;48949;49055.509444905096;49483;49650.75174624104;49924.750376249336;511776.29342239583;515313;517738;519547;520035.39982299844;27255.727442725318;27354.452910941272;27380.726192737817;27639.170824875288;27658.585121222794;42524.362134568626;43215.78392108019;47006.76496617495;48231.517684822706;48658.270125948846;39931.2013759729;40956.59043409528;41128.1774364505;41230.79384603058;42852;40665.39001914914;41622.16755664809;41716.58283417127;42206;42336.78831605946;34244.48633270453;40124.799376002935;40184.1963160741;41181.382279266436;41353.1729365405;33511;36924.815375922946;37213.44179837251;37297.81351093227;37373.6262637381;27001.72998270071;27935.860320698266;27961;28418.57372139461;28568.57147142836 15:25:30 INFO - PROCESS | 2807 | |2;jquery.html;370.30752492838394;383.05003591094095;384.5808069204567;399.8740396775014;405.5842761169802;17914.37299694511;20057.899710501464;20271.898640506814;20371.796282037176;20454.590908181828;16129.435469758531;16510;16538.586535336624;18185.54515638749;19493.707594386095;5506.779728810853;5568.693721845297;5721.542276617861;5741.224934633834;5742.799002034909;5530.336359636849;5622.859428514279;5651.378348381675;5665.1785491103765;5671.971640141794;5569.10894256919;5603.831885043455;5610.298712660918;5615.185798059279;5696.287964004499;5501.752421141038;5708.743106560236;5726.141078838166;5734.541236701054;5752.07966725322;5029.19532874742;5035.295058691786;5039.77321020555;5111.1566591512355;5116.718580478072;22928.885355573282;23312.883435582713;23318.90129888301;23347.649785253234;23549;2552.8468291902545;2622.763951244397;2896.348321627638;2964.4812157872284;3054.6334439867137;14565.271736413137;14709.485168019068;14725.926370368186;14913.478028268959;15470.226488675633;1888.5939523002621;1931.5364312565023;1952.7363805886166;2020.4342784020498;2030.2995466564012;80116;80306.5984670073;80641.59679201625;82782;84459.5777021111;10168.186545076376;10302.484875756183;10522.210834187466;10900;11094.389808560445;14709.411623535152;14836.406543738129;14837.92581037088;14881.181535015678;14903.850961490463;8185.795355116051;8407.327413806881;8536.829263414696;8572.228499434956;8640.13598640131;8101.6354264058255;8265.752027439186;8542.78643033929;8543.145685431531;8601.13988601135;6415.615063096229;6433.646149461824;6546.9017964730565;6576.276609572943;6658.201015878029;1720.4924547258588;1776.733489976514;1777.7244527098321;1818.1091265279917;1842.1526097995072;978.515634760798;985.610683779903;999.160705007797;1059;1106.3859557945257;19838.70241946372;20305.695414568792;20661;20780.272690456062;20886.58226835455;1000.0599436529639;1000.3847633705365;1048.320395412109;1049.197364016528;1060.5810704771573;9693.418394896187;11675.416229188506;11716.062714982781;11851.585194518151;11895.107866910017;380820;390085.09914901055;393802;519917;523431;89785;103643.4817825906;105549;107408.46295768628;108143.45928270466;986.5067466266867;995.4967998322585;1038.6728180623231;1038.9168866490663;1050.0549505445008;18295.908520457313;18661;19076.33232836844;19201.32795352156;19486.805131949066;39489.60510394974;41843.581564183965;44388;44394.334084988106;45241.773791130836;62526.687366562874;63290.683546581975;64315;64539.67730161319;65219.673901632086;7476;7779.494332868346;8136.105028446985;8176.632051557575;8400.201980811813;10756.731081723019;13353.132046416951;13671.931640341734;13869.445222191;14147.575572732834;11131.666050018512;11366.602168924048;11429;11607.419629018685;11735.178537502294;6655.567388119756;11013.2841365311;11670.824937626112;11681;12262.877371226174;11242.269252498561;11539.249948753304;11562.47968841421;11783.882161178279;11876.881231187923;8550.914490855012;8640.956795215983;8695.130486951255;8759.255463285692;8868.11318868108;9104.817903642022;11330.830037549278;11348.716282093013;11371.715707107389;11648.88351116478 15:25:30 INFO - PROCESS | 2807 | |3;mootools.html;1448.174540511908;1461.167134733202;1584.8177459592143;1709.2137616696318;1745.816689247629;7881.605919704006;8592.441491303061;8611.268042216412;9245.399049061807;9278.164965153135;8722.65109395625;9074.137956894085;9123.315751318662;9137.90862091379;9140.680076197334;2294.6213874710693;2329.9184528541505;2343.4024323797407;2345.0502546468706;2346.378209774411;2289.839711220215;2300.7929286364224;2360.799332056777;2365.077619728307;2366.8816559171973;2311.0640190722784;2343.60158773009;2356.8350215484925;2370.585147599163;2373.9881300593474;2258.1757658454544;2287.2909398086563;2288.7940085392393;2298.37943755186;2300.321405185466;2238.787315205053;2281.908723651052;2286.5084006938587;2294.059435631383;2300.1489448903844;8917.108289171096;8972.865407018835;9022.052684468168;9056.094390560957;9073.183413492752;5107.131787596118;5253.290805741214;5257.579393648499;5266.762995665166;5292.391374991887;3069.8004629699;3164.9050528483954;3271.4438545447333;3276.3447310537986;3317.402867483852;1068.6954218047897;1072.0512346573262;1087.1085709718034;1096.9286996345213;1101.884302148279;12341.074419418579;12421.813672794915;12448.31534265624;12491.562795302212;12576.056795740356;4244.72409293395;4308.375285583573;4494.325851122358;4497;4497.392851965008;10580.894191058145;10590.89409105899;10620.787584248272;10645.414502202453;10645.946770266253;5171.7672704728375;5194.92207616886;5201.505856943584;5218.582513398919;5238.92141617876;4286.1856247313535;4665.976670116627;4779.617630589544;4796.184648609745;4821.541953514481;3843.557990831034;3873.806309684561;3967.900802479961;4033.899152521152;4041.131156801243;1262.7916393795106;1263.823064770933;1281.5386460874079;1284.17170924753;1284.4862055178003;982.4400091947522;995.8506224066448;1012.9111205454167;1015;1016.4358780876537;6116.908246376308;6145.170401995673;6169.105479705418;6321.494280457552;6328.778492752732;384.27180492965675;393.6496518098894;396.5301118174972;398.8145512336777;399.44676622876943;4209.473815773028;4242.5121111072;4285.142971405731;4345.478542574911;4452.844150454784;10967;11142.108631309477;11229.943850280697;11287;11382.430878456044;11001.17491188164;11050.723731906606;11123.833142502868;11127.718817642364;11218.607348742755;7991.920080799234;8317.584120793936;8354.749357519406;8387.580620968927;8391.035030971394;6270.655113968775;6438.323975982642;6441.194850643669;6493.642849643315;6573.375529324707;9702.175315098013;10344.534495947852;10345.068943795095;10381.792364152523;10401.115905148146;10136.341137826017;10395.896041039796;10413.583456661649;10431.53058112402;10438.269321147447;7302.56184628924;7609.124950630749;7706.845863082819;8031;8201.42590018693;8640.654373824977;8643.481391116553;8669.479831210148;8688.869666954874;8722.389432739647;7680.500767450098;7718.073831140299;7851.568163751049;7883.566403847614;7901;7655.50239234448;7728.072631284282;7745.22547745221;7818.804529886798;7843.921560784547;7136.785896423115;7250.419966402781;7309.378702810108;7315.341619254293;7317.743878964424;5179.663321884065;5209.166533354645;5265.631405801711;5303.257543943928;5488.780448782164;5431.83704488866;5515.558755299486;5530.142827861688;5625.184348269396;5657.094864821609 15:25:30 INFO - PROCESS | 2807 | |4;prototype.html;305.39988921768736;313.95447660089286;317.5316408297761;321.6172754422236;321.83103870468;5299.754557678952;5382.439092663123;5407.891842163154;5501.312335958005;5533.6679799212025;5345.224942383352;5428.348598168215;5480.725963701809;5489.6980666063355;5502.257195278647;4266.274733295348;4269.2315383230925;4274.935875961847;4275.615194632483;4299.50555686097;4153.099342775524;4232.597903199191;4238.660907127422;4241.4698162729655;4262.573742625744;4187.492502699041;4214.789260536961;4218.6625069994325;4239.0674051708575;4243.490781106271;4229.217594744951;4237.6186143247105;4238.872833814959;4243.83024679014;4252.08656104751;3645.57822449245;3757.248550289926;3776.622337766229;3784.3566593679143;3786.8225770182257;5284.233786101032;5303.859670170932;5323.707196104213;5325.893482130375;5333.786648534093;4850.6362022848425;4854.83008094715;4862.17343051682;4864.513548645143;4889.584385327252;5603.663780173202;5668.716564171775;5709.9714501427225;5721;5731.254936858182;4054.39184122384;4089.3865920111925;4091.8158682859344;4100.097978444737;4109.2808758467145;6010.7295171717815;6045.576809623328;6045.969770151165;6052.455279024909;6063.848403789896;4059.7767122807936;4177.707560470799;4232.32282834745;4245.8513952011535;4249.915001699948;4254.276772948544;4256.489221293403;4256.808443619982;4258.297380932174;4281.379200016043;4919.434265059493;4919.7540122993705;4923.507649235048;4925.335079764258;4926.187179115477;5585.301837270341;5759.942400576025;5809.912851307234;5850.736716847752;5872.093313809692;1431.2843578210895;1432.8996970211986;1456.6358410397402;1459.292243262017;1460.3355473259853;885.2121611765534;912.0423555266943;919.7746552094779;930.4693778733945;932.6735642525061;4886.584640305543;4902.240152776325;4903;4903.926441103386;4919.2129259318335;5074.65073051784;5095.847124586268;5111.361079865017;5127.53852153308;5207.869803254949;4762.404699412574;4932.580730637936;4936.456989731127;4946.208606622923;4952.405711314594;2738.219607411878;2741.8347202438886;2745.341118131674;2747.4642444723486;2756.0491630387482;5319.6808191508635;5330.680159190461;5369.838904832861;5396.4603539646505;5402.405735369106;4932.161532539477;5186.6369354144845;5252.2384254282915;5266.472722910313;5272.683638981596;5346.679199248136;5356.758945847446;5387.919181212206;5396.271503347077;5451.672899626035;5064.873378165428;5093.592512599057;5117.334746482933;5130.384353877558;5136.640435169502;5109.948900511096;5365.3293338332705;5815.563832712648;5826.592138550261;5831.825045248649;6110.747296804233;6154.230721159855;6165.876682466415;6166.321704612399;6168.25980882297;3802.790846503469;3990.4812374391145;4078.286299897447;4107.404426358102;4144.8134833931945;5841.18223448709;5844.211031510862;5864.179014937998;5871.324797648325;5871.737576420919;5641.351244606923;5707.800226992035;5725.312962444534;5759.596828221985;5761.193432919478;5650.63270887391;5694.032014557618;5697.23087383198;5699.971500142473;5709.628874123168;5627.915581266366;5634.661920284796;5636.577256705846;5646.3788983212635;5661.547076233974;5607.158926161109;5686.516646085129;5723.456271654186;5739.942600573941;5845.532357411482;5548.583856210719;5627.774889004394;5629.521490673339;5685.260916080883;5691.3170419549915 15:25:30 INFO - PROCESS | 2807 | |5;yui.html;755.8337165823517;767.5970115689263;771.7954741993371;824.44350063707;838.1450920061534;15703.136327501983;16703.248353824078;16754.74867876983;16760.497185084438;16826.326946922138;15155.318010689518;15306.69386612267;15327.770083448757;15334.233288335594;15353.15557644329;656.1732217406079;764.6559048428215;781.8553567590014;801.623237078575;803.5138741061661;780.1496368957835;780.3601047141318;780.3640033372783;780.7228433905967;781.2148790465574;833.9916600833975;834.0825092398373;834.3283656656389;835.6740871060261;836.431226765799;826.2646244842095;826.6941231744233;829.0838623321233;830.6096134816627;830.8379865926147;601.7021574320695;602.0247199536778;607.0711810929286;610.5603965145089;613.6747523812387;14686.926565367105;14732.779008314883;14753.483628073072;14769.70460590793;14815;14813.925930370278;15027.849721502755;15167.469138580207;15223.238838058052;15250.694986100327;12749.298788566624;12789.424475898513;12859.485620575166;12930.870691293061;13051.673708157277;3925;3945.3687410014545;4033.233685599727;4106.609872062149;4116.938245926313;80663.99999999942;82195.58902205511;82699.17300826975;82953;82963;11470.48382822775;11562.248453850472;11779.823302650468;11800.173987820941;12273.754524909451;23239.3028209154;23255.534889302457;23282.8835855823;23376.532469350517;23412.765872341057;8859.379843411029;8876.801631779756;9033.593488293043;9116.726498205064;9373.812523749486;4364.8472303469225;4379.189849877783;4458.509563947963;4460.1971645104195;4468.530804265505;3542.5926018508203;3651.817409129586;3668.3396988542318;3669.688076513526;3679.3745063339297;618.2488276743778;626.1421852062613;629.5215636116493;636.4367534731796;648.4909346163239;647.3494138390887;710.754789597588;711.8574687626389;747.9551226926402;756.587659725451;10126.39241645489;10434.530446129942;10454.738631534272;10624.681259562225;10820.837687434694;630.6247782569363;736.5139008254527;738.6159197217416;740.2967181177903;756.5007095317175;5019.723915184627;5252.133397989365;5260.605454590845;5289.841304760864;5295.443978382292;123690.38154809168;129177;131231.34384328016;133634;134968;109733;109890;110139.44930275297;113483.43258283655;113732.43133784278;93421;96833;96838.51580742192;100924;100947.49526252468;9300.575716923386;9485.33602647808;9803;9854.55654495535;9906.455144967096;46039.76980115078;46351.30473042974;46827.53172468368;47993.76003119962;48529.75735121302;69648.30351696418;69654;71475.28524714687;72811.63594181996;72940.27059729335;12638.873611263769;12727.490900363882;12872.16330938486;13049.804252936403;13239.80140297877;14517.85482145165;14696.41214351414;14950.401983920521;14976.625584360478;15039.473618423302;13765.38055787472;13885.722285554435;14101.153930764187;14242.145471271757;14610.853891461375;12886.355682215664;13269.800952985906;13533.120347177402;13713.245771482665;13846.446142154604;14447.422103116178;14601.853981460474;14745.92627036858;15188.772168417261;15306.540803775904;11940.164188506722;12073.406953291833;12073.939630301793;12168;12425.75148497007;11927.284362938251;12510.687232819253;12532.498700051896;12663.620091397273;12781 15:25:30 INFO - PROCESS | 2807 | __end_tp_report 15:25:30 INFO - PROCESS | 2807 | __start_cc_report 15:25:30 INFO - PROCESS | 2807 | _x_x_mozilla_cycle_collect,327 15:25:30 INFO - PROCESS | 2807 | __end_cc_report 15:25:30 INFO - PROCESS | 2807 | __startTimestamp1470003930238__endTimestamp 15:25:30 INFO - PROCESS | 2807 | 15:25:30 INFO - PROCESS | 2807 | ------- Summary: start ------- 15:25:30 INFO - PROCESS | 2807 | Number of tests: 6 15:25:30 INFO - PROCESS | 2807 | 15:25:30 INFO - PROCESS | 2807 | [#0] dojo.html Cycles:165 Average:5346.50 Median:5609.69 stddev:723.68 (12.9%) stddev-sans-first:703.57 15:25:30 INFO - PROCESS | 2807 | Values: 3072.6 3086.9 3102.4 3116.4 3121.1 5266.1 5342.6 5348.6 5383.3 5479.7 5319.4 5344.7 5384.2 5387.9 5414.2 4845.7 4853.7 4908.9 4941.7 4997.1 4902.9 5032.2 5032.7 5037.6 5086.5 396.5 4932.4 4956.2 5025.4 5026.3 4864.0 4872.5 4886.5 4919.8 4926.4 4769.6 4817.7 4829.3 4835.6 4882.0 5136.5 5240.7 5247.3 5350.5 5366.8 5622.2 5695.9 5705.7 5740.9 5758.5 5735.5 5736.2 5744.7 5746.7 5755.1 5282.2 5317.9 5346.5 5354.8 5359.2 5866.3 5937.7 5940.8 5948.0 5985.1 5619.3 5637.0 5662.5 5662.9 5679.9 5638.7 5714.4 5739.4 5740.0 5764.8 5701.8 5742.8 5785.6 5831.2 5831.6 5782.3 5784.5 5786.5 5806.8 5812.8 4345.0 4392.5 4451.2 4475.8 4495.2 3949.2 3962.4 3976.1 4001.6 4008.2 5565.5 5588.1 5597.1 5601.2 5615.5 5641.7 5767.4 5777.3 5840.1 5844.0 5516.8 5535.5 5560.0 5560.3 5607.8 5011.2 5016.9 5018.8 5024.4 5068.6 5847.6 5968.7 5974.8 5986.9 5990.9 5844.5 5845.4 5854.2 5855.6 5882.5 6000.3 6021.2 6053.7 6067.8 6068.5 5552.5 5640.6 5663.9 5706.7 5750.7 5844.4 5845.5 5847.1 5852.2 5879.6 5681.5 5684.0 5684.1 5684.5 5692.7 5489.0 5614.2 5638.8 5660.9 5665.1 5604.1 5607.3 5609.7 5619.8 5624.0 5728.1 5731.7 5748.2 5761.6 5763.7 5422.7 5569.9 5589.1 5609.4 5631.6 15:25:30 INFO - PROCESS | 2807 | 15:25:30 INFO - PROCESS | 2807 | [#1] ext.html Cycles:180 Average:60314.20 Median:21896.77 stddev:126186.60 (576.3%) stddev-sans-first:126460.88 15:25:30 INFO - PROCESS | 2807 | Values: 576.7 577.6 589.4 593.4 628.3 38346.2 42445.8 42674.8 43186.6 43210.8 43084.6 43443.1 43465.3 43616.0 43715.8 8796.5 9051.1 9077.1 9088.5 9103.8 8879.7 8975.3 8998.1 9013.8 9070.7 9029.9 9040.4 9052.7 9098.5 9107.8 9027.5 9060.0 9076.5 9079.2 9089.2 8966.5 8981.8 8991.9 9024.8 9031.7 40103.2 40791.4 40810.8 40843.2 40852.0 3179.4 3362.6 3424.8 3483.3 3697.4 29992.0 30838.2 30922.5 31120.8 31969.5 3651.1 3732.3 3756.8 3756.8 3862.3 311112.0 313581.0 315115.0 316120.0 316785.0 34049.5 34061.5 34065.5 34103.1 34111.5 35051.1 35347.6 36010.8 36015.5 37914.0 16831.7 16965.0 16975.2 16999.2 17018.9 12804.3 12810.7 12862.5 12865.5 12886.0 18965.1 19001.2 19010.1 19049.2 19139.0 6825.4 7087.3 7115.8 7153.8 7262.7 932.2 1091.2 1094.6 1116.5 1190.1 32622.7 32897.2 33385.3 33488.7 33615.8 1056.5 1068.5 1086.7 1100.2 1127.7 16338.0 16547.3 16648.7 16681.5 16711.2 551581.0 552966.0 553338.0 555056.0 557221.0 55715.0 55735.4 56300.4 56357.7 56365.7 1326.7 1358.4 1393.1 1399.1 1401.2 29523.6 30861.5 30937.5 31011.4 31479.0 48949.0 49055.5 49483.0 49650.8 49924.8 511776.3 515313.0 517738.0 519547.0 520035.4 27255.7 27354.5 27380.7 27639.2 27658.6 42524.4 43215.8 47006.8 48231.5 48658.3 39931.2 40956.6 41128.2 41230.8 42852.0 40665.4 41622.2 41716.6 42206.0 42336.8 34244.5 40124.8 40184.2 41181.4 41353.2 33511.0 36924.8 37213.4 37297.8 37373.6 27001.7 27935.9 27961.0 28418.6 28568.6 15:25:30 INFO - PROCESS | 2807 | 15:25:30 INFO - PROCESS | 2807 | [#2] jquery.html Cycles:180 Average:28345.70 Median:13050.92 stddev:74279.81 (569.2%) stddev-sans-first:74458.48 15:25:30 INFO - PROCESS | 2807 | Values: 370.3 383.1 384.6 399.9 405.6 17914.4 20057.9 20271.9 20371.8 20454.6 16129.4 16510.0 16538.6 18185.5 19493.7 5506.8 5568.7 5721.5 5741.2 5742.8 5530.3 5622.9 5651.4 5665.2 5672.0 5569.1 5603.8 5610.3 5615.2 5696.3 5501.8 5708.7 5726.1 5734.5 5752.1 5029.2 5035.3 5039.8 5111.2 5116.7 22928.9 23312.9 23318.9 23347.6 23549.0 2552.8 2622.8 2896.3 2964.5 3054.6 14565.3 14709.5 14725.9 14913.5 15470.2 1888.6 1931.5 1952.7 2020.4 2030.3 80116.0 80306.6 80641.6 82782.0 84459.6 10168.2 10302.5 10522.2 10900.0 11094.4 14709.4 14836.4 14837.9 14881.2 14903.9 8185.8 8407.3 8536.8 8572.2 8640.1 8101.6 8265.8 8542.8 8543.1 8601.1 6415.6 6433.6 6546.9 6576.3 6658.2 1720.5 1776.7 1777.7 1818.1 1842.2 978.5 985.6 999.2 1059.0 1106.4 19838.7 20305.7 20661.0 20780.3 20886.6 1000.1 1000.4 1048.3 1049.2 1060.6 9693.4 11675.4 11716.1 11851.6 11895.1 380820.0 390085.1 393802.0 519917.0 523431.0 89785.0 103643.5 105549.0 107408.5 108143.5 986.5 995.5 1038.7 1038.9 1050.1 18295.9 18661.0 19076.3 19201.3 19486.8 39489.6 41843.6 44388.0 44394.3 45241.8 62526.7 63290.7 64315.0 64539.7 65219.7 7476.0 7779.5 8136.1 8176.6 8400.2 10756.7 13353.1 13671.9 13869.4 14147.6 11131.7 11366.6 11429.0 11607.4 11735.2 6655.6 11013.3 11670.8 11681.0 12262.9 11242.3 11539.2 11562.5 11783.9 11876.9 8550.9 8641.0 8695.1 8759.3 8868.1 9104.8 11330.8 11348.7 11371.7 11648.9 15:25:30 INFO - PROCESS | 2807 | 15:25:30 INFO - PROCESS | 2807 | [#3] mootools.html Cycles:180 Average:5881.80 Median:4285.66 stddev:3399.81 (79.3%) stddev-sans-first:3393.02 15:25:30 INFO - PROCESS | 2807 | Values: 1448.2 1461.2 1584.8 1709.2 1745.8 7881.6 8592.4 8611.3 9245.4 9278.2 8722.7 9074.1 9123.3 9137.9 9140.7 2294.6 2329.9 2343.4 2345.1 2346.4 2289.8 2300.8 2360.8 2365.1 2366.9 2311.1 2343.6 2356.8 2370.6 2374.0 2258.2 2287.3 2288.8 2298.4 2300.3 2238.8 2281.9 2286.5 2294.1 2300.1 8917.1 8972.9 9022.1 9056.1 9073.2 5107.1 5253.3 5257.6 5266.8 5292.4 3069.8 3164.9 3271.4 3276.3 3317.4 1068.7 1072.1 1087.1 1096.9 1101.9 12341.1 12421.8 12448.3 12491.6 12576.1 4244.7 4308.4 4494.3 4497.0 4497.4 10580.9 10590.9 10620.8 10645.4 10645.9 5171.8 5194.9 5201.5 5218.6 5238.9 4286.2 4666.0 4779.6 4796.2 4821.5 3843.6 3873.8 3967.9 4033.9 4041.1 1262.8 1263.8 1281.5 1284.2 1284.5 982.4 995.9 1012.9 1015.0 1016.4 6116.9 6145.2 6169.1 6321.5 6328.8 384.3 393.6 396.5 398.8 399.4 4209.5 4242.5 4285.1 4345.5 4452.8 10967.0 11142.1 11229.9 11287.0 11382.4 11001.2 11050.7 11123.8 11127.7 11218.6 7991.9 8317.6 8354.7 8387.6 8391.0 6270.7 6438.3 6441.2 6493.6 6573.4 9702.2 10344.5 10345.1 10381.8 10401.1 10136.3 10395.9 10413.6 10431.5 10438.3 7302.6 7609.1 7706.8 8031.0 8201.4 8640.7 8643.5 8669.5 8688.9 8722.4 7680.5 7718.1 7851.6 7883.6 7901.0 7655.5 7728.1 7745.2 7818.8 7843.9 7136.8 7250.4 7309.4 7315.3 7317.7 5179.7 5209.2 5265.6 5303.3 5488.8 5431.8 5515.6 5530.1 5625.2 5657.1 15:25:30 INFO - PROCESS | 2807 | 15:25:30 INFO - PROCESS | 2807 | [#4] prototype.html Cycles:180 Average:4671.51 Median:5161.64 stddev:1370.36 (26.5%) stddev-sans-first:1334.45 15:25:30 INFO - PROCESS | 2807 | Values: 305.4 314.0 317.5 321.6 321.8 5299.8 5382.4 5407.9 5501.3 5533.7 5345.2 5428.3 5480.7 5489.7 5502.3 4266.3 4269.2 4274.9 4275.6 4299.5 4153.1 4232.6 4238.7 4241.5 4262.6 4187.5 4214.8 4218.7 4239.1 4243.5 4229.2 4237.6 4238.9 4243.8 4252.1 3645.6 3757.2 3776.6 3784.4 3786.8 5284.2 5303.9 5323.7 5325.9 5333.8 4850.6 4854.8 4862.2 4864.5 4889.6 5603.7 5668.7 5710.0 5721.0 5731.3 4054.4 4089.4 4091.8 4100.1 4109.3 6010.7 6045.6 6046.0 6052.5 6063.8 4059.8 4177.7 4232.3 4245.9 4249.9 4254.3 4256.5 4256.8 4258.3 4281.4 4919.4 4919.8 4923.5 4925.3 4926.2 5585.3 5759.9 5809.9 5850.7 5872.1 1431.3 1432.9 1456.6 1459.3 1460.3 885.2 912.0 919.8 930.5 932.7 4886.6 4902.2 4903.0 4903.9 4919.2 5074.7 5095.8 5111.4 5127.5 5207.9 4762.4 4932.6 4936.5 4946.2 4952.4 2738.2 2741.8 2745.3 2747.5 2756.0 5319.7 5330.7 5369.8 5396.5 5402.4 4932.2 5186.6 5252.2 5266.5 5272.7 5346.7 5356.8 5387.9 5396.3 5451.7 5064.9 5093.6 5117.3 5130.4 5136.6 5109.9 5365.3 5815.6 5826.6 5831.8 6110.7 6154.2 6165.9 6166.3 6168.3 3802.8 3990.5 4078.3 4107.4 4144.8 5841.2 5844.2 5864.2 5871.3 5871.7 5641.4 5707.8 5725.3 5759.6 5761.2 5650.6 5694.0 5697.2 5700.0 5709.6 5627.9 5634.7 5636.6 5646.4 5661.5 5607.2 5686.5 5723.5 5739.9 5845.5 5548.6 5627.8 5629.5 5685.3 5691.3 15:25:30 INFO - PROCESS | 2807 | 15:25:30 INFO - PROCESS | 2807 | [#5] yui.html Cycles:180 Average:22170.31 Median:3674.53 stddev:32958.94 (897.0%) stddev-sans-first:33012.18 15:25:30 INFO - PROCESS | 2807 | Values: 755.8 767.6 771.8 824.4 838.1 15703.1 16703.2 16754.7 16760.5 16826.3 15155.3 15306.7 15327.8 15334.2 15353.2 656.2 764.7 781.9 801.6 803.5 780.1 780.4 780.4 780.7 781.2 834.0 834.1 834.3 835.7 836.4 826.3 826.7 829.1 830.6 830.8 601.7 602.0 607.1 610.6 613.7 14686.9 14732.8 14753.5 14769.7 14815.0 14813.9 15027.8 15167.5 15223.2 15250.7 12749.3 12789.4 12859.5 12930.9 13051.7 3925.0 3945.4 4033.2 4106.6 4116.9 80664.0 82195.6 82699.2 82953.0 82963.0 11470.5 11562.2 11779.8 11800.2 12273.8 23239.3 23255.5 23282.9 23376.5 23412.8 8859.4 8876.8 9033.6 9116.7 9373.8 4364.8 4379.2 4458.5 4460.2 4468.5 3542.6 3651.8 3668.3 3669.7 3679.4 618.2 626.1 629.5 636.4 648.5 647.3 710.8 711.9 748.0 756.6 10126.4 10434.5 10454.7 10624.7 10820.8 630.6 736.5 738.6 740.3 756.5 5019.7 5252.1 5260.6 5289.8 5295.4 123690.4 129177.0 131231.3 133634.0 134968.0 109733.0 109890.0 110139.4 113483.4 113732.4 93421.0 96833.0 96838.5 100924.0 100947.5 9300.6 9485.3 9803.0 9854.6 9906.5 46039.8 46351.3 46827.5 47993.8 48529.8 69648.3 69654.0 71475.3 72811.6 72940.3 12638.9 12727.5 12872.2 13049.8 13239.8 14517.9 14696.4 14950.4 14976.6 15039.5 13765.4 13885.7 14101.2 14242.1 14610.9 12886.4 13269.8 13533.1 13713.2 13846.4 14447.4 14601.9 14745.9 15188.8 15306.5 11940.2 12073.4 12073.9 12168.0 12425.8 11927.3 12510.7 12532.5 12663.6 12781.0 15:25:30 INFO - PROCESS | 2807 | -------- Summary: end -------- 15:25:30 INFO - PROCESS | 2807 | 15:25:30 INFO - TEST-INFO | 2807: exit 0 15:25:30 INFO - TEST-OK | dromaeo_css | took 1111192ms 15:25:30 INFO - TEST-START | kraken 15:25:30 INFO - operating with platform_type : linux_ 15:25:30 INFO - Initialising browser for kraken test... 15:25:31 INFO - TEST-INFO | started process 3103 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg5uhgA/profile http://localhost:46025/getInfo.html) 15:25:35 INFO - PROCESS | 3103 | __metrics Screen width/height:1600/1200 15:25:35 INFO - PROCESS | 3103 | colorDepth:24 15:25:35 INFO - PROCESS | 3103 | Browser inner width/height: 1024/697 15:25:35 INFO - PROCESS | 3103 | __metrics 15:25:36 ERROR - PROCESS | 3103 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 15:25:37 INFO - TEST-INFO | 3103: exit 0 15:25:37 INFO - Browser initialized. 15:25:37 INFO - Running cycle 1/1 for kraken test... 15:25:37 INFO - TEST-INFO | started process 3221 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg5uhgA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:25:49 INFO - PROCESS | 3221 | RSS: Main: 163385344 15:25:49 INFO - PROCESS | 3221 | 15:25:51 INFO - PROCESS | 3221 | Cycle 1(1): loaded http://localhost:46025/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46025/tests/kraken/driver.html?testName=audio-beat-detection) 15:25:52 INFO - PROCESS | 3221 | RSS: Main: 169009152 15:25:52 INFO - PROCESS | 3221 | 15:25:55 INFO - PROCESS | 3221 | Cycle 1(1): loaded http://localhost:46025/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46025/tests/kraken/driver.html?testName=audio-dft) 15:25:55 INFO - PROCESS | 3221 | RSS: Main: 167391232 15:25:55 INFO - PROCESS | 3221 | 15:25:58 INFO - PROCESS | 3221 | Cycle 1(1): loaded http://localhost:46025/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46025/tests/kraken/driver.html?testName=audio-fft) 15:25:59 INFO - PROCESS | 3221 | RSS: Main: 163463168 15:25:59 INFO - PROCESS | 3221 | 15:26:01 INFO - PROCESS | 3221 | Cycle 1(1): loaded http://localhost:46025/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46025/tests/kraken/driver.html?testName=audio-oscillator) 15:26:01 INFO - PROCESS | 3221 | RSS: Main: 164421632 15:26:01 INFO - PROCESS | 3221 | 15:26:04 INFO - PROCESS | 3221 | Cycle 1(1): loaded http://localhost:46025/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46025/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:26:04 INFO - PROCESS | 3221 | RSS: Main: 164970496 15:26:04 INFO - PROCESS | 3221 | 15:26:07 INFO - PROCESS | 3221 | Cycle 1(1): loaded http://localhost:46025/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46025/tests/kraken/driver.html?testName=imaging-darkroom) 15:26:08 INFO - PROCESS | 3221 | RSS: Main: 164687872 15:26:08 INFO - PROCESS | 3221 | 15:26:11 INFO - PROCESS | 3221 | Cycle 1(1): loaded http://localhost:46025/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46025/tests/kraken/driver.html?testName=imaging-desaturate) 15:26:12 INFO - PROCESS | 3221 | RSS: Main: 162807808 15:26:12 INFO - PROCESS | 3221 | 15:26:15 INFO - PROCESS | 3221 | Cycle 1(1): loaded http://localhost:46025/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46025/tests/kraken/driver.html?testName=json-parse-financial) 15:26:16 INFO - PROCESS | 3221 | RSS: Main: 164417536 15:26:16 INFO - PROCESS | 3221 | 15:26:17 INFO - PROCESS | 3221 | Cycle 1(1): loaded http://localhost:46025/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46025/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:26:18 INFO - PROCESS | 3221 | RSS: Main: 164311040 15:26:18 INFO - PROCESS | 3221 | 15:26:19 INFO - PROCESS | 3221 | Cycle 1(1): loaded http://localhost:46025/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46025/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:26:20 INFO - PROCESS | 3221 | RSS: Main: 164495360 15:26:20 INFO - PROCESS | 3221 | 15:26:22 INFO - PROCESS | 3221 | Cycle 1(1): loaded http://localhost:46025/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46025/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:26:23 INFO - PROCESS | 3221 | RSS: Main: 165273600 15:26:23 INFO - PROCESS | 3221 | 15:26:25 INFO - PROCESS | 3221 | Cycle 1(1): loaded http://localhost:46025/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46025/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:26:26 INFO - PROCESS | 3221 | RSS: Main: 165052416 15:26:26 INFO - PROCESS | 3221 | 15:26:29 INFO - PROCESS | 3221 | Cycle 1(1): loaded http://localhost:46025/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46025/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:26:29 INFO - PROCESS | 3221 | RSS: Main: 165642240 15:26:29 INFO - PROCESS | 3221 | 15:26:31 INFO - PROCESS | 3221 | Cycle 1(1): loaded http://localhost:46025/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46025/tests/kraken/driver.html?testName=ai-astar) 15:26:31 INFO - PROCESS | 3221 | RSS: Main: 166457344 15:26:31 INFO - PROCESS | 3221 | 15:26:31 INFO - PROCESS | 3221 | __start_tp_report 15:26:31 INFO - PROCESS | 3221 | _x_x_mozilla_page_load 15:26:31 INFO - PROCESS | 3221 | _x_x_mozilla_page_load_details 15:26:31 INFO - PROCESS | 3221 | |i|pagename|runs| 15:26:31 INFO - PROCESS | 3221 | |0;ai-astar;102;111;106;110;111;111;113;111;112;112 15:26:31 INFO - PROCESS | 3221 | |1;audio-beat-detection;161;118;143;180;119;149;162;123;185;121 15:26:31 INFO - PROCESS | 3221 | |2;audio-dft;162;161;161;161;164;166;177;164;162;165 15:26:31 INFO - PROCESS | 3221 | |3;audio-fft;74;76;77;182;76;75;77;76;165;77 15:26:31 INFO - PROCESS | 3221 | |4;audio-oscillator;84;84;157;84;85;85;143;85;84;145 15:26:31 INFO - PROCESS | 3221 | |5;imaging-gaussian-blur;117;118;117;118;117;117;117;117;117;118 15:26:31 INFO - PROCESS | 3221 | |6;imaging-darkroom;146;147;147;149;147;147;147;148;147;147 15:26:31 INFO - PROCESS | 3221 | |7;imaging-desaturate;95;97;96;96;95;97;96;97;95;96 15:26:31 INFO - PROCESS | 3221 | |8;json-parse-financial;56;58;54;53;55;56;54;55;56;52 15:26:31 INFO - PROCESS | 3221 | |9;json-stringify-tinderbox;60;61;61;62;62;61;60;61;62;62 15:26:31 INFO - PROCESS | 3221 | |10;stanford-crypto-aes;76;78;77;77;76;76;76;76;82;76 15:26:31 INFO - PROCESS | 3221 | |11;stanford-crypto-ccm;126;127;133;131;132;124;123;125;162;135 15:26:31 INFO - PROCESS | 3221 | |12;stanford-crypto-pbkdf2;162;168;166;158;166;163;163;162;157;159 15:26:31 INFO - PROCESS | 3221 | |13;stanford-crypto-sha256-iterative;65;65;75;65;64;63;64;64;63;62 15:26:31 INFO - PROCESS | 3221 | __end_tp_report 15:26:31 INFO - PROCESS | 3221 | __start_cc_report 15:26:31 INFO - PROCESS | 3221 | _x_x_mozilla_cycle_collect,855 15:26:31 INFO - PROCESS | 3221 | __end_cc_report 15:26:31 INFO - PROCESS | 3221 | __startTimestamp1470003991902__endTimestamp 15:26:31 INFO - PROCESS | 3221 | 15:26:31 INFO - PROCESS | 3221 | ------- Summary: start ------- 15:26:31 INFO - PROCESS | 3221 | Number of tests: 14 15:26:31 INFO - PROCESS | 3221 | 15:26:31 INFO - PROCESS | 3221 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:3.35 (3.0%) stddev-sans-first:1.99 15:26:31 INFO - PROCESS | 3221 | Values: 102.0 111.0 106.0 110.0 111.0 111.0 113.0 111.0 112.0 112.0 15:26:31 INFO - PROCESS | 3221 | 15:26:31 INFO - PROCESS | 3221 | [#1] audio-beat-detection Cycles:10 Average:146.10 Median:155.00 stddev:25.48 (16.4%) stddev-sans-first:26.45 15:26:31 INFO - PROCESS | 3221 | Values: 161.0 118.0 143.0 180.0 119.0 149.0 162.0 123.0 185.0 121.0 15:26:31 INFO - PROCESS | 3221 | 15:26:31 INFO - PROCESS | 3221 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.00 stddev:4.81 (2.9%) stddev-sans-first:5.03 15:26:31 INFO - PROCESS | 3221 | Values: 162.0 161.0 161.0 161.0 164.0 166.0 177.0 164.0 162.0 165.0 15:26:31 INFO - PROCESS | 3221 | 15:26:31 INFO - PROCESS | 3221 | [#3] audio-fft Cycles:10 Average:95.50 Median:76.00 stddev:41.32 (54.4%) stddev-sans-first:43.08 15:26:31 INFO - PROCESS | 3221 | Values: 74.0 76.0 77.0 182.0 76.0 75.0 77.0 76.0 165.0 77.0 15:26:31 INFO - PROCESS | 3221 | 15:26:31 INFO - PROCESS | 3221 | [#4] audio-oscillator Cycles:10 Average:103.60 Median:84.00 stddev:31.08 (37.0%) stddev-sans-first:32.14 15:26:31 INFO - PROCESS | 3221 | Values: 84.0 84.0 157.0 84.0 85.0 85.0 143.0 85.0 84.0 145.0 15:26:31 INFO - PROCESS | 3221 | 15:26:31 INFO - PROCESS | 3221 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 15:26:31 INFO - PROCESS | 3221 | Values: 117.0 118.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 118.0 15:26:31 INFO - PROCESS | 3221 | 15:26:31 INFO - PROCESS | 3221 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 15:26:31 INFO - PROCESS | 3221 | Values: 146.0 147.0 147.0 149.0 147.0 147.0 147.0 148.0 147.0 147.0 15:26:31 INFO - PROCESS | 3221 | 15:26:31 INFO - PROCESS | 3221 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.78 15:26:31 INFO - PROCESS | 3221 | Values: 95.0 97.0 96.0 96.0 95.0 97.0 96.0 97.0 95.0 96.0 15:26:31 INFO - PROCESS | 3221 | 15:26:31 INFO - PROCESS | 3221 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.50 stddev:1.73 (3.1%) stddev-sans-first:1.79 15:26:31 INFO - PROCESS | 3221 | Values: 56.0 58.0 54.0 53.0 55.0 56.0 54.0 55.0 56.0 52.0 15:26:31 INFO - PROCESS | 3221 | 15:26:31 INFO - PROCESS | 3221 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.50 stddev:0.79 (1.3%) stddev-sans-first:0.71 15:26:31 INFO - PROCESS | 3221 | Values: 60.0 61.0 61.0 62.0 62.0 61.0 60.0 61.0 62.0 62.0 15:26:31 INFO - PROCESS | 3221 | 15:26:31 INFO - PROCESS | 3221 | [#10] stanford-crypto-aes Cycles:10 Average:77.00 Median:76.50 stddev:1.89 (2.5%) stddev-sans-first:1.96 15:26:31 INFO - PROCESS | 3221 | Values: 76.0 78.0 77.0 77.0 76.0 76.0 76.0 76.0 82.0 76.0 15:26:31 INFO - PROCESS | 3221 | 15:26:31 INFO - PROCESS | 3221 | [#11] stanford-crypto-ccm Cycles:10 Average:131.80 Median:131.50 stddev:11.38 (8.7%) stddev-sans-first:11.88 15:26:31 INFO - PROCESS | 3221 | Values: 126.0 127.0 133.0 131.0 132.0 124.0 123.0 125.0 162.0 135.0 15:26:31 INFO - PROCESS | 3221 | 15:26:31 INFO - PROCESS | 3221 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.40 Median:163.00 stddev:3.63 (2.2%) stddev-sans-first:3.84 15:26:31 INFO - PROCESS | 3221 | Values: 162.0 168.0 166.0 158.0 166.0 163.0 163.0 162.0 157.0 159.0 15:26:31 INFO - PROCESS | 3221 | 15:26:31 INFO - PROCESS | 3221 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:64.50 stddev:3.65 (5.7%) stddev-sans-first:3.87 15:26:31 INFO - PROCESS | 3221 | Values: 65.0 65.0 75.0 65.0 64.0 63.0 64.0 64.0 63.0 62.0 15:26:31 INFO - PROCESS | 3221 | -------- Summary: end -------- 15:26:31 INFO - PROCESS | 3221 | 15:26:32 INFO - TEST-INFO | 3221: exit 0 15:26:32 INFO - TEST-OK | kraken | took 61919ms 15:26:32 INFO - SUITE-END | took 1173s 15:26:33 INFO - Completed test suite (00:19:33) 15:26:33 INFO - javascript benchmark 15:26:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7261.1072169849185, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3072.6466456357516, 3086.891958781443, 3102.441560519107, 3116.392303500817, 3121.1416860363397, 5266.078436273656, 5342.572594192465, 5348.598855085869, 5383.300170977773, 5479.671219726819, 5319.388270348911, 5344.652597581155, 5384.1923711443305, 5387.919181212285, 5414.214938833867, 4845.709257444556, 4853.684510506806, 4908.877278068059, 4941.728204948744, 4997.0505603935135, 4902.852914412556, 5032.169692000815, 5032.723200223986, 5037.5718063964605, 5086.516780905827, 396.47587840755796, 4932.383452068491, 4956.207006878882, 5025.3718285214345, 5026.346574945252, 4863.975680121577, 4872.464028956847, 4886.486918873503, 4919.7540122993705, 4926.359573255454, 4769.618430525585, 4817.710937343771, 4829.275608658694, 4835.637327200474, 4882.0, 5136.512031357015, 5240.711760853152, 5247.2653828464045, 5350.491703288181, 5366.785328586851, 5622.156676498517, 5695.857603559903, 5705.657660540381, 5740.856478588027, 5758.48173664368, 5735.4551317624755, 5736.196932429463, 5744.741486633112, 5746.655200687972, 5755.079187330049, 5282.234076058989, 5317.8936421271355, 5346.545543628797, 5354.812581559666, 5359.196120581905, 5866.325372582122, 5937.6734279614175, 5940.762369505172, 5948.0, 5985.102234664835, 5619.325680918234, 5637.013522633605, 5662.462066103713, 5662.915056274159, 5679.943200568024, 5638.718064096779, 5714.371419143891, 5739.368669446358, 5740.0, 5764.769409223584, 5701.828945131652, 5742.822721342115, 5785.623934444247, 5831.183634291203, 5831.591788574844, 5782.335031471351, 5784.4504772046585, 5786.537077033827, 5806.767729290866, 5812.796552120655, 4344.978275108668, 4392.450943632046, 4451.154280686659, 4475.849270069415, 4495.168393847149, 3949.19041596472, 3962.4254483100367, 3976.1451287973223, 4001.559828418872, 4008.238434697398, 5565.499105080562, 5588.133839254922, 5597.132444471032, 5601.215829783833, 5615.466530679579, 5641.717914104278, 5767.394423585547, 5777.30672319316, 5840.1239814027385, 5844.0, 5516.834494965157, 5535.501804837584, 5559.999200143932, 5560.332760068818, 5607.80372686954, 5011.198208286657, 5016.949830501721, 5018.774155163026, 5024.447310795809, 5068.619853511002, 5847.590668653239, 5968.671723055187, 5974.820755377345, 5986.910196347058, 5990.9101363479585, 5844.47399734026, 5845.444682755132, 5854.180414741854, 5855.619384739978, 5882.49998750111, 6000.339962604197, 6021.157038014594, 6053.697315134314, 6067.848303792264, 6068.51451883857, 5552.472515111058, 5640.633358831663, 5663.943360566342, 5706.743196556248, 5750.712464376848, 5844.357120716632, 5845.503132233808, 5847.1229315603, 5852.239208902815, 5879.559033072451, 5681.460261275172, 5684.0, 5684.147377893184, 5684.545236380997, 5692.686902220417, 5489.0, 5614.242077319673, 5638.830835074954, 5660.85847853807, 5665.0935850265405, 5604.131359639263, 5607.327120745536, 5609.691466969192, 5619.7752089917585, 5624.0, 5728.054870946414, 5731.742071606871, 5748.166515855261, 5761.56788240892, 5763.682997435181, 5422.674639521641, 5569.916451253153, 5589.105743081088, 5609.411011843861, 5631.577631677558], "value": 5299.901225832078, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.7174084698496, 577.5841394196179, 589.3634874335718, 593.3621357041181, 628.2555172121034, 38346.23307533851, 42445.78777106118, 42674.78662606682, 43186.568134318644, 43210.78394608023, 43084.56915430845, 43443.13113737731, 43465.348019779725, 43616.0, 43715.78142109293, 8796.516191609442, 9051.094890510962, 9077.137671921157, 9088.54557272137, 9103.772405689877, 8879.733607991739, 8975.281977441822, 8998.055204203563, 9013.774655633597, 9070.727878163632, 9029.864552031724, 9040.41237319572, 9052.728418147466, 9098.454092754422, 9107.772305692344, 9027.458352498837, 9060.048694887073, 9076.546172691373, 9079.182873541413, 9089.181973622339, 8966.506842123681, 8981.775455613597, 8991.865122023175, 9024.77438064047, 9031.729048128567, 40103.19793604111, 40791.388129178085, 40810.79594602008, 40843.18313633741, 40852.0, 3179.364127174574, 3362.5628668272966, 3424.7773894697016, 3483.3381657484997, 3697.4268988306853, 29992.0, 30838.22904427385, 30922.53616195759, 31120.812677449918, 31969.52045719316, 3651.1054791575966, 3732.346839303111, 3756.77459352437, 3756.812159392047, 3862.343401621731, 311112.0, 313581.0, 315114.99999999773, 316120.0, 316785.0, 34049.48925766115, 34061.48907766386, 34065.48901766475, 34103.147421314665, 34111.488327675106, 35051.123721907155, 35347.64652353495, 36010.81994590063, 36015.4597681035, 37914.0, 16831.663366732842, 16965.0, 16975.151242437827, 16999.150042497826, 17018.914905425394, 12804.295763733084, 12810.743785124245, 12862.485500579873, 12865.549705760253, 12886.0, 18965.146568404456, 19001.23995040183, 19010.144543495575, 19049.238030478624, 19139.0, 6825.419839313615, 7087.291270872975, 7115.82210444743, 7153.785386438415, 7262.709491620276, 932.2355668351886, 1091.247039542713, 1094.6332978452149, 1116.5290078614853, 1190.0717440396504, 32622.67377326244, 32897.17757056045, 33385.332293354, 33488.665113349045, 33615.83192084073, 1056.5351245451977, 1068.4657671164418, 1086.6739978006567, 1100.2133474565724, 1127.6617014895498, 16338.0, 16547.255373508222, 16648.667026659397, 16681.499555013368, 16711.164441777863, 551581.0, 552966.0, 553338.0, 555056.0, 557221.0, 55715.0, 55735.44264557303, 56300.43699563034, 56357.71821140868, 56365.7181714097, 1326.674964633671, 1358.436248956672, 1393.1084106171854, 1399.139529189541, 1401.222321611495, 29523.557146642386, 30861.537076943416, 30937.535936960514, 31011.379772403976, 31479.0, 48949.0, 49055.509444905096, 49483.0, 49650.75174624104, 49924.750376249336, 511776.29342239583, 515313.0, 517738.0, 519547.0, 520035.39982299844, 27255.727442725318, 27354.452910941272, 27380.726192737817, 27639.170824875288, 27658.585121222794, 42524.362134568626, 43215.78392108019, 47006.76496617495, 48231.517684822706, 48658.270125948846, 39931.2013759729, 40956.59043409528, 41128.1774364505, 41230.79384603058, 42852.0, 40665.39001914914, 41622.16755664809, 41716.58283417127, 42206.0, 42336.78831605946, 34244.48633270453, 40124.799376002935, 40184.1963160741, 41181.382279266436, 41353.1729365405, 33511.0, 36924.815375922946, 37213.44179837251, 37297.81351093227, 37373.6262637381, 27001.72998270071, 27935.860320698266, 27961.0, 28418.57372139461, 28568.57147142836], "value": 19397.70543283555, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.30752492838394, 383.05003591094095, 384.5808069204567, 399.8740396775014, 405.5842761169802, 17914.37299694511, 20057.899710501464, 20271.898640506814, 20371.796282037176, 20454.590908181828, 16129.435469758531, 16510.0, 16538.586535336624, 18185.54515638749, 19493.707594386095, 5506.779728810853, 5568.693721845297, 5721.542276617861, 5741.224934633834, 5742.799002034909, 5530.336359636849, 5622.859428514279, 5651.378348381675, 5665.1785491103765, 5671.971640141794, 5569.10894256919, 5603.831885043455, 5610.298712660918, 5615.185798059279, 5696.287964004499, 5501.752421141038, 5708.743106560236, 5726.141078838166, 5734.541236701054, 5752.07966725322, 5029.19532874742, 5035.295058691786, 5039.77321020555, 5111.1566591512355, 5116.718580478072, 22928.885355573282, 23312.883435582713, 23318.90129888301, 23347.649785253234, 23549.0, 2552.8468291902545, 2622.763951244397, 2896.348321627638, 2964.4812157872284, 3054.6334439867137, 14565.271736413137, 14709.485168019068, 14725.926370368186, 14913.478028268959, 15470.226488675633, 1888.5939523002621, 1931.5364312565023, 1952.7363805886166, 2020.4342784020498, 2030.2995466564012, 80116.0, 80306.5984670073, 80641.59679201625, 82782.0, 84459.5777021111, 10168.186545076376, 10302.484875756183, 10522.210834187466, 10900.0, 11094.389808560445, 14709.411623535152, 14836.406543738129, 14837.92581037088, 14881.181535015678, 14903.850961490463, 8185.795355116051, 8407.327413806881, 8536.829263414696, 8572.228499434956, 8640.13598640131, 8101.6354264058255, 8265.752027439186, 8542.78643033929, 8543.145685431531, 8601.13988601135, 6415.615063096229, 6433.646149461824, 6546.9017964730565, 6576.276609572943, 6658.201015878029, 1720.4924547258588, 1776.733489976514, 1777.7244527098321, 1818.1091265279917, 1842.1526097995072, 978.515634760798, 985.610683779903, 999.160705007797, 1059.0, 1106.3859557945257, 19838.70241946372, 20305.695414568792, 20661.0, 20780.272690456062, 20886.58226835455, 1000.0599436529639, 1000.3847633705365, 1048.320395412109, 1049.197364016528, 1060.5810704771573, 9693.418394896187, 11675.416229188506, 11716.062714982781, 11851.585194518151, 11895.107866910017, 380820.0, 390085.09914901055, 393802.0, 519917.0, 523431.0, 89785.0, 103643.4817825906, 105549.0, 107408.46295768628, 108143.45928270466, 986.5067466266867, 995.4967998322585, 1038.6728180623231, 1038.9168866490663, 1050.0549505445008, 18295.908520457313, 18661.0, 19076.33232836844, 19201.32795352156, 19486.805131949066, 39489.60510394974, 41843.581564183965, 44388.0, 44394.334084988106, 45241.773791130836, 62526.687366562874, 63290.683546581975, 64315.0, 64539.67730161319, 65219.673901632086, 7476.0, 7779.494332868346, 8136.105028446985, 8176.632051557575, 8400.201980811813, 10756.731081723019, 13353.132046416951, 13671.931640341734, 13869.445222191, 14147.575572732834, 11131.666050018512, 11366.602168924048, 11429.0, 11607.419629018685, 11735.178537502294, 6655.567388119756, 11013.2841365311, 11670.824937626112, 11681.0, 12262.877371226174, 11242.269252498561, 11539.249948753304, 11562.47968841421, 11783.882161178279, 11876.881231187923, 8550.914490855012, 8640.956795215983, 8695.130486951255, 8759.255463285692, 8868.11318868108, 9104.817903642022, 11330.830037549278, 11348.716282093013, 11371.715707107389, 11648.88351116478], "value": 9429.00002692039, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1448.174540511908, 1461.167134733202, 1584.8177459592143, 1709.2137616696318, 1745.816689247629, 7881.605919704006, 8592.441491303061, 8611.268042216412, 9245.399049061807, 9278.164965153135, 8722.65109395625, 9074.137956894085, 9123.315751318662, 9137.90862091379, 9140.680076197334, 2294.6213874710693, 2329.9184528541505, 2343.4024323797407, 2345.0502546468706, 2346.378209774411, 2289.839711220215, 2300.7929286364224, 2360.799332056777, 2365.077619728307, 2366.8816559171973, 2311.0640190722784, 2343.60158773009, 2356.8350215484925, 2370.585147599163, 2373.9881300593474, 2258.1757658454544, 2287.2909398086563, 2288.7940085392393, 2298.37943755186, 2300.321405185466, 2238.787315205053, 2281.908723651052, 2286.5084006938587, 2294.059435631383, 2300.1489448903844, 8917.108289171096, 8972.865407018835, 9022.052684468168, 9056.094390560957, 9073.183413492752, 5107.131787596118, 5253.290805741214, 5257.579393648499, 5266.762995665166, 5292.391374991887, 3069.8004629699, 3164.9050528483954, 3271.4438545447333, 3276.3447310537986, 3317.402867483852, 1068.6954218047897, 1072.0512346573262, 1087.1085709718034, 1096.9286996345213, 1101.884302148279, 12341.074419418579, 12421.813672794915, 12448.31534265624, 12491.562795302212, 12576.056795740356, 4244.72409293395, 4308.375285583573, 4494.325851122358, 4497.0, 4497.392851965008, 10580.894191058145, 10590.89409105899, 10620.787584248272, 10645.414502202453, 10645.946770266253, 5171.7672704728375, 5194.92207616886, 5201.505856943584, 5218.582513398919, 5238.92141617876, 4286.1856247313535, 4665.976670116627, 4779.617630589544, 4796.184648609745, 4821.541953514481, 3843.557990831034, 3873.806309684561, 3967.900802479961, 4033.899152521152, 4041.131156801243, 1262.7916393795106, 1263.823064770933, 1281.5386460874079, 1284.17170924753, 1284.4862055178003, 982.4400091947522, 995.8506224066448, 1012.9111205454167, 1015.0, 1016.4358780876537, 6116.908246376308, 6145.170401995673, 6169.105479705418, 6321.494280457552, 6328.778492752732, 384.27180492965675, 393.6496518098894, 396.5301118174972, 398.8145512336777, 399.44676622876943, 4209.473815773028, 4242.5121111072, 4285.142971405731, 4345.478542574911, 4452.844150454784, 10967.0, 11142.108631309477, 11229.943850280697, 11287.0, 11382.430878456044, 11001.17491188164, 11050.723731906606, 11123.833142502868, 11127.718817642364, 11218.607348742755, 7991.920080799234, 8317.584120793936, 8354.749357519406, 8387.580620968927, 8391.035030971394, 6270.655113968775, 6438.323975982642, 6441.194850643669, 6493.642849643315, 6573.375529324707, 9702.175315098013, 10344.534495947852, 10345.068943795095, 10381.792364152523, 10401.115905148146, 10136.341137826017, 10395.896041039796, 10413.583456661649, 10431.53058112402, 10438.269321147447, 7302.56184628924, 7609.124950630749, 7706.845863082819, 8031.0, 8201.42590018693, 8640.654373824977, 8643.481391116553, 8669.479831210148, 8688.869666954874, 8722.389432739647, 7680.500767450098, 7718.073831140299, 7851.568163751049, 7883.566403847614, 7901.0, 7655.50239234448, 7728.072631284282, 7745.22547745221, 7818.804529886798, 7843.921560784547, 7136.785896423115, 7250.419966402781, 7309.378702810108, 7315.341619254293, 7317.743878964424, 5179.663321884065, 5209.166533354645, 5265.631405801711, 5303.257543943928, 5488.780448782164, 5431.83704488866, 5515.558755299486, 5530.142827861688, 5625.184348269396, 5657.094864821609], "value": 4585.297356419784, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.39988921768736, 313.95447660089286, 317.5316408297761, 321.6172754422236, 321.83103870468, 5299.754557678952, 5382.439092663123, 5407.891842163154, 5501.312335958005, 5533.6679799212025, 5345.224942383352, 5428.348598168215, 5480.725963701809, 5489.6980666063355, 5502.257195278647, 4266.274733295348, 4269.2315383230925, 4274.935875961847, 4275.615194632483, 4299.50555686097, 4153.099342775524, 4232.597903199191, 4238.660907127422, 4241.4698162729655, 4262.573742625744, 4187.492502699041, 4214.789260536961, 4218.6625069994325, 4239.0674051708575, 4243.490781106271, 4229.217594744951, 4237.6186143247105, 4238.872833814959, 4243.83024679014, 4252.08656104751, 3645.57822449245, 3757.248550289926, 3776.622337766229, 3784.3566593679143, 3786.8225770182257, 5284.233786101032, 5303.859670170932, 5323.707196104213, 5325.893482130375, 5333.786648534093, 4850.6362022848425, 4854.83008094715, 4862.17343051682, 4864.513548645143, 4889.584385327252, 5603.663780173202, 5668.716564171775, 5709.9714501427225, 5721.0, 5731.254936858182, 4054.39184122384, 4089.3865920111925, 4091.8158682859344, 4100.097978444737, 4109.2808758467145, 6010.7295171717815, 6045.576809623328, 6045.969770151165, 6052.455279024909, 6063.848403789896, 4059.7767122807936, 4177.707560470799, 4232.32282834745, 4245.8513952011535, 4249.915001699948, 4254.276772948544, 4256.489221293403, 4256.808443619982, 4258.297380932174, 4281.379200016043, 4919.434265059493, 4919.7540122993705, 4923.507649235048, 4925.335079764258, 4926.187179115477, 5585.301837270341, 5759.942400576025, 5809.912851307234, 5850.736716847752, 5872.093313809692, 1431.2843578210895, 1432.8996970211986, 1456.6358410397402, 1459.292243262017, 1460.3355473259853, 885.2121611765534, 912.0423555266943, 919.7746552094779, 930.4693778733945, 932.6735642525061, 4886.584640305543, 4902.240152776325, 4903.0, 4903.926441103386, 4919.2129259318335, 5074.65073051784, 5095.847124586268, 5111.361079865017, 5127.53852153308, 5207.869803254949, 4762.404699412574, 4932.580730637936, 4936.456989731127, 4946.208606622923, 4952.405711314594, 2738.219607411878, 2741.8347202438886, 2745.341118131674, 2747.4642444723486, 2756.0491630387482, 5319.6808191508635, 5330.680159190461, 5369.838904832861, 5396.4603539646505, 5402.405735369106, 4932.161532539477, 5186.6369354144845, 5252.2384254282915, 5266.472722910313, 5272.683638981596, 5346.679199248136, 5356.758945847446, 5387.919181212206, 5396.271503347077, 5451.672899626035, 5064.873378165428, 5093.592512599057, 5117.334746482933, 5130.384353877558, 5136.640435169502, 5109.948900511096, 5365.3293338332705, 5815.563832712648, 5826.592138550261, 5831.825045248649, 6110.747296804233, 6154.230721159855, 6165.876682466415, 6166.321704612399, 6168.25980882297, 3802.790846503469, 3990.4812374391145, 4078.286299897447, 4107.404426358102, 4144.8134833931945, 5841.18223448709, 5844.211031510862, 5864.179014937998, 5871.324797648325, 5871.737576420919, 5641.351244606923, 5707.800226992035, 5725.312962444534, 5759.596828221985, 5761.193432919478, 5650.63270887391, 5694.032014557618, 5697.23087383198, 5699.971500142473, 5709.628874123168, 5627.915581266366, 5634.661920284796, 5636.577256705846, 5646.3788983212635, 5661.547076233974, 5607.158926161109, 5686.516646085129, 5723.456271654186, 5739.942600573941, 5845.532357411482, 5548.583856210719, 5627.774889004394, 5629.521490673339, 5685.260916080883, 5691.3170419549915], "value": 4227.520738519262, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [755.8337165823517, 767.5970115689263, 771.7954741993371, 824.44350063707, 838.1450920061534, 15703.136327501983, 16703.248353824078, 16754.74867876983, 16760.497185084438, 16826.326946922138, 15155.318010689518, 15306.69386612267, 15327.770083448757, 15334.233288335594, 15353.15557644329, 656.1732217406079, 764.6559048428215, 781.8553567590014, 801.623237078575, 803.5138741061661, 780.1496368957835, 780.3601047141318, 780.3640033372783, 780.7228433905967, 781.2148790465574, 833.9916600833975, 834.0825092398373, 834.3283656656389, 835.6740871060261, 836.431226765799, 826.2646244842095, 826.6941231744233, 829.0838623321233, 830.6096134816627, 830.8379865926147, 601.7021574320695, 602.0247199536778, 607.0711810929286, 610.5603965145089, 613.6747523812387, 14686.926565367105, 14732.779008314883, 14753.483628073072, 14769.70460590793, 14815.0, 14813.925930370278, 15027.849721502755, 15167.469138580207, 15223.238838058052, 15250.694986100327, 12749.298788566624, 12789.424475898513, 12859.485620575166, 12930.870691293061, 13051.673708157277, 3925.0, 3945.3687410014545, 4033.233685599727, 4106.609872062149, 4116.938245926313, 80663.99999999942, 82195.58902205511, 82699.17300826975, 82953.0, 82963.0, 11470.48382822775, 11562.248453850472, 11779.823302650468, 11800.173987820941, 12273.754524909451, 23239.3028209154, 23255.534889302457, 23282.8835855823, 23376.532469350517, 23412.765872341057, 8859.379843411029, 8876.801631779756, 9033.593488293043, 9116.726498205064, 9373.812523749486, 4364.8472303469225, 4379.189849877783, 4458.509563947963, 4460.1971645104195, 4468.530804265505, 3542.5926018508203, 3651.817409129586, 3668.3396988542318, 3669.688076513526, 3679.3745063339297, 618.2488276743778, 626.1421852062613, 629.5215636116493, 636.4367534731796, 648.4909346163239, 647.3494138390887, 710.754789597588, 711.8574687626389, 747.9551226926402, 756.587659725451, 10126.39241645489, 10434.530446129942, 10454.738631534272, 10624.681259562225, 10820.837687434694, 630.6247782569363, 736.5139008254527, 738.6159197217416, 740.2967181177903, 756.5007095317175, 5019.723915184627, 5252.133397989365, 5260.605454590845, 5289.841304760864, 5295.443978382292, 123690.38154809168, 129177.0, 131231.34384328016, 133634.0, 134968.0, 109733.0, 109890.0, 110139.44930275297, 113483.43258283655, 113732.43133784278, 93421.0, 96833.0, 96838.51580742192, 100924.0, 100947.49526252468, 9300.575716923386, 9485.33602647808, 9803.0, 9854.55654495535, 9906.455144967096, 46039.76980115078, 46351.30473042974, 46827.53172468368, 47993.76003119962, 48529.75735121302, 69648.30351696418, 69654.0, 71475.28524714687, 72811.63594181996, 72940.27059729335, 12638.873611263769, 12727.490900363882, 12872.16330938486, 13049.804252936403, 13239.80140297877, 14517.85482145165, 14696.41214351414, 14950.401983920521, 14976.625584360478, 15039.473618423302, 13765.38055787472, 13885.722285554435, 14101.153930764187, 14242.145471271757, 14610.853891461375, 12886.355682215664, 13269.800952985906, 13533.120347177402, 13713.245771482665, 13846.446142154604, 14447.422103116178, 14601.853981460474, 14745.92627036858, 15188.772168417261, 15306.540803775904, 11940.164188506722, 12073.406953291833, 12073.939630301793, 12168.0, 12425.75148497007, 11927.284362938251, 12510.687232819253, 12532.498700051896, 12663.620091397273, 12781.0], "value": 7798.937283774903, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1532.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 106.0, 110.0, 111.0, 111.0, 113.0, 111.0, 112.0, 112.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 118.0, 143.0, 180.0, 119.0, 149.0, 162.0, 123.0, 185.0, 121.0], "value": 146.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 161.0, 164.0, 166.0, 177.0, 164.0, 162.0, 165.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 77.0, 182.0, 76.0, 75.0, 77.0, 76.0, 165.0, 77.0], "value": 95.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 157.0, 84.0, 85.0, 85.0, 143.0, 85.0, 84.0, 145.0], "value": 103.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 149.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 96.0, 96.0, 95.0, 97.0, 96.0, 97.0, 95.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 54.0, 53.0, 55.0, 56.0, 54.0, 55.0, 56.0, 52.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 62.0, 62.0, 61.0, 60.0, 61.0, 62.0, 62.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 77.0, 77.0, 76.0, 76.0, 76.0, 76.0, 82.0, 76.0], "value": 77.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 127.0, 133.0, 131.0, 132.0, 124.0, 123.0, 125.0, 162.0, 135.0], "value": 131.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 168.0, 166.0, 158.0, 166.0, 163.0, 163.0, 162.0, 157.0, 159.0], "value": 162.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 75.0, 65.0, 64.0, 63.0, 64.0, 64.0, 63.0, 62.0], "value": 65.0, "unit": "score"}]}]} 15:26:33 INFO - Return code: 0 15:26:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:26:33 ERROR - # TBPL SUCCESS # 15:26:33 INFO - Running post-action listener: _resource_record_post_action 15:26:33 INFO - [mozharness: 2016-07-31 22:26:33.213646Z] Finished run-tests step (success) 15:26:33 INFO - Running post-run listener: _resource_record_post_run 15:26:33 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8192; Write bytes: 539508736; Read time: 204; Write time: 403212 15:26:33 INFO - TinderboxPrint: CPU usage
13.4% 15:26:33 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 204 15:26:33 INFO - TinderboxPrint: I/O write bytes / time
539,508,736 / 403,212 15:26:33 INFO - TinderboxPrint: CPU idle
8,222.9 (86.6%) 15:26:33 INFO - TinderboxPrint: CPU user
1,215.1 (12.8%) 15:26:33 INFO - TinderboxPrint: Swap in / out
0 / 0 15:26:33 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247726080; Read time: 0; Write time: 227636 15:26:33 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291389440; Read time: 192; Write time: 175532 15:26:33 INFO - Running post-run listener: _upload_blobber_files 15:26:33 INFO - Blob upload gear active. 15:26:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:26:33 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 15:26:33 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:26:33 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:26:34 INFO - (blobuploader) - INFO - Open directory for files ... 15:26:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:26:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:26:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:26:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:26:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:26:38 INFO - (blobuploader) - INFO - Done attempting. 15:26:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:26:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:26:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:26:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:26:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:26:39 INFO - (blobuploader) - INFO - Done attempting. 15:26:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:26:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:26:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:26:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:26:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:26:40 INFO - (blobuploader) - INFO - Done attempting. 15:26:40 INFO - (blobuploader) - INFO - Iteration through files over. 15:26:40 INFO - Return code: 0 15:26:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:26:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:26:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/42ed3dc98781b7d12e101e3a9f9d71aa3a12c22c06d7bb5fb2e0a2455591c5f045c810db1abe725bfd80e0209e116c25ad9a6b248c3ad199cac410f26b31daf3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3069345f289420d681f7dd7c1acd0346ac1d60a3099e7f29bd61507c8ff25c1be95a7080c3de7dc9d1591d319383fff61843a44f838e4f0160199bc418e3bd3f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ffdb2180ac0d1c58338e013fa8bf2c50d6300a6f07460172a8a9d2462ad1af9fa5d3540c3efe4934707b926e9cd56bff15610d32995758431e43b28c8ccc67a9"} 15:26:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:26:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:26:40 INFO - Contents: 15:26:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/42ed3dc98781b7d12e101e3a9f9d71aa3a12c22c06d7bb5fb2e0a2455591c5f045c810db1abe725bfd80e0209e116c25ad9a6b248c3ad199cac410f26b31daf3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3069345f289420d681f7dd7c1acd0346ac1d60a3099e7f29bd61507c8ff25c1be95a7080c3de7dc9d1591d319383fff61843a44f838e4f0160199bc418e3bd3f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ffdb2180ac0d1c58338e013fa8bf2c50d6300a6f07460172a8a9d2462ad1af9fa5d3540c3efe4934707b926e9cd56bff15610d32995758431e43b28c8ccc67a9"} 15:26:40 INFO - Running post-run listener: copy_logs_to_upload_dir 15:26:40 INFO - Copying logs to upload dir... 15:26:40 INFO - mkdir: /builds/slave/test/build/upload/logs 15:26:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.014126 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-07-31 15:26:38.823377) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-31 15:26:38.826837) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1470002444.886704-475043275 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/sha512/42ed3dc98781b7d12e101e3a9f9d71aa3a12c22c06d7bb5fb2e0a2455591c5f045c810db1abe725bfd80e0209e116c25ad9a6b248c3ad199cac410f26b31daf3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3069345f289420d681f7dd7c1acd0346ac1d60a3099e7f29bd61507c8ff25c1be95a7080c3de7dc9d1591d319383fff61843a44f838e4f0160199bc418e3bd3f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ffdb2180ac0d1c58338e013fa8bf2c50d6300a6f07460172a8a9d2462ad1af9fa5d3540c3efe4934707b926e9cd56bff15610d32995758431e43b28c8ccc67a9"} build_url:https://queue.taskcluster.net/v1/task/WvYYCjK6R0G3eYmLbYFreA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011524 build_url: 'https://queue.taskcluster.net/v1/task/WvYYCjK6R0G3eYmLbYFreA/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/sha512/42ed3dc98781b7d12e101e3a9f9d71aa3a12c22c06d7bb5fb2e0a2455591c5f045c810db1abe725bfd80e0209e116c25ad9a6b248c3ad199cac410f26b31daf3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3069345f289420d681f7dd7c1acd0346ac1d60a3099e7f29bd61507c8ff25c1be95a7080c3de7dc9d1591d319383fff61843a44f838e4f0160199bc418e3bd3f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ffdb2180ac0d1c58338e013fa8bf2c50d6300a6f07460172a8a9d2462ad1af9fa5d3540c3efe4934707b926e9cd56bff15610d32995758431e43b28c8ccc67a9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-31 15:26:38.851852) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 15:26:38.852154) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1470002444.886704-475043275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004416 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 15:26:38.904353) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-31 15:26:38.904681) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-31 15:26:38.904984) ========= ========= Total master_lag: 0.16 =========