builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-050 starttime: 1461150384.19 results: success (0) buildid: 20160420024742 builduid: 8df05eb3aeee4b2bba7799e3f25fde79 revision: 973dfa15822126c39ea2d98d34ac16643b040243 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 04:06:24.190109) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 04:06:24.191026) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 04:06:24.191325) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 04:06:24.208826) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 04:06:24.209185) ========= 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=6dbc10da6d83fee962c624be000001a8-1461150314.313537-970667941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-20 04:06:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-04-20 04:06:24 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102677 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 04:06:24.328959) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 04:06:24.329257) ========= 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=6dbc10da6d83fee962c624be000001a8-1461150314.313537-970667941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013829 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 04:06:24.378863) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-20 04:06:24.379243) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 973dfa15822126c39ea2d98d34ac16643b040243 --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 973dfa15822126c39ea2d98d34ac16643b040243 --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=6dbc10da6d83fee962c624be000001a8-1461150314.313537-970667941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-20 04:06:24,593 truncating revision to first 12 chars 2016-04-20 04:06:24,593 Setting DEBUG logging. 2016-04-20 04:06:24,593 attempt 1/10 2016-04-20 04:06:24,593 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/973dfa158221?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 04:06:25,211 unpacking tar archive at: mozilla-central-973dfa158221/testing/mozharness/ program finished with exit code 0 elapsedTime=1.328110 ========= master_lag: 1.67 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-20 04:06:27.373832) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 04:06:27.374120) ========= script_repo_revision: 973dfa15822126c39ea2d98d34ac16643b040243 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 04:06:27.374485) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 04:06:27.374752) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 04:06:27.663803) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-20 04:06:27.664125) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1461150314.313537-970667941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:06:27 INFO - MultiFileLogger online at 20160420 04:06:27 in /builds/slave/test 04:06:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:06:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:06:27 INFO - {'append_to_log': False, 04:06:27 INFO - 'base_work_dir': '/builds/slave/test', 04:06:27 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:06:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:06:27 INFO - 'branch': 'Firefox-Non-PGO', 04:06:27 INFO - 'buildbot_json_path': 'buildprops.json', 04:06:27 INFO - 'config_files': ('talos/linux_config.py',), 04:06:27 INFO - 'default_actions': ('clobber', 04:06:27 INFO - 'read-buildbot-config', 04:06:27 INFO - 'download-and-extract', 04:06:27 INFO - 'populate-webroot', 04:06:27 INFO - 'create-virtualenv', 04:06:27 INFO - 'install', 04:06:27 INFO - 'run-tests'), 04:06:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:06:27 INFO - 'download_minidump_stackwalk': True, 04:06:27 INFO - 'download_symbols': 'ondemand', 04:06:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:06:27 INFO - 'tooltool.py': '/tools/tooltool.py', 04:06:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:06:27 INFO - '/tools/misc-python/virtualenv.py')}, 04:06:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:06:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:06:27 INFO - 'installer_path': 'installer.exe', 04:06:27 INFO - 'log_level': 'info', 04:06:27 INFO - 'log_name': 'talos', 04:06:27 INFO - 'log_to_console': True, 04:06:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:06:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:06:27 INFO - 'opt_config_files': (), 04:06:27 INFO - 'pip_index': False, 04:06:27 INFO - 'sps_profile': False, 04:06:27 INFO - 'sps_profile_interval': 0, 04:06:27 INFO - 'suite': 'dromaeojs-e10s', 04:06:27 INFO - 'system_bits': '32', 04:06:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:06:27 INFO - 'title': 'talos-linux64-ix-050', 04:06:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:06:27 INFO - 'use_talos_json': True, 04:06:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:06:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:06:27 INFO - 'work_dir': 'build'} 04:06:27 INFO - ##### 04:06:27 INFO - ##### Running clobber step. 04:06:27 INFO - ##### 04:06:27 INFO - Running pre-action listener: _resource_record_pre_action 04:06:27 INFO - Running main action method: clobber 04:06:27 INFO - rmtree: /builds/slave/test/build 04:06:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:06:28 INFO - Running post-action listener: _resource_record_post_action 04:06:28 INFO - ##### 04:06:28 INFO - ##### Running read-buildbot-config step. 04:06:28 INFO - ##### 04:06:28 INFO - Running pre-action listener: _resource_record_pre_action 04:06:28 INFO - Running main action method: read_buildbot_config 04:06:28 INFO - Using buildbot properties: 04:06:28 INFO - { 04:06:28 INFO - "project": "", 04:06:28 INFO - "product": "firefox", 04:06:28 INFO - "script_repo_revision": "production", 04:06:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:06:28 INFO - "repository": "", 04:06:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:06:28 INFO - "buildid": "20160420024742", 04:06:28 INFO - "pgo_build": "False", 04:06:28 INFO - "basedir": "/builds/slave/test", 04:06:28 INFO - "buildnumber": 328, 04:06:28 INFO - "slavename": "talos-linux64-ix-050", 04:06:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:06:28 INFO - "platform": "ubuntu64_hw", 04:06:28 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:06:28 INFO - "branch": "mozilla-central", 04:06:28 INFO - "repo_path": "mozilla-central", 04:06:28 INFO - "revision": "973dfa15822126c39ea2d98d34ac16643b040243", 04:06:28 INFO - "stage_platform": "linux64", 04:06:28 INFO - "builduid": "8df05eb3aeee4b2bba7799e3f25fde79", 04:06:28 INFO - "slavebuilddir": "test" 04:06:28 INFO - } 04:06:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/a3Ar_86GS9iRtlmb0x-CDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 04:06:28 INFO - Running post-action listener: _resource_record_post_action 04:06:28 INFO - ##### 04:06:28 INFO - ##### Running download-and-extract step. 04:06:28 INFO - ##### 04:06:28 INFO - Running pre-action listener: _resource_record_pre_action 04:06:28 INFO - Running main action method: download_and_extract 04:06:28 INFO - mkdir: /builds/slave/test/build/tests 04:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:28 INFO - https://queue.taskcluster.net/v1/task/a3Ar_86GS9iRtlmb0x-CDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:06:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a3Ar_86GS9iRtlmb0x-CDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:06:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a3Ar_86GS9iRtlmb0x-CDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:06:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a3Ar_86GS9iRtlmb0x-CDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:06:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a3Ar_86GS9iRtlmb0x-CDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:06:29 INFO - Downloaded 1361 bytes. 04:06:29 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:06:29 INFO - Using the following test package requirements: 04:06:29 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:06:29 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:06:29 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:06:29 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:29 INFO - u'jsshell-linux-x86_64.zip'], 04:06:29 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:06:29 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:06:29 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:06:29 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:06:29 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:06:29 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:06:29 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:06:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:29 INFO - https://queue.taskcluster.net/v1/task/a3Ar_86GS9iRtlmb0x-CDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:06:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a3Ar_86GS9iRtlmb0x-CDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:06:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a3Ar_86GS9iRtlmb0x-CDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:06:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a3Ar_86GS9iRtlmb0x-CDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:06:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a3Ar_86GS9iRtlmb0x-CDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:06:31 INFO - Downloaded 22266946 bytes. 04:06:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:06:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:06:32 INFO - Return code: 0 04:06:32 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:06:32 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')]} 04:06:32 INFO - https://queue.taskcluster.net/v1/task/a3Ar_86GS9iRtlmb0x-CDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:06:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a3Ar_86GS9iRtlmb0x-CDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:06:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a3Ar_86GS9iRtlmb0x-CDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:06:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a3Ar_86GS9iRtlmb0x-CDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:06:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a3Ar_86GS9iRtlmb0x-CDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:06:33 INFO - Downloaded 22266946 bytes. 04:06:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:06:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:06:34 INFO - Return code: 0 04:06:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:34 INFO - https://queue.taskcluster.net/v1/task/a3Ar_86GS9iRtlmb0x-CDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:06:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a3Ar_86GS9iRtlmb0x-CDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:06:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a3Ar_86GS9iRtlmb0x-CDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:06:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a3Ar_86GS9iRtlmb0x-CDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:06:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a3Ar_86GS9iRtlmb0x-CDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:06:36 INFO - Downloaded 10845952 bytes. 04:06:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:06:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:06:36 INFO - Return code: 0 04:06:36 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')]} 04:06:36 INFO - https://queue.taskcluster.net/v1/task/a3Ar_86GS9iRtlmb0x-CDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:06:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a3Ar_86GS9iRtlmb0x-CDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:06:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a3Ar_86GS9iRtlmb0x-CDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:06:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a3Ar_86GS9iRtlmb0x-CDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:06:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a3Ar_86GS9iRtlmb0x-CDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:06:38 INFO - Downloaded 54585647 bytes. 04:06:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a3Ar_86GS9iRtlmb0x-CDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:06:38 INFO - mkdir: /builds/slave/test/properties 04:06:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:06:38 INFO - Writing to file /builds/slave/test/properties/build_url 04:06:38 INFO - Contents: 04:06:38 INFO - build_url:https://queue.taskcluster.net/v1/task/a3Ar_86GS9iRtlmb0x-CDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:06:39 INFO - Running post-action listener: _resource_record_post_action 04:06:39 INFO - Running post-action listener: set_extra_try_arguments 04:06:39 INFO - ##### 04:06:39 INFO - ##### Running populate-webroot step. 04:06:39 INFO - ##### 04:06:39 INFO - Running pre-action listener: _resource_record_pre_action 04:06:39 INFO - Running main action method: populate_webroot 04:06:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:06:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:06:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:06:39 INFO - '--tppagecycles', 04:06:39 INFO - '7'], 04:06:39 INFO - 'tests': ['tsvgm']}}, 04:06:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:06:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:06:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:06:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:06:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:06:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:06:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:39 INFO - 'talos_options': ['--disable-e10s'], 04:06:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:06:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:06:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:39 INFO - 'talos_options': ['--disable-e10s'], 04:06:39 INFO - 'tests': ['damp', 'tps']}, 04:06:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:39 INFO - 'tests': ['damp', 'tps']}, 04:06:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:06:39 INFO - 'tests': ['dromaeo_dom']}, 04:06:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:06:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:06:40 INFO - 'tests': ['a11yr', 04:06:40 INFO - 'ts_paint', 04:06:40 INFO - 'tpaint', 04:06:40 INFO - 'sessionrestore', 04:06:40 INFO - 'sessionrestore_no_auto_restore', 04:06:40 INFO - 'tabpaint']}, 04:06:40 INFO - 'other-e10s': {'tests': ['a11yr', 04:06:40 INFO - 'ts_paint', 04:06:40 INFO - 'tpaint', 04:06:40 INFO - 'sessionrestore', 04:06:40 INFO - 'sessionrestore_no_auto_restore', 04:06:40 INFO - 'tabpaint']}, 04:06:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:06:40 INFO - 'ts_paint', 04:06:40 INFO - 'tpaint', 04:06:40 INFO - 'sessionrestore', 04:06:40 INFO - 'sessionrestore_no_auto_restore', 04:06:40 INFO - 'tabpaint']}, 04:06:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:06:40 INFO - 'ts_paint', 04:06:40 INFO - 'tpaint', 04:06:40 INFO - 'sessionrestore', 04:06:40 INFO - 'sessionrestore_no_auto_restore', 04:06:40 INFO - 'tabpaint']}, 04:06:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:06:40 INFO - 'tests': ['a11yr', 04:06:40 INFO - 'ts_paint', 04:06:40 INFO - 'tpaint', 04:06:40 INFO - 'sessionrestore', 04:06:40 INFO - 'sessionrestore_no_auto_restore', 04:06:40 INFO - 'tabpaint']}, 04:06:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:06:40 INFO - 'tests': ['a11yr', 04:06:40 INFO - 'ts_paint', 04:06:40 INFO - 'tpaint', 04:06:40 INFO - 'sessionrestore', 04:06:40 INFO - 'sessionrestore_no_auto_restore', 04:06:40 INFO - 'tabpaint']}, 04:06:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:06:40 INFO - 'tests': ['tsvgx', 04:06:40 INFO - 'tsvgr_opacity', 04:06:40 INFO - 'tart', 04:06:40 INFO - 'tscrollx', 04:06:40 INFO - 'cart']}, 04:06:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:06:40 INFO - 'tsvgr_opacity', 04:06:40 INFO - 'tart', 04:06:40 INFO - 'tscrollx', 04:06:40 INFO - 'cart']}, 04:06:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:40 INFO - 'talos_options': ['--disable-e10s'], 04:06:40 INFO - 'tests': ['tp5o']}, 04:06:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:40 INFO - 'tests': ['tp5o']}, 04:06:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:40 INFO - 'talos_options': ['--disable-e10s', 04:06:40 INFO - '--xperf_path', 04:06:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:06:40 INFO - 'tests': ['tp5n']}, 04:06:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:40 INFO - 'talos_options': ['--xperf_path', 04:06:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:06:40 INFO - 'tests': ['tp5n']}}, 04:06:40 INFO - 'talos.zip': {'path': '', 04:06:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:06:40 INFO - Running post-action listener: _resource_record_post_action 04:06:40 INFO - ##### 04:06:40 INFO - ##### Running create-virtualenv step. 04:06:40 INFO - ##### 04:06:40 INFO - Running pre-action listener: _resource_record_pre_action 04:06:40 INFO - Running main action method: create_virtualenv 04:06:40 INFO - Creating virtualenv /builds/slave/test/build/venv 04:06:40 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 04:06:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:06:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:06:40 INFO - Using real prefix '/usr' 04:06:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:06:40 INFO - Installing distribute.............................................................................................................................................................................................done. 04:06:42 INFO - Installing pip.................done. 04:06:42 INFO - Return code: 0 04:06:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf9b386f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ba410>, '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 0x15bb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15bb7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1461150314.313537-970667941', '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 04:06:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:06:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:06:42 INFO - Using env: {'DISPLAY': ':0', 04:06:42 INFO - 'HOME': '/home/cltbld', 04:06:42 INFO - 'LANG': 'en_US.UTF-8', 04:06:42 INFO - 'LANGUAGE': 'en_US:en', 04:06:42 INFO - 'LOGNAME': 'cltbld', 04:06:42 INFO - 'MAIL': '/var/mail/cltbld', 04:06:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:42 INFO - 'MOZ_NO_REMOTE': '1', 04:06:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:42 INFO - 'NO_EM_RESTART': '1', 04:06:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:42 INFO - 'PWD': '/builds/slave/test', 04:06:42 INFO - 'SHELL': '/bin/bash', 04:06:42 INFO - 'SHLVL': '1', 04:06:42 INFO - 'TERM': 'linux', 04:06:42 INFO - 'TMOUT': '86400', 04:06:42 INFO - 'USER': 'cltbld', 04:06:42 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461150314.313537-970667941', 04:06:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:42 INFO - '_': '/tools/buildbot/bin/python'} 04:06:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:42 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 04:06:42 INFO - Cleaning up... 04:06:42 INFO - Return code: 0 04:06:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf9b386f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ba410>, '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 0x15bb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15bb7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1461150314.313537-970667941', '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 04:06:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:06:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:06:42 INFO - Using env: {'DISPLAY': ':0', 04:06:42 INFO - 'HOME': '/home/cltbld', 04:06:42 INFO - 'LANG': 'en_US.UTF-8', 04:06:42 INFO - 'LANGUAGE': 'en_US:en', 04:06:42 INFO - 'LOGNAME': 'cltbld', 04:06:42 INFO - 'MAIL': '/var/mail/cltbld', 04:06:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:42 INFO - 'MOZ_NO_REMOTE': '1', 04:06:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:42 INFO - 'NO_EM_RESTART': '1', 04:06:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:42 INFO - 'PWD': '/builds/slave/test', 04:06:42 INFO - 'SHELL': '/bin/bash', 04:06:42 INFO - 'SHLVL': '1', 04:06:42 INFO - 'TERM': 'linux', 04:06:42 INFO - 'TMOUT': '86400', 04:06:42 INFO - 'USER': 'cltbld', 04:06:42 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461150314.313537-970667941', 04:06:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:42 INFO - '_': '/tools/buildbot/bin/python'} 04:06:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:42 INFO - Downloading/unpacking psutil>=0.7.1 04:06:42 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 04:06:42 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 04:06:42 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 04:06:42 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 04:06:42 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 04:06:42 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 04:06:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:06:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:06:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:06:44 INFO - Installing collected packages: psutil 04:06:44 INFO - Running setup.py install for psutil 04:06:45 INFO - building 'psutil._psutil_linux' extension 04:06:45 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 04:06:45 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 04:06:45 INFO - building 'psutil._psutil_posix' extension 04:06:45 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 04:06:45 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 04:06:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:06:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:06:45 INFO - Successfully installed psutil 04:06:45 INFO - Cleaning up... 04:06:45 INFO - Return code: 0 04:06:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:06:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:45 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf9b386f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ba410>, '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 0x15bb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15bb7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1461150314.313537-970667941', '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 04:06:45 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.0.0'] in /builds/slave/test/build 04:06:45 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.0.0 04:06:45 INFO - Using env: {'DISPLAY': ':0', 04:06:45 INFO - 'HOME': '/home/cltbld', 04:06:45 INFO - 'LANG': 'en_US.UTF-8', 04:06:45 INFO - 'LANGUAGE': 'en_US:en', 04:06:45 INFO - 'LOGNAME': 'cltbld', 04:06:45 INFO - 'MAIL': '/var/mail/cltbld', 04:06:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:45 INFO - 'MOZ_NO_REMOTE': '1', 04:06:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:45 INFO - 'NO_EM_RESTART': '1', 04:06:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:45 INFO - 'PWD': '/builds/slave/test', 04:06:45 INFO - 'SHELL': '/bin/bash', 04:06:45 INFO - 'SHLVL': '1', 04:06:45 INFO - 'TERM': 'linux', 04:06:45 INFO - 'TMOUT': '86400', 04:06:45 INFO - 'USER': 'cltbld', 04:06:45 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461150314.313537-970667941', 04:06:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:45 INFO - '_': '/tools/buildbot/bin/python'} 04:06:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:06:45 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 04:06:45 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 04:06:45 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 04:06:45 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 04:06:45 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 04:06:45 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 04:06:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:06:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:06:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:06:47 INFO - Installing collected packages: mozsystemmonitor 04:06:47 INFO - Running setup.py install for mozsystemmonitor 04:06:47 INFO - Successfully installed mozsystemmonitor 04:06:47 INFO - Cleaning up... 04:06:47 INFO - Return code: 0 04:06:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:06:47 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')]} 04:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:47 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')]} 04:06:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:47 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 0x7fdf9b386f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ba410>, '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 0x15bb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15bb7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1461150314.313537-970667941', '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 04:06:47 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 04:06:47 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 04:06:47 INFO - Using env: {'DISPLAY': ':0', 04:06:47 INFO - 'HOME': '/home/cltbld', 04:06:47 INFO - 'LANG': 'en_US.UTF-8', 04:06:47 INFO - 'LANGUAGE': 'en_US:en', 04:06:47 INFO - 'LOGNAME': 'cltbld', 04:06:47 INFO - 'MAIL': '/var/mail/cltbld', 04:06:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:47 INFO - 'MOZ_NO_REMOTE': '1', 04:06:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:47 INFO - 'NO_EM_RESTART': '1', 04:06:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:47 INFO - 'PWD': '/builds/slave/test', 04:06:47 INFO - 'SHELL': '/bin/bash', 04:06:47 INFO - 'SHLVL': '1', 04:06:47 INFO - 'TERM': 'linux', 04:06:47 INFO - 'TMOUT': '86400', 04:06:47 INFO - 'USER': 'cltbld', 04:06:47 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461150314.313537-970667941', 04:06:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:47 INFO - '_': '/tools/buildbot/bin/python'} 04:06:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:47 INFO - Downloading/unpacking blobuploader==1.2.4 04:06:47 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 04:06:47 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 04:06:47 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 04:06:47 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 04:06:47 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 04:06:47 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 04:06:49 INFO - Downloading blobuploader-1.2.4.tar.gz 04:06:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:06:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:06:49 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 04:06:49 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 04:06:49 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 04:06:49 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 04:06:49 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 04:06:49 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 04:06:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:06:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:06:50 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 04:06:50 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 04:06:50 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 04:06:50 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 04:06:50 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 04:06:50 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 04:06:50 INFO - Downloading docopt-0.6.1.tar.gz 04:06:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:06:50 INFO - Installing collected packages: blobuploader, requests, docopt 04:06:50 INFO - Running setup.py install for blobuploader 04:06:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:06:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:06:50 INFO - Running setup.py install for requests 04:06:51 INFO - Running setup.py install for docopt 04:06:51 INFO - Successfully installed blobuploader requests docopt 04:06:51 INFO - Cleaning up... 04:06:51 INFO - Return code: 0 04:06:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:51 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')]} 04:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:51 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')]} 04:06:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:51 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 0x7fdf9b386f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ba410>, '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 0x15bb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15bb7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1461150314.313537-970667941', '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 04:06:51 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 04:06:51 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 04:06:51 INFO - Using env: {'DISPLAY': ':0', 04:06:51 INFO - 'HOME': '/home/cltbld', 04:06:51 INFO - 'LANG': 'en_US.UTF-8', 04:06:51 INFO - 'LANGUAGE': 'en_US:en', 04:06:51 INFO - 'LOGNAME': 'cltbld', 04:06:51 INFO - 'MAIL': '/var/mail/cltbld', 04:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:51 INFO - 'MOZ_NO_REMOTE': '1', 04:06:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:51 INFO - 'NO_EM_RESTART': '1', 04:06:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:51 INFO - 'PWD': '/builds/slave/test', 04:06:51 INFO - 'SHELL': '/bin/bash', 04:06:51 INFO - 'SHLVL': '1', 04:06:51 INFO - 'TERM': 'linux', 04:06:51 INFO - 'TMOUT': '86400', 04:06:51 INFO - 'USER': 'cltbld', 04:06:51 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461150314.313537-970667941', 04:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:51 INFO - '_': '/tools/buildbot/bin/python'} 04:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:06:51 INFO - Running setup.py (path:/tmp/pip-cjUalQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:06:51 INFO - Running setup.py (path:/tmp/pip-00LMFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:06:51 INFO - Running setup.py (path:/tmp/pip-N9yZk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:06:51 INFO - Running setup.py (path:/tmp/pip-PIthNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:06:51 INFO - Running setup.py (path:/tmp/pip-3nPVKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:06:51 INFO - Running setup.py (path:/tmp/pip-gkLwr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:06:51 INFO - Running setup.py (path:/tmp/pip-NroiBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:06:51 INFO - Running setup.py (path:/tmp/pip-e6WznP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:06:52 INFO - Running setup.py (path:/tmp/pip-rYuj9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:06:52 INFO - Running setup.py (path:/tmp/pip-Ci9Ksi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:06:52 INFO - Running setup.py (path:/tmp/pip-3mzWvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:06:52 INFO - Running setup.py (path:/tmp/pip-fmqQvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:06:52 INFO - Running setup.py (path:/tmp/pip-k_aLap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:06:52 INFO - Running setup.py (path:/tmp/pip-q0YqUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:52 INFO - Running setup.py (path:/tmp/pip-dJuN67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:06:52 INFO - Running setup.py (path:/tmp/pip-MOVGlR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:06:52 INFO - Running setup.py (path:/tmp/pip-w9PJ1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:06:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:06:52 INFO - Running setup.py install for manifestparser 04:06:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:06:52 INFO - Running setup.py install for mozcrash 04:06:52 INFO - Running setup.py install for mozdebug 04:06:52 INFO - Running setup.py install for mozdevice 04:06:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:06:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:06:53 INFO - Running setup.py install for mozfile 04:06:53 INFO - Running setup.py install for mozhttpd 04:06:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:06:53 INFO - Running setup.py install for mozinfo 04:06:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:06:53 INFO - Running setup.py install for mozInstall 04:06:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:06:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:06:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:06:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:06:53 INFO - Running setup.py install for mozleak 04:06:53 INFO - Running setup.py install for mozlog 04:06:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:06:53 INFO - Running setup.py install for moznetwork 04:06:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:06:53 INFO - Running setup.py install for mozprocess 04:06:53 INFO - Running setup.py install for mozprofile 04:06:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:06:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:06:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:06:53 INFO - Running setup.py install for mozrunner 04:06:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:06:54 INFO - Running setup.py install for mozscreenshot 04:06:54 INFO - Running setup.py install for moztest 04:06:54 INFO - Running setup.py install for mozversion 04:06:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:06:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:06:54 INFO - Cleaning up... 04:06:54 INFO - Return code: 0 04:06:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:54 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')]} 04:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:54 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')]} 04:06:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:54 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 0x7fdf9b386f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ba410>, '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 0x15bb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15bb7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1461150314.313537-970667941', '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 04:06:54 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 04:06:54 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 04:06:54 INFO - Using env: {'DISPLAY': ':0', 04:06:54 INFO - 'HOME': '/home/cltbld', 04:06:54 INFO - 'LANG': 'en_US.UTF-8', 04:06:54 INFO - 'LANGUAGE': 'en_US:en', 04:06:54 INFO - 'LOGNAME': 'cltbld', 04:06:54 INFO - 'MAIL': '/var/mail/cltbld', 04:06:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:54 INFO - 'MOZ_NO_REMOTE': '1', 04:06:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:54 INFO - 'NO_EM_RESTART': '1', 04:06:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:54 INFO - 'PWD': '/builds/slave/test', 04:06:54 INFO - 'SHELL': '/bin/bash', 04:06:54 INFO - 'SHLVL': '1', 04:06:54 INFO - 'TERM': 'linux', 04:06:54 INFO - 'TMOUT': '86400', 04:06:54 INFO - 'USER': 'cltbld', 04:06:54 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461150314.313537-970667941', 04:06:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:54 INFO - '_': '/tools/buildbot/bin/python'} 04:06:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:06:54 INFO - Running setup.py (path:/tmp/pip-qvXS06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:06:54 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)) 04:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:06:54 INFO - Running setup.py (path:/tmp/pip-U2t_c_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:06:54 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)) 04:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:06:54 INFO - Running setup.py (path:/tmp/pip-G42VsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:06:54 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)) 04:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:06:54 INFO - Running setup.py (path:/tmp/pip-Oh6YUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:06:54 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)) 04:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:06:54 INFO - Running setup.py (path:/tmp/pip-Ir6hTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:06:55 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)) 04:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:06:55 INFO - Running setup.py (path:/tmp/pip-huaW7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:06:55 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)) 04:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:06:55 INFO - Running setup.py (path:/tmp/pip-pYRSwP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:06:55 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)) 04:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:06:55 INFO - Running setup.py (path:/tmp/pip-EP3MrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:06:55 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)) 04:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:06:55 INFO - Running setup.py (path:/tmp/pip-mhYWqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:06:55 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)) 04:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:06:55 INFO - Running setup.py (path:/tmp/pip-SRfNGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:06:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 04:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:06:55 INFO - Running setup.py (path:/tmp/pip-gaIqai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:06:55 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)) 04:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:06:55 INFO - Running setup.py (path:/tmp/pip-kNOZeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:06:55 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)) 04:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:06:55 INFO - Running setup.py (path:/tmp/pip-T7CL4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:06:55 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)) 04:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:06:55 INFO - Running setup.py (path:/tmp/pip-vwRyxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:06:55 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)) 04:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:55 INFO - Running setup.py (path:/tmp/pip-C_4cTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:55 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)) 04:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:06:55 INFO - Running setup.py (path:/tmp/pip-cHu4w9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:06:55 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)) 04:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:06:55 INFO - Running setup.py (path:/tmp/pip-K7CVVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:06:55 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)) 04:06:55 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)) 04:06:55 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)) 04:06:55 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)) 04:06:55 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)) 04:06:55 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)) 04:06:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:06:56 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 04:06:56 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 04:06:56 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 04:06:56 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 04:06:56 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 04:06:56 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 04:06:57 INFO - Downloading blessings-1.6.tar.gz 04:06:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:06:57 INFO - Installing collected packages: blessings 04:06:57 INFO - Running setup.py install for blessings 04:06:58 INFO - Successfully installed blessings 04:06:58 INFO - Cleaning up... 04:06:58 INFO - Return code: 0 04:06:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:06:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:06:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:06:58 INFO - Reading from file tmpfile_stdout 04:06:58 INFO - Current package versions: 04:06:58 INFO - argparse == 1.2.1 04:06:58 INFO - blessings == 1.6 04:06:58 INFO - blobuploader == 1.2.4 04:06:58 INFO - docopt == 0.6.1 04:06:58 INFO - manifestparser == 1.1 04:06:58 INFO - mozInstall == 1.12 04:06:58 INFO - mozcrash == 0.17 04:06:58 INFO - mozdebug == 0.1 04:06:58 INFO - mozdevice == 0.48 04:06:58 INFO - mozfile == 1.2 04:06:58 INFO - mozhttpd == 0.7 04:06:58 INFO - mozinfo == 0.9 04:06:58 INFO - mozleak == 0.1 04:06:58 INFO - mozlog == 3.1 04:06:58 INFO - moznetwork == 0.27 04:06:58 INFO - mozprocess == 0.22 04:06:58 INFO - mozprofile == 0.28 04:06:58 INFO - mozrunner == 6.11 04:06:58 INFO - mozscreenshot == 0.1 04:06:58 INFO - mozsystemmonitor == 0.0 04:06:58 INFO - moztest == 0.7 04:06:58 INFO - mozversion == 1.4 04:06:58 INFO - psutil == 3.1.1 04:06:58 INFO - requests == 1.2.3 04:06:58 INFO - wsgiref == 0.1.2 04:06:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06: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')]} 04:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06: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')]} 04:06:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:58 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 0x7fdf9b386f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ba410>, '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 0x15bb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15bb7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1461150314.313537-970667941', '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 04:06:58 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 04:06:58 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 04:06:58 INFO - Using env: {'DISPLAY': ':0', 04:06:58 INFO - 'HOME': '/home/cltbld', 04:06:58 INFO - 'LANG': 'en_US.UTF-8', 04:06:58 INFO - 'LANGUAGE': 'en_US:en', 04:06:58 INFO - 'LOGNAME': 'cltbld', 04:06:58 INFO - 'MAIL': '/var/mail/cltbld', 04:06:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:58 INFO - 'MOZ_NO_REMOTE': '1', 04:06:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:58 INFO - 'NO_EM_RESTART': '1', 04:06:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:58 INFO - 'PWD': '/builds/slave/test', 04:06:58 INFO - 'SHELL': '/bin/bash', 04:06:58 INFO - 'SHLVL': '1', 04:06:58 INFO - 'TERM': 'linux', 04:06:58 INFO - 'TMOUT': '86400', 04:06:58 INFO - 'USER': 'cltbld', 04:06:58 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461150314.313537-970667941', 04:06:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:58 INFO - '_': '/tools/buildbot/bin/python'} 04:06:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:58 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)) 04:06:58 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)) 04:06:58 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)) 04:06:58 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)) 04:06:58 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)) 04:06:58 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)) 04:06:58 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)) 04:06:58 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)) 04:06:58 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)) 04:06:58 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)) 04:06:58 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)) 04:06:58 INFO - Cleaning up... 04:06:58 INFO - Return code: 0 04:06:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:06: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')]} 04:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06: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')]} 04:06:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:58 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 0x7fdf9b386f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ba410>, '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 0x15bb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15bb7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1461150314.313537-970667941', '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 04:06:58 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 04:06:58 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 04:06:58 INFO - Using env: {'DISPLAY': ':0', 04:06:58 INFO - 'HOME': '/home/cltbld', 04:06:58 INFO - 'LANG': 'en_US.UTF-8', 04:06:58 INFO - 'LANGUAGE': 'en_US:en', 04:06:58 INFO - 'LOGNAME': 'cltbld', 04:06:58 INFO - 'MAIL': '/var/mail/cltbld', 04:06:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:58 INFO - 'MOZ_NO_REMOTE': '1', 04:06:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:58 INFO - 'NO_EM_RESTART': '1', 04:06:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:58 INFO - 'PWD': '/builds/slave/test', 04:06:58 INFO - 'SHELL': '/bin/bash', 04:06:58 INFO - 'SHLVL': '1', 04:06:58 INFO - 'TERM': 'linux', 04:06:58 INFO - 'TMOUT': '86400', 04:06:58 INFO - 'USER': 'cltbld', 04:06:58 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461150314.313537-970667941', 04:06:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:58 INFO - '_': '/tools/buildbot/bin/python'} 04:06:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:58 INFO - Downloading/unpacking jsonschema 04:06:58 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 04:06:58 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 04:06:58 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 04:06:58 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 04:06:58 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 04:06:58 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 04:07:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:07:00 INFO - Downloading/unpacking functools32 (from jsonschema) 04:07:00 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 04:07:00 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 04:07:00 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 04:07:00 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 04:07:00 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 04:07:00 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 04:07:00 INFO - Downloading functools32-3.2.3-2.tar.gz 04:07:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:07:00 INFO - warning: no files found matching '*.txt' 04:07:00 INFO - no previously-included directories found matching 'build' 04:07:00 INFO - no previously-included directories found matching 'dist' 04:07:00 INFO - no previously-included directories found matching '.git*' 04:07:00 INFO - Installing collected packages: jsonschema, functools32 04:07:00 INFO - Running setup.py install for functools32 04:07:00 INFO - warning: no files found matching '*.txt' 04:07:00 INFO - no previously-included directories found matching 'build' 04:07:00 INFO - no previously-included directories found matching 'dist' 04:07:00 INFO - no previously-included directories found matching '.git*' 04:07:01 INFO - Successfully installed jsonschema functools32 04:07:01 INFO - Cleaning up... 04:07:01 INFO - Return code: 0 04:07:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:07:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:01 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 0x7fdf9b386f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ba410>, '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 0x15bb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15bb7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1461150314.313537-970667941', '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 04:07:01 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 04:07:01 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 04:07:01 INFO - Using env: {'DISPLAY': ':0', 04:07:01 INFO - 'HOME': '/home/cltbld', 04:07:01 INFO - 'LANG': 'en_US.UTF-8', 04:07:01 INFO - 'LANGUAGE': 'en_US:en', 04:07:01 INFO - 'LOGNAME': 'cltbld', 04:07:01 INFO - 'MAIL': '/var/mail/cltbld', 04:07:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:01 INFO - 'MOZ_NO_REMOTE': '1', 04:07:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:01 INFO - 'NO_EM_RESTART': '1', 04:07:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:01 INFO - 'PWD': '/builds/slave/test', 04:07:01 INFO - 'SHELL': '/bin/bash', 04:07:01 INFO - 'SHLVL': '1', 04:07:01 INFO - 'TERM': 'linux', 04:07:01 INFO - 'TMOUT': '86400', 04:07:01 INFO - 'USER': 'cltbld', 04:07:01 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461150314.313537-970667941', 04:07:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:01 INFO - '_': '/tools/buildbot/bin/python'} 04:07:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:01 INFO - Downloading/unpacking flake8 04:07:01 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 04:07:01 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 04:07:01 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 04:07:01 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 04:07:01 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 04:07:01 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 04:07:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:07:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:07:03 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 04:07:03 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 04:07:03 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 04:07:03 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 04:07:03 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 04:07:03 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 04:07:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:07:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:07:03 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 04:07:03 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 04:07:03 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 04:07:03 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 04:07:03 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 04:07:03 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 04:07:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:07:03 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 04:07:03 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 04:07:03 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 04:07:03 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 04:07:03 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 04:07:03 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 04:07:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:07:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:07:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:07:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:07:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:07:03 INFO - no previously-included directories found matching 'docs/_build' 04:07:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:07:03 INFO - Running setup.py install for pep8 04:07:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:07:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:07:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:07:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:07:04 INFO - no previously-included directories found matching 'docs/_build' 04:07:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:07:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:07:04 INFO - Cleaning up... 04:07:04 INFO - Return code: 0 04:07:04 INFO - Running post-action listener: _resource_record_post_action 04:07:04 INFO - Running post-action listener: _start_resource_monitoring 04:07:04 INFO - Starting resource monitoring. 04:07:04 INFO - ##### 04:07:04 INFO - ##### Running install step. 04:07:04 INFO - ##### 04:07:04 INFO - Running pre-action listener: _resource_record_pre_action 04:07:04 INFO - Running main action method: install 04:07:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:07:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:07:04 INFO - Reading from file tmpfile_stdout 04:07:04 INFO - Detecting whether we're running mozinstall >=1.0... 04:07:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:07:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:07:04 INFO - Reading from file tmpfile_stdout 04:07:04 INFO - Output received: 04:07:04 INFO - Usage: mozinstall [options] installer 04:07:04 INFO - Options: 04:07:04 INFO - -h, --help show this help message and exit 04:07:04 INFO - -d DEST, --destination=DEST 04:07:04 INFO - Directory to install application into. [default: 04:07:04 INFO - "/builds/slave/test"] 04:07:04 INFO - --app=APP Application being installed. [default: firefox] 04:07:04 INFO - mkdir: /builds/slave/test/build/application 04:07:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:07:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:07:20 INFO - Reading from file tmpfile_stdout 04:07:20 INFO - Output received: 04:07:20 INFO - /builds/slave/test/build/application/firefox/firefox 04:07:20 INFO - Running post-action listener: _resource_record_post_action 04:07:20 INFO - ##### 04:07:20 INFO - ##### Running run-tests step. 04:07:20 INFO - ##### 04:07:20 INFO - Running pre-action listener: _resource_record_pre_action 04:07:20 INFO - Running main action method: run_tests 04:07:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:07:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:07:20 INFO - Python 2.7.3 04:07:20 INFO - Return code: 0 04:07:20 INFO - grabbing minidump binary from tooltool 04:07: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')]} 04:07:20 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ba410>, '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 0x15bb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15bb7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:07:20 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 04:07:20 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 04:07:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:07:20 INFO - Return code: 0 04:07:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:07:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:07:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:07:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:07:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:07:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:07:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:07:21 INFO - Return code: 0 04:07:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a3Ar_86GS9iRtlmb0x-CDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 04:07:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a3Ar_86GS9iRtlmb0x-CDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 04:07:21 INFO - Using env: {'DISPLAY': ':0', 04:07:21 INFO - 'HOME': '/home/cltbld', 04:07:21 INFO - 'LANG': 'en_US.UTF-8', 04:07:21 INFO - 'LANGUAGE': 'en_US:en', 04:07:21 INFO - 'LOGNAME': 'cltbld', 04:07:21 INFO - 'MAIL': '/var/mail/cltbld', 04:07:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:07:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:07:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:21 INFO - 'MOZ_NO_REMOTE': '1', 04:07:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:07:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:21 INFO - 'NO_EM_RESTART': '1', 04:07:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:21 INFO - 'PWD': '/builds/slave/test', 04:07:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:07:21 INFO - 'SHELL': '/bin/bash', 04:07:21 INFO - 'SHLVL': '1', 04:07:21 INFO - 'TERM': 'linux', 04:07:21 INFO - 'TMOUT': '86400', 04:07:21 INFO - 'USER': 'cltbld', 04:07:21 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461150314.313537-970667941', 04:07:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:21 INFO - '_': '/tools/buildbot/bin/python'} 04:07:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a3Ar_86GS9iRtlmb0x-CDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 04:07:21 INFO - mozversion application_buildid: 20160420024742 04:07:21 INFO - mozversion application_changeset: 973dfa15822126c39ea2d98d34ac16643b040243 04:07:21 INFO - mozversion application_display_name: Nightly 04:07:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:07:21 INFO - mozversion application_name: Firefox 04:07:21 INFO - mozversion application_remotingname: firefox 04:07:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:07:21 INFO - mozversion application_vendor: Mozilla 04:07:21 INFO - mozversion application_version: 48.0a1 04:07:21 INFO - mozversion platform_buildid: 20160420024742 04:07:21 INFO - mozversion platform_changeset: 973dfa15822126c39ea2d98d34ac16643b040243 04:07:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:07:21 INFO - mozversion platform_version: 48.0a1 04:07:21 INFO - using testdate: 1461150441 04:07:21 INFO - actual date: 1461150441 04:07:21 INFO - starting webserver on 'localhost:58718' 04:07:21 INFO - SUITE-START | Running 2 tests 04:07:21 INFO - TEST-START | dromaeo_css 04:07:21 INFO - operating with platform_type : linux_ 04:07:21 INFO - Initialising browser for dromaeo_css test... 04:07:21 INFO - TEST-INFO | started process 9193 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdjhnzq/profile http://localhost:58718/getInfo.html) 04:07:25 INFO - PROCESS | 9193 | 04:07:25 INFO - PROCESS | 9193 | (process:9261): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:07:26 INFO - PROCESS | 9193 | __metrics Screen width/height:1600/1200 04:07:26 INFO - PROCESS | 9193 | colorDepth:24 04:07:26 INFO - PROCESS | 9193 | Browser inner width/height: 1024/697 04:07:26 INFO - PROCESS | 9193 | __metrics 04:07:26 ERROR - PROCESS | 9193 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 04:07:27 INFO - TEST-INFO | 9193: exit 0 04:07:27 INFO - Browser initialized. 04:07:27 INFO - Running cycle 1/1 for dromaeo_css test... 04:07:27 INFO - TEST-INFO | started process 9312 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdjhnzq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:07:29 INFO - PROCESS | 9312 | 04:07:29 INFO - PROCESS | 9312 | (process:9372): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:07:39 INFO - PROCESS | 9312 | RSS: Main: 165142528 04:07:39 INFO - PROCESS | 9312 | 04:08:29 INFO - PROCESS | 9312 | 1461150509312 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] 04:10:40 INFO - PROCESS | 9312 | Cycle 1(1): loaded http://localhost:58718/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58718/tests/dromaeo/cssquery-ext.html) 04:10:41 INFO - PROCESS | 9312 | RSS: Main: 168804352 04:10:41 INFO - PROCESS | 9312 | 04:13:43 INFO - PROCESS | 9312 | Cycle 1(1): loaded http://localhost:58718/tests/dromaeo/cssquery-ext.html (next: http://localhost:58718/tests/dromaeo/cssquery-jquery.html) 04:13:44 INFO - PROCESS | 9312 | RSS: Main: 166137856 04:13:44 INFO - PROCESS | 9312 | 04:16:45 INFO - PROCESS | 9312 | Cycle 1(1): loaded http://localhost:58718/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58718/tests/dromaeo/cssquery-mootools.html) 04:16:46 INFO - PROCESS | 9312 | RSS: Main: 166293504 04:16:46 INFO - PROCESS | 9312 | 04:19:48 INFO - PROCESS | 9312 | Cycle 1(1): loaded http://localhost:58718/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58718/tests/dromaeo/cssquery-prototype.html) 04:19:49 INFO - PROCESS | 9312 | RSS: Main: 164540416 04:19:49 INFO - PROCESS | 9312 | 04:22:51 INFO - PROCESS | 9312 | Cycle 1(1): loaded http://localhost:58718/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58718/tests/dromaeo/cssquery-yui.html) 04:22:52 INFO - PROCESS | 9312 | RSS: Main: 165736448 04:22:52 INFO - PROCESS | 9312 | 04:25:54 INFO - PROCESS | 9312 | Cycle 1(1): loaded http://localhost:58718/tests/dromaeo/cssquery-yui.html (next: http://localhost:58718/tests/dromaeo/cssquery-dojo.html) 04:25:55 INFO - PROCESS | 9312 | RSS: Main: 167825408 04:25:55 INFO - PROCESS | 9312 | 04:25:55 INFO - PROCESS | 9312 | __start_tp_report 04:25:55 INFO - PROCESS | 9312 | _x_x_mozilla_page_load 04:25:55 INFO - PROCESS | 9312 | _x_x_mozilla_page_load_details 04:25:55 INFO - PROCESS | 9312 | |i|pagename|runs| 04:25:55 INFO - PROCESS | 9312 | |0;dojo.html;2616.515944550258;2665.933351666207;2668.586369112787;2681.74523420275;2697.406570554478;4597.954020459799;4628.53714628537;4667.906641867165;4682.648801339896;4726.291056341551;4537.682362234645;4632.583067523922;4708.552687494691;4717.315989181567;4766.022965292115;4332.090261045184;4367.2575662137515;4423.51341352451;4423.734575925439;4470.128324976631;225.4977257344458;4332.328489084197;4360.760158191299;4424.026714122888;4454.420925279709;4220.97889510552;4264.0832221072615;4273.9999999999845;4323.546027667081;4377.737335759864;4348.673849461272;4350.847720329773;4375.124975005012;4393.538678438782;4399;4271.615554600101;4342.652587793001;4360;4365.43249377582;4370.12597480502;4575.039241759235;4575.15359658461;4596.241620132674;4619.237825758746;4639.930401043987;5019.698818070928;5041;5048;5061.215511595708;5082.974585127051;4886.755662216875;5072.188449848007;5133.30700355451;5170.353705786777;5175.378954525443;4685.835995740167;4729.196036673774;4732.574068333866;4735.266033764772;4759.904801903977;5003.2995380646735;5164.561012313995;5172.353455818023;5184.300119483897;5232.659877108052;4936.308916751657;4954.925676114861;4978.975105124451;5017.272495488134;5029.899402011939;5022.397312322471;5043.344365232496;5048.848534543969;5060.671056381323;5088.542031217208;4916.06594746997;4985.576226020757;4995.250712393097;5026.981676289346;5036.244563315532;5001.674891132065;5019.84940451787;5022.171341728647;5049.242613607915;5096.184610462308;4291.742495450283;4298.527162012176;4302.9569704303185;4306.676999225071;4339.9783001085425;3691.7415780895617;3701.03773019017;3711.0907827582414;3741.569719482294;3744.2511497700025;4255.8084886180195;4349.456317960255;4390.714603550823;4416.889577760518;4441.977790111029;4936.308916751657;5010.1983682611335;5024.42219144803;5030.8239211627415;5069.898602027939;4245.1085272093205;4309.461317335333;4364.8254069837485;4394.12117576486;4413.271810151353;4537.77311134442;4547.090581883636;4548.431446069241;4598.839040633562;4603.079384123189;4745.217039188564;4756.301850670117;4769.6661233714;4780.976095119502;4829.903401932012;4883.902321953612;5021.322121513695;5080.8221712241375;5152.458991805806;5163.225516172604;4734.881627959328;4756.976215119041;4771.809127634994;4790.473047964791;4816.975915120402;4931.2849636803185;4947.653664243612;4954.727489987941;4958.479359667183;5006.324146240211;4864.124457597666;4973.328600639012;5023.824166154167;5052.267421223975;5067.163917953497;4889.266610008527;4941.802327906988;4956.504349565014;4961.50384961501;4965.851024469272;4781.330613714153;4922.92615610759;4957.107720610325;4963.875903102451;4987.476314986874;4740.194166991689;4789.233722604506;4814.374131362901;4836.056968891033;4844.297576851407;4840.903181936271;4861.076395484846;4869.245266983623;4875.756212189447;4942.654014218971;4658.277966915133;4759.309900064541;4766.6901651392545;4785.353977213171;4847.3698419206685 04:25:55 INFO - PROCESS | 9312 | |1;ext.html;583.2010146099844;590.0117303516608;608.9343648614924;626.4487251218927;641.6695401868042;33555.83222083889;34309.82845085777;34645;34789.13027174319;34840.82579587099;34931.30137397251;35454.46818297721;35479.4678079829;35584.82207588965;35754.46368304478;7528.849423011537;7692.3461505772075;7693.192214817447;7698.730544430946;7721.459497835126;7748.651310691032;7795.649195786204;7841.882371764428;7847.96076019622;7867.8033049173655;7884.448088633798;7937.960310198469;7969.96015019927;8000.039995200584;8013.47912385696;7851.803704907395;7875.684972601089;7883.172266912006;7889.566073865935;7936;7771.184025677336;7872.173421790687;7879.96060019702;7883.054033516015;7889.329407000412;29840.10479685591;35289.47065794015;35855.64144358575;35870.64129358725;35933.82033089844;2959.082684367853;3029.560713696502;3065.601471808651;3109.9222519436967;3114.2681469854565;25867.22398328053;26176.214713558624;26538.20385388422;26689.866550667317;26690.46619067627;3190.6171259448784;3200.0879749271344;3215.131914383127;3243.805371677683;3255.8046517209045;167414;167903;168961;169058;169954.1502292493;33412.66587334096;53009.67475813058;53192.46807531953;53395;53435.46564534383;32307.51538726921;32423.189420264684;32484.350312993607;32484.837575812442;32535.349293014006;12291.877081229073;12470.875291246972;12494.687632809253;12499.625011249676;12529.43617537213;9962.900370996342;10055;10062.24533160016;10098.848517272247;10107.938666440064;8152.266296033267;8162.632681529345;8192.795180120425;8226.917730822735;8298.8340233195;3220.388126256051;3244.7566432517183;3269.525918741769;3298.835058247078;3312.817795021249;910.8132832769267;911.9361644684808;922.1930810540777;957.7844984878346;1034.9948250258851;27924;28398.85800571025;28597;28824.85587572049;28869.85565072203;1005.1305620638095;1018.5874720738113;1032.7934413117257;1032.8192566300868;1114.1198453221864;14755.483558075415;15263.160526170945;15339.463118790789;15415.383384664488;15574.766378504331;350817;355105;355897;356397;357770;50179.24731129036;51121.233181502306;51183.952641894655;51213.231801523005;51224.48775512272;1187.928724276546;1218.9704142602645;1254.8556915954416;1256.6481385212155;1261.2999785119348;25953.74046259513;28216;28291.71708282973;28459.715402846534;28786.28034299159;44392.778036109616;44618;44904;45159.54840451685;45286.77356613196;302093;305852;308081;308241;308385;25749.485010299315;26230.34424139412;26235.21294361172;39262.41106383464;40465.39301910415;40797.18405631811;41130.177396451305;41257.58742412538;41773;41829.58170418257;34909.82545087258;34958;35205.47191792074;35453;35709.46435803413;34528.309433811686;34564.48153277753;35068.473972889915;35673;36016;31451.685483144876;34733;35789.82105089458;37406;38345.4248186283;28850.567241491815;29538;29713.702862971095;29936.25159371033;31825.8408707955;25067.373315667253;25524.361890952132;25632.487350253265;25634.487310254062;25821.3544661385 04:25:55 INFO - PROCESS | 9312 | |2;jquery.html;382.5352197080547;384.3715525116435;388.23711407085057;399.7082130045067;405.4587126186541;12679.936600317009;15018.24908754562;15338.923305383458;16038.679226415465;16137.19314034298;15206.771898421532;15539.922300388482;15818.683626327467;16221.270042848071;16237.594060148502;4932.284818701286;5009.949900500985;5116.488351164891;5122.385313762354;5151.948480515203;5182.844514664566;5183.792648294064;5193.714345710984;5221.765020574083;5226.372835259755;4959.578435832958;5109.335786347789;5169.3279873616375;5171.612129090315;5176.844694659167;5111.795528178868;5138.229265610151;5143.228515722634;5149.485051494858;5166.638335316529;4535.750533720644;4549;4583.175028494869;4596.218642830727;4602.010567727954;19535.706964395544;19926.60146797056;20399.08204130818;20401.591968160552;20450.488737781525;1999.730036445076;2091.226246288883;2110.693949377347;2123.352377524854;2538.8857501412294;13019.86980130196;13220.471181152743;13346.799798003038;13371;13711.177329360171;1762.0837164674297;1774.8136445673276;1779.4928445393;1796.308421257825;1806.385828818195;67359;67460;68011;68139.65930170366;68744;9280.95359523198;9324.393914395543;9542.42745435276;9684.143177762577;9742.853857192147;11515.654530364103;12355.93822030902;13141.277229752455;13201.933990329986;13355.26546039977;6710.16122984627;6885.586864788129;6955.130608673916;6996.580205187705;7209.71161153548;6674.866502669919;6756;6814.284500127515;6830.077939478107;6863.6568171591225;5757.827265182052;5895.469407753237;5968.522518198533;6066.393360663987;6081.695915204222;1737.7219644856762;1795.1562765500194;1848.3068849181557;1866.4214093630746;1867.9719804202948;886.6852267445094;927.420362273579;973.3478569358405;978.6427953796955;1002.1331548210745;16708.74936875948;16771.53848447789;17017.659646806995;17260.913695431693;17480.300787968594;892.3084609427616;921.0973246218743;935.8322079760061;945.2626950978248;948.9193418559499;9679.419234845791;9699.51502424876;9770.36492627977;9858.654947076819;9972.900270997197;407945;412235;413440;415886;418948;68863.65568172127;70828.29171708217;71418.64290678513;71930.64034679793;72130.63934680398;792.5759718550548;799.4324029938808;804.3846457460048;809.4819315637997;810.7000409848393;14984.625384365478;15038.047834390389;15055.096694198382;15056.397744090114;15277.312520936362;30559.694403056576;30570.388592228475;31942.52086218755;32025.359492809548;32153;40748.1850362997;41267;41353.793231033655;41578;41636.79181604073;7357.632118394166;7614.466987310835;7617.200193979774;7676.692932282646;7845.5684937329;11628.18602697803;11679.824802627798;11682.532698691957;11823.704407389883;11949.940250298692;9784.559694813894;10219;10346.793064138825;10526.368417894952;10642.255042146975;10223.642172523925;10405.58377664885;10528.36829790215;10547.947260263649;10745.94627026891;9908.554115064695;9910.058544438267;10388.324758890649;10603.522841472306;10770.569177233136;7619.390448764197;7632.961835190788;7751.689932402641;7824;7834.725784597512;9637.71086867395;9686.518813854971;9716.708498745049;9779.168770654289;9893.208543316661 04:25:55 INFO - PROCESS | 9312 | |3;mootools.html;1452.1432354910603;1496.648287652402;1624.8050233971926;1755.4031629246053;1790.8746387752853;6565.343465653432;7630.542167469949;7694.192109828471;7904.130545639975;7925.881111783321;7761.417893657984;7769.417293702967;7830.608469576527;7861.371090312776;7865.882011769828;2194.122351059577;2261;2262.366537369539;2263.298377502971;2264.2188444986455;2219.1012639880873;2247.224707475918;2256.537409830989;2259.2883241778786;2262.8416010879246;2213.7786221377896;2232.2521955144966;2235.273536100766;2257.2325409360815;2287.4738810073695;2187.814035806958;2215.700880381144;2219.1678120704737;2220.0897631970975;2220.3449982255274;2104.842136839728;2106.6418708819538;2111.0816794694206;2119.035838693391;2119.3747844385944;7973.920260797376;7996.24035716606;8066.072401673824;8068.233517815798;8068.91069705594;4660.5106463821485;4828.879278018043;4839.709617422931;4853.854384368475;4866.926996095061;2791.567307067408;2940.294329360959;2984.7910646254772;2992.610960575133;3030.9545356819667;860.8020155364301;875.3916028360228;892.2772554231094;893.3791015244408;894.7047474333455;10713.517891694892;10757.30077544957;10773.407462589554;10840.295380800222;10865.185111116698;4118.382242663624;4391.978040109779;4392.407025051641;4455.153520831096;4478.081993191388;9273.489958052238;9305.53472326381;9308;9372.906270937203;9385.62457501706;4836.854894353175;4841.031793641286;4872.317875497433;4887.853364399074;4888.9755551222015;4361.716488428242;4376.431063961664;4424.11517696462;4436.955630443719;4472.865814025585;3776.263628592453;3789.6589306962505;3826.598207188205;3854.0557563397147;3930.76415415076;1234.1977714485656;1243.8196461513212;1245.439552201513;1248.3071895098126;1266.9303188324545;745.2956955676942;870.0516437083609;877.7410663854179;899.1574120939644;921.0467166482658;5439.564834813205;5439.646422982493;5552.472515111058;5613.158026296088;5699.316082070095;403.91517781265674;418.33902434153964;421.1808033375056;423.9766812825324;427.6642835374216;3904.2777086239134;3989.501312335958;3991.3015222335976;3993.740406873544;4071.246819338432;9320.580573874191;9613.663521776843;9731.270154738422;9835.360701554377;9836.754081148028;9505.192058674951;9689.41863488193;9754.0733630305;9806.754831129136;9821.656242031495;7223.386012189023;7318.890216646754;7416.332530072319;7432;7490.550566966;5384.407715151252;5405.270288511001;5425.782968681367;5445.264889239902;5446.1558458439;8928.375013748975;8947.150020748019;9021.90978090237;9091.545422728705;9093.136152065543;7820.217978202134;8521.872171917303;8670.046294907681;9029.503377314048;9085.818283634422;6819.215790183994;6956.652167391509;6995.195552511323;6999.47503937217;7001.474889383215;7288.08898887639;7326.633668316456;7336.7065317386705;7350.52221605594;7370.963145184454;6828.760993365208;6909.447244220551;6920.169579650475;6943.305669433218;7097.82255443618;6848.7260509579055;6911.619860907698;7064.858702826017;7109.537880037781;7112.324329188718;6584.209894812653;6646.83382915431;6648.867022659423;6650.3682150195655;6659.467242620482;4668.253079507263;4808.326834243138;4830.951690483191;4841.515848415131;4940.975295123501;4860.902781944271;4941.6293777966075;4961.206207006861;5008.524190201925;5013.724245166551 04:25:55 INFO - PROCESS | 9312 | |4;prototype.html;319.1972189942295;321.3524747633519;327.2228457413642;329.0835024456888;331.76444724245783;5210.983858147662;5238.7642556084975;5281.49825766552;5305.893882122365;5310.73446327684;5216.9478305216935;5228.0850851101095;5229.869253268661;5231.921521177185;5234.502722241381;3869.7484663496853;4012.7391719538136;4119.361498967664;4121.155163191538;4128.649064829493;4108.383742438628;4110.1163249901265;4120.587941205886;4132.876013719593;4136.565660605638;4057.3305404608204;4092.85675001375;4105.199486100211;4105.938410923838;4120.207709646298;4038.394240863879;4055.1281474483126;4112.712110152291;4120.114175452292;4123.154753275571;3579.7494175407733;3622.456631505269;3624.673779359844;3625.456181572759;3627.9818600907092;5041.470645582198;5042.798288068473;5070.949290507085;5077.441481437039;5106.208537676666;4630.976845115787;4709.058188362307;4717.669763116583;4742.857714268577;4744;5420.620556561043;5447.291852059247;5448.618596698233;5485.945140548583;5495.752691128909;3933.272344616255;3941.1329507508303;3943.5859234780223;3952.0910190656023;3966.980165099185;5605.187247849039;5732.31212254528;5815.127730840365;5815.680137592431;5822.1266809978415;4010.8970033241094;4011.1777085697363;4015.5181378234215;4037.37420699792;4052.392141178847;4106.117184805281;4112.444819949328;4119.299719047769;4134.64855487281;4134.875953721393;4651.5813576778255;4659.813607455664;4661.324108004321;4685.72742220023;4689.50760170184;5323.680579165262;5498.395176530578;5520.006398848165;5521.116621340566;5527.585431092684;1400.2438683111209;1426.8216472940883;1433.992830035864;1437.2238990944982;1437.4322142753763;893.4773157702816;962.2198931975789;965.6427121964917;986.1716158426956;994.2592768387598;4752.643551733634;4754.619630429557;4767.547083027107;4785.353977213102;4788.640851936118;5621.831345059655;5635.830925072254;5638.9699708105045;5642.351129620146;5651.321841379061;4652.395188625457;4766.451858036301;4772.689775164603;4774.904501910012;4796.56830885222;2990.566367876689;2996.340805022935;3002.1143762590086;3016.2308611304416;3032.4086803073187;5307.734613269321;5313.628046036818;5318.44156363584;5318.813841515528;5321.36143662763;5618.887622247532;5732.713364331767;5774.740136693859;5791.218185544982;5817.782107971771;5298.88723368097;5303.363596368384;5325.147976323769;5333.946660533423;5336.519713225828;5517.144842549411;5580.21876937221;5599.244102046172;5626.521745651666;5638.830835074954;5481.972590137024;5486.341639003185;5509.614326997072;5515.503604675599;5524.33707955048;5309.681419114865;5334.413214546319;5337.146056631076;5351.117065684274;5360.812371566976;3749.812509374575;4021.879343619696;4034.8386064558263;4034.9394759079223;4051.9189616206922;5654.802081927113;5692.829215123387;5708.315002199763;5714.971425142848;5723;5515;5519.751611177587;5520.392756796668;5539.529140023144;5542.168674698827;5362.892742145214;5519.586031047607;5538.390777014606;5542.251796007487;5547.750351234285;5197.870053248699;5426.70153141581;5443.945560544502;5459.153831156177;5463.4263402342185;5443.292371991616;5571.860703482445;5595;5607.243022191952;5607.831765047055;5423;5427.4301198373605;5433.673979561239;5452.645578037414;5457.781688732406 04:25:55 INFO - PROCESS | 9312 | |5;yui.html;639.4500729372742;651.1892693596473;688.590288778177;710.3819676881112;747.9139898911627;10921.508532116053;10969;11025.669229923094;11088;11275.548978040879;11450.427478626078;11996.100292478055;12044.337561434118;12082.21465604735;12090.03279737621;645.5287640022786;798.2775588092785;816.5917041479275;827.9875801862977;830.3772170871846;817.9386546009043;820.5158956215831;821.1172989036779;821.6836517940606;823.6252505110191;854.3080105114877;855.8459477294084;857.5026484638926;865.8051938313861;867.1501928110456;849.9575021248913;855.7176131876497;857.9656813727474;860.0238729042551;860.1441565642164;633.3033662970741;634.0837489827202;634.6414275934083;634.6509419819081;636.6275728698671;12405.813912791315;12430.813537796941;12484.250944943242;12497.062720295924;12505.56230531927;11872.940635296769;11905;11929.642110736691;11951.103667224992;12262.080343974148;8996.190342869173;9039.638414463414;9040.457572545669;9063;9278.164965153168;2815.155453363983;2853.0157095801915;2857.957130643042;2876.295307649639;2880.985595072032;45734;47529.287060694114;47607;47663.28505072427;47764.04471910577;9707.077827606367;9859.30984831055;9883.555240014217;10065.396076235449;10182.694519164437;17109.23008464622;17122.229499672543;17198.226079826436;17311.913440432716;17344;5493.395726470085;5549.139883318092;5584.832455026356;5602.607817452821;5818.4763371296785;3198.1045307313525;3264.2329052673076;3370.9662903371145;3420.0765793236183;3438.9828050859587;2699.4331190449834;2800.523910935146;2802.4815409149373;2805.509035918706;2810.6486689163853;482.36087184480004;501.9824306149267;506.1774616248596;512.9717865517432;514.3005512502993;521.6583138044587;528.5692160888864;542.9253452836438;549.4148731600833;572.2046355565767;6698.866022679519;7574.394048476109;7747.418943579254;7826.804329891685;7860.292573668397;577.4110407384528;578.887117012187;581.302755215799;592.7658574862905;597.6951754605183;3586;3603.3513967486106;3620.330238905811;3677.79772112531;3699.3711069118312;50891.293967849815;51091.233631495554;51203.487965120614;51301;52348.214776778375;45423.54576454193;45457.090858183314;45665.77167114143;45752.54247457549;45886;41670.58329416728;41756.164876702904;42283.7885810569;42494.15011699687;43067.78466107712;7698.730544430918;7877.251661092187;8194.590270486333;8278.213569710868;8420.326373890197;26777.33056673599;26969;27217.31956701098;28997.710022900344;29908.551371729005;33850.32299354048;33942.490862637576;35079.47380789341;35659.108522286115;35851.64148358483;11379.54481820718;11470.483828227583;11484.540618375171;11499.425028748696;11644.941775291409;11761;11946.342951137423;11946.761064778482;11973.880261197277;12072.154949153826;11072.501737421675;11086.833697494383;11116.833247501132;11248;11737.295762254293;10194.526282375617;10282.588696452058;10310.226732995205;10475.633352832614;10905.727356816144;10413.687589372332;10520.894791051991;10802.08182304513;11027.062699670618;11074.944625276821;9825.9017409825;10022;10069.69790906274;10300.278980471296;10383.844242336521;8591.140885911358;8788.956055219684;8820.955895220482;8872.73381798547;9056.773580660536 04:25:55 INFO - PROCESS | 9312 | __end_tp_report 04:25:55 INFO - PROCESS | 9312 | __start_cc_report 04:25:55 INFO - PROCESS | 9312 | _x_x_mozilla_cycle_collect,353 04:25:55 INFO - PROCESS | 9312 | __end_cc_report 04:25:55 INFO - PROCESS | 9312 | __startTimestamp1461151555166__endTimestamp 04:25:55 INFO - PROCESS | 9312 | 04:25:55 INFO - PROCESS | 9312 | ------- Summary: start ------- 04:25:55 INFO - PROCESS | 9312 | Number of tests: 6 04:25:55 INFO - PROCESS | 9312 | 04:25:55 INFO - PROCESS | 9312 | [#0] dojo.html Cycles:165 Average:4632.03 Median:4766.69 stddev:590.87 (12.4%) stddev-sans-first:571.14 04:25:55 INFO - PROCESS | 9312 | Values: 2616.5 2665.9 2668.6 2681.7 2697.4 4598.0 4628.5 4667.9 4682.6 4726.3 4537.7 4632.6 4708.6 4717.3 4766.0 4332.1 4367.3 4423.5 4423.7 4470.1 225.5 4332.3 4360.8 4424.0 4454.4 4221.0 4264.1 4274.0 4323.5 4377.7 4348.7 4350.8 4375.1 4393.5 4399.0 4271.6 4342.7 4360.0 4365.4 4370.1 4575.0 4575.2 4596.2 4619.2 4639.9 5019.7 5041.0 5048.0 5061.2 5083.0 4886.8 5072.2 5133.3 5170.4 5175.4 4685.8 4729.2 4732.6 4735.3 4759.9 5003.3 5164.6 5172.4 5184.3 5232.7 4936.3 4954.9 4979.0 5017.3 5029.9 5022.4 5043.3 5048.8 5060.7 5088.5 4916.1 4985.6 4995.3 5027.0 5036.2 5001.7 5019.8 5022.2 5049.2 5096.2 4291.7 4298.5 4303.0 4306.7 4340.0 3691.7 3701.0 3711.1 3741.6 3744.3 4255.8 4349.5 4390.7 4416.9 4442.0 4936.3 5010.2 5024.4 5030.8 5069.9 4245.1 4309.5 4364.8 4394.1 4413.3 4537.8 4547.1 4548.4 4598.8 4603.1 4745.2 4756.3 4769.7 4781.0 4829.9 4883.9 5021.3 5080.8 5152.5 5163.2 4734.9 4757.0 4771.8 4790.5 4817.0 4931.3 4947.7 4954.7 4958.5 5006.3 4864.1 4973.3 5023.8 5052.3 5067.2 4889.3 4941.8 4956.5 4961.5 4965.9 4781.3 4922.9 4957.1 4963.9 4987.5 4740.2 4789.2 4814.4 4836.1 4844.3 4840.9 4861.1 4869.2 4875.8 4942.7 4658.3 4759.3 4766.7 4785.4 4847.4 04:25:55 INFO - PROCESS | 9312 | 04:25:55 INFO - PROCESS | 9312 | [#1] ext.html Cycles:180 Average:42451.27 Median:34689.00 stddev:75994.89 (219.1%) stddev-sans-first:76143.06 04:25:55 INFO - PROCESS | 9312 | Values: 583.2 590.0 608.9 626.4 641.7 33555.8 34309.8 34645.0 34789.1 34840.8 34931.3 35454.5 35479.5 35584.8 35754.5 7528.8 7692.3 7693.2 7698.7 7721.5 7748.7 7795.6 7841.9 7848.0 7867.8 7884.4 7938.0 7970.0 8000.0 8013.5 7851.8 7875.7 7883.2 7889.6 7936.0 7771.2 7872.2 7880.0 7883.1 7889.3 29840.1 35289.5 35855.6 35870.6 35933.8 2959.1 3029.6 3065.6 3109.9 3114.3 25867.2 26176.2 26538.2 26689.9 26690.5 3190.6 3200.1 3215.1 3243.8 3255.8 167414.0 167903.0 168961.0 169058.0 169954.2 33412.7 53009.7 53192.5 53395.0 53435.5 32307.5 32423.2 32484.4 32484.8 32535.3 12291.9 12470.9 12494.7 12499.6 12529.4 9962.9 10055.0 10062.2 10098.8 10107.9 8152.3 8162.6 8192.8 8226.9 8298.8 3220.4 3244.8 3269.5 3298.8 3312.8 910.8 911.9 922.2 957.8 1035.0 27924.0 28398.9 28597.0 28824.9 28869.9 1005.1 1018.6 1032.8 1032.8 1114.1 14755.5 15263.2 15339.5 15415.4 15574.8 350817.0 355105.0 355897.0 356397.0 357770.0 50179.2 51121.2 51184.0 51213.2 51224.5 1187.9 1219.0 1254.9 1256.6 1261.3 25953.7 28216.0 28291.7 28459.7 28786.3 44392.8 44618.0 44904.0 45159.5 45286.8 302093.0 305852.0 308081.0 308241.0 308385.0 25749.5 26230.3 26235.2 39262.4 40465.4 40797.2 41130.2 41257.6 41773.0 41829.6 34909.8 34958.0 35205.5 35453.0 35709.5 34528.3 34564.5 35068.5 35673.0 36016.0 31451.7 34733.0 35789.8 37406.0 38345.4 28850.6 29538.0 29713.7 29936.3 31825.8 25067.4 25524.4 25632.5 25634.5 25821.4 04:25:55 INFO - PROCESS | 9312 | 04:25:55 INFO - PROCESS | 9312 | [#2] jquery.html Cycles:180 Average:24320.17 Median:4589.70 stddev:67908.39 (1479.6%) stddev-sans-first:68075.11 04:25:55 INFO - PROCESS | 9312 | Values: 382.5 384.4 388.2 399.7 405.5 12679.9 15018.2 15338.9 16038.7 16137.2 15206.8 15539.9 15818.7 16221.3 16237.6 4932.3 5009.9 5116.5 5122.4 5151.9 5182.8 5183.8 5193.7 5221.8 5226.4 4959.6 5109.3 5169.3 5171.6 5176.8 5111.8 5138.2 5143.2 5149.5 5166.6 4535.8 4549.0 4583.2 4596.2 4602.0 19535.7 19926.6 20399.1 20401.6 20450.5 1999.7 2091.2 2110.7 2123.4 2538.9 13019.9 13220.5 13346.8 13371.0 13711.2 1762.1 1774.8 1779.5 1796.3 1806.4 67359.0 67460.0 68011.0 68139.7 68744.0 9281.0 9324.4 9542.4 9684.1 9742.9 11515.7 12355.9 13141.3 13201.9 13355.3 6710.2 6885.6 6955.1 6996.6 7209.7 6674.9 6756.0 6814.3 6830.1 6863.7 5757.8 5895.5 5968.5 6066.4 6081.7 1737.7 1795.2 1848.3 1866.4 1868.0 886.7 927.4 973.3 978.6 1002.1 16708.7 16771.5 17017.7 17260.9 17480.3 892.3 921.1 935.8 945.3 948.9 9679.4 9699.5 9770.4 9858.7 9972.9 407945.0 412235.0 413440.0 415886.0 418948.0 68863.7 70828.3 71418.6 71930.6 72130.6 792.6 799.4 804.4 809.5 810.7 14984.6 15038.0 15055.1 15056.4 15277.3 30559.7 30570.4 31942.5 32025.4 32153.0 40748.2 41267.0 41353.8 41578.0 41636.8 7357.6 7614.5 7617.2 7676.7 7845.6 11628.2 11679.8 11682.5 11823.7 11949.9 9784.6 10219.0 10346.8 10526.4 10642.3 10223.6 10405.6 10528.4 10547.9 10745.9 9908.6 9910.1 10388.3 10603.5 10770.6 7619.4 7633.0 7751.7 7824.0 7834.7 9637.7 9686.5 9716.7 9779.2 9893.2 04:25:55 INFO - PROCESS | 9312 | 04:25:55 INFO - PROCESS | 9312 | [#3] mootools.html Cycles:180 Average:5246.49 Median:5394.84 stddev:2896.23 (53.7%) stddev-sans-first:2890.32 04:25:55 INFO - PROCESS | 9312 | Values: 1452.1 1496.6 1624.8 1755.4 1790.9 6565.3 7630.5 7694.2 7904.1 7925.9 7761.4 7769.4 7830.6 7861.4 7865.9 2194.1 2261.0 2262.4 2263.3 2264.2 2219.1 2247.2 2256.5 2259.3 2262.8 2213.8 2232.3 2235.3 2257.2 2287.5 2187.8 2215.7 2219.2 2220.1 2220.3 2104.8 2106.6 2111.1 2119.0 2119.4 7973.9 7996.2 8066.1 8068.2 8068.9 4660.5 4828.9 4839.7 4853.9 4866.9 2791.6 2940.3 2984.8 2992.6 3031.0 860.8 875.4 892.3 893.4 894.7 10713.5 10757.3 10773.4 10840.3 10865.2 4118.4 4392.0 4392.4 4455.2 4478.1 9273.5 9305.5 9308.0 9372.9 9385.6 4836.9 4841.0 4872.3 4887.9 4889.0 4361.7 4376.4 4424.1 4437.0 4472.9 3776.3 3789.7 3826.6 3854.1 3930.8 1234.2 1243.8 1245.4 1248.3 1266.9 745.3 870.1 877.7 899.2 921.0 5439.6 5439.6 5552.5 5613.2 5699.3 403.9 418.3 421.2 424.0 427.7 3904.3 3989.5 3991.3 3993.7 4071.2 9320.6 9613.7 9731.3 9835.4 9836.8 9505.2 9689.4 9754.1 9806.8 9821.7 7223.4 7318.9 7416.3 7432.0 7490.6 5384.4 5405.3 5425.8 5445.3 5446.2 8928.4 8947.2 9021.9 9091.5 9093.1 7820.2 8521.9 8670.0 9029.5 9085.8 6819.2 6956.7 6995.2 6999.5 7001.5 7288.1 7326.6 7336.7 7350.5 7371.0 6828.8 6909.4 6920.2 6943.3 7097.8 6848.7 6911.6 7064.9 7109.5 7112.3 6584.2 6646.8 6648.9 6650.4 6659.5 4668.3 4808.3 4831.0 4841.5 4941.0 4860.9 4941.6 4961.2 5008.5 5013.7 04:25:55 INFO - PROCESS | 9312 | 04:25:55 INFO - PROCESS | 9312 | [#4] prototype.html Cycles:180 Average:4569.90 Median:5233.21 stddev:1320.79 (25.2%) stddev-sans-first:1285.38 04:25:55 INFO - PROCESS | 9312 | Values: 319.2 321.4 327.2 329.1 331.8 5211.0 5238.8 5281.5 5305.9 5310.7 5216.9 5228.1 5229.9 5231.9 5234.5 3869.7 4012.7 4119.4 4121.2 4128.6 4108.4 4110.1 4120.6 4132.9 4136.6 4057.3 4092.9 4105.2 4105.9 4120.2 4038.4 4055.1 4112.7 4120.1 4123.2 3579.7 3622.5 3624.7 3625.5 3628.0 5041.5 5042.8 5070.9 5077.4 5106.2 4631.0 4709.1 4717.7 4742.9 4744.0 5420.6 5447.3 5448.6 5485.9 5495.8 3933.3 3941.1 3943.6 3952.1 3967.0 5605.2 5732.3 5815.1 5815.7 5822.1 4010.9 4011.2 4015.5 4037.4 4052.4 4106.1 4112.4 4119.3 4134.6 4134.9 4651.6 4659.8 4661.3 4685.7 4689.5 5323.7 5498.4 5520.0 5521.1 5527.6 1400.2 1426.8 1434.0 1437.2 1437.4 893.5 962.2 965.6 986.2 994.3 4752.6 4754.6 4767.5 4785.4 4788.6 5621.8 5635.8 5639.0 5642.4 5651.3 4652.4 4766.5 4772.7 4774.9 4796.6 2990.6 2996.3 3002.1 3016.2 3032.4 5307.7 5313.6 5318.4 5318.8 5321.4 5618.9 5732.7 5774.7 5791.2 5817.8 5298.9 5303.4 5325.1 5333.9 5336.5 5517.1 5580.2 5599.2 5626.5 5638.8 5482.0 5486.3 5509.6 5515.5 5524.3 5309.7 5334.4 5337.1 5351.1 5360.8 3749.8 4021.9 4034.8 4034.9 4051.9 5654.8 5692.8 5708.3 5715.0 5723.0 5515.0 5519.8 5520.4 5539.5 5542.2 5362.9 5519.6 5538.4 5542.3 5547.8 5197.9 5426.7 5443.9 5459.2 5463.4 5443.3 5571.9 5595.0 5607.2 5607.8 5423.0 5427.4 5433.7 5452.6 5457.8 04:25:55 INFO - PROCESS | 9312 | 04:25:55 INFO - PROCESS | 9312 | [#5] yui.html Cycles:180 Average:12444.99 Median:44245.67 stddev:14195.49 (32.1%) stddev-sans-first:14207.63 04:25:55 INFO - PROCESS | 9312 | Values: 639.5 651.2 688.6 710.4 747.9 10921.5 10969.0 11025.7 11088.0 11275.5 11450.4 11996.1 12044.3 12082.2 12090.0 645.5 798.3 816.6 828.0 830.4 817.9 820.5 821.1 821.7 823.6 854.3 855.8 857.5 865.8 867.2 850.0 855.7 858.0 860.0 860.1 633.3 634.1 634.6 634.7 636.6 12405.8 12430.8 12484.3 12497.1 12505.6 11872.9 11905.0 11929.6 11951.1 12262.1 8996.2 9039.6 9040.5 9063.0 9278.2 2815.2 2853.0 2858.0 2876.3 2881.0 45734.0 47529.3 47607.0 47663.3 47764.0 9707.1 9859.3 9883.6 10065.4 10182.7 17109.2 17122.2 17198.2 17311.9 17344.0 5493.4 5549.1 5584.8 5602.6 5818.5 3198.1 3264.2 3371.0 3420.1 3439.0 2699.4 2800.5 2802.5 2805.5 2810.6 482.4 502.0 506.2 513.0 514.3 521.7 528.6 542.9 549.4 572.2 6698.9 7574.4 7747.4 7826.8 7860.3 577.4 578.9 581.3 592.8 597.7 3586.0 3603.4 3620.3 3677.8 3699.4 50891.3 51091.2 51203.5 51301.0 52348.2 45423.5 45457.1 45665.8 45752.5 45886.0 41670.6 41756.2 42283.8 42494.2 43067.8 7698.7 7877.3 8194.6 8278.2 8420.3 26777.3 26969.0 27217.3 28997.7 29908.6 33850.3 33942.5 35079.5 35659.1 35851.6 11379.5 11470.5 11484.5 11499.4 11644.9 11761.0 11946.3 11946.8 11973.9 12072.2 11072.5 11086.8 11116.8 11248.0 11737.3 10194.5 10282.6 10310.2 10475.6 10905.7 10413.7 10520.9 10802.1 11027.1 11074.9 9825.9 10022.0 10069.7 10300.3 10383.8 8591.1 8789.0 8821.0 8872.7 9056.8 04:25:55 INFO - PROCESS | 9312 | -------- Summary: end -------- 04:25:55 INFO - PROCESS | 9312 | 04:25:55 INFO - TEST-INFO | 9312: exit 0 04:25:55 INFO - TEST-OK | dromaeo_css | took 1114512ms 04:25:55 INFO - TEST-START | kraken 04:25:55 INFO - operating with platform_type : linux_ 04:25:55 INFO - Initialising browser for kraken test... 04:25:55 INFO - TEST-INFO | started process 9548 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd61JCh/profile http://localhost:58718/getInfo.html) 04:25:59 INFO - PROCESS | 9548 | 04:25:59 INFO - PROCESS | 9548 | (process:9618): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:26:00 INFO - PROCESS | 9548 | __metrics Screen width/height:1600/1200 04:26:00 INFO - PROCESS | 9548 | colorDepth:24 04:26:00 INFO - PROCESS | 9548 | Browser inner width/height: 1024/697 04:26:00 INFO - PROCESS | 9548 | __metrics 04:26:00 ERROR - PROCESS | 9548 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 04:26:01 INFO - TEST-INFO | 9548: exit 0 04:26:01 INFO - Browser initialized. 04:26:01 INFO - Running cycle 1/1 for kraken test... 04:26:01 INFO - TEST-INFO | started process 9669 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd61JCh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:26:03 INFO - PROCESS | 9669 | 04:26:03 INFO - PROCESS | 9669 | (process:9731): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:26:13 INFO - PROCESS | 9669 | RSS: Main: 164511744 04:26:13 INFO - PROCESS | 9669 | 04:26:16 INFO - PROCESS | 9669 | Cycle 1(1): loaded http://localhost:58718/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58718/tests/kraken/driver.html?testName=audio-beat-detection) 04:26:17 INFO - PROCESS | 9669 | RSS: Main: 168718336 04:26:17 INFO - PROCESS | 9669 | 04:26:20 INFO - PROCESS | 9669 | Cycle 1(1): loaded http://localhost:58718/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58718/tests/kraken/driver.html?testName=audio-dft) 04:26:20 INFO - PROCESS | 9669 | RSS: Main: 172171264 04:26:20 INFO - PROCESS | 9669 | 04:26:23 INFO - PROCESS | 9669 | Cycle 1(1): loaded http://localhost:58718/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58718/tests/kraken/driver.html?testName=audio-fft) 04:26:24 INFO - PROCESS | 9669 | RSS: Main: 163295232 04:26:24 INFO - PROCESS | 9669 | 04:26:26 INFO - PROCESS | 9669 | Cycle 1(1): loaded http://localhost:58718/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58718/tests/kraken/driver.html?testName=audio-oscillator) 04:26:27 INFO - PROCESS | 9669 | RSS: Main: 163397632 04:26:27 INFO - PROCESS | 9669 | 04:26:29 INFO - PROCESS | 9669 | Cycle 1(1): loaded http://localhost:58718/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58718/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:26:30 INFO - PROCESS | 9669 | RSS: Main: 163975168 04:26:30 INFO - PROCESS | 9669 | 04:26:33 INFO - PROCESS | 9669 | Cycle 1(1): loaded http://localhost:58718/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58718/tests/kraken/driver.html?testName=imaging-darkroom) 04:26:33 INFO - PROCESS | 9669 | RSS: Main: 164585472 04:26:33 INFO - PROCESS | 9669 | 04:26:37 INFO - PROCESS | 9669 | Cycle 1(1): loaded http://localhost:58718/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58718/tests/kraken/driver.html?testName=imaging-desaturate) 04:26:38 INFO - PROCESS | 9669 | RSS: Main: 162992128 04:26:38 INFO - PROCESS | 9669 | 04:26:41 INFO - PROCESS | 9669 | Cycle 1(1): loaded http://localhost:58718/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58718/tests/kraken/driver.html?testName=json-parse-financial) 04:26:41 INFO - PROCESS | 9669 | RSS: Main: 163729408 04:26:41 INFO - PROCESS | 9669 | 04:26:43 INFO - PROCESS | 9669 | Cycle 1(1): loaded http://localhost:58718/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58718/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:26:44 INFO - PROCESS | 9669 | RSS: Main: 163893248 04:26:44 INFO - PROCESS | 9669 | 04:26:45 INFO - PROCESS | 9669 | Cycle 1(1): loaded http://localhost:58718/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58718/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:26:46 INFO - PROCESS | 9669 | RSS: Main: 163885056 04:26:46 INFO - PROCESS | 9669 | 04:26:48 INFO - PROCESS | 9669 | Cycle 1(1): loaded http://localhost:58718/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58718/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:26:49 INFO - PROCESS | 9669 | RSS: Main: 164274176 04:26:49 INFO - PROCESS | 9669 | 04:26:52 INFO - PROCESS | 9669 | Cycle 1(1): loaded http://localhost:58718/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58718/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:26:52 INFO - PROCESS | 9669 | RSS: Main: 164921344 04:26:52 INFO - PROCESS | 9669 | 04:26:55 INFO - PROCESS | 9669 | Cycle 1(1): loaded http://localhost:58718/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58718/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:26:56 INFO - PROCESS | 9669 | RSS: Main: 164794368 04:26:56 INFO - PROCESS | 9669 | 04:26:58 INFO - PROCESS | 9669 | Cycle 1(1): loaded http://localhost:58718/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58718/tests/kraken/driver.html?testName=ai-astar) 04:26:58 INFO - PROCESS | 9669 | RSS: Main: 166305792 04:26:58 INFO - PROCESS | 9669 | 04:26:58 INFO - PROCESS | 9669 | __start_tp_report 04:26:58 INFO - PROCESS | 9669 | _x_x_mozilla_page_load 04:26:58 INFO - PROCESS | 9669 | _x_x_mozilla_page_load_details 04:26:58 INFO - PROCESS | 9669 | |i|pagename|runs| 04:26:58 INFO - PROCESS | 9669 | |0;ai-astar;113;109;113;115;112;125;114;112;114;114 04:26:58 INFO - PROCESS | 9669 | |1;audio-beat-detection;163;134;156;193;134;157;157;135;183;141 04:26:58 INFO - PROCESS | 9669 | |2;audio-dft;170;167;165;171;166;163;163;163;167;165 04:26:58 INFO - PROCESS | 9669 | |3;audio-fft;75;78;75;155;78;78;75;75;151;75 04:26:58 INFO - PROCESS | 9669 | |4;audio-oscillator;96;95;151;95;96;93;146;95;94;142 04:26:58 INFO - PROCESS | 9669 | |5;imaging-gaussian-blur;117;117;118;118;117;119;118;119;118;118 04:26:58 INFO - PROCESS | 9669 | |6;imaging-darkroom;149;147;150;148;148;148;147;146;149;147 04:26:58 INFO - PROCESS | 9669 | |7;imaging-desaturate;96;95;95;96;95;95;95;96;95;95 04:26:58 INFO - PROCESS | 9669 | |8;json-parse-financial;67;65;69;65;64;66;74;65;69;70 04:26:58 INFO - PROCESS | 9669 | |9;json-stringify-tinderbox;65;65;66;66;65;65;65;65;66;65 04:26:58 INFO - PROCESS | 9669 | |10;stanford-crypto-aes;81;80;82;88;80;82;80;80;123;81 04:26:58 INFO - PROCESS | 9669 | |11;stanford-crypto-ccm;137;136;137;137;136;136;138;139;150;132 04:26:58 INFO - PROCESS | 9669 | |12;stanford-crypto-pbkdf2;177;175;174;174;172;176;173;173;175;174 04:26:58 INFO - PROCESS | 9669 | |13;stanford-crypto-sha256-iterative;71;73;73;74;70;71;77;76;74;76 04:26:58 INFO - PROCESS | 9669 | __end_tp_report 04:26:58 INFO - PROCESS | 9669 | __start_cc_report 04:26:58 INFO - PROCESS | 9669 | _x_x_mozilla_cycle_collect,907 04:26:58 INFO - PROCESS | 9669 | __end_cc_report 04:26:58 INFO - PROCESS | 9669 | __startTimestamp1461151618428__endTimestamp 04:26:58 INFO - PROCESS | 9669 | 04:26:58 INFO - PROCESS | 9669 | ------- Summary: start ------- 04:26:58 INFO - PROCESS | 9669 | Number of tests: 14 04:26:58 INFO - PROCESS | 9669 | 04:26:58 INFO - PROCESS | 9669 | [#0] ai-astar Cycles:10 Average:114.10 Median:114.00 stddev:4.18 (3.7%) stddev-sans-first:4.41 04:26:58 INFO - PROCESS | 9669 | Values: 113.0 109.0 113.0 115.0 112.0 125.0 114.0 112.0 114.0 114.0 04:26:58 INFO - PROCESS | 9669 | 04:26:58 INFO - PROCESS | 9669 | [#1] audio-beat-detection Cycles:10 Average:155.30 Median:157.00 stddev:20.49 (13.1%) stddev-sans-first:21.54 04:26:58 INFO - PROCESS | 9669 | Values: 163.0 134.0 156.0 193.0 134.0 157.0 157.0 135.0 183.0 141.0 04:26:58 INFO - PROCESS | 9669 | 04:26:58 INFO - PROCESS | 9669 | [#2] audio-dft Cycles:10 Average:166.00 Median:166.50 stddev:2.83 (1.7%) stddev-sans-first:2.60 04:26:58 INFO - PROCESS | 9669 | Values: 170.0 167.0 165.0 171.0 166.0 163.0 163.0 163.0 167.0 165.0 04:26:58 INFO - PROCESS | 9669 | 04:26:58 INFO - PROCESS | 9669 | [#3] audio-fft Cycles:10 Average:91.50 Median:75.00 stddev:32.46 (43.3%) stddev-sans-first:33.87 04:26:58 INFO - PROCESS | 9669 | Values: 75.0 78.0 75.0 155.0 78.0 78.0 75.0 75.0 151.0 75.0 04:26:58 INFO - PROCESS | 9669 | 04:26:58 INFO - PROCESS | 9669 | [#4] audio-oscillator Cycles:10 Average:110.30 Median:95.00 stddev:24.97 (26.3%) stddev-sans-first:25.94 04:26:58 INFO - PROCESS | 9669 | Values: 96.0 95.0 151.0 95.0 96.0 93.0 146.0 95.0 94.0 142.0 04:26:58 INFO - PROCESS | 9669 | 04:26:58 INFO - PROCESS | 9669 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.71 04:26:58 INFO - PROCESS | 9669 | Values: 117.0 117.0 118.0 118.0 117.0 119.0 118.0 119.0 118.0 118.0 04:26:58 INFO - PROCESS | 9669 | 04:26:58 INFO - PROCESS | 9669 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:1.20 (0.8%) stddev-sans-first:1.20 04:26:58 INFO - PROCESS | 9669 | Values: 149.0 147.0 150.0 148.0 148.0 148.0 147.0 146.0 149.0 147.0 04:26:58 INFO - PROCESS | 9669 | 04:26:58 INFO - PROCESS | 9669 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 04:26:58 INFO - PROCESS | 9669 | Values: 96.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 04:26:58 INFO - PROCESS | 9669 | 04:26:58 INFO - PROCESS | 9669 | [#8] json-parse-financial Cycles:10 Average:67.40 Median:68.00 stddev:3.10 (4.6%) stddev-sans-first:3.28 04:26:58 INFO - PROCESS | 9669 | Values: 67.0 65.0 69.0 65.0 64.0 66.0 74.0 65.0 69.0 70.0 04:26:58 INFO - PROCESS | 9669 | 04:26:58 INFO - PROCESS | 9669 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 04:26:58 INFO - PROCESS | 9669 | Values: 65.0 65.0 66.0 66.0 65.0 65.0 65.0 65.0 66.0 65.0 04:26:58 INFO - PROCESS | 9669 | 04:26:58 INFO - PROCESS | 9669 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:81.00 stddev:13.33 (16.5%) stddev-sans-first:14.02 04:26:58 INFO - PROCESS | 9669 | Values: 81.0 80.0 82.0 88.0 80.0 82.0 80.0 80.0 123.0 81.0 04:26:58 INFO - PROCESS | 9669 | 04:26:58 INFO - PROCESS | 9669 | [#11] stanford-crypto-ccm Cycles:10 Average:137.80 Median:137.00 stddev:4.66 (3.4%) stddev-sans-first:4.94 04:26:58 INFO - PROCESS | 9669 | Values: 137.0 136.0 137.0 137.0 136.0 136.0 138.0 139.0 150.0 132.0 04:26:58 INFO - PROCESS | 9669 | 04:26:58 INFO - PROCESS | 9669 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.30 Median:174.50 stddev:1.49 (0.9%) stddev-sans-first:1.22 04:26:58 INFO - PROCESS | 9669 | Values: 177.0 175.0 174.0 174.0 172.0 176.0 173.0 173.0 175.0 174.0 04:26:58 INFO - PROCESS | 9669 | 04:26:58 INFO - PROCESS | 9669 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.50 Median:74.00 stddev:2.37 (3.2%) stddev-sans-first:2.33 04:26:58 INFO - PROCESS | 9669 | Values: 71.0 73.0 73.0 74.0 70.0 71.0 77.0 76.0 74.0 76.0 04:26:58 INFO - PROCESS | 9669 | -------- Summary: end -------- 04:26:58 INFO - PROCESS | 9669 | 04:26:59 INFO - TEST-INFO | 9669: exit 0 04:26:59 INFO - TEST-OK | kraken | took 63525ms 04:26:59 INFO - SUITE-END | took 1178s 04:26:59 INFO - Completed test suite (00:19:38) 04:26:59 INFO - javascript benchmark 04:26:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2616.515944550258, 2665.933351666207, 2668.586369112787, 2681.74523420275, 2697.406570554478, 4597.954020459799, 4628.53714628537, 4667.906641867165, 4682.648801339896, 4726.291056341551, 4537.682362234645, 4632.583067523922, 4708.552687494691, 4717.315989181567, 4766.022965292115, 4332.090261045184, 4367.2575662137515, 4423.51341352451, 4423.734575925439, 4470.128324976631, 225.4977257344458, 4332.328489084197, 4360.760158191299, 4424.026714122888, 4454.420925279709, 4220.97889510552, 4264.0832221072615, 4273.9999999999845, 4323.546027667081, 4377.737335759864, 4348.673849461272, 4350.847720329773, 4375.124975005012, 4393.538678438782, 4399.0, 4271.615554600101, 4342.652587793001, 4360.0, 4365.43249377582, 4370.12597480502, 4575.039241759235, 4575.15359658461, 4596.241620132674, 4619.237825758746, 4639.930401043987, 5019.698818070928, 5041.0, 5048.0, 5061.215511595708, 5082.974585127051, 4886.755662216875, 5072.188449848007, 5133.30700355451, 5170.353705786777, 5175.378954525443, 4685.835995740167, 4729.196036673774, 4732.574068333866, 4735.266033764772, 4759.904801903977, 5003.2995380646735, 5164.561012313995, 5172.353455818023, 5184.300119483897, 5232.659877108052, 4936.308916751657, 4954.925676114861, 4978.975105124451, 5017.272495488134, 5029.899402011939, 5022.397312322471, 5043.344365232496, 5048.848534543969, 5060.671056381323, 5088.542031217208, 4916.06594746997, 4985.576226020757, 4995.250712393097, 5026.981676289346, 5036.244563315532, 5001.674891132065, 5019.84940451787, 5022.171341728647, 5049.242613607915, 5096.184610462308, 4291.742495450283, 4298.527162012176, 4302.9569704303185, 4306.676999225071, 4339.9783001085425, 3691.7415780895617, 3701.03773019017, 3711.0907827582414, 3741.569719482294, 3744.2511497700025, 4255.8084886180195, 4349.456317960255, 4390.714603550823, 4416.889577760518, 4441.977790111029, 4936.308916751657, 5010.1983682611335, 5024.42219144803, 5030.8239211627415, 5069.898602027939, 4245.1085272093205, 4309.461317335333, 4364.8254069837485, 4394.12117576486, 4413.271810151353, 4537.77311134442, 4547.090581883636, 4548.431446069241, 4598.839040633562, 4603.079384123189, 4745.217039188564, 4756.301850670117, 4769.6661233714, 4780.976095119502, 4829.903401932012, 4883.902321953612, 5021.322121513695, 5080.8221712241375, 5152.458991805806, 5163.225516172604, 4734.881627959328, 4756.976215119041, 4771.809127634994, 4790.473047964791, 4816.975915120402, 4931.2849636803185, 4947.653664243612, 4954.727489987941, 4958.479359667183, 5006.324146240211, 4864.124457597666, 4973.328600639012, 5023.824166154167, 5052.267421223975, 5067.163917953497, 4889.266610008527, 4941.802327906988, 4956.504349565014, 4961.50384961501, 4965.851024469272, 4781.330613714153, 4922.92615610759, 4957.107720610325, 4963.875903102451, 4987.476314986874, 4740.194166991689, 4789.233722604506, 4814.374131362901, 4836.056968891033, 4844.297576851407, 4840.903181936271, 4861.076395484846, 4869.245266983623, 4875.756212189447, 4942.654014218971, 4658.277966915133, 4759.309900064541, 4766.6901651392545, 4785.353977213171, 4847.3698419206685], "value": 4597.907615566394, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.2010146099844, 590.0117303516608, 608.9343648614924, 626.4487251218927, 641.6695401868042, 33555.83222083889, 34309.82845085777, 34645.0, 34789.13027174319, 34840.82579587099, 34931.30137397251, 35454.46818297721, 35479.4678079829, 35584.82207588965, 35754.46368304478, 7528.849423011537, 7692.3461505772075, 7693.192214817447, 7698.730544430946, 7721.459497835126, 7748.651310691032, 7795.649195786204, 7841.882371764428, 7847.96076019622, 7867.8033049173655, 7884.448088633798, 7937.960310198469, 7969.96015019927, 8000.039995200584, 8013.47912385696, 7851.803704907395, 7875.684972601089, 7883.172266912006, 7889.566073865935, 7936.0, 7771.184025677336, 7872.173421790687, 7879.96060019702, 7883.054033516015, 7889.329407000412, 29840.10479685591, 35289.47065794015, 35855.64144358575, 35870.64129358725, 35933.82033089844, 2959.082684367853, 3029.560713696502, 3065.601471808651, 3109.9222519436967, 3114.2681469854565, 25867.22398328053, 26176.214713558624, 26538.20385388422, 26689.866550667317, 26690.46619067627, 3190.6171259448784, 3200.0879749271344, 3215.131914383127, 3243.805371677683, 3255.8046517209045, 167414.0, 167903.0, 168961.0, 169058.0, 169954.1502292493, 33412.66587334096, 53009.67475813058, 53192.46807531953, 53395.0, 53435.46564534383, 32307.51538726921, 32423.189420264684, 32484.350312993607, 32484.837575812442, 32535.349293014006, 12291.877081229073, 12470.875291246972, 12494.687632809253, 12499.625011249676, 12529.43617537213, 9962.900370996342, 10055.0, 10062.24533160016, 10098.848517272247, 10107.938666440064, 8152.266296033267, 8162.632681529345, 8192.795180120425, 8226.917730822735, 8298.8340233195, 3220.388126256051, 3244.7566432517183, 3269.525918741769, 3298.835058247078, 3312.817795021249, 910.8132832769267, 911.9361644684808, 922.1930810540777, 957.7844984878346, 1034.9948250258851, 27924.0, 28398.85800571025, 28597.0, 28824.85587572049, 28869.85565072203, 1005.1305620638095, 1018.5874720738113, 1032.7934413117257, 1032.8192566300868, 1114.1198453221864, 14755.483558075415, 15263.160526170945, 15339.463118790789, 15415.383384664488, 15574.766378504331, 350817.0, 355105.0, 355897.0, 356397.0, 357770.0, 50179.24731129036, 51121.233181502306, 51183.952641894655, 51213.231801523005, 51224.48775512272, 1187.928724276546, 1218.9704142602645, 1254.8556915954416, 1256.6481385212155, 1261.2999785119348, 25953.74046259513, 28216.0, 28291.71708282973, 28459.715402846534, 28786.28034299159, 44392.778036109616, 44618.0, 44904.0, 45159.54840451685, 45286.77356613196, 302093.0, 305852.0, 308081.0, 308241.0, 308385.0, 25749.485010299315, 26230.34424139412, 26235.21294361172, 39262.41106383464, 40465.39301910415, 40797.18405631811, 41130.177396451305, 41257.58742412538, 41773.0, 41829.58170418257, 34909.82545087258, 34958.0, 35205.47191792074, 35453.0, 35709.46435803413, 34528.309433811686, 34564.48153277753, 35068.473972889915, 35673.0, 36016.0, 31451.685483144876, 34733.0, 35789.82105089458, 37406.0, 38345.4248186283, 28850.567241491815, 29538.0, 29713.702862971095, 29936.25159371033, 31825.8408707955, 25067.373315667253, 25524.361890952132, 25632.487350253265, 25634.487310254062, 25821.3544661385], "value": 16122.061578330193, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.5352197080547, 384.3715525116435, 388.23711407085057, 399.7082130045067, 405.4587126186541, 12679.936600317009, 15018.24908754562, 15338.923305383458, 16038.679226415465, 16137.19314034298, 15206.771898421532, 15539.922300388482, 15818.683626327467, 16221.270042848071, 16237.594060148502, 4932.284818701286, 5009.949900500985, 5116.488351164891, 5122.385313762354, 5151.948480515203, 5182.844514664566, 5183.792648294064, 5193.714345710984, 5221.765020574083, 5226.372835259755, 4959.578435832958, 5109.335786347789, 5169.3279873616375, 5171.612129090315, 5176.844694659167, 5111.795528178868, 5138.229265610151, 5143.228515722634, 5149.485051494858, 5166.638335316529, 4535.750533720644, 4549.0, 4583.175028494869, 4596.218642830727, 4602.010567727954, 19535.706964395544, 19926.60146797056, 20399.08204130818, 20401.591968160552, 20450.488737781525, 1999.730036445076, 2091.226246288883, 2110.693949377347, 2123.352377524854, 2538.8857501412294, 13019.86980130196, 13220.471181152743, 13346.799798003038, 13371.0, 13711.177329360171, 1762.0837164674297, 1774.8136445673276, 1779.4928445393, 1796.308421257825, 1806.385828818195, 67359.0, 67460.0, 68011.0, 68139.65930170366, 68744.0, 9280.95359523198, 9324.393914395543, 9542.42745435276, 9684.143177762577, 9742.853857192147, 11515.654530364103, 12355.93822030902, 13141.277229752455, 13201.933990329986, 13355.26546039977, 6710.16122984627, 6885.586864788129, 6955.130608673916, 6996.580205187705, 7209.71161153548, 6674.866502669919, 6756.0, 6814.284500127515, 6830.077939478107, 6863.6568171591225, 5757.827265182052, 5895.469407753237, 5968.522518198533, 6066.393360663987, 6081.695915204222, 1737.7219644856762, 1795.1562765500194, 1848.3068849181557, 1866.4214093630746, 1867.9719804202948, 886.6852267445094, 927.420362273579, 973.3478569358405, 978.6427953796955, 1002.1331548210745, 16708.74936875948, 16771.53848447789, 17017.659646806995, 17260.913695431693, 17480.300787968594, 892.3084609427616, 921.0973246218743, 935.8322079760061, 945.2626950978248, 948.9193418559499, 9679.419234845791, 9699.51502424876, 9770.36492627977, 9858.654947076819, 9972.900270997197, 407945.0, 412235.0, 413440.0, 415886.0, 418948.0, 68863.65568172127, 70828.29171708217, 71418.64290678513, 71930.64034679793, 72130.63934680398, 792.5759718550548, 799.4324029938808, 804.3846457460048, 809.4819315637997, 810.7000409848393, 14984.625384365478, 15038.047834390389, 15055.096694198382, 15056.397744090114, 15277.312520936362, 30559.694403056576, 30570.388592228475, 31942.52086218755, 32025.359492809548, 32153.0, 40748.1850362997, 41267.0, 41353.793231033655, 41578.0, 41636.79181604073, 7357.632118394166, 7614.466987310835, 7617.200193979774, 7676.692932282646, 7845.5684937329, 11628.18602697803, 11679.824802627798, 11682.532698691957, 11823.704407389883, 11949.940250298692, 9784.559694813894, 10219.0, 10346.793064138825, 10526.368417894952, 10642.255042146975, 10223.642172523925, 10405.58377664885, 10528.36829790215, 10547.947260263649, 10745.94627026891, 9908.554115064695, 9910.058544438267, 10388.324758890649, 10603.522841472306, 10770.569177233136, 7619.390448764197, 7632.961835190788, 7751.689932402641, 7824.0, 7834.725784597512, 9637.71086867395, 9686.518813854971, 9716.708498745049, 9779.168770654289, 9893.208543316661], "value": 8163.104714031007, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1452.1432354910603, 1496.648287652402, 1624.8050233971926, 1755.4031629246053, 1790.8746387752853, 6565.343465653432, 7630.542167469949, 7694.192109828471, 7904.130545639975, 7925.881111783321, 7761.417893657984, 7769.417293702967, 7830.608469576527, 7861.371090312776, 7865.882011769828, 2194.122351059577, 2261.0, 2262.366537369539, 2263.298377502971, 2264.2188444986455, 2219.1012639880873, 2247.224707475918, 2256.537409830989, 2259.2883241778786, 2262.8416010879246, 2213.7786221377896, 2232.2521955144966, 2235.273536100766, 2257.2325409360815, 2287.4738810073695, 2187.814035806958, 2215.700880381144, 2219.1678120704737, 2220.0897631970975, 2220.3449982255274, 2104.842136839728, 2106.6418708819538, 2111.0816794694206, 2119.035838693391, 2119.3747844385944, 7973.920260797376, 7996.24035716606, 8066.072401673824, 8068.233517815798, 8068.91069705594, 4660.5106463821485, 4828.879278018043, 4839.709617422931, 4853.854384368475, 4866.926996095061, 2791.567307067408, 2940.294329360959, 2984.7910646254772, 2992.610960575133, 3030.9545356819667, 860.8020155364301, 875.3916028360228, 892.2772554231094, 893.3791015244408, 894.7047474333455, 10713.517891694892, 10757.30077544957, 10773.407462589554, 10840.295380800222, 10865.185111116698, 4118.382242663624, 4391.978040109779, 4392.407025051641, 4455.153520831096, 4478.081993191388, 9273.489958052238, 9305.53472326381, 9308.0, 9372.906270937203, 9385.62457501706, 4836.854894353175, 4841.031793641286, 4872.317875497433, 4887.853364399074, 4888.9755551222015, 4361.716488428242, 4376.431063961664, 4424.11517696462, 4436.955630443719, 4472.865814025585, 3776.263628592453, 3789.6589306962505, 3826.598207188205, 3854.0557563397147, 3930.76415415076, 1234.1977714485656, 1243.8196461513212, 1245.439552201513, 1248.3071895098126, 1266.9303188324545, 745.2956955676942, 870.0516437083609, 877.7410663854179, 899.1574120939644, 921.0467166482658, 5439.564834813205, 5439.646422982493, 5552.472515111058, 5613.158026296088, 5699.316082070095, 403.91517781265674, 418.33902434153964, 421.1808033375056, 423.9766812825324, 427.6642835374216, 3904.2777086239134, 3989.501312335958, 3991.3015222335976, 3993.740406873544, 4071.246819338432, 9320.580573874191, 9613.663521776843, 9731.270154738422, 9835.360701554377, 9836.754081148028, 9505.192058674951, 9689.41863488193, 9754.0733630305, 9806.754831129136, 9821.656242031495, 7223.386012189023, 7318.890216646754, 7416.332530072319, 7432.0, 7490.550566966, 5384.407715151252, 5405.270288511001, 5425.782968681367, 5445.264889239902, 5446.1558458439, 8928.375013748975, 8947.150020748019, 9021.90978090237, 9091.545422728705, 9093.136152065543, 7820.217978202134, 8521.872171917303, 8670.046294907681, 9029.503377314048, 9085.818283634422, 6819.215790183994, 6956.652167391509, 6995.195552511323, 6999.47503937217, 7001.474889383215, 7288.08898887639, 7326.633668316456, 7336.7065317386705, 7350.52221605594, 7370.963145184454, 6828.760993365208, 6909.447244220551, 6920.169579650475, 6943.305669433218, 7097.82255443618, 6848.7260509579055, 6911.619860907698, 7064.858702826017, 7109.537880037781, 7112.324329188718, 6584.209894812653, 6646.83382915431, 6648.867022659423, 6650.3682150195655, 6659.467242620482, 4668.253079507263, 4808.326834243138, 4830.951690483191, 4841.515848415131, 4940.975295123501, 4860.902781944271, 4941.6293777966075, 4961.206207006861, 5008.524190201925, 5013.724245166551], "value": 4171.163622233295, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.1972189942295, 321.3524747633519, 327.2228457413642, 329.0835024456888, 331.76444724245783, 5210.983858147662, 5238.7642556084975, 5281.49825766552, 5305.893882122365, 5310.73446327684, 5216.9478305216935, 5228.0850851101095, 5229.869253268661, 5231.921521177185, 5234.502722241381, 3869.7484663496853, 4012.7391719538136, 4119.361498967664, 4121.155163191538, 4128.649064829493, 4108.383742438628, 4110.1163249901265, 4120.587941205886, 4132.876013719593, 4136.565660605638, 4057.3305404608204, 4092.85675001375, 4105.199486100211, 4105.938410923838, 4120.207709646298, 4038.394240863879, 4055.1281474483126, 4112.712110152291, 4120.114175452292, 4123.154753275571, 3579.7494175407733, 3622.456631505269, 3624.673779359844, 3625.456181572759, 3627.9818600907092, 5041.470645582198, 5042.798288068473, 5070.949290507085, 5077.441481437039, 5106.208537676666, 4630.976845115787, 4709.058188362307, 4717.669763116583, 4742.857714268577, 4744.0, 5420.620556561043, 5447.291852059247, 5448.618596698233, 5485.945140548583, 5495.752691128909, 3933.272344616255, 3941.1329507508303, 3943.5859234780223, 3952.0910190656023, 3966.980165099185, 5605.187247849039, 5732.31212254528, 5815.127730840365, 5815.680137592431, 5822.1266809978415, 4010.8970033241094, 4011.1777085697363, 4015.5181378234215, 4037.37420699792, 4052.392141178847, 4106.117184805281, 4112.444819949328, 4119.299719047769, 4134.64855487281, 4134.875953721393, 4651.5813576778255, 4659.813607455664, 4661.324108004321, 4685.72742220023, 4689.50760170184, 5323.680579165262, 5498.395176530578, 5520.006398848165, 5521.116621340566, 5527.585431092684, 1400.2438683111209, 1426.8216472940883, 1433.992830035864, 1437.2238990944982, 1437.4322142753763, 893.4773157702816, 962.2198931975789, 965.6427121964917, 986.1716158426956, 994.2592768387598, 4752.643551733634, 4754.619630429557, 4767.547083027107, 4785.353977213102, 4788.640851936118, 5621.831345059655, 5635.830925072254, 5638.9699708105045, 5642.351129620146, 5651.321841379061, 4652.395188625457, 4766.451858036301, 4772.689775164603, 4774.904501910012, 4796.56830885222, 2990.566367876689, 2996.340805022935, 3002.1143762590086, 3016.2308611304416, 3032.4086803073187, 5307.734613269321, 5313.628046036818, 5318.44156363584, 5318.813841515528, 5321.36143662763, 5618.887622247532, 5732.713364331767, 5774.740136693859, 5791.218185544982, 5817.782107971771, 5298.88723368097, 5303.363596368384, 5325.147976323769, 5333.946660533423, 5336.519713225828, 5517.144842549411, 5580.21876937221, 5599.244102046172, 5626.521745651666, 5638.830835074954, 5481.972590137024, 5486.341639003185, 5509.614326997072, 5515.503604675599, 5524.33707955048, 5309.681419114865, 5334.413214546319, 5337.146056631076, 5351.117065684274, 5360.812371566976, 3749.812509374575, 4021.879343619696, 4034.8386064558263, 4034.9394759079223, 4051.9189616206922, 5654.802081927113, 5692.829215123387, 5708.315002199763, 5714.971425142848, 5723.0, 5515.0, 5519.751611177587, 5520.392756796668, 5539.529140023144, 5542.168674698827, 5362.892742145214, 5519.586031047607, 5538.390777014606, 5542.251796007487, 5547.750351234285, 5197.870053248699, 5426.70153141581, 5443.945560544502, 5459.153831156177, 5463.4263402342185, 5443.292371991616, 5571.860703482445, 5595.0, 5607.243022191952, 5607.831765047055, 5423.0, 5427.4301198373605, 5433.673979561239, 5452.645578037414, 5457.781688732406], "value": 4152.339086801008, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [639.4500729372742, 651.1892693596473, 688.590288778177, 710.3819676881112, 747.9139898911627, 10921.508532116053, 10969.0, 11025.669229923094, 11088.0, 11275.548978040879, 11450.427478626078, 11996.100292478055, 12044.337561434118, 12082.21465604735, 12090.03279737621, 645.5287640022786, 798.2775588092785, 816.5917041479275, 827.9875801862977, 830.3772170871846, 817.9386546009043, 820.5158956215831, 821.1172989036779, 821.6836517940606, 823.6252505110191, 854.3080105114877, 855.8459477294084, 857.5026484638926, 865.8051938313861, 867.1501928110456, 849.9575021248913, 855.7176131876497, 857.9656813727474, 860.0238729042551, 860.1441565642164, 633.3033662970741, 634.0837489827202, 634.6414275934083, 634.6509419819081, 636.6275728698671, 12405.813912791315, 12430.813537796941, 12484.250944943242, 12497.062720295924, 12505.56230531927, 11872.940635296769, 11905.0, 11929.642110736691, 11951.103667224992, 12262.080343974148, 8996.190342869173, 9039.638414463414, 9040.457572545669, 9063.0, 9278.164965153168, 2815.155453363983, 2853.0157095801915, 2857.957130643042, 2876.295307649639, 2880.985595072032, 45734.0, 47529.287060694114, 47607.0, 47663.28505072427, 47764.04471910577, 9707.077827606367, 9859.30984831055, 9883.555240014217, 10065.396076235449, 10182.694519164437, 17109.23008464622, 17122.229499672543, 17198.226079826436, 17311.913440432716, 17344.0, 5493.395726470085, 5549.139883318092, 5584.832455026356, 5602.607817452821, 5818.4763371296785, 3198.1045307313525, 3264.2329052673076, 3370.9662903371145, 3420.0765793236183, 3438.9828050859587, 2699.4331190449834, 2800.523910935146, 2802.4815409149373, 2805.509035918706, 2810.6486689163853, 482.36087184480004, 501.9824306149267, 506.1774616248596, 512.9717865517432, 514.3005512502993, 521.6583138044587, 528.5692160888864, 542.9253452836438, 549.4148731600833, 572.2046355565767, 6698.866022679519, 7574.394048476109, 7747.418943579254, 7826.804329891685, 7860.292573668397, 577.4110407384528, 578.887117012187, 581.302755215799, 592.7658574862905, 597.6951754605183, 3586.0, 3603.3513967486106, 3620.330238905811, 3677.79772112531, 3699.3711069118312, 50891.293967849815, 51091.233631495554, 51203.487965120614, 51301.0, 52348.214776778375, 45423.54576454193, 45457.090858183314, 45665.77167114143, 45752.54247457549, 45886.0, 41670.58329416728, 41756.164876702904, 42283.7885810569, 42494.15011699687, 43067.78466107712, 7698.730544430918, 7877.251661092187, 8194.590270486333, 8278.213569710868, 8420.326373890197, 26777.33056673599, 26969.0, 27217.31956701098, 28997.710022900344, 29908.551371729005, 33850.32299354048, 33942.490862637576, 35079.47380789341, 35659.108522286115, 35851.64148358483, 11379.54481820718, 11470.483828227583, 11484.540618375171, 11499.425028748696, 11644.941775291409, 11761.0, 11946.342951137423, 11946.761064778482, 11973.880261197277, 12072.154949153826, 11072.501737421675, 11086.833697494383, 11116.833247501132, 11248.0, 11737.295762254293, 10194.526282375617, 10282.588696452058, 10310.226732995205, 10475.633352832614, 10905.727356816144, 10413.687589372332, 10520.894791051991, 10802.08182304513, 11027.062699670618, 11074.944625276821, 9825.9017409825, 10022.0, 10069.69790906274, 10300.278980471296, 10383.844242336521, 8591.140885911358, 8788.956055219684, 8820.955895220482, 8872.73381798547, 9056.773580660536], "value": 5761.830277554481, "unit": "score"}], "name": "dromaeo_css", "value": 6263.708759329442, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 109.0, 113.0, 115.0, 112.0, 125.0, 114.0, 112.0, 114.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 134.0, 156.0, 193.0, 134.0, 157.0, 157.0, 135.0, 183.0, 141.0], "value": 155.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 167.0, 165.0, 171.0, 166.0, 163.0, 163.0, 163.0, 167.0, 165.0], "value": 166.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 75.0, 155.0, 78.0, 78.0, 75.0, 75.0, 151.0, 75.0], "value": 91.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 151.0, 95.0, 96.0, 93.0, 146.0, 95.0, 94.0, 142.0], "value": 110.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 117.0, 119.0, 118.0, 119.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 150.0, 148.0, 148.0, 148.0, 147.0, 146.0, 149.0, 147.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 69.0, 65.0, 64.0, 66.0, 74.0, 65.0, 69.0, 70.0], "value": 67.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 66.0, 65.0, 65.0, 65.0, 65.0, 66.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 82.0, 88.0, 80.0, 82.0, 80.0, 80.0, 123.0, 81.0], "value": 85.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 136.0, 137.0, 137.0, 136.0, 136.0, 138.0, 139.0, 150.0, 132.0], "value": 137.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 175.0, 174.0, 174.0, 172.0, 176.0, 173.0, 173.0, 175.0, 174.0], "value": 174.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 73.0, 73.0, 74.0, 70.0, 71.0, 77.0, 76.0, 74.0, 76.0], "value": 73.5, "unit": "score"}], "name": "kraken", "value": 1602.2999999999997, "alertThreshold": 2.0}]} 04:26:59 INFO - Return code: 0 04:26:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:26:59 ERROR - # TBPL SUCCESS # 04:26:59 INFO - Running post-action listener: _resource_record_post_action 04:26:59 INFO - Running post-run listener: _resource_record_post_run 04:27:00 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 518295552; Read time: 0; Write time: 478672 04:27:00 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234201088; Read time: 0; Write time: 253452 04:27:00 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 284094464; Read time: 0; Write time: 225220 04:27:00 INFO - Running post-run listener: _upload_blobber_files 04:27:00 INFO - Blob upload gear active. 04:27:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:27:00 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 04:27:00 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:27:00 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:27:01 INFO - (blobuploader) - INFO - Open directory for files ... 04:27:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:27:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:27:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:27:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:27:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:27:02 INFO - (blobuploader) - INFO - Done attempting. 04:27:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:27:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:27:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:27:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:27:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:27:02 INFO - (blobuploader) - INFO - Done attempting. 04:27:02 INFO - (blobuploader) - INFO - Iteration through files over. 04:27:02 INFO - Return code: 0 04:27:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:27:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:27:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/239f7ee95b724d130564470d149e5f6db2b408dec8177ba37b9a25f7f5ac90ce192bbc1d320861a1290c21bca284610ef053b9d721696a75ad1c28b9301f6261", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6ae3d233efb6dfd8dbc4eea7066d30ac38db7f190f54634b9703122d0ddfb4129e9a98e91f066d0813296fac3af2b8ac28e930dc8235640a9f75467793ba441b"} 04:27:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:27:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:27:02 INFO - Contents: 04:27:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/239f7ee95b724d130564470d149e5f6db2b408dec8177ba37b9a25f7f5ac90ce192bbc1d320861a1290c21bca284610ef053b9d721696a75ad1c28b9301f6261", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6ae3d233efb6dfd8dbc4eea7066d30ac38db7f190f54634b9703122d0ddfb4129e9a98e91f066d0813296fac3af2b8ac28e930dc8235640a9f75467793ba441b"} 04:27:02 INFO - Running post-run listener: copy_logs_to_upload_dir 04:27:02 INFO - Copying logs to upload dir... 04:27:02 INFO - mkdir: /builds/slave/test/build/upload/logs 04:27:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.968576 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-20 04:27:02.659162) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 04:27:02.662628) ========= 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=6dbc10da6d83fee962c624be000001a8-1461150314.313537-970667941 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-Non-PGO/sha512/239f7ee95b724d130564470d149e5f6db2b408dec8177ba37b9a25f7f5ac90ce192bbc1d320861a1290c21bca284610ef053b9d721696a75ad1c28b9301f6261", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6ae3d233efb6dfd8dbc4eea7066d30ac38db7f190f54634b9703122d0ddfb4129e9a98e91f066d0813296fac3af2b8ac28e930dc8235640a9f75467793ba441b"} build_url:https://queue.taskcluster.net/v1/task/a3Ar_86GS9iRtlmb0x-CDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011264 build_url: 'https://queue.taskcluster.net/v1/task/a3Ar_86GS9iRtlmb0x-CDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/239f7ee95b724d130564470d149e5f6db2b408dec8177ba37b9a25f7f5ac90ce192bbc1d320861a1290c21bca284610ef053b9d721696a75ad1c28b9301f6261", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6ae3d233efb6dfd8dbc4eea7066d30ac38db7f190f54634b9703122d0ddfb4129e9a98e91f066d0813296fac3af2b8ac28e930dc8235640a9f75467793ba441b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 04:27:02.687938) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 04:27:02.688345) ========= 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=6dbc10da6d83fee962c624be000001a8-1461150314.313537-970667941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 04:27:02.771461) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 04:27:02.771861) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 04:27:02.772244) ========= ========= Total master_lag: 1.84 =========