builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-017 starttime: 1463601558.26 results: success (0) buildid: 20160517073121 builduid: 91748e3a507046789edb563a3e6ea041 revision: 3780a3a6b83aeda143f9562829c830410a0c961e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-18 12:59:18.264959) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-18 12:59:18.265356) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-18 12:59:18.265655) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-18 12:59:18.903621) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 12:59:18.903887) ========= 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=0333a256a5e4f052382dd180000001b1-1463601352.890358-1880406764 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-18 12:59:19-- 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% 223M=0s 2016-05-18 12:59:19 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.175726 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 12:59:19.099597) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 12:59:19.099884) ========= 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=0333a256a5e4f052382dd180000001b1-1463601352.890358-1880406764 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019818 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 12:59:19.151956) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 12:59:19.152291) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3780a3a6b83aeda143f9562829c830410a0c961e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 3780a3a6b83aeda143f9562829c830410a0c961e --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=0333a256a5e4f052382dd180000001b1-1463601352.890358-1880406764 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-18 12:59:19,566 truncating revision to first 12 chars 2016-05-18 12:59:19,566 Setting DEBUG logging. 2016-05-18 12:59:19,566 attempt 1/10 2016-05-18 12:59:19,566 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3780a3a6b83a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-18 12:59:19,814 unpacking tar archive at: mozilla-central-3780a3a6b83a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.541607 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 12:59:19.709989) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-18 12:59:19.710288) ========= script_repo_revision: 3780a3a6b83aeda143f9562829c830410a0c961e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-18 12:59:19.710684) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-18 12:59:19.710955) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-18 12:59:19.742940) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 3 secs) (at 2016-05-18 12:59:19.743209) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=0333a256a5e4f052382dd180000001b1-1463601352.890358-1880406764 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:59:20 INFO - MultiFileLogger online at 20160518 12:59:20 in /builds/slave/test 12:59:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 12:59:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:59:20 INFO - {'append_to_log': False, 12:59:20 INFO - 'base_work_dir': '/builds/slave/test', 12:59:20 INFO - 'blob_upload_branch': 'Firefox', 12:59:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:59:20 INFO - 'branch': 'Firefox', 12:59:20 INFO - 'buildbot_json_path': 'buildprops.json', 12:59:20 INFO - 'config_files': ('talos/linux_config.py',), 12:59:20 INFO - 'default_actions': ('clobber', 12:59:20 INFO - 'read-buildbot-config', 12:59:20 INFO - 'download-and-extract', 12:59:20 INFO - 'populate-webroot', 12:59:20 INFO - 'create-virtualenv', 12:59:20 INFO - 'install', 12:59:20 INFO - 'run-tests'), 12:59:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:59:20 INFO - 'download_minidump_stackwalk': True, 12:59:20 INFO - 'download_symbols': 'ondemand', 12:59:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:59:20 INFO - 'tooltool.py': '/tools/tooltool.py', 12:59:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:59:20 INFO - '/tools/misc-python/virtualenv.py')}, 12:59:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:59:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:59:20 INFO - 'installer_path': 'installer.exe', 12:59:20 INFO - 'log_level': 'info', 12:59:20 INFO - 'log_name': 'talos', 12:59:20 INFO - 'log_to_console': True, 12:59:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:59:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:59:20 INFO - 'opt_config_files': (), 12:59:20 INFO - 'pip_index': False, 12:59:20 INFO - 'sps_profile': False, 12:59:20 INFO - 'sps_profile_interval': 0, 12:59:20 INFO - 'suite': 'dromaeojs-e10s', 12:59:20 INFO - 'system_bits': '32', 12:59:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:59:20 INFO - 'title': 'talos-linux64-ix-017', 12:59:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:59:20 INFO - 'use_talos_json': True, 12:59:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:59:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:59:20 INFO - 'work_dir': 'build'} 12:59:20 INFO - ##### 12:59:20 INFO - ##### Running clobber step. 12:59:20 INFO - ##### 12:59:20 INFO - Running pre-action listener: _resource_record_pre_action 12:59:20 INFO - Running main action method: clobber 12:59:20 INFO - rmtree: /builds/slave/test/build 12:59:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:59:21 INFO - Running post-action listener: _resource_record_post_action 12:59:21 INFO - ##### 12:59:21 INFO - ##### Finished clobber step (success) 12:59:21 INFO - ##### 12:59:21 INFO - ##### 12:59:21 INFO - ##### Running read-buildbot-config step. 12:59:21 INFO - ##### 12:59:21 INFO - Running pre-action listener: _resource_record_pre_action 12:59:21 INFO - Running main action method: read_buildbot_config 12:59:21 INFO - Using buildbot properties: 12:59:21 INFO - { 12:59:21 INFO - "project": "", 12:59:21 INFO - "product": "firefox", 12:59:21 INFO - "script_repo_revision": "production", 12:59:21 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 12:59:21 INFO - "repository": "", 12:59:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 12:59:21 INFO - "buildid": "20160517073121", 12:59:21 INFO - "pgo_build": "True", 12:59:21 INFO - "basedir": "/builds/slave/test", 12:59:21 INFO - "buildnumber": 209, 12:59:21 INFO - "slavename": "talos-linux64-ix-017", 12:59:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:59:21 INFO - "platform": "ubuntu64_hw", 12:59:21 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 12:59:21 INFO - "branch": "mozilla-central", 12:59:21 INFO - "repo_path": "mozilla-central", 12:59:21 INFO - "revision": "3780a3a6b83aeda143f9562829c830410a0c961e", 12:59:21 INFO - "stage_platform": "linux64-pgo", 12:59:21 INFO - "builduid": "91748e3a507046789edb563a3e6ea041", 12:59:21 INFO - "slavebuilddir": "test" 12:59:21 INFO - } 12:59:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/ARDPPwsRRDOz2R2e9Cnw-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 12:59:21 INFO - Running post-action listener: _resource_record_post_action 12:59:21 INFO - ##### 12:59:21 INFO - ##### Finished read-buildbot-config step (success) 12:59:21 INFO - ##### 12:59:21 INFO - ##### 12:59:21 INFO - ##### Running download-and-extract step. 12:59:21 INFO - ##### 12:59:21 INFO - Running pre-action listener: _resource_record_pre_action 12:59:21 INFO - Running main action method: download_and_extract 12:59:21 INFO - mkdir: /builds/slave/test/build/tests 12:59:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:21 INFO - https://queue.taskcluster.net/v1/task/ARDPPwsRRDOz2R2e9Cnw-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:59:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ARDPPwsRRDOz2R2e9Cnw-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:59:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ARDPPwsRRDOz2R2e9Cnw-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:59:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ARDPPwsRRDOz2R2e9Cnw-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:59:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ARDPPwsRRDOz2R2e9Cnw-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:59:31 INFO - Downloaded 1361 bytes. 12:59:31 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:59:31 INFO - Using the following test package requirements: 12:59:31 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 12:59:31 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:59:31 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:59:31 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:59:31 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:59:31 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:59:31 INFO - u'jsshell-linux-x86_64.zip'], 12:59:31 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:59:31 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:59:31 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 12:59:31 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:59:31 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:59:31 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:59:31 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:59:31 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:59:31 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:59:31 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:59:31 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:59:31 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:59:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:31 INFO - https://queue.taskcluster.net/v1/task/ARDPPwsRRDOz2R2e9Cnw-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:59:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ARDPPwsRRDOz2R2e9Cnw-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:59:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ARDPPwsRRDOz2R2e9Cnw-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:59:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ARDPPwsRRDOz2R2e9Cnw-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:59:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ARDPPwsRRDOz2R2e9Cnw-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:00:01 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ARDPPwsRRDOz2R2e9Cnw-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 13:00:01 INFO - retry: attempt #1 caught exception: timed out 13:00:01 INFO - retry: Failed, sleeping 30 seconds before retrying 13:00:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ARDPPwsRRDOz2R2e9Cnw-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #2 13:00:52 INFO - Downloaded 24023024 bytes. 13:00:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:00:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:00:53 INFO - Return code: 0 13:00:53 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:00:53 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')]} 13:00:53 INFO - https://queue.taskcluster.net/v1/task/ARDPPwsRRDOz2R2e9Cnw-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:00:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ARDPPwsRRDOz2R2e9Cnw-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:00:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ARDPPwsRRDOz2R2e9Cnw-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:00:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ARDPPwsRRDOz2R2e9Cnw-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:00:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ARDPPwsRRDOz2R2e9Cnw-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:00:56 INFO - Downloaded 24023024 bytes. 13:00:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:00:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:00:58 INFO - Return code: 0 13:00: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')]} 13:00:58 INFO - https://queue.taskcluster.net/v1/task/ARDPPwsRRDOz2R2e9Cnw-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:00:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ARDPPwsRRDOz2R2e9Cnw-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:00:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ARDPPwsRRDOz2R2e9Cnw-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:00:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ARDPPwsRRDOz2R2e9Cnw-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:00:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ARDPPwsRRDOz2R2e9Cnw-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:00:59 INFO - Downloaded 10840194 bytes. 13:00:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:00:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:00:59 INFO - Return code: 0 13:00:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:59 INFO - https://queue.taskcluster.net/v1/task/ARDPPwsRRDOz2R2e9Cnw-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:00:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ARDPPwsRRDOz2R2e9Cnw-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:00:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ARDPPwsRRDOz2R2e9Cnw-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:00:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ARDPPwsRRDOz2R2e9Cnw-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:00:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ARDPPwsRRDOz2R2e9Cnw-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:01:01 INFO - Downloaded 58399391 bytes. 13:01:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ARDPPwsRRDOz2R2e9Cnw-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:01:01 INFO - mkdir: /builds/slave/test/properties 13:01:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:01:01 INFO - Writing to file /builds/slave/test/properties/build_url 13:01:01 INFO - Contents: 13:01:01 INFO - build_url:https://queue.taskcluster.net/v1/task/ARDPPwsRRDOz2R2e9Cnw-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:01:02 INFO - Running post-action listener: _resource_record_post_action 13:01:02 INFO - Running post-action listener: set_extra_try_arguments 13:01:02 INFO - ##### 13:01:02 INFO - ##### Finished download-and-extract step (success) 13:01:02 INFO - ##### 13:01:02 INFO - ##### 13:01:02 INFO - ##### Running populate-webroot step. 13:01:02 INFO - ##### 13:01:02 INFO - Running pre-action listener: _resource_record_pre_action 13:01:02 INFO - Running main action method: populate_webroot 13:01:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:01:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:01:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:01:02 INFO - '--tppagecycles', 13:01:02 INFO - '7'], 13:01:02 INFO - 'tests': ['tsvgm']}}, 13:01:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:01:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:01:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:01:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:01:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:01:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:01:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:01:02 INFO - 'talos_options': ['--disable-e10s'], 13:01:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:01:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:01:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:01:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:01:02 INFO - 'talos_options': ['--disable-e10s'], 13:01:02 INFO - 'tests': ['damp', 'tps']}, 13:01:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:01:02 INFO - 'tests': ['damp', 'tps']}, 13:01:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:01:02 INFO - 'tests': ['dromaeo_dom']}, 13:01:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:01:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:01:02 INFO - 'tests': ['a11yr', 13:01:02 INFO - 'ts_paint', 13:01:02 INFO - 'tpaint', 13:01:02 INFO - 'sessionrestore', 13:01:02 INFO - 'sessionrestore_no_auto_restore', 13:01:02 INFO - 'tabpaint']}, 13:01:02 INFO - 'other-e10s': {'tests': ['a11yr', 13:01:02 INFO - 'ts_paint', 13:01:02 INFO - 'tpaint', 13:01:02 INFO - 'sessionrestore', 13:01:02 INFO - 'sessionrestore_no_auto_restore', 13:01:02 INFO - 'tabpaint']}, 13:01:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:01:02 INFO - 'ts_paint', 13:01:02 INFO - 'tpaint', 13:01:02 INFO - 'sessionrestore', 13:01:02 INFO - 'sessionrestore_no_auto_restore', 13:01:02 INFO - 'tabpaint']}, 13:01:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:01:02 INFO - 'ts_paint', 13:01:02 INFO - 'tpaint', 13:01:02 INFO - 'sessionrestore', 13:01:02 INFO - 'sessionrestore_no_auto_restore', 13:01:02 INFO - 'tabpaint']}, 13:01:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:01:02 INFO - 'tests': ['a11yr', 13:01:02 INFO - 'ts_paint', 13:01:02 INFO - 'tpaint', 13:01:02 INFO - 'sessionrestore', 13:01:02 INFO - 'sessionrestore_no_auto_restore', 13:01:02 INFO - 'tabpaint']}, 13:01:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:01:02 INFO - 'tests': ['a11yr', 13:01:02 INFO - 'ts_paint', 13:01:02 INFO - 'tpaint', 13:01:02 INFO - 'sessionrestore', 13:01:02 INFO - 'sessionrestore_no_auto_restore', 13:01:02 INFO - 'tabpaint']}, 13:01:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:01:02 INFO - 'tests': ['tsvgx', 13:01:02 INFO - 'tsvgr_opacity', 13:01:02 INFO - 'tart', 13:01:02 INFO - 'tscrollx', 13:01:02 INFO - 'cart']}, 13:01:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:01:02 INFO - 'tsvgr_opacity', 13:01:02 INFO - 'tart', 13:01:02 INFO - 'tscrollx', 13:01:02 INFO - 'cart']}, 13:01:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:01:02 INFO - 'talos_options': ['--disable-e10s'], 13:01:02 INFO - 'tests': ['tp5o']}, 13:01:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:01:02 INFO - 'tests': ['tp5o']}, 13:01:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:01:02 INFO - 'talos_options': ['--disable-e10s', 13:01:02 INFO - '--xperf_path', 13:01:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:01:02 INFO - 'tests': ['tp5n']}, 13:01:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:01:02 INFO - 'talos_options': ['--xperf_path', 13:01:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:01:02 INFO - 'tests': ['tp5n']}}, 13:01:02 INFO - 'talos.zip': {'path': '', 13:01:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:01:02 INFO - Running post-action listener: _resource_record_post_action 13:01:02 INFO - ##### 13:01:02 INFO - ##### Finished populate-webroot step (success) 13:01:02 INFO - ##### 13:01:02 INFO - ##### 13:01:02 INFO - ##### Running create-virtualenv step. 13:01:02 INFO - ##### 13:01:02 INFO - Running pre-action listener: _resource_record_pre_action 13:01:02 INFO - Running main action method: create_virtualenv 13:01:02 INFO - Creating virtualenv /builds/slave/test/build/venv 13:01:02 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 13:01:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:01:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:01:02 INFO - Using real prefix '/usr' 13:01:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:01:02 INFO - Installing distribute.............................................................................................................................................................................................done. 13:01:04 INFO - Installing pip.................done. 13:01:04 INFO - Return code: 0 13:01:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:01:04 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')]} 13:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:01:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:04 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')]} 13:01:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:01:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:04 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 0x7f6444c90f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2714770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a39c0>, '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 0x27a48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a4d50>, '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': '0333a256a5e4f052382dd180000001b1-1463601352.890358-1880406764', '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 13:01:04 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 13:01:04 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 13:01:04 INFO - Using env: {'DISPLAY': ':0', 13:01:04 INFO - 'HOME': '/home/cltbld', 13:01:04 INFO - 'LANG': 'en_US.UTF-8', 13:01:04 INFO - 'LANGUAGE': 'en_US:en', 13:01:04 INFO - 'LOGNAME': 'cltbld', 13:01:04 INFO - 'MAIL': '/var/mail/cltbld', 13:01:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:01:04 INFO - 'MOZ_NO_REMOTE': '1', 13:01:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:01:04 INFO - 'NO_EM_RESTART': '1', 13:01:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:01:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:01:04 INFO - 'PWD': '/builds/slave/test', 13:01:04 INFO - 'SHELL': '/bin/bash', 13:01:04 INFO - 'SHLVL': '1', 13:01:04 INFO - 'TERM': 'linux', 13:01:04 INFO - 'TMOUT': '86400', 13:01:04 INFO - 'USER': 'cltbld', 13:01:04 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463601352.890358-1880406764', 13:01:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:01:04 INFO - '_': '/tools/buildbot/bin/python'} 13:01:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:01:04 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 13:01:04 INFO - Cleaning up... 13:01:04 INFO - Return code: 0 13:01:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:01:04 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')]} 13:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:01:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:04 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')]} 13:01:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:01:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:04 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 0x7f6444c90f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2714770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a39c0>, '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 0x27a48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a4d50>, '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': '0333a256a5e4f052382dd180000001b1-1463601352.890358-1880406764', '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 13:01:04 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 13:01:04 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 13:01:04 INFO - Using env: {'DISPLAY': ':0', 13:01:04 INFO - 'HOME': '/home/cltbld', 13:01:04 INFO - 'LANG': 'en_US.UTF-8', 13:01:04 INFO - 'LANGUAGE': 'en_US:en', 13:01:04 INFO - 'LOGNAME': 'cltbld', 13:01:04 INFO - 'MAIL': '/var/mail/cltbld', 13:01:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:01:04 INFO - 'MOZ_NO_REMOTE': '1', 13:01:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:01:04 INFO - 'NO_EM_RESTART': '1', 13:01:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:01:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:01:04 INFO - 'PWD': '/builds/slave/test', 13:01:04 INFO - 'SHELL': '/bin/bash', 13:01:04 INFO - 'SHLVL': '1', 13:01:04 INFO - 'TERM': 'linux', 13:01:04 INFO - 'TMOUT': '86400', 13:01:04 INFO - 'USER': 'cltbld', 13:01:04 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463601352.890358-1880406764', 13:01:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:01:04 INFO - '_': '/tools/buildbot/bin/python'} 13:01:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:01:05 INFO - Downloading/unpacking psutil>=3.1.1 13:01:05 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 13:01:05 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 13:01:05 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 13:01:05 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 13:01:05 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 13:01:05 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 13:01:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:01:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:01:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:01:07 INFO - Installing collected packages: psutil 13:01:07 INFO - Running setup.py install for psutil 13:01:07 INFO - building 'psutil._psutil_linux' extension 13:01:07 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 13:01:07 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 13:01:07 INFO - building 'psutil._psutil_posix' extension 13:01:07 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 13:01:07 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 13:01:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:01:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:01:07 INFO - Successfully installed psutil 13:01:07 INFO - Cleaning up... 13:01:07 INFO - Return code: 0 13:01:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:01:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:01:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:01:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:01:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:07 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 0x7f6444c90f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2714770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a39c0>, '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 0x27a48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a4d50>, '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': '0333a256a5e4f052382dd180000001b1-1463601352.890358-1880406764', '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 13:01:07 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 13:01:07 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 13:01:07 INFO - Using env: {'DISPLAY': ':0', 13:01:07 INFO - 'HOME': '/home/cltbld', 13:01:07 INFO - 'LANG': 'en_US.UTF-8', 13:01:07 INFO - 'LANGUAGE': 'en_US:en', 13:01:07 INFO - 'LOGNAME': 'cltbld', 13:01:07 INFO - 'MAIL': '/var/mail/cltbld', 13:01:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:01:07 INFO - 'MOZ_NO_REMOTE': '1', 13:01:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:01:07 INFO - 'NO_EM_RESTART': '1', 13:01:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:01:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:01:07 INFO - 'PWD': '/builds/slave/test', 13:01:07 INFO - 'SHELL': '/bin/bash', 13:01:07 INFO - 'SHLVL': '1', 13:01:07 INFO - 'TERM': 'linux', 13:01:07 INFO - 'TMOUT': '86400', 13:01:07 INFO - 'USER': 'cltbld', 13:01:07 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463601352.890358-1880406764', 13:01:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:01:07 INFO - '_': '/tools/buildbot/bin/python'} 13:01:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:01:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:01:07 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 13:01:07 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 13:01:07 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 13:01:07 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 13:01:07 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 13:01:07 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 13:01:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:01:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:01:09 INFO - Installing collected packages: mozsystemmonitor 13:01:09 INFO - Running setup.py install for mozsystemmonitor 13:01:09 INFO - Successfully installed mozsystemmonitor 13:01:09 INFO - Cleaning up... 13:01:10 INFO - Return code: 0 13:01:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:01: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')]} 13:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:01:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01: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')]} 13:01:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:01:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01: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', '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 0x7f6444c90f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2714770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a39c0>, '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 0x27a48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a4d50>, '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': '0333a256a5e4f052382dd180000001b1-1463601352.890358-1880406764', '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 13:01: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:01: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 blobuploader==1.2.4 13:01:10 INFO - Using env: {'DISPLAY': ':0', 13:01:10 INFO - 'HOME': '/home/cltbld', 13:01:10 INFO - 'LANG': 'en_US.UTF-8', 13:01:10 INFO - 'LANGUAGE': 'en_US:en', 13:01:10 INFO - 'LOGNAME': 'cltbld', 13:01:10 INFO - 'MAIL': '/var/mail/cltbld', 13:01:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:01:10 INFO - 'MOZ_NO_REMOTE': '1', 13:01:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:01:10 INFO - 'NO_EM_RESTART': '1', 13:01:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:01:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:01:10 INFO - 'PWD': '/builds/slave/test', 13:01:10 INFO - 'SHELL': '/bin/bash', 13:01:10 INFO - 'SHLVL': '1', 13:01:10 INFO - 'TERM': 'linux', 13:01:10 INFO - 'TMOUT': '86400', 13:01:10 INFO - 'USER': 'cltbld', 13:01:10 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463601352.890358-1880406764', 13:01:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:01:10 INFO - '_': '/tools/buildbot/bin/python'} 13:01:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:01:10 INFO - Downloading/unpacking blobuploader==1.2.4 13:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:01:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:01:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:01:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:01:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:01:12 INFO - Downloading blobuploader-1.2.4.tar.gz 13:01:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:01:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:01:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:01:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:01:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:01:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:01:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:01:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:01:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:01:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:01:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:01:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:01:12 INFO - Downloading docopt-0.6.1.tar.gz 13:01:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:01:12 INFO - Installing collected packages: blobuploader, requests, docopt 13:01:12 INFO - Running setup.py install for blobuploader 13:01:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:01:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:01:12 INFO - Running setup.py install for requests 13:01:13 INFO - Running setup.py install for docopt 13:01:13 INFO - Successfully installed blobuploader requests docopt 13:01:13 INFO - Cleaning up... 13:01:13 INFO - Return code: 0 13:01:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:01: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')]} 13:01:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:01:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01: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')]} 13:01:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:01:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:13 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 0x7f6444c90f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2714770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a39c0>, '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 0x27a48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a4d50>, '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': '0333a256a5e4f052382dd180000001b1-1463601352.890358-1880406764', '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 13:01:13 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 13:01:13 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 13:01:13 INFO - Using env: {'DISPLAY': ':0', 13:01:13 INFO - 'HOME': '/home/cltbld', 13:01:13 INFO - 'LANG': 'en_US.UTF-8', 13:01:13 INFO - 'LANGUAGE': 'en_US:en', 13:01:13 INFO - 'LOGNAME': 'cltbld', 13:01:13 INFO - 'MAIL': '/var/mail/cltbld', 13:01:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:01:13 INFO - 'MOZ_NO_REMOTE': '1', 13:01:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:01:13 INFO - 'NO_EM_RESTART': '1', 13:01:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:01:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:01:13 INFO - 'PWD': '/builds/slave/test', 13:01:13 INFO - 'SHELL': '/bin/bash', 13:01:13 INFO - 'SHLVL': '1', 13:01:13 INFO - 'TERM': 'linux', 13:01:13 INFO - 'TMOUT': '86400', 13:01:13 INFO - 'USER': 'cltbld', 13:01:13 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463601352.890358-1880406764', 13:01:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:01:13 INFO - '_': '/tools/buildbot/bin/python'} 13:01:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:01:13 INFO - Running setup.py (path:/tmp/pip-Mx4Cvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:01:13 INFO - Running setup.py (path:/tmp/pip-mTY2Hm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:01:13 INFO - Running setup.py (path:/tmp/pip-CiYjaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:01:13 INFO - Running setup.py (path:/tmp/pip-3JS5dp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:01:13 INFO - Running setup.py (path:/tmp/pip-VdVS4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:01:14 INFO - Running setup.py (path:/tmp/pip-L3TGbW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:01:14 INFO - Running setup.py (path:/tmp/pip-Venizp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:01:14 INFO - Running setup.py (path:/tmp/pip-nwsNTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:01:14 INFO - Running setup.py (path:/tmp/pip-n_G3jG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:01:14 INFO - Running setup.py (path:/tmp/pip-SJLWl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:01:14 INFO - Running setup.py (path:/tmp/pip-Nrl5o6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:01:14 INFO - Running setup.py (path:/tmp/pip-w9_nM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:01:14 INFO - Running setup.py (path:/tmp/pip-KqjrFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:01:14 INFO - Running setup.py (path:/tmp/pip-KI5NhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:01:14 INFO - Running setup.py (path:/tmp/pip-TJEbrI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:01:14 INFO - Running setup.py (path:/tmp/pip-R5Myku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:01:14 INFO - Running setup.py (path:/tmp/pip-o46dZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:01:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:01:14 INFO - Running setup.py install for manifestparser 13:01:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:01:14 INFO - Running setup.py install for mozcrash 13:01:15 INFO - Running setup.py install for mozdebug 13:01:15 INFO - Running setup.py install for mozdevice 13:01:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:01:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:01:15 INFO - Running setup.py install for mozfile 13:01:15 INFO - Running setup.py install for mozhttpd 13:01:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:01:15 INFO - Running setup.py install for mozinfo 13:01:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:01:15 INFO - Running setup.py install for mozInstall 13:01:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:01:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:01:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:01:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:01:15 INFO - Running setup.py install for mozleak 13:01:15 INFO - Running setup.py install for mozlog 13:01:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:01:15 INFO - Running setup.py install for moznetwork 13:01:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:01:16 INFO - Running setup.py install for mozprocess 13:01:16 INFO - Running setup.py install for mozprofile 13:01:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:01:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:01:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:01:16 INFO - Running setup.py install for mozrunner 13:01:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:01:16 INFO - Running setup.py install for mozscreenshot 13:01:16 INFO - Running setup.py install for moztest 13:01:16 INFO - Running setup.py install for mozversion 13:01:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:01:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:01:16 INFO - Cleaning up... 13:01:16 INFO - Return code: 0 13:01:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:01: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')]} 13:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:01:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01: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')]} 13:01:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:01:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:16 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 0x7f6444c90f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2714770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a39c0>, '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 0x27a48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a4d50>, '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': '0333a256a5e4f052382dd180000001b1-1463601352.890358-1880406764', '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 13:01:16 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 13:01:16 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 13:01:16 INFO - Using env: {'DISPLAY': ':0', 13:01:16 INFO - 'HOME': '/home/cltbld', 13:01:16 INFO - 'LANG': 'en_US.UTF-8', 13:01:16 INFO - 'LANGUAGE': 'en_US:en', 13:01:16 INFO - 'LOGNAME': 'cltbld', 13:01:16 INFO - 'MAIL': '/var/mail/cltbld', 13:01:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:01:16 INFO - 'MOZ_NO_REMOTE': '1', 13:01:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:01:16 INFO - 'NO_EM_RESTART': '1', 13:01:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:01:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:01:16 INFO - 'PWD': '/builds/slave/test', 13:01:16 INFO - 'SHELL': '/bin/bash', 13:01:16 INFO - 'SHLVL': '1', 13:01:16 INFO - 'TERM': 'linux', 13:01:16 INFO - 'TMOUT': '86400', 13:01:16 INFO - 'USER': 'cltbld', 13:01:16 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463601352.890358-1880406764', 13:01:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:01:16 INFO - '_': '/tools/buildbot/bin/python'} 13:01:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:01:16 INFO - Running setup.py (path:/tmp/pip-yR1H26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:01:16 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)) 13:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:01:16 INFO - Running setup.py (path:/tmp/pip-9OitBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:01:17 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)) 13:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:01:17 INFO - Running setup.py (path:/tmp/pip-1kIjyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:01:17 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)) 13:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:01:17 INFO - Running setup.py (path:/tmp/pip-Rqj6iJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:01:17 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)) 13:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:01:17 INFO - Running setup.py (path:/tmp/pip-XIFTpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:01:17 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)) 13:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:01:17 INFO - Running setup.py (path:/tmp/pip-OIXYlF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:01:17 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)) 13:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:01:17 INFO - Running setup.py (path:/tmp/pip-0r9Lrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:01:17 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)) 13:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:01:17 INFO - Running setup.py (path:/tmp/pip-y2lRn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:01:17 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)) 13:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:01:17 INFO - Running setup.py (path:/tmp/pip-QZIp_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:01:17 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)) 13:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:01:17 INFO - Running setup.py (path:/tmp/pip-UGGMuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:01:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 13:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:01:17 INFO - Running setup.py (path:/tmp/pip-TmcPPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:01:17 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)) 13:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:01:17 INFO - Running setup.py (path:/tmp/pip-0rk_W4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:01:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 13:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:01:17 INFO - Running setup.py (path:/tmp/pip-7AR8WE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:01:17 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)) 13:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:01:17 INFO - Running setup.py (path:/tmp/pip-1vjONV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:01:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 13:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:01:17 INFO - Running setup.py (path:/tmp/pip-fZLsN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:01:17 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)) 13:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:01:17 INFO - Running setup.py (path:/tmp/pip-HKOQIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:01:18 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)) 13:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:01:18 INFO - Running setup.py (path:/tmp/pip-5YLR_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:01:18 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)) 13:01:18 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)) 13:01:18 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)) 13:01:18 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)) 13:01:18 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)) 13:01:18 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)) 13:01:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:01: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 13:01: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 13:01: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 13:01: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 13:01: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 13:01: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 13:01:19 INFO - Downloading blessings-1.6.tar.gz 13:01:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:01:20 INFO - Installing collected packages: blessings 13:01:20 INFO - Running setup.py install for blessings 13:01:20 INFO - Successfully installed blessings 13:01:20 INFO - Cleaning up... 13:01:20 INFO - Return code: 0 13:01:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:01:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:01:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:01:20 INFO - Reading from file tmpfile_stdout 13:01:20 INFO - Current package versions: 13:01:20 INFO - argparse == 1.2.1 13:01:20 INFO - blessings == 1.6 13:01:20 INFO - blobuploader == 1.2.4 13:01:20 INFO - docopt == 0.6.1 13:01:20 INFO - manifestparser == 1.1 13:01:20 INFO - mozInstall == 1.12 13:01:20 INFO - mozcrash == 0.17 13:01:20 INFO - mozdebug == 0.1 13:01:20 INFO - mozdevice == 0.48 13:01:20 INFO - mozfile == 1.2 13:01:20 INFO - mozhttpd == 0.7 13:01:20 INFO - mozinfo == 0.9 13:01:20 INFO - mozleak == 0.1 13:01:20 INFO - mozlog == 3.2 13:01:20 INFO - moznetwork == 0.27 13:01:20 INFO - mozprocess == 0.22 13:01:20 INFO - mozprofile == 0.28 13:01:20 INFO - mozrunner == 6.11 13:01:20 INFO - mozscreenshot == 0.1 13:01:20 INFO - mozsystemmonitor == 0.3 13:01:20 INFO - moztest == 0.7 13:01:20 INFO - mozversion == 1.4 13:01:20 INFO - psutil == 3.1.1 13:01:20 INFO - requests == 1.2.3 13:01:20 INFO - wsgiref == 0.1.2 13:01:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:01:20 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')]} 13:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:01:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:20 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')]} 13:01:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:01:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:20 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 0x7f6444c90f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2714770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a39c0>, '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 0x27a48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a4d50>, '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': '0333a256a5e4f052382dd180000001b1-1463601352.890358-1880406764', '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 13:01:20 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 13:01:20 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 13:01:20 INFO - Using env: {'DISPLAY': ':0', 13:01:20 INFO - 'HOME': '/home/cltbld', 13:01:20 INFO - 'LANG': 'en_US.UTF-8', 13:01:20 INFO - 'LANGUAGE': 'en_US:en', 13:01:20 INFO - 'LOGNAME': 'cltbld', 13:01:20 INFO - 'MAIL': '/var/mail/cltbld', 13:01:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:01:20 INFO - 'MOZ_NO_REMOTE': '1', 13:01:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:01:20 INFO - 'NO_EM_RESTART': '1', 13:01:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:01:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:01:20 INFO - 'PWD': '/builds/slave/test', 13:01:20 INFO - 'SHELL': '/bin/bash', 13:01:20 INFO - 'SHLVL': '1', 13:01:20 INFO - 'TERM': 'linux', 13:01:20 INFO - 'TMOUT': '86400', 13:01:20 INFO - 'USER': 'cltbld', 13:01:20 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463601352.890358-1880406764', 13:01:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:01:20 INFO - '_': '/tools/buildbot/bin/python'} 13:01:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:01:20 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)) 13:01:20 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)) 13:01:20 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)) 13:01:20 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)) 13:01:20 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)) 13:01:20 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)) 13:01:20 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)) 13:01:20 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)) 13:01:20 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)) 13:01:20 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)) 13:01:20 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)) 13:01:20 INFO - Cleaning up... 13:01:20 INFO - Return code: 0 13:01:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:01:20 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')]} 13:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:01:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:20 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')]} 13:01:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:01:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:20 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 0x7f6444c90f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2714770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a39c0>, '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 0x27a48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a4d50>, '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': '0333a256a5e4f052382dd180000001b1-1463601352.890358-1880406764', '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 13:01:20 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 13:01:20 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 13:01:20 INFO - Using env: {'DISPLAY': ':0', 13:01:20 INFO - 'HOME': '/home/cltbld', 13:01:20 INFO - 'LANG': 'en_US.UTF-8', 13:01:20 INFO - 'LANGUAGE': 'en_US:en', 13:01:20 INFO - 'LOGNAME': 'cltbld', 13:01:20 INFO - 'MAIL': '/var/mail/cltbld', 13:01:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:01:20 INFO - 'MOZ_NO_REMOTE': '1', 13:01:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:01:20 INFO - 'NO_EM_RESTART': '1', 13:01:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:01:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:01:20 INFO - 'PWD': '/builds/slave/test', 13:01:20 INFO - 'SHELL': '/bin/bash', 13:01:20 INFO - 'SHLVL': '1', 13:01:20 INFO - 'TERM': 'linux', 13:01:20 INFO - 'TMOUT': '86400', 13:01:20 INFO - 'USER': 'cltbld', 13:01:20 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463601352.890358-1880406764', 13:01:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:01:20 INFO - '_': '/tools/buildbot/bin/python'} 13:01:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:01:20 INFO - Downloading/unpacking jsonschema 13:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:01:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:01:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:01:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:01:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:01:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:01:22 INFO - Downloading/unpacking functools32 (from jsonschema) 13:01:22 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 13:01:22 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 13:01:22 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 13:01:22 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 13:01:22 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 13:01:22 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 13:01:22 INFO - Downloading functools32-3.2.3-2.tar.gz 13:01:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:01:23 INFO - warning: no files found matching '*.txt' 13:01:23 INFO - no previously-included directories found matching 'build' 13:01:23 INFO - no previously-included directories found matching 'dist' 13:01:23 INFO - no previously-included directories found matching '.git*' 13:01:23 INFO - Installing collected packages: jsonschema, functools32 13:01:23 INFO - Running setup.py install for functools32 13:01:23 INFO - warning: no files found matching '*.txt' 13:01:23 INFO - no previously-included directories found matching 'build' 13:01:23 INFO - no previously-included directories found matching 'dist' 13:01:23 INFO - no previously-included directories found matching '.git*' 13:01:23 INFO - Successfully installed jsonschema functools32 13:01:23 INFO - Cleaning up... 13:01:23 INFO - Return code: 0 13:01:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:01:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:01:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:01:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:01:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:01:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6444c90f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2714770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a39c0>, '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 0x27a48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a4d50>, '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': '0333a256a5e4f052382dd180000001b1-1463601352.890358-1880406764', '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 13:01:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 13:01:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:01:23 INFO - Using env: {'DISPLAY': ':0', 13:01:23 INFO - 'HOME': '/home/cltbld', 13:01:23 INFO - 'LANG': 'en_US.UTF-8', 13:01:23 INFO - 'LANGUAGE': 'en_US:en', 13:01:23 INFO - 'LOGNAME': 'cltbld', 13:01:23 INFO - 'MAIL': '/var/mail/cltbld', 13:01:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:01:23 INFO - 'MOZ_NO_REMOTE': '1', 13:01:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:01:23 INFO - 'NO_EM_RESTART': '1', 13:01:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:01:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:01:23 INFO - 'PWD': '/builds/slave/test', 13:01:23 INFO - 'SHELL': '/bin/bash', 13:01:23 INFO - 'SHLVL': '1', 13:01:23 INFO - 'TERM': 'linux', 13:01:23 INFO - 'TMOUT': '86400', 13:01:23 INFO - 'USER': 'cltbld', 13:01:23 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463601352.890358-1880406764', 13:01:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:01:23 INFO - '_': '/tools/buildbot/bin/python'} 13:01:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:01:23 INFO - Downloading/unpacking flake8 13:01:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:01:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:01:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:01:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:01:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:01:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:01:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:01:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:01:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:01:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:01:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:01:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:01:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:01:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:01:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:01:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:01:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:01:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:01:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:01:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:01:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:01:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:01:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:01:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:01:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:01:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:01:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:01:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:01:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:01:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:01:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:01:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:01:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:01:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:01:26 INFO - no previously-included directories found matching 'docs/_build' 13:01:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:01:26 INFO - Running setup.py install for pep8 13:01:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:01:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:01:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:01:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:01:26 INFO - no previously-included directories found matching 'docs/_build' 13:01:26 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:01:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:01:26 INFO - Cleaning up... 13:01:26 INFO - Return code: 0 13:01:26 INFO - Running post-action listener: _resource_record_post_action 13:01:26 INFO - Running post-action listener: _start_resource_monitoring 13:01:26 INFO - Starting resource monitoring. 13:01:26 INFO - ##### 13:01:26 INFO - ##### Finished create-virtualenv step (success) 13:01:26 INFO - ##### 13:01:26 INFO - ##### 13:01:26 INFO - ##### Running install step. 13:01:26 INFO - ##### 13:01:26 INFO - Running pre-action listener: _resource_record_pre_action 13:01:26 INFO - Running main action method: install 13:01:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:01:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:01:26 INFO - Reading from file tmpfile_stdout 13:01:26 INFO - Detecting whether we're running mozinstall >=1.0... 13:01:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:01:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:01:26 INFO - Reading from file tmpfile_stdout 13:01:26 INFO - Output received: 13:01:26 INFO - Usage: mozinstall [options] installer 13:01:26 INFO - Options: 13:01:26 INFO - -h, --help show this help message and exit 13:01:26 INFO - -d DEST, --destination=DEST 13:01:26 INFO - Directory to install application into. [default: 13:01:26 INFO - "/builds/slave/test"] 13:01:26 INFO - --app=APP Application being installed. [default: firefox] 13:01:26 INFO - mkdir: /builds/slave/test/build/application 13:01:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:01:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:01:43 INFO - Reading from file tmpfile_stdout 13:01:43 INFO - Output received: 13:01:43 INFO - /builds/slave/test/build/application/firefox/firefox 13:01:43 INFO - Running post-action listener: _resource_record_post_action 13:01:43 INFO - ##### 13:01:43 INFO - ##### Finished install step (success) 13:01:43 INFO - ##### 13:01:43 INFO - ##### 13:01:43 INFO - ##### Running run-tests step. 13:01:43 INFO - ##### 13:01:43 INFO - Running pre-action listener: _resource_record_pre_action 13:01:43 INFO - Running main action method: run_tests 13:01:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:01:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:01:43 INFO - Python 2.7.3 13:01:43 INFO - Return code: 0 13:01:43 INFO - grabbing minidump binary from tooltool 13:01:43 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')]} 13:01:43 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 0x27a39c0>, '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 0x27a48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a4d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:01:43 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 13:01:43 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 13:01:43 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 13:01:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:01:43 INFO - Return code: 0 13:01:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:01:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:01:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:01:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:01:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:01:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:01:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:01:44 INFO - Return code: 0 13:01:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ARDPPwsRRDOz2R2e9Cnw-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 13:01:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ARDPPwsRRDOz2R2e9Cnw-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 13:01:44 INFO - Using env: {'DISPLAY': ':0', 13:01:44 INFO - 'HOME': '/home/cltbld', 13:01:44 INFO - 'LANG': 'en_US.UTF-8', 13:01:44 INFO - 'LANGUAGE': 'en_US:en', 13:01:44 INFO - 'LOGNAME': 'cltbld', 13:01:44 INFO - 'MAIL': '/var/mail/cltbld', 13:01:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:01:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:01:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:01:44 INFO - 'MOZ_NO_REMOTE': '1', 13:01:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:01:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:01:44 INFO - 'NO_EM_RESTART': '1', 13:01:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:01:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:01:44 INFO - 'PWD': '/builds/slave/test', 13:01:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:01:44 INFO - 'SHELL': '/bin/bash', 13:01:44 INFO - 'SHLVL': '1', 13:01:44 INFO - 'TERM': 'linux', 13:01:44 INFO - 'TMOUT': '86400', 13:01:44 INFO - 'USER': 'cltbld', 13:01:44 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463601352.890358-1880406764', 13:01:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:01:44 INFO - '_': '/tools/buildbot/bin/python'} 13:01:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ARDPPwsRRDOz2R2e9Cnw-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 13:01:44 INFO - mozversion application_buildid: 20160517073121 13:01:44 INFO - mozversion application_changeset: 3780a3a6b83aeda143f9562829c830410a0c961e 13:01:44 INFO - mozversion application_display_name: Nightly 13:01:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:01:44 INFO - mozversion application_name: Firefox 13:01:44 INFO - mozversion application_remotingname: firefox 13:01:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:01:44 INFO - mozversion application_vendor: Mozilla 13:01:44 INFO - mozversion application_version: 49.0a1 13:01:44 INFO - mozversion platform_buildid: 20160517073121 13:01:44 INFO - mozversion platform_changeset: 3780a3a6b83aeda143f9562829c830410a0c961e 13:01:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:01:44 INFO - mozversion platform_version: 49.0a1 13:01:44 INFO - using testdate: 1463601704 13:01:44 INFO - actual date: 1463601704 13:01:44 INFO - starting webserver on 'localhost:40345' 13:01:44 INFO - SUITE-START | Running 2 tests 13:01:44 INFO - TEST-START | dromaeo_css 13:01:44 INFO - operating with platform_type : linux_ 13:01:44 INFO - Initialising browser for dromaeo_css test... 13:01:44 INFO - TEST-INFO | started process 4040 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaOSViJ/profile http://localhost:40345/getInfo.html) 13:01:47 INFO - PROCESS | 4040 | 13:01:47 INFO - PROCESS | 4040 | (process:4110): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:01:48 INFO - PROCESS | 4040 | __metrics Screen width/height:1600/1200 13:01:48 INFO - PROCESS | 4040 | colorDepth:24 13:01:48 INFO - PROCESS | 4040 | Browser inner width/height: 1024/697 13:01:48 INFO - PROCESS | 4040 | __metrics 13:01:49 ERROR - PROCESS | 4040 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 13:01:49 INFO - TEST-INFO | 4040: exit 0 13:01:49 INFO - Browser initialized. 13:01:49 INFO - Running cycle 1/1 for dromaeo_css test... 13:01:49 INFO - TEST-INFO | started process 4161 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaOSViJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:01:51 INFO - PROCESS | 4161 | 13:01:51 INFO - PROCESS | 4161 | (process:4224): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:02:01 INFO - PROCESS | 4161 | RSS: Main: 163209216 13:02:01 INFO - PROCESS | 4161 | 13:02:51 INFO - PROCESS | 4161 | 1463601771222 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] 13:04:59 INFO - PROCESS | 4161 | Cycle 1(1): loaded http://localhost:40345/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40345/tests/dromaeo/cssquery-ext.html) 13:05:00 INFO - PROCESS | 4161 | RSS: Main: 166547456 13:05:00 INFO - PROCESS | 4161 | 13:08:02 INFO - PROCESS | 4161 | Cycle 1(1): loaded http://localhost:40345/tests/dromaeo/cssquery-ext.html (next: http://localhost:40345/tests/dromaeo/cssquery-jquery.html) 13:08:02 INFO - PROCESS | 4161 | RSS: Main: 166547456 13:08:02 INFO - PROCESS | 4161 | 13:11:04 INFO - PROCESS | 4161 | Cycle 1(1): loaded http://localhost:40345/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40345/tests/dromaeo/cssquery-mootools.html) 13:11:05 INFO - PROCESS | 4161 | RSS: Main: 167329792 13:11:05 INFO - PROCESS | 4161 | 13:14:06 INFO - PROCESS | 4161 | Cycle 1(1): loaded http://localhost:40345/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40345/tests/dromaeo/cssquery-prototype.html) 13:14:07 INFO - PROCESS | 4161 | RSS: Main: 165150720 13:14:07 INFO - PROCESS | 4161 | 13:17:09 INFO - PROCESS | 4161 | Cycle 1(1): loaded http://localhost:40345/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40345/tests/dromaeo/cssquery-yui.html) 13:17:10 INFO - PROCESS | 4161 | RSS: Main: 166952960 13:17:10 INFO - PROCESS | 4161 | 13:20:12 INFO - PROCESS | 4161 | Cycle 1(1): loaded http://localhost:40345/tests/dromaeo/cssquery-yui.html (next: http://localhost:40345/tests/dromaeo/cssquery-dojo.html) 13:20:12 INFO - PROCESS | 4161 | RSS: Main: 168583168 13:20:12 INFO - PROCESS | 4161 | 13:20:12 INFO - PROCESS | 4161 | __start_tp_report 13:20:12 INFO - PROCESS | 4161 | _x_x_mozilla_page_load 13:20:12 INFO - PROCESS | 4161 | _x_x_mozilla_page_load_details 13:20:12 INFO - PROCESS | 4161 | |i|pagename|runs| 13:20:12 INFO - PROCESS | 4161 | |0;dojo.html;3203.551502789609;3205.791623544471;3225.822579758112;3246.2371342734446;3263.6899494548024;5477.808276710321;5495.368032676243;5544.140658197981;5550.77796888124;5581.079121944885;5436.945630543693;5542.418046105161;5550.306211723524;5583.972080139603;5606;4985.52637499437;4997.325361076263;5106.514881086309;5135.666181698196;5143.794248230066;5065.518775716301;5205.479452054802;5229.398619158788;5240.161574148137;5249.8950020999555;4958.281049247875;4964.851054468371;5017.996400719834;5070.036693028313;5072.771725272353;5029.245613158056;5033.1695270280725;5037.0429618372755;5040.218766091261;5087.058894104603;4995.025969935864;5016.548510634024;5028.245763135523;5031.270465782441;5044.092063428581;5386.73066346685;5417.431169727161;5420.457954204588;5452.536534394581;5487.807926722586;5991.340952495222;5996.130561068664;6015.849603759897;6027.517798576104;6046.5767396281835;5942.702864856783;5955.106733989893;6092.329843717188;6094.902917474853;6098.481629061535;5548.611597188198;5579.525740312038;5597.636153650041;5601.831945041656;5623.7469313880565;6131.417515336036;6136.9079463808075;6151.907721384183;6152.538559608047;6159.84600384994;5716.5998380113;5803.941960580424;5827.009408400498;5886.676232807236;5892.175095486636;5986.970065149646;5989.790357337472;5996.640201587831;6002.159697642333;6038.245219347582;5851.882962340729;5909.202257695242;5944.7027648617395;5967.045272756425;5990.850228744316;5950.672713000827;5985.730642121115;5999.970000150059;6013.338532761392;6058.636481811105;4504.48198457175;4505.819767209275;4529.275315949498;4546.272596384562;4557.703749256354;3910.765354078764;3984.7409918355215;4016.1766837798764;4019.91960160801;4091.243120022805;5668;5684.459976302244;5703.771849125988;5704.857378565569;5804.100364443518;5952.166696662471;5969.76120955157;5973.790917317873;5983.521318294526;6041.818745437556;5599.972000140055;5708.80019199326;5710.086386178275;5738.540916726735;5754.683492407958;5134.871628209325;5162.045021671003;5169.560587350042;5169.793208271627;5187.792488300426;6272.3100458949475;6299.212598425197;6308.400701933309;6313.337099604567;6316.715747791361;5851.6781577012825;5911.497522710618;5931.110333450017;5967.403259674172;6031.276246850406;6175.907361389673;6220.222472190976;6228.781992630236;6235.875282494416;6251.53113516479;5679.091345384719;5910.202122713378;5920.763169473173;5921.111833225051;5955.225820643462;5990.610610310316;6005.6396616203165;6015.789447369321;6047.183630209865;6061.878762424815;5747.770089196385;5793.739281732248;5837.387074357302;5844.357120716632;5852.151438041546;5720.3707592164;5761.625494342854;5791.102379131242;5866.853328666647;5882.5293976482635;5534.446555344433;5671.829845104653;5676.858078548069;5681.431856814285;5784;5831.825045248649;5869.618474799125;5880.911786323294;5914.4381283777975;5919.6744179070565;5614.9719251403485;5641.661500309994;5778.335491418373;5806.361300256884;5809 13:20:12 INFO - PROCESS | 4161 | |1;ext.html;601.0353382820573;646.085788609118;649.451213724403;659.5020759326708;667.7929841749058;33664.83167584162;43736.12527749447;44511.55488445111;44697.329540056926;44699.55300446995;45841.770791145995;46439.53560464403;46456.3031554527;46467;46663.53336466634;8805.95597022014;8932.285417166611;9018.278537716968;9024.368294219406;9032.32257580684;8863.689770858022;8954.37319387643;8994.68518601849;8996;9003.684871029514;8987.281017518582;9028.68399606014;9030.954845225764;9031.367804253705;9040.321975851804;8911.108889111101;8931.151540603632;8964.820703585958;8974.371793974424;8977.102289771035;8781.253593444564;8844.46933184011;8904.287656987426;8916.242119419858;8916.643334266622;42412.78793606012;42684.573154268684;43022.35466468005;43040.784796076136;43194.352084718754;3322.7175690066374;3427.4344733119256;3507.2634746703225;3553.875614353485;4197.769122698251;32280.192995175075;32632;32731.345373092405;33111.50332745011;34182.316353673035;4339.218940590692;4351.673624478177;4409.470863496369;4411.580899814545;4510.391097201868;348079;348448;348852;349675;350908;35075.29849402998;35837.46243806345;35937.82031089828;37897.62102378941;58171.70914145402;37651.81174094112;37976.43035354472;38111.61888381081;38158.61841381606;38312.233755324734;14156.433742650384;14239.43042278318;14263;14306.499272525412;14326.57020289393;12137.575184868487;12177.330246836333;12207.511699532097;12229.266244025386;12281.710420405907;8504.914950850536;8550.144985501525;8597.355198360148;8604.053554109043;8643.265322447662;3311.536384906067;3324.1855745342064;3384.2554637979606;3384.966150338514;3471.8264086795557;1046.1839764983324;1081.6538707613488;1093.147345070846;1102.581019212694;1113.9665810025713;33012.1746956328;33099.17252068669;33356.3328733424;33401.32585415651;33671.15822104467;1138.59579849154;1172.935488548138;1177.3963801535954;1193.8746431624554;1208.4924331780674;17299.30802767875;17313.91343043302;17398.826011739722;17461.38885139014;17749.290028398977;520421;523554;523836;524326;526883;59048;59397.70301148553;59788;59923.101153482734;60024;1397.6436008817686;1439.6760728836139;1453.789200565912;1459.489178787416;1464.8388677245493;31697.5245371315;32274.838625806722;32470.40236781099;32486.35027299488;32914.34171316608;47206.29190562213;47628.7618561905;47677.76161119172;47697;47716.284255735496;443109;450428;450842;452014;452607;28645;28664.14007579776;28761.856190718914;28954.855225723735;29087.56368654514;48597;48708.756456217496;49217;49560;49690;41418.792906035276;42149.367759484245;42512.78743606386;42717.78641106775;42988;40245.39631905465;41268.38097428601;41789;41947.16105677808;42806;43180.56819431765;45969.31046034379;45988.31017534673;46973.76513117413;47066.529334707586;36618;36767;37511.43732844064;37916.62083379131;38100.23799523938;28666.42667146687;29559.26101847471;29573.852130739207;29854.552181716856;29893.402131956806 13:20:12 INFO - PROCESS | 4161 | |2;jquery.html;405.26849037487335;408.67714505540624;414.5729898204849;416.2133567557317;431.92873175925973;16190.595235119128;18194.454166375013;19093;19963;20120;19009.619807603838;19024.714629280537;20146.798532014676;20199.697004544945;20202.19191232349;5678.99999999999;5884.6763428011445;5888.558358123137;5912.231409916726;5925.111233314994;5620.9437905620825;5722.427757224265;5743.10981797822;5764.221830052952;5778.682172480512;5680.5455563554815;5799.565032622549;5824.184614154022;5824.650520968756;5841.853953651172;5762.481376676119;5779.1620215069;5780.710964451781;5781.884362312751;5824.650520968734;5078.238264260353;5173.870653233662;5183.766730497136;5196.948030519684;5199.272101905736;20177;22235.777642223693;23981.280561583182;23987.52024959491;24052.278431646904;2177.292379976514;2346.4016675747744;2364.822638302117;2965.911022669302;3072.339447018902;10208.846867296996;10419.583216671399;10605.257631965766;10908.181886358554;11493.5977240797;1922.1158267197106;1971.2312198242696;1987.6010141023569;2024.6355655982065;2077.4079387374677;73449.6327518359;84639.57680211621;85331;86026.56986715026;86631.56684216602;11305.434728263554;11361.14791390649;11420.428978551205;11424.200305978668;11474.426278686033;13083.869161308456;14653.780193296896;15540.84459155394;16032.438864639682;16116.274767635485;7929.52422854619;7955;8140;8250.628721707537;8307.460015098999;7505.174430812606;7542.208068152875;7681.961590192125;7715.729949451742;7727.613619319124;4836.492168322276;4848.933234688363;4931.679440836334;5004.374453193351;5009.273655319958;1922.5770330527262;1966.3117908732115;2033.0851116997114;2059.6910463430604;2062.3709768520444;921.9262459003397;1004.8894621591619;1045.325764881647;1061.1192710050639;1077.9892201078046;18809.529761756065;19454;19758.60482790336;19772.11025503827;19927.800721992884;1000.4547521600599;1011.4335971855784;1018.8930162332997;1076.1928553584812;1084.924055316136;10762;11177.944110279397;11200.831987520194;11219.102471802236;11269.661910142544;477143;478770.486065972;485313;487334;498503;59748;66314.66842665852;72529.6373518129;80863;96595.7212781167;1021.4739409204266;1027.0551092994463;1032.3805716569998;1047.7537778622018;1052.095198129608;17205.741913871552;17291.481255562354;17332.30670773155;17579;17595;30223.69776302209;33424.83287583546;38089;38365.80817095897;41390.96522586959;55346.72326638341;55570.166447504125;55584.444155557925;56309;57626.7118664404;8572.228499435081;8799.90491942901;8898.911010889808;9123.178913897782;9160.267178625827;12850.293233871853;13729.176249425067;13868.306584670525;13964.37160327808;14082.366293516612;11752.647420577396;11782.87599340224;11816.70458238551;11824.527018919147;11924.523019079139;11682.357470339213;11729.003034742142;12011.099167562294;12033.097517686034;12153.574624888086;11647;11899.286042837457;11952.64142075739;12092.576759813364;12195;8646.697365592174;8834.955825220834;8923.15230053144;8960.731178064669;9064.50145242018;10914.32167580681;12513.93743031279;12691.365431728193;12821.551245706356;12888.226706397647 13:20:12 INFO - PROCESS | 4161 | |3;mootools.html;1542.7994360733107;1569.8351673074326;1720.6644704282662;1797.1912639312313;1809.6833054215508;7973;8320.583970801466;8675.479471231723;9166.212588545228;9169.174774270314;8283.088860225385;8524.360672949522;8556.486610803357;8572.142785721424;8585.871211931826;2335.6730057791924;2387.7970372518357;2390.521895620874;2393.102586530051;2396.2332053742807;2287.9885600572056;2312.7455979842202;2312.7455979842202;2313.7570555091725;2317.0152685108847;2312.2369618026096;2328.7205535335784;2344.9413764655933;2375.3705268103968;2375.406148462884;2280.1791355112146;2291.9885400572975;2294.0365046680436;2325.616273314901;2329.801966832821;2303.9308820735405;2323.744388117306;2331.6269396896414;2333.6382860656627;2350.976490235093;8493.66025358985;8623.396362254645;8633.395662303641;8668.30653547721;8712.21590056898;4952.504749525055;4967.180415231483;5085.720285384303;5094.770735316883;5109.693418394871;3349.899503014889;3366.360391525602;3407.812570308632;3420.555327807394;3429.725621950238;1105.2981356838386;1124.9943750281277;1128.6614015795228;1132.6828488023366;1142.9371384573844;11829.704257393549;11831.408429578572;11899.940500297529;11946.701332466759;11993.880061199363;4547.5679810418615;4678.836240731558;4700.224462963641;4707.835225767081;4709.270063140219;10190.235732319958;10193.388396696222;10199.337043092324;10203.489825508696;10209.693709188736;5182.196759502283;5318;5318.282031925718;5319.5744340452675;5322.14845624706;4268.765217913045;4719.221328480831;4811.27830825379;4817.421909370828;4830.106430310404;4122.732022418533;4194.307939189999;4216.177845320133;4255.063885945087;4339.696221264481;1296.857345691973;1317.6705823544114;1322.4776213395846;1326.038621999043;1343.3081962789172;855.9529225892636;908.9818203636022;950.1970834644715;984.3749219245688;991.9851202231972;5961.225040744675;6012.969935150296;6105.419985101408;6115.327313995457;6196.3803619638575;436.5220084008006;438.2462165076064;441.5849101844256;442.63703762914747;446.1812573926816;4205.011822221775;4234.809433575497;4240;4255.8084886180195;4258.318669012943;11000;11352.091832653368;11374.715632109264;11377.658670239905;11391.430428478543;11221.831672524919;11327.150463715254;11350.148738844455;11358.26171298863;11370.09039276856;7759.0689117305155;7990.880136797953;7994.480358776661;8145.3483721302155;8202.835943281101;5936.5844390892225;6040.969795150996;6142.631442113308;6144.293406258159;6168.1056246844855;9487.857682134636;9743.561539730586;9758.658446954323;9939.105480506789;9946.005399460286;9985.251106166921;10024.899751002396;10033;10045.196384289093;10070.244731645302;6895.103636527219;7186.245444228281;7444.069491313586;7652.387808975157;7671.041119860018;8161.306288965505;8236.629351679068;8258.29804466603;8287.792805179919;8315.043769966289;7359.300866417681;7600.80997975055;7618.276263754934;7683.040824589694;7721.691132354643;7510.436717246338;7610.733624323122;7630.084389873251;7666.961665191861;7697.961510192637;6971.0937578116545;7010.158780946319;7020.929790702232;7028.683709233199;7046.436285097282;5184.481551844936;5190.740462976912;5350.5184533392185;5359.732013399236;5421.481985044194;5198.402183748766;5281.234221037851;5408.37803652585;5610.102383618601;5706.514946229451 13:20:12 INFO - PROCESS | 4161 | |4;prototype.html;331.5557153414424;336.8703049326009;340.99147521311977;345.22669220945073;349.11499349149904;5535.308086489189;5629.410471183261;5731.283589551306;5811.0702287633985;5812.970935145324;5601.971990140044;5679.716014199284;5692.5161361284345;5696.344920334162;5701.0878259478495;4463.352813841982;4467.97236635574;4469.240229161051;4477.865664030084;4481.417415735966;4351.4343135392355;4385.693001489897;4407;4410.55894410558;4485.52901945296;4323;4340.56594340565;4345.739735476708;4354.956450435503;4364.563543645641;4368.453943257093;4378.912421751563;4382.276924307485;4389.912201755947;4401.943533551925;3844.6347596978244;3908.9804550977065;3932.8565931567364;3965.920681586352;3971.1660551284267;5382.0581398255545;5415.945840541623;5472.315960504937;5489.58828087895;5517.393086760453;5071.416787069497;5078.7303174206445;5103.591712663015;5114.130597798346;5128.5640720538795;5573.693446860421;5926;5939.821805345847;5975.416514623628;5992.921274170648;4281.614654681093;4288.785560721952;4311.50417701962;4319.3952846601505;4339.826406943718;6143.692815359259;6186.19579454668;6187.617767159631;6198.690065496708;6209.782657606962;4030.4760381150263;4256.659467242614;4258.254805409041;4270.41994462051;4442.333649952533;4309.655227581786;4324.200022995756;4328.653707703376;4330.112326972963;4339.500957389941;4957.553820156203;4995.200767877122;4996.575291100297;5009.949900501021;5010.498950105033;5792.565557583198;5811.564132690065;5862.296524417097;5887.293524776968;5990.341062483123;1508.5323549699408;1517.2034681791927;1522.7563589825575;1529.3806008566548;1533.4939469974881;951.6574033347989;970.0735797313548;974.9658761943298;982.5185659027026;984.448708723103;5059.443461219263;5117.974410127926;5175.489887404606;5198.766055527511;5201.115810312181;5369.6509726867625;5377.838664840061;5386.326709161355;5386.515213630713;5506.889862202734;4941.975290123526;5031.924521132186;5185.766640501187;5216.165413533817;5220;2894.45005448964;2927.238917881366;2930.168644597127;2973.8661760220843;2977.374751302251;5661.716914154358;5665.235193248858;5670.8015219467125;5675.205471233948;5703.230063941315;5216.313598496778;5499.477549632778;5502.669839809624;5546.611737178439;5577.298923828272;5559.054960656698;5560.972195139079;5587.05020146576;5657.2928383952;5678.501459357869;5017.749112544285;5332.30680011596;5338.145896656516;5387.81142660005;5409.540189083972;5288.540828514759;5331.200319952039;5353.892922141613;5364.624476286623;5398.326518779191;5558.916616250679;5611.859703507445;5666.243464525845;5668.858278543069;5695.772169113189;3991.560928297943;4022.3363145080734;4041.515018197835;4289.871303860889;4366.978165109154;5975.282966044103;6072.301685306246;6081.361457046946;6122.908156377569;6145.938540614537;5877.94122058774;5936.970315148396;5938.673372964528;5946.316173639913;5965.164876917322;5899.970500147472;5906.793262235801;5907.49786268172;5933.525317974465;5953.196318497121;5677.801276955287;5806.709664516842;5881.794327127327;5885.293764748258;5904.8780731660845;5965.850853728692;6022.3977602241175;6039.849003774941;6057.515398768176;6090.878182436238;5619.381867994435;5857.384974577608;5888.852778680567;5894.145348924296;5941.346451890375 13:20:12 INFO - PROCESS | 4161 | |5;yui.html;765.9655315510802;780.4858673471921;827.6730691376906;861.4745005546617;862.5988915154452;15182.089074655529;15660.921695391522;15842.207889605503;15858.127802970861;15905.602359941007;14309.069910455813;14344.426222951095;14365.28173591319;14382.352794124263;14384.640383990405;668.5119862500366;790.0519376747897;810.8905297784783;811.407672399146;814.0434988888062;809.465752603282;816.8856360109589;817.2236375443323;818.443458448255;821.2608652212996;866.5493943149559;866.9349798765086;867.483847110968;869.0397111192136;871.0070519607652;857.4126723194569;862.706679728892;863.0290922711949;864.2869632553106;864.3992425264412;636.544870417649;637.3817397124782;637.4931929116364;638.3010603389281;638.955273130881;14589.489367872073;14591.708165836624;14615.342309596093;14620.195889226088;14642.926785366111;13803.723925521434;13916.791248131287;14079.648008799863;14125.929370353186;14166.079204851652;11482.65552033432;11793.705157371134;11798.41007949599;11909.10681698876;12003.399830008551;3830.195658911632;3864.4589757433982;3902.9219415611815;3932.213557288525;3956.5845586213322;59057.114143288316;59399.70300148472;60510;60543.394566054216;60595.697021514614;11029.44852757375;11068.833967490495;11274.210805243554;11366.602168924213;11506.654800356002;21583.892080539496;21594.352169434627;21620.78379216219;21623.351299461043;21633.56732865334;8085.636146373427;8178.713745018896;8199.180081991872;8227.8354432911;8231.46495477792;4567.1550763108935;4572.74849883253;4642.9767851161205;4717.575418212377;4759.524047595282;3599.676029157336;3664.5785734640326;3666.926661466809;3668.137987572918;3686.152184997412;633.5660072850112;646.5958775765147;650.3853858104046;653.2781276689285;654.2116749317062;747.3983443328065;748.135903031999;768.9038870141233;769.0579040675128;789.3014682006351;9130;9307.674231401868;9330.300227482965;9458.763530911645;9576.521173941275;644.2120332445193;703.7888633409957;722.0252658910429;725.0936329588015;780.0522365326156;4551.203539380595;4603.769811509478;4733.171694953438;4739.881502962385;4758.738269395148;69998.45010074328;70873.6456317715;71100.64449677718;71226.64386678033;71792;61136.38863611396;62014.37985620086;62831;63000;63393;56594.71702641543;56829.71585142048;57293.71353143208;57365.42634573601;57372.42627573671;8521.147885211429;8620.439671421338;8650.610722517627;8742.60658270392;8779.604917778588;36492.635073648926;36530.72142475001;36589.634103658624;36954.26091478209;37033.44449833308;48878.26682599835;49177.75411122922;49214;49503;50315.74842125766;11685.240459370114;11877.703057423634;12094.153409261267;12135.271883687006;12554.43505042257;12645.178063426216;12736.490540378281;12786.296753678636;12826.102172847812;12892.29092399927;11409.25839820409;11710.238834476073;12109;12120.878791211975;12232.143749937419;11100.722481938015;11527.942360288145;11533.88466115328;11653.53385864556;11849.466773995018;11661.35862527569;11676.532938682358;12534.749305014031;12998.090133690552;13499.190048597116;10726.517306721373;11285.71785705364;11890.643280701594;11916.225445346025;12096.818547721616;11525.481353339288;11728.179027467995;11819.704507387383;11998.160128790902;12002.699932501757 13:20:12 INFO - PROCESS | 4161 | __end_tp_report 13:20:12 INFO - PROCESS | 4161 | __start_cc_report 13:20:12 INFO - PROCESS | 4161 | _x_x_mozilla_cycle_collect,346 13:20:12 INFO - PROCESS | 4161 | __end_cc_report 13:20:12 INFO - PROCESS | 4161 | __startTimestamp1463602812968__endTimestamp 13:20:12 INFO - PROCESS | 4161 | 13:20:12 INFO - PROCESS | 4161 | ------- Summary: start ------- 13:20:12 INFO - PROCESS | 4161 | Number of tests: 6 13:20:12 INFO - PROCESS | 4161 | 13:20:12 INFO - PROCESS | 4161 | [#0] dojo.html Cycles:165 Average:5545.73 Median:5747.77 stddev:646.29 (11.2%) stddev-sans-first:621.61 13:20:12 INFO - PROCESS | 4161 | Values: 3203.6 3205.8 3225.8 3246.2 3263.7 5477.8 5495.4 5544.1 5550.8 5581.1 5436.9 5542.4 5550.3 5584.0 5606.0 4985.5 4997.3 5106.5 5135.7 5143.8 5065.5 5205.5 5229.4 5240.2 5249.9 4958.3 4964.9 5018.0 5070.0 5072.8 5029.2 5033.2 5037.0 5040.2 5087.1 4995.0 5016.5 5028.2 5031.3 5044.1 5386.7 5417.4 5420.5 5452.5 5487.8 5991.3 5996.1 6015.8 6027.5 6046.6 5942.7 5955.1 6092.3 6094.9 6098.5 5548.6 5579.5 5597.6 5601.8 5623.7 6131.4 6136.9 6151.9 6152.5 6159.8 5716.6 5803.9 5827.0 5886.7 5892.2 5987.0 5989.8 5996.6 6002.2 6038.2 5851.9 5909.2 5944.7 5967.0 5990.9 5950.7 5985.7 6000.0 6013.3 6058.6 4504.5 4505.8 4529.3 4546.3 4557.7 3910.8 3984.7 4016.2 4019.9 4091.2 5668.0 5684.5 5703.8 5704.9 5804.1 5952.2 5969.8 5973.8 5983.5 6041.8 5600.0 5708.8 5710.1 5738.5 5754.7 5134.9 5162.0 5169.6 5169.8 5187.8 6272.3 6299.2 6308.4 6313.3 6316.7 5851.7 5911.5 5931.1 5967.4 6031.3 6175.9 6220.2 6228.8 6235.9 6251.5 5679.1 5910.2 5920.8 5921.1 5955.2 5990.6 6005.6 6015.8 6047.2 6061.9 5747.8 5793.7 5837.4 5844.4 5852.2 5720.4 5761.6 5791.1 5866.9 5882.5 5534.4 5671.8 5676.9 5681.4 5784.0 5831.8 5869.6 5880.9 5914.4 5919.7 5615.0 5641.7 5778.3 5806.4 5809.0 13:20:12 INFO - PROCESS | 4161 | 13:20:12 INFO - PROCESS | 4161 | [#1] ext.html Cycles:180 Average:59069.06 Median:42281.08 stddev:118580.05 (280.5%) stddev-sans-first:118831.44 13:20:12 INFO - PROCESS | 4161 | Values: 601.0 646.1 649.5 659.5 667.8 33664.8 43736.1 44511.6 44697.3 44699.6 45841.8 46439.5 46456.3 46467.0 46663.5 8806.0 8932.3 9018.3 9024.4 9032.3 8863.7 8954.4 8994.7 8996.0 9003.7 8987.3 9028.7 9031.0 9031.4 9040.3 8911.1 8931.2 8964.8 8974.4 8977.1 8781.3 8844.5 8904.3 8916.2 8916.6 42412.8 42684.6 43022.4 43040.8 43194.4 3322.7 3427.4 3507.3 3553.9 4197.8 32280.2 32632.0 32731.3 33111.5 34182.3 4339.2 4351.7 4409.5 4411.6 4510.4 348079.0 348448.0 348852.0 349675.0 350908.0 35075.3 35837.5 35937.8 37897.6 58171.7 37651.8 37976.4 38111.6 38158.6 38312.2 14156.4 14239.4 14263.0 14306.5 14326.6 12137.6 12177.3 12207.5 12229.3 12281.7 8504.9 8550.1 8597.4 8604.1 8643.3 3311.5 3324.2 3384.3 3385.0 3471.8 1046.2 1081.7 1093.1 1102.6 1114.0 33012.2 33099.2 33356.3 33401.3 33671.2 1138.6 1172.9 1177.4 1193.9 1208.5 17299.3 17313.9 17398.8 17461.4 17749.3 520421.0 523554.0 523836.0 524326.0 526883.0 59048.0 59397.7 59788.0 59923.1 60024.0 1397.6 1439.7 1453.8 1459.5 1464.8 31697.5 32274.8 32470.4 32486.4 32914.3 47206.3 47628.8 47677.8 47697.0 47716.3 443109.0 450428.0 450842.0 452014.0 452607.0 28645.0 28664.1 28761.9 28954.9 29087.6 48597.0 48708.8 49217.0 49560.0 49690.0 41418.8 42149.4 42512.8 42717.8 42988.0 40245.4 41268.4 41789.0 41947.2 42806.0 43180.6 45969.3 45988.3 46973.8 47066.5 36618.0 36767.0 37511.4 37916.6 38100.2 28666.4 29559.3 29573.9 29854.6 29893.4 13:20:12 INFO - PROCESS | 4161 | 13:20:12 INFO - PROCESS | 4161 | [#2] jquery.html Cycles:180 Average:28374.79 Median:12206.54 stddev:79760.32 (653.4%) stddev-sans-first:79956.42 13:20:12 INFO - PROCESS | 4161 | Values: 405.3 408.7 414.6 416.2 431.9 16190.6 18194.5 19093.0 19963.0 20120.0 19009.6 19024.7 20146.8 20199.7 20202.2 5679.0 5884.7 5888.6 5912.2 5925.1 5620.9 5722.4 5743.1 5764.2 5778.7 5680.5 5799.6 5824.2 5824.7 5841.9 5762.5 5779.2 5780.7 5781.9 5824.7 5078.2 5173.9 5183.8 5196.9 5199.3 20177.0 22235.8 23981.3 23987.5 24052.3 2177.3 2346.4 2364.8 2965.9 3072.3 10208.8 10419.6 10605.3 10908.2 11493.6 1922.1 1971.2 1987.6 2024.6 2077.4 73449.6 84639.6 85331.0 86026.6 86631.6 11305.4 11361.1 11420.4 11424.2 11474.4 13083.9 14653.8 15540.8 16032.4 16116.3 7929.5 7955.0 8140.0 8250.6 8307.5 7505.2 7542.2 7682.0 7715.7 7727.6 4836.5 4848.9 4931.7 5004.4 5009.3 1922.6 1966.3 2033.1 2059.7 2062.4 921.9 1004.9 1045.3 1061.1 1078.0 18809.5 19454.0 19758.6 19772.1 19927.8 1000.5 1011.4 1018.9 1076.2 1084.9 10762.0 11177.9 11200.8 11219.1 11269.7 477143.0 478770.5 485313.0 487334.0 498503.0 59748.0 66314.7 72529.6 80863.0 96595.7 1021.5 1027.1 1032.4 1047.8 1052.1 17205.7 17291.5 17332.3 17579.0 17595.0 30223.7 33424.8 38089.0 38365.8 41391.0 55346.7 55570.2 55584.4 56309.0 57626.7 8572.2 8799.9 8898.9 9123.2 9160.3 12850.3 13729.2 13868.3 13964.4 14082.4 11752.6 11782.9 11816.7 11824.5 11924.5 11682.4 11729.0 12011.1 12033.1 12153.6 11647.0 11899.3 11952.6 12092.6 12195.0 8646.7 8835.0 8923.2 8960.7 9064.5 10914.3 12513.9 12691.4 12821.6 12888.2 13:20:12 INFO - PROCESS | 4161 | 13:20:12 INFO - PROCESS | 4161 | [#3] mootools.html Cycles:180 Average:5773.39 Median:4765.25 stddev:3267.93 (68.6%) stddev-sans-first:3261.63 13:20:12 INFO - PROCESS | 4161 | Values: 1542.8 1569.8 1720.7 1797.2 1809.7 7973.0 8320.6 8675.5 9166.2 9169.2 8283.1 8524.4 8556.5 8572.1 8585.9 2335.7 2387.8 2390.5 2393.1 2396.2 2288.0 2312.7 2312.7 2313.8 2317.0 2312.2 2328.7 2344.9 2375.4 2375.4 2280.2 2292.0 2294.0 2325.6 2329.8 2303.9 2323.7 2331.6 2333.6 2351.0 8493.7 8623.4 8633.4 8668.3 8712.2 4952.5 4967.2 5085.7 5094.8 5109.7 3349.9 3366.4 3407.8 3420.6 3429.7 1105.3 1125.0 1128.7 1132.7 1142.9 11829.7 11831.4 11899.9 11946.7 11993.9 4547.6 4678.8 4700.2 4707.8 4709.3 10190.2 10193.4 10199.3 10203.5 10209.7 5182.2 5318.0 5318.3 5319.6 5322.1 4268.8 4719.2 4811.3 4817.4 4830.1 4122.7 4194.3 4216.2 4255.1 4339.7 1296.9 1317.7 1322.5 1326.0 1343.3 856.0 909.0 950.2 984.4 992.0 5961.2 6013.0 6105.4 6115.3 6196.4 436.5 438.2 441.6 442.6 446.2 4205.0 4234.8 4240.0 4255.8 4258.3 11000.0 11352.1 11374.7 11377.7 11391.4 11221.8 11327.2 11350.1 11358.3 11370.1 7759.1 7990.9 7994.5 8145.3 8202.8 5936.6 6041.0 6142.6 6144.3 6168.1 9487.9 9743.6 9758.7 9939.1 9946.0 9985.3 10024.9 10033.0 10045.2 10070.2 6895.1 7186.2 7444.1 7652.4 7671.0 8161.3 8236.6 8258.3 8287.8 8315.0 7359.3 7600.8 7618.3 7683.0 7721.7 7510.4 7610.7 7630.1 7667.0 7698.0 6971.1 7010.2 7020.9 7028.7 7046.4 5184.5 5190.7 5350.5 5359.7 5421.5 5198.4 5281.2 5408.4 5610.1 5706.5 13:20:12 INFO - PROCESS | 4161 | 13:20:12 INFO - PROCESS | 4161 | [#4] prototype.html Cycles:180 Average:4820.95 Median:5384.19 stddev:1392.64 (25.9%) stddev-sans-first:1355.17 13:20:12 INFO - PROCESS | 4161 | Values: 331.6 336.9 341.0 345.2 349.1 5535.3 5629.4 5731.3 5811.1 5813.0 5602.0 5679.7 5692.5 5696.3 5701.1 4463.4 4468.0 4469.2 4477.9 4481.4 4351.4 4385.7 4407.0 4410.6 4485.5 4323.0 4340.6 4345.7 4355.0 4364.6 4368.5 4378.9 4382.3 4389.9 4401.9 3844.6 3909.0 3932.9 3965.9 3971.2 5382.1 5415.9 5472.3 5489.6 5517.4 5071.4 5078.7 5103.6 5114.1 5128.6 5573.7 5926.0 5939.8 5975.4 5992.9 4281.6 4288.8 4311.5 4319.4 4339.8 6143.7 6186.2 6187.6 6198.7 6209.8 4030.5 4256.7 4258.3 4270.4 4442.3 4309.7 4324.2 4328.7 4330.1 4339.5 4957.6 4995.2 4996.6 5009.9 5010.5 5792.6 5811.6 5862.3 5887.3 5990.3 1508.5 1517.2 1522.8 1529.4 1533.5 951.7 970.1 975.0 982.5 984.4 5059.4 5118.0 5175.5 5198.8 5201.1 5369.7 5377.8 5386.3 5386.5 5506.9 4942.0 5031.9 5185.8 5216.2 5220.0 2894.5 2927.2 2930.2 2973.9 2977.4 5661.7 5665.2 5670.8 5675.2 5703.2 5216.3 5499.5 5502.7 5546.6 5577.3 5559.1 5561.0 5587.1 5657.3 5678.5 5017.7 5332.3 5338.1 5387.8 5409.5 5288.5 5331.2 5353.9 5364.6 5398.3 5558.9 5611.9 5666.2 5668.9 5695.8 3991.6 4022.3 4041.5 4289.9 4367.0 5975.3 6072.3 6081.4 6122.9 6145.9 5877.9 5937.0 5938.7 5946.3 5965.2 5900.0 5906.8 5907.5 5933.5 5953.2 5677.8 5806.7 5881.8 5885.3 5904.9 5965.9 6022.4 6039.8 6057.5 6090.9 5619.4 5857.4 5888.9 5894.1 5941.3 13:20:12 INFO - PROCESS | 4161 | 13:20:12 INFO - PROCESS | 4161 | [#5] yui.html Cycles:180 Average:15950.81 Median:4725.37 stddev:19314.70 (408.7%) stddev-sans-first:19335.22 13:20:12 INFO - PROCESS | 4161 | Values: 766.0 780.5 827.7 861.5 862.6 15182.1 15660.9 15842.2 15858.1 15905.6 14309.1 14344.4 14365.3 14382.4 14384.6 668.5 790.1 810.9 811.4 814.0 809.5 816.9 817.2 818.4 821.3 866.5 866.9 867.5 869.0 871.0 857.4 862.7 863.0 864.3 864.4 636.5 637.4 637.5 638.3 639.0 14589.5 14591.7 14615.3 14620.2 14642.9 13803.7 13916.8 14079.6 14125.9 14166.1 11482.7 11793.7 11798.4 11909.1 12003.4 3830.2 3864.5 3902.9 3932.2 3956.6 59057.1 59399.7 60510.0 60543.4 60595.7 11029.4 11068.8 11274.2 11366.6 11506.7 21583.9 21594.4 21620.8 21623.4 21633.6 8085.6 8178.7 8199.2 8227.8 8231.5 4567.2 4572.7 4643.0 4717.6 4759.5 3599.7 3664.6 3666.9 3668.1 3686.2 633.6 646.6 650.4 653.3 654.2 747.4 748.1 768.9 769.1 789.3 9130.0 9307.7 9330.3 9458.8 9576.5 644.2 703.8 722.0 725.1 780.1 4551.2 4603.8 4733.2 4739.9 4758.7 69998.5 70873.6 71100.6 71226.6 71792.0 61136.4 62014.4 62831.0 63000.0 63393.0 56594.7 56829.7 57293.7 57365.4 57372.4 8521.1 8620.4 8650.6 8742.6 8779.6 36492.6 36530.7 36589.6 36954.3 37033.4 48878.3 49177.8 49214.0 49503.0 50315.7 11685.2 11877.7 12094.2 12135.3 12554.4 12645.2 12736.5 12786.3 12826.1 12892.3 11409.3 11710.2 12109.0 12120.9 12232.1 11100.7 11527.9 11533.9 11653.5 11849.5 11661.4 11676.5 12534.7 12998.1 13499.2 10726.5 11285.7 11890.6 11916.2 12096.8 11525.5 11728.2 11819.7 11998.2 12002.7 13:20:12 INFO - PROCESS | 4161 | -------- Summary: end -------- 13:20:12 INFO - PROCESS | 4161 | 13:20:13 INFO - TEST-INFO | 4161: exit 0 13:20:13 INFO - TEST-OK | dromaeo_css | took 1109299ms 13:20:13 INFO - TEST-START | kraken 13:20:13 INFO - operating with platform_type : linux_ 13:20:13 INFO - Initialising browser for kraken test... 13:20:13 INFO - TEST-INFO | started process 4400 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnTo9nw/profile http://localhost:40345/getInfo.html) 13:20:16 INFO - PROCESS | 4400 | 13:20:16 INFO - PROCESS | 4400 | (process:4469): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:20:17 INFO - PROCESS | 4400 | __metrics Screen width/height:1600/1200 13:20:17 INFO - PROCESS | 4400 | colorDepth:24 13:20:17 INFO - PROCESS | 4400 | Browser inner width/height: 1024/697 13:20:17 INFO - PROCESS | 4400 | __metrics 13:20:18 ERROR - PROCESS | 4400 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 13:20:18 INFO - TEST-INFO | 4400: exit 0 13:20:18 INFO - Browser initialized. 13:20:18 INFO - Running cycle 1/1 for kraken test... 13:20:18 INFO - TEST-INFO | started process 4520 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnTo9nw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:20:20 INFO - PROCESS | 4520 | 13:20:20 INFO - PROCESS | 4520 | (process:4581): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:20:30 INFO - PROCESS | 4520 | RSS: Main: 163205120 13:20:30 INFO - PROCESS | 4520 | 13:20:33 INFO - PROCESS | 4520 | Cycle 1(1): loaded http://localhost:40345/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40345/tests/kraken/driver.html?testName=audio-beat-detection) 13:20:34 INFO - PROCESS | 4520 | RSS: Main: 168124416 13:20:34 INFO - PROCESS | 4520 | 13:20:37 INFO - PROCESS | 4520 | Cycle 1(1): loaded http://localhost:40345/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40345/tests/kraken/driver.html?testName=audio-dft) 13:20:37 INFO - PROCESS | 4520 | RSS: Main: 168165376 13:20:37 INFO - PROCESS | 4520 | 13:20:40 INFO - PROCESS | 4520 | Cycle 1(1): loaded http://localhost:40345/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40345/tests/kraken/driver.html?testName=audio-fft) 13:20:41 INFO - PROCESS | 4520 | RSS: Main: 162684928 13:20:41 INFO - PROCESS | 4520 | 13:20:43 INFO - PROCESS | 4520 | Cycle 1(1): loaded http://localhost:40345/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40345/tests/kraken/driver.html?testName=audio-oscillator) 13:20:44 INFO - PROCESS | 4520 | RSS: Main: 163287040 13:20:44 INFO - PROCESS | 4520 | 13:20:46 INFO - PROCESS | 4520 | Cycle 1(1): loaded http://localhost:40345/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40345/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:20:46 INFO - PROCESS | 4520 | RSS: Main: 163442688 13:20:46 INFO - PROCESS | 4520 | 13:20:50 INFO - PROCESS | 4520 | Cycle 1(1): loaded http://localhost:40345/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40345/tests/kraken/driver.html?testName=imaging-darkroom) 13:20:50 INFO - PROCESS | 4520 | RSS: Main: 163213312 13:20:50 INFO - PROCESS | 4520 | 13:20:54 INFO - PROCESS | 4520 | Cycle 1(1): loaded http://localhost:40345/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40345/tests/kraken/driver.html?testName=imaging-desaturate) 13:20:54 INFO - PROCESS | 4520 | RSS: Main: 161857536 13:20:54 INFO - PROCESS | 4520 | 13:20:57 INFO - PROCESS | 4520 | Cycle 1(1): loaded http://localhost:40345/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40345/tests/kraken/driver.html?testName=json-parse-financial) 13:20:58 INFO - PROCESS | 4520 | RSS: Main: 162570240 13:20:58 INFO - PROCESS | 4520 | 13:21:00 INFO - PROCESS | 4520 | Cycle 1(1): loaded http://localhost:40345/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40345/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:21:00 INFO - PROCESS | 4520 | RSS: Main: 163123200 13:21:00 INFO - PROCESS | 4520 | 13:21:02 INFO - PROCESS | 4520 | Cycle 1(1): loaded http://localhost:40345/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40345/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:21:03 INFO - PROCESS | 4520 | RSS: Main: 163155968 13:21:03 INFO - PROCESS | 4520 | 13:21:05 INFO - PROCESS | 4520 | Cycle 1(1): loaded http://localhost:40345/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40345/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:21:06 INFO - PROCESS | 4520 | RSS: Main: 164069376 13:21:06 INFO - PROCESS | 4520 | 13:21:08 INFO - PROCESS | 4520 | Cycle 1(1): loaded http://localhost:40345/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40345/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:21:09 INFO - PROCESS | 4520 | RSS: Main: 163823616 13:21:09 INFO - PROCESS | 4520 | 13:21:12 INFO - PROCESS | 4520 | Cycle 1(1): loaded http://localhost:40345/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40345/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:21:12 INFO - PROCESS | 4520 | RSS: Main: 164163584 13:21:12 INFO - PROCESS | 4520 | 13:21:14 INFO - PROCESS | 4520 | Cycle 1(1): loaded http://localhost:40345/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40345/tests/kraken/driver.html?testName=ai-astar) 13:21:14 INFO - PROCESS | 4520 | RSS: Main: 165257216 13:21:14 INFO - PROCESS | 4520 | 13:21:14 INFO - PROCESS | 4520 | __start_tp_report 13:21:14 INFO - PROCESS | 4520 | _x_x_mozilla_page_load 13:21:14 INFO - PROCESS | 4520 | _x_x_mozilla_page_load_details 13:21:14 INFO - PROCESS | 4520 | |i|pagename|runs| 13:21:14 INFO - PROCESS | 4520 | |0;ai-astar;109;110;103;110;111;109;104;111;109;111 13:21:14 INFO - PROCESS | 4520 | |1;audio-beat-detection;161;134;152;210;126;156;153;128;184;128 13:21:14 INFO - PROCESS | 4520 | |2;audio-dft;162;164;161;164;165;170;162;162;163;164 13:21:14 INFO - PROCESS | 4520 | |3;audio-fft;82;74;76;159;75;76;73;75;178;76 13:21:14 INFO - PROCESS | 4520 | |4;audio-oscillator;92;92;175;91;92;92;156;91;91;157 13:21:14 INFO - PROCESS | 4520 | |5;imaging-gaussian-blur;117;117;116;118;118;117;118;116;117;119 13:21:14 INFO - PROCESS | 4520 | |6;imaging-darkroom;151;150;148;147;147;147;146;146;146;148 13:21:14 INFO - PROCESS | 4520 | |7;imaging-desaturate;95;95;95;96;95;95;95;95;95;95 13:21:14 INFO - PROCESS | 4520 | |8;json-parse-financial;55;61;58;55;55;55;54;112;53;55 13:21:14 INFO - PROCESS | 4520 | |9;json-stringify-tinderbox;60;63;60;60;60;59;60;59;60;60 13:21:14 INFO - PROCESS | 4520 | |10;stanford-crypto-aes;78;76;78;78;80;79;80;80;79;82 13:21:14 INFO - PROCESS | 4520 | |11;stanford-crypto-ccm;123;130;124;125;124;124;123;120;235;124 13:21:14 INFO - PROCESS | 4520 | |12;stanford-crypto-pbkdf2;163;160;164;159;160;161;160;160;160;165 13:21:14 INFO - PROCESS | 4520 | |13;stanford-crypto-sha256-iterative;64;63;65;65;65;64;67;62;64;63 13:21:14 INFO - PROCESS | 4520 | __end_tp_report 13:21:14 INFO - PROCESS | 4520 | __start_cc_report 13:21:14 INFO - PROCESS | 4520 | _x_x_mozilla_cycle_collect,834 13:21:14 INFO - PROCESS | 4520 | __end_cc_report 13:21:14 INFO - PROCESS | 4520 | __startTimestamp1463602874689__endTimestamp 13:21:14 INFO - PROCESS | 4520 | 13:21:14 INFO - PROCESS | 4520 | ------- Summary: start ------- 13:21:14 INFO - PROCESS | 4520 | Number of tests: 14 13:21:14 INFO - PROCESS | 4520 | 13:21:14 INFO - PROCESS | 4520 | [#0] ai-astar Cycles:10 Average:108.70 Median:110.00 stddev:2.87 (2.6%) stddev-sans-first:3.04 13:21:14 INFO - PROCESS | 4520 | Values: 109.0 110.0 103.0 110.0 111.0 109.0 104.0 111.0 109.0 111.0 13:21:14 INFO - PROCESS | 4520 | 13:21:14 INFO - PROCESS | 4520 | [#1] audio-beat-detection Cycles:10 Average:153.20 Median:154.50 stddev:27.13 (17.6%) stddev-sans-first:28.63 13:21:14 INFO - PROCESS | 4520 | Values: 161.0 134.0 152.0 210.0 126.0 156.0 153.0 128.0 184.0 128.0 13:21:14 INFO - PROCESS | 4520 | 13:21:14 INFO - PROCESS | 4520 | [#2] audio-dft Cycles:10 Average:163.70 Median:164.00 stddev:2.54 (1.5%) stddev-sans-first:2.62 13:21:14 INFO - PROCESS | 4520 | Values: 162.0 164.0 161.0 164.0 165.0 170.0 162.0 162.0 163.0 164.0 13:21:14 INFO - PROCESS | 4520 | 13:21:14 INFO - PROCESS | 4520 | [#3] audio-fft Cycles:10 Average:94.40 Median:75.50 stddev:39.38 (52.2%) stddev-sans-first:41.51 13:21:14 INFO - PROCESS | 4520 | Values: 82.0 74.0 76.0 159.0 75.0 76.0 73.0 75.0 178.0 76.0 13:21:14 INFO - PROCESS | 4520 | 13:21:14 INFO - PROCESS | 4520 | [#4] audio-oscillator Cycles:10 Average:112.90 Median:91.50 stddev:34.71 (37.9%) stddev-sans-first:35.99 13:21:14 INFO - PROCESS | 4520 | Values: 92.0 92.0 175.0 91.0 92.0 92.0 156.0 91.0 91.0 157.0 13:21:14 INFO - PROCESS | 4520 | 13:21:14 INFO - PROCESS | 4520 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.50 stddev:0.95 (0.8%) stddev-sans-first:1.00 13:21:14 INFO - PROCESS | 4520 | Values: 117.0 117.0 116.0 118.0 118.0 117.0 118.0 116.0 117.0 119.0 13:21:14 INFO - PROCESS | 4520 | 13:21:14 INFO - PROCESS | 4520 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.50 stddev:1.71 (1.2%) stddev-sans-first:1.30 13:21:14 INFO - PROCESS | 4520 | Values: 151.0 150.0 148.0 147.0 147.0 147.0 146.0 146.0 146.0 148.0 13:21:14 INFO - PROCESS | 4520 | 13:21:14 INFO - PROCESS | 4520 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 13:21:14 INFO - PROCESS | 4520 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 13:21:14 INFO - PROCESS | 4520 | 13:21:14 INFO - PROCESS | 4520 | [#8] json-parse-financial Cycles:10 Average:61.30 Median:55.00 stddev:17.96 (32.6%) stddev-sans-first:18.90 13:21:14 INFO - PROCESS | 4520 | Values: 55.0 61.0 58.0 55.0 55.0 55.0 54.0 112.0 53.0 55.0 13:21:14 INFO - PROCESS | 4520 | 13:21:14 INFO - PROCESS | 4520 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:60.00 stddev:1.10 (1.8%) stddev-sans-first:1.17 13:21:14 INFO - PROCESS | 4520 | Values: 60.0 63.0 60.0 60.0 60.0 59.0 60.0 59.0 60.0 60.0 13:21:14 INFO - PROCESS | 4520 | 13:21:14 INFO - PROCESS | 4520 | [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:79.50 stddev:1.63 (2.1%) stddev-sans-first:1.69 13:21:14 INFO - PROCESS | 4520 | Values: 78.0 76.0 78.0 78.0 80.0 79.0 80.0 80.0 79.0 82.0 13:21:14 INFO - PROCESS | 4520 | 13:21:14 INFO - PROCESS | 4520 | [#11] stanford-crypto-ccm Cycles:10 Average:135.20 Median:124.00 stddev:35.15 (28.3%) stddev-sans-first:37.01 13:21:14 INFO - PROCESS | 4520 | Values: 123.0 130.0 124.0 125.0 124.0 124.0 123.0 120.0 235.0 124.0 13:21:14 INFO - PROCESS | 4520 | 13:21:14 INFO - PROCESS | 4520 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.20 Median:160.50 stddev:2.04 (1.3%) stddev-sans-first:2.06 13:21:14 INFO - PROCESS | 4520 | Values: 163.0 160.0 164.0 159.0 160.0 161.0 160.0 160.0 160.0 165.0 13:21:14 INFO - PROCESS | 4520 | 13:21:14 INFO - PROCESS | 4520 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.50 stddev:1.40 (2.2%) stddev-sans-first:1.48 13:21:14 INFO - PROCESS | 4520 | Values: 64.0 63.0 65.0 65.0 65.0 64.0 67.0 62.0 64.0 63.0 13:21:14 INFO - PROCESS | 4520 | -------- Summary: end -------- 13:21:14 INFO - PROCESS | 4520 | 13:21:15 INFO - TEST-INFO | 4520: exit 0 13:21:15 INFO - TEST-OK | kraken | took 61908ms 13:21:15 INFO - SUITE-END | took 1171s 13:21:15 INFO - Completed test suite (00:19:31) 13:21:15 INFO - javascript benchmark 13:21:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7170.648407872741, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3203.551502789609, 3205.791623544471, 3225.822579758112, 3246.2371342734446, 3263.6899494548024, 5477.808276710321, 5495.368032676243, 5544.140658197981, 5550.77796888124, 5581.079121944885, 5436.945630543693, 5542.418046105161, 5550.306211723524, 5583.972080139603, 5606.0, 4985.52637499437, 4997.325361076263, 5106.514881086309, 5135.666181698196, 5143.794248230066, 5065.518775716301, 5205.479452054802, 5229.398619158788, 5240.161574148137, 5249.8950020999555, 4958.281049247875, 4964.851054468371, 5017.996400719834, 5070.036693028313, 5072.771725272353, 5029.245613158056, 5033.1695270280725, 5037.0429618372755, 5040.218766091261, 5087.058894104603, 4995.025969935864, 5016.548510634024, 5028.245763135523, 5031.270465782441, 5044.092063428581, 5386.73066346685, 5417.431169727161, 5420.457954204588, 5452.536534394581, 5487.807926722586, 5991.340952495222, 5996.130561068664, 6015.849603759897, 6027.517798576104, 6046.5767396281835, 5942.702864856783, 5955.106733989893, 6092.329843717188, 6094.902917474853, 6098.481629061535, 5548.611597188198, 5579.525740312038, 5597.636153650041, 5601.831945041656, 5623.7469313880565, 6131.417515336036, 6136.9079463808075, 6151.907721384183, 6152.538559608047, 6159.84600384994, 5716.5998380113, 5803.941960580424, 5827.009408400498, 5886.676232807236, 5892.175095486636, 5986.970065149646, 5989.790357337472, 5996.640201587831, 6002.159697642333, 6038.245219347582, 5851.882962340729, 5909.202257695242, 5944.7027648617395, 5967.045272756425, 5990.850228744316, 5950.672713000827, 5985.730642121115, 5999.970000150059, 6013.338532761392, 6058.636481811105, 4504.48198457175, 4505.819767209275, 4529.275315949498, 4546.272596384562, 4557.703749256354, 3910.765354078764, 3984.7409918355215, 4016.1766837798764, 4019.91960160801, 4091.243120022805, 5668.0, 5684.459976302244, 5703.771849125988, 5704.857378565569, 5804.100364443518, 5952.166696662471, 5969.76120955157, 5973.790917317873, 5983.521318294526, 6041.818745437556, 5599.972000140055, 5708.80019199326, 5710.086386178275, 5738.540916726735, 5754.683492407958, 5134.871628209325, 5162.045021671003, 5169.560587350042, 5169.793208271627, 5187.792488300426, 6272.3100458949475, 6299.212598425197, 6308.400701933309, 6313.337099604567, 6316.715747791361, 5851.6781577012825, 5911.497522710618, 5931.110333450017, 5967.403259674172, 6031.276246850406, 6175.907361389673, 6220.222472190976, 6228.781992630236, 6235.875282494416, 6251.53113516479, 5679.091345384719, 5910.202122713378, 5920.763169473173, 5921.111833225051, 5955.225820643462, 5990.610610310316, 6005.6396616203165, 6015.789447369321, 6047.183630209865, 6061.878762424815, 5747.770089196385, 5793.739281732248, 5837.387074357302, 5844.357120716632, 5852.151438041546, 5720.3707592164, 5761.625494342854, 5791.102379131242, 5866.853328666647, 5882.5293976482635, 5534.446555344433, 5671.829845104653, 5676.858078548069, 5681.431856814285, 5784.0, 5831.825045248649, 5869.618474799125, 5880.911786323294, 5914.4381283777975, 5919.6744179070565, 5614.9719251403485, 5641.661500309994, 5778.335491418373, 5806.361300256884, 5809.0], "value": 5501.098647491983, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.0353382820573, 646.085788609118, 649.451213724403, 659.5020759326708, 667.7929841749058, 33664.83167584162, 43736.12527749447, 44511.55488445111, 44697.329540056926, 44699.55300446995, 45841.770791145995, 46439.53560464403, 46456.3031554527, 46467.0, 46663.53336466634, 8805.95597022014, 8932.285417166611, 9018.278537716968, 9024.368294219406, 9032.32257580684, 8863.689770858022, 8954.37319387643, 8994.68518601849, 8996.0, 9003.684871029514, 8987.281017518582, 9028.68399606014, 9030.954845225764, 9031.367804253705, 9040.321975851804, 8911.108889111101, 8931.151540603632, 8964.820703585958, 8974.371793974424, 8977.102289771035, 8781.253593444564, 8844.46933184011, 8904.287656987426, 8916.242119419858, 8916.643334266622, 42412.78793606012, 42684.573154268684, 43022.35466468005, 43040.784796076136, 43194.352084718754, 3322.7175690066374, 3427.4344733119256, 3507.2634746703225, 3553.875614353485, 4197.769122698251, 32280.192995175075, 32632.0, 32731.345373092405, 33111.50332745011, 34182.316353673035, 4339.218940590692, 4351.673624478177, 4409.470863496369, 4411.580899814545, 4510.391097201868, 348079.0, 348448.0, 348852.0, 349675.0, 350908.0, 35075.29849402998, 35837.46243806345, 35937.82031089828, 37897.62102378941, 58171.70914145402, 37651.81174094112, 37976.43035354472, 38111.61888381081, 38158.61841381606, 38312.233755324734, 14156.433742650384, 14239.43042278318, 14263.0, 14306.499272525412, 14326.57020289393, 12137.575184868487, 12177.330246836333, 12207.511699532097, 12229.266244025386, 12281.710420405907, 8504.914950850536, 8550.144985501525, 8597.355198360148, 8604.053554109043, 8643.265322447662, 3311.536384906067, 3324.1855745342064, 3384.2554637979606, 3384.966150338514, 3471.8264086795557, 1046.1839764983324, 1081.6538707613488, 1093.147345070846, 1102.581019212694, 1113.9665810025713, 33012.1746956328, 33099.17252068669, 33356.3328733424, 33401.32585415651, 33671.15822104467, 1138.59579849154, 1172.935488548138, 1177.3963801535954, 1193.8746431624554, 1208.4924331780674, 17299.30802767875, 17313.91343043302, 17398.826011739722, 17461.38885139014, 17749.290028398977, 520421.0, 523554.0, 523836.0, 524326.0, 526883.0, 59048.0, 59397.70301148553, 59788.0, 59923.101153482734, 60024.0, 1397.6436008817686, 1439.6760728836139, 1453.789200565912, 1459.489178787416, 1464.8388677245493, 31697.5245371315, 32274.838625806722, 32470.40236781099, 32486.35027299488, 32914.34171316608, 47206.29190562213, 47628.7618561905, 47677.76161119172, 47697.0, 47716.284255735496, 443109.0, 450428.0, 450842.0, 452014.0, 452607.0, 28645.0, 28664.14007579776, 28761.856190718914, 28954.855225723735, 29087.56368654514, 48597.0, 48708.756456217496, 49217.0, 49560.0, 49690.0, 41418.792906035276, 42149.367759484245, 42512.78743606386, 42717.78641106775, 42988.0, 40245.39631905465, 41268.38097428601, 41789.0, 41947.16105677808, 42806.0, 43180.56819431765, 45969.31046034379, 45988.31017534673, 46973.76513117413, 47066.529334707586, 36618.0, 36767.0, 37511.43732844064, 37916.62083379131, 38100.23799523938, 28666.42667146687, 29559.26101847471, 29573.852130739207, 29854.552181716856, 29893.402131956806], "value": 19099.148612468132, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.26849037487335, 408.67714505540624, 414.5729898204849, 416.2133567557317, 431.92873175925973, 16190.595235119128, 18194.454166375013, 19093.0, 19963.0, 20120.0, 19009.619807603838, 19024.714629280537, 20146.798532014676, 20199.697004544945, 20202.19191232349, 5678.99999999999, 5884.6763428011445, 5888.558358123137, 5912.231409916726, 5925.111233314994, 5620.9437905620825, 5722.427757224265, 5743.10981797822, 5764.221830052952, 5778.682172480512, 5680.5455563554815, 5799.565032622549, 5824.184614154022, 5824.650520968756, 5841.853953651172, 5762.481376676119, 5779.1620215069, 5780.710964451781, 5781.884362312751, 5824.650520968734, 5078.238264260353, 5173.870653233662, 5183.766730497136, 5196.948030519684, 5199.272101905736, 20177.0, 22235.777642223693, 23981.280561583182, 23987.52024959491, 24052.278431646904, 2177.292379976514, 2346.4016675747744, 2364.822638302117, 2965.911022669302, 3072.339447018902, 10208.846867296996, 10419.583216671399, 10605.257631965766, 10908.181886358554, 11493.5977240797, 1922.1158267197106, 1971.2312198242696, 1987.6010141023569, 2024.6355655982065, 2077.4079387374677, 73449.6327518359, 84639.57680211621, 85331.0, 86026.56986715026, 86631.56684216602, 11305.434728263554, 11361.14791390649, 11420.428978551205, 11424.200305978668, 11474.426278686033, 13083.869161308456, 14653.780193296896, 15540.84459155394, 16032.438864639682, 16116.274767635485, 7929.52422854619, 7955.0, 8140.0, 8250.628721707537, 8307.460015098999, 7505.174430812606, 7542.208068152875, 7681.961590192125, 7715.729949451742, 7727.613619319124, 4836.492168322276, 4848.933234688363, 4931.679440836334, 5004.374453193351, 5009.273655319958, 1922.5770330527262, 1966.3117908732115, 2033.0851116997114, 2059.6910463430604, 2062.3709768520444, 921.9262459003397, 1004.8894621591619, 1045.325764881647, 1061.1192710050639, 1077.9892201078046, 18809.529761756065, 19454.0, 19758.60482790336, 19772.11025503827, 19927.800721992884, 1000.4547521600599, 1011.4335971855784, 1018.8930162332997, 1076.1928553584812, 1084.924055316136, 10762.0, 11177.944110279397, 11200.831987520194, 11219.102471802236, 11269.661910142544, 477143.0, 478770.486065972, 485313.0, 487334.0, 498503.0, 59748.0, 66314.66842665852, 72529.6373518129, 80863.0, 96595.7212781167, 1021.4739409204266, 1027.0551092994463, 1032.3805716569998, 1047.7537778622018, 1052.095198129608, 17205.741913871552, 17291.481255562354, 17332.30670773155, 17579.0, 17595.0, 30223.69776302209, 33424.83287583546, 38089.0, 38365.80817095897, 41390.96522586959, 55346.72326638341, 55570.166447504125, 55584.444155557925, 56309.0, 57626.7118664404, 8572.228499435081, 8799.90491942901, 8898.911010889808, 9123.178913897782, 9160.267178625827, 12850.293233871853, 13729.176249425067, 13868.306584670525, 13964.37160327808, 14082.366293516612, 11752.647420577396, 11782.87599340224, 11816.70458238551, 11824.527018919147, 11924.523019079139, 11682.357470339213, 11729.003034742142, 12011.099167562294, 12033.097517686034, 12153.574624888086, 11647.0, 11899.286042837457, 11952.64142075739, 12092.576759813364, 12195.0, 8646.697365592174, 8834.955825220834, 8923.15230053144, 8960.731178064669, 9064.50145242018, 10914.32167580681, 12513.93743031279, 12691.365431728193, 12821.551245706356, 12888.226706397647], "value": 9286.357111929614, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1542.7994360733107, 1569.8351673074326, 1720.6644704282662, 1797.1912639312313, 1809.6833054215508, 7973.0, 8320.583970801466, 8675.479471231723, 9166.212588545228, 9169.174774270314, 8283.088860225385, 8524.360672949522, 8556.486610803357, 8572.142785721424, 8585.871211931826, 2335.6730057791924, 2387.7970372518357, 2390.521895620874, 2393.102586530051, 2396.2332053742807, 2287.9885600572056, 2312.7455979842202, 2312.7455979842202, 2313.7570555091725, 2317.0152685108847, 2312.2369618026096, 2328.7205535335784, 2344.9413764655933, 2375.3705268103968, 2375.406148462884, 2280.1791355112146, 2291.9885400572975, 2294.0365046680436, 2325.616273314901, 2329.801966832821, 2303.9308820735405, 2323.744388117306, 2331.6269396896414, 2333.6382860656627, 2350.976490235093, 8493.66025358985, 8623.396362254645, 8633.395662303641, 8668.30653547721, 8712.21590056898, 4952.504749525055, 4967.180415231483, 5085.720285384303, 5094.770735316883, 5109.693418394871, 3349.899503014889, 3366.360391525602, 3407.812570308632, 3420.555327807394, 3429.725621950238, 1105.2981356838386, 1124.9943750281277, 1128.6614015795228, 1132.6828488023366, 1142.9371384573844, 11829.704257393549, 11831.408429578572, 11899.940500297529, 11946.701332466759, 11993.880061199363, 4547.5679810418615, 4678.836240731558, 4700.224462963641, 4707.835225767081, 4709.270063140219, 10190.235732319958, 10193.388396696222, 10199.337043092324, 10203.489825508696, 10209.693709188736, 5182.196759502283, 5318.0, 5318.282031925718, 5319.5744340452675, 5322.14845624706, 4268.765217913045, 4719.221328480831, 4811.27830825379, 4817.421909370828, 4830.106430310404, 4122.732022418533, 4194.307939189999, 4216.177845320133, 4255.063885945087, 4339.696221264481, 1296.857345691973, 1317.6705823544114, 1322.4776213395846, 1326.038621999043, 1343.3081962789172, 855.9529225892636, 908.9818203636022, 950.1970834644715, 984.3749219245688, 991.9851202231972, 5961.225040744675, 6012.969935150296, 6105.419985101408, 6115.327313995457, 6196.3803619638575, 436.5220084008006, 438.2462165076064, 441.5849101844256, 442.63703762914747, 446.1812573926816, 4205.011822221775, 4234.809433575497, 4240.0, 4255.8084886180195, 4258.318669012943, 11000.0, 11352.091832653368, 11374.715632109264, 11377.658670239905, 11391.430428478543, 11221.831672524919, 11327.150463715254, 11350.148738844455, 11358.26171298863, 11370.09039276856, 7759.0689117305155, 7990.880136797953, 7994.480358776661, 8145.3483721302155, 8202.835943281101, 5936.5844390892225, 6040.969795150996, 6142.631442113308, 6144.293406258159, 6168.1056246844855, 9487.857682134636, 9743.561539730586, 9758.658446954323, 9939.105480506789, 9946.005399460286, 9985.251106166921, 10024.899751002396, 10033.0, 10045.196384289093, 10070.244731645302, 6895.103636527219, 7186.245444228281, 7444.069491313586, 7652.387808975157, 7671.041119860018, 8161.306288965505, 8236.629351679068, 8258.29804466603, 8287.792805179919, 8315.043769966289, 7359.300866417681, 7600.80997975055, 7618.276263754934, 7683.040824589694, 7721.691132354643, 7510.436717246338, 7610.733624323122, 7630.084389873251, 7666.961665191861, 7697.961510192637, 6971.0937578116545, 7010.158780946319, 7020.929790702232, 7028.683709233199, 7046.436285097282, 5184.481551844936, 5190.740462976912, 5350.5184533392185, 5359.732013399236, 5421.481985044194, 5198.402183748766, 5281.234221037851, 5408.37803652585, 5610.102383618601, 5706.514946229451], "value": 4559.328302788101, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.5557153414424, 336.8703049326009, 340.99147521311977, 345.22669220945073, 349.11499349149904, 5535.308086489189, 5629.410471183261, 5731.283589551306, 5811.0702287633985, 5812.970935145324, 5601.971990140044, 5679.716014199284, 5692.5161361284345, 5696.344920334162, 5701.0878259478495, 4463.352813841982, 4467.97236635574, 4469.240229161051, 4477.865664030084, 4481.417415735966, 4351.4343135392355, 4385.693001489897, 4407.0, 4410.55894410558, 4485.52901945296, 4323.0, 4340.56594340565, 4345.739735476708, 4354.956450435503, 4364.563543645641, 4368.453943257093, 4378.912421751563, 4382.276924307485, 4389.912201755947, 4401.943533551925, 3844.6347596978244, 3908.9804550977065, 3932.8565931567364, 3965.920681586352, 3971.1660551284267, 5382.0581398255545, 5415.945840541623, 5472.315960504937, 5489.58828087895, 5517.393086760453, 5071.416787069497, 5078.7303174206445, 5103.591712663015, 5114.130597798346, 5128.5640720538795, 5573.693446860421, 5926.0, 5939.821805345847, 5975.416514623628, 5992.921274170648, 4281.614654681093, 4288.785560721952, 4311.50417701962, 4319.3952846601505, 4339.826406943718, 6143.692815359259, 6186.19579454668, 6187.617767159631, 6198.690065496708, 6209.782657606962, 4030.4760381150263, 4256.659467242614, 4258.254805409041, 4270.41994462051, 4442.333649952533, 4309.655227581786, 4324.200022995756, 4328.653707703376, 4330.112326972963, 4339.500957389941, 4957.553820156203, 4995.200767877122, 4996.575291100297, 5009.949900501021, 5010.498950105033, 5792.565557583198, 5811.564132690065, 5862.296524417097, 5887.293524776968, 5990.341062483123, 1508.5323549699408, 1517.2034681791927, 1522.7563589825575, 1529.3806008566548, 1533.4939469974881, 951.6574033347989, 970.0735797313548, 974.9658761943298, 982.5185659027026, 984.448708723103, 5059.443461219263, 5117.974410127926, 5175.489887404606, 5198.766055527511, 5201.115810312181, 5369.6509726867625, 5377.838664840061, 5386.326709161355, 5386.515213630713, 5506.889862202734, 4941.975290123526, 5031.924521132186, 5185.766640501187, 5216.165413533817, 5220.0, 2894.45005448964, 2927.238917881366, 2930.168644597127, 2973.8661760220843, 2977.374751302251, 5661.716914154358, 5665.235193248858, 5670.8015219467125, 5675.205471233948, 5703.230063941315, 5216.313598496778, 5499.477549632778, 5502.669839809624, 5546.611737178439, 5577.298923828272, 5559.054960656698, 5560.972195139079, 5587.05020146576, 5657.2928383952, 5678.501459357869, 5017.749112544285, 5332.30680011596, 5338.145896656516, 5387.81142660005, 5409.540189083972, 5288.540828514759, 5331.200319952039, 5353.892922141613, 5364.624476286623, 5398.326518779191, 5558.916616250679, 5611.859703507445, 5666.243464525845, 5668.858278543069, 5695.772169113189, 3991.560928297943, 4022.3363145080734, 4041.515018197835, 4289.871303860889, 4366.978165109154, 5975.282966044103, 6072.301685306246, 6081.361457046946, 6122.908156377569, 6145.938540614537, 5877.94122058774, 5936.970315148396, 5938.673372964528, 5946.316173639913, 5965.164876917322, 5899.970500147472, 5906.793262235801, 5907.49786268172, 5933.525317974465, 5953.196318497121, 5677.801276955287, 5806.709664516842, 5881.794327127327, 5885.293764748258, 5904.8780731660845, 5965.850853728692, 6022.3977602241175, 6039.849003774941, 6057.515398768176, 6090.878182436238, 5619.381867994435, 5857.384974577608, 5888.852778680567, 5894.145348924296, 5941.346451890375], "value": 4376.374333802045, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [765.9655315510802, 780.4858673471921, 827.6730691376906, 861.4745005546617, 862.5988915154452, 15182.089074655529, 15660.921695391522, 15842.207889605503, 15858.127802970861, 15905.602359941007, 14309.069910455813, 14344.426222951095, 14365.28173591319, 14382.352794124263, 14384.640383990405, 668.5119862500366, 790.0519376747897, 810.8905297784783, 811.407672399146, 814.0434988888062, 809.465752603282, 816.8856360109589, 817.2236375443323, 818.443458448255, 821.2608652212996, 866.5493943149559, 866.9349798765086, 867.483847110968, 869.0397111192136, 871.0070519607652, 857.4126723194569, 862.706679728892, 863.0290922711949, 864.2869632553106, 864.3992425264412, 636.544870417649, 637.3817397124782, 637.4931929116364, 638.3010603389281, 638.955273130881, 14589.489367872073, 14591.708165836624, 14615.342309596093, 14620.195889226088, 14642.926785366111, 13803.723925521434, 13916.791248131287, 14079.648008799863, 14125.929370353186, 14166.079204851652, 11482.65552033432, 11793.705157371134, 11798.41007949599, 11909.10681698876, 12003.399830008551, 3830.195658911632, 3864.4589757433982, 3902.9219415611815, 3932.213557288525, 3956.5845586213322, 59057.114143288316, 59399.70300148472, 60510.0, 60543.394566054216, 60595.697021514614, 11029.44852757375, 11068.833967490495, 11274.210805243554, 11366.602168924213, 11506.654800356002, 21583.892080539496, 21594.352169434627, 21620.78379216219, 21623.351299461043, 21633.56732865334, 8085.636146373427, 8178.713745018896, 8199.180081991872, 8227.8354432911, 8231.46495477792, 4567.1550763108935, 4572.74849883253, 4642.9767851161205, 4717.575418212377, 4759.524047595282, 3599.676029157336, 3664.5785734640326, 3666.926661466809, 3668.137987572918, 3686.152184997412, 633.5660072850112, 646.5958775765147, 650.3853858104046, 653.2781276689285, 654.2116749317062, 747.3983443328065, 748.135903031999, 768.9038870141233, 769.0579040675128, 789.3014682006351, 9130.0, 9307.674231401868, 9330.300227482965, 9458.763530911645, 9576.521173941275, 644.2120332445193, 703.7888633409957, 722.0252658910429, 725.0936329588015, 780.0522365326156, 4551.203539380595, 4603.769811509478, 4733.171694953438, 4739.881502962385, 4758.738269395148, 69998.45010074328, 70873.6456317715, 71100.64449677718, 71226.64386678033, 71792.0, 61136.38863611396, 62014.37985620086, 62831.0, 63000.0, 63393.0, 56594.71702641543, 56829.71585142048, 57293.71353143208, 57365.42634573601, 57372.42627573671, 8521.147885211429, 8620.439671421338, 8650.610722517627, 8742.60658270392, 8779.604917778588, 36492.635073648926, 36530.72142475001, 36589.634103658624, 36954.26091478209, 37033.44449833308, 48878.26682599835, 49177.75411122922, 49214.0, 49503.0, 50315.74842125766, 11685.240459370114, 11877.703057423634, 12094.153409261267, 12135.271883687006, 12554.43505042257, 12645.178063426216, 12736.490540378281, 12786.296753678636, 12826.102172847812, 12892.29092399927, 11409.25839820409, 11710.238834476073, 12109.0, 12120.878791211975, 12232.143749937419, 11100.722481938015, 11527.942360288145, 11533.88466115328, 11653.53385864556, 11849.466773995018, 11661.35862527569, 11676.532938682358, 12534.749305014031, 12998.090133690552, 13499.190048597116, 10726.517306721373, 11285.71785705364, 11890.643280701594, 11916.225445346025, 12096.818547721616, 11525.481353339288, 11728.179027467995, 11819.704507387383, 11998.160128790902, 12002.699932501757], "value": 6982.077784081154, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1553.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 103.0, 110.0, 111.0, 109.0, 104.0, 111.0, 109.0, 111.0], "value": 108.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 134.0, 152.0, 210.0, 126.0, 156.0, 153.0, 128.0, 184.0, 128.0], "value": 153.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 161.0, 164.0, 165.0, 170.0, 162.0, 162.0, 163.0, 164.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 74.0, 76.0, 159.0, 75.0, 76.0, 73.0, 75.0, 178.0, 76.0], "value": 94.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 175.0, 91.0, 92.0, 92.0, 156.0, 91.0, 91.0, 157.0], "value": 112.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 118.0, 118.0, 117.0, 118.0, 116.0, 117.0, 119.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 148.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 148.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 61.0, 58.0, 55.0, 55.0, 55.0, 54.0, 112.0, 53.0, 55.0], "value": 61.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 63.0, 60.0, 60.0, 60.0, 59.0, 60.0, 59.0, 60.0, 60.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 78.0, 78.0, 80.0, 79.0, 80.0, 80.0, 79.0, 82.0], "value": 79.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 130.0, 124.0, 125.0, 124.0, 124.0, 123.0, 120.0, 235.0, 124.0], "value": 135.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 164.0, 159.0, 160.0, 161.0, 160.0, 160.0, 160.0, 165.0], "value": 161.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 65.0, 65.0, 65.0, 64.0, 67.0, 62.0, 64.0, 63.0], "value": 64.2, "unit": "score"}]}]} 13:21:15 INFO - Return code: 0 13:21:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:21:16 ERROR - # TBPL SUCCESS # 13:21:16 INFO - Running post-action listener: _resource_record_post_action 13:21:16 INFO - ##### 13:21:16 INFO - ##### Finished run-tests step (success) 13:21:16 INFO - ##### 13:21:16 INFO - Running post-run listener: _resource_record_post_run 13:21:16 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 540250112; Read time: 0; Write time: 407088 13:21:16 INFO - TinderboxPrint: CPU usage
13.4% 13:21:16 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 13:21:16 INFO - TinderboxPrint: I/O write bytes / time
540,250,112 / 407,088 13:21:16 INFO - TinderboxPrint: CPU idle
8,209.1 (86.5%) 13:21:16 INFO - TinderboxPrint: CPU user
1,223.6 (12.9%) 13:21:16 INFO - TinderboxPrint: Swap in / out
0 / 0 13:21:16 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 246312960; Read time: 0; Write time: 196036 13:21:16 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 293765120; Read time: 0; Write time: 211028 13:21:16 INFO - Running post-run listener: _upload_blobber_files 13:21:16 INFO - Blob upload gear active. 13:21:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:21:16 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 13:21:16 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:21:16 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:21:17 INFO - (blobuploader) - INFO - Open directory for files ... 13:21:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:21:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:21:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:21:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:21:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:21:18 INFO - (blobuploader) - INFO - Done attempting. 13:21:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:21:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:21:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:21:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:21:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:21:19 INFO - (blobuploader) - INFO - Done attempting. 13:21:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:21:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:21:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:21:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:21:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:21:23 INFO - (blobuploader) - INFO - Done attempting. 13:21:23 INFO - (blobuploader) - INFO - Iteration through files over. 13:21:23 INFO - Return code: 0 13:21:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:21:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:21:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5696a6ad89b46d4e55595b918bce7d87df8e787a5905508ac6fef6c5b39fb634120cb8841ad02ceb726426b7e4b6c00db539534eb09ce5951336900b33eb7917", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/96ddb52aac35a7a920d2c24d0db893ee2ed5ab11c0cb94ab3d7c6beff32b01aa95912fe20877669baaa838113ab849710aa0b4efe0277b7d5dc4d307e316394a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9d47d135d1287218e64330f0bb5a5720cd0ed75cb39ec2e3ee3273f5f53b84abb38be9ef3fa5e1f7dcbcbde16c24ed6b41142b2177851996e73fdb1ea60dadc"} 13:21:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:21:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:21:23 INFO - Contents: 13:21:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5696a6ad89b46d4e55595b918bce7d87df8e787a5905508ac6fef6c5b39fb634120cb8841ad02ceb726426b7e4b6c00db539534eb09ce5951336900b33eb7917", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/96ddb52aac35a7a920d2c24d0db893ee2ed5ab11c0cb94ab3d7c6beff32b01aa95912fe20877669baaa838113ab849710aa0b4efe0277b7d5dc4d307e316394a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9d47d135d1287218e64330f0bb5a5720cd0ed75cb39ec2e3ee3273f5f53b84abb38be9ef3fa5e1f7dcbcbde16c24ed6b41142b2177851996e73fdb1ea60dadc"} 13:21:23 INFO - Running post-run listener: copy_logs_to_upload_dir 13:21:23 INFO - Copying logs to upload dir... 13:21:23 INFO - mkdir: /builds/slave/test/build/upload/logs 13:21:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1323.187697 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 3 secs) (at 2016-05-18 13:21:22.942946) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-18 13:21:22.946970) ========= 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=0333a256a5e4f052382dd180000001b1-1463601352.890358-1880406764 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/Firefox/sha512/5696a6ad89b46d4e55595b918bce7d87df8e787a5905508ac6fef6c5b39fb634120cb8841ad02ceb726426b7e4b6c00db539534eb09ce5951336900b33eb7917", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/96ddb52aac35a7a920d2c24d0db893ee2ed5ab11c0cb94ab3d7c6beff32b01aa95912fe20877669baaa838113ab849710aa0b4efe0277b7d5dc4d307e316394a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9d47d135d1287218e64330f0bb5a5720cd0ed75cb39ec2e3ee3273f5f53b84abb38be9ef3fa5e1f7dcbcbde16c24ed6b41142b2177851996e73fdb1ea60dadc"} build_url:https://queue.taskcluster.net/v1/task/ARDPPwsRRDOz2R2e9Cnw-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011336 build_url: 'https://queue.taskcluster.net/v1/task/ARDPPwsRRDOz2R2e9Cnw-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5696a6ad89b46d4e55595b918bce7d87df8e787a5905508ac6fef6c5b39fb634120cb8841ad02ceb726426b7e4b6c00db539534eb09ce5951336900b33eb7917", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/96ddb52aac35a7a920d2c24d0db893ee2ed5ab11c0cb94ab3d7c6beff32b01aa95912fe20877669baaa838113ab849710aa0b4efe0277b7d5dc4d307e316394a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9d47d135d1287218e64330f0bb5a5720cd0ed75cb39ec2e3ee3273f5f53b84abb38be9ef3fa5e1f7dcbcbde16c24ed6b41142b2177851996e73fdb1ea60dadc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-18 13:21:22.971892) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 13:21:22.972359) ========= 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=0333a256a5e4f052382dd180000001b1-1463601352.890358-1880406764 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004510 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 13:21:23.055662) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-18 13:21:23.055986) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-18 13:21:23.056327) ========= ========= Total master_lag: 0.17 =========