builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-065 starttime: 1469621635.94 results: success (0) buildid: 20160727032116 builduid: 22f92290f4aa4c6285de1d955a16ee48 revision: c1b0512e0b7b7260df1dd37d6607aefaec450c60 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 05:13:55.936756) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 05:13:55.937399) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 05:13:55.937839) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 05:13:55.955558) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 05:13:55.955873) ========= 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=523ca41ca1e0623de333ad52000001bf-1469621635.294678-1357436416 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-27 05:13:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.5M=0s 2016-07-27 05:13:56 (42.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099774 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 05:13:56.070414) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 05:13:56.070782) ========= 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=523ca41ca1e0623de333ad52000001bf-1469621635.294678-1357436416 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021168 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 05:13:56.121001) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-27 05:13:56.121398) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev c1b0512e0b7b7260df1dd37d6607aefaec450c60 --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 c1b0512e0b7b7260df1dd37d6607aefaec450c60 --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=523ca41ca1e0623de333ad52000001bf-1469621635.294678-1357436416 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-27 05:13:56,208 truncating revision to first 12 chars 2016-07-27 05:13:56,208 Setting DEBUG logging. 2016-07-27 05:13:56,208 attempt 1/10 2016-07-27 05:13:56,208 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/c1b0512e0b7b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-27 05:13:57,219 unpacking tar archive at: autoland-c1b0512e0b7b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.436032 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-27 05:13:57.572194) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 05:13:57.572551) ========= script_repo_revision: c1b0512e0b7b7260df1dd37d6607aefaec450c60 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 05:13:57.573006) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 05:13:57.573333) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 05:13:57.583441) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 38 secs) (at 2016-07-27 05:13:57.583774) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1469621635.294678-1357436416 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:13:57 INFO - MultiFileLogger online at 20160727 05:13:57 in /builds/slave/test 05:13:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 05:13:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:13:57 INFO - {'append_to_log': False, 05:13:57 INFO - 'base_work_dir': '/builds/slave/test', 05:13:57 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 05:13:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:13:57 INFO - 'branch': 'Autoland-Non-PGO', 05:13:57 INFO - 'buildbot_json_path': 'buildprops.json', 05:13:57 INFO - 'config_files': ('talos/linux_config.py',), 05:13:57 INFO - 'default_actions': ('clobber', 05:13:57 INFO - 'read-buildbot-config', 05:13:57 INFO - 'download-and-extract', 05:13:57 INFO - 'populate-webroot', 05:13:57 INFO - 'create-virtualenv', 05:13:57 INFO - 'install', 05:13:57 INFO - 'run-tests'), 05:13:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:13:57 INFO - 'download_minidump_stackwalk': True, 05:13:57 INFO - 'download_symbols': 'ondemand', 05:13:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:13:57 INFO - 'tooltool.py': '/tools/tooltool.py', 05:13:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:13:57 INFO - '/tools/misc-python/virtualenv.py')}, 05:13:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:13:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:13:57 INFO - 'installer_path': 'installer.exe', 05:13:57 INFO - 'log_level': 'info', 05:13:57 INFO - 'log_name': 'talos', 05:13:57 INFO - 'log_to_console': True, 05:13:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:13:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:13:57 INFO - 'opt_config_files': (), 05:13:57 INFO - 'pip_index': False, 05:13:57 INFO - 'sps_profile': False, 05:13:57 INFO - 'sps_profile_interval': 0, 05:13:57 INFO - 'suite': 'dromaeojs-e10s', 05:13:57 INFO - 'system_bits': '32', 05:13:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:13:57 INFO - 'title': 'talos-linux64-ix-065', 05:13:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:13:57 INFO - 'use_talos_json': True, 05:13:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:13:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:13:57 INFO - 'work_dir': 'build'} 05:13:57 INFO - [mozharness: 2016-07-27 12:13:57.761986Z] Running clobber step. 05:13:57 INFO - Running pre-action listener: _resource_record_pre_action 05:13:57 INFO - Running main action method: clobber 05:13:57 INFO - rmtree: /builds/slave/test/build 05:13:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:13:58 INFO - Running post-action listener: _resource_record_post_action 05:13:58 INFO - [mozharness: 2016-07-27 12:13:58.227983Z] Finished clobber step (success) 05:13:58 INFO - [mozharness: 2016-07-27 12:13:58.228085Z] Running read-buildbot-config step. 05:13:58 INFO - Running pre-action listener: _resource_record_pre_action 05:13:58 INFO - Running main action method: read_buildbot_config 05:13:58 INFO - Using buildbot properties: 05:13:58 INFO - { 05:13:58 INFO - "project": "", 05:13:58 INFO - "product": "firefox", 05:13:58 INFO - "script_repo_revision": "production", 05:13:58 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 05:13:58 INFO - "repository": "", 05:13:58 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 05:13:58 INFO - "buildid": "20160727032116", 05:13:58 INFO - "pgo_build": "False", 05:13:58 INFO - "basedir": "/builds/slave/test", 05:13:58 INFO - "buildnumber": 153, 05:13:58 INFO - "slavename": "talos-linux64-ix-065", 05:13:58 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:13:58 INFO - "platform": "ubuntu64_hw", 05:13:58 INFO - "scheduler": "tests-autoland-linux64-talos", 05:13:58 INFO - "branch": "autoland", 05:13:58 INFO - "repo_path": "integration/autoland", 05:13:58 INFO - "revision": "c1b0512e0b7b7260df1dd37d6607aefaec450c60", 05:13:58 INFO - "stage_platform": "linux64", 05:13:58 INFO - "builduid": "22f92290f4aa4c6285de1d955a16ee48", 05:13:58 INFO - "slavebuilddir": "test" 05:13:58 INFO - } 05:13:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/HxW2M4-MQ0KpyWfD7eYyew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:13:58 INFO - Running post-action listener: _resource_record_post_action 05:13:58 INFO - [mozharness: 2016-07-27 12:13:58.230559Z] Finished read-buildbot-config step (success) 05:13:58 INFO - [mozharness: 2016-07-27 12:13:58.230648Z] Running download-and-extract step. 05:13:58 INFO - Running pre-action listener: _resource_record_pre_action 05:13:58 INFO - Running main action method: download_and_extract 05:13:58 INFO - mkdir: /builds/slave/test/build/tests 05:13:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:58 INFO - https://queue.taskcluster.net/v1/task/HxW2M4-MQ0KpyWfD7eYyew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:13:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HxW2M4-MQ0KpyWfD7eYyew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:13:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HxW2M4-MQ0KpyWfD7eYyew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:13:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HxW2M4-MQ0KpyWfD7eYyew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:13:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HxW2M4-MQ0KpyWfD7eYyew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:13:58 INFO - Downloaded 1361 bytes. 05:13:58 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:13:58 INFO - Using the following test package requirements: 05:13:58 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:13:58 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:13:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:13:58 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:13:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:13:58 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:13:58 INFO - u'jsshell-linux-x86_64.zip'], 05:13:58 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:13:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:13:58 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:13:58 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:13:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:13:58 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:13:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:13:58 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:13:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:13:58 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:13:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:13:58 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:13:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:58 INFO - https://queue.taskcluster.net/v1/task/HxW2M4-MQ0KpyWfD7eYyew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:13:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HxW2M4-MQ0KpyWfD7eYyew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:13:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HxW2M4-MQ0KpyWfD7eYyew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:13:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HxW2M4-MQ0KpyWfD7eYyew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:13:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HxW2M4-MQ0KpyWfD7eYyew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:14:30 WARNING - Socket error when accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HxW2M4-MQ0KpyWfD7eYyew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip: The read operation timed out 05:14:30 INFO - retry: attempt #1 caught exception: The read operation timed out 05:14:30 INFO - retry: Failed, sleeping 30 seconds before retrying 05:15:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HxW2M4-MQ0KpyWfD7eYyew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #2 05:15:01 INFO - Downloaded 22744791 bytes. 05:15:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:15:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:15:02 INFO - Return code: 0 05:15:02 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:15:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:02 INFO - https://queue.taskcluster.net/v1/task/HxW2M4-MQ0KpyWfD7eYyew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:15:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HxW2M4-MQ0KpyWfD7eYyew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:15:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HxW2M4-MQ0KpyWfD7eYyew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:15:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HxW2M4-MQ0KpyWfD7eYyew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:15:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HxW2M4-MQ0KpyWfD7eYyew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:15:03 INFO - Downloaded 22744791 bytes. 05:15:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:15:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:15:05 INFO - Return code: 0 05:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:05 INFO - https://queue.taskcluster.net/v1/task/HxW2M4-MQ0KpyWfD7eYyew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:15:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HxW2M4-MQ0KpyWfD7eYyew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:15:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HxW2M4-MQ0KpyWfD7eYyew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:15:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HxW2M4-MQ0KpyWfD7eYyew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:15:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HxW2M4-MQ0KpyWfD7eYyew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:15:06 INFO - Downloaded 14413725 bytes. 05:15:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:15:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:15:06 INFO - Return code: 0 05:15: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')]} 05:15:06 INFO - https://queue.taskcluster.net/v1/task/HxW2M4-MQ0KpyWfD7eYyew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:15:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HxW2M4-MQ0KpyWfD7eYyew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:15:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HxW2M4-MQ0KpyWfD7eYyew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:15:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HxW2M4-MQ0KpyWfD7eYyew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:15:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HxW2M4-MQ0KpyWfD7eYyew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:15:07 INFO - Downloaded 57174145 bytes. 05:15:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HxW2M4-MQ0KpyWfD7eYyew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:15:07 INFO - mkdir: /builds/slave/test/properties 05:15:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:15:07 INFO - Writing to file /builds/slave/test/properties/build_url 05:15:07 INFO - Contents: 05:15:07 INFO - build_url:https://queue.taskcluster.net/v1/task/HxW2M4-MQ0KpyWfD7eYyew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:15:08 INFO - Running post-action listener: _resource_record_post_action 05:15:08 INFO - Running post-action listener: set_extra_try_arguments 05:15:08 INFO - [mozharness: 2016-07-27 12:15:08.134639Z] Finished download-and-extract step (success) 05:15:08 INFO - [mozharness: 2016-07-27 12:15:08.134873Z] Running populate-webroot step. 05:15:08 INFO - Running pre-action listener: _resource_record_pre_action 05:15:08 INFO - Running main action method: populate_webroot 05:15:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:15:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:15:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:15:08 INFO - '--tppagecycles', 05:15:08 INFO - '7'], 05:15:08 INFO - 'tests': ['tsvgm']}}, 05:15:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:15:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:15:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:15:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:15:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:15:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:15:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:08 INFO - 'talos_options': ['--disable-e10s'], 05:15:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:15:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:15:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:08 INFO - 'talos_options': ['--disable-e10s'], 05:15:08 INFO - 'tests': ['damp', 'tps']}, 05:15:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:08 INFO - 'tests': ['damp', 'tps']}, 05:15:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:15:08 INFO - 'tests': ['dromaeo_dom']}, 05:15:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:15:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:15:08 INFO - 'tests': ['basic_compositor_video']}, 05:15:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:15:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:15:08 INFO - 'tests': ['a11yr', 05:15:08 INFO - 'ts_paint', 05:15:08 INFO - 'tpaint', 05:15:08 INFO - 'sessionrestore', 05:15:08 INFO - 'sessionrestore_no_auto_restore', 05:15:08 INFO - 'tabpaint']}, 05:15:08 INFO - 'other-e10s': {'tests': ['a11yr', 05:15:08 INFO - 'ts_paint', 05:15:08 INFO - 'tpaint', 05:15:08 INFO - 'sessionrestore', 05:15:08 INFO - 'sessionrestore_no_auto_restore', 05:15:08 INFO - 'tabpaint']}, 05:15:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:15:08 INFO - 'ts_paint', 05:15:08 INFO - 'tpaint', 05:15:08 INFO - 'sessionrestore', 05:15:08 INFO - 'sessionrestore_no_auto_restore', 05:15:08 INFO - 'tabpaint']}, 05:15:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:15:08 INFO - 'ts_paint', 05:15:08 INFO - 'tpaint', 05:15:08 INFO - 'sessionrestore', 05:15:08 INFO - 'sessionrestore_no_auto_restore', 05:15:08 INFO - 'tabpaint']}, 05:15:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:15:08 INFO - 'tests': ['a11yr', 05:15:08 INFO - 'ts_paint', 05:15:08 INFO - 'tpaint', 05:15:08 INFO - 'sessionrestore', 05:15:08 INFO - 'sessionrestore_no_auto_restore', 05:15:08 INFO - 'tabpaint']}, 05:15:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:15:08 INFO - 'tests': ['a11yr', 05:15:08 INFO - 'ts_paint', 05:15:08 INFO - 'tpaint', 05:15:08 INFO - 'sessionrestore', 05:15:08 INFO - 'sessionrestore_no_auto_restore', 05:15:08 INFO - 'tabpaint']}, 05:15:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:15:08 INFO - 'tests': ['tsvgx', 05:15:08 INFO - 'tsvgr_opacity', 05:15:08 INFO - 'tart', 05:15:08 INFO - 'tscrollx', 05:15:08 INFO - 'cart']}, 05:15:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:15:08 INFO - 'tsvgr_opacity', 05:15:08 INFO - 'tart', 05:15:08 INFO - 'tscrollx', 05:15:08 INFO - 'cart']}, 05:15:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:08 INFO - 'talos_options': ['--disable-e10s'], 05:15:08 INFO - 'tests': ['tp5o']}, 05:15:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:08 INFO - 'tests': ['tp5o']}, 05:15:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:08 INFO - 'talos_options': ['--disable-e10s', 05:15:08 INFO - '--xperf_path', 05:15:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:15:08 INFO - 'tests': ['tp5n']}, 05:15:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:08 INFO - 'talos_options': ['--xperf_path', 05:15:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:15:08 INFO - 'tests': ['tp5n']}}, 05:15:08 INFO - 'talos.zip': {'path': '', 05:15:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:15:08 INFO - Running post-action listener: _resource_record_post_action 05:15:08 INFO - [mozharness: 2016-07-27 12:15:08.157559Z] Finished populate-webroot step (success) 05:15:08 INFO - [mozharness: 2016-07-27 12:15:08.157648Z] Running create-virtualenv step. 05:15:08 INFO - Running pre-action listener: _resource_record_pre_action 05:15:08 INFO - Running main action method: create_virtualenv 05:15:08 INFO - Creating virtualenv /builds/slave/test/build/venv 05:15:08 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:15:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:15:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:15:08 INFO - Using real prefix '/usr' 05:15:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:15:08 INFO - Installing distribute.............................................................................................................................................................................................done. 05:15:10 INFO - Installing pip.................done. 05:15:10 INFO - Return code: 0 05:15:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:15:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:10 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 0x1e52030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2081400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2110570>, '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 0x2111470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2111900>, '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': '523ca41ca1e0623de333ad52000001bf-1469621635.294678-1357436416', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:15:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:15:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:15:10 INFO - Using env: {'DISPLAY': ':0', 05:15:10 INFO - 'HOME': '/home/cltbld', 05:15:10 INFO - 'LANG': 'en_US.UTF-8', 05:15:10 INFO - 'LANGUAGE': 'en_US:en', 05:15:10 INFO - 'LOGNAME': 'cltbld', 05:15:10 INFO - 'MAIL': '/var/mail/cltbld', 05:15:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:10 INFO - 'MOZ_NO_REMOTE': '1', 05:15:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:10 INFO - 'NO_EM_RESTART': '1', 05:15:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:10 INFO - 'PWD': '/builds/slave/test', 05:15:10 INFO - 'SHELL': '/bin/bash', 05:15:10 INFO - 'SHLVL': '1', 05:15:10 INFO - 'TERM': 'linux', 05:15:10 INFO - 'TMOUT': '86400', 05:15:10 INFO - 'USER': 'cltbld', 05:15:10 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469621635.294678-1357436416', 05:15:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:10 INFO - '_': '/tools/buildbot/bin/python'} 05:15:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:15:10 INFO - Cleaning up... 05:15:10 INFO - Return code: 0 05:15:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:15:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:10 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 0x1e52030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2081400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2110570>, '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 0x2111470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2111900>, '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': '523ca41ca1e0623de333ad52000001bf-1469621635.294678-1357436416', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:15:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:15:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:15:10 INFO - Using env: {'DISPLAY': ':0', 05:15:10 INFO - 'HOME': '/home/cltbld', 05:15:10 INFO - 'LANG': 'en_US.UTF-8', 05:15:10 INFO - 'LANGUAGE': 'en_US:en', 05:15:10 INFO - 'LOGNAME': 'cltbld', 05:15:10 INFO - 'MAIL': '/var/mail/cltbld', 05:15:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:10 INFO - 'MOZ_NO_REMOTE': '1', 05:15:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:10 INFO - 'NO_EM_RESTART': '1', 05:15:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:10 INFO - 'PWD': '/builds/slave/test', 05:15:10 INFO - 'SHELL': '/bin/bash', 05:15:10 INFO - 'SHLVL': '1', 05:15:10 INFO - 'TERM': 'linux', 05:15:10 INFO - 'TMOUT': '86400', 05:15:10 INFO - 'USER': 'cltbld', 05:15:10 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469621635.294678-1357436416', 05:15:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:10 INFO - '_': '/tools/buildbot/bin/python'} 05:15:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:11 INFO - Downloading/unpacking psutil>=3.1.1 05:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:15:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:15:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:15:13 INFO - Installing collected packages: psutil 05:15:13 INFO - Running setup.py install for psutil 05:15:13 INFO - building 'psutil._psutil_linux' extension 05:15:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:15:13 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:15:13 INFO - building 'psutil._psutil_posix' extension 05:15:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:15:13 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:15:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:15:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:15:13 INFO - Successfully installed psutil 05:15:13 INFO - Cleaning up... 05:15:13 INFO - Return code: 0 05:15:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:15:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:13 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 0x1e52030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2081400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2110570>, '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 0x2111470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2111900>, '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': '523ca41ca1e0623de333ad52000001bf-1469621635.294678-1357436416', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:15:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:15:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:15:13 INFO - Using env: {'DISPLAY': ':0', 05:15:13 INFO - 'HOME': '/home/cltbld', 05:15:13 INFO - 'LANG': 'en_US.UTF-8', 05:15:13 INFO - 'LANGUAGE': 'en_US:en', 05:15:13 INFO - 'LOGNAME': 'cltbld', 05:15:13 INFO - 'MAIL': '/var/mail/cltbld', 05:15:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:13 INFO - 'MOZ_NO_REMOTE': '1', 05:15:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:13 INFO - 'NO_EM_RESTART': '1', 05:15:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:13 INFO - 'PWD': '/builds/slave/test', 05:15:13 INFO - 'SHELL': '/bin/bash', 05:15:13 INFO - 'SHLVL': '1', 05:15:13 INFO - 'TERM': 'linux', 05:15:13 INFO - 'TMOUT': '86400', 05:15:13 INFO - 'USER': 'cltbld', 05:15:13 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469621635.294678-1357436416', 05:15:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:13 INFO - '_': '/tools/buildbot/bin/python'} 05:15:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:15:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:15:15 INFO - Installing collected packages: mozsystemmonitor 05:15:15 INFO - Running setup.py install for mozsystemmonitor 05:15:16 INFO - Successfully installed mozsystemmonitor 05:15:16 INFO - Cleaning up... 05:15:16 INFO - Return code: 0 05:15:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:15:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1e52030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2081400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2110570>, '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 0x2111470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2111900>, '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': '523ca41ca1e0623de333ad52000001bf-1469621635.294678-1357436416', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:15:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:15:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:15:16 INFO - Using env: {'DISPLAY': ':0', 05:15:16 INFO - 'HOME': '/home/cltbld', 05:15:16 INFO - 'LANG': 'en_US.UTF-8', 05:15:16 INFO - 'LANGUAGE': 'en_US:en', 05:15:16 INFO - 'LOGNAME': 'cltbld', 05:15:16 INFO - 'MAIL': '/var/mail/cltbld', 05:15:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:16 INFO - 'MOZ_NO_REMOTE': '1', 05:15:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:16 INFO - 'NO_EM_RESTART': '1', 05:15:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:16 INFO - 'PWD': '/builds/slave/test', 05:15:16 INFO - 'SHELL': '/bin/bash', 05:15:16 INFO - 'SHLVL': '1', 05:15:16 INFO - 'TERM': 'linux', 05:15:16 INFO - 'TMOUT': '86400', 05:15:16 INFO - 'USER': 'cltbld', 05:15:16 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469621635.294678-1357436416', 05:15:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:16 INFO - '_': '/tools/buildbot/bin/python'} 05:15:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:16 INFO - Downloading/unpacking jsonschema==2.5.1 05:15:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:15:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:18 INFO - Downloading functools32-3.2.3-2.tar.gz 05:15:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:15:18 INFO - warning: no files found matching '*.txt' 05:15:18 INFO - no previously-included directories found matching 'build' 05:15:18 INFO - no previously-included directories found matching 'dist' 05:15:18 INFO - no previously-included directories found matching '.git*' 05:15:18 INFO - Installing collected packages: jsonschema, functools32 05:15:18 INFO - Running setup.py install for functools32 05:15:18 INFO - warning: no files found matching '*.txt' 05:15:18 INFO - no previously-included directories found matching 'build' 05:15:18 INFO - no previously-included directories found matching 'dist' 05:15:18 INFO - no previously-included directories found matching '.git*' 05:15:18 INFO - Successfully installed jsonschema functools32 05:15:18 INFO - Cleaning up... 05:15:18 INFO - Return code: 0 05:15:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:15:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1e52030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2081400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2110570>, '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 0x2111470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2111900>, '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': '523ca41ca1e0623de333ad52000001bf-1469621635.294678-1357436416', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:15:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:15:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:15:18 INFO - Using env: {'DISPLAY': ':0', 05:15:18 INFO - 'HOME': '/home/cltbld', 05:15:18 INFO - 'LANG': 'en_US.UTF-8', 05:15:18 INFO - 'LANGUAGE': 'en_US:en', 05:15:18 INFO - 'LOGNAME': 'cltbld', 05:15:18 INFO - 'MAIL': '/var/mail/cltbld', 05:15:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:18 INFO - 'MOZ_NO_REMOTE': '1', 05:15:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:18 INFO - 'NO_EM_RESTART': '1', 05:15:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:18 INFO - 'PWD': '/builds/slave/test', 05:15:18 INFO - 'SHELL': '/bin/bash', 05:15:18 INFO - 'SHLVL': '1', 05:15:18 INFO - 'TERM': 'linux', 05:15:18 INFO - 'TMOUT': '86400', 05:15:18 INFO - 'USER': 'cltbld', 05:15:18 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469621635.294678-1357436416', 05:15:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:18 INFO - '_': '/tools/buildbot/bin/python'} 05:15:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:15:18 INFO - Cleaning up... 05:15:18 INFO - Return code: 0 05:15:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:15:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1e52030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2081400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2110570>, '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 0x2111470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2111900>, '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': '523ca41ca1e0623de333ad52000001bf-1469621635.294678-1357436416', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:15:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:15:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:15:18 INFO - Using env: {'DISPLAY': ':0', 05:15:18 INFO - 'HOME': '/home/cltbld', 05:15:18 INFO - 'LANG': 'en_US.UTF-8', 05:15:18 INFO - 'LANGUAGE': 'en_US:en', 05:15:18 INFO - 'LOGNAME': 'cltbld', 05:15:18 INFO - 'MAIL': '/var/mail/cltbld', 05:15:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:18 INFO - 'MOZ_NO_REMOTE': '1', 05:15:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:18 INFO - 'NO_EM_RESTART': '1', 05:15:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:18 INFO - 'PWD': '/builds/slave/test', 05:15:18 INFO - 'SHELL': '/bin/bash', 05:15:18 INFO - 'SHLVL': '1', 05:15:18 INFO - 'TERM': 'linux', 05:15:18 INFO - 'TMOUT': '86400', 05:15:18 INFO - 'USER': 'cltbld', 05:15:18 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469621635.294678-1357436416', 05:15:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:18 INFO - '_': '/tools/buildbot/bin/python'} 05:15:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:19 INFO - Downloading/unpacking blobuploader==1.2.4 05:15:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:21 INFO - Downloading blobuploader-1.2.4.tar.gz 05:15:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:15:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:15:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:15:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:15:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:21 INFO - Downloading docopt-0.6.1.tar.gz 05:15:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:15:21 INFO - Installing collected packages: blobuploader, requests, docopt 05:15:21 INFO - Running setup.py install for blobuploader 05:15:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:15:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:15:21 INFO - Running setup.py install for requests 05:15:22 INFO - Running setup.py install for docopt 05:15:22 INFO - Successfully installed blobuploader requests docopt 05:15:22 INFO - Cleaning up... 05:15:22 INFO - Return code: 0 05:15:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:15:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:22 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 0x1e52030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2081400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2110570>, '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 0x2111470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2111900>, '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': '523ca41ca1e0623de333ad52000001bf-1469621635.294678-1357436416', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:15:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:15:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:15:22 INFO - Using env: {'DISPLAY': ':0', 05:15:22 INFO - 'HOME': '/home/cltbld', 05:15:22 INFO - 'LANG': 'en_US.UTF-8', 05:15:22 INFO - 'LANGUAGE': 'en_US:en', 05:15:22 INFO - 'LOGNAME': 'cltbld', 05:15:22 INFO - 'MAIL': '/var/mail/cltbld', 05:15:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:22 INFO - 'MOZ_NO_REMOTE': '1', 05:15:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:22 INFO - 'NO_EM_RESTART': '1', 05:15:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:22 INFO - 'PWD': '/builds/slave/test', 05:15:22 INFO - 'SHELL': '/bin/bash', 05:15:22 INFO - 'SHLVL': '1', 05:15:22 INFO - 'TERM': 'linux', 05:15:22 INFO - 'TMOUT': '86400', 05:15:22 INFO - 'USER': 'cltbld', 05:15:22 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469621635.294678-1357436416', 05:15:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:22 INFO - '_': '/tools/buildbot/bin/python'} 05:15:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:15:22 INFO - Running setup.py (path:/tmp/pip-2rwEvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:15:22 INFO - Running setup.py (path:/tmp/pip-0LQOM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:15:22 INFO - Running setup.py (path:/tmp/pip-cY9fZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:15:22 INFO - Running setup.py (path:/tmp/pip-bszahU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:15:22 INFO - Running setup.py (path:/tmp/pip-xATQX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:15:22 INFO - Running setup.py (path:/tmp/pip-9G6_j9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:15:23 INFO - Running setup.py (path:/tmp/pip-ZAtO1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:15:23 INFO - Running setup.py (path:/tmp/pip-mhaOLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:15:23 INFO - Running setup.py (path:/tmp/pip-yrZmFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:15:23 INFO - Running setup.py (path:/tmp/pip-SlUJWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:15:23 INFO - Running setup.py (path:/tmp/pip-_XZWFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:15:23 INFO - Running setup.py (path:/tmp/pip-VYl_0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:15:23 INFO - Running setup.py (path:/tmp/pip-5Tlhts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:15:23 INFO - Running setup.py (path:/tmp/pip-rXXrdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:23 INFO - Running setup.py (path:/tmp/pip-AEYN48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:15:23 INFO - Running setup.py (path:/tmp/pip-pJTHg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:15:23 INFO - Running setup.py (path:/tmp/pip-y6bAaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:15:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:15:23 INFO - Running setup.py install for manifestparser 05:15:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:15:23 INFO - Running setup.py install for mozcrash 05:15:24 INFO - Running setup.py install for mozdebug 05:15:24 INFO - Running setup.py install for mozdevice 05:15:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:15:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:15:24 INFO - Running setup.py install for mozfile 05:15:24 INFO - Running setup.py install for mozhttpd 05:15:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:15:24 INFO - Running setup.py install for mozinfo 05:15:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:15:24 INFO - Running setup.py install for mozInstall 05:15:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:15:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:15:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:15:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:15:24 INFO - Running setup.py install for mozleak 05:15:24 INFO - Running setup.py install for mozlog 05:15:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:15:24 INFO - Running setup.py install for moznetwork 05:15:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:15:24 INFO - Running setup.py install for mozprocess 05:15:25 INFO - Running setup.py install for mozprofile 05:15:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:15:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:15:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:15:25 INFO - Running setup.py install for mozrunner 05:15:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:15:25 INFO - Running setup.py install for mozscreenshot 05:15:25 INFO - Running setup.py install for moztest 05:15:25 INFO - Running setup.py install for mozversion 05:15:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:15:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:15:25 INFO - Cleaning up... 05:15:25 INFO - Return code: 0 05:15:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:15:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:25 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 0x1e52030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2081400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2110570>, '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 0x2111470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2111900>, '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': '523ca41ca1e0623de333ad52000001bf-1469621635.294678-1357436416', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:15:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:15:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:15:25 INFO - Using env: {'DISPLAY': ':0', 05:15:25 INFO - 'HOME': '/home/cltbld', 05:15:25 INFO - 'LANG': 'en_US.UTF-8', 05:15:25 INFO - 'LANGUAGE': 'en_US:en', 05:15:25 INFO - 'LOGNAME': 'cltbld', 05:15:25 INFO - 'MAIL': '/var/mail/cltbld', 05:15:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:25 INFO - 'MOZ_NO_REMOTE': '1', 05:15:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:25 INFO - 'NO_EM_RESTART': '1', 05:15:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:25 INFO - 'PWD': '/builds/slave/test', 05:15:25 INFO - 'SHELL': '/bin/bash', 05:15:25 INFO - 'SHLVL': '1', 05:15:25 INFO - 'TERM': 'linux', 05:15:25 INFO - 'TMOUT': '86400', 05:15:25 INFO - 'USER': 'cltbld', 05:15:25 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469621635.294678-1357436416', 05:15:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:25 INFO - '_': '/tools/buildbot/bin/python'} 05:15:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:15:25 INFO - Running setup.py (path:/tmp/pip-s9zjmh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:15:25 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:15:25 INFO - Running setup.py (path:/tmp/pip-6FRXVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:15:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:15:26 INFO - Running setup.py (path:/tmp/pip-0_VZTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:15:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:15:26 INFO - Running setup.py (path:/tmp/pip-JRN57B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:15:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:15:26 INFO - Running setup.py (path:/tmp/pip-33haqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:15:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:15:26 INFO - Running setup.py (path:/tmp/pip-GtCpk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:15:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:15:26 INFO - Running setup.py (path:/tmp/pip-DJejv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:15:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:15:26 INFO - Running setup.py (path:/tmp/pip-OdtYHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:15:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:15:26 INFO - Running setup.py (path:/tmp/pip-aQqVU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:15:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:15:26 INFO - Running setup.py (path:/tmp/pip-UKTkPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:15:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:15:26 INFO - Running setup.py (path:/tmp/pip-vrUcNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:15:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:15:26 INFO - Running setup.py (path:/tmp/pip-6Ua7PM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:15:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:15:26 INFO - Running setup.py (path:/tmp/pip-70lzTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:15:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:15:26 INFO - Running setup.py (path:/tmp/pip-N37Bcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:15:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:26 INFO - Running setup.py (path:/tmp/pip-0GIQ5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:15:26 INFO - Running setup.py (path:/tmp/pip-8w1bPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:15:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:15:27 INFO - Running setup.py (path:/tmp/pip-Ual1OI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:15:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:15:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:15:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:15:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:15:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:15:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:15:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:15:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:29 INFO - Downloading blessings-1.6.tar.gz 05:15:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:15:29 INFO - Installing collected packages: blessings 05:15:29 INFO - Running setup.py install for blessings 05:15:29 INFO - Successfully installed blessings 05:15:29 INFO - Cleaning up... 05:15:29 INFO - Return code: 0 05:15:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:15:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:15:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:15:29 INFO - Reading from file tmpfile_stdout 05:15:29 INFO - Current package versions: 05:15:29 INFO - argparse == 1.2.1 05:15:29 INFO - blessings == 1.6 05:15:29 INFO - blobuploader == 1.2.4 05:15:29 INFO - docopt == 0.6.1 05:15:29 INFO - functools32 == 3.2.3-2 05:15:29 INFO - jsonschema == 2.5.1 05:15:29 INFO - manifestparser == 1.1 05:15:29 INFO - mozInstall == 1.12 05:15:29 INFO - mozcrash == 0.17 05:15:29 INFO - mozdebug == 0.1 05:15:29 INFO - mozdevice == 0.48 05:15:29 INFO - mozfile == 1.2 05:15:29 INFO - mozhttpd == 0.7 05:15:29 INFO - mozinfo == 0.9 05:15:29 INFO - mozleak == 0.1 05:15:29 INFO - mozlog == 3.3 05:15:29 INFO - moznetwork == 0.27 05:15:29 INFO - mozprocess == 0.23 05:15:29 INFO - mozprofile == 0.28 05:15:29 INFO - mozrunner == 6.12 05:15:29 INFO - mozscreenshot == 0.1 05:15:29 INFO - mozsystemmonitor == 0.3 05:15:29 INFO - moztest == 0.7 05:15:29 INFO - mozversion == 1.4 05:15:29 INFO - psutil == 3.1.1 05:15:29 INFO - requests == 1.2.3 05:15:29 INFO - wsgiref == 0.1.2 05:15:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:15:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:29 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 0x1e52030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2081400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2110570>, '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 0x2111470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2111900>, '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': '523ca41ca1e0623de333ad52000001bf-1469621635.294678-1357436416', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:15:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:15:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:15:29 INFO - Using env: {'DISPLAY': ':0', 05:15:29 INFO - 'HOME': '/home/cltbld', 05:15:29 INFO - 'LANG': 'en_US.UTF-8', 05:15:29 INFO - 'LANGUAGE': 'en_US:en', 05:15:29 INFO - 'LOGNAME': 'cltbld', 05:15:29 INFO - 'MAIL': '/var/mail/cltbld', 05:15:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:29 INFO - 'MOZ_NO_REMOTE': '1', 05:15:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:29 INFO - 'NO_EM_RESTART': '1', 05:15:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:29 INFO - 'PWD': '/builds/slave/test', 05:15:29 INFO - 'SHELL': '/bin/bash', 05:15:29 INFO - 'SHLVL': '1', 05:15:29 INFO - 'TERM': 'linux', 05:15:29 INFO - 'TMOUT': '86400', 05:15:29 INFO - 'USER': 'cltbld', 05:15:29 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469621635.294678-1357436416', 05:15:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:29 INFO - '_': '/tools/buildbot/bin/python'} 05:15:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:15:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:15:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:15:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:15:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:15:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:15:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:15:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:15:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:15:29 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:15:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:15:29 INFO - Cleaning up... 05:15:29 INFO - Return code: 0 05:15:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:15:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:29 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 0x1e52030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2081400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2110570>, '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 0x2111470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2111900>, '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': '523ca41ca1e0623de333ad52000001bf-1469621635.294678-1357436416', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:15:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:15:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:15:29 INFO - Using env: {'DISPLAY': ':0', 05:15:29 INFO - 'HOME': '/home/cltbld', 05:15:29 INFO - 'LANG': 'en_US.UTF-8', 05:15:29 INFO - 'LANGUAGE': 'en_US:en', 05:15:29 INFO - 'LOGNAME': 'cltbld', 05:15:29 INFO - 'MAIL': '/var/mail/cltbld', 05:15:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:29 INFO - 'MOZ_NO_REMOTE': '1', 05:15:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:29 INFO - 'NO_EM_RESTART': '1', 05:15:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:29 INFO - 'PWD': '/builds/slave/test', 05:15:29 INFO - 'SHELL': '/bin/bash', 05:15:29 INFO - 'SHLVL': '1', 05:15:29 INFO - 'TERM': 'linux', 05:15:29 INFO - 'TMOUT': '86400', 05:15:29 INFO - 'USER': 'cltbld', 05:15:29 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469621635.294678-1357436416', 05:15:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:29 INFO - '_': '/tools/buildbot/bin/python'} 05:15:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:15:30 INFO - Cleaning up... 05:15:30 INFO - Return code: 0 05:15:30 INFO - Running post-action listener: _resource_record_post_action 05:15:30 INFO - Running post-action listener: _start_resource_monitoring 05:15:30 INFO - Starting resource monitoring. 05:15:30 INFO - [mozharness: 2016-07-27 12:15:30.149407Z] Finished create-virtualenv step (success) 05:15:30 INFO - [mozharness: 2016-07-27 12:15:30.150004Z] Running install step. 05:15:30 INFO - Running pre-action listener: _resource_record_pre_action 05:15:30 INFO - Running main action method: install 05:15:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:15:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:15:30 INFO - Reading from file tmpfile_stdout 05:15:30 INFO - Detecting whether we're running mozinstall >=1.0... 05:15:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:15:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:15:30 INFO - Reading from file tmpfile_stdout 05:15:30 INFO - Output received: 05:15:30 INFO - Usage: mozinstall [options] installer 05:15:30 INFO - Options: 05:15:30 INFO - -h, --help show this help message and exit 05:15:30 INFO - -d DEST, --destination=DEST 05:15:30 INFO - Directory to install application into. [default: 05:15:30 INFO - "/builds/slave/test"] 05:15:30 INFO - --app=APP Application being installed. [default: firefox] 05:15:30 INFO - mkdir: /builds/slave/test/build/application 05:15:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:15:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:15:46 INFO - Reading from file tmpfile_stdout 05:15:46 INFO - Output received: 05:15:46 INFO - /builds/slave/test/build/application/firefox/firefox 05:15:46 INFO - Running post-action listener: _resource_record_post_action 05:15:46 INFO - [mozharness: 2016-07-27 12:15:46.839514Z] Finished install step (success) 05:15:46 INFO - [mozharness: 2016-07-27 12:15:46.839789Z] Running run-tests step. 05:15:46 INFO - Running pre-action listener: _resource_record_pre_action 05:15:46 INFO - Running main action method: run_tests 05:15:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:15:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:15:46 INFO - Python 2.7.3 05:15:46 INFO - Return code: 0 05:15:46 INFO - grabbing minidump binary from tooltool 05:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:46 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 0x2110570>, '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 0x2111470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2111900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:15:46 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:15:46 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:15:46 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:15:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:15:46 INFO - Return code: 0 05:15:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:15:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:15:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:15:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:15:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:15:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HxW2M4-MQ0KpyWfD7eYyew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 05:15:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HxW2M4-MQ0KpyWfD7eYyew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --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 05:15:46 INFO - Using env: {'DISPLAY': ':0', 05:15:46 INFO - 'HOME': '/home/cltbld', 05:15:46 INFO - 'LANG': 'en_US.UTF-8', 05:15:46 INFO - 'LANGUAGE': 'en_US:en', 05:15:46 INFO - 'LOGNAME': 'cltbld', 05:15:46 INFO - 'MAIL': '/var/mail/cltbld', 05:15:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:15:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:46 INFO - 'MOZ_NO_REMOTE': '1', 05:15:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:15:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:46 INFO - 'NO_EM_RESTART': '1', 05:15:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:46 INFO - 'PWD': '/builds/slave/test', 05:15:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:15:46 INFO - 'SHELL': '/bin/bash', 05:15:46 INFO - 'SHLVL': '1', 05:15:46 INFO - 'TERM': 'linux', 05:15:46 INFO - 'TMOUT': '86400', 05:15:46 INFO - 'USER': 'cltbld', 05:15:46 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469621635.294678-1357436416', 05:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:46 INFO - '_': '/tools/buildbot/bin/python'} 05:15:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HxW2M4-MQ0KpyWfD7eYyew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 05:15:47 INFO - mozversion application_buildid: 20160727032116 05:15:47 INFO - mozversion application_changeset: c1b0512e0b7b7260df1dd37d6607aefaec450c60 05:15:47 INFO - mozversion application_display_name: Nightly 05:15:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:15:47 INFO - mozversion application_name: Firefox 05:15:47 INFO - mozversion application_remotingname: firefox 05:15:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 05:15:47 INFO - mozversion application_vendor: Mozilla 05:15:47 INFO - mozversion application_version: 50.0a1 05:15:47 INFO - mozversion platform_buildid: 20160727032116 05:15:47 INFO - mozversion platform_changeset: c1b0512e0b7b7260df1dd37d6607aefaec450c60 05:15:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 05:15:47 INFO - mozversion platform_version: 50.0a1 05:15:47 INFO - using testdate: 1469621747 05:15:47 INFO - actual date: 1469621747 05:15:47 INFO - starting webserver on 'localhost:36102' 05:15:47 INFO - SUITE-START | Running 2 tests 05:15:47 INFO - TEST-START | dromaeo_css 05:15:47 INFO - operating with platform_type : linux_ 05:15:47 INFO - Initialising browser for dromaeo_css test... 05:15:47 INFO - TEST-INFO | started process 17311 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWHkElQ/profile http://localhost:36102/getInfo.html) 05:15:50 INFO - PROCESS | 17311 | JavaScript error: , line 0: uncaught exception: undefined 05:15:51 INFO - PROCESS | 17311 | __metrics Screen width/height:1600/1200 05:15:51 INFO - PROCESS | 17311 | colorDepth:24 05:15:51 INFO - PROCESS | 17311 | Browser inner width/height: 1024/697 05:15:51 INFO - PROCESS | 17311 | __metrics 05:15:52 ERROR - PROCESS | 17311 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 05:15:53 INFO - TEST-INFO | 17311: exit 0 05:15:53 INFO - Browser initialized. 05:15:53 INFO - Running cycle 1/1 for dromaeo_css test... 05:15:53 INFO - TEST-INFO | started process 17432 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWHkElQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:16:05 INFO - PROCESS | 17432 | RSS: Main: 166027264 05:16:05 INFO - PROCESS | 17432 | 05:16:55 INFO - PROCESS | 17432 | 1469621815014 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] 05:19:07 INFO - PROCESS | 17432 | Cycle 1(1): loaded http://localhost:36102/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36102/tests/dromaeo/cssquery-ext.html) 05:19:08 INFO - PROCESS | 17432 | RSS: Main: 167976960 05:19:08 INFO - PROCESS | 17432 | 05:22:10 INFO - PROCESS | 17432 | Cycle 1(1): loaded http://localhost:36102/tests/dromaeo/cssquery-ext.html (next: http://localhost:36102/tests/dromaeo/cssquery-jquery.html) 05:22:11 INFO - PROCESS | 17432 | RSS: Main: 167784448 05:22:11 INFO - PROCESS | 17432 | 05:25:13 INFO - PROCESS | 17432 | Cycle 1(1): loaded http://localhost:36102/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36102/tests/dromaeo/cssquery-mootools.html) 05:25:13 INFO - PROCESS | 17432 | RSS: Main: 170643456 05:25:13 INFO - PROCESS | 17432 | 05:28:15 INFO - PROCESS | 17432 | Cycle 1(1): loaded http://localhost:36102/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36102/tests/dromaeo/cssquery-prototype.html) 05:28:16 INFO - PROCESS | 17432 | RSS: Main: 165064704 05:28:16 INFO - PROCESS | 17432 | 05:31:19 INFO - PROCESS | 17432 | Cycle 1(1): loaded http://localhost:36102/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36102/tests/dromaeo/cssquery-yui.html) 05:31:19 INFO - PROCESS | 17432 | RSS: Main: 167809024 05:31:19 INFO - PROCESS | 17432 | 05:34:22 INFO - PROCESS | 17432 | Cycle 1(1): loaded http://localhost:36102/tests/dromaeo/cssquery-yui.html (next: http://localhost:36102/tests/dromaeo/cssquery-dojo.html) 05:34:22 INFO - PROCESS | 17432 | RSS: Main: 171642880 05:34:22 INFO - PROCESS | 17432 | 05:34:22 INFO - PROCESS | 17432 | __start_tp_report 05:34:22 INFO - PROCESS | 17432 | _x_x_mozilla_page_load 05:34:22 INFO - PROCESS | 17432 | _x_x_mozilla_page_load_details 05:34:22 INFO - PROCESS | 17432 | |i|pagename|runs| 05:34:22 INFO - PROCESS | 17432 | |0;dojo.html;2601.700804407493;2610.791136709061;2647.0602935957736;2648.801339899508;2659.521286168489;4561.1105834362315;4657.60410365119;4679.134360143372;4704.317873908281;4713.552212539807;4657.604103651185;4679.883002924928;4723.90552188956;4741.217699079648;4756.143894099061;4282.8501002464845;4348.173846969065;4353.869383918487;4447.666425018137;4474.709143905652;4395.296752519597;4436.711613745112;4472.485664148632;4485.372047913294;4492.213862574053;4215.283401821667;4239.660827133822;4371.256886329332;4382.605565499089;4458.398116254297;4290.806913688892;4292.712186344084;4292.978535107304;4304.978475107604;4375.343698445226;4306.978465107686;4313.051128751669;4326.978365108186;4354.716943398669;4361.345798130305;4619.399478067863;4650.372199753024;4656.068786242731;4694.882627934295;4762.738049407281;4960.751962401865;4970.975145124287;4999.125153098194;5004.324416203803;5005.174146265898;5017.122003649383;5032.949670503284;5041.470645582234;5042.924356134624;5063.063333283354;4558.111168322179;4616.95383046172;4634.2585186370015;4655.441347038377;4751.0022895191705;5059.06407314648;5069.239614057921;5072.594192464668;5082.542571168613;5115.769790359443;4876.780544875489;4884.413870335582;4900.754962251873;4900.975495122501;4919.3604831371695;4821.855344339605;4984.825531106467;5007.073691367109;5022.096022715873;5062.265971434122;5026.045051440215;5034.974825125851;5035.924461133086;5039.722815245197;5053.0904437200925;4985.127602669519;5001.224810154432;5002.59979201663;5009.023240468074;5013.323201367842;4035.970827438984;4116.115035267372;4134.834606615762;4135.462389889355;4252.808623611945;3669.082729317671;3672.265546890633;3683.2265224303196;3690.704743620504;3715.20123173519;4366.410534577792;4469.597736203757;4474.843380481668;4495.595396414338;4512.9323060153465;4909.5090490950615;5022.648414610942;5025.698458092453;5051.646384753106;5074.898502030012;4456.376107344974;4461.933071003938;4466.598006179394;4483.036147228297;4491.932621010687;4484.551544845554;4497.752623605667;4499.955000450019;4505.053938672915;4537.455505339314;4584.862454126382;4730.408698912636;4762.690425122356;4771.95228047715;4783.784729687242;5041.6470847040355;5073.949260507347;5077.644564880423;5086.491350865032;5127.615428842777;4773.284007398918;4779.06808172403;4785.832495862628;4790.808367665254;4808.519148085164;4782;4923.753812309442;4963.354763880672;4979.103761322996;5037.722925239147;5028.094942910165;5057.848264552069;5077.39071311445;5084.034033533617;5134.666246693953;4900.779464924159;4935.777889994887;4937.185364414831;4962.007598480391;4984.152694041949;4723.527647235249;4805.063012712627;4901.975490122527;4911.4106307243355;4941.876453088702;4645.117427688863;4793.880152996203;4826.155422800925;4837.782299796588;4877.9024419512125;4916.237983112624;4939.925901111558;4951.207806750903;4955.058538877602;4994.350734404504;4653.790579424001;4743.928841067318;4798.904021919472;4802.087603355351;4810.6151507878585 05:34:22 INFO - PROCESS | 17432 | |1;ext.html;554.6976897590815;557.8521691751686;572.8224250482351;576.8990426675331;601.9367966363534;37398.62601373986;38406.423903641466;38552.80723596382;38554.421683674766;38554.61445385545;38669.419958700644;39229.80385098071;39251.214975700466;39300.410493842544;39385.60614393855;7548.622568871562;7670.578118203496;7716.729914452995;7727.96136019322;7763.689452421896;7662.233776622321;7754.06951165858;7756.0692716874055;7759.262870027338;7760.573168475732;7643.159252482223;7732;7744.7676569703;7766.883496747553;7780.14418413974;7620.199879012707;7680.039995000625;7712.537247765152;7737.148913619498;7751.496152750054;7622.618869056525;7663.5785031823225;7668.348190403823;7713.730019449293;7729;34797.65202347969;35265.823670881735;35349.646503534896;35377.292454150775;35483.4677479838;2459.717132529764;2676.678798544168;2682.329417645589;2872.6121973533513;2902.201894479014;27387;27448.862755686292;27480.725192748017;27697.86151069252;27770.722292777016;3186.9681303186903;3204.3431096625136;3211.8072915624903;3265.6407795142513;3266.232435377708;208057;270974;271887;272351;274349.62825185945;55556;55884.441155588735;56168.71915640395;56202;56291.15563266554;32580.837095814844;33429.66570334314;33589.66410335866;35451.64548354483;57667.42332576704;14433.422663093568;14506.927465362816;14598.708025839423;14619.488317908823;14713.779293310608;10555.788884222273;10589.046985771318;10645.84031239532;10705.9464702676;10718.24972251935;17816.732749008774;17913.19390627425;17967.73048404275;18042;18108.275668973358;6824.317568243236;6943.756968506078;7050.083489146378;7052.576845389293;7156;747.2116916652875;882.9293656507464;901.1484147480699;908.4458480326995;912.9680461183959;24913.377165570644;26161.607575886377;26607.600885986725;26762.866185668947;26851.73148268492;894.6332003878508;974.8635191073255;980.9166220871306;982.9705108846603;1005.9446730429751;13134.60596182116;13789.448422063006;13799.724005519833;13900.443982240597;14129.152250864981;383685;391102;391509;391797;392259;49444.258336124985;49805.75097124491;49978.50021499739;50167.74916125396;50248.74875625598;1159.1654009113593;1193.6836738264367;1208;1216.9330686812311;1219.4634360881184;24434.407226796677;25206.369840754127;26036.739632603432;26272;26328.868355658098;43267;43807.34288985604;43851;43872.78063609661;43896.34155487734;342562;345731;348346;349554;351698;25254.49491010206;25535.489290214464;25794.45233285934;25810.483790323713;25849.224523264333;41604.37593436161;42098.78950605227;42696.146077078905;42923.78538107289;43549.782251088545;35418.29163416769;35871.64128358683;36866.63133368739;37104;37736.62263377441;35884.461733073505;36366.81816591006;36567.817160914026;36611.81694091512;36703.265934681694;34450.48324275088;34876.65123348835;35220.295594088486;35750.106247344025;36368.45447318239;31747.523787143673;33837;34098.65901341054;34303.313933721685;34576.30847383088;25670.94632429364;25699.871500642377;25912.963481461284;25920.22239332823;26193.607095893956 05:34:22 INFO - PROCESS | 17432 | |2;jquery.html;355.2610570014369;367.0328683917876;378.6213786213786;381.60122671807966;391.4734681852907;15705.764413533792;16897.408590699328;17686.734698979526;17698.823011769877;17809.109544522755;16849.32602695891;17169.399071032516;17620.82379176208;17698.734518982226;17780.199891004904;5147.794088236476;5371.113766228567;5377.193420986844;5377.46225377463;5379;3853.364194907837;5311.123664595337;5921.289445266574;6189;6254.186955695754;6225.3463386344465;6271.529635277349;6278.37216278373;6279.372062793707;6292.402221788946;6162.815115546541;6196.256449226076;6200.968995155018;6202.069689546559;6210.937890621104;4637.165310244155;4897.51024897511;5399.271098401705;5496.697681627549;5518.751656175482;19664;20039.298624548217;20075.297364592316;20275.695864562043;20715.689264661043;1686.0558087471056;1718.7679663245426;1724.1034661975827;1800.756897818804;1865.2072869030744;8207.48326426525;8727.170918762708;8748.912510874874;12250.203736757083;12636.81044784329;1546.5539720361385;1574.480421460915;1579.107804090685;1585.1994742654886;1606.4297174503117;68270.65864670645;69883.95174072393;71684.64157679178;72184;72527.37363131822;9778.217742580577;9935.503224838729;10175.287729858986;10295.536700848479;10483.947580262049;14000.719985600435;14006.579802605938;14017.299135043208;14025.71948561023;14068.859311406755;6977;7085.078939737801;7189.712411503586;7387.630618469055;7399.741009064657;6761.797146085625;6808.421284190899;6952.2352541220425;6960.547564408398;6980;4282.229198744256;4295.355696645465;4344.3483477478;4456.62118719906;4489.663275254304;1516.4237589715838;1521.8478152184914;1618.368836153901;1845.280340667141;1971.2115153938253;731.2614259597739;799.7520768561765;809.9919000809916;894.0433735902521;900.045951291633;15804.604884877741;16220.513384598245;16331.101789401459;16579.585510362096;16622.25199866009;818.5211651184005;830.6469750356074;850.1838235294064;874.5539774714941;900.8783814185132;9299.349045566745;10404.167666586654;10622.36265824053;10694.893051069545;10767.444525834748;385681;391342;393099;394421;395146;80406.59796700979;82833.17166828376;84191.57904210562;84691;85214;890.2343984173606;910.5583791860943;919.3013309884536;919.5172534419484;953.8092381523722;15235.247946485853;15676.76484852751;16249.350025998827;16290.592735181715;16602.50192494227;35996.28007439889;36377.454338185475;36588;40211.39682904817;40603.98490037773;49423.25865111954;53052.73473632607;53967;53985.19022214749;55018.17472737992;7280.271972802678;7296.160941491797;7402.666879990521;7627.23727627255;8133.918660813553;12046.277223366626;12096.939515302367;12158.331291779037;12203.450844712186;12336.81494777561;10042.347247428894;10263.127634150882;10432.895671043496;10489.52797124116;10505.632302869362;9882.308238423242;10636.946815265874;10650.467476626292;10744.086752625803;11021.283616565219;9395.107464790834;9747.415155090717;9857.457839818879;10146.543405546621;10378.014088661565;6894.621075784963;7349.55902645843;7506.549607023596;7678.769636910902;7733.574653394117;8964.506952117696;9562.378445401027;9843.458609776531;9847.295134682321;9929.453880036668 05:34:22 INFO - PROCESS | 17432 | |3;mootools.html;1395.8534353892842;1413.1770016678486;1523.862852343289;1684.4104563402802;1686.932522699092;6262.248530176374;7050.682719277632;7150.070490836197;7566.621668916553;7604.391648668107;7318.780436586898;7491.85016299675;7522.623868806551;7534.924650753491;7536.095668519772;2173.608750424923;2184.159098746986;2197.9120835166655;2202.603531364354;2206.1285792112108;2132.605467988419;2133.477298061969;2195.121951219509;2195.506011147495;2202.757696653367;2158.902849371782;2185.09318632768;2190.233418303597;2190.299104286629;2229.2309153342153;2119.629064913634;2126.415235810149;2127.181035301405;2130.669746189343;2130.7549631792385;2057.0537552725614;2107.7470703515523;2108.9982258427276;2111.535462198314;2111.5882402931434;7477.1775104738435;7527.5859827709455;7596.354309883612;7608.733694320672;7641.579713115776;4374.693771436001;4467.620252278561;4510.436195475566;4510.571495707903;4512.819487220508;2643.2598872315784;2720.7279272072833;2769.2799872033215;2776.3475583237923;2790.0513825299295;830.9540218568499;858.4591707224471;868.7306934850153;869.5521806269776;871.333429926107;9911.603535858558;10051.597936082548;10060.39637621745;10115.949420252926;10168.644097456627;3927.626875446828;4033.556308806029;4157.64660003897;4186.309258972296;4189.664826813848;8526.360522960802;8576.656933722707;8582.399232053822;8582.87125693115;8593.054763975957;4444.888877778017;4449.755263460541;4474.821007159677;4479.992001799569;4505.43682039745;3557.4663800429626;3936.4292177634657;4064.3700226464944;4093.488313960755;4095;3507.7369197310304;3531.170175008871;3584.211473475831;3597.6762091411374;3631.654992775682;1147.1740346950182;1170.0347213548687;1177.375990724917;1199.0467578275293;1201.9218750781172;788.9289963903161;810.9553974531458;816.8856360109589;823.9752807415787;830.9916900831035;4901.632377571696;4950.653454258239;4960.23116416956;4991.301217829507;5021.623378246646;398.4123417958488;402.59941358348044;405.84577860413447;410.1673602586754;412.5688655355161;3225.870965161414;3286.4577344738327;3319.3195394943978;3324.3683700096904;3401.6938475536826;8937.374383793202;9056.36605437613;9217.723468295962;9232.446053236827;9297.30270229722;9175.816483670289;9185.586648600829;9189.127032931861;9225.446473211628;9258.907410925805;6955.7217711292;7020.227774944752;7058.576485410892;7072;7077.92922070783;4867.342908707279;4893.119238537098;4914.827981020647;5011.84964451067;5169.327987361619;8222.958885205775;8368.539730314891;8563.400561960603;8613.784655383666;8657.480551166951;8608.870866936875;8780.824383512421;8804.251638610789;8813.735587932373;8859.689910853089;5675.205471234113;5912.379200183918;6106.725197366218;6607.933920660732;6731.528792984444;7072.292770722886;7120.074390329224;7157.105361829771;7212.89180662301;7250.129984401695;6381.521385895983;6408.359164083555;6522.34776522344;6529.249136349381;6562.114114594659;6401.55189136756;6460.095586617971;6477.319881412573;6521.108878425393;6540.672966351759;5921.3782552831335;5992.43071908168;5995.1906492624685;6009.308929473166;6013.488853447506;4529.614982726505;4619.607333376701;4634.8146074158;4643.628509719282;4686.226772582486;4329.069250111241;4536.183486972377;4580.88547786308;4634.2585186370015;4749 05:34:22 INFO - PROCESS | 17432 | |4;prototype.html;303.8086005816335;305.6133990502015;311.5591438115067;313.84778382484507;314.02964838648586;5010.995601759293;5042.747862606873;5060.4686507916695;5065.189569668853;5074.898502029957;4938.654294199408;4944.5797107245835;4950.826721064764;4958.677685950411;4963.975180124104;3670.6879915207173;3830.6360895715;3851.480050193216;3892.746971446861;3893.2602805467013;3885.339492286318;3893.8247778849877;3895.474110995022;3907.6287752663593;3911.765294082364;3825.8087095645105;3850.8062500624756;3857.0550215197177;3874.748141370816;3879.0690234343697;3786.6970642348547;3873.3802591585213;3906.257811015898;3918.392649139388;3927.3127202739547;3417.96582034179;3420.58952925648;3423.726101911841;3440.518327434161;3442.5008373785913;4823.421189457287;4854.466008739036;4856.8300109495995;4863.53796389346;4877.51224877513;4372.27857403528;4445.911081778347;4448.621867141297;4459.665525085599;4462.665300102472;5050.191969284933;5114.693118412907;5132.692038477666;5144.43411224765;5165.74171291434;3745.812709364548;3757.5678796938155;3767.831972088661;3778.3199024175638;3787.867424640124;5382.2464854920345;5430.402655707869;5457.536109430703;5480.205370221295;5482.970017037434;3797.240551889633;3853.3641949078647;3862.208247309295;3875.9612403876163;3884.9223015540097;3935.9803200984384;3940.842366305316;3951.446797448302;3952.288588054178;3956.742811717229;4429.800658970354;4439.334099885043;4445.199864024442;4453.910921781546;4462.531434199427;5092.898142037138;5146.507512821315;5152.381714194321;5220.608454365862;5229.6339256251695;1342.6441992871896;1351.8242628458434;1354.1198221156328;1355.2207480698637;1358.7893876449166;833.4291010657719;862.5256109139948;873.2446433834814;873.5370253765515;879.9340049496313;4310.676699247569;4453.4433195850515;4632.86101416958;4643.721376717408;4645.953540464619;5346.8663283417445;5347.224652425454;5359.383670877899;5363.5440987516495;5383.138697808332;4594.448666160082;4648.395708557866;4671.439427268681;4674.368960190399;4684.203685373494;2677.491276657429;2788.2750484873673;2837.793937576522;2843.928901777472;2847.149352920618;5011.949880501221;5014.6991180529285;5032.6980381177245;5035.169197082514;5061.228570000544;5297.22194563376;5469.234307196995;5471.385941147371;5481.616286859961;5485;5006.574441172541;5013.649044566845;5020.071286811878;5023.990403838494;5036.345275114285;5277.947220527899;5298.682079075268;5328.600354973315;5346.358436987586;5348.705821179717;5008.749562521933;5194.454582268959;5204.02247146082;5213.869653258699;5236.162214045735;5017.315736081179;5018.598512119095;5019.3976722793495;5035.086667066491;5048.192289233705;3417.1457135716073;3428.588569371592;3448.689617934398;3449.7757645752945;3465.497502862121;4592.288195329729;4772.451168115711;4777;4794.945112075337;4821.674039639127;4616.699914505546;4625.7918393673035;4632.328312394751;4644.608026866099;4662.5104364042645;4590.740574192361;4613.284940834176;4621.145088158702;4662.557057079572;4668.953310466852;4299.376590394313;4597.379353787196;4598.310253461874;4606.470255920612;4610.308453731967;4680.321353403806;4694.760615175518;4999.275105109811;5065.848024559269;5189.714565698923;5061.164907790173;5076.873078173076;5083.517065878736;5085.576038709168;5092.414372347227 05:34:22 INFO - PROCESS | 17432 | |5;yui.html;553.1840535210564;583.6089819820721;628.208457343747;645.6900687669915;686.2725510958381;12999.805002924952;13910.234937078456;13976.09155404898;14046.648833779147;14057.92971035146;12433.440495177716;12442.129050966436;12488.438020289086;12501.499940002412;12566.183198092118;629.4209327418763;762.2034973452742;771.7106085218044;786.5084322298563;788.846174995876;795.4352409789028;797.6410615223173;798.6366203377478;798.656577671601;800.3517151107592;833.1418638802044;836.4521238588734;838.9454685445457;840.0675250471971;840.4201101240125;823.4770920465547;826.2192228344217;828.88810010649;831.42631584207;832.8625776746829;609.2384519350811;610.4079043327964;611.5780111722942;611.7675283392327;616.8642898562309;13383.732325353536;13412;13442.462301508025;13443.3950472228;13478.258695771729;13042.804357934638;13054.543090991865;13221.471141154343;13335.199888006653;13335.257612931233;9505.477198754135;9505.762355941157;9584.472853993027;9637.277204209642;9845;3200.247941733691;3226.9354612907846;3231.0952933178746;3253.511973204015;3254.7721659483846;60389.69805150946;61462.69268653673;62627.6868615654;63280;63740.681296593684;10020.69937901864;10150.543225554868;10172.440515771556;10268.383896966207;10268.383896966207;18985.62028759417;19012.429627111207;19066.142023608973;19342.129604167847;19374.70937935932;6460.418562329413;6531.738730450728;6574.309697481695;6608.537402381883;6733.46132309414;3470.5661792275964;3490.6683865032783;3505.211327451354;3519.5072689823446;3587.0673624857723;2755.5453350197395;2815.6480439945008;2850.0594803714725;2854.6574411070806;2858.828470291789;457.51274892239655;469.86761903812334;469.97650117493987;475.16134023448643;480.33473639010225;511.8541215753492;519.9714015729096;536.6914024435965;543.1337017457149;550.1307933465196;7636.579988100597;7896.881546776803;7948.920510794934;8007.239312265326;8135.1051384347675;584.9415058494117;606.8651621467883;624.8562830548999;625.6371304643296;629.97795077173;3565.16218688608;3729.9440508392395;3821.216650586623;3825.923481530354;3833.271678381099;52003.219951700754;52805.7359713199;74150.25849741542;91334;95805;78743;80966.19033809705;83066.58466707628;83477.16522834815;84660;43336.3499547507;52053.47946520562;65757.67121164268;73864.63067684734;75862.62068689622;7180.461465390013;7297.817554560966;7435.293647103516;7551.509151905108;7646.541207527566;43710.344344834215;43949.340759889266;44066.779666101465;44540;45300.32049519194;59695;64643;65310;65682.67158664177;67322;9840.261980351646;10013.288904756088;10026.448545330077;10160.08559229673;10198.592056317664;10258.076773090457;10972.23194376386;11045.447727613426;11256.21206515536;11414.600488982845;10000.899990999997;10086.848697269694;10120.291579589653;10154.54304556282;10176.236782241509;9366.625334986524;9533.189678877374;9650.71047868565;9875.40747555149;10154.949225253826;8841.955790221007;9020.548972551478;9051.683191088281;9109.498977556297;9373.859392108987;7820.217978202362;8192.675159235763;8581.95709021451;8671.046184919527;8747.956260218658;7551.942728018192;7867.763967080997;7982.161873003483;8207.753767386988;8295.834083318421 05:34:22 INFO - PROCESS | 17432 | __end_tp_report 05:34:22 INFO - PROCESS | 17432 | __start_cc_report 05:34:22 INFO - PROCESS | 17432 | _x_x_mozilla_cycle_collect,378 05:34:22 INFO - PROCESS | 17432 | __end_cc_report 05:34:22 INFO - PROCESS | 17432 | __startTimestamp1469622862494__endTimestamp 05:34:22 INFO - PROCESS | 17432 | 05:34:22 INFO - PROCESS | 17432 | ------- Summary: start ------- 05:34:22 INFO - PROCESS | 17432 | Number of tests: 6 05:34:22 INFO - PROCESS | 17432 | 05:34:22 INFO - PROCESS | 17432 | [#0] dojo.html Cycles:165 Average:4647.44 Median:4771.95 stddev:481.86 (10.1%) stddev-sans-first:455.83 05:34:22 INFO - PROCESS | 17432 | Values: 2601.7 2610.8 2647.1 2648.8 2659.5 4561.1 4657.6 4679.1 4704.3 4713.6 4657.6 4679.9 4723.9 4741.2 4756.1 4282.9 4348.2 4353.9 4447.7 4474.7 4395.3 4436.7 4472.5 4485.4 4492.2 4215.3 4239.7 4371.3 4382.6 4458.4 4290.8 4292.7 4293.0 4305.0 4375.3 4307.0 4313.1 4327.0 4354.7 4361.3 4619.4 4650.4 4656.1 4694.9 4762.7 4960.8 4971.0 4999.1 5004.3 5005.2 5017.1 5032.9 5041.5 5042.9 5063.1 4558.1 4617.0 4634.3 4655.4 4751.0 5059.1 5069.2 5072.6 5082.5 5115.8 4876.8 4884.4 4900.8 4901.0 4919.4 4821.9 4984.8 5007.1 5022.1 5062.3 5026.0 5035.0 5035.9 5039.7 5053.1 4985.1 5001.2 5002.6 5009.0 5013.3 4036.0 4116.1 4134.8 4135.5 4252.8 3669.1 3672.3 3683.2 3690.7 3715.2 4366.4 4469.6 4474.8 4495.6 4512.9 4909.5 5022.6 5025.7 5051.6 5074.9 4456.4 4461.9 4466.6 4483.0 4491.9 4484.6 4497.8 4500.0 4505.1 4537.5 4584.9 4730.4 4762.7 4772.0 4783.8 5041.6 5073.9 5077.6 5086.5 5127.6 4773.3 4779.1 4785.8 4790.8 4808.5 4782.0 4923.8 4963.4 4979.1 5037.7 5028.1 5057.8 5077.4 5084.0 5134.7 4900.8 4935.8 4937.2 4962.0 4984.2 4723.5 4805.1 4902.0 4911.4 4941.9 4645.1 4793.9 4826.2 4837.8 4877.9 4916.2 4939.9 4951.2 4955.1 4994.4 4653.8 4743.9 4798.9 4802.1 4810.6 05:34:22 INFO - PROCESS | 17432 | 05:34:22 INFO - PROCESS | 17432 | [#1] ext.html Cycles:180 Average:47938.99 Median:35878.05 stddev:88932.62 (247.9%) stddev-sans-first:89110.93 05:34:22 INFO - PROCESS | 17432 | Values: 554.7 557.9 572.8 576.9 601.9 37398.6 38406.4 38552.8 38554.4 38554.6 38669.4 39229.8 39251.2 39300.4 39385.6 7548.6 7670.6 7716.7 7728.0 7763.7 7662.2 7754.1 7756.1 7759.3 7760.6 7643.2 7732.0 7744.8 7766.9 7780.1 7620.2 7680.0 7712.5 7737.1 7751.5 7622.6 7663.6 7668.3 7713.7 7729.0 34797.7 35265.8 35349.6 35377.3 35483.5 2459.7 2676.7 2682.3 2872.6 2902.2 27387.0 27448.9 27480.7 27697.9 27770.7 3187.0 3204.3 3211.8 3265.6 3266.2 208057.0 270974.0 271887.0 272351.0 274349.6 55556.0 55884.4 56168.7 56202.0 56291.2 32580.8 33429.7 33589.7 35451.6 57667.4 14433.4 14506.9 14598.7 14619.5 14713.8 10555.8 10589.0 10645.8 10705.9 10718.2 17816.7 17913.2 17967.7 18042.0 18108.3 6824.3 6943.8 7050.1 7052.6 7156.0 747.2 882.9 901.1 908.4 913.0 24913.4 26161.6 26607.6 26762.9 26851.7 894.6 974.9 980.9 983.0 1005.9 13134.6 13789.4 13799.7 13900.4 14129.2 383685.0 391102.0 391509.0 391797.0 392259.0 49444.3 49805.8 49978.5 50167.7 50248.7 1159.2 1193.7 1208.0 1216.9 1219.5 24434.4 25206.4 26036.7 26272.0 26328.9 43267.0 43807.3 43851.0 43872.8 43896.3 342562.0 345731.0 348346.0 349554.0 351698.0 25254.5 25535.5 25794.5 25810.5 25849.2 41604.4 42098.8 42696.1 42923.8 43549.8 35418.3 35871.6 36866.6 37104.0 37736.6 35884.5 36366.8 36567.8 36611.8 36703.3 34450.5 34876.7 35220.3 35750.1 36368.5 31747.5 33837.0 34098.7 34303.3 34576.3 25670.9 25699.9 25913.0 25920.2 26193.6 05:34:22 INFO - PROCESS | 17432 | 05:34:22 INFO - PROCESS | 17432 | [#2] jquery.html Cycles:180 Average:24767.71 Median:4563.41 stddev:64905.57 (1422.3%) stddev-sans-first:65061.76 05:34:22 INFO - PROCESS | 17432 | Values: 355.3 367.0 378.6 381.6 391.5 15705.8 16897.4 17686.7 17698.8 17809.1 16849.3 17169.4 17620.8 17698.7 17780.2 5147.8 5371.1 5377.2 5377.5 5379.0 3853.4 5311.1 5921.3 6189.0 6254.2 6225.3 6271.5 6278.4 6279.4 6292.4 6162.8 6196.3 6201.0 6202.1 6210.9 4637.2 4897.5 5399.3 5496.7 5518.8 19664.0 20039.3 20075.3 20275.7 20715.7 1686.1 1718.8 1724.1 1800.8 1865.2 8207.5 8727.2 8748.9 12250.2 12636.8 1546.6 1574.5 1579.1 1585.2 1606.4 68270.7 69884.0 71684.6 72184.0 72527.4 9778.2 9935.5 10175.3 10295.5 10483.9 14000.7 14006.6 14017.3 14025.7 14068.9 6977.0 7085.1 7189.7 7387.6 7399.7 6761.8 6808.4 6952.2 6960.5 6980.0 4282.2 4295.4 4344.3 4456.6 4489.7 1516.4 1521.8 1618.4 1845.3 1971.2 731.3 799.8 810.0 894.0 900.0 15804.6 16220.5 16331.1 16579.6 16622.3 818.5 830.6 850.2 874.6 900.9 9299.3 10404.2 10622.4 10694.9 10767.4 385681.0 391342.0 393099.0 394421.0 395146.0 80406.6 82833.2 84191.6 84691.0 85214.0 890.2 910.6 919.3 919.5 953.8 15235.2 15676.8 16249.4 16290.6 16602.5 35996.3 36377.5 36588.0 40211.4 40604.0 49423.3 53052.7 53967.0 53985.2 55018.2 7280.3 7296.2 7402.7 7627.2 8133.9 12046.3 12096.9 12158.3 12203.5 12336.8 10042.3 10263.1 10432.9 10489.5 10505.6 9882.3 10636.9 10650.5 10744.1 11021.3 9395.1 9747.4 9857.5 10146.5 10378.0 6894.6 7349.6 7506.5 7678.8 7733.6 8964.5 9562.4 9843.5 9847.3 9929.5 05:34:22 INFO - PROCESS | 17432 | 05:34:22 INFO - PROCESS | 17432 | [#3] mootools.html Cycles:180 Average:4919.52 Median:4897.38 stddev:2738.82 (55.9%) stddev-sans-first:2733.70 05:34:22 INFO - PROCESS | 17432 | Values: 1395.9 1413.2 1523.9 1684.4 1686.9 6262.2 7050.7 7150.1 7566.6 7604.4 7318.8 7491.9 7522.6 7534.9 7536.1 2173.6 2184.2 2197.9 2202.6 2206.1 2132.6 2133.5 2195.1 2195.5 2202.8 2158.9 2185.1 2190.2 2190.3 2229.2 2119.6 2126.4 2127.2 2130.7 2130.8 2057.1 2107.7 2109.0 2111.5 2111.6 7477.2 7527.6 7596.4 7608.7 7641.6 4374.7 4467.6 4510.4 4510.6 4512.8 2643.3 2720.7 2769.3 2776.3 2790.1 831.0 858.5 868.7 869.6 871.3 9911.6 10051.6 10060.4 10115.9 10168.6 3927.6 4033.6 4157.6 4186.3 4189.7 8526.4 8576.7 8582.4 8582.9 8593.1 4444.9 4449.8 4474.8 4480.0 4505.4 3557.5 3936.4 4064.4 4093.5 4095.0 3507.7 3531.2 3584.2 3597.7 3631.7 1147.2 1170.0 1177.4 1199.0 1201.9 788.9 811.0 816.9 824.0 831.0 4901.6 4950.7 4960.2 4991.3 5021.6 398.4 402.6 405.8 410.2 412.6 3225.9 3286.5 3319.3 3324.4 3401.7 8937.4 9056.4 9217.7 9232.4 9297.3 9175.8 9185.6 9189.1 9225.4 9258.9 6955.7 7020.2 7058.6 7072.0 7077.9 4867.3 4893.1 4914.8 5011.8 5169.3 8223.0 8368.5 8563.4 8613.8 8657.5 8608.9 8780.8 8804.3 8813.7 8859.7 5675.2 5912.4 6106.7 6607.9 6731.5 7072.3 7120.1 7157.1 7212.9 7250.1 6381.5 6408.4 6522.3 6529.2 6562.1 6401.6 6460.1 6477.3 6521.1 6540.7 5921.4 5992.4 5995.2 6009.3 6013.5 4529.6 4619.6 4634.8 4643.6 4686.2 4329.1 4536.2 4580.9 4634.3 4749.0 05:34:22 INFO - PROCESS | 17432 | 05:34:22 INFO - PROCESS | 17432 | [#4] prototype.html Cycles:180 Average:4245.61 Median:4662.53 stddev:1217.78 (26.1%) stddev-sans-first:1184.71 05:34:22 INFO - PROCESS | 17432 | Values: 303.8 305.6 311.6 313.8 314.0 5011.0 5042.7 5060.5 5065.2 5074.9 4938.7 4944.6 4950.8 4958.7 4964.0 3670.7 3830.6 3851.5 3892.7 3893.3 3885.3 3893.8 3895.5 3907.6 3911.8 3825.8 3850.8 3857.1 3874.7 3879.1 3786.7 3873.4 3906.3 3918.4 3927.3 3418.0 3420.6 3423.7 3440.5 3442.5 4823.4 4854.5 4856.8 4863.5 4877.5 4372.3 4445.9 4448.6 4459.7 4462.7 5050.2 5114.7 5132.7 5144.4 5165.7 3745.8 3757.6 3767.8 3778.3 3787.9 5382.2 5430.4 5457.5 5480.2 5483.0 3797.2 3853.4 3862.2 3876.0 3884.9 3936.0 3940.8 3951.4 3952.3 3956.7 4429.8 4439.3 4445.2 4453.9 4462.5 5092.9 5146.5 5152.4 5220.6 5229.6 1342.6 1351.8 1354.1 1355.2 1358.8 833.4 862.5 873.2 873.5 879.9 4310.7 4453.4 4632.9 4643.7 4646.0 5346.9 5347.2 5359.4 5363.5 5383.1 4594.4 4648.4 4671.4 4674.4 4684.2 2677.5 2788.3 2837.8 2843.9 2847.1 5011.9 5014.7 5032.7 5035.2 5061.2 5297.2 5469.2 5471.4 5481.6 5485.0 5006.6 5013.6 5020.1 5024.0 5036.3 5277.9 5298.7 5328.6 5346.4 5348.7 5008.7 5194.5 5204.0 5213.9 5236.2 5017.3 5018.6 5019.4 5035.1 5048.2 3417.1 3428.6 3448.7 3449.8 3465.5 4592.3 4772.5 4777.0 4794.9 4821.7 4616.7 4625.8 4632.3 4644.6 4662.5 4590.7 4613.3 4621.1 4662.6 4669.0 4299.4 4597.4 4598.3 4606.5 4610.3 4680.3 4694.8 4999.3 5065.8 5189.7 5061.2 5076.9 5083.5 5085.6 5092.4 05:34:22 INFO - PROCESS | 17432 | 05:34:22 INFO - PROCESS | 17432 | [#5] yui.html Cycles:180 Average:16339.66 Median:609.82 stddev:23038.37 (3777.9%) stddev-sans-first:23072.50 05:34:22 INFO - PROCESS | 17432 | Values: 553.2 583.6 628.2 645.7 686.3 12999.8 13910.2 13976.1 14046.6 14057.9 12433.4 12442.1 12488.4 12501.5 12566.2 629.4 762.2 771.7 786.5 788.8 795.4 797.6 798.6 798.7 800.4 833.1 836.5 838.9 840.1 840.4 823.5 826.2 828.9 831.4 832.9 609.2 610.4 611.6 611.8 616.9 13383.7 13412.0 13442.5 13443.4 13478.3 13042.8 13054.5 13221.5 13335.2 13335.3 9505.5 9505.8 9584.5 9637.3 9845.0 3200.2 3226.9 3231.1 3253.5 3254.8 60389.7 61462.7 62627.7 63280.0 63740.7 10020.7 10150.5 10172.4 10268.4 10268.4 18985.6 19012.4 19066.1 19342.1 19374.7 6460.4 6531.7 6574.3 6608.5 6733.5 3470.6 3490.7 3505.2 3519.5 3587.1 2755.5 2815.6 2850.1 2854.7 2858.8 457.5 469.9 470.0 475.2 480.3 511.9 520.0 536.7 543.1 550.1 7636.6 7896.9 7948.9 8007.2 8135.1 584.9 606.9 624.9 625.6 630.0 3565.2 3729.9 3821.2 3825.9 3833.3 52003.2 52805.7 74150.3 91334.0 95805.0 78743.0 80966.2 83066.6 83477.2 84660.0 43336.3 52053.5 65757.7 73864.6 75862.6 7180.5 7297.8 7435.3 7551.5 7646.5 43710.3 43949.3 44066.8 44540.0 45300.3 59695.0 64643.0 65310.0 65682.7 67322.0 9840.3 10013.3 10026.4 10160.1 10198.6 10258.1 10972.2 11045.4 11256.2 11414.6 10000.9 10086.8 10120.3 10154.5 10176.2 9366.6 9533.2 9650.7 9875.4 10154.9 8842.0 9020.5 9051.7 9109.5 9373.9 7820.2 8192.7 8582.0 8671.0 8748.0 7551.9 7867.8 7982.2 8207.8 8295.8 05:34:22 INFO - PROCESS | 17432 | -------- Summary: end -------- 05:34:22 INFO - PROCESS | 17432 | 05:34:23 INFO - TEST-INFO | 17432: exit 0 05:34:23 INFO - TEST-OK | dromaeo_css | took 1116220ms 05:34:23 INFO - TEST-START | kraken 05:34:23 INFO - operating with platform_type : linux_ 05:34:23 INFO - Initialising browser for kraken test... 05:34:23 INFO - TEST-INFO | started process 17675 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvHso26/profile http://localhost:36102/getInfo.html) 05:34:26 INFO - PROCESS | 17675 | JavaScript error: , line 0: uncaught exception: undefined 05:34:28 INFO - PROCESS | 17675 | __metrics Screen width/height:1600/1200 05:34:28 INFO - PROCESS | 17675 | colorDepth:24 05:34:28 INFO - PROCESS | 17675 | Browser inner width/height: 1024/697 05:34:28 INFO - PROCESS | 17675 | __metrics 05:34:28 ERROR - PROCESS | 17675 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 05:34:29 INFO - TEST-INFO | 17675: exit 0 05:34:29 INFO - Browser initialized. 05:34:29 INFO - Running cycle 1/1 for kraken test... 05:34:29 INFO - TEST-INFO | started process 17795 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvHso26/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:34:41 INFO - PROCESS | 17795 | RSS: Main: 165814272 05:34:41 INFO - PROCESS | 17795 | 05:34:44 INFO - PROCESS | 17795 | Cycle 1(1): loaded http://localhost:36102/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36102/tests/kraken/driver.html?testName=audio-beat-detection) 05:34:45 INFO - PROCESS | 17795 | RSS: Main: 171245568 05:34:45 INFO - PROCESS | 17795 | 05:34:48 INFO - PROCESS | 17795 | Cycle 1(1): loaded http://localhost:36102/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36102/tests/kraken/driver.html?testName=audio-dft) 05:34:48 INFO - PROCESS | 17795 | RSS: Main: 170557440 05:34:48 INFO - PROCESS | 17795 | 05:34:51 INFO - PROCESS | 17795 | Cycle 1(1): loaded http://localhost:36102/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36102/tests/kraken/driver.html?testName=audio-fft) 05:34:52 INFO - PROCESS | 17795 | RSS: Main: 166498304 05:34:52 INFO - PROCESS | 17795 | 05:34:54 INFO - PROCESS | 17795 | Cycle 1(1): loaded http://localhost:36102/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36102/tests/kraken/driver.html?testName=audio-oscillator) 05:34:55 INFO - PROCESS | 17795 | RSS: Main: 167428096 05:34:55 INFO - PROCESS | 17795 | 05:34:57 INFO - PROCESS | 17795 | Cycle 1(1): loaded http://localhost:36102/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36102/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:34:57 INFO - PROCESS | 17795 | RSS: Main: 167882752 05:34:57 INFO - PROCESS | 17795 | 05:35:01 INFO - PROCESS | 17795 | Cycle 1(1): loaded http://localhost:36102/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36102/tests/kraken/driver.html?testName=imaging-darkroom) 05:35:01 INFO - PROCESS | 17795 | RSS: Main: 167923712 05:35:01 INFO - PROCESS | 17795 | 05:35:05 INFO - PROCESS | 17795 | Cycle 1(1): loaded http://localhost:36102/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36102/tests/kraken/driver.html?testName=imaging-desaturate) 05:35:06 INFO - PROCESS | 17795 | RSS: Main: 164618240 05:35:06 INFO - PROCESS | 17795 | 05:35:09 INFO - PROCESS | 17795 | Cycle 1(1): loaded http://localhost:36102/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36102/tests/kraken/driver.html?testName=json-parse-financial) 05:35:09 INFO - PROCESS | 17795 | RSS: Main: 166821888 05:35:09 INFO - PROCESS | 17795 | 05:35:11 INFO - PROCESS | 17795 | Cycle 1(1): loaded http://localhost:36102/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36102/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:35:12 INFO - PROCESS | 17795 | RSS: Main: 166707200 05:35:12 INFO - PROCESS | 17795 | 05:35:13 INFO - PROCESS | 17795 | Cycle 1(1): loaded http://localhost:36102/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36102/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:35:14 INFO - PROCESS | 17795 | RSS: Main: 167141376 05:35:14 INFO - PROCESS | 17795 | 05:35:16 INFO - PROCESS | 17795 | Cycle 1(1): loaded http://localhost:36102/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36102/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:35:17 INFO - PROCESS | 17795 | RSS: Main: 167899136 05:35:17 INFO - PROCESS | 17795 | 05:35:20 INFO - PROCESS | 17795 | Cycle 1(1): loaded http://localhost:36102/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36102/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:35:20 INFO - PROCESS | 17795 | RSS: Main: 168001536 05:35:20 INFO - PROCESS | 17795 | 05:35:23 INFO - PROCESS | 17795 | Cycle 1(1): loaded http://localhost:36102/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36102/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:35:24 INFO - PROCESS | 17795 | RSS: Main: 168140800 05:35:24 INFO - PROCESS | 17795 | 05:35:26 INFO - PROCESS | 17795 | Cycle 1(1): loaded http://localhost:36102/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36102/tests/kraken/driver.html?testName=ai-astar) 05:35:26 INFO - PROCESS | 17795 | RSS: Main: 169046016 05:35:26 INFO - PROCESS | 17795 | 05:35:26 INFO - PROCESS | 17795 | __start_tp_report 05:35:26 INFO - PROCESS | 17795 | _x_x_mozilla_page_load 05:35:26 INFO - PROCESS | 17795 | _x_x_mozilla_page_load_details 05:35:26 INFO - PROCESS | 17795 | |i|pagename|runs| 05:35:26 INFO - PROCESS | 17795 | |0;ai-astar;104;116;109;115;114;115;115;116;116;113 05:35:26 INFO - PROCESS | 17795 | |1;audio-beat-detection;155;124;145;207;123;149;152;131;178;126 05:35:26 INFO - PROCESS | 17795 | |2;audio-dft;163;168;166;176;163;163;168;167;162;161 05:35:26 INFO - PROCESS | 17795 | |3;audio-fft;75;76;76;188;78;77;80;76;163;76 05:35:26 INFO - PROCESS | 17795 | |4;audio-oscillator;86;86;140;85;86;86;129;86;85;137 05:35:26 INFO - PROCESS | 17795 | |5;imaging-gaussian-blur;118;118;118;117;117;119;121;118;118;118 05:35:26 INFO - PROCESS | 17795 | |6;imaging-darkroom;148;148;147;150;148;148;148;150;148;148 05:35:26 INFO - PROCESS | 17795 | |7;imaging-desaturate;96;96;96;95;96;96;96;96;96;95 05:35:26 INFO - PROCESS | 17795 | |8;json-parse-financial;62;63;64;64;64;63;64;63;64;63 05:35:26 INFO - PROCESS | 17795 | |9;json-stringify-tinderbox;66;66;68;67;67;66;66;66;67;66 05:35:26 INFO - PROCESS | 17795 | |10;stanford-crypto-aes;80;81;81;83;81;81;79;83;86;84 05:35:26 INFO - PROCESS | 17795 | |11;stanford-crypto-ccm;141;133;133;129;139;132;129;145;181;142 05:35:26 INFO - PROCESS | 17795 | |12;stanford-crypto-pbkdf2;174;169;169;165;169;171;166;169;168;171 05:35:26 INFO - PROCESS | 17795 | |13;stanford-crypto-sha256-iterative;70;68;68;68;71;67;67;68;68;73 05:35:26 INFO - PROCESS | 17795 | __end_tp_report 05:35:26 INFO - PROCESS | 17795 | __start_cc_report 05:35:26 INFO - PROCESS | 17795 | _x_x_mozilla_cycle_collect,966 05:35:26 INFO - PROCESS | 17795 | __end_cc_report 05:35:26 INFO - PROCESS | 17795 | __startTimestamp1469622926374__endTimestamp 05:35:26 INFO - PROCESS | 17795 | 05:35:26 INFO - PROCESS | 17795 | ------- Summary: start ------- 05:35:26 INFO - PROCESS | 17795 | Number of tests: 14 05:35:26 INFO - PROCESS | 17795 | 05:35:26 INFO - PROCESS | 17795 | [#0] ai-astar Cycles:10 Average:113.30 Median:115.00 stddev:3.89 (3.4%) stddev-sans-first:2.24 05:35:26 INFO - PROCESS | 17795 | Values: 104.0 116.0 109.0 115.0 114.0 115.0 115.0 116.0 116.0 113.0 05:35:26 INFO - PROCESS | 17795 | 05:35:26 INFO - PROCESS | 17795 | [#1] audio-beat-detection Cycles:10 Average:149.00 Median:150.50 stddev:26.71 (17.7%) stddev-sans-first:28.24 05:35:26 INFO - PROCESS | 17795 | Values: 155.0 124.0 145.0 207.0 123.0 149.0 152.0 131.0 178.0 126.0 05:35:26 INFO - PROCESS | 17795 | 05:35:26 INFO - PROCESS | 17795 | [#2] audio-dft Cycles:10 Average:165.70 Median:166.50 stddev:4.42 (2.7%) stddev-sans-first:4.58 05:35:26 INFO - PROCESS | 17795 | Values: 163.0 168.0 166.0 176.0 163.0 163.0 168.0 167.0 162.0 161.0 05:35:26 INFO - PROCESS | 17795 | 05:35:26 INFO - PROCESS | 17795 | [#3] audio-fft Cycles:10 Average:96.50 Median:76.00 stddev:42.07 (55.4%) stddev-sans-first:43.90 05:35:26 INFO - PROCESS | 17795 | Values: 75.0 76.0 76.0 188.0 78.0 77.0 80.0 76.0 163.0 76.0 05:35:26 INFO - PROCESS | 17795 | 05:35:26 INFO - PROCESS | 17795 | [#4] audio-oscillator Cycles:10 Average:100.60 Median:86.00 stddev:24.12 (28.0%) stddev-sans-first:25.00 05:35:26 INFO - PROCESS | 17795 | Values: 86.0 86.0 140.0 85.0 86.0 86.0 129.0 86.0 85.0 137.0 05:35:26 INFO - PROCESS | 17795 | 05:35:26 INFO - PROCESS | 17795 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:1.14 (1.0%) stddev-sans-first:1.20 05:35:26 INFO - PROCESS | 17795 | Values: 118.0 118.0 118.0 117.0 117.0 119.0 121.0 118.0 118.0 118.0 05:35:26 INFO - PROCESS | 17795 | 05:35:26 INFO - PROCESS | 17795 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 05:35:26 INFO - PROCESS | 17795 | Values: 148.0 148.0 147.0 150.0 148.0 148.0 148.0 150.0 148.0 148.0 05:35:26 INFO - PROCESS | 17795 | 05:35:26 INFO - PROCESS | 17795 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:35:26 INFO - PROCESS | 17795 | Values: 96.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 05:35:26 INFO - PROCESS | 17795 | 05:35:26 INFO - PROCESS | 17795 | [#8] json-parse-financial Cycles:10 Average:63.40 Median:64.00 stddev:0.70 (1.1%) stddev-sans-first:0.53 05:35:26 INFO - PROCESS | 17795 | Values: 62.0 63.0 64.0 64.0 64.0 63.0 64.0 63.0 64.0 63.0 05:35:26 INFO - PROCESS | 17795 | 05:35:26 INFO - PROCESS | 17795 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:66.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 05:35:26 INFO - PROCESS | 17795 | Values: 66.0 66.0 68.0 67.0 67.0 66.0 66.0 66.0 67.0 66.0 05:35:26 INFO - PROCESS | 17795 | 05:35:26 INFO - PROCESS | 17795 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.00 stddev:2.08 (2.5%) stddev-sans-first:2.09 05:35:26 INFO - PROCESS | 17795 | Values: 80.0 81.0 81.0 83.0 81.0 81.0 79.0 83.0 86.0 84.0 05:35:26 INFO - PROCESS | 17795 | 05:35:26 INFO - PROCESS | 17795 | [#11] stanford-crypto-ccm Cycles:10 Average:140.40 Median:140.00 stddev:15.33 (10.9%) stddev-sans-first:16.26 05:35:26 INFO - PROCESS | 17795 | Values: 141.0 133.0 133.0 129.0 139.0 132.0 129.0 145.0 181.0 142.0 05:35:26 INFO - PROCESS | 17795 | 05:35:26 INFO - PROCESS | 17795 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.10 Median:169.00 stddev:2.56 (1.5%) stddev-sans-first:2.01 05:35:26 INFO - PROCESS | 17795 | Values: 174.0 169.0 169.0 165.0 169.0 171.0 166.0 169.0 168.0 171.0 05:35:26 INFO - PROCESS | 17795 | 05:35:26 INFO - PROCESS | 17795 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:68.00 stddev:1.93 (2.8%) stddev-sans-first:2.00 05:35:26 INFO - PROCESS | 17795 | Values: 70.0 68.0 68.0 68.0 71.0 67.0 67.0 68.0 68.0 73.0 05:35:26 INFO - PROCESS | 17795 | -------- Summary: end -------- 05:35:26 INFO - PROCESS | 17795 | 05:35:27 INFO - TEST-INFO | 17795: exit 0 05:35:27 INFO - TEST-OK | kraken | took 64161ms 05:35:27 INFO - SUITE-END | took 1180s 05:35:27 INFO - Completed test suite (00:19:40) 05:35:27 INFO - javascript benchmark 05:35:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6279.644737401445, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2601.700804407493, 2610.791136709061, 2647.0602935957736, 2648.801339899508, 2659.521286168489, 4561.1105834362315, 4657.60410365119, 4679.134360143372, 4704.317873908281, 4713.552212539807, 4657.604103651185, 4679.883002924928, 4723.90552188956, 4741.217699079648, 4756.143894099061, 4282.8501002464845, 4348.173846969065, 4353.869383918487, 4447.666425018137, 4474.709143905652, 4395.296752519597, 4436.711613745112, 4472.485664148632, 4485.372047913294, 4492.213862574053, 4215.283401821667, 4239.660827133822, 4371.256886329332, 4382.605565499089, 4458.398116254297, 4290.806913688892, 4292.712186344084, 4292.978535107304, 4304.978475107604, 4375.343698445226, 4306.978465107686, 4313.051128751669, 4326.978365108186, 4354.716943398669, 4361.345798130305, 4619.399478067863, 4650.372199753024, 4656.068786242731, 4694.882627934295, 4762.738049407281, 4960.751962401865, 4970.975145124287, 4999.125153098194, 5004.324416203803, 5005.174146265898, 5017.122003649383, 5032.949670503284, 5041.470645582234, 5042.924356134624, 5063.063333283354, 4558.111168322179, 4616.95383046172, 4634.2585186370015, 4655.441347038377, 4751.0022895191705, 5059.06407314648, 5069.239614057921, 5072.594192464668, 5082.542571168613, 5115.769790359443, 4876.780544875489, 4884.413870335582, 4900.754962251873, 4900.975495122501, 4919.3604831371695, 4821.855344339605, 4984.825531106467, 5007.073691367109, 5022.096022715873, 5062.265971434122, 5026.045051440215, 5034.974825125851, 5035.924461133086, 5039.722815245197, 5053.0904437200925, 4985.127602669519, 5001.224810154432, 5002.59979201663, 5009.023240468074, 5013.323201367842, 4035.970827438984, 4116.115035267372, 4134.834606615762, 4135.462389889355, 4252.808623611945, 3669.082729317671, 3672.265546890633, 3683.2265224303196, 3690.704743620504, 3715.20123173519, 4366.410534577792, 4469.597736203757, 4474.843380481668, 4495.595396414338, 4512.9323060153465, 4909.5090490950615, 5022.648414610942, 5025.698458092453, 5051.646384753106, 5074.898502030012, 4456.376107344974, 4461.933071003938, 4466.598006179394, 4483.036147228297, 4491.932621010687, 4484.551544845554, 4497.752623605667, 4499.955000450019, 4505.053938672915, 4537.455505339314, 4584.862454126382, 4730.408698912636, 4762.690425122356, 4771.95228047715, 4783.784729687242, 5041.6470847040355, 5073.949260507347, 5077.644564880423, 5086.491350865032, 5127.615428842777, 4773.284007398918, 4779.06808172403, 4785.832495862628, 4790.808367665254, 4808.519148085164, 4782.0, 4923.753812309442, 4963.354763880672, 4979.103761322996, 5037.722925239147, 5028.094942910165, 5057.848264552069, 5077.39071311445, 5084.034033533617, 5134.666246693953, 4900.779464924159, 4935.777889994887, 4937.185364414831, 4962.007598480391, 4984.152694041949, 4723.527647235249, 4805.063012712627, 4901.975490122527, 4911.4106307243355, 4941.876453088702, 4645.117427688863, 4793.880152996203, 4826.155422800925, 4837.782299796588, 4877.9024419512125, 4916.237983112624, 4939.925901111558, 4951.207806750903, 4955.058538877602, 4994.350734404504, 4653.790579424001, 4743.928841067318, 4798.904021919472, 4802.087603355351, 4810.6151507878585], "value": 4616.896214843521, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.6976897590815, 557.8521691751686, 572.8224250482351, 576.8990426675331, 601.9367966363534, 37398.62601373986, 38406.423903641466, 38552.80723596382, 38554.421683674766, 38554.61445385545, 38669.419958700644, 39229.80385098071, 39251.214975700466, 39300.410493842544, 39385.60614393855, 7548.622568871562, 7670.578118203496, 7716.729914452995, 7727.96136019322, 7763.689452421896, 7662.233776622321, 7754.06951165858, 7756.0692716874055, 7759.262870027338, 7760.573168475732, 7643.159252482223, 7732.0, 7744.7676569703, 7766.883496747553, 7780.14418413974, 7620.199879012707, 7680.039995000625, 7712.537247765152, 7737.148913619498, 7751.496152750054, 7622.618869056525, 7663.5785031823225, 7668.348190403823, 7713.730019449293, 7729.0, 34797.65202347969, 35265.823670881735, 35349.646503534896, 35377.292454150775, 35483.4677479838, 2459.717132529764, 2676.678798544168, 2682.329417645589, 2872.6121973533513, 2902.201894479014, 27387.0, 27448.862755686292, 27480.725192748017, 27697.86151069252, 27770.722292777016, 3186.9681303186903, 3204.3431096625136, 3211.8072915624903, 3265.6407795142513, 3266.232435377708, 208057.0, 270974.0, 271887.0, 272351.0, 274349.62825185945, 55556.0, 55884.441155588735, 56168.71915640395, 56202.0, 56291.15563266554, 32580.837095814844, 33429.66570334314, 33589.66410335866, 35451.64548354483, 57667.42332576704, 14433.422663093568, 14506.927465362816, 14598.708025839423, 14619.488317908823, 14713.779293310608, 10555.788884222273, 10589.046985771318, 10645.84031239532, 10705.9464702676, 10718.24972251935, 17816.732749008774, 17913.19390627425, 17967.73048404275, 18042.0, 18108.275668973358, 6824.317568243236, 6943.756968506078, 7050.083489146378, 7052.576845389293, 7156.0, 747.2116916652875, 882.9293656507464, 901.1484147480699, 908.4458480326995, 912.9680461183959, 24913.377165570644, 26161.607575886377, 26607.600885986725, 26762.866185668947, 26851.73148268492, 894.6332003878508, 974.8635191073255, 980.9166220871306, 982.9705108846603, 1005.9446730429751, 13134.60596182116, 13789.448422063006, 13799.724005519833, 13900.443982240597, 14129.152250864981, 383685.0, 391102.0, 391509.0, 391797.0, 392259.0, 49444.258336124985, 49805.75097124491, 49978.50021499739, 50167.74916125396, 50248.74875625598, 1159.1654009113593, 1193.6836738264367, 1208.0, 1216.9330686812311, 1219.4634360881184, 24434.407226796677, 25206.369840754127, 26036.739632603432, 26272.0, 26328.868355658098, 43267.0, 43807.34288985604, 43851.0, 43872.78063609661, 43896.34155487734, 342562.0, 345731.0, 348346.0, 349554.0, 351698.0, 25254.49491010206, 25535.489290214464, 25794.45233285934, 25810.483790323713, 25849.224523264333, 41604.37593436161, 42098.78950605227, 42696.146077078905, 42923.78538107289, 43549.782251088545, 35418.29163416769, 35871.64128358683, 36866.63133368739, 37104.0, 37736.62263377441, 35884.461733073505, 36366.81816591006, 36567.817160914026, 36611.81694091512, 36703.265934681694, 34450.48324275088, 34876.65123348835, 35220.295594088486, 35750.106247344025, 36368.45447318239, 31747.523787143673, 33837.0, 34098.65901341054, 34303.313933721685, 34576.30847383088, 25670.94632429364, 25699.871500642377, 25912.963481461284, 25920.22239332823, 26193.607095893956], "value": 17151.97300766253, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.2610570014369, 367.0328683917876, 378.6213786213786, 381.60122671807966, 391.4734681852907, 15705.764413533792, 16897.408590699328, 17686.734698979526, 17698.823011769877, 17809.109544522755, 16849.32602695891, 17169.399071032516, 17620.82379176208, 17698.734518982226, 17780.199891004904, 5147.794088236476, 5371.113766228567, 5377.193420986844, 5377.46225377463, 5379.0, 3853.364194907837, 5311.123664595337, 5921.289445266574, 6189.0, 6254.186955695754, 6225.3463386344465, 6271.529635277349, 6278.37216278373, 6279.372062793707, 6292.402221788946, 6162.815115546541, 6196.256449226076, 6200.968995155018, 6202.069689546559, 6210.937890621104, 4637.165310244155, 4897.51024897511, 5399.271098401705, 5496.697681627549, 5518.751656175482, 19664.0, 20039.298624548217, 20075.297364592316, 20275.695864562043, 20715.689264661043, 1686.0558087471056, 1718.7679663245426, 1724.1034661975827, 1800.756897818804, 1865.2072869030744, 8207.48326426525, 8727.170918762708, 8748.912510874874, 12250.203736757083, 12636.81044784329, 1546.5539720361385, 1574.480421460915, 1579.107804090685, 1585.1994742654886, 1606.4297174503117, 68270.65864670645, 69883.95174072393, 71684.64157679178, 72184.0, 72527.37363131822, 9778.217742580577, 9935.503224838729, 10175.287729858986, 10295.536700848479, 10483.947580262049, 14000.719985600435, 14006.579802605938, 14017.299135043208, 14025.71948561023, 14068.859311406755, 6977.0, 7085.078939737801, 7189.712411503586, 7387.630618469055, 7399.741009064657, 6761.797146085625, 6808.421284190899, 6952.2352541220425, 6960.547564408398, 6980.0, 4282.229198744256, 4295.355696645465, 4344.3483477478, 4456.62118719906, 4489.663275254304, 1516.4237589715838, 1521.8478152184914, 1618.368836153901, 1845.280340667141, 1971.2115153938253, 731.2614259597739, 799.7520768561765, 809.9919000809916, 894.0433735902521, 900.045951291633, 15804.604884877741, 16220.513384598245, 16331.101789401459, 16579.585510362096, 16622.25199866009, 818.5211651184005, 830.6469750356074, 850.1838235294064, 874.5539774714941, 900.8783814185132, 9299.349045566745, 10404.167666586654, 10622.36265824053, 10694.893051069545, 10767.444525834748, 385681.0, 391342.0, 393099.0, 394421.0, 395146.0, 80406.59796700979, 82833.17166828376, 84191.57904210562, 84691.0, 85214.0, 890.2343984173606, 910.5583791860943, 919.3013309884536, 919.5172534419484, 953.8092381523722, 15235.247946485853, 15676.76484852751, 16249.350025998827, 16290.592735181715, 16602.50192494227, 35996.28007439889, 36377.454338185475, 36588.0, 40211.39682904817, 40603.98490037773, 49423.25865111954, 53052.73473632607, 53967.0, 53985.19022214749, 55018.17472737992, 7280.271972802678, 7296.160941491797, 7402.666879990521, 7627.23727627255, 8133.918660813553, 12046.277223366626, 12096.939515302367, 12158.331291779037, 12203.450844712186, 12336.81494777561, 10042.347247428894, 10263.127634150882, 10432.895671043496, 10489.52797124116, 10505.632302869362, 9882.308238423242, 10636.946815265874, 10650.467476626292, 10744.086752625803, 11021.283616565219, 9395.107464790834, 9747.415155090717, 9857.457839818879, 10146.543405546621, 10378.014088661565, 6894.621075784963, 7349.55902645843, 7506.549607023596, 7678.769636910902, 7733.574653394117, 8964.506952117696, 9562.378445401027, 9843.458609776531, 9847.295134682321, 9929.453880036668], "value": 8287.623384043518, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1395.8534353892842, 1413.1770016678486, 1523.862852343289, 1684.4104563402802, 1686.932522699092, 6262.248530176374, 7050.682719277632, 7150.070490836197, 7566.621668916553, 7604.391648668107, 7318.780436586898, 7491.85016299675, 7522.623868806551, 7534.924650753491, 7536.095668519772, 2173.608750424923, 2184.159098746986, 2197.9120835166655, 2202.603531364354, 2206.1285792112108, 2132.605467988419, 2133.477298061969, 2195.121951219509, 2195.506011147495, 2202.757696653367, 2158.902849371782, 2185.09318632768, 2190.233418303597, 2190.299104286629, 2229.2309153342153, 2119.629064913634, 2126.415235810149, 2127.181035301405, 2130.669746189343, 2130.7549631792385, 2057.0537552725614, 2107.7470703515523, 2108.9982258427276, 2111.535462198314, 2111.5882402931434, 7477.1775104738435, 7527.5859827709455, 7596.354309883612, 7608.733694320672, 7641.579713115776, 4374.693771436001, 4467.620252278561, 4510.436195475566, 4510.571495707903, 4512.819487220508, 2643.2598872315784, 2720.7279272072833, 2769.2799872033215, 2776.3475583237923, 2790.0513825299295, 830.9540218568499, 858.4591707224471, 868.7306934850153, 869.5521806269776, 871.333429926107, 9911.603535858558, 10051.597936082548, 10060.39637621745, 10115.949420252926, 10168.644097456627, 3927.626875446828, 4033.556308806029, 4157.64660003897, 4186.309258972296, 4189.664826813848, 8526.360522960802, 8576.656933722707, 8582.399232053822, 8582.87125693115, 8593.054763975957, 4444.888877778017, 4449.755263460541, 4474.821007159677, 4479.992001799569, 4505.43682039745, 3557.4663800429626, 3936.4292177634657, 4064.3700226464944, 4093.488313960755, 4095.0, 3507.7369197310304, 3531.170175008871, 3584.211473475831, 3597.6762091411374, 3631.654992775682, 1147.1740346950182, 1170.0347213548687, 1177.375990724917, 1199.0467578275293, 1201.9218750781172, 788.9289963903161, 810.9553974531458, 816.8856360109589, 823.9752807415787, 830.9916900831035, 4901.632377571696, 4950.653454258239, 4960.23116416956, 4991.301217829507, 5021.623378246646, 398.4123417958488, 402.59941358348044, 405.84577860413447, 410.1673602586754, 412.5688655355161, 3225.870965161414, 3286.4577344738327, 3319.3195394943978, 3324.3683700096904, 3401.6938475536826, 8937.374383793202, 9056.36605437613, 9217.723468295962, 9232.446053236827, 9297.30270229722, 9175.816483670289, 9185.586648600829, 9189.127032931861, 9225.446473211628, 9258.907410925805, 6955.7217711292, 7020.227774944752, 7058.576485410892, 7072.0, 7077.92922070783, 4867.342908707279, 4893.119238537098, 4914.827981020647, 5011.84964451067, 5169.327987361619, 8222.958885205775, 8368.539730314891, 8563.400561960603, 8613.784655383666, 8657.480551166951, 8608.870866936875, 8780.824383512421, 8804.251638610789, 8813.735587932373, 8859.689910853089, 5675.205471234113, 5912.379200183918, 6106.725197366218, 6607.933920660732, 6731.528792984444, 7072.292770722886, 7120.074390329224, 7157.105361829771, 7212.89180662301, 7250.129984401695, 6381.521385895983, 6408.359164083555, 6522.34776522344, 6529.249136349381, 6562.114114594659, 6401.55189136756, 6460.095586617971, 6477.319881412573, 6521.108878425393, 6540.672966351759, 5921.3782552831335, 5992.43071908168, 5995.1906492624685, 6009.308929473166, 6013.488853447506, 4529.614982726505, 4619.607333376701, 4634.8146074158, 4643.628509719282, 4686.226772582486, 4329.069250111241, 4536.183486972377, 4580.88547786308, 4634.2585186370015, 4749.0], "value": 3919.3016924313124, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.8086005816335, 305.6133990502015, 311.5591438115067, 313.84778382484507, 314.02964838648586, 5010.995601759293, 5042.747862606873, 5060.4686507916695, 5065.189569668853, 5074.898502029957, 4938.654294199408, 4944.5797107245835, 4950.826721064764, 4958.677685950411, 4963.975180124104, 3670.6879915207173, 3830.6360895715, 3851.480050193216, 3892.746971446861, 3893.2602805467013, 3885.339492286318, 3893.8247778849877, 3895.474110995022, 3907.6287752663593, 3911.765294082364, 3825.8087095645105, 3850.8062500624756, 3857.0550215197177, 3874.748141370816, 3879.0690234343697, 3786.6970642348547, 3873.3802591585213, 3906.257811015898, 3918.392649139388, 3927.3127202739547, 3417.96582034179, 3420.58952925648, 3423.726101911841, 3440.518327434161, 3442.5008373785913, 4823.421189457287, 4854.466008739036, 4856.8300109495995, 4863.53796389346, 4877.51224877513, 4372.27857403528, 4445.911081778347, 4448.621867141297, 4459.665525085599, 4462.665300102472, 5050.191969284933, 5114.693118412907, 5132.692038477666, 5144.43411224765, 5165.74171291434, 3745.812709364548, 3757.5678796938155, 3767.831972088661, 3778.3199024175638, 3787.867424640124, 5382.2464854920345, 5430.402655707869, 5457.536109430703, 5480.205370221295, 5482.970017037434, 3797.240551889633, 3853.3641949078647, 3862.208247309295, 3875.9612403876163, 3884.9223015540097, 3935.9803200984384, 3940.842366305316, 3951.446797448302, 3952.288588054178, 3956.742811717229, 4429.800658970354, 4439.334099885043, 4445.199864024442, 4453.910921781546, 4462.531434199427, 5092.898142037138, 5146.507512821315, 5152.381714194321, 5220.608454365862, 5229.6339256251695, 1342.6441992871896, 1351.8242628458434, 1354.1198221156328, 1355.2207480698637, 1358.7893876449166, 833.4291010657719, 862.5256109139948, 873.2446433834814, 873.5370253765515, 879.9340049496313, 4310.676699247569, 4453.4433195850515, 4632.86101416958, 4643.721376717408, 4645.953540464619, 5346.8663283417445, 5347.224652425454, 5359.383670877899, 5363.5440987516495, 5383.138697808332, 4594.448666160082, 4648.395708557866, 4671.439427268681, 4674.368960190399, 4684.203685373494, 2677.491276657429, 2788.2750484873673, 2837.793937576522, 2843.928901777472, 2847.149352920618, 5011.949880501221, 5014.6991180529285, 5032.6980381177245, 5035.169197082514, 5061.228570000544, 5297.22194563376, 5469.234307196995, 5471.385941147371, 5481.616286859961, 5485.0, 5006.574441172541, 5013.649044566845, 5020.071286811878, 5023.990403838494, 5036.345275114285, 5277.947220527899, 5298.682079075268, 5328.600354973315, 5346.358436987586, 5348.705821179717, 5008.749562521933, 5194.454582268959, 5204.02247146082, 5213.869653258699, 5236.162214045735, 5017.315736081179, 5018.598512119095, 5019.3976722793495, 5035.086667066491, 5048.192289233705, 3417.1457135716073, 3428.588569371592, 3448.689617934398, 3449.7757645752945, 3465.497502862121, 4592.288195329729, 4772.451168115711, 4777.0, 4794.945112075337, 4821.674039639127, 4616.699914505546, 4625.7918393673035, 4632.328312394751, 4644.608026866099, 4662.5104364042645, 4590.740574192361, 4613.284940834176, 4621.145088158702, 4662.557057079572, 4668.953310466852, 4299.376590394313, 4597.379353787196, 4598.310253461874, 4606.470255920612, 4610.308453731967, 4680.321353403806, 4694.760615175518, 4999.275105109811, 5065.848024559269, 5189.714565698923, 5061.164907790173, 5076.873078173076, 5083.517065878736, 5085.576038709168, 5092.414372347227], "value": 3861.3185270419053, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.1840535210564, 583.6089819820721, 628.208457343747, 645.6900687669915, 686.2725510958381, 12999.805002924952, 13910.234937078456, 13976.09155404898, 14046.648833779147, 14057.92971035146, 12433.440495177716, 12442.129050966436, 12488.438020289086, 12501.499940002412, 12566.183198092118, 629.4209327418763, 762.2034973452742, 771.7106085218044, 786.5084322298563, 788.846174995876, 795.4352409789028, 797.6410615223173, 798.6366203377478, 798.656577671601, 800.3517151107592, 833.1418638802044, 836.4521238588734, 838.9454685445457, 840.0675250471971, 840.4201101240125, 823.4770920465547, 826.2192228344217, 828.88810010649, 831.42631584207, 832.8625776746829, 609.2384519350811, 610.4079043327964, 611.5780111722942, 611.7675283392327, 616.8642898562309, 13383.732325353536, 13412.0, 13442.462301508025, 13443.3950472228, 13478.258695771729, 13042.804357934638, 13054.543090991865, 13221.471141154343, 13335.199888006653, 13335.257612931233, 9505.477198754135, 9505.762355941157, 9584.472853993027, 9637.277204209642, 9845.0, 3200.247941733691, 3226.9354612907846, 3231.0952933178746, 3253.511973204015, 3254.7721659483846, 60389.69805150946, 61462.69268653673, 62627.6868615654, 63280.0, 63740.681296593684, 10020.69937901864, 10150.543225554868, 10172.440515771556, 10268.383896966207, 10268.383896966207, 18985.62028759417, 19012.429627111207, 19066.142023608973, 19342.129604167847, 19374.70937935932, 6460.418562329413, 6531.738730450728, 6574.309697481695, 6608.537402381883, 6733.46132309414, 3470.5661792275964, 3490.6683865032783, 3505.211327451354, 3519.5072689823446, 3587.0673624857723, 2755.5453350197395, 2815.6480439945008, 2850.0594803714725, 2854.6574411070806, 2858.828470291789, 457.51274892239655, 469.86761903812334, 469.97650117493987, 475.16134023448643, 480.33473639010225, 511.8541215753492, 519.9714015729096, 536.6914024435965, 543.1337017457149, 550.1307933465196, 7636.579988100597, 7896.881546776803, 7948.920510794934, 8007.239312265326, 8135.1051384347675, 584.9415058494117, 606.8651621467883, 624.8562830548999, 625.6371304643296, 629.97795077173, 3565.16218688608, 3729.9440508392395, 3821.216650586623, 3825.923481530354, 3833.271678381099, 52003.219951700754, 52805.7359713199, 74150.25849741542, 91334.0, 95805.0, 78743.0, 80966.19033809705, 83066.58466707628, 83477.16522834815, 84660.0, 43336.3499547507, 52053.47946520562, 65757.67121164268, 73864.63067684734, 75862.62068689622, 7180.461465390013, 7297.817554560966, 7435.293647103516, 7551.509151905108, 7646.541207527566, 43710.344344834215, 43949.340759889266, 44066.779666101465, 44540.0, 45300.32049519194, 59695.0, 64643.0, 65310.0, 65682.67158664177, 67322.0, 9840.261980351646, 10013.288904756088, 10026.448545330077, 10160.08559229673, 10198.592056317664, 10258.076773090457, 10972.23194376386, 11045.447727613426, 11256.21206515536, 11414.600488982845, 10000.899990999997, 10086.848697269694, 10120.291579589653, 10154.54304556282, 10176.236782241509, 9366.625334986524, 9533.189678877374, 9650.71047868565, 9875.40747555149, 10154.949225253826, 8841.955790221007, 9020.548972551478, 9051.683191088281, 9109.498977556297, 9373.859392108987, 7820.217978202362, 8192.675159235763, 8581.95709021451, 8671.046184919527, 8747.956260218658, 7551.942728018192, 7867.763967080997, 7982.161873003483, 8207.753767386988, 8295.834083318421], "value": 6173.3580957412305, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1577.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 116.0, 109.0, 115.0, 114.0, 115.0, 115.0, 116.0, 116.0, 113.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 124.0, 145.0, 207.0, 123.0, 149.0, 152.0, 131.0, 178.0, 126.0], "value": 149.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 168.0, 166.0, 176.0, 163.0, 163.0, 168.0, 167.0, 162.0, 161.0], "value": 165.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 188.0, 78.0, 77.0, 80.0, 76.0, 163.0, 76.0], "value": 96.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 140.0, 85.0, 86.0, 86.0, 129.0, 86.0, 85.0, 137.0], "value": 100.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 117.0, 119.0, 121.0, 118.0, 118.0, 118.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 150.0, 148.0, 148.0, 148.0, 150.0, 148.0, 148.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 64.0, 64.0, 64.0, 63.0, 64.0, 63.0, 64.0, 63.0], "value": 63.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 68.0, 67.0, 67.0, 66.0, 66.0, 66.0, 67.0, 66.0], "value": 66.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 81.0, 83.0, 81.0, 81.0, 79.0, 83.0, 86.0, 84.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 133.0, 133.0, 129.0, 139.0, 132.0, 129.0, 145.0, 181.0, 142.0], "value": 140.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 169.0, 169.0, 165.0, 169.0, 171.0, 166.0, 169.0, 168.0, 171.0], "value": 169.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 68.0, 68.0, 71.0, 67.0, 67.0, 68.0, 68.0, 73.0], "value": 68.8, "unit": "score"}]}]} 05:35:27 INFO - Return code: 0 05:35:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:35:27 ERROR - # TBPL SUCCESS # 05:35:27 INFO - Running post-action listener: _resource_record_post_action 05:35:27 INFO - [mozharness: 2016-07-27 12:35:27.692002Z] Finished run-tests step (success) 05:35:27 INFO - Running post-run listener: _resource_record_post_run 05:35:27 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 8192; Write bytes: 537571328; Read time: 28; Write time: 483000 05:35:27 INFO - TinderboxPrint: CPU usage
13.4% 05:35:27 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 28 05:35:27 INFO - TinderboxPrint: I/O write bytes / time
537,571,328 / 483,000 05:35:27 INFO - TinderboxPrint: CPU idle
8,274.1 (86.6%) 05:35:27 INFO - TinderboxPrint: CPU user
1,220.5 (12.8%) 05:35:27 INFO - TinderboxPrint: Swap in / out
0 / 0 05:35:27 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 253956096; Read time: 0; Write time: 259360 05:35:27 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283615232; Read time: 8; Write time: 223640 05:35:28 INFO - Running post-run listener: _upload_blobber_files 05:35:28 INFO - Blob upload gear active. 05:35:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:35:28 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:35:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:35:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:35:28 INFO - (blobuploader) - INFO - Open directory for files ... 05:35:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:35:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:35:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:35:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:35:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:35:29 INFO - (blobuploader) - INFO - Done attempting. 05:35:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:35:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:35:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:35:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:35:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:35:30 INFO - (blobuploader) - INFO - Done attempting. 05:35:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:35:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:35:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:35:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:35:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:35:36 INFO - (blobuploader) - INFO - Done attempting. 05:35:36 INFO - (blobuploader) - INFO - Iteration through files over. 05:35:36 INFO - Return code: 0 05:35:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:35:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:35:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/214c567aac1251eb157c23ab9ec46cf4d18c1f9c333514bf1a35f60eb5b0f32369d7eac873fa3189bc146b8f30a7a2717eadb5fdf27f9160c186299a1a20f28e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/02b57bb00cdccd69e802f0a09c40bc9dca15521f1084f8b0c6c367740d4ee961c31476de80012d3b68087c62cf944cf90e7d7ddd59acfa38362a013a2da40e23", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/84f0e7f13204ecc7989f72c87dbf4b00a5bae4f8d61724c4c5148e6660cb5b9137d9cc69a5bce12479c9af0ee9be09e8fed7d60751c50db463b7004b5002d69b"} 05:35:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:35:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:35:36 INFO - Contents: 05:35:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/214c567aac1251eb157c23ab9ec46cf4d18c1f9c333514bf1a35f60eb5b0f32369d7eac873fa3189bc146b8f30a7a2717eadb5fdf27f9160c186299a1a20f28e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/02b57bb00cdccd69e802f0a09c40bc9dca15521f1084f8b0c6c367740d4ee961c31476de80012d3b68087c62cf944cf90e7d7ddd59acfa38362a013a2da40e23", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/84f0e7f13204ecc7989f72c87dbf4b00a5bae4f8d61724c4c5148e6660cb5b9137d9cc69a5bce12479c9af0ee9be09e8fed7d60751c50db463b7004b5002d69b"} 05:35:36 INFO - Running post-run listener: copy_logs_to_upload_dir 05:35:36 INFO - Copying logs to upload dir... 05:35:36 INFO - mkdir: /builds/slave/test/build/upload/logs 05:35:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1298.755686 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 38 secs) (at 2016-07-27 05:35:36.344672) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 05:35:36.348410) ========= 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=523ca41ca1e0623de333ad52000001bf-1469621635.294678-1357436416 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/214c567aac1251eb157c23ab9ec46cf4d18c1f9c333514bf1a35f60eb5b0f32369d7eac873fa3189bc146b8f30a7a2717eadb5fdf27f9160c186299a1a20f28e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/02b57bb00cdccd69e802f0a09c40bc9dca15521f1084f8b0c6c367740d4ee961c31476de80012d3b68087c62cf944cf90e7d7ddd59acfa38362a013a2da40e23", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/84f0e7f13204ecc7989f72c87dbf4b00a5bae4f8d61724c4c5148e6660cb5b9137d9cc69a5bce12479c9af0ee9be09e8fed7d60751c50db463b7004b5002d69b"} build_url:https://queue.taskcluster.net/v1/task/HxW2M4-MQ0KpyWfD7eYyew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011434 build_url: 'https://queue.taskcluster.net/v1/task/HxW2M4-MQ0KpyWfD7eYyew/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/214c567aac1251eb157c23ab9ec46cf4d18c1f9c333514bf1a35f60eb5b0f32369d7eac873fa3189bc146b8f30a7a2717eadb5fdf27f9160c186299a1a20f28e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/02b57bb00cdccd69e802f0a09c40bc9dca15521f1084f8b0c6c367740d4ee961c31476de80012d3b68087c62cf944cf90e7d7ddd59acfa38362a013a2da40e23", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/84f0e7f13204ecc7989f72c87dbf4b00a5bae4f8d61724c4c5148e6660cb5b9137d9cc69a5bce12479c9af0ee9be09e8fed7d60751c50db463b7004b5002d69b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 05:35:36.373890) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 05:35:36.374243) ========= 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=523ca41ca1e0623de333ad52000001bf-1469621635.294678-1357436416 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 05:35:36.457964) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 05:35:36.458286) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 05:35:36.458603) ========= ========= Total master_lag: 0.16 =========