builder: autoland_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-020 starttime: 1470306120.35 results: success (0) buildid: 20160804003002 builduid: bd249a9a74f647be98bc4c7c7276a9be revision: 62a983c56050b3ac647d8f95d9c2ca69c3ad2d91 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 03:22:00.349573) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 03:22:00.350626) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 03:22:00.350941) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 03:22:00.371733) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 03:22:00.372036) ========= 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=af724c981e2a0f424dbabf99000001e7-1470304095.281387-939844424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-04 03:22:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-08-04 03:22:00 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095148 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 03:22:00.481315) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 03:22:00.481659) ========= 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=af724c981e2a0f424dbabf99000001e7-1470304095.281387-939844424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019398 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 03:22:00.533333) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-04 03:22:00.533723) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 62a983c56050b3ac647d8f95d9c2ca69c3ad2d91 --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 62a983c56050b3ac647d8f95d9c2ca69c3ad2d91 --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=af724c981e2a0f424dbabf99000001e7-1470304095.281387-939844424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-04 03:22:00,981 truncating revision to first 12 chars 2016-08-04 03:22:00,981 Setting DEBUG logging. 2016-08-04 03:22:00,981 attempt 1/10 2016-08-04 03:22:00,981 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/62a983c56050?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-04 03:22:02,445 unpacking tar archive at: autoland-62a983c56050/testing/mozharness/ program finished with exit code 0 elapsedTime=1.819386 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-04 03:22:02.368156) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 03:22:02.368519) ========= script_repo_revision: 62a983c56050b3ac647d8f95d9c2ca69c3ad2d91 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 03:22:02.368968) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 03:22:02.369294) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 03:22:02.380117) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-04 03:22:02.380508) ========= /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=af724c981e2a0f424dbabf99000001e7-1470304095.281387-939844424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:22:02 INFO - MultiFileLogger online at 20160804 03:22:02 in /builds/slave/test 03:22:02 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 03:22:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:22:02 INFO - {'append_to_log': False, 03:22:02 INFO - 'base_work_dir': '/builds/slave/test', 03:22:02 INFO - 'blob_upload_branch': 'Autoland', 03:22:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:22:02 INFO - 'branch': 'Autoland', 03:22:02 INFO - 'buildbot_json_path': 'buildprops.json', 03:22:02 INFO - 'config_files': ('talos/linux_config.py',), 03:22:02 INFO - 'default_actions': ('clobber', 03:22:02 INFO - 'read-buildbot-config', 03:22:02 INFO - 'download-and-extract', 03:22:02 INFO - 'populate-webroot', 03:22:02 INFO - 'create-virtualenv', 03:22:02 INFO - 'install', 03:22:02 INFO - 'run-tests'), 03:22:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:22:02 INFO - 'download_minidump_stackwalk': True, 03:22:02 INFO - 'download_symbols': 'ondemand', 03:22:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:22:02 INFO - 'tooltool.py': '/tools/tooltool.py', 03:22:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:22:02 INFO - '/tools/misc-python/virtualenv.py')}, 03:22:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:22:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:22:02 INFO - 'installer_path': 'installer.exe', 03:22:02 INFO - 'log_level': 'info', 03:22:02 INFO - 'log_name': 'talos', 03:22:02 INFO - 'log_to_console': True, 03:22:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:22:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:22:02 INFO - 'opt_config_files': (), 03:22:02 INFO - 'pip_index': False, 03:22:02 INFO - 'sps_profile': False, 03:22:02 INFO - 'sps_profile_interval': 0, 03:22:02 INFO - 'suite': 'dromaeojs-e10s', 03:22:02 INFO - 'system_bits': '32', 03:22:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:22:02 INFO - 'title': 'talos-linux64-ix-020', 03:22:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:22:02 INFO - 'use_talos_json': True, 03:22:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:22:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:22:02 INFO - 'work_dir': 'build'} 03:22:02 INFO - [mozharness: 2016-08-04 10:22:02.927358Z] Running clobber step. 03:22:02 INFO - Running pre-action listener: _resource_record_pre_action 03:22:02 INFO - Running main action method: clobber 03:22:02 INFO - rmtree: /builds/slave/test/build 03:22:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:22:03 INFO - Running post-action listener: _resource_record_post_action 03:22:03 INFO - [mozharness: 2016-08-04 10:22:03.902944Z] Finished clobber step (success) 03:22:03 INFO - [mozharness: 2016-08-04 10:22:03.903048Z] Running read-buildbot-config step. 03:22:03 INFO - Running pre-action listener: _resource_record_pre_action 03:22:03 INFO - Running main action method: read_buildbot_config 03:22:03 INFO - Using buildbot properties: 03:22:03 INFO - { 03:22:03 INFO - "project": "", 03:22:03 INFO - "product": "firefox", 03:22:03 INFO - "script_repo_revision": "production", 03:22:03 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 03:22:03 INFO - "repository": "", 03:22:03 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs-e10s", 03:22:03 INFO - "buildid": "20160804003002", 03:22:03 INFO - "pgo_build": "True", 03:22:03 INFO - "basedir": "/builds/slave/test", 03:22:03 INFO - "buildnumber": 83, 03:22:03 INFO - "slavename": "talos-linux64-ix-020", 03:22:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:22:03 INFO - "platform": "ubuntu64_hw", 03:22:03 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 03:22:03 INFO - "branch": "autoland", 03:22:03 INFO - "repo_path": "integration/autoland", 03:22:03 INFO - "revision": "62a983c56050b3ac647d8f95d9c2ca69c3ad2d91", 03:22:03 INFO - "stage_platform": "linux64-pgo", 03:22:03 INFO - "builduid": "bd249a9a74f647be98bc4c7c7276a9be", 03:22:03 INFO - "slavebuilddir": "test" 03:22:03 INFO - } 03:22:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/OijUhQ4CSPe7nhJNWYhNuw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 03:22:03 INFO - Running post-action listener: _resource_record_post_action 03:22:03 INFO - [mozharness: 2016-08-04 10:22:03.905498Z] Finished read-buildbot-config step (success) 03:22:03 INFO - [mozharness: 2016-08-04 10:22:03.905588Z] Running download-and-extract step. 03:22:03 INFO - Running pre-action listener: _resource_record_pre_action 03:22:03 INFO - Running main action method: download_and_extract 03:22:03 INFO - mkdir: /builds/slave/test/build/tests 03:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:03 INFO - https://queue.taskcluster.net/v1/task/OijUhQ4CSPe7nhJNWYhNuw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:22:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OijUhQ4CSPe7nhJNWYhNuw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 03:22:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OijUhQ4CSPe7nhJNWYhNuw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 03:22:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OijUhQ4CSPe7nhJNWYhNuw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 03:22:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OijUhQ4CSPe7nhJNWYhNuw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:22:06 INFO - Downloaded 1361 bytes. 03:22:06 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 03:22:06 INFO - Using the following test package requirements: 03:22:06 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 03:22:06 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:22:06 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:22:06 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:22:06 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:22:06 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:22:06 INFO - u'jsshell-linux-x86_64.zip'], 03:22:06 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:22:06 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:22:06 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 03:22:06 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:22:06 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:22:06 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:22:06 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:22:06 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:22:06 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:22:06 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:22:06 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:22:06 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:22:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:06 INFO - https://queue.taskcluster.net/v1/task/OijUhQ4CSPe7nhJNWYhNuw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:22:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OijUhQ4CSPe7nhJNWYhNuw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 03:22:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OijUhQ4CSPe7nhJNWYhNuw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 03:22:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OijUhQ4CSPe7nhJNWYhNuw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 03:22:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OijUhQ4CSPe7nhJNWYhNuw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:22:11 INFO - Downloaded 21812345 bytes. 03:22:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:22:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:22:12 INFO - Return code: 0 03:22:12 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:22:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:12 INFO - https://queue.taskcluster.net/v1/task/OijUhQ4CSPe7nhJNWYhNuw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:22:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OijUhQ4CSPe7nhJNWYhNuw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 03:22:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OijUhQ4CSPe7nhJNWYhNuw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 03:22:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OijUhQ4CSPe7nhJNWYhNuw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 03:22:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OijUhQ4CSPe7nhJNWYhNuw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:22:14 INFO - Downloaded 21812345 bytes. 03:22:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:22:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:22:15 INFO - Return code: 0 03:22:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:15 INFO - https://queue.taskcluster.net/v1/task/OijUhQ4CSPe7nhJNWYhNuw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:22:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OijUhQ4CSPe7nhJNWYhNuw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 03:22:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OijUhQ4CSPe7nhJNWYhNuw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 03:22:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OijUhQ4CSPe7nhJNWYhNuw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 03:22:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OijUhQ4CSPe7nhJNWYhNuw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:22:16 INFO - Downloaded 14413723 bytes. 03:22:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:22:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:22:17 INFO - Return code: 0 03:22: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')]} 03:22:17 INFO - https://queue.taskcluster.net/v1/task/OijUhQ4CSPe7nhJNWYhNuw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:22:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OijUhQ4CSPe7nhJNWYhNuw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 03:22:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OijUhQ4CSPe7nhJNWYhNuw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 03:22:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OijUhQ4CSPe7nhJNWYhNuw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 03:22:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OijUhQ4CSPe7nhJNWYhNuw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:22:19 INFO - Downloaded 59330700 bytes. 03:22:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OijUhQ4CSPe7nhJNWYhNuw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 03:22:19 INFO - mkdir: /builds/slave/test/properties 03:22:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:22:19 INFO - Writing to file /builds/slave/test/properties/build_url 03:22:19 INFO - Contents: 03:22:19 INFO - build_url:https://queue.taskcluster.net/v1/task/OijUhQ4CSPe7nhJNWYhNuw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 03:22:20 INFO - Running post-action listener: _resource_record_post_action 03:22:20 INFO - Running post-action listener: set_extra_try_arguments 03:22:20 INFO - [mozharness: 2016-08-04 10:22:20.551624Z] Finished download-and-extract step (success) 03:22:20 INFO - [mozharness: 2016-08-04 10:22:20.551858Z] Running populate-webroot step. 03:22:20 INFO - Running pre-action listener: _resource_record_pre_action 03:22:20 INFO - Running main action method: populate_webroot 03:22:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:22:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:22:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:22:20 INFO - '--tppagecycles', 03:22:20 INFO - '7'], 03:22:20 INFO - 'tests': ['tsvgm']}}, 03:22:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:22:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:22:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:22:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:22:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:22:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:22:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:20 INFO - 'talos_options': ['--disable-e10s'], 03:22:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:22:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:22:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:20 INFO - 'talos_options': ['--disable-e10s'], 03:22:20 INFO - 'tests': ['damp', 'tps']}, 03:22:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:20 INFO - 'tests': ['damp', 'tps']}, 03:22:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:22:20 INFO - 'tests': ['dromaeo_dom']}, 03:22:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:22:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:22:20 INFO - 'tests': ['basic_compositor_video']}, 03:22:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:22:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:22:20 INFO - 'tests': ['a11yr', 03:22:20 INFO - 'ts_paint', 03:22:20 INFO - 'tpaint', 03:22:20 INFO - 'sessionrestore', 03:22:20 INFO - 'sessionrestore_no_auto_restore', 03:22:20 INFO - 'tabpaint']}, 03:22:20 INFO - 'other-e10s': {'tests': ['a11yr', 03:22:20 INFO - 'ts_paint', 03:22:20 INFO - 'tpaint', 03:22:20 INFO - 'sessionrestore', 03:22:20 INFO - 'sessionrestore_no_auto_restore', 03:22:20 INFO - 'tabpaint']}, 03:22:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:22:20 INFO - 'ts_paint', 03:22:20 INFO - 'tpaint', 03:22:20 INFO - 'sessionrestore', 03:22:20 INFO - 'sessionrestore_no_auto_restore', 03:22:20 INFO - 'tabpaint']}, 03:22:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:22:20 INFO - 'ts_paint', 03:22:20 INFO - 'tpaint', 03:22:20 INFO - 'sessionrestore', 03:22:20 INFO - 'sessionrestore_no_auto_restore', 03:22:20 INFO - 'tabpaint']}, 03:22:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:22:20 INFO - 'tests': ['a11yr', 03:22:20 INFO - 'ts_paint', 03:22:20 INFO - 'tpaint', 03:22:20 INFO - 'sessionrestore', 03:22:20 INFO - 'sessionrestore_no_auto_restore', 03:22:20 INFO - 'tabpaint']}, 03:22:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:22:20 INFO - 'tests': ['a11yr', 03:22:20 INFO - 'ts_paint', 03:22:20 INFO - 'tpaint', 03:22:20 INFO - 'sessionrestore', 03:22:20 INFO - 'sessionrestore_no_auto_restore', 03:22:20 INFO - 'tabpaint']}, 03:22:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:22:20 INFO - 'tests': ['tsvgx', 03:22:20 INFO - 'tsvgr_opacity', 03:22:20 INFO - 'tart', 03:22:20 INFO - 'tscrollx', 03:22:20 INFO - 'cart']}, 03:22:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:22:20 INFO - 'tsvgr_opacity', 03:22:20 INFO - 'tart', 03:22:20 INFO - 'tscrollx', 03:22:20 INFO - 'cart']}, 03:22:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:20 INFO - 'talos_options': ['--disable-e10s'], 03:22:20 INFO - 'tests': ['tp5o']}, 03:22:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:20 INFO - 'tests': ['tp5o']}, 03:22:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:20 INFO - 'talos_options': ['--disable-e10s', 03:22:20 INFO - '--xperf_path', 03:22:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:22:20 INFO - 'tests': ['tp5n']}, 03:22:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:20 INFO - 'talos_options': ['--xperf_path', 03:22:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:22:20 INFO - 'tests': ['tp5n']}}, 03:22:20 INFO - 'talos.zip': {'path': '', 03:22:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:22:20 INFO - Running post-action listener: _resource_record_post_action 03:22:20 INFO - [mozharness: 2016-08-04 10:22:20.573742Z] Finished populate-webroot step (success) 03:22:20 INFO - [mozharness: 2016-08-04 10:22:20.573833Z] Running create-virtualenv step. 03:22:20 INFO - Running pre-action listener: _resource_record_pre_action 03:22:20 INFO - Running main action method: create_virtualenv 03:22:20 INFO - Creating virtualenv /builds/slave/test/build/venv 03:22: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 03:22:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:22:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:22:20 INFO - Using real prefix '/usr' 03:22:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:22:21 INFO - Installing distribute.............................................................................................................................................................................................done. 03:22:23 INFO - Installing pip.................done. 03:22:23 INFO - Return code: 0 03:22:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:22:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22: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 0x1ce4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa33b0>, '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 0x1fa42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa4740>, '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': 'af724c981e2a0f424dbabf99000001e7-1470304095.281387-939844424', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:22: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 03:22: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 03:22:23 INFO - Using env: {'DISPLAY': ':0', 03:22:23 INFO - 'HOME': '/home/cltbld', 03:22:23 INFO - 'LANG': 'en_US.UTF-8', 03:22:23 INFO - 'LANGUAGE': 'en_US:en', 03:22:23 INFO - 'LOGNAME': 'cltbld', 03:22:23 INFO - 'MAIL': '/var/mail/cltbld', 03:22:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:23 INFO - 'MOZ_NO_REMOTE': '1', 03:22:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:23 INFO - 'NO_EM_RESTART': '1', 03:22:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:23 INFO - 'PWD': '/builds/slave/test', 03:22:23 INFO - 'SHELL': '/bin/bash', 03:22:23 INFO - 'SHLVL': '1', 03:22:23 INFO - 'TERM': 'linux', 03:22:23 INFO - 'TMOUT': '86400', 03:22:23 INFO - 'USER': 'cltbld', 03:22:23 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470304095.281387-939844424', 03:22:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:23 INFO - '_': '/tools/buildbot/bin/python'} 03:22:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22: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 03:22:23 INFO - Cleaning up... 03:22:23 INFO - Return code: 0 03:22:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:22:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22: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 0x1ce4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa33b0>, '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 0x1fa42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa4740>, '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': 'af724c981e2a0f424dbabf99000001e7-1470304095.281387-939844424', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:22: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 03:22: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 03:22:23 INFO - Using env: {'DISPLAY': ':0', 03:22:23 INFO - 'HOME': '/home/cltbld', 03:22:23 INFO - 'LANG': 'en_US.UTF-8', 03:22:23 INFO - 'LANGUAGE': 'en_US:en', 03:22:23 INFO - 'LOGNAME': 'cltbld', 03:22:23 INFO - 'MAIL': '/var/mail/cltbld', 03:22:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:23 INFO - 'MOZ_NO_REMOTE': '1', 03:22:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:23 INFO - 'NO_EM_RESTART': '1', 03:22:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:23 INFO - 'PWD': '/builds/slave/test', 03:22:23 INFO - 'SHELL': '/bin/bash', 03:22:23 INFO - 'SHLVL': '1', 03:22:23 INFO - 'TERM': 'linux', 03:22:23 INFO - 'TMOUT': '86400', 03:22:23 INFO - 'USER': 'cltbld', 03:22:23 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470304095.281387-939844424', 03:22:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:23 INFO - '_': '/tools/buildbot/bin/python'} 03:22:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:23 INFO - Downloading/unpacking psutil>=3.1.1 03:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:22:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:22:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:22:25 INFO - Installing collected packages: psutil 03:22:25 INFO - Running setup.py install for psutil 03:22:25 INFO - building 'psutil._psutil_linux' extension 03:22: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 03:22: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 03:22:25 INFO - building 'psutil._psutil_posix' extension 03:22: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 03:22: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_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:22:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:22:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:22:26 INFO - Successfully installed psutil 03:22:26 INFO - Cleaning up... 03:22:26 INFO - Return code: 0 03:22:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:22: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')]} 03:22:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22: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')]} 03:22:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22: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 0x1ce4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa33b0>, '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 0x1fa42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa4740>, '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': 'af724c981e2a0f424dbabf99000001e7-1470304095.281387-939844424', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:22: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 03:22: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 03:22:26 INFO - Using env: {'DISPLAY': ':0', 03:22:26 INFO - 'HOME': '/home/cltbld', 03:22:26 INFO - 'LANG': 'en_US.UTF-8', 03:22:26 INFO - 'LANGUAGE': 'en_US:en', 03:22:26 INFO - 'LOGNAME': 'cltbld', 03:22:26 INFO - 'MAIL': '/var/mail/cltbld', 03:22:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:26 INFO - 'MOZ_NO_REMOTE': '1', 03:22:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:26 INFO - 'NO_EM_RESTART': '1', 03:22:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:26 INFO - 'PWD': '/builds/slave/test', 03:22:26 INFO - 'SHELL': '/bin/bash', 03:22:26 INFO - 'SHLVL': '1', 03:22:26 INFO - 'TERM': 'linux', 03:22:26 INFO - 'TMOUT': '86400', 03:22:26 INFO - 'USER': 'cltbld', 03:22:26 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470304095.281387-939844424', 03:22:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:26 INFO - '_': '/tools/buildbot/bin/python'} 03:22:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:22:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:22:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:22:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:22:28 INFO - Installing collected packages: mozsystemmonitor 03:22:28 INFO - Running setup.py install for mozsystemmonitor 03:22:28 INFO - Successfully installed mozsystemmonitor 03:22:28 INFO - Cleaning up... 03:22:28 INFO - Return code: 0 03:22:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:22: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')]} 03:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22: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')]} 03:22:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22: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 0x1ce4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa33b0>, '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 0x1fa42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa4740>, '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': 'af724c981e2a0f424dbabf99000001e7-1470304095.281387-939844424', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:22: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 03:22: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 03:22:28 INFO - Using env: {'DISPLAY': ':0', 03:22:28 INFO - 'HOME': '/home/cltbld', 03:22:28 INFO - 'LANG': 'en_US.UTF-8', 03:22:28 INFO - 'LANGUAGE': 'en_US:en', 03:22:28 INFO - 'LOGNAME': 'cltbld', 03:22:28 INFO - 'MAIL': '/var/mail/cltbld', 03:22:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:28 INFO - 'MOZ_NO_REMOTE': '1', 03:22:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:28 INFO - 'NO_EM_RESTART': '1', 03:22:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:28 INFO - 'PWD': '/builds/slave/test', 03:22:28 INFO - 'SHELL': '/bin/bash', 03:22:28 INFO - 'SHLVL': '1', 03:22:28 INFO - 'TERM': 'linux', 03:22:28 INFO - 'TMOUT': '86400', 03:22:28 INFO - 'USER': 'cltbld', 03:22:28 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470304095.281387-939844424', 03:22:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:28 INFO - '_': '/tools/buildbot/bin/python'} 03:22:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:28 INFO - Downloading/unpacking jsonschema==2.5.1 03:22: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 03:22: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 03:22: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 03:22: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 03:22: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 03:22: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 03:22:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:22:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:22: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 03:22: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 03:22: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 03:22: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 03:22: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 03:22: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 03:22:30 INFO - Downloading functools32-3.2.3-2.tar.gz 03:22:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:22:30 INFO - warning: no files found matching '*.txt' 03:22:30 INFO - no previously-included directories found matching 'build' 03:22:30 INFO - no previously-included directories found matching 'dist' 03:22:30 INFO - no previously-included directories found matching '.git*' 03:22:30 INFO - Installing collected packages: jsonschema, functools32 03:22:30 INFO - Running setup.py install for functools32 03:22:30 INFO - warning: no files found matching '*.txt' 03:22:30 INFO - no previously-included directories found matching 'build' 03:22:30 INFO - no previously-included directories found matching 'dist' 03:22:30 INFO - no previously-included directories found matching '.git*' 03:22:30 INFO - Successfully installed jsonschema functools32 03:22:30 INFO - Cleaning up... 03:22:30 INFO - Return code: 0 03:22:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:22:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:30 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 0x1ce4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa33b0>, '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 0x1fa42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa4740>, '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': 'af724c981e2a0f424dbabf99000001e7-1470304095.281387-939844424', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:22:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:22:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:22:30 INFO - Using env: {'DISPLAY': ':0', 03:22:30 INFO - 'HOME': '/home/cltbld', 03:22:30 INFO - 'LANG': 'en_US.UTF-8', 03:22:30 INFO - 'LANGUAGE': 'en_US:en', 03:22:30 INFO - 'LOGNAME': 'cltbld', 03:22:30 INFO - 'MAIL': '/var/mail/cltbld', 03:22:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:30 INFO - 'MOZ_NO_REMOTE': '1', 03:22:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:30 INFO - 'NO_EM_RESTART': '1', 03:22:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:30 INFO - 'PWD': '/builds/slave/test', 03:22:30 INFO - 'SHELL': '/bin/bash', 03:22:30 INFO - 'SHLVL': '1', 03:22:30 INFO - 'TERM': 'linux', 03:22:30 INFO - 'TMOUT': '86400', 03:22:30 INFO - 'USER': 'cltbld', 03:22:30 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470304095.281387-939844424', 03:22:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:30 INFO - '_': '/tools/buildbot/bin/python'} 03:22:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:22:31 INFO - Cleaning up... 03:22:31 INFO - Return code: 0 03:22:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:22:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22: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 0x1ce4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa33b0>, '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 0x1fa42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa4740>, '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': 'af724c981e2a0f424dbabf99000001e7-1470304095.281387-939844424', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:22: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 03:22: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 03:22:31 INFO - Using env: {'DISPLAY': ':0', 03:22:31 INFO - 'HOME': '/home/cltbld', 03:22:31 INFO - 'LANG': 'en_US.UTF-8', 03:22:31 INFO - 'LANGUAGE': 'en_US:en', 03:22:31 INFO - 'LOGNAME': 'cltbld', 03:22:31 INFO - 'MAIL': '/var/mail/cltbld', 03:22:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:31 INFO - 'MOZ_NO_REMOTE': '1', 03:22:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:31 INFO - 'NO_EM_RESTART': '1', 03:22:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:31 INFO - 'PWD': '/builds/slave/test', 03:22:31 INFO - 'SHELL': '/bin/bash', 03:22:31 INFO - 'SHLVL': '1', 03:22:31 INFO - 'TERM': 'linux', 03:22:31 INFO - 'TMOUT': '86400', 03:22:31 INFO - 'USER': 'cltbld', 03:22:31 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470304095.281387-939844424', 03:22:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:31 INFO - '_': '/tools/buildbot/bin/python'} 03:22:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:31 INFO - Downloading/unpacking blobuploader==1.2.4 03:22: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 03:22: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 03:22: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 03:22: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 03:22: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 03:22: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 03:22:33 INFO - Downloading blobuploader-1.2.4.tar.gz 03:22:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:22:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:22: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 03:22: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 03:22: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 03:22: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 03:22: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 03:22: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 03:22:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:22:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:22: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 03:22: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 03:22: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 03:22: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 03:22: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 03:22: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 03:22:33 INFO - Downloading docopt-0.6.1.tar.gz 03:22:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:22:34 INFO - Installing collected packages: blobuploader, requests, docopt 03:22:34 INFO - Running setup.py install for blobuploader 03:22:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:22:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:22:34 INFO - Running setup.py install for requests 03:22:34 INFO - Running setup.py install for docopt 03:22:34 INFO - Successfully installed blobuploader requests docopt 03:22:34 INFO - Cleaning up... 03:22:34 INFO - Return code: 0 03:22:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22: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 0x1ce4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa33b0>, '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 0x1fa42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa4740>, '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': 'af724c981e2a0f424dbabf99000001e7-1470304095.281387-939844424', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:22: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 03:22: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 03:22:34 INFO - Using env: {'DISPLAY': ':0', 03:22:34 INFO - 'HOME': '/home/cltbld', 03:22:34 INFO - 'LANG': 'en_US.UTF-8', 03:22:34 INFO - 'LANGUAGE': 'en_US:en', 03:22:34 INFO - 'LOGNAME': 'cltbld', 03:22:34 INFO - 'MAIL': '/var/mail/cltbld', 03:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:34 INFO - 'MOZ_NO_REMOTE': '1', 03:22:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:34 INFO - 'NO_EM_RESTART': '1', 03:22:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:34 INFO - 'PWD': '/builds/slave/test', 03:22:34 INFO - 'SHELL': '/bin/bash', 03:22:34 INFO - 'SHLVL': '1', 03:22:34 INFO - 'TERM': 'linux', 03:22:34 INFO - 'TMOUT': '86400', 03:22:34 INFO - 'USER': 'cltbld', 03:22:34 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470304095.281387-939844424', 03:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:34 INFO - '_': '/tools/buildbot/bin/python'} 03:22:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:22:34 INFO - Running setup.py (path:/tmp/pip-BLxKa3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:22:34 INFO - Running setup.py (path:/tmp/pip-EbkMBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:22:35 INFO - Running setup.py (path:/tmp/pip-3Tk0s6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:22:35 INFO - Running setup.py (path:/tmp/pip-FLUGod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:22:35 INFO - Running setup.py (path:/tmp/pip-oPIM5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:22:35 INFO - Running setup.py (path:/tmp/pip-2P3MDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:22:35 INFO - Running setup.py (path:/tmp/pip-pxHJQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:22:35 INFO - Running setup.py (path:/tmp/pip-RoWwvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:22:35 INFO - Running setup.py (path:/tmp/pip-N8gnJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:22:35 INFO - Running setup.py (path:/tmp/pip-RFdfpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:22:35 INFO - Running setup.py (path:/tmp/pip-bJB5UW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:22:35 INFO - Running setup.py (path:/tmp/pip-sWR4Y9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:22:35 INFO - Running setup.py (path:/tmp/pip-HHu3Aw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:22:35 INFO - Running setup.py (path:/tmp/pip-z75lc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:22:35 INFO - Running setup.py (path:/tmp/pip-U8Ge9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:22:35 INFO - Running setup.py (path:/tmp/pip-RZGM3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:22:36 INFO - Running setup.py (path:/tmp/pip-fP0Sqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:22:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:22:36 INFO - Running setup.py install for manifestparser 03:22:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:22:36 INFO - Running setup.py install for mozcrash 03:22:36 INFO - Running setup.py install for mozdebug 03:22:36 INFO - Running setup.py install for mozdevice 03:22:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:22:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:22:36 INFO - Running setup.py install for mozfile 03:22:36 INFO - Running setup.py install for mozhttpd 03:22:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:22:36 INFO - Running setup.py install for mozinfo 03:22:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:22:36 INFO - Running setup.py install for mozInstall 03:22:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:22:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:22:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:22:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:22:36 INFO - Running setup.py install for mozleak 03:22:36 INFO - Running setup.py install for mozlog 03:22:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:22:37 INFO - Running setup.py install for moznetwork 03:22:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:22:37 INFO - Running setup.py install for mozprocess 03:22:37 INFO - Running setup.py install for mozprofile 03:22:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:22:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:22:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:22:37 INFO - Running setup.py install for mozrunner 03:22:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:22:37 INFO - Running setup.py install for mozscreenshot 03:22:37 INFO - Running setup.py install for moztest 03:22:37 INFO - Running setup.py install for mozversion 03:22:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:22:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:22:37 INFO - Cleaning up... 03:22:37 INFO - Return code: 0 03:22:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:22:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:37 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 0x1ce4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa33b0>, '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 0x1fa42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa4740>, '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': 'af724c981e2a0f424dbabf99000001e7-1470304095.281387-939844424', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:22:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:22:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:22:37 INFO - Using env: {'DISPLAY': ':0', 03:22:37 INFO - 'HOME': '/home/cltbld', 03:22:37 INFO - 'LANG': 'en_US.UTF-8', 03:22:37 INFO - 'LANGUAGE': 'en_US:en', 03:22:37 INFO - 'LOGNAME': 'cltbld', 03:22:37 INFO - 'MAIL': '/var/mail/cltbld', 03:22:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:37 INFO - 'MOZ_NO_REMOTE': '1', 03:22:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:37 INFO - 'NO_EM_RESTART': '1', 03:22:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:37 INFO - 'PWD': '/builds/slave/test', 03:22:37 INFO - 'SHELL': '/bin/bash', 03:22:37 INFO - 'SHLVL': '1', 03:22:37 INFO - 'TERM': 'linux', 03:22:37 INFO - 'TMOUT': '86400', 03:22:37 INFO - 'USER': 'cltbld', 03:22:37 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470304095.281387-939844424', 03:22:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:37 INFO - '_': '/tools/buildbot/bin/python'} 03:22:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:22:38 INFO - Running setup.py (path:/tmp/pip-arSN0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:22: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)) 03:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:22:38 INFO - Running setup.py (path:/tmp/pip-MfDlzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:22: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)) 03:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:22:38 INFO - Running setup.py (path:/tmp/pip-_gcKUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:22: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)) 03:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:22:38 INFO - Running setup.py (path:/tmp/pip-x0z1k7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:22: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)) 03:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:22:38 INFO - Running setup.py (path:/tmp/pip-gAw1EV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:22: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)) 03:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:22:38 INFO - Running setup.py (path:/tmp/pip-kQyqsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:22: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)) 03:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:22:38 INFO - Running setup.py (path:/tmp/pip-6ZxTgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:22: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)) 03:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:22:38 INFO - Running setup.py (path:/tmp/pip-bWNh9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:22: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)) 03:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:22:38 INFO - Running setup.py (path:/tmp/pip-bEInnP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:22: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)) 03:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:22:38 INFO - Running setup.py (path:/tmp/pip-9x2Cjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:22: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)) 03:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:22:38 INFO - Running setup.py (path:/tmp/pip-lGyYsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:22:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:22:38 INFO - Running setup.py (path:/tmp/pip-9_39Zt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:22:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:22:38 INFO - Running setup.py (path:/tmp/pip-4pQXhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:22: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)) 03:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:22:39 INFO - Running setup.py (path:/tmp/pip-HUmpTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:22: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)) 03:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:22:39 INFO - Running setup.py (path:/tmp/pip-GnpxkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:22: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)) 03:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:22:39 INFO - Running setup.py (path:/tmp/pip-OCLZt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:22: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)) 03:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:22:39 INFO - Running setup.py (path:/tmp/pip-aw5ryf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:22: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)) 03:22: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)) 03:22: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)) 03:22: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)) 03:22: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)) 03:22: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)) 03:22:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:22: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 03:22: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 03:22: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 03:22: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 03:22: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 03:22: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 03:22:41 INFO - Downloading blessings-1.6.tar.gz 03:22:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:22:41 INFO - Installing collected packages: blessings 03:22:41 INFO - Running setup.py install for blessings 03:22:41 INFO - Successfully installed blessings 03:22:41 INFO - Cleaning up... 03:22:41 INFO - Return code: 0 03:22:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:22:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:22:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:22:41 INFO - Reading from file tmpfile_stdout 03:22:41 INFO - Current package versions: 03:22:41 INFO - argparse == 1.2.1 03:22:41 INFO - blessings == 1.6 03:22:41 INFO - blobuploader == 1.2.4 03:22:41 INFO - docopt == 0.6.1 03:22:41 INFO - functools32 == 3.2.3-2 03:22:41 INFO - jsonschema == 2.5.1 03:22:41 INFO - manifestparser == 1.1 03:22:41 INFO - mozInstall == 1.12 03:22:41 INFO - mozcrash == 0.17 03:22:41 INFO - mozdebug == 0.1 03:22:41 INFO - mozdevice == 0.48 03:22:41 INFO - mozfile == 1.2 03:22:41 INFO - mozhttpd == 0.7 03:22:41 INFO - mozinfo == 0.9 03:22:41 INFO - mozleak == 0.1 03:22:41 INFO - mozlog == 3.3 03:22:41 INFO - moznetwork == 0.27 03:22:41 INFO - mozprocess == 0.23 03:22:41 INFO - mozprofile == 0.28 03:22:41 INFO - mozrunner == 6.12 03:22:41 INFO - mozscreenshot == 0.1 03:22:41 INFO - mozsystemmonitor == 0.3 03:22:41 INFO - moztest == 0.7 03:22:41 INFO - mozversion == 1.4 03:22:41 INFO - psutil == 3.1.1 03:22:41 INFO - requests == 1.2.3 03:22:41 INFO - wsgiref == 0.1.2 03:22:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:22: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')]} 03:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22: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')]} 03:22:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22: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 0x1ce4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa33b0>, '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 0x1fa42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa4740>, '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': 'af724c981e2a0f424dbabf99000001e7-1470304095.281387-939844424', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:22: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 03:22: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 03:22:41 INFO - Using env: {'DISPLAY': ':0', 03:22:41 INFO - 'HOME': '/home/cltbld', 03:22:41 INFO - 'LANG': 'en_US.UTF-8', 03:22:41 INFO - 'LANGUAGE': 'en_US:en', 03:22:41 INFO - 'LOGNAME': 'cltbld', 03:22:41 INFO - 'MAIL': '/var/mail/cltbld', 03:22:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:41 INFO - 'MOZ_NO_REMOTE': '1', 03:22:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:41 INFO - 'NO_EM_RESTART': '1', 03:22:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:41 INFO - 'PWD': '/builds/slave/test', 03:22:41 INFO - 'SHELL': '/bin/bash', 03:22:41 INFO - 'SHLVL': '1', 03:22:41 INFO - 'TERM': 'linux', 03:22:41 INFO - 'TMOUT': '86400', 03:22:41 INFO - 'USER': 'cltbld', 03:22:41 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470304095.281387-939844424', 03:22:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:41 INFO - '_': '/tools/buildbot/bin/python'} 03:22:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:22:41 INFO - Cleaning up... 03:22:41 INFO - Return code: 0 03:22:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:22: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')]} 03:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22: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')]} 03:22:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa33b0>, '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 0x1fa42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa4740>, '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': 'af724c981e2a0f424dbabf99000001e7-1470304095.281387-939844424', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:22:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:22:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:22:41 INFO - Using env: {'DISPLAY': ':0', 03:22:41 INFO - 'HOME': '/home/cltbld', 03:22:41 INFO - 'LANG': 'en_US.UTF-8', 03:22:41 INFO - 'LANGUAGE': 'en_US:en', 03:22:41 INFO - 'LOGNAME': 'cltbld', 03:22:41 INFO - 'MAIL': '/var/mail/cltbld', 03:22:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:41 INFO - 'MOZ_NO_REMOTE': '1', 03:22:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:41 INFO - 'NO_EM_RESTART': '1', 03:22:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:41 INFO - 'PWD': '/builds/slave/test', 03:22:41 INFO - 'SHELL': '/bin/bash', 03:22:41 INFO - 'SHLVL': '1', 03:22:41 INFO - 'TERM': 'linux', 03:22:41 INFO - 'TMOUT': '86400', 03:22:41 INFO - 'USER': 'cltbld', 03:22:41 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470304095.281387-939844424', 03:22:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:41 INFO - '_': '/tools/buildbot/bin/python'} 03:22:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:22:42 INFO - Cleaning up... 03:22:42 INFO - Return code: 0 03:22:42 INFO - Running post-action listener: _resource_record_post_action 03:22:42 INFO - Running post-action listener: _start_resource_monitoring 03:22:42 INFO - Starting resource monitoring. 03:22:42 INFO - [mozharness: 2016-08-04 10:22:42.142824Z] Finished create-virtualenv step (success) 03:22:42 INFO - [mozharness: 2016-08-04 10:22:42.143258Z] Running install step. 03:22:42 INFO - Running pre-action listener: _resource_record_pre_action 03:22:42 INFO - Running main action method: install 03:22:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:22:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:22:42 INFO - Reading from file tmpfile_stdout 03:22:42 INFO - Detecting whether we're running mozinstall >=1.0... 03:22:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:22:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:22:42 INFO - Reading from file tmpfile_stdout 03:22:42 INFO - Output received: 03:22:42 INFO - Usage: mozinstall [options] installer 03:22:42 INFO - Options: 03:22:42 INFO - -h, --help show this help message and exit 03:22:42 INFO - -d DEST, --destination=DEST 03:22:42 INFO - Directory to install application into. [default: 03:22:42 INFO - "/builds/slave/test"] 03:22:42 INFO - --app=APP Application being installed. [default: firefox] 03:22:42 INFO - mkdir: /builds/slave/test/build/application 03:22:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:22:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:22:59 INFO - Reading from file tmpfile_stdout 03:22:59 INFO - Output received: 03:22:59 INFO - /builds/slave/test/build/application/firefox/firefox 03:22:59 INFO - Running post-action listener: _resource_record_post_action 03:22:59 INFO - [mozharness: 2016-08-04 10:22:59.324017Z] Finished install step (success) 03:22:59 INFO - [mozharness: 2016-08-04 10:22:59.324289Z] Running run-tests step. 03:22:59 INFO - Running pre-action listener: _resource_record_pre_action 03:22:59 INFO - Running main action method: run_tests 03:22:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:22:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:22:59 INFO - Python 2.7.3 03:22:59 INFO - Return code: 0 03:22:59 INFO - grabbing minidump binary from tooltool 03:22:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22: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 0x1fa33b0>, '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 0x1fa42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa4740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:22: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 03:22: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 03:22: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 03:22:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:22:59 INFO - Return code: 0 03:22:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:22:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:22:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:22:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:22:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:22: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/OijUhQ4CSPe7nhJNWYhNuw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 03:22: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/OijUhQ4CSPe7nhJNWYhNuw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 03:22:59 INFO - Using env: {'DISPLAY': ':0', 03:22:59 INFO - 'HOME': '/home/cltbld', 03:22:59 INFO - 'LANG': 'en_US.UTF-8', 03:22:59 INFO - 'LANGUAGE': 'en_US:en', 03:22:59 INFO - 'LOGNAME': 'cltbld', 03:22:59 INFO - 'MAIL': '/var/mail/cltbld', 03:22:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:22:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:22:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:59 INFO - 'MOZ_NO_REMOTE': '1', 03:22:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:22:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:59 INFO - 'NO_EM_RESTART': '1', 03:22:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:59 INFO - 'PWD': '/builds/slave/test', 03:22:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:22:59 INFO - 'SHELL': '/bin/bash', 03:22:59 INFO - 'SHLVL': '1', 03:22:59 INFO - 'TERM': 'linux', 03:22:59 INFO - 'TMOUT': '86400', 03:22:59 INFO - 'USER': 'cltbld', 03:22:59 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470304095.281387-939844424', 03:22:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:59 INFO - '_': '/tools/buildbot/bin/python'} 03:22: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/OijUhQ4CSPe7nhJNWYhNuw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 03:22:59 INFO - mozversion application_buildid: 20160804003002 03:22:59 INFO - mozversion application_changeset: 62a983c56050b3ac647d8f95d9c2ca69c3ad2d91 03:22:59 INFO - mozversion application_display_name: Nightly 03:22:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:22:59 INFO - mozversion application_name: Firefox 03:22:59 INFO - mozversion application_remotingname: firefox 03:22:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 03:22:59 INFO - mozversion application_vendor: Mozilla 03:22:59 INFO - mozversion application_version: 51.0a1 03:22:59 INFO - mozversion platform_buildid: 20160804003002 03:22:59 INFO - mozversion platform_changeset: 62a983c56050b3ac647d8f95d9c2ca69c3ad2d91 03:22:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 03:22:59 INFO - mozversion platform_version: 51.0a1 03:22:59 INFO - using testdate: 1470306179 03:22:59 INFO - actual date: 1470306179 03:22:59 INFO - starting webserver on 'localhost:48238' 03:22:59 INFO - SUITE-START | Running 2 tests 03:22:59 INFO - TEST-START | dromaeo_css 03:22:59 INFO - operating with platform_type : linux_ 03:22:59 INFO - Initialising browser for dromaeo_css test... 03:22:59 INFO - TEST-INFO | started process 25019 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfD8fmj/profile http://localhost:48238/getInfo.html) 03:23:04 INFO - PROCESS | 25019 | __metrics Screen width/height:1600/1200 03:23:04 INFO - PROCESS | 25019 | colorDepth:24 03:23:04 INFO - PROCESS | 25019 | Browser inner width/height: 1024/697 03:23:04 INFO - PROCESS | 25019 | __metrics 03:23:05 ERROR - PROCESS | 25019 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 03:23:06 INFO - TEST-INFO | 25019: exit 0 03:23:06 INFO - Browser initialized. 03:23:06 INFO - Running cycle 1/1 for dromaeo_css test... 03:23:06 INFO - TEST-INFO | started process 25139 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfD8fmj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:23:17 INFO - PROCESS | 25139 | RSS: Main: 163864576 03:23:17 INFO - PROCESS | 25139 | 03:24:07 INFO - PROCESS | 25139 | 1470306247539 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:26:16 INFO - PROCESS | 25139 | Cycle 1(1): loaded http://localhost:48238/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48238/tests/dromaeo/cssquery-ext.html) 03:26:17 INFO - PROCESS | 25139 | RSS: Main: 169037824 03:26:17 INFO - PROCESS | 25139 | 03:29:19 INFO - PROCESS | 25139 | Cycle 1(1): loaded http://localhost:48238/tests/dromaeo/cssquery-ext.html (next: http://localhost:48238/tests/dromaeo/cssquery-jquery.html) 03:29:20 INFO - PROCESS | 25139 | RSS: Main: 166625280 03:29:20 INFO - PROCESS | 25139 | 03:32:22 INFO - PROCESS | 25139 | Cycle 1(1): loaded http://localhost:48238/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48238/tests/dromaeo/cssquery-mootools.html) 03:32:22 INFO - PROCESS | 25139 | RSS: Main: 169607168 03:32:22 INFO - PROCESS | 25139 | 03:35:24 INFO - PROCESS | 25139 | Cycle 1(1): loaded http://localhost:48238/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48238/tests/dromaeo/cssquery-prototype.html) 03:35:25 INFO - PROCESS | 25139 | RSS: Main: 164134912 03:35:25 INFO - PROCESS | 25139 | 03:38:27 INFO - PROCESS | 25139 | Cycle 1(1): loaded http://localhost:48238/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48238/tests/dromaeo/cssquery-yui.html) 03:38:28 INFO - PROCESS | 25139 | RSS: Main: 166674432 03:38:28 INFO - PROCESS | 25139 | 03:41:31 INFO - PROCESS | 25139 | Cycle 1(1): loaded http://localhost:48238/tests/dromaeo/cssquery-yui.html (next: http://localhost:48238/tests/dromaeo/cssquery-dojo.html) 03:41:31 INFO - PROCESS | 25139 | RSS: Main: 169848832 03:41:31 INFO - PROCESS | 25139 | 03:41:31 INFO - PROCESS | 25139 | __start_tp_report 03:41:31 INFO - PROCESS | 25139 | _x_x_mozilla_page_load 03:41:31 INFO - PROCESS | 25139 | _x_x_mozilla_page_load_details 03:41:31 INFO - PROCESS | 25139 | |i|pagename|runs| 03:41:31 INFO - PROCESS | 25139 | |0;dojo.html;3075.6924307569243;3120.859561319743;3162.9841850790745;3167.303193297475;3167.7307428868544;5288.6562373445695;5400.378956420018;5445.210444485552;5489.752961116749;5497.175423686449;5337.919931201035;5391.595630327722;5416.214648875911;5523.199136125259;5585.162225666142;4865.732384718839;4949.381327334083;4950.851474455772;5042.520960508764;5045.571126454256;290.4559409471938;4967.254911763228;4978.5270399312;5043.067032598962;5091.363579552556;4897.559219670246;4942.975285123587;4968.7515624219;4976.576990955755;4996.575291100261;4964.751762411865;4974.701517908937;4975.825846095369;4980.327655766498;4987.725675087869;4808.2547205183255;4882.36529251195;4948.208286674115;4976.4525902150735;4998.150314446553;5414.512693857532;5457.617966742329;5510.724463776795;5525.281713377275;5531.640443371209;5856.707164641751;5861.794837180721;5876.764929402819;5882.823515294548;5885.617434866763;5684.772609095672;5723.427657234243;5727.971360143214;5893.793717219876;5901.852453688693;5387.622866399353;5399.2980912481125;5399.757010934439;5412.107002344608;5428.511433970962;5884.352721200665;5900.793472228537;5902.911456328158;5912.881742365214;5932.79235226765;5481.698506582096;5608.130739735348;5639.069553523623;5639.6334238274385;5658;5733.283339582552;5736.885262294814;5745.052066409079;5754.913676294859;5761.452661997104;5710.828675139669;5711.457411545896;5726.341470730836;5743.511801496836;5750.511206547407;5665.886682266414;5692.971535142297;5722.885542289214;5744.368119506851;5745.971270143623;4395.384646149541;4423.181711383404;4434.600885920283;4437;4450.643948484114;3911.041794760245;3919.0594257378025;3924.4898163238595;3932.1545867638024;3992.341263691458;5393.7033463159905;5403.540699040547;5446;5568.1091025435735;5575.163725441135;5686.317641883001;5702.258706368146;5724.942750572524;5759.942400576025;5762.481376676119;5446.591505637093;5470.288862447936;5474.178873169057;5475.753591088411;5486.31421072366;4936.75316234194;4941.530554597308;4952.950470495321;4972.030454061423;4977.825776097891;5931.703414829241;5938.020226662638;5959.225300710967;5968.134620480006;5988.610740301867;5705.3153621564015;5712.0860662293835;5716.5426765859465;5722;5758.8848223034465;5868.706564671835;5873.5594830388745;5912.763489460373;5994.430529099728;6002.8499287516415;5594.328680558359;5594.664320140804;5606.271184745957;5636.408177141341;5639.520640745583;5726.79956201531;5728.312602487728;5745.310562732332;5768.2501274834;5771.105478650816;5526.834194974157;5605.075162598126;5607.607467477237;5626.07169816992;5716.256886604715;5696.174054761954;5712.37163911961;5712.7714891403875;5727.083666613322;5771.105478650816;5667.744951477111;5694.772209111589;5718.342390625131;5723.227364305932;5748.080307150836;5407.270018547603;5675.57433192504;5682.6306290091015;5720.141978703062;5732;5619.353774315842;5637.915431268452;5644.9435505644415;5663.150527420755;5680.062789639664 03:41:31 INFO - PROCESS | 25139 | |1;ext.html;562.5977426140308;564.6217034586829;577.1458241802134;578.1587789765888;593.0718425663838;39649.80175099124;43909.341359879625;43977.12045759087;43978.780106099504;44076.11847763051;41523.58476415235;42928;43349;43457.78271108648;43480.347794783105;8706.303495720344;8796.8680469793;8836.734897953073;8853.380263381567;8856.380053396264;8785.692500762474;8799.516026618534;8869.95565022174;8875.28997680184;8876.289896808272;8918.643254269822;8927.95536022319;8952.641894324219;8975.371723979324;9005.954970225172;8861.822763544726;8891.710701948214;8905.332100092519;8925.464472131693;8933.240674542672;8734.956325218396;8759.124087591254;8782.780430489225;8799;8839.02770695223;41341.379879301836;41630.375544366856;41903.580964190274;41962.58037419648;42057.78971105125;3705.221903400289;3761.3605687032996;4071.1857628474127;4137.50349958007;4248.362745588187;32778.83610581956;33014.6698533014;33058.17354566131;33506.32987340264;33516.6648333516;3941.8029098545244;3967.6032396760384;4054.108096218827;4074.9185016299803;4208.263553878059;371413;372002;373358.1332093349;373524;374586;58147;58471;58716.77965084891;58803.117953230736;58914.11628825571;56973.14540281899;56990;57025.71487142538;57407.42592574021;60481;15695.921520392554;15906.76139857903;15944.681106377808;15973;16001.919990400207;12126.757464850654;12184.329861857683;12251.629152840473;12254.448549815279;12312.322822244863;16708.91645541789;17399.304027838745;17469;17501.29994800194;17735.201915913814;6541.6075035498025;6837.282085381063;6844.8973265401055;6878.209005964378;6900.827479313058;996.9651062212788;1041.234692501011;1052.2371280821496;1054.4411461925192;1065.355459946721;32297.838510807294;32334.70661173574;32408.83795581054;32773.3445331092;33143;1022.4580972084807;1038.4496217004998;1038.4548112241134;1068.6633710381204;1118.4072441605963;16832;16976.660466790596;17031.744523832152;17100;17142.228599713042;589031;594041;595572;596933;597216;59097;59243.70378148081;59423.405765942654;59438.70280648656;59499.70250148721;1323.3647849032518;1364.9317534123254;1368.4184221705934;1396.0716123777777;1399.2863639543702;30981.690183097882;33390.666093338754;34263.82868085644;34294.31411371809;34422.13944651404;50561.24158137704;50618.74690626523;51114.48885511246;51153.74423127861;51156.48843511666;420297;421101;423145;423446;424225;27658.585121222794;28676.713232867405;28739.28151796222;28804.567931480626;28845;46275.305870412645;47247;47386.28920566263;47645.76177119092;48585.5141448581;40589.59410405858;40995;41075.794621026704;41346.58653413427;42454;40960.59039409568;41381.79309103556;41560.16879662329;42729.572704272556;42890.14219715651;40509.59490405058;41440.171196576506;42884.57115428806;43576.78211608922;43975.560244397144;34696;37566.624333756314;37857.81071094627;38001.4299785509;38633.227335453696;28029.859850700617;28622.85688571627;28692.569611455427;28740.281492962844;28842.567361489175 03:41:31 INFO - PROCESS | 25139 | |2;jquery.html;374.20481476861687;380.3947342215849;385.2737589643522;401.08752587862625;404.2218728946777;18757.2497100116;20825.479363015915;20941.162353505842;20994.18902836773;21539;16038.627059934935;16239.756403653955;16463.094529800856;20321.898390508064;20584.176632934665;5488.423715509874;5719.628224165416;5755.45323194298;5899.823005309848;5932.6143800653035;3956.9802150989203;5866.88266234675;5898.085796701518;5899.823005309848;5910;5951.22634057574;6025.457708806207;6036.939630603703;6077.908831367533;6078.118672792442;5890.145928840316;6020.969895150518;6064.241969753781;6068.57519973602;6112.113743507211;5801.941980580183;5842.795502157446;5917.408259174048;5947.791827286068;5953.613015154045;13642.931785341108;14272.92863535686;14525.418983240657;14594.27028648574;14678.266086695623;2377.8811059446957;2416.226807421626;2486.751324867517;2577.87110644467;2846.6584009918733;10416.687499374955;10434.895651043544;10440.47797610124;10444.373337599769;10663.146948244123;1896.2035944903173;1937.4865660599953;1967.7146813712075;1995.7605087389607;2016.4353980885376;82065.58967205185;82747.5862620689;83288;83345.58327208325;83355.58322208411;10530.947345263225;10918;11211.66365009051;11342.489587968561;11589.420528973686;15896;15948.521544353687;15957.361705531881;15982.920085399732;15992.680146397239;7792.376609871197;7972.322352600094;7987.3610111190965;8176.877346839683;8203.630836612367;7302.452316076316;7356.448266380043;7427.554346739213;7705.42209334291;7749.147593764681;4705.7647117644665;4723.574878260973;4745.762711864393;4777.187878060738;4848.254628333797;1671.156066186568;1884.4629280654947;1917.6260629177177;1923.5864289177894;2016.4857961219795;952.3761935931838;1037.7570093457944;1086.5653738504661;1114.654457118296;1116.7152376144031;20709.792902070785;20826.166953322;20844;21016.15935362599;21119.78880211209;1002.0680766886719;1009.2077718990557;1018.6892997635792;1021.9897801022043;1029.1920842139034;9407.858882116774;11548.59579914699;11561.42192890352;11652.30086194814;11754.647360579196;473899;484718;510925;519351;520709;93517.5324123375;97241;97509;100603;100863;960.7454024683465;990.6087095597198;1045.0698877998586;1047.057648116701;1054.3726482742757;17346.91326543359;18019.369322073664;18204.908975455568;18363.35728249505;18660.066996650385;35204.119897002776;43396.999999998734;43564.56435435605;44419.77790111029;44766.77616611896;60160.09759853518;60615.69692151511;60742;61141.38858611357;61547.384526154165;8080.71717489885;8334.958130233721;8536.957315213383;8698.956125264756;8825.249853762502;12359.196652217577;13251.006174536755;13728.45086196541;13827.585172444842;14013.649658758204;11184.608538701106;11472;11860.94069529647;12027.218230815319;12348.135630506138;11815.113866460222;11848.407579621156;11872.46573904159;12054.337011464453;12166.878331216574;12181.39093045362;12260.141790074966;12321.322327272086;12430.316332601793;12663.366831658195;8574.528400938008;8728.563571821256;8847;9033.238518488832;9132.178103970675;10584.89415105839;11699.06407487416;11972;12166.817497737718;12551.623451296477 03:41:31 INFO - PROCESS | 25139 | |3;mootools.html;1427.5717284814557;1455.6797504549;1572.5282415275415;1739.9304027838887;1751.964960700786;8005.5997200140055;8654.91345086549;8767.912320876789;9229.5846686899;9240.353175277733;8733.30133589313;8940.374173807835;8944.195022447979;9003.954980225106;9008.774780630487;2328.7205535335784;2359;2361.3624321433203;2363.409147713072;2376.2633583589054;2326.3137374474572;2340.566995105902;2399;2405.5549723301156;2412.626042963335;2344.202970989863;2344.742078371378;2349.3774149850306;2374.3470545599926;2395.401149712572;2314.8958296876513;2338.4504641409253;2340.1224540797202;2342.4143964009;2350.189184731265;2282.577723121228;2282.6233671444193;2294.380517260347;2297.3337732057685;2308;8717.128287171296;8758.518281494515;8776.561171941377;8782.64869405223;8804.163604457566;5222.843314700565;5253.86865328366;5282.286891269668;5291.3385826771655;5320.65415747979;3146.889858854952;3282.556854824592;3305.3719793239206;3360.7311415086733;3388.136025313554;1023.1150055202271;1045.6131231444415;1061.0980666433547;1081.7728277061826;1102.9117670586334;12592.81110783339;12624.873751262554;12727.93636031814;12737;12742.171758835646;4473.686841921034;4597.287420449836;4780.95219047812;4793.281007848851;4872.4640289568115;10668.413237272025;10708.946455267675;10711;10714.839277410845;10727.195460340507;5342.8664283392445;5378;5397.568194544427;5399.244105825188;5402.891942161214;4364.8254069837485;4814.759262036884;4871.123197824355;4891.119598472238;4920.8769780755765;4045.5347635021762;4090.5003766798477;4099.795010249535;4117.855875044419;4119.608637179464;1275.1775105057372;1279.449836570265;1284.0818814547642;1285.0747461827468;1288.4524077267124;841.5287439034161;960.4189465373348;963.8987906269881;979.8873129590188;993.7217579077725;5841.678707671119;5955.880882382328;6017.308009578955;6029.366916473795;6063.029915213545;1006.1447769396101;1048.8846226915034;1085.9294145880651;1094.5074716377503;1096.3202814255212;4325.2214601371425;4443;4527.7509736964785;4569.086182763394;4666.626669866402;11104.278221915549;11219.495122719498;11289.0968722502;11308.547658093748;11324.94337528307;10585.311954722918;11190.888091118984;11235.775284494428;11254.662360129209;11266.605668801716;8106.108328083906;8440.11378805229;8467.788305292417;8472.364572657076;8494.32045436376;6275.717592708248;6296.622202667854;6372.6495042773095;6414.5189110815945;6596.175478065242;10305.793884122426;10322.535485903303;10328.948355258175;10385.948070259601;10418.68743937683;10327.638532651321;10369.948150259503;10419.479026048515;10503.212259080447;10675.839862402225;7366.116066072105;7739.729109481141;7946.642401091849;7947.324477419253;8212.30195433371;8861.069587693457;8888.60001299956;8947.821043579223;8956.373053886166;8972.37193396456;7828.882566761617;7867.685292588232;7902.802429939297;8115.634796434057;8168.959155204424;7817.960910195413;7844.17636148219;7872.1340652529325;7905.209479052049;8029.558374289237;6731.865362692621;6739.359760822714;6758.797236082925;6794.898076528757;6806.897896531457;4933.9013219736125;5122.615803814803;5158.922616160686;5255.737213139251;5477.068898287221;4683.086798074342;4964.826231082039;5164.173732202829;5268.815591454434;5522.088855338985 03:41:31 INFO - PROCESS | 25139 | |4;prototype.html;330.4679466059645;334.5600535296085;338.4821223528002;343.37505739554007;347.1979726831019;5351.357837059549;5418.214358917964;5490.917636235455;5594;5598.020346439372;5425.538829199523;5443.618946673724;5446.945530544694;5456.945430545703;5459.590530710193;4265.8080386382535;4269.594388533084;4291.875521616788;4308.97845510772;4311.655067594585;4179.623833854967;4312.654987600984;4320.466234486759;4334.0031792687705;4346.478422589294;4202.957970420287;4258.850940217093;4262.701610887239;4270.957290427087;4291.806868690916;4229.794508565044;4254.808533615979;4296.140771845643;4315.676324275661;4322.978385108086;3749.2314075614436;3812.2947254757682;3814.866479673226;3828.3874580067054;3867.323218436762;5356.794721187702;5358.91961620576;5387.973060134714;5394.487523685244;5432.79971611498;4951.480094590052;4951.900961980777;4962.87592810179;4970.179920313144;4973.35346404965;5491.7254137292975;5672.829815105553;5684.886302273972;5722.599418040739;5729.427057294279;4103.384492326145;4114.691398145121;4125.793710314502;4151.418801367811;4161.583841615845;5908.556858235606;6005.789797357115;6030.185924900126;6038.426349496791;6058.1518587397795;3940.763554186758;4142.46148000764;4248.787560621957;4264.488261408651;4267.0825772459075;4220.472440944882;4233.97883010583;4235.745855248695;4242.278812601865;4261.936070958938;4877.195262781673;4886.780094895738;4892.046051020088;4895;4928.457869634337;5592.328920529562;5758.309002919593;5793.304803423616;5823.097419899922;5830.271216097988;1411.964700882486;1470.5514817980618;1472.5214305350803;1474.5502621700484;1479.1051413894438;914.5015966298383;934.2059249637889;941.0354386753633;942.3168203052732;956.1346980982222;4860.270959356125;4878.975605122023;4881.87638377307;4891.584215341736;4908.852734417973;5119.387392971202;5149.944261426399;5168.9741551292755;5184.792608295701;5216.295800066942;4695.600873925686;4858.46556878743;4886.584640305543;4943.9258411123865;4962.8759281018265;2760.268528839859;2764.226016715323;2765.612814206013;2766.7786577073784;2776.208780497589;5296.788128474895;5326.92009619856;5345.572354211654;5386.380566234855;5426.864328391822;4919.311296418504;5166.5866730661455;5180.6891586504935;5209.947900521022;5239.318888544541;5269.525742683177;5329.573634109262;5333.759980800874;5344.679319240858;5372.946270537323;5158.45836187195;5171.629518177761;5180.7409629517615;5198.766055527435;5210.505002024802;4742.411292217146;5028.798848046037;5050.368703912011;5068.670536415121;5118.053160165381;5274.182501712241;5297.841064768063;5343.732813359239;5356.491133342326;5357.276767636319;3851.4030325299623;3853.5183102112237;3861.0540417596744;3873.477080594084;3874.651281384576;4929.404482348574;5167.483251674953;5194.4805519447755;5278.4193738687945;5766.2503874497725;5704.914426283526;5753.654780713171;5754.482096611325;5793.188953546422;5794.6970226970225;5744.425557444222;5751.4536119068625;5769.68266745333;5789.421057894177;5799.9130013049;5632.464915832989;5672.801451949162;5734.397888221677;5760.279965004374;5788.27646544182;5757.984705353093;5788.884222315614;5835.790315326638;5837.737301821343;5878.3239927408895;5500.037493438552;5668.744906479301;5681.147827825859;5684.261046063985;5698.886022279614 03:41:31 INFO - PROCESS | 25139 | |5;yui.html;740.0859937976595;749.8912657664639;773.9187385324541;793.8332950080483;871.2202578692073;15667.216639168038;16662.416815411463;16672.083035433046;16841;16928.238229279683;15236.23818809058;15381.769273460906;15392.384304627802;15398.153101579408;15431.228438578082;649.5940037476577;763.4693887748017;768.6041688530412;772.2239149654589;781.9726309579166;777.5762209595756;778.5367706214793;779.76996785948;780.4887798491968;785.83104632504;829.5603330234954;830.4975489828657;835.064727505195;835.4653022065883;836.113719457374;818.7380038387719;820.7578764264556;828.4863384701464;832.196929962586;833.8165603567205;606.8573885136989;607.5898768331359;611.4222060153157;611.8929187392189;611.9694015299261;15261.084334939827;15316.463923762727;15329.923350383287;15342.156181410019;15349.386024559004;15693.686126277526;15918.522444326689;15956.680866382723;16059.197040148063;16105.194740263058;12908.806367904488;12949.741005179843;13063.216207027514;13066.477340906353;13232;3937.8424863005444;3951.7036222283155;3962.5244970603426;3974.4435778990965;4074.898127546835;80303.27987501463;80386;80404.19595804026;81523;84790.57604711936;10919.071878890225;11787.492531368287;11862.940685296691;12031.398430078461;12119.575814846437;20332.898335508522;20673;20691.689624655643;20795.792042079687;20956.89521552413;7811.687532498637;7818.648160832776;7937.126916039231;8181.059178194584;8215.507069575844;4803.375561177025;4907.362042934467;4929.704217746947;4946.159152944008;4948.727819969864;3513.9648603514147;3607.4769158471877;3621.239539696693;3624.637536246407;3624.8550057997386;591.6124938165423;596.3440215762627;603.801454113593;607.8936186167491;609.1563184988734;647.4011539326199;686.3411125319749;686.5160062156168;690.5373399822131;715.8210447388153;9317.44095354281;9834.311598188058;9961.452120133317;10031.39811611291;10144.847827282596;648.740503798475;664.5613894829389;671.992011982027;682.6313790553046;711.2141084101993;4738.780561754742;4841.878953026132;4853.102176097434;4856.271559266068;4887.877803054881;85147;110509;112705;123858;124515;106947.46526267318;107858.46070769752;109247.45376273067;109518;112606;96096.51951740336;97047;97060.51469742747;97776;99697;9301.627934882528;9509.286803489627;9605.615775368908;9721.902780972383;9758.75603109928;53299.46700532945;53740.193897090794;53767.73116134551;54335;56542;76838;76961.61519192369;81708.59145704233;81827;83005;11610.883891161318;11714.1800073994;11819.349935753617;13154.868451315364;13252.271125088213;15020.474283400028;15190.696186076437;15322.233888305764;15608.453704120755;15953.57509646922;14677.853221467649;14742.11547307165;14916;15038.172900490577;15690.843091568939;14195.929020354832;14278.2146981917;14561.781573276197;14587.927060364631;14755.409783608535;13538.864611354154;14091.224982626054;14114.858851411354;14342.211178384872;14816.851831481978;11950.820737689115;11976.520939162336;12003.459844307201;12459.377031148226;12485.75028499443;10858.511366988347;12171.438556201863;12227.69430764238;12296.754064918472;12379.69050773738 03:41:31 INFO - PROCESS | 25139 | __end_tp_report 03:41:31 INFO - PROCESS | 25139 | __start_cc_report 03:41:31 INFO - PROCESS | 25139 | _x_x_mozilla_cycle_collect,342 03:41:31 INFO - PROCESS | 25139 | __end_cc_report 03:41:31 INFO - PROCESS | 25139 | __startTimestamp1470307291317__endTimestamp 03:41:31 INFO - PROCESS | 25139 | 03:41:31 INFO - PROCESS | 25139 | ------- Summary: start ------- 03:41:31 INFO - PROCESS | 25139 | Number of tests: 6 03:41:31 INFO - PROCESS | 25139 | 03:41:31 INFO - PROCESS | 25139 | [#0] dojo.html Cycles:165 Average:5347.88 Median:5607.61 stddev:717.19 (12.8%) stddev-sans-first:696.88 03:41:31 INFO - PROCESS | 25139 | Values: 3075.7 3120.9 3163.0 3167.3 3167.7 5288.7 5400.4 5445.2 5489.8 5497.2 5337.9 5391.6 5416.2 5523.2 5585.2 4865.7 4949.4 4950.9 5042.5 5045.6 290.5 4967.3 4978.5 5043.1 5091.4 4897.6 4943.0 4968.8 4976.6 4996.6 4964.8 4974.7 4975.8 4980.3 4987.7 4808.3 4882.4 4948.2 4976.5 4998.2 5414.5 5457.6 5510.7 5525.3 5531.6 5856.7 5861.8 5876.8 5882.8 5885.6 5684.8 5723.4 5728.0 5893.8 5901.9 5387.6 5399.3 5399.8 5412.1 5428.5 5884.4 5900.8 5902.9 5912.9 5932.8 5481.7 5608.1 5639.1 5639.6 5658.0 5733.3 5736.9 5745.1 5754.9 5761.5 5710.8 5711.5 5726.3 5743.5 5750.5 5665.9 5693.0 5722.9 5744.4 5746.0 4395.4 4423.2 4434.6 4437.0 4450.6 3911.0 3919.1 3924.5 3932.2 3992.3 5393.7 5403.5 5446.0 5568.1 5575.2 5686.3 5702.3 5724.9 5759.9 5762.5 5446.6 5470.3 5474.2 5475.8 5486.3 4936.8 4941.5 4953.0 4972.0 4977.8 5931.7 5938.0 5959.2 5968.1 5988.6 5705.3 5712.1 5716.5 5722.0 5758.9 5868.7 5873.6 5912.8 5994.4 6002.8 5594.3 5594.7 5606.3 5636.4 5639.5 5726.8 5728.3 5745.3 5768.3 5771.1 5526.8 5605.1 5607.6 5626.1 5716.3 5696.2 5712.4 5712.8 5727.1 5771.1 5667.7 5694.8 5718.3 5723.2 5748.1 5407.3 5675.6 5682.6 5720.1 5732.0 5619.4 5637.9 5644.9 5663.2 5680.1 03:41:31 INFO - PROCESS | 25139 | 03:41:31 INFO - PROCESS | 25139 | [#1] ext.html Cycles:180 Average:62138.16 Median:41933.08 stddev:125707.36 (299.8%) stddev-sans-first:125974.99 03:41:31 INFO - PROCESS | 25139 | Values: 562.6 564.6 577.1 578.2 593.1 39649.8 43909.3 43977.1 43978.8 44076.1 41523.6 42928.0 43349.0 43457.8 43480.3 8706.3 8796.9 8836.7 8853.4 8856.4 8785.7 8799.5 8870.0 8875.3 8876.3 8918.6 8928.0 8952.6 8975.4 9006.0 8861.8 8891.7 8905.3 8925.5 8933.2 8735.0 8759.1 8782.8 8799.0 8839.0 41341.4 41630.4 41903.6 41962.6 42057.8 3705.2 3761.4 4071.2 4137.5 4248.4 32778.8 33014.7 33058.2 33506.3 33516.7 3941.8 3967.6 4054.1 4074.9 4208.3 371413.0 372002.0 373358.1 373524.0 374586.0 58147.0 58471.0 58716.8 58803.1 58914.1 56973.1 56990.0 57025.7 57407.4 60481.0 15695.9 15906.8 15944.7 15973.0 16001.9 12126.8 12184.3 12251.6 12254.4 12312.3 16708.9 17399.3 17469.0 17501.3 17735.2 6541.6 6837.3 6844.9 6878.2 6900.8 997.0 1041.2 1052.2 1054.4 1065.4 32297.8 32334.7 32408.8 32773.3 33143.0 1022.5 1038.4 1038.5 1068.7 1118.4 16832.0 16976.7 17031.7 17100.0 17142.2 589031.0 594041.0 595572.0 596933.0 597216.0 59097.0 59243.7 59423.4 59438.7 59499.7 1323.4 1364.9 1368.4 1396.1 1399.3 30981.7 33390.7 34263.8 34294.3 34422.1 50561.2 50618.7 51114.5 51153.7 51156.5 420297.0 421101.0 423145.0 423446.0 424225.0 27658.6 28676.7 28739.3 28804.6 28845.0 46275.3 47247.0 47386.3 47645.8 48585.5 40589.6 40995.0 41075.8 41346.6 42454.0 40960.6 41381.8 41560.2 42729.6 42890.1 40509.6 41440.2 42884.6 43576.8 43975.6 34696.0 37566.6 37857.8 38001.4 38633.2 28029.9 28622.9 28692.6 28740.3 28842.6 03:41:31 INFO - PROCESS | 25139 | 03:41:31 INFO - PROCESS | 25139 | [#2] jquery.html Cycles:180 Average:29574.05 Median:21067.97 stddev:82955.47 (393.8%) stddev-sans-first:83159.21 03:41:31 INFO - PROCESS | 25139 | Values: 374.2 380.4 385.3 401.1 404.2 18757.2 20825.5 20941.2 20994.2 21539.0 16038.6 16239.8 16463.1 20321.9 20584.2 5488.4 5719.6 5755.5 5899.8 5932.6 3957.0 5866.9 5898.1 5899.8 5910.0 5951.2 6025.5 6036.9 6077.9 6078.1 5890.1 6021.0 6064.2 6068.6 6112.1 5801.9 5842.8 5917.4 5947.8 5953.6 13642.9 14272.9 14525.4 14594.3 14678.3 2377.9 2416.2 2486.8 2577.9 2846.7 10416.7 10434.9 10440.5 10444.4 10663.1 1896.2 1937.5 1967.7 1995.8 2016.4 82065.6 82747.6 83288.0 83345.6 83355.6 10530.9 10918.0 11211.7 11342.5 11589.4 15896.0 15948.5 15957.4 15982.9 15992.7 7792.4 7972.3 7987.4 8176.9 8203.6 7302.5 7356.4 7427.6 7705.4 7749.1 4705.8 4723.6 4745.8 4777.2 4848.3 1671.2 1884.5 1917.6 1923.6 2016.5 952.4 1037.8 1086.6 1114.7 1116.7 20709.8 20826.2 20844.0 21016.2 21119.8 1002.1 1009.2 1018.7 1022.0 1029.2 9407.9 11548.6 11561.4 11652.3 11754.6 473899.0 484718.0 510925.0 519351.0 520709.0 93517.5 97241.0 97509.0 100603.0 100863.0 960.7 990.6 1045.1 1047.1 1054.4 17346.9 18019.4 18204.9 18363.4 18660.1 35204.1 43397.0 43564.6 44419.8 44766.8 60160.1 60615.7 60742.0 61141.4 61547.4 8080.7 8335.0 8537.0 8699.0 8825.2 12359.2 13251.0 13728.5 13827.6 14013.6 11184.6 11472.0 11860.9 12027.2 12348.1 11815.1 11848.4 11872.5 12054.3 12166.9 12181.4 12260.1 12321.3 12430.3 12663.4 8574.5 8728.6 8847.0 9033.2 9132.2 10584.9 11699.1 11972.0 12166.8 12551.6 03:41:31 INFO - PROCESS | 25139 | 03:41:31 INFO - PROCESS | 25139 | [#3] mootools.html Cycles:180 Average:5922.87 Median:4583.19 stddev:3388.58 (73.9%) stddev-sans-first:3381.25 03:41:31 INFO - PROCESS | 25139 | Values: 1427.6 1455.7 1572.5 1739.9 1752.0 8005.6 8654.9 8767.9 9229.6 9240.4 8733.3 8940.4 8944.2 9004.0 9008.8 2328.7 2359.0 2361.4 2363.4 2376.3 2326.3 2340.6 2399.0 2405.6 2412.6 2344.2 2344.7 2349.4 2374.3 2395.4 2314.9 2338.5 2340.1 2342.4 2350.2 2282.6 2282.6 2294.4 2297.3 2308.0 8717.1 8758.5 8776.6 8782.6 8804.2 5222.8 5253.9 5282.3 5291.3 5320.7 3146.9 3282.6 3305.4 3360.7 3388.1 1023.1 1045.6 1061.1 1081.8 1102.9 12592.8 12624.9 12727.9 12737.0 12742.2 4473.7 4597.3 4781.0 4793.3 4872.5 10668.4 10708.9 10711.0 10714.8 10727.2 5342.9 5378.0 5397.6 5399.2 5402.9 4364.8 4814.8 4871.1 4891.1 4920.9 4045.5 4090.5 4099.8 4117.9 4119.6 1275.2 1279.4 1284.1 1285.1 1288.5 841.5 960.4 963.9 979.9 993.7 5841.7 5955.9 6017.3 6029.4 6063.0 1006.1 1048.9 1085.9 1094.5 1096.3 4325.2 4443.0 4527.8 4569.1 4666.6 11104.3 11219.5 11289.1 11308.5 11324.9 10585.3 11190.9 11235.8 11254.7 11266.6 8106.1 8440.1 8467.8 8472.4 8494.3 6275.7 6296.6 6372.6 6414.5 6596.2 10305.8 10322.5 10328.9 10385.9 10418.7 10327.6 10369.9 10419.5 10503.2 10675.8 7366.1 7739.7 7946.6 7947.3 8212.3 8861.1 8888.6 8947.8 8956.4 8972.4 7828.9 7867.7 7902.8 8115.6 8169.0 7818.0 7844.2 7872.1 7905.2 8029.6 6731.9 6739.4 6758.8 6794.9 6806.9 4933.9 5122.6 5158.9 5255.7 5477.1 4683.1 4964.8 5164.2 5268.8 5522.1 03:41:31 INFO - PROCESS | 25139 | 03:41:31 INFO - PROCESS | 25139 | [#4] prototype.html Cycles:180 Average:4630.81 Median:5167.03 stddev:1334.22 (25.8%) stddev-sans-first:1298.34 03:41:31 INFO - PROCESS | 25139 | Values: 330.5 334.6 338.5 343.4 347.2 5351.4 5418.2 5490.9 5594.0 5598.0 5425.5 5443.6 5446.9 5456.9 5459.6 4265.8 4269.6 4291.9 4309.0 4311.7 4179.6 4312.7 4320.5 4334.0 4346.5 4203.0 4258.9 4262.7 4271.0 4291.8 4229.8 4254.8 4296.1 4315.7 4323.0 3749.2 3812.3 3814.9 3828.4 3867.3 5356.8 5358.9 5388.0 5394.5 5432.8 4951.5 4951.9 4962.9 4970.2 4973.4 5491.7 5672.8 5684.9 5722.6 5729.4 4103.4 4114.7 4125.8 4151.4 4161.6 5908.6 6005.8 6030.2 6038.4 6058.2 3940.8 4142.5 4248.8 4264.5 4267.1 4220.5 4234.0 4235.7 4242.3 4261.9 4877.2 4886.8 4892.0 4895.0 4928.5 5592.3 5758.3 5793.3 5823.1 5830.3 1412.0 1470.6 1472.5 1474.6 1479.1 914.5 934.2 941.0 942.3 956.1 4860.3 4879.0 4881.9 4891.6 4908.9 5119.4 5149.9 5169.0 5184.8 5216.3 4695.6 4858.5 4886.6 4943.9 4962.9 2760.3 2764.2 2765.6 2766.8 2776.2 5296.8 5326.9 5345.6 5386.4 5426.9 4919.3 5166.6 5180.7 5209.9 5239.3 5269.5 5329.6 5333.8 5344.7 5372.9 5158.5 5171.6 5180.7 5198.8 5210.5 4742.4 5028.8 5050.4 5068.7 5118.1 5274.2 5297.8 5343.7 5356.5 5357.3 3851.4 3853.5 3861.1 3873.5 3874.7 4929.4 5167.5 5194.5 5278.4 5766.3 5704.9 5753.7 5754.5 5793.2 5794.7 5744.4 5751.5 5769.7 5789.4 5799.9 5632.5 5672.8 5734.4 5760.3 5788.3 5758.0 5788.9 5835.8 5837.7 5878.3 5500.0 5668.7 5681.1 5684.3 5698.9 03:41:31 INFO - PROCESS | 25139 | 03:41:31 INFO - PROCESS | 25139 | [#5] yui.html Cycles:180 Average:21931.38 Median:4406.84 stddev:31772.32 (721.0%) stddev-sans-first:31821.61 03:41:31 INFO - PROCESS | 25139 | Values: 740.1 749.9 773.9 793.8 871.2 15667.2 16662.4 16672.1 16841.0 16928.2 15236.2 15381.8 15392.4 15398.2 15431.2 649.6 763.5 768.6 772.2 782.0 777.6 778.5 779.8 780.5 785.8 829.6 830.5 835.1 835.5 836.1 818.7 820.8 828.5 832.2 833.8 606.9 607.6 611.4 611.9 612.0 15261.1 15316.5 15329.9 15342.2 15349.4 15693.7 15918.5 15956.7 16059.2 16105.2 12908.8 12949.7 13063.2 13066.5 13232.0 3937.8 3951.7 3962.5 3974.4 4074.9 80303.3 80386.0 80404.2 81523.0 84790.6 10919.1 11787.5 11862.9 12031.4 12119.6 20332.9 20673.0 20691.7 20795.8 20956.9 7811.7 7818.6 7937.1 8181.1 8215.5 4803.4 4907.4 4929.7 4946.2 4948.7 3514.0 3607.5 3621.2 3624.6 3624.9 591.6 596.3 603.8 607.9 609.2 647.4 686.3 686.5 690.5 715.8 9317.4 9834.3 9961.5 10031.4 10144.8 648.7 664.6 672.0 682.6 711.2 4738.8 4841.9 4853.1 4856.3 4887.9 85147.0 110509.0 112705.0 123858.0 124515.0 106947.5 107858.5 109247.5 109518.0 112606.0 96096.5 97047.0 97060.5 97776.0 99697.0 9301.6 9509.3 9605.6 9721.9 9758.8 53299.5 53740.2 53767.7 54335.0 56542.0 76838.0 76961.6 81708.6 81827.0 83005.0 11610.9 11714.2 11819.3 13154.9 13252.3 15020.5 15190.7 15322.2 15608.5 15953.6 14677.9 14742.1 14916.0 15038.2 15690.8 14195.9 14278.2 14561.8 14587.9 14755.4 13538.9 14091.2 14114.9 14342.2 14816.9 11950.8 11976.5 12003.5 12459.4 12485.8 10858.5 12171.4 12227.7 12296.8 12379.7 03:41:31 INFO - PROCESS | 25139 | -------- Summary: end -------- 03:41:31 INFO - PROCESS | 25139 | 03:41:32 INFO - TEST-INFO | 25139: exit 0 03:41:32 INFO - TEST-OK | dromaeo_css | took 1112469ms 03:41:32 INFO - TEST-START | kraken 03:41:32 INFO - operating with platform_type : linux_ 03:41:32 INFO - Initialising browser for kraken test... 03:41:32 INFO - TEST-INFO | started process 25384 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnK3P4I/profile http://localhost:48238/getInfo.html) 03:41:36 INFO - PROCESS | 25384 | __metrics Screen width/height:1600/1200 03:41:36 INFO - PROCESS | 25384 | colorDepth:24 03:41:36 INFO - PROCESS | 25384 | Browser inner width/height: 1024/697 03:41:36 INFO - PROCESS | 25384 | __metrics 03:41:37 ERROR - PROCESS | 25384 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 03:41:38 INFO - TEST-INFO | 25384: exit 0 03:41:38 INFO - Browser initialized. 03:41:38 INFO - Running cycle 1/1 for kraken test... 03:41:38 INFO - TEST-INFO | started process 25504 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnK3P4I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:41:50 INFO - PROCESS | 25504 | RSS: Main: 163385344 03:41:50 INFO - PROCESS | 25504 | 03:41:52 INFO - PROCESS | 25504 | Cycle 1(1): loaded http://localhost:48238/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48238/tests/kraken/driver.html?testName=audio-beat-detection) 03:41:53 INFO - PROCESS | 25504 | RSS: Main: 169357312 03:41:53 INFO - PROCESS | 25504 | 03:41:56 INFO - PROCESS | 25504 | Cycle 1(1): loaded http://localhost:48238/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48238/tests/kraken/driver.html?testName=audio-dft) 03:41:57 INFO - PROCESS | 25504 | RSS: Main: 167575552 03:41:57 INFO - PROCESS | 25504 | 03:41:59 INFO - PROCESS | 25504 | Cycle 1(1): loaded http://localhost:48238/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48238/tests/kraken/driver.html?testName=audio-fft) 03:42:00 INFO - PROCESS | 25504 | RSS: Main: 163672064 03:42:00 INFO - PROCESS | 25504 | 03:42:02 INFO - PROCESS | 25504 | Cycle 1(1): loaded http://localhost:48238/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48238/tests/kraken/driver.html?testName=audio-oscillator) 03:42:03 INFO - PROCESS | 25504 | RSS: Main: 165351424 03:42:03 INFO - PROCESS | 25504 | 03:42:05 INFO - PROCESS | 25504 | Cycle 1(1): loaded http://localhost:48238/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48238/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:42:06 INFO - PROCESS | 25504 | RSS: Main: 165851136 03:42:06 INFO - PROCESS | 25504 | 03:42:09 INFO - PROCESS | 25504 | Cycle 1(1): loaded http://localhost:48238/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48238/tests/kraken/driver.html?testName=imaging-darkroom) 03:42:09 INFO - PROCESS | 25504 | RSS: Main: 165736448 03:42:09 INFO - PROCESS | 25504 | 03:42:13 INFO - PROCESS | 25504 | Cycle 1(1): loaded http://localhost:48238/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48238/tests/kraken/driver.html?testName=imaging-desaturate) 03:42:14 INFO - PROCESS | 25504 | RSS: Main: 162545664 03:42:14 INFO - PROCESS | 25504 | 03:42:16 INFO - PROCESS | 25504 | Cycle 1(1): loaded http://localhost:48238/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48238/tests/kraken/driver.html?testName=json-parse-financial) 03:42:17 INFO - PROCESS | 25504 | RSS: Main: 164855808 03:42:17 INFO - PROCESS | 25504 | 03:42:19 INFO - PROCESS | 25504 | Cycle 1(1): loaded http://localhost:48238/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48238/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:42:19 INFO - PROCESS | 25504 | RSS: Main: 164704256 03:42:19 INFO - PROCESS | 25504 | 03:42:21 INFO - PROCESS | 25504 | Cycle 1(1): loaded http://localhost:48238/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48238/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:42:22 INFO - PROCESS | 25504 | RSS: Main: 164519936 03:42:22 INFO - PROCESS | 25504 | 03:42:24 INFO - PROCESS | 25504 | Cycle 1(1): loaded http://localhost:48238/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48238/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:42:24 INFO - PROCESS | 25504 | RSS: Main: 166334464 03:42:24 INFO - PROCESS | 25504 | 03:42:27 INFO - PROCESS | 25504 | Cycle 1(1): loaded http://localhost:48238/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:42:28 INFO - PROCESS | 25504 | RSS: Main: 165777408 03:42:28 INFO - PROCESS | 25504 | 03:42:30 INFO - PROCESS | 25504 | Cycle 1(1): loaded http://localhost:48238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:42:31 INFO - PROCESS | 25504 | RSS: Main: 166023168 03:42:31 INFO - PROCESS | 25504 | 03:42:33 INFO - PROCESS | 25504 | Cycle 1(1): loaded http://localhost:48238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48238/tests/kraken/driver.html?testName=ai-astar) 03:42:33 INFO - PROCESS | 25504 | RSS: Main: 167088128 03:42:33 INFO - PROCESS | 25504 | 03:42:33 INFO - PROCESS | 25504 | __start_tp_report 03:42:33 INFO - PROCESS | 25504 | _x_x_mozilla_page_load 03:42:33 INFO - PROCESS | 25504 | _x_x_mozilla_page_load_details 03:42:33 INFO - PROCESS | 25504 | |i|pagename|runs| 03:42:33 INFO - PROCESS | 25504 | |0;ai-astar;104;113;107;112;114;114;112;111;110;112 03:42:33 INFO - PROCESS | 25504 | |1;audio-beat-detection;151;120;153;181;118;150;146;120;178;122 03:42:33 INFO - PROCESS | 25504 | |2;audio-dft;161;163;162;163;164;168;172;162;163;165 03:42:33 INFO - PROCESS | 25504 | |3;audio-fft;75;75;75;181;75;76;76;76;164;76 03:42:33 INFO - PROCESS | 25504 | |4;audio-oscillator;84;84;156;85;87;85;151;85;84;150 03:42:33 INFO - PROCESS | 25504 | |5;imaging-gaussian-blur;118;118;118;119;118;121;117;117;118;118 03:42:33 INFO - PROCESS | 25504 | |6;imaging-darkroom;148;148;149;148;148;148;148;147;146;146 03:42:33 INFO - PROCESS | 25504 | |7;imaging-desaturate;96;97;96;96;95;96;96;96;97;95 03:42:33 INFO - PROCESS | 25504 | |8;json-parse-financial;51;51;54;52;53;52;51;51;52;54 03:42:33 INFO - PROCESS | 25504 | |9;json-stringify-tinderbox;60;60;60;60;61;59;60;62;61;61 03:42:33 INFO - PROCESS | 25504 | |10;stanford-crypto-aes;76;76;77;78;77;76;76;76;80;76 03:42:33 INFO - PROCESS | 25504 | |11;stanford-crypto-ccm;132;123;138;125;136;123;131;126;159;125 03:42:33 INFO - PROCESS | 25504 | |12;stanford-crypto-pbkdf2;157;158;159;164;157;159;159;158;156;155 03:42:33 INFO - PROCESS | 25504 | |13;stanford-crypto-sha256-iterative;67;66;68;64;69;65;64;64;63;65 03:42:33 INFO - PROCESS | 25504 | __end_tp_report 03:42:33 INFO - PROCESS | 25504 | __start_cc_report 03:42:33 INFO - PROCESS | 25504 | _x_x_mozilla_cycle_collect,870 03:42:33 INFO - PROCESS | 25504 | __end_cc_report 03:42:33 INFO - PROCESS | 25504 | __startTimestamp1470307353390__endTimestamp 03:42:33 INFO - PROCESS | 25504 | 03:42:33 INFO - PROCESS | 25504 | ------- Summary: start ------- 03:42:33 INFO - PROCESS | 25504 | Number of tests: 14 03:42:33 INFO - PROCESS | 25504 | 03:42:33 INFO - PROCESS | 25504 | [#0] ai-astar Cycles:10 Average:110.90 Median:112.00 stddev:3.18 (2.8%) stddev-sans-first:2.18 03:42:33 INFO - PROCESS | 25504 | Values: 104.0 113.0 107.0 112.0 114.0 114.0 112.0 111.0 110.0 112.0 03:42:33 INFO - PROCESS | 25504 | 03:42:33 INFO - PROCESS | 25504 | [#1] audio-beat-detection Cycles:10 Average:143.90 Median:150.50 stddev:23.59 (15.7%) stddev-sans-first:24.88 03:42:33 INFO - PROCESS | 25504 | Values: 151.0 120.0 153.0 181.0 118.0 150.0 146.0 120.0 178.0 122.0 03:42:33 INFO - PROCESS | 25504 | 03:42:33 INFO - PROCESS | 25504 | [#2] audio-dft Cycles:10 Average:164.30 Median:163.50 stddev:3.33 (2.0%) stddev-sans-first:3.32 03:42:33 INFO - PROCESS | 25504 | Values: 161.0 163.0 162.0 163.0 164.0 168.0 172.0 162.0 163.0 165.0 03:42:33 INFO - PROCESS | 25504 | 03:42:33 INFO - PROCESS | 25504 | [#3] audio-fft Cycles:10 Average:94.90 Median:75.50 stddev:41.10 (54.4%) stddev-sans-first:42.95 03:42:33 INFO - PROCESS | 25504 | Values: 75.0 75.0 75.0 181.0 75.0 76.0 76.0 76.0 164.0 76.0 03:42:33 INFO - PROCESS | 25504 | 03:42:33 INFO - PROCESS | 25504 | [#4] audio-oscillator Cycles:10 Average:105.10 Median:84.50 stddev:32.64 (38.6%) stddev-sans-first:33.72 03:42:33 INFO - PROCESS | 25504 | Values: 84.0 84.0 156.0 85.0 87.0 85.0 151.0 85.0 84.0 150.0 03:42:33 INFO - PROCESS | 25504 | 03:42:33 INFO - PROCESS | 25504 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:1.14 (1.0%) stddev-sans-first:1.20 03:42:33 INFO - PROCESS | 25504 | Values: 118.0 118.0 118.0 119.0 118.0 121.0 117.0 117.0 118.0 118.0 03:42:33 INFO - PROCESS | 25504 | 03:42:33 INFO - PROCESS | 25504 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 03:42:33 INFO - PROCESS | 25504 | Values: 148.0 148.0 149.0 148.0 148.0 148.0 148.0 147.0 146.0 146.0 03:42:33 INFO - PROCESS | 25504 | 03:42:33 INFO - PROCESS | 25504 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 03:42:33 INFO - PROCESS | 25504 | Values: 96.0 97.0 96.0 96.0 95.0 96.0 96.0 96.0 97.0 95.0 03:42:33 INFO - PROCESS | 25504 | 03:42:33 INFO - PROCESS | 25504 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.00 stddev:1.20 (2.3%) stddev-sans-first:1.20 03:42:33 INFO - PROCESS | 25504 | Values: 51.0 51.0 54.0 52.0 53.0 52.0 51.0 51.0 52.0 54.0 03:42:33 INFO - PROCESS | 25504 | 03:42:33 INFO - PROCESS | 25504 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:60.50 stddev:0.84 (1.4%) stddev-sans-first:0.88 03:42:33 INFO - PROCESS | 25504 | Values: 60.0 60.0 60.0 60.0 61.0 59.0 60.0 62.0 61.0 61.0 03:42:33 INFO - PROCESS | 25504 | 03:42:33 INFO - PROCESS | 25504 | [#10] stanford-crypto-aes Cycles:10 Average:76.80 Median:76.50 stddev:1.32 (1.7%) stddev-sans-first:1.36 03:42:33 INFO - PROCESS | 25504 | Values: 76.0 76.0 77.0 78.0 77.0 76.0 76.0 76.0 80.0 76.0 03:42:33 INFO - PROCESS | 25504 | 03:42:33 INFO - PROCESS | 25504 | [#11] stanford-crypto-ccm Cycles:10 Average:131.80 Median:131.50 stddev:10.94 (8.3%) stddev-sans-first:11.61 03:42:33 INFO - PROCESS | 25504 | Values: 132.0 123.0 138.0 125.0 136.0 123.0 131.0 126.0 159.0 125.0 03:42:33 INFO - PROCESS | 25504 | 03:42:33 INFO - PROCESS | 25504 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.20 Median:158.50 stddev:2.44 (1.5%) stddev-sans-first:2.55 03:42:33 INFO - PROCESS | 25504 | Values: 157.0 158.0 159.0 164.0 157.0 159.0 159.0 158.0 156.0 155.0 03:42:33 INFO - PROCESS | 25504 | 03:42:33 INFO - PROCESS | 25504 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:65.50 stddev:1.96 (3.0%) stddev-sans-first:2.00 03:42:33 INFO - PROCESS | 25504 | Values: 67.0 66.0 68.0 64.0 69.0 65.0 64.0 64.0 63.0 65.0 03:42:33 INFO - PROCESS | 25504 | -------- Summary: end -------- 03:42:33 INFO - PROCESS | 25504 | 03:42:34 INFO - TEST-INFO | 25504: exit 0 03:42:34 INFO - TEST-OK | kraken | took 62306ms 03:42:34 INFO - SUITE-END | took 1174s 03:42:34 INFO - Completed test suite (00:19:34) 03:42:34 INFO - javascript benchmark 03:42:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7311.066138104339, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3075.6924307569243, 3120.859561319743, 3162.9841850790745, 3167.303193297475, 3167.7307428868544, 5288.6562373445695, 5400.378956420018, 5445.210444485552, 5489.752961116749, 5497.175423686449, 5337.919931201035, 5391.595630327722, 5416.214648875911, 5523.199136125259, 5585.162225666142, 4865.732384718839, 4949.381327334083, 4950.851474455772, 5042.520960508764, 5045.571126454256, 290.4559409471938, 4967.254911763228, 4978.5270399312, 5043.067032598962, 5091.363579552556, 4897.559219670246, 4942.975285123587, 4968.7515624219, 4976.576990955755, 4996.575291100261, 4964.751762411865, 4974.701517908937, 4975.825846095369, 4980.327655766498, 4987.725675087869, 4808.2547205183255, 4882.36529251195, 4948.208286674115, 4976.4525902150735, 4998.150314446553, 5414.512693857532, 5457.617966742329, 5510.724463776795, 5525.281713377275, 5531.640443371209, 5856.707164641751, 5861.794837180721, 5876.764929402819, 5882.823515294548, 5885.617434866763, 5684.772609095672, 5723.427657234243, 5727.971360143214, 5893.793717219876, 5901.852453688693, 5387.622866399353, 5399.2980912481125, 5399.757010934439, 5412.107002344608, 5428.511433970962, 5884.352721200665, 5900.793472228537, 5902.911456328158, 5912.881742365214, 5932.79235226765, 5481.698506582096, 5608.130739735348, 5639.069553523623, 5639.6334238274385, 5658.0, 5733.283339582552, 5736.885262294814, 5745.052066409079, 5754.913676294859, 5761.452661997104, 5710.828675139669, 5711.457411545896, 5726.341470730836, 5743.511801496836, 5750.511206547407, 5665.886682266414, 5692.971535142297, 5722.885542289214, 5744.368119506851, 5745.971270143623, 4395.384646149541, 4423.181711383404, 4434.600885920283, 4437.0, 4450.643948484114, 3911.041794760245, 3919.0594257378025, 3924.4898163238595, 3932.1545867638024, 3992.341263691458, 5393.7033463159905, 5403.540699040547, 5446.0, 5568.1091025435735, 5575.163725441135, 5686.317641883001, 5702.258706368146, 5724.942750572524, 5759.942400576025, 5762.481376676119, 5446.591505637093, 5470.288862447936, 5474.178873169057, 5475.753591088411, 5486.31421072366, 4936.75316234194, 4941.530554597308, 4952.950470495321, 4972.030454061423, 4977.825776097891, 5931.703414829241, 5938.020226662638, 5959.225300710967, 5968.134620480006, 5988.610740301867, 5705.3153621564015, 5712.0860662293835, 5716.5426765859465, 5722.0, 5758.8848223034465, 5868.706564671835, 5873.5594830388745, 5912.763489460373, 5994.430529099728, 6002.8499287516415, 5594.328680558359, 5594.664320140804, 5606.271184745957, 5636.408177141341, 5639.520640745583, 5726.79956201531, 5728.312602487728, 5745.310562732332, 5768.2501274834, 5771.105478650816, 5526.834194974157, 5605.075162598126, 5607.607467477237, 5626.07169816992, 5716.256886604715, 5696.174054761954, 5712.37163911961, 5712.7714891403875, 5727.083666613322, 5771.105478650816, 5667.744951477111, 5694.772209111589, 5718.342390625131, 5723.227364305932, 5748.080307150836, 5407.270018547603, 5675.57433192504, 5682.6306290091015, 5720.141978703062, 5732.0, 5619.353774315842, 5637.915431268452, 5644.9435505644415, 5663.150527420755, 5680.062789639664], "value": 5302.949868167094, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.5977426140308, 564.6217034586829, 577.1458241802134, 578.1587789765888, 593.0718425663838, 39649.80175099124, 43909.341359879625, 43977.12045759087, 43978.780106099504, 44076.11847763051, 41523.58476415235, 42928.0, 43349.0, 43457.78271108648, 43480.347794783105, 8706.303495720344, 8796.8680469793, 8836.734897953073, 8853.380263381567, 8856.380053396264, 8785.692500762474, 8799.516026618534, 8869.95565022174, 8875.28997680184, 8876.289896808272, 8918.643254269822, 8927.95536022319, 8952.641894324219, 8975.371723979324, 9005.954970225172, 8861.822763544726, 8891.710701948214, 8905.332100092519, 8925.464472131693, 8933.240674542672, 8734.956325218396, 8759.124087591254, 8782.780430489225, 8799.0, 8839.02770695223, 41341.379879301836, 41630.375544366856, 41903.580964190274, 41962.58037419648, 42057.78971105125, 3705.221903400289, 3761.3605687032996, 4071.1857628474127, 4137.50349958007, 4248.362745588187, 32778.83610581956, 33014.6698533014, 33058.17354566131, 33506.32987340264, 33516.6648333516, 3941.8029098545244, 3967.6032396760384, 4054.108096218827, 4074.9185016299803, 4208.263553878059, 371413.0, 372002.0, 373358.1332093349, 373524.0, 374586.0, 58147.0, 58471.0, 58716.77965084891, 58803.117953230736, 58914.11628825571, 56973.14540281899, 56990.0, 57025.71487142538, 57407.42592574021, 60481.0, 15695.921520392554, 15906.76139857903, 15944.681106377808, 15973.0, 16001.919990400207, 12126.757464850654, 12184.329861857683, 12251.629152840473, 12254.448549815279, 12312.322822244863, 16708.91645541789, 17399.304027838745, 17469.0, 17501.29994800194, 17735.201915913814, 6541.6075035498025, 6837.282085381063, 6844.8973265401055, 6878.209005964378, 6900.827479313058, 996.9651062212788, 1041.234692501011, 1052.2371280821496, 1054.4411461925192, 1065.355459946721, 32297.838510807294, 32334.70661173574, 32408.83795581054, 32773.3445331092, 33143.0, 1022.4580972084807, 1038.4496217004998, 1038.4548112241134, 1068.6633710381204, 1118.4072441605963, 16832.0, 16976.660466790596, 17031.744523832152, 17100.0, 17142.228599713042, 589031.0, 594041.0, 595572.0, 596933.0, 597216.0, 59097.0, 59243.70378148081, 59423.405765942654, 59438.70280648656, 59499.70250148721, 1323.3647849032518, 1364.9317534123254, 1368.4184221705934, 1396.0716123777777, 1399.2863639543702, 30981.690183097882, 33390.666093338754, 34263.82868085644, 34294.31411371809, 34422.13944651404, 50561.24158137704, 50618.74690626523, 51114.48885511246, 51153.74423127861, 51156.48843511666, 420297.0, 421101.0, 423145.0, 423446.0, 424225.0, 27658.585121222794, 28676.713232867405, 28739.28151796222, 28804.567931480626, 28845.0, 46275.305870412645, 47247.0, 47386.28920566263, 47645.76177119092, 48585.5141448581, 40589.59410405858, 40995.0, 41075.794621026704, 41346.58653413427, 42454.0, 40960.59039409568, 41381.79309103556, 41560.16879662329, 42729.572704272556, 42890.14219715651, 40509.59490405058, 41440.171196576506, 42884.57115428806, 43576.78211608922, 43975.560244397144, 34696.0, 37566.624333756314, 37857.81071094627, 38001.4299785509, 38633.227335453696, 28029.859850700617, 28622.85688571627, 28692.569611455427, 28740.281492962844, 28842.567361489175], "value": 20121.936955204255, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.20481476861687, 380.3947342215849, 385.2737589643522, 401.08752587862625, 404.2218728946777, 18757.2497100116, 20825.479363015915, 20941.162353505842, 20994.18902836773, 21539.0, 16038.627059934935, 16239.756403653955, 16463.094529800856, 20321.898390508064, 20584.176632934665, 5488.423715509874, 5719.628224165416, 5755.45323194298, 5899.823005309848, 5932.6143800653035, 3956.9802150989203, 5866.88266234675, 5898.085796701518, 5899.823005309848, 5910.0, 5951.22634057574, 6025.457708806207, 6036.939630603703, 6077.908831367533, 6078.118672792442, 5890.145928840316, 6020.969895150518, 6064.241969753781, 6068.57519973602, 6112.113743507211, 5801.941980580183, 5842.795502157446, 5917.408259174048, 5947.791827286068, 5953.613015154045, 13642.931785341108, 14272.92863535686, 14525.418983240657, 14594.27028648574, 14678.266086695623, 2377.8811059446957, 2416.226807421626, 2486.751324867517, 2577.87110644467, 2846.6584009918733, 10416.687499374955, 10434.895651043544, 10440.47797610124, 10444.373337599769, 10663.146948244123, 1896.2035944903173, 1937.4865660599953, 1967.7146813712075, 1995.7605087389607, 2016.4353980885376, 82065.58967205185, 82747.5862620689, 83288.0, 83345.58327208325, 83355.58322208411, 10530.947345263225, 10918.0, 11211.66365009051, 11342.489587968561, 11589.420528973686, 15896.0, 15948.521544353687, 15957.361705531881, 15982.920085399732, 15992.680146397239, 7792.376609871197, 7972.322352600094, 7987.3610111190965, 8176.877346839683, 8203.630836612367, 7302.452316076316, 7356.448266380043, 7427.554346739213, 7705.42209334291, 7749.147593764681, 4705.7647117644665, 4723.574878260973, 4745.762711864393, 4777.187878060738, 4848.254628333797, 1671.156066186568, 1884.4629280654947, 1917.6260629177177, 1923.5864289177894, 2016.4857961219795, 952.3761935931838, 1037.7570093457944, 1086.5653738504661, 1114.654457118296, 1116.7152376144031, 20709.792902070785, 20826.166953322, 20844.0, 21016.15935362599, 21119.78880211209, 1002.0680766886719, 1009.2077718990557, 1018.6892997635792, 1021.9897801022043, 1029.1920842139034, 9407.858882116774, 11548.59579914699, 11561.42192890352, 11652.30086194814, 11754.647360579196, 473899.0, 484718.0, 510925.0, 519351.0, 520709.0, 93517.5324123375, 97241.0, 97509.0, 100603.0, 100863.0, 960.7454024683465, 990.6087095597198, 1045.0698877998586, 1047.057648116701, 1054.3726482742757, 17346.91326543359, 18019.369322073664, 18204.908975455568, 18363.35728249505, 18660.066996650385, 35204.119897002776, 43396.999999998734, 43564.56435435605, 44419.77790111029, 44766.77616611896, 60160.09759853518, 60615.69692151511, 60742.0, 61141.38858611357, 61547.384526154165, 8080.71717489885, 8334.958130233721, 8536.957315213383, 8698.956125264756, 8825.249853762502, 12359.196652217577, 13251.006174536755, 13728.45086196541, 13827.585172444842, 14013.649658758204, 11184.608538701106, 11472.0, 11860.94069529647, 12027.218230815319, 12348.135630506138, 11815.113866460222, 11848.407579621156, 11872.46573904159, 12054.337011464453, 12166.878331216574, 12181.39093045362, 12260.141790074966, 12321.322327272086, 12430.316332601793, 12663.366831658195, 8574.528400938008, 8728.563571821256, 8847.0, 9033.238518488832, 9132.178103970675, 10584.89415105839, 11699.06407487416, 11972.0, 12166.817497737718, 12551.623451296477], "value": 9294.239472488953, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1427.5717284814557, 1455.6797504549, 1572.5282415275415, 1739.9304027838887, 1751.964960700786, 8005.5997200140055, 8654.91345086549, 8767.912320876789, 9229.5846686899, 9240.353175277733, 8733.30133589313, 8940.374173807835, 8944.195022447979, 9003.954980225106, 9008.774780630487, 2328.7205535335784, 2359.0, 2361.3624321433203, 2363.409147713072, 2376.2633583589054, 2326.3137374474572, 2340.566995105902, 2399.0, 2405.5549723301156, 2412.626042963335, 2344.202970989863, 2344.742078371378, 2349.3774149850306, 2374.3470545599926, 2395.401149712572, 2314.8958296876513, 2338.4504641409253, 2340.1224540797202, 2342.4143964009, 2350.189184731265, 2282.577723121228, 2282.6233671444193, 2294.380517260347, 2297.3337732057685, 2308.0, 8717.128287171296, 8758.518281494515, 8776.561171941377, 8782.64869405223, 8804.163604457566, 5222.843314700565, 5253.86865328366, 5282.286891269668, 5291.3385826771655, 5320.65415747979, 3146.889858854952, 3282.556854824592, 3305.3719793239206, 3360.7311415086733, 3388.136025313554, 1023.1150055202271, 1045.6131231444415, 1061.0980666433547, 1081.7728277061826, 1102.9117670586334, 12592.81110783339, 12624.873751262554, 12727.93636031814, 12737.0, 12742.171758835646, 4473.686841921034, 4597.287420449836, 4780.95219047812, 4793.281007848851, 4872.4640289568115, 10668.413237272025, 10708.946455267675, 10711.0, 10714.839277410845, 10727.195460340507, 5342.8664283392445, 5378.0, 5397.568194544427, 5399.244105825188, 5402.891942161214, 4364.8254069837485, 4814.759262036884, 4871.123197824355, 4891.119598472238, 4920.8769780755765, 4045.5347635021762, 4090.5003766798477, 4099.795010249535, 4117.855875044419, 4119.608637179464, 1275.1775105057372, 1279.449836570265, 1284.0818814547642, 1285.0747461827468, 1288.4524077267124, 841.5287439034161, 960.4189465373348, 963.8987906269881, 979.8873129590188, 993.7217579077725, 5841.678707671119, 5955.880882382328, 6017.308009578955, 6029.366916473795, 6063.029915213545, 1006.1447769396101, 1048.8846226915034, 1085.9294145880651, 1094.5074716377503, 1096.3202814255212, 4325.2214601371425, 4443.0, 4527.7509736964785, 4569.086182763394, 4666.626669866402, 11104.278221915549, 11219.495122719498, 11289.0968722502, 11308.547658093748, 11324.94337528307, 10585.311954722918, 11190.888091118984, 11235.775284494428, 11254.662360129209, 11266.605668801716, 8106.108328083906, 8440.11378805229, 8467.788305292417, 8472.364572657076, 8494.32045436376, 6275.717592708248, 6296.622202667854, 6372.6495042773095, 6414.5189110815945, 6596.175478065242, 10305.793884122426, 10322.535485903303, 10328.948355258175, 10385.948070259601, 10418.68743937683, 10327.638532651321, 10369.948150259503, 10419.479026048515, 10503.212259080447, 10675.839862402225, 7366.116066072105, 7739.729109481141, 7946.642401091849, 7947.324477419253, 8212.30195433371, 8861.069587693457, 8888.60001299956, 8947.821043579223, 8956.373053886166, 8972.37193396456, 7828.882566761617, 7867.685292588232, 7902.802429939297, 8115.634796434057, 8168.959155204424, 7817.960910195413, 7844.17636148219, 7872.1340652529325, 7905.209479052049, 8029.558374289237, 6731.865362692621, 6739.359760822714, 6758.797236082925, 6794.898076528757, 6806.897896531457, 4933.9013219736125, 5122.615803814803, 5158.922616160686, 5255.737213139251, 5477.068898287221, 4683.086798074342, 4964.826231082039, 5164.173732202829, 5268.815591454434, 5522.088855338985], "value": 4727.793179262365, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.4679466059645, 334.5600535296085, 338.4821223528002, 343.37505739554007, 347.1979726831019, 5351.357837059549, 5418.214358917964, 5490.917636235455, 5594.0, 5598.020346439372, 5425.538829199523, 5443.618946673724, 5446.945530544694, 5456.945430545703, 5459.590530710193, 4265.8080386382535, 4269.594388533084, 4291.875521616788, 4308.97845510772, 4311.655067594585, 4179.623833854967, 4312.654987600984, 4320.466234486759, 4334.0031792687705, 4346.478422589294, 4202.957970420287, 4258.850940217093, 4262.701610887239, 4270.957290427087, 4291.806868690916, 4229.794508565044, 4254.808533615979, 4296.140771845643, 4315.676324275661, 4322.978385108086, 3749.2314075614436, 3812.2947254757682, 3814.866479673226, 3828.3874580067054, 3867.323218436762, 5356.794721187702, 5358.91961620576, 5387.973060134714, 5394.487523685244, 5432.79971611498, 4951.480094590052, 4951.900961980777, 4962.87592810179, 4970.179920313144, 4973.35346404965, 5491.7254137292975, 5672.829815105553, 5684.886302273972, 5722.599418040739, 5729.427057294279, 4103.384492326145, 4114.691398145121, 4125.793710314502, 4151.418801367811, 4161.583841615845, 5908.556858235606, 6005.789797357115, 6030.185924900126, 6038.426349496791, 6058.1518587397795, 3940.763554186758, 4142.46148000764, 4248.787560621957, 4264.488261408651, 4267.0825772459075, 4220.472440944882, 4233.97883010583, 4235.745855248695, 4242.278812601865, 4261.936070958938, 4877.195262781673, 4886.780094895738, 4892.046051020088, 4895.0, 4928.457869634337, 5592.328920529562, 5758.309002919593, 5793.304803423616, 5823.097419899922, 5830.271216097988, 1411.964700882486, 1470.5514817980618, 1472.5214305350803, 1474.5502621700484, 1479.1051413894438, 914.5015966298383, 934.2059249637889, 941.0354386753633, 942.3168203052732, 956.1346980982222, 4860.270959356125, 4878.975605122023, 4881.87638377307, 4891.584215341736, 4908.852734417973, 5119.387392971202, 5149.944261426399, 5168.9741551292755, 5184.792608295701, 5216.295800066942, 4695.600873925686, 4858.46556878743, 4886.584640305543, 4943.9258411123865, 4962.8759281018265, 2760.268528839859, 2764.226016715323, 2765.612814206013, 2766.7786577073784, 2776.208780497589, 5296.788128474895, 5326.92009619856, 5345.572354211654, 5386.380566234855, 5426.864328391822, 4919.311296418504, 5166.5866730661455, 5180.6891586504935, 5209.947900521022, 5239.318888544541, 5269.525742683177, 5329.573634109262, 5333.759980800874, 5344.679319240858, 5372.946270537323, 5158.45836187195, 5171.629518177761, 5180.7409629517615, 5198.766055527435, 5210.505002024802, 4742.411292217146, 5028.798848046037, 5050.368703912011, 5068.670536415121, 5118.053160165381, 5274.182501712241, 5297.841064768063, 5343.732813359239, 5356.491133342326, 5357.276767636319, 3851.4030325299623, 3853.5183102112237, 3861.0540417596744, 3873.477080594084, 3874.651281384576, 4929.404482348574, 5167.483251674953, 5194.4805519447755, 5278.4193738687945, 5766.2503874497725, 5704.914426283526, 5753.654780713171, 5754.482096611325, 5793.188953546422, 5794.6970226970225, 5744.425557444222, 5751.4536119068625, 5769.68266745333, 5789.421057894177, 5799.9130013049, 5632.464915832989, 5672.801451949162, 5734.397888221677, 5760.279965004374, 5788.27646544182, 5757.984705353093, 5788.884222315614, 5835.790315326638, 5837.737301821343, 5878.3239927408895, 5500.037493438552, 5668.744906479301, 5681.147827825859, 5684.261046063985, 5698.886022279614], "value": 4208.127872125056, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.0859937976595, 749.8912657664639, 773.9187385324541, 793.8332950080483, 871.2202578692073, 15667.216639168038, 16662.416815411463, 16672.083035433046, 16841.0, 16928.238229279683, 15236.23818809058, 15381.769273460906, 15392.384304627802, 15398.153101579408, 15431.228438578082, 649.5940037476577, 763.4693887748017, 768.6041688530412, 772.2239149654589, 781.9726309579166, 777.5762209595756, 778.5367706214793, 779.76996785948, 780.4887798491968, 785.83104632504, 829.5603330234954, 830.4975489828657, 835.064727505195, 835.4653022065883, 836.113719457374, 818.7380038387719, 820.7578764264556, 828.4863384701464, 832.196929962586, 833.8165603567205, 606.8573885136989, 607.5898768331359, 611.4222060153157, 611.8929187392189, 611.9694015299261, 15261.084334939827, 15316.463923762727, 15329.923350383287, 15342.156181410019, 15349.386024559004, 15693.686126277526, 15918.522444326689, 15956.680866382723, 16059.197040148063, 16105.194740263058, 12908.806367904488, 12949.741005179843, 13063.216207027514, 13066.477340906353, 13232.0, 3937.8424863005444, 3951.7036222283155, 3962.5244970603426, 3974.4435778990965, 4074.898127546835, 80303.27987501463, 80386.0, 80404.19595804026, 81523.0, 84790.57604711936, 10919.071878890225, 11787.492531368287, 11862.940685296691, 12031.398430078461, 12119.575814846437, 20332.898335508522, 20673.0, 20691.689624655643, 20795.792042079687, 20956.89521552413, 7811.687532498637, 7818.648160832776, 7937.126916039231, 8181.059178194584, 8215.507069575844, 4803.375561177025, 4907.362042934467, 4929.704217746947, 4946.159152944008, 4948.727819969864, 3513.9648603514147, 3607.4769158471877, 3621.239539696693, 3624.637536246407, 3624.8550057997386, 591.6124938165423, 596.3440215762627, 603.801454113593, 607.8936186167491, 609.1563184988734, 647.4011539326199, 686.3411125319749, 686.5160062156168, 690.5373399822131, 715.8210447388153, 9317.44095354281, 9834.311598188058, 9961.452120133317, 10031.39811611291, 10144.847827282596, 648.740503798475, 664.5613894829389, 671.992011982027, 682.6313790553046, 711.2141084101993, 4738.780561754742, 4841.878953026132, 4853.102176097434, 4856.271559266068, 4887.877803054881, 85147.0, 110509.0, 112705.0, 123858.0, 124515.0, 106947.46526267318, 107858.46070769752, 109247.45376273067, 109518.0, 112606.0, 96096.51951740336, 97047.0, 97060.51469742747, 97776.0, 99697.0, 9301.627934882528, 9509.286803489627, 9605.615775368908, 9721.902780972383, 9758.75603109928, 53299.46700532945, 53740.193897090794, 53767.73116134551, 54335.0, 56542.0, 76838.0, 76961.61519192369, 81708.59145704233, 81827.0, 83005.0, 11610.883891161318, 11714.1800073994, 11819.349935753617, 13154.868451315364, 13252.271125088213, 15020.474283400028, 15190.696186076437, 15322.233888305764, 15608.453704120755, 15953.57509646922, 14677.853221467649, 14742.11547307165, 14916.0, 15038.172900490577, 15690.843091568939, 14195.929020354832, 14278.2146981917, 14561.781573276197, 14587.927060364631, 14755.409783608535, 13538.864611354154, 14091.224982626054, 14114.858851411354, 14342.211178384872, 14816.851831481978, 11950.820737689115, 11976.520939162336, 12003.459844307201, 12459.377031148226, 12485.75028499443, 10858.511366988347, 12171.438556201863, 12227.69430764238, 12296.754064918472, 12379.69050773738], "value": 7739.105247354865, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1525.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 107.0, 112.0, 114.0, 114.0, 112.0, 111.0, 110.0, 112.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 120.0, 153.0, 181.0, 118.0, 150.0, 146.0, 120.0, 178.0, 122.0], "value": 143.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 162.0, 163.0, 164.0, 168.0, 172.0, 162.0, 163.0, 165.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 181.0, 75.0, 76.0, 76.0, 76.0, 164.0, 76.0], "value": 94.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 156.0, 85.0, 87.0, 85.0, 151.0, 85.0, 84.0, 150.0], "value": 105.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 119.0, 118.0, 121.0, 117.0, 117.0, 118.0, 118.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 149.0, 148.0, 148.0, 148.0, 148.0, 147.0, 146.0, 146.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 97.0, 95.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 54.0, 52.0, 53.0, 52.0, 51.0, 51.0, 52.0, 54.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 61.0, 59.0, 60.0, 62.0, 61.0, 61.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 78.0, 77.0, 76.0, 76.0, 76.0, 80.0, 76.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 123.0, 138.0, 125.0, 136.0, 123.0, 131.0, 126.0, 159.0, 125.0], "value": 131.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 158.0, 159.0, 164.0, 157.0, 159.0, 159.0, 158.0, 156.0, 155.0], "value": 158.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 68.0, 64.0, 69.0, 65.0, 64.0, 64.0, 63.0, 65.0], "value": 65.5, "unit": "score"}]}]} 03:42:34 INFO - Return code: 0 03:42:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:42:34 ERROR - # TBPL SUCCESS # 03:42:34 INFO - Running post-action listener: _resource_record_post_action 03:42:34 INFO - [mozharness: 2016-08-04 10:42:34.676831Z] Finished run-tests step (success) 03:42:34 INFO - Running post-run listener: _resource_record_post_run 03:42:34 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 12288; Write bytes: 537845760; Read time: 476; Write time: 772476 03:42:34 INFO - TinderboxPrint: CPU usage
13.5% 03:42:34 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 476 03:42:34 INFO - TinderboxPrint: I/O write bytes / time
537,845,760 / 772,476 03:42:34 INFO - TinderboxPrint: CPU idle
8,230.8 (86.5%) 03:42:34 INFO - TinderboxPrint: CPU user
1,219.2 (12.8%) 03:42:34 INFO - TinderboxPrint: Swap in / out
0 / 0 03:42:34 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 247517184; Read time: 156; Write time: 424780 03:42:34 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289832960; Read time: 308; Write time: 347632 03:42:35 INFO - Running post-run listener: _upload_blobber_files 03:42:35 INFO - Blob upload gear active. 03:42:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:42:35 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:42:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:42:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:42:35 INFO - (blobuploader) - INFO - Open directory for files ... 03:42:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:42:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:42:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:42:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:42:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:42:39 INFO - (blobuploader) - INFO - Done attempting. 03:42:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:42:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:42:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:42:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:42:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:42:40 INFO - (blobuploader) - INFO - Done attempting. 03:42:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:42:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:42:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:42:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:42:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:42:40 INFO - (blobuploader) - INFO - Done attempting. 03:42:40 INFO - (blobuploader) - INFO - Iteration through files over. 03:42:40 INFO - Return code: 0 03:42:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:42:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:42:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c352246a3585ded88f1ad948f9ace8d5cab7f3ee0b0355e93e56482e2cf15e61732bcdc4eb8488dcdbf8e86628527a26fff50e6037a4097603b782e2deea9684", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c5ee255470702f9a20d5dc2e7b8403bb05936540a76ffe882e924289188bb1f30de9a793a541fc337265b01af41f3871e8cd501721322703abdd4ed576400eaf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4a6f5a6168c26ae23e0db060520cf00a3a5b7af0bd58df7f403eb5ef20915e8c278ebbf94efe840519dfbf9f5e392fd54d7e05c2f4f86432b4fac82d42383676"} 03:42:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:42:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:42:40 INFO - Contents: 03:42:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c352246a3585ded88f1ad948f9ace8d5cab7f3ee0b0355e93e56482e2cf15e61732bcdc4eb8488dcdbf8e86628527a26fff50e6037a4097603b782e2deea9684", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c5ee255470702f9a20d5dc2e7b8403bb05936540a76ffe882e924289188bb1f30de9a793a541fc337265b01af41f3871e8cd501721322703abdd4ed576400eaf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4a6f5a6168c26ae23e0db060520cf00a3a5b7af0bd58df7f403eb5ef20915e8c278ebbf94efe840519dfbf9f5e392fd54d7e05c2f4f86432b4fac82d42383676"} 03:42:40 INFO - Running post-run listener: copy_logs_to_upload_dir 03:42:40 INFO - Copying logs to upload dir... 03:42:40 INFO - mkdir: /builds/slave/test/build/upload/logs 03:42:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.190698 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-04 03:42:40.585176) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 03:42:40.588862) ========= 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=af724c981e2a0f424dbabf99000001e7-1470304095.281387-939844424 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/c352246a3585ded88f1ad948f9ace8d5cab7f3ee0b0355e93e56482e2cf15e61732bcdc4eb8488dcdbf8e86628527a26fff50e6037a4097603b782e2deea9684", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c5ee255470702f9a20d5dc2e7b8403bb05936540a76ffe882e924289188bb1f30de9a793a541fc337265b01af41f3871e8cd501721322703abdd4ed576400eaf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4a6f5a6168c26ae23e0db060520cf00a3a5b7af0bd58df7f403eb5ef20915e8c278ebbf94efe840519dfbf9f5e392fd54d7e05c2f4f86432b4fac82d42383676"} build_url:https://queue.taskcluster.net/v1/task/OijUhQ4CSPe7nhJNWYhNuw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011417 build_url: 'https://queue.taskcluster.net/v1/task/OijUhQ4CSPe7nhJNWYhNuw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c352246a3585ded88f1ad948f9ace8d5cab7f3ee0b0355e93e56482e2cf15e61732bcdc4eb8488dcdbf8e86628527a26fff50e6037a4097603b782e2deea9684", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c5ee255470702f9a20d5dc2e7b8403bb05936540a76ffe882e924289188bb1f30de9a793a541fc337265b01af41f3871e8cd501721322703abdd4ed576400eaf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4a6f5a6168c26ae23e0db060520cf00a3a5b7af0bd58df7f403eb5ef20915e8c278ebbf94efe840519dfbf9f5e392fd54d7e05c2f4f86432b4fac82d42383676"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 03:42:40.614969) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 03:42:40.615348) ========= 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=af724c981e2a0f424dbabf99000001e7-1470304095.281387-939844424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004523 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 03:42:40.698099) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 03:42:40.698423) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 03:42:40.698722) ========= ========= Total master_lag: 0.17 =========