builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-020 starttime: 1460648413.31 results: success (0) buildid: 20160414072048 builduid: 4bc212b1ceae4d1aa097dd9dd0d5658a revision: 10f66b3164570b2183333262fa91a16004cbb908 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 08:40:13.314816) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 08:40:13.315651) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 08:40:13.316126) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 08:40:13.334573) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 08:40:13.335128) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=af724c981e2a0f424dbabf99000001e7-1460647731.195793-1485537721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-14 08:40:13-- 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% 221M=0s 2016-04-14 08:40:13 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.154917 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 08:40:13.504930) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 08:40:13.505335) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=af724c981e2a0f424dbabf99000001e7-1460647731.195793-1485537721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016328 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 08:40:13.554992) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 08:40:13.555401) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 10f66b3164570b2183333262fa91a16004cbb908 --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 10f66b3164570b2183333262fa91a16004cbb908 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=af724c981e2a0f424dbabf99000001e7-1460647731.195793-1485537721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-14 08:40:13,881 truncating revision to first 12 chars 2016-04-14 08:40:13,881 Setting DEBUG logging. 2016-04-14 08:40:13,882 attempt 1/10 2016-04-14 08:40:13,882 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/10f66b316457?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-14 08:40:14,159 unpacking tar archive at: mozilla-central-10f66b316457/testing/mozharness/ program finished with exit code 0 elapsedTime=0.556008 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 08:40:14.124952) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 08:40:14.125327) ========= script_repo_revision: 10f66b3164570b2183333262fa91a16004cbb908 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 08:40:14.126072) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 08:40:14.126477) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 08:40:14.135971) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-04-14 08:40:14.136403) ========= /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=af724c981e2a0f424dbabf99000001e7-1460647731.195793-1485537721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:40:14 INFO - MultiFileLogger online at 20160414 08:40:14 in /builds/slave/test 08:40:14 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 08:40:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:40:14 INFO - {'append_to_log': False, 08:40:14 INFO - 'base_work_dir': '/builds/slave/test', 08:40:14 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:40:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:40:14 INFO - 'branch': 'Firefox-Non-PGO', 08:40:14 INFO - 'buildbot_json_path': 'buildprops.json', 08:40:14 INFO - 'config_files': ('talos/linux_config.py',), 08:40:14 INFO - 'default_actions': ('clobber', 08:40:14 INFO - 'read-buildbot-config', 08:40:14 INFO - 'download-and-extract', 08:40:14 INFO - 'populate-webroot', 08:40:14 INFO - 'create-virtualenv', 08:40:14 INFO - 'install', 08:40:14 INFO - 'run-tests'), 08:40:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:40:14 INFO - 'download_minidump_stackwalk': True, 08:40:14 INFO - 'download_symbols': 'ondemand', 08:40:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:40:14 INFO - 'tooltool.py': '/tools/tooltool.py', 08:40:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:40:14 INFO - '/tools/misc-python/virtualenv.py')}, 08:40:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:40:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:40:14 INFO - 'installer_path': 'installer.exe', 08:40:14 INFO - 'log_level': 'info', 08:40:14 INFO - 'log_name': 'talos', 08:40:14 INFO - 'log_to_console': True, 08:40:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:40:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:40:14 INFO - 'opt_config_files': (), 08:40:14 INFO - 'pip_index': False, 08:40:14 INFO - 'sps_profile': False, 08:40:14 INFO - 'sps_profile_interval': 0, 08:40:14 INFO - 'suite': 'dromaeojs-e10s', 08:40:14 INFO - 'system_bits': '32', 08:40:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:40:14 INFO - 'title': 'talos-linux64-ix-020', 08:40:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:40:14 INFO - 'use_talos_json': True, 08:40:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:40:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:40:14 INFO - 'work_dir': 'build'} 08:40:14 INFO - ##### 08:40:14 INFO - ##### Running clobber step. 08:40:14 INFO - ##### 08:40:14 INFO - Running pre-action listener: _resource_record_pre_action 08:40:14 INFO - Running main action method: clobber 08:40:14 INFO - rmtree: /builds/slave/test/build 08:40:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:40:15 INFO - Running post-action listener: _resource_record_post_action 08:40:15 INFO - ##### 08:40:15 INFO - ##### Running read-buildbot-config step. 08:40:15 INFO - ##### 08:40:15 INFO - Running pre-action listener: _resource_record_pre_action 08:40:15 INFO - Running main action method: read_buildbot_config 08:40:15 INFO - Using buildbot properties: 08:40:15 INFO - { 08:40:15 INFO - "project": "", 08:40:15 INFO - "product": "firefox", 08:40:15 INFO - "script_repo_revision": "production", 08:40:15 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:40:15 INFO - "repository": "", 08:40:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:40:15 INFO - "buildid": "20160414072048", 08:40:15 INFO - "pgo_build": "False", 08:40:15 INFO - "basedir": "/builds/slave/test", 08:40:15 INFO - "buildnumber": 324, 08:40:15 INFO - "slavename": "talos-linux64-ix-020", 08:40:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:40:15 INFO - "platform": "ubuntu64_hw", 08:40:15 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:40:15 INFO - "branch": "mozilla-central", 08:40:15 INFO - "repo_path": "mozilla-central", 08:40:15 INFO - "revision": "10f66b3164570b2183333262fa91a16004cbb908", 08:40:15 INFO - "stage_platform": "linux64", 08:40:15 INFO - "builduid": "4bc212b1ceae4d1aa097dd9dd0d5658a", 08:40:15 INFO - "slavebuilddir": "test" 08:40:15 INFO - } 08:40:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/ax_7_9NxTNqgRtTSrajKlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 08:40:15 INFO - Running post-action listener: _resource_record_post_action 08:40:15 INFO - ##### 08:40:15 INFO - ##### Running download-and-extract step. 08:40:15 INFO - ##### 08:40:15 INFO - Running pre-action listener: _resource_record_pre_action 08:40:15 INFO - Running main action method: download_and_extract 08:40:15 INFO - mkdir: /builds/slave/test/build/tests 08:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:15 INFO - https://queue.taskcluster.net/v1/task/ax_7_9NxTNqgRtTSrajKlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:40:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ax_7_9NxTNqgRtTSrajKlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:40:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ax_7_9NxTNqgRtTSrajKlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:40:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ax_7_9NxTNqgRtTSrajKlw/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 08:40:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ax_7_9NxTNqgRtTSrajKlw/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 08:40:15 INFO - Downloaded 1361 bytes. 08:40:15 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:40:15 INFO - Using the following test package requirements: 08:40:15 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:40:15 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:40:15 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:40:15 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:15 INFO - u'jsshell-linux-x86_64.zip'], 08:40:15 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:40:15 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:40:15 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:40:15 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:40:15 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:40:15 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:40:15 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:15 INFO - https://queue.taskcluster.net/v1/task/ax_7_9NxTNqgRtTSrajKlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:40:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ax_7_9NxTNqgRtTSrajKlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:40:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ax_7_9NxTNqgRtTSrajKlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:40:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ax_7_9NxTNqgRtTSrajKlw/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 08:40:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ax_7_9NxTNqgRtTSrajKlw/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 08:40:16 INFO - Downloaded 22200427 bytes. 08:40:16 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'] 08:40:16 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 08:40:17 INFO - Return code: 0 08:40:17 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 08:40:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:17 INFO - https://queue.taskcluster.net/v1/task/ax_7_9NxTNqgRtTSrajKlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:40:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ax_7_9NxTNqgRtTSrajKlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:40:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ax_7_9NxTNqgRtTSrajKlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:40:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ax_7_9NxTNqgRtTSrajKlw/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 08:40:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ax_7_9NxTNqgRtTSrajKlw/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 08:40:22 INFO - Downloaded 22200427 bytes. 08:40:22 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'] 08:40:22 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 08:40:23 INFO - Return code: 0 08:40:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:23 INFO - https://queue.taskcluster.net/v1/task/ax_7_9NxTNqgRtTSrajKlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:40:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ax_7_9NxTNqgRtTSrajKlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:40:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ax_7_9NxTNqgRtTSrajKlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:40:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ax_7_9NxTNqgRtTSrajKlw/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 08:40:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ax_7_9NxTNqgRtTSrajKlw/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 08:40:24 INFO - Downloaded 10841076 bytes. 08:40:24 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'] 08:40:24 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 08:40:25 INFO - Return code: 0 08:40:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:25 INFO - https://queue.taskcluster.net/v1/task/ax_7_9NxTNqgRtTSrajKlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:40:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ax_7_9NxTNqgRtTSrajKlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:40:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ax_7_9NxTNqgRtTSrajKlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:40:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ax_7_9NxTNqgRtTSrajKlw/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 08:40:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ax_7_9NxTNqgRtTSrajKlw/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 08:40:27 INFO - Downloaded 54449872 bytes. 08:40:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ax_7_9NxTNqgRtTSrajKlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:40:27 INFO - mkdir: /builds/slave/test/properties 08:40:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:40:27 INFO - Writing to file /builds/slave/test/properties/build_url 08:40:27 INFO - Contents: 08:40:27 INFO - build_url:https://queue.taskcluster.net/v1/task/ax_7_9NxTNqgRtTSrajKlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:40:28 INFO - Running post-action listener: _resource_record_post_action 08:40:28 INFO - Running post-action listener: set_extra_try_arguments 08:40:28 INFO - ##### 08:40:28 INFO - ##### Running populate-webroot step. 08:40:28 INFO - ##### 08:40:28 INFO - Running pre-action listener: _resource_record_pre_action 08:40:28 INFO - Running main action method: populate_webroot 08:40:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:40:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:40:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:40:28 INFO - '--tppagecycles', 08:40:28 INFO - '7'], 08:40:28 INFO - 'tests': ['tsvgm']}}, 08:40:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:40:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:40:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:40:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:40:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:40:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:40:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:28 INFO - 'talos_options': ['--disable-e10s'], 08:40:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:40:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:40:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:28 INFO - 'talos_options': ['--disable-e10s'], 08:40:28 INFO - 'tests': ['damp', 'tps']}, 08:40:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:28 INFO - 'tests': ['damp', 'tps']}, 08:40:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:40:28 INFO - 'tests': ['dromaeo_dom']}, 08:40:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:40:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:40:28 INFO - 'tests': ['a11yr', 08:40:28 INFO - 'ts_paint', 08:40:28 INFO - 'tpaint', 08:40:28 INFO - 'sessionrestore', 08:40:28 INFO - 'sessionrestore_no_auto_restore', 08:40:28 INFO - 'tabpaint']}, 08:40:28 INFO - 'other-e10s': {'tests': ['a11yr', 08:40:28 INFO - 'ts_paint', 08:40:28 INFO - 'tpaint', 08:40:28 INFO - 'sessionrestore', 08:40:28 INFO - 'sessionrestore_no_auto_restore', 08:40:28 INFO - 'tabpaint']}, 08:40:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:40:28 INFO - 'ts_paint', 08:40:28 INFO - 'tpaint', 08:40:28 INFO - 'sessionrestore', 08:40:28 INFO - 'sessionrestore_no_auto_restore', 08:40:28 INFO - 'tabpaint']}, 08:40:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:40:28 INFO - 'ts_paint', 08:40:28 INFO - 'tpaint', 08:40:28 INFO - 'sessionrestore', 08:40:28 INFO - 'sessionrestore_no_auto_restore', 08:40:28 INFO - 'tabpaint']}, 08:40:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:40:28 INFO - 'tests': ['a11yr', 08:40:28 INFO - 'ts_paint', 08:40:28 INFO - 'tpaint', 08:40:28 INFO - 'sessionrestore', 08:40:28 INFO - 'sessionrestore_no_auto_restore', 08:40:28 INFO - 'tabpaint']}, 08:40:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:40:28 INFO - 'tests': ['a11yr', 08:40:28 INFO - 'ts_paint', 08:40:28 INFO - 'tpaint', 08:40:28 INFO - 'sessionrestore', 08:40:28 INFO - 'sessionrestore_no_auto_restore', 08:40:28 INFO - 'tabpaint']}, 08:40:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:40:28 INFO - 'tests': ['tsvgx', 08:40:28 INFO - 'tsvgr_opacity', 08:40:28 INFO - 'tart', 08:40:28 INFO - 'tscrollx', 08:40:28 INFO - 'cart']}, 08:40:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:40:28 INFO - 'tsvgr_opacity', 08:40:28 INFO - 'tart', 08:40:28 INFO - 'tscrollx', 08:40:28 INFO - 'cart']}, 08:40:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:28 INFO - 'talos_options': ['--disable-e10s'], 08:40:28 INFO - 'tests': ['tp5o']}, 08:40:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:28 INFO - 'tests': ['tp5o']}, 08:40:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:28 INFO - 'talos_options': ['--disable-e10s', 08:40:28 INFO - '--xperf_path', 08:40:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:40:28 INFO - 'tests': ['tp5n']}, 08:40:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:28 INFO - 'talos_options': ['--xperf_path', 08:40:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:40:28 INFO - 'tests': ['tp5n']}}, 08:40:28 INFO - 'talos.zip': {'path': '', 08:40:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:40:28 INFO - Running post-action listener: _resource_record_post_action 08:40:28 INFO - ##### 08:40:28 INFO - ##### Running create-virtualenv step. 08:40:28 INFO - ##### 08:40:28 INFO - Running pre-action listener: _resource_record_pre_action 08:40:28 INFO - Running main action method: create_virtualenv 08:40:28 INFO - Creating virtualenv /builds/slave/test/build/venv 08:40:28 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 08:40:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:40:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:40:28 INFO - Using real prefix '/usr' 08:40:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:40:29 INFO - Installing distribute.............................................................................................................................................................................................done. 08:40:31 INFO - Installing pip.................done. 08:40:31 INFO - Return code: 0 08:40:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:40:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f15d07a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d62410>, '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 0x2d63310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d637a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1460647731.195793-1485537721', '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 08:40:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:40:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:40:31 INFO - Using env: {'DISPLAY': ':0', 08:40:31 INFO - 'HOME': '/home/cltbld', 08:40:31 INFO - 'LANG': 'en_US.UTF-8', 08:40:31 INFO - 'LANGUAGE': 'en_US:en', 08:40:31 INFO - 'LOGNAME': 'cltbld', 08:40:31 INFO - 'MAIL': '/var/mail/cltbld', 08:40:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:31 INFO - 'MOZ_NO_REMOTE': '1', 08:40:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:31 INFO - 'NO_EM_RESTART': '1', 08:40:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:31 INFO - 'PWD': '/builds/slave/test', 08:40:31 INFO - 'SHELL': '/bin/bash', 08:40:31 INFO - 'SHLVL': '1', 08:40:31 INFO - 'TERM': 'linux', 08:40:31 INFO - 'TMOUT': '86400', 08:40:31 INFO - 'USER': 'cltbld', 08:40:31 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1460647731.195793-1485537721', 08:40:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:31 INFO - '_': '/tools/buildbot/bin/python'} 08:40:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:31 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 08:40:31 INFO - Cleaning up... 08:40:31 INFO - Return code: 0 08:40:31 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:40:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f15d07a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d62410>, '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 0x2d63310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d637a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1460647731.195793-1485537721', '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 08:40:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:40:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:40:31 INFO - Using env: {'DISPLAY': ':0', 08:40:31 INFO - 'HOME': '/home/cltbld', 08:40:31 INFO - 'LANG': 'en_US.UTF-8', 08:40:31 INFO - 'LANGUAGE': 'en_US:en', 08:40:31 INFO - 'LOGNAME': 'cltbld', 08:40:31 INFO - 'MAIL': '/var/mail/cltbld', 08:40:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:31 INFO - 'MOZ_NO_REMOTE': '1', 08:40:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:31 INFO - 'NO_EM_RESTART': '1', 08:40:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:31 INFO - 'PWD': '/builds/slave/test', 08:40:31 INFO - 'SHELL': '/bin/bash', 08:40:31 INFO - 'SHLVL': '1', 08:40:31 INFO - 'TERM': 'linux', 08:40:31 INFO - 'TMOUT': '86400', 08:40:31 INFO - 'USER': 'cltbld', 08:40:31 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1460647731.195793-1485537721', 08:40:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:31 INFO - '_': '/tools/buildbot/bin/python'} 08:40:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:31 INFO - Downloading/unpacking psutil>=0.7.1 08:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:40:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:40:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:40:33 INFO - Installing collected packages: psutil 08:40:33 INFO - Running setup.py install for psutil 08:40:33 INFO - building 'psutil._psutil_linux' extension 08:40:33 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 08:40:33 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 08:40:33 INFO - building 'psutil._psutil_posix' extension 08:40:33 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 08:40:34 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 08:40:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:40:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:40:34 INFO - Successfully installed psutil 08:40:34 INFO - Cleaning up... 08:40:34 INFO - Return code: 0 08:40:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:40: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')]} 08:40:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40: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')]} 08:40:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:34 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 0x7f15d07a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d62410>, '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 0x2d63310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d637a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1460647731.195793-1485537721', '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 08:40:34 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 08:40:34 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 08:40:34 INFO - Using env: {'DISPLAY': ':0', 08:40:34 INFO - 'HOME': '/home/cltbld', 08:40:34 INFO - 'LANG': 'en_US.UTF-8', 08:40:34 INFO - 'LANGUAGE': 'en_US:en', 08:40:34 INFO - 'LOGNAME': 'cltbld', 08:40:34 INFO - 'MAIL': '/var/mail/cltbld', 08:40:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:34 INFO - 'MOZ_NO_REMOTE': '1', 08:40:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:34 INFO - 'NO_EM_RESTART': '1', 08:40:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:34 INFO - 'PWD': '/builds/slave/test', 08:40:34 INFO - 'SHELL': '/bin/bash', 08:40:34 INFO - 'SHLVL': '1', 08:40:34 INFO - 'TERM': 'linux', 08:40:34 INFO - 'TMOUT': '86400', 08:40:34 INFO - 'USER': 'cltbld', 08:40:34 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1460647731.195793-1485537721', 08:40:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:34 INFO - '_': '/tools/buildbot/bin/python'} 08:40:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:34 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:40:34 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 08:40:34 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 08:40:34 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 08:40:34 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 08:40:34 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 08:40:34 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 08:40:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:40:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:40:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:40:36 INFO - Installing collected packages: mozsystemmonitor 08:40:36 INFO - Running setup.py install for mozsystemmonitor 08:40:36 INFO - Successfully installed mozsystemmonitor 08:40:36 INFO - Cleaning up... 08:40:36 INFO - Return code: 0 08:40:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:40: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')]} 08:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40: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')]} 08:40:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:36 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 0x7f15d07a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d62410>, '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 0x2d63310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d637a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1460647731.195793-1485537721', '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 08:40:36 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 08:40:36 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 08:40:36 INFO - Using env: {'DISPLAY': ':0', 08:40:36 INFO - 'HOME': '/home/cltbld', 08:40:36 INFO - 'LANG': 'en_US.UTF-8', 08:40:36 INFO - 'LANGUAGE': 'en_US:en', 08:40:36 INFO - 'LOGNAME': 'cltbld', 08:40:36 INFO - 'MAIL': '/var/mail/cltbld', 08:40:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:36 INFO - 'MOZ_NO_REMOTE': '1', 08:40:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:36 INFO - 'NO_EM_RESTART': '1', 08:40:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:36 INFO - 'PWD': '/builds/slave/test', 08:40:36 INFO - 'SHELL': '/bin/bash', 08:40:36 INFO - 'SHLVL': '1', 08:40:36 INFO - 'TERM': 'linux', 08:40:36 INFO - 'TMOUT': '86400', 08:40:36 INFO - 'USER': 'cltbld', 08:40:36 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1460647731.195793-1485537721', 08:40:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:36 INFO - '_': '/tools/buildbot/bin/python'} 08:40:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:36 INFO - Downloading/unpacking blobuploader==1.2.4 08:40:36 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 08:40:36 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 08:40:36 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 08:40:36 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 08:40:36 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 08:40:36 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 08:40:38 INFO - Downloading blobuploader-1.2.4.tar.gz 08:40:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:40:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:40:38 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 08:40:38 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 08:40:38 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 08:40:38 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 08:40:38 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 08:40:38 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 08:40:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:40:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:40:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:39 INFO - Downloading docopt-0.6.1.tar.gz 08:40:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:40:39 INFO - Installing collected packages: blobuploader, requests, docopt 08:40:39 INFO - Running setup.py install for blobuploader 08:40:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:40:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:40:39 INFO - Running setup.py install for requests 08:40:39 INFO - Running setup.py install for docopt 08:40:39 INFO - Successfully installed blobuploader requests docopt 08:40:39 INFO - Cleaning up... 08:40:39 INFO - Return code: 0 08:40:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:40:39 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')]} 08:40:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:39 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')]} 08:40:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:39 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 0x7f15d07a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d62410>, '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 0x2d63310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d637a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1460647731.195793-1485537721', '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 08:40:39 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 08:40:39 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 08:40:39 INFO - Using env: {'DISPLAY': ':0', 08:40:39 INFO - 'HOME': '/home/cltbld', 08:40:39 INFO - 'LANG': 'en_US.UTF-8', 08:40:39 INFO - 'LANGUAGE': 'en_US:en', 08:40:39 INFO - 'LOGNAME': 'cltbld', 08:40:39 INFO - 'MAIL': '/var/mail/cltbld', 08:40:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:39 INFO - 'MOZ_NO_REMOTE': '1', 08:40:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:39 INFO - 'NO_EM_RESTART': '1', 08:40:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:39 INFO - 'PWD': '/builds/slave/test', 08:40:39 INFO - 'SHELL': '/bin/bash', 08:40:39 INFO - 'SHLVL': '1', 08:40:39 INFO - 'TERM': 'linux', 08:40:39 INFO - 'TMOUT': '86400', 08:40:39 INFO - 'USER': 'cltbld', 08:40:39 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1460647731.195793-1485537721', 08:40:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:39 INFO - '_': '/tools/buildbot/bin/python'} 08:40:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:40:40 INFO - Running setup.py (path:/tmp/pip-FPNg5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:40:40 INFO - Running setup.py (path:/tmp/pip-4QGMPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:40:40 INFO - Running setup.py (path:/tmp/pip-pWDkvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:40:40 INFO - Running setup.py (path:/tmp/pip-VhSaMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:40:40 INFO - Running setup.py (path:/tmp/pip-nhxEUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:40:40 INFO - Running setup.py (path:/tmp/pip-qxRWdB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:40:40 INFO - Running setup.py (path:/tmp/pip-QXDDiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:40:40 INFO - Running setup.py (path:/tmp/pip-thdpPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:40:40 INFO - Running setup.py (path:/tmp/pip-snYLuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:40:40 INFO - Running setup.py (path:/tmp/pip-22HFxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:40:40 INFO - Running setup.py (path:/tmp/pip-E2VPAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:40:40 INFO - Running setup.py (path:/tmp/pip-FH8Q4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:40:41 INFO - Running setup.py (path:/tmp/pip-0voRlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:40:41 INFO - Running setup.py (path:/tmp/pip-Vz_zTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:41 INFO - Running setup.py (path:/tmp/pip-3rALLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:40:41 INFO - Running setup.py (path:/tmp/pip-2OdhgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:40:41 INFO - Running setup.py (path:/tmp/pip-tWZSMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:40:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:40:41 INFO - Running setup.py install for manifestparser 08:40:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:40:41 INFO - Running setup.py install for mozcrash 08:40:41 INFO - Running setup.py install for mozdebug 08:40:41 INFO - Running setup.py install for mozdevice 08:40:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:40:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:40:41 INFO - Running setup.py install for mozfile 08:40:41 INFO - Running setup.py install for mozhttpd 08:40:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:40:41 INFO - Running setup.py install for mozinfo 08:40:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:40:42 INFO - Running setup.py install for mozInstall 08:40:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:40:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:40:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:40:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:40:42 INFO - Running setup.py install for mozleak 08:40:42 INFO - Running setup.py install for mozlog 08:40:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:40:42 INFO - Running setup.py install for moznetwork 08:40:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:40:42 INFO - Running setup.py install for mozprocess 08:40:42 INFO - Running setup.py install for mozprofile 08:40:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:40:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:40:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:40:42 INFO - Running setup.py install for mozrunner 08:40:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:40:42 INFO - Running setup.py install for mozscreenshot 08:40:42 INFO - Running setup.py install for moztest 08:40:43 INFO - Running setup.py install for mozversion 08:40:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:40:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:40:43 INFO - Cleaning up... 08:40:43 INFO - Return code: 0 08:40:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:40:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:43 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 0x7f15d07a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d62410>, '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 0x2d63310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d637a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1460647731.195793-1485537721', '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 08:40:43 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 08:40:43 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 08:40:43 INFO - Using env: {'DISPLAY': ':0', 08:40:43 INFO - 'HOME': '/home/cltbld', 08:40:43 INFO - 'LANG': 'en_US.UTF-8', 08:40:43 INFO - 'LANGUAGE': 'en_US:en', 08:40:43 INFO - 'LOGNAME': 'cltbld', 08:40:43 INFO - 'MAIL': '/var/mail/cltbld', 08:40:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:43 INFO - 'MOZ_NO_REMOTE': '1', 08:40:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:43 INFO - 'NO_EM_RESTART': '1', 08:40:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:43 INFO - 'PWD': '/builds/slave/test', 08:40:43 INFO - 'SHELL': '/bin/bash', 08:40:43 INFO - 'SHLVL': '1', 08:40:43 INFO - 'TERM': 'linux', 08:40:43 INFO - 'TMOUT': '86400', 08:40:43 INFO - 'USER': 'cltbld', 08:40:43 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1460647731.195793-1485537721', 08:40:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:43 INFO - '_': '/tools/buildbot/bin/python'} 08:40:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:40:43 INFO - Running setup.py (path:/tmp/pip-BTXvIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:40:43 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)) 08:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:40:43 INFO - Running setup.py (path:/tmp/pip-Ns58Z5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:40:43 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)) 08:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:40:43 INFO - Running setup.py (path:/tmp/pip-RZ5n90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:40:43 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)) 08:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:40:43 INFO - Running setup.py (path:/tmp/pip-YK80YE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:40:43 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)) 08:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:40:43 INFO - Running setup.py (path:/tmp/pip-vjxWSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:40:43 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)) 08:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:40:43 INFO - Running setup.py (path:/tmp/pip-aOiMoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:40:43 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)) 08:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:40:43 INFO - Running setup.py (path:/tmp/pip-sCQicq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:40:43 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)) 08:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:40:43 INFO - Running setup.py (path:/tmp/pip-13_vNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:40:43 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)) 08:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:40:43 INFO - Running setup.py (path:/tmp/pip-SHmpEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:40:44 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)) 08:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:40:44 INFO - Running setup.py (path:/tmp/pip-Y1hoNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:40:44 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)) 08:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:40:44 INFO - Running setup.py (path:/tmp/pip-lbPUGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:40:44 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)) 08:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:40:44 INFO - Running setup.py (path:/tmp/pip-6y6SUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:40:44 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)) 08:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:40:44 INFO - Running setup.py (path:/tmp/pip-KPFBFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:40:44 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)) 08:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:40:44 INFO - Running setup.py (path:/tmp/pip-6V4HAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:40:44 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)) 08:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:44 INFO - Running setup.py (path:/tmp/pip-3bwmBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:44 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)) 08:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:40:44 INFO - Running setup.py (path:/tmp/pip-PU3Vgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:40:44 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)) 08:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:40:44 INFO - Running setup.py (path:/tmp/pip-33egps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:40:44 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)) 08:40:44 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)) 08:40:44 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)) 08:40:44 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)) 08:40:44 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)) 08:40:44 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)) 08:40:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:40:44 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 08:40:44 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 08:40:44 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 08:40:44 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 08:40:44 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 08:40:44 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 08:40:46 INFO - Downloading blessings-1.6.tar.gz 08:40:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:40:46 INFO - Installing collected packages: blessings 08:40:46 INFO - Running setup.py install for blessings 08:40:46 INFO - Successfully installed blessings 08:40:46 INFO - Cleaning up... 08:40:46 INFO - Return code: 0 08:40:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:40:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:40:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:40:46 INFO - Reading from file tmpfile_stdout 08:40:46 INFO - Current package versions: 08:40:46 INFO - argparse == 1.2.1 08:40:46 INFO - blessings == 1.6 08:40:46 INFO - blobuploader == 1.2.4 08:40:46 INFO - docopt == 0.6.1 08:40:46 INFO - manifestparser == 1.1 08:40:46 INFO - mozInstall == 1.12 08:40:46 INFO - mozcrash == 0.17 08:40:46 INFO - mozdebug == 0.1 08:40:46 INFO - mozdevice == 0.48 08:40:46 INFO - mozfile == 1.2 08:40:46 INFO - mozhttpd == 0.7 08:40:46 INFO - mozinfo == 0.9 08:40:46 INFO - mozleak == 0.1 08:40:46 INFO - mozlog == 3.1 08:40:46 INFO - moznetwork == 0.27 08:40:46 INFO - mozprocess == 0.22 08:40:46 INFO - mozprofile == 0.28 08:40:46 INFO - mozrunner == 6.11 08:40:46 INFO - mozscreenshot == 0.1 08:40:46 INFO - mozsystemmonitor == 0.0 08:40:46 INFO - moztest == 0.7 08:40:46 INFO - mozversion == 1.4 08:40:46 INFO - psutil == 3.1.1 08:40:46 INFO - requests == 1.2.3 08:40:46 INFO - wsgiref == 0.1.2 08:40:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:40:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:46 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 0x7f15d07a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d62410>, '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 0x2d63310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d637a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1460647731.195793-1485537721', '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 08:40:46 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 08:40:46 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 08:40:46 INFO - Using env: {'DISPLAY': ':0', 08:40:46 INFO - 'HOME': '/home/cltbld', 08:40:46 INFO - 'LANG': 'en_US.UTF-8', 08:40:46 INFO - 'LANGUAGE': 'en_US:en', 08:40:46 INFO - 'LOGNAME': 'cltbld', 08:40:46 INFO - 'MAIL': '/var/mail/cltbld', 08:40:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:46 INFO - 'MOZ_NO_REMOTE': '1', 08:40:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:46 INFO - 'NO_EM_RESTART': '1', 08:40:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:47 INFO - 'PWD': '/builds/slave/test', 08:40:47 INFO - 'SHELL': '/bin/bash', 08:40:47 INFO - 'SHLVL': '1', 08:40:47 INFO - 'TERM': 'linux', 08:40:47 INFO - 'TMOUT': '86400', 08:40:47 INFO - 'USER': 'cltbld', 08:40:47 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1460647731.195793-1485537721', 08:40:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:47 INFO - '_': '/tools/buildbot/bin/python'} 08:40:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:47 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)) 08:40:47 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)) 08:40:47 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)) 08:40:47 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)) 08:40:47 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)) 08:40:47 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)) 08:40:47 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)) 08:40:47 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)) 08:40:47 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)) 08:40:47 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)) 08:40:47 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)) 08:40:47 INFO - Cleaning up... 08:40:47 INFO - Return code: 0 08:40:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:40: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')]} 08:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40: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')]} 08:40:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f15d07a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d62410>, '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 0x2d63310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d637a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1460647731.195793-1485537721', '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 08:40: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', 'jsonschema'] in /builds/slave/test/build 08:40: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 jsonschema 08:40:47 INFO - Using env: {'DISPLAY': ':0', 08:40:47 INFO - 'HOME': '/home/cltbld', 08:40:47 INFO - 'LANG': 'en_US.UTF-8', 08:40:47 INFO - 'LANGUAGE': 'en_US:en', 08:40:47 INFO - 'LOGNAME': 'cltbld', 08:40:47 INFO - 'MAIL': '/var/mail/cltbld', 08:40:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:47 INFO - 'MOZ_NO_REMOTE': '1', 08:40:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:47 INFO - 'NO_EM_RESTART': '1', 08:40:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:47 INFO - 'PWD': '/builds/slave/test', 08:40:47 INFO - 'SHELL': '/bin/bash', 08:40:47 INFO - 'SHLVL': '1', 08:40:47 INFO - 'TERM': 'linux', 08:40:47 INFO - 'TMOUT': '86400', 08:40:47 INFO - 'USER': 'cltbld', 08:40:47 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1460647731.195793-1485537721', 08:40:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:47 INFO - '_': '/tools/buildbot/bin/python'} 08:40:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:47 INFO - Downloading/unpacking jsonschema 08:40: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 08:40: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 08:40: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 08:40: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 08:40: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 08:40: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 08:40:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:40:49 INFO - Downloading/unpacking functools32 (from jsonschema) 08:40: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 08:40: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 08:40: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 08:40: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 08:40: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 08:40: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 08:40:49 INFO - Downloading functools32-3.2.3-2.tar.gz 08:40:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:40:49 INFO - warning: no files found matching '*.txt' 08:40:49 INFO - no previously-included directories found matching 'build' 08:40:49 INFO - no previously-included directories found matching 'dist' 08:40:49 INFO - no previously-included directories found matching '.git*' 08:40:49 INFO - Installing collected packages: jsonschema, functools32 08:40:49 INFO - Running setup.py install for functools32 08:40:49 INFO - warning: no files found matching '*.txt' 08:40:49 INFO - no previously-included directories found matching 'build' 08:40:49 INFO - no previously-included directories found matching 'dist' 08:40:49 INFO - no previously-included directories found matching '.git*' 08:40:49 INFO - Successfully installed jsonschema functools32 08:40:49 INFO - Cleaning up... 08:40:49 INFO - Return code: 0 08:40:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:40:49 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')]} 08:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:49 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')]} 08:40:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:49 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 0x7f15d07a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d62410>, '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 0x2d63310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d637a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1460647731.195793-1485537721', '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 08:40:49 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 08:40:49 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 08:40:49 INFO - Using env: {'DISPLAY': ':0', 08:40:49 INFO - 'HOME': '/home/cltbld', 08:40:49 INFO - 'LANG': 'en_US.UTF-8', 08:40:49 INFO - 'LANGUAGE': 'en_US:en', 08:40:49 INFO - 'LOGNAME': 'cltbld', 08:40:49 INFO - 'MAIL': '/var/mail/cltbld', 08:40:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:49 INFO - 'MOZ_NO_REMOTE': '1', 08:40:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:49 INFO - 'NO_EM_RESTART': '1', 08:40:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:49 INFO - 'PWD': '/builds/slave/test', 08:40:49 INFO - 'SHELL': '/bin/bash', 08:40:49 INFO - 'SHLVL': '1', 08:40:49 INFO - 'TERM': 'linux', 08:40:49 INFO - 'TMOUT': '86400', 08:40:49 INFO - 'USER': 'cltbld', 08:40:49 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1460647731.195793-1485537721', 08:40:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:49 INFO - '_': '/tools/buildbot/bin/python'} 08:40:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:49 INFO - Downloading/unpacking flake8 08:40: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 08:40: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 08:40: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 08:40: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 08:40: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 08:40: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 08:40:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:40:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:40:51 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 08:40:51 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 08:40:51 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 08:40:51 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 08:40:51 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 08:40:51 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 08:40:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:40:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:40:52 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 08:40:52 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 08:40:52 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 08:40:52 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 08:40:52 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 08:40:52 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 08:40:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:40:52 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 08:40:52 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 08:40:52 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 08:40:52 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 08:40:52 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 08:40:52 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 08:40:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:40:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:40:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:40:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:40:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:40:52 INFO - no previously-included directories found matching 'docs/_build' 08:40:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:40:52 INFO - Running setup.py install for pep8 08:40:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:40:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:40:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:40:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:40:52 INFO - no previously-included directories found matching 'docs/_build' 08:40:52 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:40:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:40:52 INFO - Cleaning up... 08:40:52 INFO - Return code: 0 08:40:52 INFO - Running post-action listener: _resource_record_post_action 08:40:52 INFO - Running post-action listener: _start_resource_monitoring 08:40:52 INFO - Starting resource monitoring. 08:40:52 INFO - ##### 08:40:52 INFO - ##### Running install step. 08:40:52 INFO - ##### 08:40:52 INFO - Running pre-action listener: _resource_record_pre_action 08:40:52 INFO - Running main action method: install 08:40:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:40:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:40:53 INFO - Reading from file tmpfile_stdout 08:40:53 INFO - Detecting whether we're running mozinstall >=1.0... 08:40:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:40:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:40:53 INFO - Reading from file tmpfile_stdout 08:40:53 INFO - Output received: 08:40:53 INFO - Usage: mozinstall [options] installer 08:40:53 INFO - Options: 08:40:53 INFO - -h, --help show this help message and exit 08:40:53 INFO - -d DEST, --destination=DEST 08:40:53 INFO - Directory to install application into. [default: 08:40:53 INFO - "/builds/slave/test"] 08:40:53 INFO - --app=APP Application being installed. [default: firefox] 08:40:53 INFO - mkdir: /builds/slave/test/build/application 08:40:53 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'] 08:40:53 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 08:41:08 INFO - Reading from file tmpfile_stdout 08:41:08 INFO - Output received: 08:41:08 INFO - /builds/slave/test/build/application/firefox/firefox 08:41:08 INFO - Running post-action listener: _resource_record_post_action 08:41:08 INFO - ##### 08:41:08 INFO - ##### Running run-tests step. 08:41:08 INFO - ##### 08:41:08 INFO - Running pre-action listener: _resource_record_pre_action 08:41:08 INFO - Running main action method: run_tests 08:41:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:41:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:41:08 INFO - Python 2.7.3 08:41:08 INFO - Return code: 0 08:41:08 INFO - grabbing minidump binary from tooltool 08:41:08 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')]} 08:41:08 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 0x2d62410>, '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 0x2d63310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d637a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:41:08 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 08:41:08 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 08:41:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:41:08 INFO - Return code: 0 08:41:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:41:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:41:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:41:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:41:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:41:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:41:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:41:09 INFO - Return code: 0 08:41:09 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/ax_7_9NxTNqgRtTSrajKlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:41:09 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/ax_7_9NxTNqgRtTSrajKlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:41:09 INFO - Using env: {'DISPLAY': ':0', 08:41:09 INFO - 'HOME': '/home/cltbld', 08:41:09 INFO - 'LANG': 'en_US.UTF-8', 08:41:09 INFO - 'LANGUAGE': 'en_US:en', 08:41:09 INFO - 'LOGNAME': 'cltbld', 08:41:09 INFO - 'MAIL': '/var/mail/cltbld', 08:41:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:41:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:41:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:09 INFO - 'MOZ_NO_REMOTE': '1', 08:41:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:41:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:09 INFO - 'NO_EM_RESTART': '1', 08:41:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:09 INFO - 'PWD': '/builds/slave/test', 08:41:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:41:09 INFO - 'SHELL': '/bin/bash', 08:41:09 INFO - 'SHLVL': '1', 08:41:09 INFO - 'TERM': 'linux', 08:41:09 INFO - 'TMOUT': '86400', 08:41:09 INFO - 'USER': 'cltbld', 08:41:09 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1460647731.195793-1485537721', 08:41:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:09 INFO - '_': '/tools/buildbot/bin/python'} 08:41:09 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/ax_7_9NxTNqgRtTSrajKlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:41:10 INFO - mozversion application_buildid: 20160414072048 08:41:10 INFO - mozversion application_changeset: 10f66b3164570b2183333262fa91a16004cbb908 08:41:10 INFO - mozversion application_display_name: Nightly 08:41:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:41:10 INFO - mozversion application_name: Firefox 08:41:10 INFO - mozversion application_remotingname: firefox 08:41:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:41:10 INFO - mozversion application_vendor: Mozilla 08:41:10 INFO - mozversion application_version: 48.0a1 08:41:10 INFO - mozversion platform_buildid: 20160414072048 08:41:10 INFO - mozversion platform_changeset: 10f66b3164570b2183333262fa91a16004cbb908 08:41:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:41:10 INFO - mozversion platform_version: 48.0a1 08:41:10 INFO - using testdate: 1460648470 08:41:10 INFO - actual date: 1460648470 08:41:10 INFO - starting webserver on 'localhost:34776' 08:41:10 INFO - SUITE-START | Running 2 tests 08:41:10 INFO - TEST-START | dromaeo_css 08:41:10 INFO - operating with platform_type : linux_ 08:41:10 INFO - Initialising browser for dromaeo_css test... 08:41:10 INFO - TEST-INFO | started process 22951 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkskoK8/profile http://localhost:34776/getInfo.html) 08:41:14 INFO - PROCESS | 22951 | 08:41:14 INFO - PROCESS | 22951 | (process:23017): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:41:14 INFO - PROCESS | 22951 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 08:41:15 INFO - PROCESS | 22951 | __metrics Screen width/height:1600/1200 08:41:15 INFO - PROCESS | 22951 | colorDepth:24 08:41:15 INFO - PROCESS | 22951 | Browser inner width/height: 1024/697 08:41:15 INFO - PROCESS | 22951 | __metrics 08:41:16 ERROR - PROCESS | 22951 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 08:41:17 INFO - TEST-INFO | 22951: exit 0 08:41:17 INFO - Browser initialized. 08:41:17 INFO - Running cycle 1/1 for dromaeo_css test... 08:41:17 INFO - TEST-INFO | started process 23068 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkskoK8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:41:19 INFO - PROCESS | 23068 | 08:41:19 INFO - PROCESS | 23068 | (process:23129): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:41:29 INFO - PROCESS | 23068 | RSS: Main: 163999744 08:41:29 INFO - PROCESS | 23068 | 08:42:19 INFO - PROCESS | 23068 | 1460648539073 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] 08:44:31 INFO - PROCESS | 23068 | Cycle 1(1): loaded http://localhost:34776/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34776/tests/dromaeo/cssquery-ext.html) 08:44:32 INFO - PROCESS | 23068 | RSS: Main: 168525824 08:44:32 INFO - PROCESS | 23068 | 08:47:34 INFO - PROCESS | 23068 | Cycle 1(1): loaded http://localhost:34776/tests/dromaeo/cssquery-ext.html (next: http://localhost:34776/tests/dromaeo/cssquery-jquery.html) 08:47:34 INFO - PROCESS | 23068 | RSS: Main: 165335040 08:47:34 INFO - PROCESS | 23068 | 08:50:36 INFO - PROCESS | 23068 | Cycle 1(1): loaded http://localhost:34776/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34776/tests/dromaeo/cssquery-mootools.html) 08:50:37 INFO - PROCESS | 23068 | RSS: Main: 165761024 08:50:37 INFO - PROCESS | 23068 | 08:53:39 INFO - PROCESS | 23068 | Cycle 1(1): loaded http://localhost:34776/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34776/tests/dromaeo/cssquery-prototype.html) 08:53:39 INFO - PROCESS | 23068 | RSS: Main: 163246080 08:53:39 INFO - PROCESS | 23068 | 08:56:42 INFO - PROCESS | 23068 | Cycle 1(1): loaded http://localhost:34776/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34776/tests/dromaeo/cssquery-yui.html) 08:56:43 INFO - PROCESS | 23068 | RSS: Main: 164995072 08:56:43 INFO - PROCESS | 23068 | 08:59:45 INFO - PROCESS | 23068 | Cycle 1(1): loaded http://localhost:34776/tests/dromaeo/cssquery-yui.html (next: http://localhost:34776/tests/dromaeo/cssquery-dojo.html) 08:59:45 INFO - PROCESS | 23068 | RSS: Main: 166674432 08:59:45 INFO - PROCESS | 23068 | 08:59:45 INFO - PROCESS | 23068 | __start_tp_report 08:59:45 INFO - PROCESS | 23068 | _x_x_mozilla_page_load 08:59:45 INFO - PROCESS | 23068 | _x_x_mozilla_page_load_details 08:59:45 INFO - PROCESS | 23068 | |i|pagename|runs| 08:59:45 INFO - PROCESS | 23068 | |0;dojo.html;2651.1913866270784;2722.7005029446764;2734.6171535984954;2749.134022782823;2754.7520723134926;4834.734089625069;4856.247281671338;4858.246971719389;4868.975655121724;4928.852134435972;4740.336352910595;4813.157697402958;4883.731394773286;4893.266010098479;4911;4405.889852753683;4432.711873728197;4489.169503641837;4491.191585514606;4526.841560545382;673.0867224707528;4336.3712261722185;4340.8697739067875;4385.7149285296355;4432.534583868695;4447.888802779924;4486;4489.551044895485;4512.345709872083;4553.795079221443;4496.527864574238;4507.143642707875;4515.458145022585;4524.298733696282;4554;4321.459817522809;4402.185595664812;4433.113377324548;4437.711548749321;4473.127740090684;4701.294805779161;4735.597474214662;4759.976200119012;4765.618750499986;4838.056578967103;5178.197379406198;5216.817411390621;5239.711815850127;5257;5326.547243484309;5210.192420174879;5214.556762675177;5224.190250511177;5237.869053273661;5276.788928442896;4803.663743537989;4849.612031037508;4851;4868.805247790084;4904.117258893433;5126.38483381989;5310.070737620901;5330.733463326818;5406.972965135149;5457.727113644302;5186.81846135391;5206.479352064839;5214.426413094557;5215.504527069922;5222.451642577475;5261.921071183935;5298.523132917979;5306.7611957462;5309.973450132725;5347.0909945309395;5057.8229761958155;5081.466446023188;5130.97434512825;5134.743262836918;5190.8183213587345;5135.974320128375;5152.948470515322;5164.14791559396;5189.922151167735;5196.246544251062;4430.269005614102;4441.911161776811;4457.955420445819;4459.44256967879;4495.393121928563;3743.494628225155;3831.7892515911894;3880.553736320303;3899.3566061600086;3952.802359882052;4372.650187984954;4430.246858034142;4437.090396468716;4463.152001119777;4557.840475583405;5198;5200.401953775364;5238.161894097002;5255.474452554714;5268.1834315681135;4380.912381752347;4482.708623939434;4483.08096840147;4516.006478574708;4524.185646583646;4762.714237145782;4786.329913812069;4786.44955830077;4794.304825800309;4826;4957.975210123926;4961.50384961501;4970.105381031449;4970.204767237225;4975.253711943165;5032.471590483093;5293.5765138789575;5301.787928482971;5366.382865970463;5375.032494150934;4934.679245849008;4956.727379994135;4958.206686930074;4960.379952505937;4998.475160108136;5194.714290713896;5224.869378265574;5227.92158117621;5232.764525596282;5271.20931860224;5057.974710126426;5234.607404444758;5294.735263236746;5306.044911915892;5320.308359913187;5078.136716758087;5102.897942041064;5103.87240318995;5104.668196567211;5122.103631864335;5114.5652619527755;5115.514026167508;5117.667351622133;5120.923186152137;5122.231665250242;4903.04390643821;4995.450500444876;5006.69959802413;5018;5019.3976722793495;5005.899882002267;5017.799288028584;5021.171506701354;5022.924656130088;5056.241563765465;4839.346688197048;4889.706617602955;4896.510348965075;4912.287718280901;4931.06309801151 08:59:45 INFO - PROCESS | 23068 | |1;ext.html;574.2821473158551;581.3837332427624;589.8171566814287;617.8939697940685;632.9461446691259;33314;34260.48609270863;34285.65714342856;34314.65685343146;34399.65600343996;35340.64659353406;35557.46663800045;35703.28593428136;35778.284434311296;35781.10547236314;7567.735129270491;7673.2326767323375;7697.653605587762;7703.922960770405;7746.341560967325;7643.961780191091;7831.177726338738;7854.057513098408;7872.960635196845;7900.051993760757;7846;7869.921300787005;7924.128345881977;7933.642986065641;7984.560849153294;7838.843223135534;7847.6468558914985;7915.722949696762;7919.168487308807;7923.049234091945;7765.883511747328;7832.882506762403;7858.882116768253;7872.5042241974415;7892.763217103496;30006.399872002658;35363;35865.10337241564;35921;36008.81995590031;3004.684508126637;3065.984670076635;3096;3133.7649676274373;3526.788392696421;27649.447011059867;28151.859240703667;28457.146285611463;28496.85751571229;28717.712822871712;3276.344731053775;3306.189983454069;3317.1872891141584;3329.400707872582;3334.0331303921835;195607;201393;201631.93472261092;201763;203516;58836.411635883094;59945.70027149836;60050.39949600448;60064;60187.09719354213;62043;67056.66471667611;68044.6597767018;68461.65769171221;68717.65641171862;14897.627559310888;15138.545843624708;15146.848531514765;15152.621184470476;15209.6197595061;11132.220744547965;11132.721681958015;11274.718132046764;11287.49206285719;11291.3789741565;19307.06929307058;19693.803061969196;19742;19867.403977880687;19911.800881991283;7442.292982166686;7741.4968027079185;7825.843483130306;7899.960500197462;7920.366370690331;854.478767951549;872.1627237851607;907.274180655473;975.2977855943709;1064.3081996702206;26285.605715914277;26328.736712632628;26527.867360663073;26808;26876.32809179747;1024.3853687787416;1045.816982028142;1060.4432672846817;1099.983500247497;1145.135422755814;14241.572752817432;14307.284635768377;14318.212498312485;14477.131372117707;14604.561863144123;347953;352764;354773;356102;356104;49463.505364946606;50784.74607626938;50809.74595127074;50992.23511647328;50994.49005509972;1236.221180656163;1240.7394447166196;1250.6748245456247;1269.3082270162784;1280.807878818166;26348.20955371342;27253;27288.317792054564;27680.723192767815;27809.44381112407;40481;41201.79399102985;41213;41505.79247103745;41535.7923210382;318466;318707;321996;322643;323044;25994.87002564975;26117.347066323495;26957;26962.32594185161;27058.45883082288;44274.55725442704;44732.32901506415;44751.32873006973;44792.328115078955;44826;36753;37484.625153749206;37487.25025499529;38168.236635266585;38348.2330353397;36999.445008325434;37168.628313716516;37625.4356184652;37689.62310376861;37881.24237515289;33674.158146046546;36824;37033;37114.814425927696;38159;29170.611154847065;32776.34447311088;33038;33309.83345083259;33342.83328583342;25173;25360.873195633903;25402.491950160525;25404.364890877136;25625.743742562336 08:59:45 INFO - PROCESS | 23068 | |2;jquery.html;362.72070505710593;366.8055930356911;389.99415008774855;391.3386377022831;396.6450027225631;15706.371745130182;16059.678806423864;16855.578610534743;16868;16970.15149242536;10373.688789336313;10377.896221037807;10399.53202105905;10400.583976640944;10436.06075453209;4531.4335708036415;4666.346711460398;4744.620430365562;5039.370078740158;5157.510036546522;3403.149212696826;5135.768890399922;5400.486953739408;5422.078246698071;5438.021156191884;5361.249425080492;5367.570594352443;5371.194320851864;5372.086745253317;5401.837944861641;5136.922946155811;5365.919511207296;5374.731263436852;5390.86791773728;5403.78384864605;5189.818356357547;5206.193040078794;5218.895622087575;5223.582113430916;5249.212618107276;12411.379431028503;12626.68433289166;12751.61745147647;12770.68073298175;12790.808137877939;1722.6985277576373;1985.4043786864027;2097.119209931817;2218.1718309155794;2232.2633530934913;9169.587368568364;9282.860757088649;9536.094071063239;10244.487775611264;13062.608121756362;1629.0714292853079;1662.8669706423457;1765.4085881229676;1824.3797108982876;1829.8902065875957;66551.334486655;69026;69489;70306;71361;9724.270679699051;9857.30998830075;9870.309078364446;9917.75205619851;10449.477526123663;14136.15183089018;14214.715705686036;14275.428982840778;14307.427702891975;14344.426222950966;6803.455723542104;6826.649134341438;7131.750388736473;7159.854423292249;7159.964200178966;6495.220573531112;6506.772262970773;6583.242927063353;6597.406233439014;6683.565568238049;4089.9795501022304;4322.524522302544;4361.847335343247;4399.36209249657;4568;1646.5801220688647;1711.238498867992;1720.4408567215705;1920.4060629677335;1933.680942644476;898.9460632362079;973.4451362723321;977.5112443778111;1018.0989824005808;1026.1226651213256;15691.450799221973;16239.106849123174;16390;16475.83524164767;16667;888.9244414224734;891.9598618062203;907.6278725722422;916.6883259691737;929.2426672262085;8882.557172246497;9244.768880778034;9247.39891907024;9413.717588472357;9425.952870235606;362543;363899;370158;371337;378337;44900.55099448964;71371.643141785;73280;73424.63287683527;75370;938.4369378372921;954;956.8851737791509;961.6730311694058;979.9804003919882;14526.20105894186;14590.489332873298;14673.119612823264;14802.111873287637;14817.407303708162;31301.06096817099;32429.18927026843;32892.34215315728;33290.83482078116;33459.665403346626;45119.32321015253;46180.307295389925;46195.3070703933;46430;46524.53475465202;4391.8682439526865;4482.462104547475;6994.440444764305;7197.020819274741;7369.299916507923;8742.56287185651;10664.093552048163;11089.112870970464;11338.206325557132;11706.648800535997;9777.804443911224;10012.69961901144;10080.899191007997;10284.2801003932;10333.173346132142;9402.717918462457;9559.952200238955;9776.413415195111;9869.654562090293;9983.251256155672;9959.950200248952;9980.850287245843;10102.646407375707;10167.644132455625;10465.476726163814;6640.335966403514;6986.056882320821;7105.2894710528535;7174.605396703231;7466.738664146729;4956.950430495793;6647.803395388876;7712.652930618024;8982.505962172143;10268.64059757905 08:59:45 INFO - PROCESS | 23068 | |3;mootools.html;1440.2294772296823;1494.7907292978982;1599.6560739441018;1767.187093936789;1774.8136445673197;6982.546134501254;7658.195889431613;7794.571298578576;7911.208879112086;7932.206779322065;7823.569703666296;7888.171741967097;7915.683372665101;7938.2061793820585;7959.124496305416;2242.6972358731527;2256.537409830989;2260.2880092770806;2267.1498188179435;2269.500709843832;2148.34475484977;2175;2182.563487302538;2200.5048864005553;2205.195103787114;2153.0849389009686;2185.344396680989;2196.3410976707005;2202.317281642696;2205.0077465140753;2085.259732794859;2092;2098.171222367164;2099.3177217404404;2108.599366120432;2183.443221978401;2196.615592271362;2217.2128894242474;2218.2457964292216;2218.633925402323;8009.599520023976;8027.558484283362;8030.07654119772;8059.95970020152;8118.309943654737;4524.954750452519;4640.09518143962;4641.466231383401;4657.068586282723;4662.230731929261;2904.4626744052207;2911.6315331794235;2976.4047190561973;2989.7010298970145;2996.3258266889993;891.892972843263;921.5208091792231;927.5501381829807;935.9625614975461;943.1134733350628;10603.469826508644;10643.680689579325;10788.622398216025;10807.351558906412;10838;4372.912541749147;4391.451068616423;4530.161920044802;4532.70537415067;4536.138133754576;9201.17189452939;9208.493532855624;9212.170904618617;9227.723168304961;9231.215346695606;4716.457607375196;4719.3628860103445;4724.2205036169335;4736.478987311393;4739.881502962385;3747.231817477465;4275.893102672396;4298;4324.762138082436;4449.043455657049;3725.701943844486;3730.1980074283615;3758.830852611639;3821.560520540118;3835.175437280998;1237.3194742891553;1243.278898239019;1259.8551166615773;1273.3505911984955;1274.8278982337265;772.4824367673672;828.846663367279;841.9727931923044;858.2704701004096;887.6759982606432;5496.80761173357;5533.474319939599;5644.435556444323;5646.237757902631;5669.518090962232;912.4114945859883;916.1251005289932;920.052346083535;952.5713428956997;970.1898914406408;3477.8608855646;3598.946015809765;3662.8351724171944;3664.7984360859878;3683.4106542953;9315.301352398597;9570.99504552012;9644.565994530263;9668.854967175497;9669.323147379757;9300.906990930003;9538.189253913495;9727.416355018722;9865.556049977768;9960.103590676874;7245.673944672502;7279.6360181990685;7291.234420385889;7319.377852882458;7339.779806605917;5301.628885978099;5506.64206826555;5608.6073974823;5631.662100273997;5676.318841739017;8587.22714955657;8837.160469755363;8846.424982376126;8861.778455538662;8870.86693699582;8576.65693372283;8911.866322005046;8966.641334346554;9019.052999434965;9021.503817290111;6037.15479832815;6595.835104122435;6706.83232919181;6739.123913891162;6997.195322537973;7556.206598307099;7565.6973721050545;7573.2805383488485;7577.318041376303;7640.235976402315;6674.699638516376;6917.619530925847;6918.308169183041;7018.929810701828;7021.719131234693;6853.965730171317;6890.44876409876;6897.7585784497305;6909.343612356818;6969.6515174242095;6523.347665233438;6546.345365463606;6577.901331480128;6587.934120658732;6701.731930722716;4622.399088118523;4632.444106707082;4665.953340466552;4666.953330466652;4681.789319480564;4580.083983203306;4629.4676112247525;4673.345731597511;4704.29435584665;4720.787564559671 08:59:45 INFO - PROCESS | 23068 | |4;prototype.html;306.598356153439;309.1899224033034;316.7640108119451;317.4793338924163;324.72722912753284;5187.896242075156;5244.292020577221;5321.3348331458565;5344.4922732340465;5369.865753356163;5317.707526086064;5320.680759154454;5325.973370133153;5342.439043900383;5343.118385466393;4203.991042149877;4206.768627725482;4207.05341298207;4208.368744688306;4213.7893105344765;4122.567130451304;4151.692216951666;4198.97900510497;4230.97884510577;4232.49210094789;4130.876073717778;4139.317012692902;4158.8336466541305;4164.958350416502;4174.666026717855;4154.563770804068;4180.853670121562;4183.309753890604;4190.308599081148;4205.495340559122;3703.4259689748133;3713.294474049922;3715.368387374153;3716.7026637869176;3725.3480640887738;4931.3835770528685;5053.191489361684;5098.818968445876;5101.540861322499;5116.69299842007;4803.78382972767;4818.10864989978;4824.083424149436;4824.831130910401;4828.661993660445;5556.277683901108;5638.323401191842;5643.68959707216;5657.405972372882;5672.631278966854;4036.777977211252;4046.615571520701;4050.711348088321;4060.187962407501;4067.3288907330257;5862.325832529228;5877.118432235199;5899.085641725539;5903.763849446017;5918.526517878559;4165.8958526037095;4200.558941311179;4202.663786897041;4208.726432781859;4214.7355793261895;4095.89760255996;4190.832366705297;4226.809793559297;4227.2179646764835;4248.723832950848;4760.238361862085;4785.856424307276;4816.975915120472;4825.420949486084;4850.272459131159;5373.462653734673;5718.228039214653;5732.856678582985;5736.6844823534275;5752.964466396089;1398.6992097349562;1470.4926800253895;1472.6465648244343;1475.9852401476062;1481.9110853348618;975.7267964969819;981.6466072213997;1001.3191030099603;1011.4133802394593;1016.070295679445;4772.331873537708;4822.903541929142;4840.136547429265;4843;4848.781804818792;5743.655380677173;5745.511631511368;5787.71061446926;5787.8553036174435;5792.422372044484;4653.86038418848;4809.9038019240115;4821.325014497973;4826.541478559531;4906.411230652273;3153.4323821711855;3158.6683398243313;3164.351307981858;3165.1770539659856;3171.302313491028;5398.541124004425;5476.945230547723;5478.506934375925;5480.26016487777;5483.616146869681;5903.586748927534;6047.667378294236;6056.545759068;6059.6364218147055;6063.211782468251;5427.755750991136;5469.371022332482;5471.616986810965;5487.862803429866;5500.4499550044675;5650.85872853182;5859.472647461749;5867.354590995073;5885.646861188342;5898.203742494708;5698.1452782083015;5739.512141467855;5751.5398768099285;5754.396482813816;5801.5938884279385;5417.241586178017;5418.783248670009;5471;5483.643563168382;5494.2857428534035;3986.940195897122;4051.47330846988;4054.0675644601315;4080.6123418275215;4087.325591277525;5540.695261760642;5664.915026274527;5809.796657116981;5832.504237139721;5847.853803654943;5651.4348565143155;5664.745086471036;5671.716414179192;5711.086226203787;5713.22871412354;5587.77648894056;5641.464060914206;5645.153227015816;5651.90879374634;5663.490285874291;5407.161889907071;5520.806771762969;5522.806701765419;5582.804601838916;5585.1901474286815;5663.66018038919;5688.431156884279;5699.601027928005;5705.144228365778;5714.885702286014;5394.568434525307;5511.090670039559;5520.889582208413;5520.972395137998;5554.611177217556 08:59:45 INFO - PROCESS | 23068 | |5;yui.html;696.8745625787358;776.9533827970322;781.6443518199218;782.374100719425;790.12690976471;11556.768864622703;11582.536698532069;11614;11793.7641247175;11973.940130299357;11628.709282267948;11692.123090768184;11724;11749.060075193986;11791.587294444696;645.1935081148564;803.3854101612271;808.1352952341012;823.7693445835175;826.0954255090696;809.3727361294984;813.1746277528314;813.3615112136973;818.2390376949435;820.2453742556833;841.20506121715;842.4103127810527;845.5772113943028;847.0978407995465;849.9842687987857;834.5201509132243;838.983220335596;841.7727213652311;842.1830824100613;843.6245870587591;613.7790395457631;616.4513582911212;617.2654541096082;621.2079598511888;622.3030206169075;12513.37433128349;12581.685457863536;12583.622491325275;12590.18163819358;12593.99248060153;12945.676358091028;13023.674408139872;13052.54316098932;13244.205347679073;13263.86736132636;9592.712218633453;9996.100350968374;10021.09810117093;10131.696049118538;10268.94865525675;3316.3533111043357;3351.262722201112;3364.8654053838063;3370.6629337066097;3401.234722187513;44528.109437811385;44601.553984460064;44642.776786116185;45395.77302113501;46122.5387746125;10027.197824174049;10194.745131371626;10279.794404111875;10412.791744165073;10432.2697411182;16998.57503562421;18053.368132115313;18097.547561311072;18219;18429;6976.755813546603;6977;7010.088688470466;7031.472639551952;7154.570725756471;3830.6020441150426;3831.214601006787;3834.405667121601;3883.203943191639;3924.4505769192338;2983.1348908816635;3029.4849875521213;3057.8929737459084;3062.4793785056595;3074.738647214967;540.9945900541023;549.2502733768378;558.6564262978239;561.2563353556473;564.3735453646449;542.5252903709254;568.3520786303617;573.4924591736343;641.416311156845;650.1970066967292;7418.146913104954;7475.401967842559;7624.923750762421;7706.152323244439;7916.920830791619;511.9078565858107;561.3712641841082;617.8702472480829;619.6746707978348;639.9712012959428;3430.433978393587;3599.3881040223223;3634.0677696468533;3649.927001459956;3670.9632903671154;46517;48198.27702584464;48271.75864120727;48294.5170548297;49036.50963490391;38403;40617;41303.38044929328;41531.79234103871;44663.33005004928;39125;39138.412923806165;39290.2141957165;39297.607023929966;39804.208810603595;7531;7600.923990760021;8023.4784738991775;8046.114927358103;8194.50832950025;27437.725622743517;27543.17370478889;27850.303742406602;28039.579406308512;28310.43379132447;34783.652163478044;35565.39955701948;35977.46033809547;37018.444723328634;38025.429618555194;10550.788984220118;10567.101796347397;10624.575016999543;10694.786104277715;10784.946075269574;11967.880321197024;11979.580714674945;12265.509379624715;12283.631491055283;12584.244945303311;10988;11159.553617855196;11160.665180044612;11188.608398706006;11275.605353812578;10991.945040274748;11192.38441885704;11319;11478;11556;11273.154513411691;11340.94329528347;11423.200375973602;11554.248973816675;11574.594889179176;8758.386912916034;8979.620296033607;9123.863142052742;9166.24587875359;9375.765605859635;9211.58928838583;9489.620415183315;9498.715038548855;9568.330216884751;9573.425594464354 08:59:45 INFO - PROCESS | 23068 | __end_tp_report 08:59:45 INFO - PROCESS | 23068 | __start_cc_report 08:59:45 INFO - PROCESS | 23068 | _x_x_mozilla_cycle_collect,387 08:59:45 INFO - PROCESS | 23068 | __end_cc_report 08:59:45 INFO - PROCESS | 23068 | __startTimestamp1460649585777__endTimestamp 08:59:45 INFO - PROCESS | 23068 | 08:59:45 INFO - PROCESS | 23068 | ------- Summary: start ------- 08:59:45 INFO - PROCESS | 23068 | Number of tests: 6 08:59:45 INFO - PROCESS | 23068 | 08:59:45 INFO - PROCESS | 23068 | [#0] dojo.html Cycles:165 Average:4796.00 Median:4957.98 stddev:606.47 (12.2%) stddev-sans-first:584.53 08:59:45 INFO - PROCESS | 23068 | Values: 2651.2 2722.7 2734.6 2749.1 2754.8 4834.7 4856.2 4858.2 4869.0 4928.9 4740.3 4813.2 4883.7 4893.3 4911.0 4405.9 4432.7 4489.2 4491.2 4526.8 673.1 4336.4 4340.9 4385.7 4432.5 4447.9 4486.0 4489.6 4512.3 4553.8 4496.5 4507.1 4515.5 4524.3 4554.0 4321.5 4402.2 4433.1 4437.7 4473.1 4701.3 4735.6 4760.0 4765.6 4838.1 5178.2 5216.8 5239.7 5257.0 5326.5 5210.2 5214.6 5224.2 5237.9 5276.8 4803.7 4849.6 4851.0 4868.8 4904.1 5126.4 5310.1 5330.7 5407.0 5457.7 5186.8 5206.5 5214.4 5215.5 5222.5 5261.9 5298.5 5306.8 5310.0 5347.1 5057.8 5081.5 5131.0 5134.7 5190.8 5136.0 5152.9 5164.1 5189.9 5196.2 4430.3 4441.9 4458.0 4459.4 4495.4 3743.5 3831.8 3880.6 3899.4 3952.8 4372.7 4430.2 4437.1 4463.2 4557.8 5198.0 5200.4 5238.2 5255.5 5268.2 4380.9 4482.7 4483.1 4516.0 4524.2 4762.7 4786.3 4786.4 4794.3 4826.0 4958.0 4961.5 4970.1 4970.2 4975.3 5032.5 5293.6 5301.8 5366.4 5375.0 4934.7 4956.7 4958.2 4960.4 4998.5 5194.7 5224.9 5227.9 5232.8 5271.2 5058.0 5234.6 5294.7 5306.0 5320.3 5078.1 5102.9 5103.9 5104.7 5122.1 5114.6 5115.5 5117.7 5120.9 5122.2 4903.0 4995.5 5006.7 5018.0 5019.4 5005.9 5017.8 5021.2 5022.9 5056.2 4839.3 4889.7 4896.5 4912.3 4931.1 08:59:45 INFO - PROCESS | 23068 | 08:59:45 INFO - PROCESS | 23068 | [#1] ext.html Cycles:180 Average:45518.37 Median:35351.82 stddev:78722.26 (222.7%) stddev-sans-first:78870.77 08:59:45 INFO - PROCESS | 23068 | Values: 574.3 581.4 589.8 617.9 632.9 33314.0 34260.5 34285.7 34314.7 34399.7 35340.6 35557.5 35703.3 35778.3 35781.1 7567.7 7673.2 7697.7 7703.9 7746.3 7644.0 7831.2 7854.1 7873.0 7900.1 7846.0 7869.9 7924.1 7933.6 7984.6 7838.8 7847.6 7915.7 7919.2 7923.0 7765.9 7832.9 7858.9 7872.5 7892.8 30006.4 35363.0 35865.1 35921.0 36008.8 3004.7 3066.0 3096.0 3133.8 3526.8 27649.4 28151.9 28457.1 28496.9 28717.7 3276.3 3306.2 3317.2 3329.4 3334.0 195607.0 201393.0 201631.9 201763.0 203516.0 58836.4 59945.7 60050.4 60064.0 60187.1 62043.0 67056.7 68044.7 68461.7 68717.7 14897.6 15138.5 15146.8 15152.6 15209.6 11132.2 11132.7 11274.7 11287.5 11291.4 19307.1 19693.8 19742.0 19867.4 19911.8 7442.3 7741.5 7825.8 7900.0 7920.4 854.5 872.2 907.3 975.3 1064.3 26285.6 26328.7 26527.9 26808.0 26876.3 1024.4 1045.8 1060.4 1100.0 1145.1 14241.6 14307.3 14318.2 14477.1 14604.6 347953.0 352764.0 354773.0 356102.0 356104.0 49463.5 50784.7 50809.7 50992.2 50994.5 1236.2 1240.7 1250.7 1269.3 1280.8 26348.2 27253.0 27288.3 27680.7 27809.4 40481.0 41201.8 41213.0 41505.8 41535.8 318466.0 318707.0 321996.0 322643.0 323044.0 25994.9 26117.3 26957.0 26962.3 27058.5 44274.6 44732.3 44751.3 44792.3 44826.0 36753.0 37484.6 37487.3 38168.2 38348.2 36999.4 37168.6 37625.4 37689.6 37881.2 33674.2 36824.0 37033.0 37114.8 38159.0 29170.6 32776.3 33038.0 33309.8 33342.8 25173.0 25360.9 25402.5 25404.4 25625.7 08:59:45 INFO - PROCESS | 23068 | 08:59:45 INFO - PROCESS | 23068 | [#2] jquery.html Cycles:180 Average:22591.22 Median:46477.27 stddev:60966.42 (131.2%) stddev-sans-first:61114.60 08:59:45 INFO - PROCESS | 23068 | Values: 362.7 366.8 390.0 391.3 396.6 15706.4 16059.7 16855.6 16868.0 16970.2 10373.7 10377.9 10399.5 10400.6 10436.1 4531.4 4666.3 4744.6 5039.4 5157.5 3403.1 5135.8 5400.5 5422.1 5438.0 5361.2 5367.6 5371.2 5372.1 5401.8 5136.9 5365.9 5374.7 5390.9 5403.8 5189.8 5206.2 5218.9 5223.6 5249.2 12411.4 12626.7 12751.6 12770.7 12790.8 1722.7 1985.4 2097.1 2218.2 2232.3 9169.6 9282.9 9536.1 10244.5 13062.6 1629.1 1662.9 1765.4 1824.4 1829.9 66551.3 69026.0 69489.0 70306.0 71361.0 9724.3 9857.3 9870.3 9917.8 10449.5 14136.2 14214.7 14275.4 14307.4 14344.4 6803.5 6826.6 7131.8 7159.9 7160.0 6495.2 6506.8 6583.2 6597.4 6683.6 4090.0 4322.5 4361.8 4399.4 4568.0 1646.6 1711.2 1720.4 1920.4 1933.7 898.9 973.4 977.5 1018.1 1026.1 15691.5 16239.1 16390.0 16475.8 16667.0 888.9 892.0 907.6 916.7 929.2 8882.6 9244.8 9247.4 9413.7 9426.0 362543.0 363899.0 370158.0 371337.0 378337.0 44900.6 71371.6 73280.0 73424.6 75370.0 938.4 954.0 956.9 961.7 980.0 14526.2 14590.5 14673.1 14802.1 14817.4 31301.1 32429.2 32892.3 33290.8 33459.7 45119.3 46180.3 46195.3 46430.0 46524.5 4391.9 4482.5 6994.4 7197.0 7369.3 8742.6 10664.1 11089.1 11338.2 11706.6 9777.8 10012.7 10080.9 10284.3 10333.2 9402.7 9560.0 9776.4 9869.7 9983.3 9960.0 9980.9 10102.6 10167.6 10465.5 6640.3 6986.1 7105.3 7174.6 7466.7 4957.0 6647.8 7712.7 8982.5 10268.6 08:59:45 INFO - PROCESS | 23068 | 08:59:45 INFO - PROCESS | 23068 | [#3] mootools.html Cycles:180 Average:5215.61 Median:5638.05 stddev:2876.36 (51.0%) stddev-sans-first:2870.44 08:59:45 INFO - PROCESS | 23068 | Values: 1440.2 1494.8 1599.7 1767.2 1774.8 6982.5 7658.2 7794.6 7911.2 7932.2 7823.6 7888.2 7915.7 7938.2 7959.1 2242.7 2256.5 2260.3 2267.1 2269.5 2148.3 2175.0 2182.6 2200.5 2205.2 2153.1 2185.3 2196.3 2202.3 2205.0 2085.3 2092.0 2098.2 2099.3 2108.6 2183.4 2196.6 2217.2 2218.2 2218.6 8009.6 8027.6 8030.1 8060.0 8118.3 4525.0 4640.1 4641.5 4657.1 4662.2 2904.5 2911.6 2976.4 2989.7 2996.3 891.9 921.5 927.6 936.0 943.1 10603.5 10643.7 10788.6 10807.4 10838.0 4372.9 4391.5 4530.2 4532.7 4536.1 9201.2 9208.5 9212.2 9227.7 9231.2 4716.5 4719.4 4724.2 4736.5 4739.9 3747.2 4275.9 4298.0 4324.8 4449.0 3725.7 3730.2 3758.8 3821.6 3835.2 1237.3 1243.3 1259.9 1273.4 1274.8 772.5 828.8 842.0 858.3 887.7 5496.8 5533.5 5644.4 5646.2 5669.5 912.4 916.1 920.1 952.6 970.2 3477.9 3598.9 3662.8 3664.8 3683.4 9315.3 9571.0 9644.6 9668.9 9669.3 9300.9 9538.2 9727.4 9865.6 9960.1 7245.7 7279.6 7291.2 7319.4 7339.8 5301.6 5506.6 5608.6 5631.7 5676.3 8587.2 8837.2 8846.4 8861.8 8870.9 8576.7 8911.9 8966.6 9019.1 9021.5 6037.2 6595.8 6706.8 6739.1 6997.2 7556.2 7565.7 7573.3 7577.3 7640.2 6674.7 6917.6 6918.3 7018.9 7021.7 6854.0 6890.4 6897.8 6909.3 6969.7 6523.3 6546.3 6577.9 6587.9 6701.7 4622.4 4632.4 4666.0 4667.0 4681.8 4580.1 4629.5 4673.3 4704.3 4720.8 08:59:45 INFO - PROCESS | 23068 | 08:59:45 INFO - PROCESS | 23068 | [#4] prototype.html Cycles:180 Average:4682.24 Median:5319.19 stddev:1354.56 (25.5%) stddev-sans-first:1317.94 08:59:45 INFO - PROCESS | 23068 | Values: 306.6 309.2 316.8 317.5 324.7 5187.9 5244.3 5321.3 5344.5 5369.9 5317.7 5320.7 5326.0 5342.4 5343.1 4204.0 4206.8 4207.1 4208.4 4213.8 4122.6 4151.7 4199.0 4231.0 4232.5 4130.9 4139.3 4158.8 4165.0 4174.7 4154.6 4180.9 4183.3 4190.3 4205.5 3703.4 3713.3 3715.4 3716.7 3725.3 4931.4 5053.2 5098.8 5101.5 5116.7 4803.8 4818.1 4824.1 4824.8 4828.7 5556.3 5638.3 5643.7 5657.4 5672.6 4036.8 4046.6 4050.7 4060.2 4067.3 5862.3 5877.1 5899.1 5903.8 5918.5 4165.9 4200.6 4202.7 4208.7 4214.7 4095.9 4190.8 4226.8 4227.2 4248.7 4760.2 4785.9 4817.0 4825.4 4850.3 5373.5 5718.2 5732.9 5736.7 5753.0 1398.7 1470.5 1472.6 1476.0 1481.9 975.7 981.6 1001.3 1011.4 1016.1 4772.3 4822.9 4840.1 4843.0 4848.8 5743.7 5745.5 5787.7 5787.9 5792.4 4653.9 4809.9 4821.3 4826.5 4906.4 3153.4 3158.7 3164.4 3165.2 3171.3 5398.5 5476.9 5478.5 5480.3 5483.6 5903.6 6047.7 6056.5 6059.6 6063.2 5427.8 5469.4 5471.6 5487.9 5500.4 5650.9 5859.5 5867.4 5885.6 5898.2 5698.1 5739.5 5751.5 5754.4 5801.6 5417.2 5418.8 5471.0 5483.6 5494.3 3986.9 4051.5 4054.1 4080.6 4087.3 5540.7 5664.9 5809.8 5832.5 5847.9 5651.4 5664.7 5671.7 5711.1 5713.2 5587.8 5641.5 5645.2 5651.9 5663.5 5407.2 5520.8 5522.8 5582.8 5585.2 5663.7 5688.4 5699.6 5705.1 5714.9 5394.6 5511.1 5520.9 5521.0 5554.6 08:59:45 INFO - PROCESS | 23068 | 08:59:45 INFO - PROCESS | 23068 | [#5] yui.html Cycles:180 Average:12314.05 Median:21607.33 stddev:13375.60 (61.9%) stddev-sans-first:13384.67 08:59:45 INFO - PROCESS | 23068 | Values: 696.9 777.0 781.6 782.4 790.1 11556.8 11582.5 11614.0 11793.8 11973.9 11628.7 11692.1 11724.0 11749.1 11791.6 645.2 803.4 808.1 823.8 826.1 809.4 813.2 813.4 818.2 820.2 841.2 842.4 845.6 847.1 850.0 834.5 839.0 841.8 842.2 843.6 613.8 616.5 617.3 621.2 622.3 12513.4 12581.7 12583.6 12590.2 12594.0 12945.7 13023.7 13052.5 13244.2 13263.9 9592.7 9996.1 10021.1 10131.7 10268.9 3316.4 3351.3 3364.9 3370.7 3401.2 44528.1 44601.6 44642.8 45395.8 46122.5 10027.2 10194.7 10279.8 10412.8 10432.3 16998.6 18053.4 18097.5 18219.0 18429.0 6976.8 6977.0 7010.1 7031.5 7154.6 3830.6 3831.2 3834.4 3883.2 3924.5 2983.1 3029.5 3057.9 3062.5 3074.7 541.0 549.3 558.7 561.3 564.4 542.5 568.4 573.5 641.4 650.2 7418.1 7475.4 7624.9 7706.2 7916.9 511.9 561.4 617.9 619.7 640.0 3430.4 3599.4 3634.1 3649.9 3671.0 46517.0 48198.3 48271.8 48294.5 49036.5 38403.0 40617.0 41303.4 41531.8 44663.3 39125.0 39138.4 39290.2 39297.6 39804.2 7531.0 7600.9 8023.5 8046.1 8194.5 27437.7 27543.2 27850.3 28039.6 28310.4 34783.7 35565.4 35977.5 37018.4 38025.4 10550.8 10567.1 10624.6 10694.8 10784.9 11967.9 11979.6 12265.5 12283.6 12584.2 10988.0 11159.6 11160.7 11188.6 11275.6 10991.9 11192.4 11319.0 11478.0 11556.0 11273.2 11340.9 11423.2 11554.2 11574.6 8758.4 8979.6 9123.9 9166.2 9375.8 9211.6 9489.6 9498.7 9568.3 9573.4 08:59:45 INFO - PROCESS | 23068 | -------- Summary: end -------- 08:59:45 INFO - PROCESS | 23068 | 08:59:46 INFO - TEST-INFO | 23068: exit 0 08:59:46 INFO - TEST-OK | dromaeo_css | took 1116423ms 08:59:46 INFO - TEST-START | kraken 08:59:46 INFO - operating with platform_type : linux_ 08:59:46 INFO - Initialising browser for kraken test... 08:59:46 INFO - TEST-INFO | started process 23305 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3Zskk8/profile http://localhost:34776/getInfo.html) 08:59:50 INFO - PROCESS | 23305 | 08:59:50 INFO - PROCESS | 23305 | (process:23373): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:59:51 INFO - PROCESS | 23305 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 08:59:51 INFO - PROCESS | 23305 | __metrics Screen width/height:1600/1200 08:59:51 INFO - PROCESS | 23305 | colorDepth:24 08:59:51 INFO - PROCESS | 23305 | Browser inner width/height: 1024/697 08:59:51 INFO - PROCESS | 23305 | __metrics 08:59:52 ERROR - PROCESS | 23305 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 08:59:53 INFO - TEST-INFO | 23305: exit 0 08:59:53 INFO - Browser initialized. 08:59:53 INFO - Running cycle 1/1 for kraken test... 08:59:53 INFO - TEST-INFO | started process 23424 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3Zskk8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:59:55 INFO - PROCESS | 23424 | 08:59:55 INFO - PROCESS | 23424 | (process:23484): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:00:05 INFO - PROCESS | 23424 | RSS: Main: 164167680 09:00:05 INFO - PROCESS | 23424 | 09:00:08 INFO - PROCESS | 23424 | Cycle 1(1): loaded http://localhost:34776/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34776/tests/kraken/driver.html?testName=audio-beat-detection) 09:00:09 INFO - PROCESS | 23424 | RSS: Main: 168583168 09:00:09 INFO - PROCESS | 23424 | 09:00:11 INFO - PROCESS | 23424 | Cycle 1(1): loaded http://localhost:34776/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34776/tests/kraken/driver.html?testName=audio-dft) 09:00:12 INFO - PROCESS | 23424 | RSS: Main: 172277760 09:00:12 INFO - PROCESS | 23424 | 09:00:15 INFO - PROCESS | 23424 | Cycle 1(1): loaded http://localhost:34776/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34776/tests/kraken/driver.html?testName=audio-fft) 09:00:16 INFO - PROCESS | 23424 | RSS: Main: 163442688 09:00:16 INFO - PROCESS | 23424 | 09:00:18 INFO - PROCESS | 23424 | Cycle 1(1): loaded http://localhost:34776/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34776/tests/kraken/driver.html?testName=audio-oscillator) 09:00:18 INFO - PROCESS | 23424 | RSS: Main: 163774464 09:00:18 INFO - PROCESS | 23424 | 09:00:21 INFO - PROCESS | 23424 | Cycle 1(1): loaded http://localhost:34776/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34776/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:00:21 INFO - PROCESS | 23424 | RSS: Main: 164270080 09:00:21 INFO - PROCESS | 23424 | 09:00:25 INFO - PROCESS | 23424 | Cycle 1(1): loaded http://localhost:34776/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34776/tests/kraken/driver.html?testName=imaging-darkroom) 09:00:25 INFO - PROCESS | 23424 | RSS: Main: 164491264 09:00:25 INFO - PROCESS | 23424 | 09:00:29 INFO - PROCESS | 23424 | Cycle 1(1): loaded http://localhost:34776/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34776/tests/kraken/driver.html?testName=imaging-desaturate) 09:00:29 INFO - PROCESS | 23424 | RSS: Main: 163852288 09:00:29 INFO - PROCESS | 23424 | 09:00:32 INFO - PROCESS | 23424 | Cycle 1(1): loaded http://localhost:34776/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34776/tests/kraken/driver.html?testName=json-parse-financial) 09:00:33 INFO - PROCESS | 23424 | RSS: Main: 164683776 09:00:33 INFO - PROCESS | 23424 | 09:00:35 INFO - PROCESS | 23424 | Cycle 1(1): loaded http://localhost:34776/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34776/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:00:35 INFO - PROCESS | 23424 | RSS: Main: 164982784 09:00:35 INFO - PROCESS | 23424 | 09:00:37 INFO - PROCESS | 23424 | Cycle 1(1): loaded http://localhost:34776/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34776/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:00:38 INFO - PROCESS | 23424 | RSS: Main: 164876288 09:00:38 INFO - PROCESS | 23424 | 09:00:40 INFO - PROCESS | 23424 | Cycle 1(1): loaded http://localhost:34776/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34776/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:00:41 INFO - PROCESS | 23424 | RSS: Main: 165093376 09:00:41 INFO - PROCESS | 23424 | 09:00:44 INFO - PROCESS | 23424 | Cycle 1(1): loaded http://localhost:34776/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34776/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:00:44 INFO - PROCESS | 23424 | RSS: Main: 165183488 09:00:44 INFO - PROCESS | 23424 | 09:00:47 INFO - PROCESS | 23424 | Cycle 1(1): loaded http://localhost:34776/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34776/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:00:48 INFO - PROCESS | 23424 | RSS: Main: 164835328 09:00:48 INFO - PROCESS | 23424 | 09:00:50 INFO - PROCESS | 23424 | Cycle 1(1): loaded http://localhost:34776/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34776/tests/kraken/driver.html?testName=ai-astar) 09:00:50 INFO - PROCESS | 23424 | RSS: Main: 166821888 09:00:50 INFO - PROCESS | 23424 | 09:00:50 INFO - PROCESS | 23424 | __start_tp_report 09:00:50 INFO - PROCESS | 23424 | _x_x_mozilla_page_load 09:00:50 INFO - PROCESS | 23424 | _x_x_mozilla_page_load_details 09:00:50 INFO - PROCESS | 23424 | |i|pagename|runs| 09:00:50 INFO - PROCESS | 23424 | |0;ai-astar;115;108;113;113;114;126;113;112;112;112 09:00:50 INFO - PROCESS | 23424 | |1;audio-beat-detection;160;133;158;184;144;173;162;134;186;140 09:00:50 INFO - PROCESS | 23424 | |2;audio-dft;161;164;166;177;164;162;161;164;166;163 09:00:50 INFO - PROCESS | 23424 | |3;audio-fft;78;77;75;160;79;75;77;74;154;74 09:00:50 INFO - PROCESS | 23424 | |4;audio-oscillator;95;96;148;94;99;94;136;95;94;145 09:00:50 INFO - PROCESS | 23424 | |5;imaging-gaussian-blur;117;117;117;118;118;117;118;117;118;117 09:00:50 INFO - PROCESS | 23424 | |6;imaging-darkroom;147;147;147;148;148;154;147;148;148;148 09:00:50 INFO - PROCESS | 23424 | |7;imaging-desaturate;96;96;97;95;96;96;95;95;96;96 09:00:50 INFO - PROCESS | 23424 | |8;json-parse-financial;67;67;69;68;68;68;67;94;71;71 09:00:50 INFO - PROCESS | 23424 | |9;json-stringify-tinderbox;67;67;65;66;65;66;65;66;64;65 09:00:50 INFO - PROCESS | 23424 | |10;stanford-crypto-aes;84;90;83;86;87;86;87;86;88;86 09:00:50 INFO - PROCESS | 23424 | |11;stanford-crypto-ccm;139;142;142;137;138;141;138;140;219;140 09:00:50 INFO - PROCESS | 23424 | |12;stanford-crypto-pbkdf2;172;173;171;174;171;175;180;170;169;173 09:00:50 INFO - PROCESS | 23424 | |13;stanford-crypto-sha256-iterative;72;73;72;73;72;70;71;71;76;74 09:00:50 INFO - PROCESS | 23424 | __end_tp_report 09:00:50 INFO - PROCESS | 23424 | __start_cc_report 09:00:50 INFO - PROCESS | 23424 | _x_x_mozilla_cycle_collect,914 09:00:50 INFO - PROCESS | 23424 | __end_cc_report 09:00:50 INFO - PROCESS | 23424 | __startTimestamp1460649650372__endTimestamp 09:00:50 INFO - PROCESS | 23424 | 09:00:50 INFO - PROCESS | 23424 | ------- Summary: start ------- 09:00:50 INFO - PROCESS | 23424 | Number of tests: 14 09:00:50 INFO - PROCESS | 23424 | 09:00:50 INFO - PROCESS | 23424 | [#0] ai-astar Cycles:10 Average:113.80 Median:113.00 stddev:4.66 (4.1%) stddev-sans-first:4.92 09:00:50 INFO - PROCESS | 23424 | Values: 115.0 108.0 113.0 113.0 114.0 126.0 113.0 112.0 112.0 112.0 09:00:50 INFO - PROCESS | 23424 | 09:00:50 INFO - PROCESS | 23424 | [#1] audio-beat-detection Cycles:10 Average:157.40 Median:161.00 stddev:19.50 (12.1%) stddev-sans-first:20.66 09:00:50 INFO - PROCESS | 23424 | Values: 160.0 133.0 158.0 184.0 144.0 173.0 162.0 134.0 186.0 140.0 09:00:50 INFO - PROCESS | 23424 | 09:00:50 INFO - PROCESS | 23424 | [#2] audio-dft Cycles:10 Average:164.80 Median:164.00 stddev:4.64 (2.8%) stddev-sans-first:4.71 09:00:50 INFO - PROCESS | 23424 | Values: 161.0 164.0 166.0 177.0 164.0 162.0 161.0 164.0 166.0 163.0 09:00:50 INFO - PROCESS | 23424 | 09:00:50 INFO - PROCESS | 23424 | [#3] audio-fft Cycles:10 Average:92.30 Median:76.00 stddev:34.17 (45.0%) stddev-sans-first:35.85 09:00:50 INFO - PROCESS | 23424 | Values: 78.0 77.0 75.0 160.0 79.0 75.0 77.0 74.0 154.0 74.0 09:00:50 INFO - PROCESS | 23424 | 09:00:50 INFO - PROCESS | 23424 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:94.50 stddev:23.28 (24.6%) stddev-sans-first:24.09 09:00:50 INFO - PROCESS | 23424 | Values: 95.0 96.0 148.0 94.0 99.0 94.0 136.0 95.0 94.0 145.0 09:00:50 INFO - PROCESS | 23424 | 09:00:50 INFO - PROCESS | 23424 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 09:00:50 INFO - PROCESS | 23424 | Values: 117.0 117.0 117.0 118.0 118.0 117.0 118.0 117.0 118.0 117.0 09:00:50 INFO - PROCESS | 23424 | 09:00:50 INFO - PROCESS | 23424 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:2.10 (1.4%) stddev-sans-first:2.18 09:00:50 INFO - PROCESS | 23424 | Values: 147.0 147.0 147.0 148.0 148.0 154.0 147.0 148.0 148.0 148.0 09:00:50 INFO - PROCESS | 23424 | 09:00:50 INFO - PROCESS | 23424 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 09:00:50 INFO - PROCESS | 23424 | Values: 96.0 96.0 97.0 95.0 96.0 96.0 95.0 95.0 96.0 96.0 09:00:50 INFO - PROCESS | 23424 | 09:00:50 INFO - PROCESS | 23424 | [#8] json-parse-financial Cycles:10 Average:71.00 Median:68.50 stddev:8.22 (12.0%) stddev-sans-first:8.59 09:00:50 INFO - PROCESS | 23424 | Values: 67.0 67.0 69.0 68.0 68.0 68.0 67.0 94.0 71.0 71.0 09:00:50 INFO - PROCESS | 23424 | 09:00:50 INFO - PROCESS | 23424 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.97 (1.5%) stddev-sans-first:0.88 09:00:50 INFO - PROCESS | 23424 | Values: 67.0 67.0 65.0 66.0 65.0 66.0 65.0 66.0 64.0 65.0 09:00:50 INFO - PROCESS | 23424 | 09:00:50 INFO - PROCESS | 23424 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:86.50 stddev:1.95 (2.3%) stddev-sans-first:1.88 09:00:50 INFO - PROCESS | 23424 | Values: 84.0 90.0 83.0 86.0 87.0 86.0 87.0 86.0 88.0 86.0 09:00:50 INFO - PROCESS | 23424 | 09:00:50 INFO - PROCESS | 23424 | [#11] stanford-crypto-ccm Cycles:10 Average:147.60 Median:140.50 stddev:25.14 (17.9%) stddev-sans-first:26.48 09:00:50 INFO - PROCESS | 23424 | Values: 139.0 142.0 142.0 137.0 138.0 141.0 138.0 140.0 219.0 140.0 09:00:50 INFO - PROCESS | 23424 | 09:00:50 INFO - PROCESS | 23424 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.80 Median:173.00 stddev:3.12 (1.8%) stddev-sans-first:3.30 09:00:50 INFO - PROCESS | 23424 | Values: 172.0 173.0 171.0 174.0 171.0 175.0 180.0 170.0 169.0 173.0 09:00:50 INFO - PROCESS | 23424 | 09:00:50 INFO - PROCESS | 23424 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.40 Median:72.50 stddev:1.71 (2.4%) stddev-sans-first:1.81 09:00:50 INFO - PROCESS | 23424 | Values: 72.0 73.0 72.0 73.0 72.0 70.0 71.0 71.0 76.0 74.0 09:00:50 INFO - PROCESS | 23424 | -------- Summary: end -------- 09:00:50 INFO - PROCESS | 23424 | 09:00:51 INFO - TEST-INFO | 23424: exit 0 09:00:51 INFO - TEST-OK | kraken | took 65146ms 09:00:51 INFO - SUITE-END | took 1181s 09:00:52 INFO - Completed test suite (00:19:41) 09:00:52 INFO - javascript benchmark 09:00:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2651.1913866270784, 2722.7005029446764, 2734.6171535984954, 2749.134022782823, 2754.7520723134926, 4834.734089625069, 4856.247281671338, 4858.246971719389, 4868.975655121724, 4928.852134435972, 4740.336352910595, 4813.157697402958, 4883.731394773286, 4893.266010098479, 4911.0, 4405.889852753683, 4432.711873728197, 4489.169503641837, 4491.191585514606, 4526.841560545382, 673.0867224707528, 4336.3712261722185, 4340.8697739067875, 4385.7149285296355, 4432.534583868695, 4447.888802779924, 4486.0, 4489.551044895485, 4512.345709872083, 4553.795079221443, 4496.527864574238, 4507.143642707875, 4515.458145022585, 4524.298733696282, 4554.0, 4321.459817522809, 4402.185595664812, 4433.113377324548, 4437.711548749321, 4473.127740090684, 4701.294805779161, 4735.597474214662, 4759.976200119012, 4765.618750499986, 4838.056578967103, 5178.197379406198, 5216.817411390621, 5239.711815850127, 5257.0, 5326.547243484309, 5210.192420174879, 5214.556762675177, 5224.190250511177, 5237.869053273661, 5276.788928442896, 4803.663743537989, 4849.612031037508, 4851.0, 4868.805247790084, 4904.117258893433, 5126.38483381989, 5310.070737620901, 5330.733463326818, 5406.972965135149, 5457.727113644302, 5186.81846135391, 5206.479352064839, 5214.426413094557, 5215.504527069922, 5222.451642577475, 5261.921071183935, 5298.523132917979, 5306.7611957462, 5309.973450132725, 5347.0909945309395, 5057.8229761958155, 5081.466446023188, 5130.97434512825, 5134.743262836918, 5190.8183213587345, 5135.974320128375, 5152.948470515322, 5164.14791559396, 5189.922151167735, 5196.246544251062, 4430.269005614102, 4441.911161776811, 4457.955420445819, 4459.44256967879, 4495.393121928563, 3743.494628225155, 3831.7892515911894, 3880.553736320303, 3899.3566061600086, 3952.802359882052, 4372.650187984954, 4430.246858034142, 4437.090396468716, 4463.152001119777, 4557.840475583405, 5198.0, 5200.401953775364, 5238.161894097002, 5255.474452554714, 5268.1834315681135, 4380.912381752347, 4482.708623939434, 4483.08096840147, 4516.006478574708, 4524.185646583646, 4762.714237145782, 4786.329913812069, 4786.44955830077, 4794.304825800309, 4826.0, 4957.975210123926, 4961.50384961501, 4970.105381031449, 4970.204767237225, 4975.253711943165, 5032.471590483093, 5293.5765138789575, 5301.787928482971, 5366.382865970463, 5375.032494150934, 4934.679245849008, 4956.727379994135, 4958.206686930074, 4960.379952505937, 4998.475160108136, 5194.714290713896, 5224.869378265574, 5227.92158117621, 5232.764525596282, 5271.20931860224, 5057.974710126426, 5234.607404444758, 5294.735263236746, 5306.044911915892, 5320.308359913187, 5078.136716758087, 5102.897942041064, 5103.87240318995, 5104.668196567211, 5122.103631864335, 5114.5652619527755, 5115.514026167508, 5117.667351622133, 5120.923186152137, 5122.231665250242, 4903.04390643821, 4995.450500444876, 5006.69959802413, 5018.0, 5019.3976722793495, 5005.899882002267, 5017.799288028584, 5021.171506701354, 5022.924656130088, 5056.241563765465, 4839.346688197048, 4889.706617602955, 4896.510348965075, 4912.287718280901, 4931.06309801151], "value": 4758.3915797089685, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.2821473158551, 581.3837332427624, 589.8171566814287, 617.8939697940685, 632.9461446691259, 33314.0, 34260.48609270863, 34285.65714342856, 34314.65685343146, 34399.65600343996, 35340.64659353406, 35557.46663800045, 35703.28593428136, 35778.284434311296, 35781.10547236314, 7567.735129270491, 7673.2326767323375, 7697.653605587762, 7703.922960770405, 7746.341560967325, 7643.961780191091, 7831.177726338738, 7854.057513098408, 7872.960635196845, 7900.051993760757, 7846.0, 7869.921300787005, 7924.128345881977, 7933.642986065641, 7984.560849153294, 7838.843223135534, 7847.6468558914985, 7915.722949696762, 7919.168487308807, 7923.049234091945, 7765.883511747328, 7832.882506762403, 7858.882116768253, 7872.5042241974415, 7892.763217103496, 30006.399872002658, 35363.0, 35865.10337241564, 35921.0, 36008.81995590031, 3004.684508126637, 3065.984670076635, 3096.0, 3133.7649676274373, 3526.788392696421, 27649.447011059867, 28151.859240703667, 28457.146285611463, 28496.85751571229, 28717.712822871712, 3276.344731053775, 3306.189983454069, 3317.1872891141584, 3329.400707872582, 3334.0331303921835, 195607.0, 201393.0, 201631.93472261092, 201763.0, 203516.0, 58836.411635883094, 59945.70027149836, 60050.39949600448, 60064.0, 60187.09719354213, 62043.0, 67056.66471667611, 68044.6597767018, 68461.65769171221, 68717.65641171862, 14897.627559310888, 15138.545843624708, 15146.848531514765, 15152.621184470476, 15209.6197595061, 11132.220744547965, 11132.721681958015, 11274.718132046764, 11287.49206285719, 11291.3789741565, 19307.06929307058, 19693.803061969196, 19742.0, 19867.403977880687, 19911.800881991283, 7442.292982166686, 7741.4968027079185, 7825.843483130306, 7899.960500197462, 7920.366370690331, 854.478767951549, 872.1627237851607, 907.274180655473, 975.2977855943709, 1064.3081996702206, 26285.605715914277, 26328.736712632628, 26527.867360663073, 26808.0, 26876.32809179747, 1024.3853687787416, 1045.816982028142, 1060.4432672846817, 1099.983500247497, 1145.135422755814, 14241.572752817432, 14307.284635768377, 14318.212498312485, 14477.131372117707, 14604.561863144123, 347953.0, 352764.0, 354773.0, 356102.0, 356104.0, 49463.505364946606, 50784.74607626938, 50809.74595127074, 50992.23511647328, 50994.49005509972, 1236.221180656163, 1240.7394447166196, 1250.6748245456247, 1269.3082270162784, 1280.807878818166, 26348.20955371342, 27253.0, 27288.317792054564, 27680.723192767815, 27809.44381112407, 40481.0, 41201.79399102985, 41213.0, 41505.79247103745, 41535.7923210382, 318466.0, 318707.0, 321996.0, 322643.0, 323044.0, 25994.87002564975, 26117.347066323495, 26957.0, 26962.32594185161, 27058.45883082288, 44274.55725442704, 44732.32901506415, 44751.32873006973, 44792.328115078955, 44826.0, 36753.0, 37484.625153749206, 37487.25025499529, 38168.236635266585, 38348.2330353397, 36999.445008325434, 37168.628313716516, 37625.4356184652, 37689.62310376861, 37881.24237515289, 33674.158146046546, 36824.0, 37033.0, 37114.814425927696, 38159.0, 29170.611154847065, 32776.34447311088, 33038.0, 33309.83345083259, 33342.83328583342, 25173.0, 25360.873195633903, 25402.491950160525, 25404.364890877136, 25625.743742562336], "value": 17622.495148748745, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.72070505710593, 366.8055930356911, 389.99415008774855, 391.3386377022831, 396.6450027225631, 15706.371745130182, 16059.678806423864, 16855.578610534743, 16868.0, 16970.15149242536, 10373.688789336313, 10377.896221037807, 10399.53202105905, 10400.583976640944, 10436.06075453209, 4531.4335708036415, 4666.346711460398, 4744.620430365562, 5039.370078740158, 5157.510036546522, 3403.149212696826, 5135.768890399922, 5400.486953739408, 5422.078246698071, 5438.021156191884, 5361.249425080492, 5367.570594352443, 5371.194320851864, 5372.086745253317, 5401.837944861641, 5136.922946155811, 5365.919511207296, 5374.731263436852, 5390.86791773728, 5403.78384864605, 5189.818356357547, 5206.193040078794, 5218.895622087575, 5223.582113430916, 5249.212618107276, 12411.379431028503, 12626.68433289166, 12751.61745147647, 12770.68073298175, 12790.808137877939, 1722.6985277576373, 1985.4043786864027, 2097.119209931817, 2218.1718309155794, 2232.2633530934913, 9169.587368568364, 9282.860757088649, 9536.094071063239, 10244.487775611264, 13062.608121756362, 1629.0714292853079, 1662.8669706423457, 1765.4085881229676, 1824.3797108982876, 1829.8902065875957, 66551.334486655, 69026.0, 69489.0, 70306.0, 71361.0, 9724.270679699051, 9857.30998830075, 9870.309078364446, 9917.75205619851, 10449.477526123663, 14136.15183089018, 14214.715705686036, 14275.428982840778, 14307.427702891975, 14344.426222950966, 6803.455723542104, 6826.649134341438, 7131.750388736473, 7159.854423292249, 7159.964200178966, 6495.220573531112, 6506.772262970773, 6583.242927063353, 6597.406233439014, 6683.565568238049, 4089.9795501022304, 4322.524522302544, 4361.847335343247, 4399.36209249657, 4568.0, 1646.5801220688647, 1711.238498867992, 1720.4408567215705, 1920.4060629677335, 1933.680942644476, 898.9460632362079, 973.4451362723321, 977.5112443778111, 1018.0989824005808, 1026.1226651213256, 15691.450799221973, 16239.106849123174, 16390.0, 16475.83524164767, 16667.0, 888.9244414224734, 891.9598618062203, 907.6278725722422, 916.6883259691737, 929.2426672262085, 8882.557172246497, 9244.768880778034, 9247.39891907024, 9413.717588472357, 9425.952870235606, 362543.0, 363899.0, 370158.0, 371337.0, 378337.0, 44900.55099448964, 71371.643141785, 73280.0, 73424.63287683527, 75370.0, 938.4369378372921, 954.0, 956.8851737791509, 961.6730311694058, 979.9804003919882, 14526.20105894186, 14590.489332873298, 14673.119612823264, 14802.111873287637, 14817.407303708162, 31301.06096817099, 32429.18927026843, 32892.34215315728, 33290.83482078116, 33459.665403346626, 45119.32321015253, 46180.307295389925, 46195.3070703933, 46430.0, 46524.53475465202, 4391.8682439526865, 4482.462104547475, 6994.440444764305, 7197.020819274741, 7369.299916507923, 8742.56287185651, 10664.093552048163, 11089.112870970464, 11338.206325557132, 11706.648800535997, 9777.804443911224, 10012.69961901144, 10080.899191007997, 10284.2801003932, 10333.173346132142, 9402.717918462457, 9559.952200238955, 9776.413415195111, 9869.654562090293, 9983.251256155672, 9959.950200248952, 9980.850287245843, 10102.646407375707, 10167.644132455625, 10465.476726163814, 6640.335966403514, 6986.056882320821, 7105.2894710528535, 7174.605396703231, 7466.738664146729, 4956.950430495793, 6647.803395388876, 7712.652930618024, 8982.505962172143, 10268.64059757905], "value": 7735.529031025341, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1440.2294772296823, 1494.7907292978982, 1599.6560739441018, 1767.187093936789, 1774.8136445673197, 6982.546134501254, 7658.195889431613, 7794.571298578576, 7911.208879112086, 7932.206779322065, 7823.569703666296, 7888.171741967097, 7915.683372665101, 7938.2061793820585, 7959.124496305416, 2242.6972358731527, 2256.537409830989, 2260.2880092770806, 2267.1498188179435, 2269.500709843832, 2148.34475484977, 2175.0, 2182.563487302538, 2200.5048864005553, 2205.195103787114, 2153.0849389009686, 2185.344396680989, 2196.3410976707005, 2202.317281642696, 2205.0077465140753, 2085.259732794859, 2092.0, 2098.171222367164, 2099.3177217404404, 2108.599366120432, 2183.443221978401, 2196.615592271362, 2217.2128894242474, 2218.2457964292216, 2218.633925402323, 8009.599520023976, 8027.558484283362, 8030.07654119772, 8059.95970020152, 8118.309943654737, 4524.954750452519, 4640.09518143962, 4641.466231383401, 4657.068586282723, 4662.230731929261, 2904.4626744052207, 2911.6315331794235, 2976.4047190561973, 2989.7010298970145, 2996.3258266889993, 891.892972843263, 921.5208091792231, 927.5501381829807, 935.9625614975461, 943.1134733350628, 10603.469826508644, 10643.680689579325, 10788.622398216025, 10807.351558906412, 10838.0, 4372.912541749147, 4391.451068616423, 4530.161920044802, 4532.70537415067, 4536.138133754576, 9201.17189452939, 9208.493532855624, 9212.170904618617, 9227.723168304961, 9231.215346695606, 4716.457607375196, 4719.3628860103445, 4724.2205036169335, 4736.478987311393, 4739.881502962385, 3747.231817477465, 4275.893102672396, 4298.0, 4324.762138082436, 4449.043455657049, 3725.701943844486, 3730.1980074283615, 3758.830852611639, 3821.560520540118, 3835.175437280998, 1237.3194742891553, 1243.278898239019, 1259.8551166615773, 1273.3505911984955, 1274.8278982337265, 772.4824367673672, 828.846663367279, 841.9727931923044, 858.2704701004096, 887.6759982606432, 5496.80761173357, 5533.474319939599, 5644.435556444323, 5646.237757902631, 5669.518090962232, 912.4114945859883, 916.1251005289932, 920.052346083535, 952.5713428956997, 970.1898914406408, 3477.8608855646, 3598.946015809765, 3662.8351724171944, 3664.7984360859878, 3683.4106542953, 9315.301352398597, 9570.99504552012, 9644.565994530263, 9668.854967175497, 9669.323147379757, 9300.906990930003, 9538.189253913495, 9727.416355018722, 9865.556049977768, 9960.103590676874, 7245.673944672502, 7279.6360181990685, 7291.234420385889, 7319.377852882458, 7339.779806605917, 5301.628885978099, 5506.64206826555, 5608.6073974823, 5631.662100273997, 5676.318841739017, 8587.22714955657, 8837.160469755363, 8846.424982376126, 8861.778455538662, 8870.86693699582, 8576.65693372283, 8911.866322005046, 8966.641334346554, 9019.052999434965, 9021.503817290111, 6037.15479832815, 6595.835104122435, 6706.83232919181, 6739.123913891162, 6997.195322537973, 7556.206598307099, 7565.6973721050545, 7573.2805383488485, 7577.318041376303, 7640.235976402315, 6674.699638516376, 6917.619530925847, 6918.308169183041, 7018.929810701828, 7021.719131234693, 6853.965730171317, 6890.44876409876, 6897.7585784497305, 6909.343612356818, 6969.6515174242095, 6523.347665233438, 6546.345365463606, 6577.901331480128, 6587.934120658732, 6701.731930722716, 4622.399088118523, 4632.444106707082, 4665.953340466552, 4666.953330466652, 4681.789319480564, 4580.083983203306, 4629.4676112247525, 4673.345731597511, 4704.29435584665, 4720.787564559671], "value": 4222.629303781348, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.598356153439, 309.1899224033034, 316.7640108119451, 317.4793338924163, 324.72722912753284, 5187.896242075156, 5244.292020577221, 5321.3348331458565, 5344.4922732340465, 5369.865753356163, 5317.707526086064, 5320.680759154454, 5325.973370133153, 5342.439043900383, 5343.118385466393, 4203.991042149877, 4206.768627725482, 4207.05341298207, 4208.368744688306, 4213.7893105344765, 4122.567130451304, 4151.692216951666, 4198.97900510497, 4230.97884510577, 4232.49210094789, 4130.876073717778, 4139.317012692902, 4158.8336466541305, 4164.958350416502, 4174.666026717855, 4154.563770804068, 4180.853670121562, 4183.309753890604, 4190.308599081148, 4205.495340559122, 3703.4259689748133, 3713.294474049922, 3715.368387374153, 3716.7026637869176, 3725.3480640887738, 4931.3835770528685, 5053.191489361684, 5098.818968445876, 5101.540861322499, 5116.69299842007, 4803.78382972767, 4818.10864989978, 4824.083424149436, 4824.831130910401, 4828.661993660445, 5556.277683901108, 5638.323401191842, 5643.68959707216, 5657.405972372882, 5672.631278966854, 4036.777977211252, 4046.615571520701, 4050.711348088321, 4060.187962407501, 4067.3288907330257, 5862.325832529228, 5877.118432235199, 5899.085641725539, 5903.763849446017, 5918.526517878559, 4165.8958526037095, 4200.558941311179, 4202.663786897041, 4208.726432781859, 4214.7355793261895, 4095.89760255996, 4190.832366705297, 4226.809793559297, 4227.2179646764835, 4248.723832950848, 4760.238361862085, 4785.856424307276, 4816.975915120472, 4825.420949486084, 4850.272459131159, 5373.462653734673, 5718.228039214653, 5732.856678582985, 5736.6844823534275, 5752.964466396089, 1398.6992097349562, 1470.4926800253895, 1472.6465648244343, 1475.9852401476062, 1481.9110853348618, 975.7267964969819, 981.6466072213997, 1001.3191030099603, 1011.4133802394593, 1016.070295679445, 4772.331873537708, 4822.903541929142, 4840.136547429265, 4843.0, 4848.781804818792, 5743.655380677173, 5745.511631511368, 5787.71061446926, 5787.8553036174435, 5792.422372044484, 4653.86038418848, 4809.9038019240115, 4821.325014497973, 4826.541478559531, 4906.411230652273, 3153.4323821711855, 3158.6683398243313, 3164.351307981858, 3165.1770539659856, 3171.302313491028, 5398.541124004425, 5476.945230547723, 5478.506934375925, 5480.26016487777, 5483.616146869681, 5903.586748927534, 6047.667378294236, 6056.545759068, 6059.6364218147055, 6063.211782468251, 5427.755750991136, 5469.371022332482, 5471.616986810965, 5487.862803429866, 5500.4499550044675, 5650.85872853182, 5859.472647461749, 5867.354590995073, 5885.646861188342, 5898.203742494708, 5698.1452782083015, 5739.512141467855, 5751.5398768099285, 5754.396482813816, 5801.5938884279385, 5417.241586178017, 5418.783248670009, 5471.0, 5483.643563168382, 5494.2857428534035, 3986.940195897122, 4051.47330846988, 4054.0675644601315, 4080.6123418275215, 4087.325591277525, 5540.695261760642, 5664.915026274527, 5809.796657116981, 5832.504237139721, 5847.853803654943, 5651.4348565143155, 5664.745086471036, 5671.716414179192, 5711.086226203787, 5713.22871412354, 5587.77648894056, 5641.464060914206, 5645.153227015816, 5651.90879374634, 5663.490285874291, 5407.161889907071, 5520.806771762969, 5522.806701765419, 5582.804601838916, 5585.1901474286815, 5663.66018038919, 5688.431156884279, 5699.601027928005, 5705.144228365778, 5714.885702286014, 5394.568434525307, 5511.090670039559, 5520.889582208413, 5520.972395137998, 5554.611177217556], "value": 4249.68990609395, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [696.8745625787358, 776.9533827970322, 781.6443518199218, 782.374100719425, 790.12690976471, 11556.768864622703, 11582.536698532069, 11614.0, 11793.7641247175, 11973.940130299357, 11628.709282267948, 11692.123090768184, 11724.0, 11749.060075193986, 11791.587294444696, 645.1935081148564, 803.3854101612271, 808.1352952341012, 823.7693445835175, 826.0954255090696, 809.3727361294984, 813.1746277528314, 813.3615112136973, 818.2390376949435, 820.2453742556833, 841.20506121715, 842.4103127810527, 845.5772113943028, 847.0978407995465, 849.9842687987857, 834.5201509132243, 838.983220335596, 841.7727213652311, 842.1830824100613, 843.6245870587591, 613.7790395457631, 616.4513582911212, 617.2654541096082, 621.2079598511888, 622.3030206169075, 12513.37433128349, 12581.685457863536, 12583.622491325275, 12590.18163819358, 12593.99248060153, 12945.676358091028, 13023.674408139872, 13052.54316098932, 13244.205347679073, 13263.86736132636, 9592.712218633453, 9996.100350968374, 10021.09810117093, 10131.696049118538, 10268.94865525675, 3316.3533111043357, 3351.262722201112, 3364.8654053838063, 3370.6629337066097, 3401.234722187513, 44528.109437811385, 44601.553984460064, 44642.776786116185, 45395.77302113501, 46122.5387746125, 10027.197824174049, 10194.745131371626, 10279.794404111875, 10412.791744165073, 10432.2697411182, 16998.57503562421, 18053.368132115313, 18097.547561311072, 18219.0, 18429.0, 6976.755813546603, 6977.0, 7010.088688470466, 7031.472639551952, 7154.570725756471, 3830.6020441150426, 3831.214601006787, 3834.405667121601, 3883.203943191639, 3924.4505769192338, 2983.1348908816635, 3029.4849875521213, 3057.8929737459084, 3062.4793785056595, 3074.738647214967, 540.9945900541023, 549.2502733768378, 558.6564262978239, 561.2563353556473, 564.3735453646449, 542.5252903709254, 568.3520786303617, 573.4924591736343, 641.416311156845, 650.1970066967292, 7418.146913104954, 7475.401967842559, 7624.923750762421, 7706.152323244439, 7916.920830791619, 511.9078565858107, 561.3712641841082, 617.8702472480829, 619.6746707978348, 639.9712012959428, 3430.433978393587, 3599.3881040223223, 3634.0677696468533, 3649.927001459956, 3670.9632903671154, 46517.0, 48198.27702584464, 48271.75864120727, 48294.5170548297, 49036.50963490391, 38403.0, 40617.0, 41303.38044929328, 41531.79234103871, 44663.33005004928, 39125.0, 39138.412923806165, 39290.2141957165, 39297.607023929966, 39804.208810603595, 7531.0, 7600.923990760021, 8023.4784738991775, 8046.114927358103, 8194.50832950025, 27437.725622743517, 27543.17370478889, 27850.303742406602, 28039.579406308512, 28310.43379132447, 34783.652163478044, 35565.39955701948, 35977.46033809547, 37018.444723328634, 38025.429618555194, 10550.788984220118, 10567.101796347397, 10624.575016999543, 10694.786104277715, 10784.946075269574, 11967.880321197024, 11979.580714674945, 12265.509379624715, 12283.631491055283, 12584.244945303311, 10988.0, 11159.553617855196, 11160.665180044612, 11188.608398706006, 11275.605353812578, 10991.945040274748, 11192.38441885704, 11319.0, 11478.0, 11556.0, 11273.154513411691, 11340.94329528347, 11423.200375973602, 11554.248973816675, 11574.594889179176, 8758.386912916034, 8979.620296033607, 9123.863142052742, 9166.24587875359, 9375.765605859635, 9211.58928838583, 9489.620415183315, 9498.715038548855, 9568.330216884751, 9573.425594464354], "value": 5911.272512709467, "unit": "score"}], "name": "dromaeo_css", "value": 6401.479802319739, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 108.0, 113.0, 113.0, 114.0, 126.0, 113.0, 112.0, 112.0, 112.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 133.0, 158.0, 184.0, 144.0, 173.0, 162.0, 134.0, 186.0, 140.0], "value": 157.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 166.0, 177.0, 164.0, 162.0, 161.0, 164.0, 166.0, 163.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 75.0, 160.0, 79.0, 75.0, 77.0, 74.0, 154.0, 74.0], "value": 92.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 148.0, 94.0, 99.0, 94.0, 136.0, 95.0, 94.0, 145.0], "value": 109.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 148.0, 154.0, 147.0, 148.0, 148.0, 148.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 69.0, 68.0, 68.0, 68.0, 67.0, 94.0, 71.0, 71.0], "value": 71.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 65.0, 66.0, 65.0, 66.0, 65.0, 66.0, 64.0, 65.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 90.0, 83.0, 86.0, 87.0, 86.0, 87.0, 86.0, 88.0, 86.0], "value": 86.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 142.0, 142.0, 137.0, 138.0, 141.0, 138.0, 140.0, 219.0, 140.0], "value": 147.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 173.0, 171.0, 174.0, 171.0, 175.0, 180.0, 170.0, 169.0, 173.0], "value": 172.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 72.0, 73.0, 72.0, 70.0, 71.0, 71.0, 76.0, 74.0], "value": 72.4, "unit": "score"}], "name": "kraken", "value": 1614.9999999999998, "alertThreshold": 2.0}]} 09:00:52 INFO - Return code: 0 09:00:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:00:52 ERROR - # TBPL SUCCESS # 09:00:52 INFO - Running post-action listener: _resource_record_post_action 09:00:52 INFO - Running post-run listener: _resource_record_post_run 09:00:53 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 539172864; Read time: 0; Write time: 1500552 09:00:53 INFO - install - Wall time: 16s; CPU: 19.0%; Read bytes: 0; Write bytes: 218722304; Read time: 0; Write time: 894164 09:00:53 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 295522304; Read time: 0; Write time: 600092 09:00:53 INFO - Running post-run listener: _upload_blobber_files 09:00:53 INFO - Blob upload gear active. 09:00:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:00:53 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 09:00:53 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'] 09:00:53 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 09:00:53 INFO - (blobuploader) - INFO - Open directory for files ... 09:00:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:00:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:00:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:00:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:00:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:00:54 INFO - (blobuploader) - INFO - Done attempting. 09:00:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:00:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:00:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:00:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:00:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:00:55 INFO - (blobuploader) - INFO - Done attempting. 09:00:55 INFO - (blobuploader) - INFO - Iteration through files over. 09:00:55 INFO - Return code: 0 09:00:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:00:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:00:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c39012cd565b0da953801c2deb5136f506afb4ea868988acddc759364aa107ef873d0a8dcdb6467e837ba7aa3db90e3360fbea193640e7ab6feda0a6ba10fa8e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5023c17a68f4ef9efb3141aa4555adc90ce4e9eac9d888550580c5742cbac799f33d2097d5bfd872d1452ce8fa4e32ade575e746452696558503622a63d6ee79"} 09:00:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:00:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:00:55 INFO - Contents: 09:00:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c39012cd565b0da953801c2deb5136f506afb4ea868988acddc759364aa107ef873d0a8dcdb6467e837ba7aa3db90e3360fbea193640e7ab6feda0a6ba10fa8e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5023c17a68f4ef9efb3141aa4555adc90ce4e9eac9d888550580c5742cbac799f33d2097d5bfd872d1452ce8fa4e32ade575e746452696558503622a63d6ee79"} 09:00:55 INFO - Running post-run listener: copy_logs_to_upload_dir 09:00:55 INFO - Copying logs to upload dir... 09:00:55 INFO - mkdir: /builds/slave/test/build/upload/logs 09:00:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.035477 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-04-14 09:00:55.178390) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 09:00:55.182630) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=af724c981e2a0f424dbabf99000001e7-1460647731.195793-1485537721 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/c39012cd565b0da953801c2deb5136f506afb4ea868988acddc759364aa107ef873d0a8dcdb6467e837ba7aa3db90e3360fbea193640e7ab6feda0a6ba10fa8e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5023c17a68f4ef9efb3141aa4555adc90ce4e9eac9d888550580c5742cbac799f33d2097d5bfd872d1452ce8fa4e32ade575e746452696558503622a63d6ee79"} build_url:https://queue.taskcluster.net/v1/task/ax_7_9NxTNqgRtTSrajKlw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011418 build_url: 'https://queue.taskcluster.net/v1/task/ax_7_9NxTNqgRtTSrajKlw/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/c39012cd565b0da953801c2deb5136f506afb4ea868988acddc759364aa107ef873d0a8dcdb6467e837ba7aa3db90e3360fbea193640e7ab6feda0a6ba10fa8e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5023c17a68f4ef9efb3141aa4555adc90ce4e9eac9d888550580c5742cbac799f33d2097d5bfd872d1452ce8fa4e32ade575e746452696558503622a63d6ee79"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 09:00:55.211289) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 09:00:55.211834) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=af724c981e2a0f424dbabf99000001e7-1460647731.195793-1485537721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004626 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 09:00:55.294661) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 09:00:55.295049) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 09:00:55.295512) ========= ========= Total master_lag: 0.16 =========