builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-004 starttime: 1461925534.71 results: success (0) buildid: 20160429004052 builduid: cf844daba61045de8c42c78cef417c6e revision: 6e453fe828bf9054b6db0307ffb034d3acceb9c9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 03:25:34.708364) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 03:25:34.709555) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 03:25:34.710050) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 03:25:34.742943) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 03:25:34.743291) ========= 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=c6927cf182745ad25b1d38b9000001fe-1461923663.377427-506740734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-29 03:25:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-04-29 03:25:35 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.174251 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 03:25:34.931005) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 03:25:34.931371) ========= 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=c6927cf182745ad25b1d38b9000001fe-1461923663.377427-506740734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022592 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 03:25:34.980941) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 03:25:34.981303) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6e453fe828bf9054b6db0307ffb034d3acceb9c9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6e453fe828bf9054b6db0307ffb034d3acceb9c9 --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=c6927cf182745ad25b1d38b9000001fe-1461923663.377427-506740734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-29 03:25:35,138 truncating revision to first 12 chars 2016-04-29 03:25:35,138 Setting DEBUG logging. 2016-04-29 03:25:35,138 attempt 1/10 2016-04-29 03:25:35,139 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/6e453fe828bf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-29 03:25:35,409 unpacking tar archive at: mozilla-aurora-6e453fe828bf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.543392 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 03:25:35.540610) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 03:25:35.541149) ========= script_repo_revision: 6e453fe828bf9054b6db0307ffb034d3acceb9c9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 03:25:35.541762) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 03:25:35.542222) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 03:25:35.552554) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-04-29 03:25:35.553155) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=c6927cf182745ad25b1d38b9000001fe-1461923663.377427-506740734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:25:35 INFO - MultiFileLogger online at 20160429 03:25:35 in /builds/slave/test 03:25:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:25:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:25:35 INFO - {'append_to_log': False, 03:25:35 INFO - 'base_work_dir': '/builds/slave/test', 03:25:35 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:25:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:25:35 INFO - 'branch': 'Mozilla-Aurora', 03:25:35 INFO - 'buildbot_json_path': 'buildprops.json', 03:25:35 INFO - 'config_files': ('talos/linux_config.py',), 03:25:35 INFO - 'default_actions': ('clobber', 03:25:35 INFO - 'read-buildbot-config', 03:25:35 INFO - 'download-and-extract', 03:25:35 INFO - 'populate-webroot', 03:25:35 INFO - 'create-virtualenv', 03:25:35 INFO - 'install', 03:25:35 INFO - 'run-tests'), 03:25:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:25:35 INFO - 'download_minidump_stackwalk': True, 03:25:35 INFO - 'download_symbols': 'ondemand', 03:25:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:25:35 INFO - 'tooltool.py': '/tools/tooltool.py', 03:25:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:25:35 INFO - '/tools/misc-python/virtualenv.py')}, 03:25:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:25:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:25:35 INFO - 'installer_path': 'installer.exe', 03:25:35 INFO - 'log_level': 'info', 03:25:35 INFO - 'log_name': 'talos', 03:25:35 INFO - 'log_to_console': True, 03:25:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:25:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:25:35 INFO - 'opt_config_files': (), 03:25:35 INFO - 'pip_index': False, 03:25:35 INFO - 'sps_profile': False, 03:25:35 INFO - 'sps_profile_interval': 0, 03:25:35 INFO - 'suite': 'dromaeojs-e10s', 03:25:35 INFO - 'system_bits': '32', 03:25:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:25:35 INFO - 'title': 'talos-linux64-ix-004', 03:25:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:25:35 INFO - 'use_talos_json': True, 03:25:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:25:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:25:35 INFO - 'work_dir': 'build'} 03:25:35 INFO - ##### 03:25:35 INFO - ##### Running clobber step. 03:25:35 INFO - ##### 03:25:35 INFO - Running pre-action listener: _resource_record_pre_action 03:25:35 INFO - Running main action method: clobber 03:25:35 INFO - rmtree: /builds/slave/test/build 03:25:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:25:36 INFO - Running post-action listener: _resource_record_post_action 03:25:36 INFO - ##### 03:25:36 INFO - ##### Running read-buildbot-config step. 03:25:36 INFO - ##### 03:25:36 INFO - Running pre-action listener: _resource_record_pre_action 03:25:36 INFO - Running main action method: read_buildbot_config 03:25:36 INFO - Using buildbot properties: 03:25:36 INFO - { 03:25:36 INFO - "project": "", 03:25:36 INFO - "product": "firefox", 03:25:36 INFO - "script_repo_revision": "production", 03:25:36 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:25:36 INFO - "repository": "", 03:25:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:25:36 INFO - "buildid": "20160429004052", 03:25:36 INFO - "stage_platform": "linux64-pgo", 03:25:36 INFO - "basedir": "/builds/slave/test", 03:25:36 INFO - "nightly_build": "True", 03:25:36 INFO - "buildnumber": 269, 03:25:36 INFO - "slavename": "talos-linux64-ix-004", 03:25:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:25:36 INFO - "platform": "ubuntu64_hw", 03:25:36 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:25:36 INFO - "branch": "mozilla-aurora", 03:25:36 INFO - "repo_path": "releases/mozilla-aurora", 03:25:36 INFO - "revision": "6e453fe828bf9054b6db0307ffb034d3acceb9c9", 03:25:36 INFO - "pgo_build": "True", 03:25:36 INFO - "builduid": "cf844daba61045de8c42c78cef417c6e", 03:25:36 INFO - "slavebuilddir": "test" 03:25:36 INFO - } 03:25:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/I8YlWi5_QtuZvkF-Ziocvg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 03:25:36 INFO - Running post-action listener: _resource_record_post_action 03:25:36 INFO - ##### 03:25:36 INFO - ##### Running download-and-extract step. 03:25:36 INFO - ##### 03:25:36 INFO - Running pre-action listener: _resource_record_pre_action 03:25:36 INFO - Running main action method: download_and_extract 03:25:36 INFO - mkdir: /builds/slave/test/build/tests 03:25: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')]} 03:25:36 INFO - https://queue.taskcluster.net/v1/task/I8YlWi5_QtuZvkF-Ziocvg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:25:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I8YlWi5_QtuZvkF-Ziocvg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:25:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I8YlWi5_QtuZvkF-Ziocvg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:25:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I8YlWi5_QtuZvkF-Ziocvg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:25:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I8YlWi5_QtuZvkF-Ziocvg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:25:40 INFO - Downloaded 1361 bytes. 03:25:40 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:25:40 INFO - Using the following test package requirements: 03:25:40 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:25:40 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:40 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:25:40 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:40 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:25:40 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:40 INFO - u'jsshell-linux-x86_64.zip'], 03:25:40 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:40 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:25:40 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:25:40 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:40 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:25:40 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:40 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:25:40 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:40 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:25:40 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:40 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:25:40 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:25:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:40 INFO - https://queue.taskcluster.net/v1/task/I8YlWi5_QtuZvkF-Ziocvg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:25:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I8YlWi5_QtuZvkF-Ziocvg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:25:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I8YlWi5_QtuZvkF-Ziocvg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:25:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I8YlWi5_QtuZvkF-Ziocvg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:25:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I8YlWi5_QtuZvkF-Ziocvg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:25:43 INFO - Downloaded 23820413 bytes. 03:25:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:25:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:25:44 INFO - Return code: 0 03:25:44 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:25:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:44 INFO - https://queue.taskcluster.net/v1/task/I8YlWi5_QtuZvkF-Ziocvg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:25:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I8YlWi5_QtuZvkF-Ziocvg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:25:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I8YlWi5_QtuZvkF-Ziocvg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:25:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I8YlWi5_QtuZvkF-Ziocvg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:25:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I8YlWi5_QtuZvkF-Ziocvg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:25:52 INFO - Downloaded 23820413 bytes. 03:25:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:25:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:25:53 INFO - Return code: 0 03:25:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:53 INFO - https://queue.taskcluster.net/v1/task/I8YlWi5_QtuZvkF-Ziocvg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:25:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I8YlWi5_QtuZvkF-Ziocvg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:25:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I8YlWi5_QtuZvkF-Ziocvg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:25:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I8YlWi5_QtuZvkF-Ziocvg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:25:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I8YlWi5_QtuZvkF-Ziocvg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:25:55 INFO - Downloaded 10840145 bytes. 03:25:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:25:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:25:55 INFO - Return code: 0 03:25:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:55 INFO - https://queue.taskcluster.net/v1/task/I8YlWi5_QtuZvkF-Ziocvg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:25:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I8YlWi5_QtuZvkF-Ziocvg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:25:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I8YlWi5_QtuZvkF-Ziocvg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:25:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I8YlWi5_QtuZvkF-Ziocvg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:25:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I8YlWi5_QtuZvkF-Ziocvg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:25:59 INFO - Downloaded 62660781 bytes. 03:25:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I8YlWi5_QtuZvkF-Ziocvg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:25:59 INFO - mkdir: /builds/slave/test/properties 03:25:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:25:59 INFO - Writing to file /builds/slave/test/properties/build_url 03:25:59 INFO - Contents: 03:25:59 INFO - build_url:https://queue.taskcluster.net/v1/task/I8YlWi5_QtuZvkF-Ziocvg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:26:00 INFO - Running post-action listener: _resource_record_post_action 03:26:00 INFO - Running post-action listener: set_extra_try_arguments 03:26:00 INFO - ##### 03:26:00 INFO - ##### Running populate-webroot step. 03:26:00 INFO - ##### 03:26:00 INFO - Running pre-action listener: _resource_record_pre_action 03:26:00 INFO - Running main action method: populate_webroot 03:26:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:26:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:26:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:26:00 INFO - '--tppagecycles', 03:26:00 INFO - '7'], 03:26:00 INFO - 'tests': ['tsvgm']}}, 03:26:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:26:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:26:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:26:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:26:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:26:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:26:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:00 INFO - 'talos_options': ['--disable-e10s'], 03:26:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:26:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:26:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:00 INFO - 'talos_options': ['--disable-e10s'], 03:26:00 INFO - 'tests': ['damp', 'tps']}, 03:26:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:00 INFO - 'tests': ['damp', 'tps']}, 03:26:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:26:00 INFO - 'tests': ['dromaeo_dom']}, 03:26:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:26:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:26:00 INFO - 'tests': ['a11yr', 03:26:00 INFO - 'ts_paint', 03:26:00 INFO - 'tpaint', 03:26:00 INFO - 'sessionrestore', 03:26:00 INFO - 'sessionrestore_no_auto_restore', 03:26:00 INFO - 'tabpaint']}, 03:26:00 INFO - 'other-e10s': {'tests': ['a11yr', 03:26:00 INFO - 'ts_paint', 03:26:00 INFO - 'tpaint', 03:26:00 INFO - 'sessionrestore', 03:26:00 INFO - 'sessionrestore_no_auto_restore', 03:26:00 INFO - 'tabpaint']}, 03:26:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:26:00 INFO - 'ts_paint', 03:26:00 INFO - 'tpaint', 03:26:00 INFO - 'sessionrestore', 03:26:00 INFO - 'sessionrestore_no_auto_restore', 03:26:00 INFO - 'tabpaint']}, 03:26:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:26:00 INFO - 'ts_paint', 03:26:00 INFO - 'tpaint', 03:26:00 INFO - 'sessionrestore', 03:26:00 INFO - 'sessionrestore_no_auto_restore', 03:26:00 INFO - 'tabpaint']}, 03:26:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:26:00 INFO - 'tests': ['a11yr', 03:26:00 INFO - 'ts_paint', 03:26:00 INFO - 'tpaint', 03:26:00 INFO - 'sessionrestore', 03:26:00 INFO - 'sessionrestore_no_auto_restore', 03:26:00 INFO - 'tabpaint']}, 03:26:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:26:00 INFO - 'tests': ['a11yr', 03:26:00 INFO - 'ts_paint', 03:26:00 INFO - 'tpaint', 03:26:00 INFO - 'sessionrestore', 03:26:00 INFO - 'sessionrestore_no_auto_restore', 03:26:00 INFO - 'tabpaint']}, 03:26:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:26:00 INFO - 'tests': ['tsvgx', 03:26:00 INFO - 'tsvgr_opacity', 03:26:00 INFO - 'tart', 03:26:00 INFO - 'tscrollx', 03:26:00 INFO - 'cart']}, 03:26:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:26:00 INFO - 'tsvgr_opacity', 03:26:00 INFO - 'tart', 03:26:00 INFO - 'tscrollx', 03:26:00 INFO - 'cart']}, 03:26:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:00 INFO - 'talos_options': ['--disable-e10s'], 03:26:00 INFO - 'tests': ['tp5o']}, 03:26:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:00 INFO - 'tests': ['tp5o']}, 03:26:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:00 INFO - 'talos_options': ['--disable-e10s', 03:26:00 INFO - '--xperf_path', 03:26:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:26:00 INFO - 'tests': ['tp5n']}, 03:26:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:00 INFO - 'talos_options': ['--xperf_path', 03:26:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:26:00 INFO - 'tests': ['tp5n']}}, 03:26:00 INFO - 'talos.zip': {'path': '', 03:26:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:26:00 INFO - Running post-action listener: _resource_record_post_action 03:26:00 INFO - ##### 03:26:00 INFO - ##### Running create-virtualenv step. 03:26:00 INFO - ##### 03:26:00 INFO - Running pre-action listener: _resource_record_pre_action 03:26:00 INFO - Running main action method: create_virtualenv 03:26:00 INFO - Creating virtualenv /builds/slave/test/build/venv 03:26:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:26:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:26:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:26:00 INFO - Using real prefix '/usr' 03:26:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:26:00 INFO - Installing distribute.............................................................................................................................................................................................done. 03:26:02 INFO - Installing pip.................done. 03:26:02 INFO - Return code: 0 03:26:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:26:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:02 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 0x7f11eff64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18505a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18df410>, '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 0x18e0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e07a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461923663.377427-506740734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:26:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:26:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:26:02 INFO - Using env: {'DISPLAY': ':0', 03:26:02 INFO - 'HOME': '/home/cltbld', 03:26:02 INFO - 'LANG': 'en_US.UTF-8', 03:26:02 INFO - 'LANGUAGE': 'en_US:en', 03:26:02 INFO - 'LOGNAME': 'cltbld', 03:26:02 INFO - 'MAIL': '/var/mail/cltbld', 03:26:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:02 INFO - 'MOZ_NO_REMOTE': '1', 03:26:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:02 INFO - 'NO_EM_RESTART': '1', 03:26:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:02 INFO - 'PWD': '/builds/slave/test', 03:26:02 INFO - 'SHELL': '/bin/bash', 03:26:02 INFO - 'SHLVL': '1', 03:26:02 INFO - 'TERM': 'linux', 03:26:02 INFO - 'TMOUT': '86400', 03:26:02 INFO - 'USER': 'cltbld', 03:26:02 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461923663.377427-506740734', 03:26:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:02 INFO - '_': '/tools/buildbot/bin/python'} 03:26:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:26:03 INFO - Cleaning up... 03:26:03 INFO - Return code: 0 03:26:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:26:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:03 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 0x7f11eff64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18505a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18df410>, '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 0x18e0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e07a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461923663.377427-506740734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:26:03 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 03:26:03 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 03:26:03 INFO - Using env: {'DISPLAY': ':0', 03:26:03 INFO - 'HOME': '/home/cltbld', 03:26:03 INFO - 'LANG': 'en_US.UTF-8', 03:26:03 INFO - 'LANGUAGE': 'en_US:en', 03:26:03 INFO - 'LOGNAME': 'cltbld', 03:26:03 INFO - 'MAIL': '/var/mail/cltbld', 03:26:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:03 INFO - 'MOZ_NO_REMOTE': '1', 03:26:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:03 INFO - 'NO_EM_RESTART': '1', 03:26:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:03 INFO - 'PWD': '/builds/slave/test', 03:26:03 INFO - 'SHELL': '/bin/bash', 03:26:03 INFO - 'SHLVL': '1', 03:26:03 INFO - 'TERM': 'linux', 03:26:03 INFO - 'TMOUT': '86400', 03:26:03 INFO - 'USER': 'cltbld', 03:26:03 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461923663.377427-506740734', 03:26:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:03 INFO - '_': '/tools/buildbot/bin/python'} 03:26:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:03 INFO - Downloading/unpacking psutil>=0.7.1 03:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:26:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:26:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:26:05 INFO - Installing collected packages: psutil 03:26:05 INFO - Running setup.py install for psutil 03:26:05 INFO - building 'psutil._psutil_linux' extension 03:26:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:26:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:26:05 INFO - building 'psutil._psutil_posix' extension 03:26:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:26:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:26:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:26:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:26:05 INFO - Successfully installed psutil 03:26:05 INFO - Cleaning up... 03:26:05 INFO - Return code: 0 03:26:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:05 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 0x7f11eff64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18505a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18df410>, '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 0x18e0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e07a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461923663.377427-506740734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:26:05 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 03:26:05 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 03:26:05 INFO - Using env: {'DISPLAY': ':0', 03:26:05 INFO - 'HOME': '/home/cltbld', 03:26:05 INFO - 'LANG': 'en_US.UTF-8', 03:26:05 INFO - 'LANGUAGE': 'en_US:en', 03:26:05 INFO - 'LOGNAME': 'cltbld', 03:26:05 INFO - 'MAIL': '/var/mail/cltbld', 03:26:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:05 INFO - 'MOZ_NO_REMOTE': '1', 03:26:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:05 INFO - 'NO_EM_RESTART': '1', 03:26:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:05 INFO - 'PWD': '/builds/slave/test', 03:26:05 INFO - 'SHELL': '/bin/bash', 03:26:05 INFO - 'SHLVL': '1', 03:26:05 INFO - 'TERM': 'linux', 03:26:05 INFO - 'TMOUT': '86400', 03:26:05 INFO - 'USER': 'cltbld', 03:26:05 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461923663.377427-506740734', 03:26:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:05 INFO - '_': '/tools/buildbot/bin/python'} 03:26:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:26:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:26:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:26:08 INFO - Installing collected packages: mozsystemmonitor 03:26:08 INFO - Running setup.py install for mozsystemmonitor 03:26:08 INFO - Successfully installed mozsystemmonitor 03:26:08 INFO - Cleaning up... 03:26:08 INFO - Return code: 0 03:26:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:26: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')]} 03:26:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26: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')]} 03:26:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:08 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 0x7f11eff64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18505a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18df410>, '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 0x18e0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e07a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461923663.377427-506740734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:26:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:26:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:26:08 INFO - Using env: {'DISPLAY': ':0', 03:26:08 INFO - 'HOME': '/home/cltbld', 03:26:08 INFO - 'LANG': 'en_US.UTF-8', 03:26:08 INFO - 'LANGUAGE': 'en_US:en', 03:26:08 INFO - 'LOGNAME': 'cltbld', 03:26:08 INFO - 'MAIL': '/var/mail/cltbld', 03:26:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:08 INFO - 'MOZ_NO_REMOTE': '1', 03:26:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:08 INFO - 'NO_EM_RESTART': '1', 03:26:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:08 INFO - 'PWD': '/builds/slave/test', 03:26:08 INFO - 'SHELL': '/bin/bash', 03:26:08 INFO - 'SHLVL': '1', 03:26:08 INFO - 'TERM': 'linux', 03:26:08 INFO - 'TMOUT': '86400', 03:26:08 INFO - 'USER': 'cltbld', 03:26:08 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461923663.377427-506740734', 03:26:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:08 INFO - '_': '/tools/buildbot/bin/python'} 03:26:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:08 INFO - Downloading/unpacking blobuploader==1.2.4 03:26:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:10 INFO - Downloading blobuploader-1.2.4.tar.gz 03:26:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:26:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:26:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:10 INFO - Downloading docopt-0.6.1.tar.gz 03:26:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:26:11 INFO - Installing collected packages: blobuploader, requests, docopt 03:26:11 INFO - Running setup.py install for blobuploader 03:26:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:26:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:26:11 INFO - Running setup.py install for requests 03:26:11 INFO - Running setup.py install for docopt 03:26:11 INFO - Successfully installed blobuploader requests docopt 03:26:11 INFO - Cleaning up... 03:26:11 INFO - Return code: 0 03:26:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:11 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 0x7f11eff64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18505a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18df410>, '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 0x18e0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e07a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461923663.377427-506740734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:26:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:26:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:26:11 INFO - Using env: {'DISPLAY': ':0', 03:26:11 INFO - 'HOME': '/home/cltbld', 03:26:11 INFO - 'LANG': 'en_US.UTF-8', 03:26:11 INFO - 'LANGUAGE': 'en_US:en', 03:26:11 INFO - 'LOGNAME': 'cltbld', 03:26:11 INFO - 'MAIL': '/var/mail/cltbld', 03:26:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:11 INFO - 'MOZ_NO_REMOTE': '1', 03:26:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:11 INFO - 'NO_EM_RESTART': '1', 03:26:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:11 INFO - 'PWD': '/builds/slave/test', 03:26:11 INFO - 'SHELL': '/bin/bash', 03:26:11 INFO - 'SHLVL': '1', 03:26:11 INFO - 'TERM': 'linux', 03:26:11 INFO - 'TMOUT': '86400', 03:26:11 INFO - 'USER': 'cltbld', 03:26:11 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461923663.377427-506740734', 03:26:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:11 INFO - '_': '/tools/buildbot/bin/python'} 03:26:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:26:11 INFO - Running setup.py (path:/tmp/pip-wpeU1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:11 INFO - Running setup.py (path:/tmp/pip-al2SnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:12 INFO - Running setup.py (path:/tmp/pip-etPwVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:12 INFO - Running setup.py (path:/tmp/pip-W4Cjlt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:12 INFO - Running setup.py (path:/tmp/pip-r7Z5yJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:26:12 INFO - Running setup.py (path:/tmp/pip-9qXKKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:26:12 INFO - Running setup.py (path:/tmp/pip-yhNB3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:26:12 INFO - Running setup.py (path:/tmp/pip-7WYHlz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:12 INFO - Running setup.py (path:/tmp/pip-0KbdcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:12 INFO - Running setup.py (path:/tmp/pip-852MDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:12 INFO - Running setup.py (path:/tmp/pip-XjOE32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:12 INFO - Running setup.py (path:/tmp/pip-uTFes3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:12 INFO - Running setup.py (path:/tmp/pip-qjXDsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:12 INFO - Running setup.py (path:/tmp/pip-bP0iHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:12 INFO - Running setup.py (path:/tmp/pip-shIIAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:12 INFO - Running setup.py (path:/tmp/pip-XZMTAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:13 INFO - Running setup.py (path:/tmp/pip-_mtI1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:26:13 INFO - Running setup.py install for manifestparser 03:26:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:26:13 INFO - Running setup.py install for mozcrash 03:26:13 INFO - Running setup.py install for mozdebug 03:26:13 INFO - Running setup.py install for mozdevice 03:26:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:26:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:26:13 INFO - Running setup.py install for mozfile 03:26:13 INFO - Running setup.py install for mozhttpd 03:26:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:26:13 INFO - Running setup.py install for mozinfo 03:26:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:26:13 INFO - Running setup.py install for mozInstall 03:26:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:26:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:26:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:26:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:26:13 INFO - Running setup.py install for mozleak 03:26:13 INFO - Running setup.py install for mozlog 03:26:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:26:14 INFO - Running setup.py install for moznetwork 03:26:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:26:14 INFO - Running setup.py install for mozprocess 03:26:14 INFO - Running setup.py install for mozprofile 03:26:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:26:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:26:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:26:14 INFO - Running setup.py install for mozrunner 03:26:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:26:14 INFO - Running setup.py install for mozscreenshot 03:26:14 INFO - Running setup.py install for moztest 03:26:14 INFO - Running setup.py install for mozversion 03:26:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:26:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:26:14 INFO - Cleaning up... 03:26:14 INFO - Return code: 0 03:26:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:14 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 0x7f11eff64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18505a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18df410>, '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 0x18e0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e07a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461923663.377427-506740734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:26:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:26:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:26:14 INFO - Using env: {'DISPLAY': ':0', 03:26:14 INFO - 'HOME': '/home/cltbld', 03:26:14 INFO - 'LANG': 'en_US.UTF-8', 03:26:14 INFO - 'LANGUAGE': 'en_US:en', 03:26:14 INFO - 'LOGNAME': 'cltbld', 03:26:14 INFO - 'MAIL': '/var/mail/cltbld', 03:26:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:14 INFO - 'MOZ_NO_REMOTE': '1', 03:26:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:14 INFO - 'NO_EM_RESTART': '1', 03:26:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:14 INFO - 'PWD': '/builds/slave/test', 03:26:14 INFO - 'SHELL': '/bin/bash', 03:26:14 INFO - 'SHLVL': '1', 03:26:14 INFO - 'TERM': 'linux', 03:26:14 INFO - 'TMOUT': '86400', 03:26:14 INFO - 'USER': 'cltbld', 03:26:14 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461923663.377427-506740734', 03:26:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:14 INFO - '_': '/tools/buildbot/bin/python'} 03:26:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:26:15 INFO - Running setup.py (path:/tmp/pip-zoVXUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:15 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:15 INFO - Running setup.py (path:/tmp/pip-3BUwct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:15 INFO - Running setup.py (path:/tmp/pip-CFYcBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:15 INFO - Running setup.py (path:/tmp/pip-7PqXL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:15 INFO - Running setup.py (path:/tmp/pip-EhYuMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:26:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:26:15 INFO - Running setup.py (path:/tmp/pip-6SaVaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:26:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:26:15 INFO - Running setup.py (path:/tmp/pip-Wmjrjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:26:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:26:15 INFO - Running setup.py (path:/tmp/pip-fW57Cy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:15 INFO - Running setup.py (path:/tmp/pip-swF3ga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:15 INFO - Running setup.py (path:/tmp/pip-3y9Lo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:15 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)) 03:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:15 INFO - Running setup.py (path:/tmp/pip-C1QrHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:15 INFO - Running setup.py (path:/tmp/pip-3uxaJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:15 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)) 03:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:15 INFO - Running setup.py (path:/tmp/pip-5QGOBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:16 INFO - Running setup.py (path:/tmp/pip-P4kvFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:16 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)) 03:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:16 INFO - Running setup.py (path:/tmp/pip-6klXyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:16 INFO - Running setup.py (path:/tmp/pip-RUPad2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:16 INFO - Running setup.py (path:/tmp/pip-zmIBhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:26:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:26:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:26:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:26:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:26:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:26:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:18 INFO - Downloading blessings-1.6.tar.gz 03:26:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:26:18 INFO - Installing collected packages: blessings 03:26:18 INFO - Running setup.py install for blessings 03:26:18 INFO - Successfully installed blessings 03:26:18 INFO - Cleaning up... 03:26:18 INFO - Return code: 0 03:26:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:26:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:26:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:26:18 INFO - Reading from file tmpfile_stdout 03:26:18 INFO - Current package versions: 03:26:18 INFO - argparse == 1.2.1 03:26:18 INFO - blessings == 1.6 03:26:18 INFO - blobuploader == 1.2.4 03:26:18 INFO - docopt == 0.6.1 03:26:18 INFO - manifestparser == 1.1 03:26:18 INFO - mozInstall == 1.12 03:26:18 INFO - mozcrash == 0.17 03:26:18 INFO - mozdebug == 0.1 03:26:18 INFO - mozdevice == 0.48 03:26:18 INFO - mozfile == 1.2 03:26:18 INFO - mozhttpd == 0.7 03:26:18 INFO - mozinfo == 0.9 03:26:18 INFO - mozleak == 0.1 03:26:18 INFO - mozlog == 3.1 03:26:18 INFO - moznetwork == 0.27 03:26:18 INFO - mozprocess == 0.22 03:26:18 INFO - mozprofile == 0.28 03:26:18 INFO - mozrunner == 6.11 03:26:18 INFO - mozscreenshot == 0.1 03:26:18 INFO - mozsystemmonitor == 0.0 03:26:18 INFO - moztest == 0.7 03:26:18 INFO - mozversion == 1.4 03:26:18 INFO - psutil == 3.1.1 03:26:18 INFO - requests == 1.2.3 03:26:18 INFO - wsgiref == 0.1.2 03:26:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:18 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 0x7f11eff64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18505a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18df410>, '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 0x18e0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e07a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461923663.377427-506740734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:26:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:26:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:26:18 INFO - Using env: {'DISPLAY': ':0', 03:26:18 INFO - 'HOME': '/home/cltbld', 03:26:18 INFO - 'LANG': 'en_US.UTF-8', 03:26:18 INFO - 'LANGUAGE': 'en_US:en', 03:26:18 INFO - 'LOGNAME': 'cltbld', 03:26:18 INFO - 'MAIL': '/var/mail/cltbld', 03:26:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:18 INFO - 'MOZ_NO_REMOTE': '1', 03:26:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:18 INFO - 'NO_EM_RESTART': '1', 03:26:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:18 INFO - 'PWD': '/builds/slave/test', 03:26:18 INFO - 'SHELL': '/bin/bash', 03:26:18 INFO - 'SHLVL': '1', 03:26:18 INFO - 'TERM': 'linux', 03:26:18 INFO - 'TMOUT': '86400', 03:26:18 INFO - 'USER': 'cltbld', 03:26:18 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461923663.377427-506740734', 03:26:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:18 INFO - '_': '/tools/buildbot/bin/python'} 03:26:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:26:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:26:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:26:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:26:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:26:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:26:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:26:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:26:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:26:18 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:26:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:26:18 INFO - Cleaning up... 03:26:18 INFO - Return code: 0 03:26:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:26:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f11eff64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18505a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18df410>, '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 0x18e0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e07a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461923663.377427-506740734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:26:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:26:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:26:18 INFO - Using env: {'DISPLAY': ':0', 03:26:18 INFO - 'HOME': '/home/cltbld', 03:26:18 INFO - 'LANG': 'en_US.UTF-8', 03:26:18 INFO - 'LANGUAGE': 'en_US:en', 03:26:18 INFO - 'LOGNAME': 'cltbld', 03:26:18 INFO - 'MAIL': '/var/mail/cltbld', 03:26:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:18 INFO - 'MOZ_NO_REMOTE': '1', 03:26:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:18 INFO - 'NO_EM_RESTART': '1', 03:26:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:18 INFO - 'PWD': '/builds/slave/test', 03:26:18 INFO - 'SHELL': '/bin/bash', 03:26:18 INFO - 'SHLVL': '1', 03:26:18 INFO - 'TERM': 'linux', 03:26:18 INFO - 'TMOUT': '86400', 03:26:18 INFO - 'USER': 'cltbld', 03:26:18 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461923663.377427-506740734', 03:26:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:18 INFO - '_': '/tools/buildbot/bin/python'} 03:26:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:19 INFO - Downloading/unpacking jsonschema 03:26:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:26:20 INFO - Downloading/unpacking functools32 (from jsonschema) 03:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:21 INFO - Downloading functools32-3.2.3-2.tar.gz 03:26:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:26:21 INFO - warning: no files found matching '*.txt' 03:26:21 INFO - no previously-included directories found matching 'build' 03:26:21 INFO - no previously-included directories found matching 'dist' 03:26:21 INFO - no previously-included directories found matching '.git*' 03:26:21 INFO - Installing collected packages: jsonschema, functools32 03:26:21 INFO - Running setup.py install for functools32 03:26:21 INFO - warning: no files found matching '*.txt' 03:26:21 INFO - no previously-included directories found matching 'build' 03:26:21 INFO - no previously-included directories found matching 'dist' 03:26:21 INFO - no previously-included directories found matching '.git*' 03:26:21 INFO - Successfully installed jsonschema functools32 03:26:21 INFO - Cleaning up... 03:26:21 INFO - Return code: 0 03:26:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:26:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:21 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 0x7f11eff64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18505a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18df410>, '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 0x18e0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e07a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461923663.377427-506740734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:26:21 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 03:26:21 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 03:26:21 INFO - Using env: {'DISPLAY': ':0', 03:26:21 INFO - 'HOME': '/home/cltbld', 03:26:21 INFO - 'LANG': 'en_US.UTF-8', 03:26:21 INFO - 'LANGUAGE': 'en_US:en', 03:26:21 INFO - 'LOGNAME': 'cltbld', 03:26:21 INFO - 'MAIL': '/var/mail/cltbld', 03:26:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:21 INFO - 'MOZ_NO_REMOTE': '1', 03:26:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:21 INFO - 'NO_EM_RESTART': '1', 03:26:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:21 INFO - 'PWD': '/builds/slave/test', 03:26:21 INFO - 'SHELL': '/bin/bash', 03:26:21 INFO - 'SHLVL': '1', 03:26:21 INFO - 'TERM': 'linux', 03:26:21 INFO - 'TMOUT': '86400', 03:26:21 INFO - 'USER': 'cltbld', 03:26:21 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461923663.377427-506740734', 03:26:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:21 INFO - '_': '/tools/buildbot/bin/python'} 03:26:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:21 INFO - Downloading/unpacking flake8 03:26:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:26:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:26:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:26:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:26:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:26:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:26:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:26:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:26:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:26:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:26:24 INFO - no previously-included directories found matching 'docs/_build' 03:26:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:26:24 INFO - Running setup.py install for pep8 03:26:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:26:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:26:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:26:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:26:24 INFO - no previously-included directories found matching 'docs/_build' 03:26:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:26:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:26:24 INFO - Cleaning up... 03:26:24 INFO - Return code: 0 03:26:24 INFO - Running post-action listener: _resource_record_post_action 03:26:24 INFO - Running post-action listener: _start_resource_monitoring 03:26:24 INFO - Starting resource monitoring. 03:26:24 INFO - ##### 03:26:24 INFO - ##### Running install step. 03:26:24 INFO - ##### 03:26:24 INFO - Running pre-action listener: _resource_record_pre_action 03:26:24 INFO - Running main action method: install 03:26:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:26:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:26:24 INFO - Reading from file tmpfile_stdout 03:26:24 INFO - Detecting whether we're running mozinstall >=1.0... 03:26:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:26:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:26:24 INFO - Reading from file tmpfile_stdout 03:26:24 INFO - Output received: 03:26:24 INFO - Usage: mozinstall [options] installer 03:26:24 INFO - Options: 03:26:24 INFO - -h, --help show this help message and exit 03:26:24 INFO - -d DEST, --destination=DEST 03:26:24 INFO - Directory to install application into. [default: 03:26:24 INFO - "/builds/slave/test"] 03:26:24 INFO - --app=APP Application being installed. [default: firefox] 03:26:24 INFO - mkdir: /builds/slave/test/build/application 03:26:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:26:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:26:40 INFO - Reading from file tmpfile_stdout 03:26:40 INFO - Output received: 03:26:40 INFO - /builds/slave/test/build/application/firefox/firefox 03:26:40 INFO - Running post-action listener: _resource_record_post_action 03:26:40 INFO - ##### 03:26:40 INFO - ##### Running run-tests step. 03:26:40 INFO - ##### 03:26:40 INFO - Running pre-action listener: _resource_record_pre_action 03:26:40 INFO - Running main action method: run_tests 03:26:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:26:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:26:40 INFO - Python 2.7.3 03:26:40 INFO - Return code: 0 03:26:40 INFO - grabbing minidump binary from tooltool 03:26:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:40 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 0x18df410>, '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 0x18e0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e07a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:26:40 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:26:40 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:26:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:26:40 INFO - Return code: 0 03:26:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:26:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:26:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:26:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:26:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:26:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:26:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:26:41 INFO - Return code: 0 03:26:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I8YlWi5_QtuZvkF-Ziocvg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:26:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I8YlWi5_QtuZvkF-Ziocvg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:26:41 INFO - Using env: {'DISPLAY': ':0', 03:26:41 INFO - 'HOME': '/home/cltbld', 03:26:41 INFO - 'LANG': 'en_US.UTF-8', 03:26:41 INFO - 'LANGUAGE': 'en_US:en', 03:26:41 INFO - 'LOGNAME': 'cltbld', 03:26:41 INFO - 'MAIL': '/var/mail/cltbld', 03:26:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:26:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:26:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:41 INFO - 'MOZ_NO_REMOTE': '1', 03:26:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:26:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:41 INFO - 'NO_EM_RESTART': '1', 03:26:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:41 INFO - 'PWD': '/builds/slave/test', 03:26:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:26:41 INFO - 'SHELL': '/bin/bash', 03:26:41 INFO - 'SHLVL': '1', 03:26:41 INFO - 'TERM': 'linux', 03:26:41 INFO - 'TMOUT': '86400', 03:26:41 INFO - 'USER': 'cltbld', 03:26:41 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461923663.377427-506740734', 03:26:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:41 INFO - '_': '/tools/buildbot/bin/python'} 03:26:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I8YlWi5_QtuZvkF-Ziocvg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:26:41 INFO - mozversion application_buildid: 20160429004052 03:26:41 INFO - mozversion application_changeset: 6e453fe828bf9054b6db0307ffb034d3acceb9c9 03:26:41 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:26:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:26:41 INFO - mozversion application_name: Firefox 03:26:41 INFO - mozversion application_remotingname: firefox-dev 03:26:41 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:26:41 INFO - mozversion application_vendor: Mozilla 03:26:41 INFO - mozversion application_version: 48.0a2 03:26:41 INFO - mozversion platform_buildid: 20160429004052 03:26:41 INFO - mozversion platform_changeset: 6e453fe828bf9054b6db0307ffb034d3acceb9c9 03:26:41 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:26:41 INFO - mozversion platform_version: 48.0a2 03:26:41 INFO - using testdate: 1461925601 03:26:41 INFO - actual date: 1461925601 03:26:41 INFO - starting webserver on 'localhost:59099' 03:26:41 INFO - SUITE-START | Running 2 tests 03:26:41 INFO - TEST-START | dromaeo_css 03:26:41 INFO - operating with platform_type : linux_ 03:26:41 INFO - Initialising browser for dromaeo_css test... 03:26:41 INFO - TEST-INFO | started process 4336 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0bXAOH/profile http://localhost:59099/getInfo.html) 03:26:45 INFO - PROCESS | 4336 | 03:26:45 INFO - PROCESS | 4336 | (process:4417): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:26:46 INFO - PROCESS | 4336 | __metrics Screen width/height:1600/1200 03:26:46 INFO - PROCESS | 4336 | colorDepth:24 03:26:46 INFO - PROCESS | 4336 | Browser inner width/height: 1024/697 03:26:46 INFO - PROCESS | 4336 | __metrics 03:26:47 ERROR - PROCESS | 4336 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 03:26:47 INFO - TEST-INFO | 4336: exit 0 03:26:47 INFO - Browser initialized. 03:26:47 INFO - Running cycle 1/1 for dromaeo_css test... 03:26:47 INFO - TEST-INFO | started process 4468 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0bXAOH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:26:49 INFO - PROCESS | 4468 | 03:26:49 INFO - PROCESS | 4468 | (process:4536): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:26:59 INFO - PROCESS | 4468 | RSS: Main: 152653824 03:26:59 INFO - PROCESS | 4468 | 03:27:49 INFO - PROCESS | 4468 | 1461925669220 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:29:56 INFO - PROCESS | 4468 | Cycle 1(1): loaded http://localhost:59099/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59099/tests/dromaeo/cssquery-ext.html) 03:29:57 INFO - PROCESS | 4468 | RSS: Main: 155459584 03:29:57 INFO - PROCESS | 4468 | 03:32:59 INFO - PROCESS | 4468 | Cycle 1(1): loaded http://localhost:59099/tests/dromaeo/cssquery-ext.html (next: http://localhost:59099/tests/dromaeo/cssquery-jquery.html) 03:33:00 INFO - PROCESS | 4468 | RSS: Main: 154337280 03:33:00 INFO - PROCESS | 4468 | 03:36:01 INFO - PROCESS | 4468 | Cycle 1(1): loaded http://localhost:59099/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59099/tests/dromaeo/cssquery-mootools.html) 03:36:02 INFO - PROCESS | 4468 | RSS: Main: 153694208 03:36:02 INFO - PROCESS | 4468 | 03:39:04 INFO - PROCESS | 4468 | Cycle 1(1): loaded http://localhost:59099/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59099/tests/dromaeo/cssquery-prototype.html) 03:39:04 INFO - PROCESS | 4468 | RSS: Main: 153538560 03:39:04 INFO - PROCESS | 4468 | 03:42:07 INFO - PROCESS | 4468 | Cycle 1(1): loaded http://localhost:59099/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59099/tests/dromaeo/cssquery-yui.html) 03:42:07 INFO - PROCESS | 4468 | RSS: Main: 154697728 03:42:07 INFO - PROCESS | 4468 | 03:45:10 INFO - PROCESS | 4468 | Cycle 1(1): loaded http://localhost:59099/tests/dromaeo/cssquery-yui.html (next: http://localhost:59099/tests/dromaeo/cssquery-dojo.html) 03:45:10 INFO - PROCESS | 4468 | RSS: Main: 156057600 03:45:10 INFO - PROCESS | 4468 | 03:45:10 INFO - PROCESS | 4468 | __start_tp_report 03:45:10 INFO - PROCESS | 4468 | _x_x_mozilla_page_load 03:45:10 INFO - PROCESS | 4468 | _x_x_mozilla_page_load_details 03:45:10 INFO - PROCESS | 4468 | |i|pagename|runs| 03:45:10 INFO - PROCESS | 4468 | |0;dojo.html;3333.7833040852342;3336.8164750938704;3428.897133086008;3444.586649602048;3454.5163677085197;5632.464915832995;5641.68970706611;5662.235598194243;5664.716764161796;5691.573132015094;5627.352854421742;5660.264165658469;5663.3204015518095;5700.201971723962;5727.885442291162;5099.311592934962;5121.615878809085;5142.331496905415;5166.121759300909;5178.378594568657;5081.542661160494;5183.274341592161;5189.091908915943;5263.684178949256;5288.444713305105;5170.638055336128;5193.714345710984;5275.129603615399;5283.07546179419;5283.577313814885;5170.043541944715;5190.091733946544;5196.272521846944;5198.40218374888;5233.267342572043;5011.749412529395;5035.295058691786;5082.339295891547;5098.184290513537;5180;5601.271834661508;5604.3835178130375;5628.971855140739;5634.239377684001;5695.174199741055;6156.538259630501;6172.8765424691255;6173.290071641729;6193.0710393440895;6210.596311239755;6074.058520929263;6081.969590152065;6153.600015998945;6242.063690446424;6247.406496382836;5759.625624334405;5774.422557744234;5778.5377169826315;5782.074868021096;5805.245318108661;6241.407066328691;6248.187735594343;6274.090256912813;6281.340459251713;6321.431071203614;5849.94150058494;6005.369436209223;6014.338422773491;6062.818115456544;6119.388061193845;6089.878202435926;6113.296970848321;6118.541109416722;6120;6122.020476723703;6039.456448919618;6043.244594425697;6105.84735381619;6112.327643959161;6114.6636934969;5881.411858814085;5974.253218347707;6054.243219597551;6071.7571297147615;6114.388561143939;4547.272436410225;4592.311153327028;4593.19619066662;4598.908021839545;4612.285095810154;4069.9389509157386;4142.171565686875;4144.606262405066;4159.500859896832;4182.205380977604;5741;5751.1085781703905;5813.622114562624;5882.499987501024;5917.733701983421;6212.9068063979075;6239.313675495692;6243.469305109116;6249.406306400884;6258.280297765815;5767.538596912237;5915.201447804578;5932.436418540232;5945.40545945402;5985.910211346833;5248.160294352885;5284.9735751320995;5308.442613525524;5330.600204984642;5330.840074797762;6245.344238854946;6264;6285.497160227171;6295.622262664163;6295.653739044396;5973.611715238496;6090.604110732788;6092.9086063709965;6094.573379863456;6110.346130329577;6394.968025159845;6460.192475940507;6466.547341686037;6473.385028422293;6475.870482590416;6096.451319381277;6104.26748790148;6128.571000029955;6130.846728831815;6160;5966.403359663999;6044.84887877789;6114.48026917717;6213.720382582705;6276.278228003838;5890.3226128994;5927.525797936069;5934.109883517334;5951.256092988377;5953.821385358447;5904.675242861684;5908.468237858613;5912.024515954819;5925.05199168131;5931.347551769216;5746.856328591819;5834;5886.41135886425;5989.251343582052;6001.159837622824;6020.036794112921;6036.84907877289;6040.879182416415;6050.818475445743;6052.697365131814;5876.294844618673;5880.088586269135;5881.470667639933;5890.322612899571;5909.113632955091 03:45:10 INFO - PROCESS | 4468 | |1;ext.html;663.6781161136851;666.5634009723633;669.2972379002048;674.8156984492215;681.3901558105496;40548;42012.579874201285;42194.36708449376;42233.57766422335;42284.57715422852;44725;46032.53967460324;46035;46096.53903460965;46151.53848461514;8912.287017038654;9131.08689131085;9137.177654011137;9137.954310228473;9142.405743626643;8993.595288212013;9108.22580080694;9211.631534738635;9222.769430764218;9237.030111838261;9203.263738900872;9208.401453905475;9281.35030547862;9287.396319239228;9291.953540232324;9032.367734258605;9097.59060842257;9182.494962777044;9226.354155209137;9250.907490925072;9075.364724469224;9210.263178945735;9228.123328283802;9240.953795231047;9291.860622090675;45782.542174578164;45794.313085303744;45834.54165458336;45850.54149458496;45934.77032614849;4048.655864251542;4126.319157339036;4209.894752631178;4395.142947125312;4687.460941991681;34612;34837;34934.47598286028;34937.47593786095;36372;4295.355696645497;4300.1399720056115;4325.632321252698;4337.089211265638;4379.715318504287;333766;335769;337090.99999999756;337314;337850.99999999756;36886.81556592254;64316;64835;65245;65303;38394.42408363877;38484.230315394096;38512;38521.422178667344;38551;16878.831211687724;16980.660386792442;17077.658446830992;17090.743638845426;17121.315147393965;12824.679383015498;12850.742985140245;12872.871271287355;12907.935460322638;12910.483580656857;9498.857517137249;9623.230141588656;9662.08210220028;9665.90334096664;9698.70903872885;3557.288542291552;3671.1372827385544;3702.148505843671;3725.590185079639;3755.8122093895195;1042.9426381548935;1081.9513121909533;1109.9788194860748;1141.1042331769522;1144.582227486978;33752;33958;34203.486947695805;34300.15381234889;35035.124121896646;1213.8422005139275;1233.6299110266884;1241.962741117768;1259.6158171757702;1266.1326991011003;18064.27742890296;18252.726209106873;18262.452126436227;18450.630987380177;18570.721439178422;309424;315960;323880;333490;423840;65089.349106509275;67157.66421167862;67170;67183.66408167928;67441.66279168573;1545.3200591739599;1558.3610719604908;1568.968620627581;1585.0648117610665;1615.135902292268;34743.30513389769;34985.30029399347;35174.47238291479;35271;35342.46986295156;56334;57475.71262143662;57486.7125664369;57489;57646.7117664409;456566;456819;460852;461882;464410;32124.19689507781;32236.83881580577;32422.351552968335;43591.56408436002;43598;46365.53634463612;46430.767846160554;47194;47829.28256076231;48006;42048.369274460296;42395.57604423916;43338.78330608327;43505.56494435142;44846.3273050911;42219.7889010553;42475.36286955636;43062;43157.56842431535;43970;41415.7929210352;41760;41899.58100418957;44074.11851762883;44250.778746106065;33841.3231735359;34874.82562587171;35428.114297142776;37182;37273.25453490969;27791.72208277972;27802.304942376602;28448.43103137884;28515.42969140564;29234.269143271587 03:45:10 INFO - PROCESS | 4468 | |2;jquery.html;437.6979883880122;443.4634092747775;446.72526396266306;446.7833100946041;449.5818888433757;18773.71839422408;19556.31552895649;20130.698039529383;21441.46396340092;21555.67666485004;19250.89534421013;19615.803841961577;20219.696704549442;20467.18131274747;20513.897430512865;5775.047117225663;5923.348431672513;5942.6137301075505;5943.167956486095;5962.612430192045;5823.563232757539;5875.588708790387;5911.527077833763;5917.378675239102;5931.614445061057;5804.390538993408;5846.766129354821;5852.853678658025;5854.238948936653;5857.85355366115;5608.859778505529;5796.82609521715;5808.941910580925;5837.241158649391;5841.591088623798;5147.073526765181;5195.19474481456;5205.219217117425;5276.472352764731;5301.946980530184;23773.881130594236;24007.879960600087;24016.519669606685;24055.879720601286;24210.15264465753;2574.5494538455696;2673.1579552440917;2883.956740648871;3041.4525385430616;3094.7214750672324;14481.275936203148;14937.626559335995;14998.550043498712;15300;15509.767353489706;2071.5753270579494;2099.4751312171957;2120.2791051042564;2180.3240995291353;2181.2365672014666;81786;85045;85696;86627.13372866253;86741.56629216814;10609.84085238722;11094.833577496343;11242.988131068243;11249.550017999352;11579.363135027486;16086.517404477885;16222.675546489005;16291.185440727917;16340.346386144658;16347.91826040886;8330.166983301742;8592.312614990786;8605.612747426381;8723.432976856484;8784.341174411944;8291.8341633167;8319.209675080858;8320.791980200544;8405.70580029696;8461.534615596078;6822.656898119885;6963.82590435233;7024.086868707035;7026.754063607749;7070.434365250768;2067.0491573876184;2110.4090854560745;2111.0922303409375;2119.205298013245;2131.4032071020138;1122.9775404491863;1169.8362229287907;1185.9110566707532;1200.0039966827512;1250.7936190528642;19997.60004799896;20061.29785457502;20092.296769612993;20095.19619215244;20139.798602014085;1076.5586109694987;1103.1285284625217;1113.5768408004906;1114.5176914703425;1131.6491887514896;11486.885131148749;11564.306141631529;11579.826302605468;11632.651020469399;11689.590864319878;387490;390931;395500;522266;523704;86542.56728716442;94866.5256673726;97440.51279743556;104351.47824260982;104767.4761626187;1164.4527072276016;1185.7154282972197;1200.4117982188666;1221.8228356888378;1251.9812202816966;17546.21042053085;17672.55818604545;17787.822121779132;17806.732899006784;17964.461066168034;40351.3947290785;41184;41432.1713565733;41491;43092.78453607712;58877.70561147167;59331.703341483015;59818.700906495185;60032.39967600268;60890;7972.920270797218;8297;8514.701985430727;8687.826243475221;8851.955740221258;9379.531023448664;12007.459664314953;12989.480420783062;13076.462964809016;13088.149270297401;11523.481443335239;11545.13411494158;11601.941990289995;11607.477663504993;11700.765984680429;10515.894841051491;11358.09121798635;11435.714107147387;11745.706357341134;11752.58865939688;11564.595239166589;12030.15788894769;12122.575709850113;12175.512979480722;12407.503699851904;8619.310455163446;8674.175953284428;8835.602397891982;8893.822123557622;8907.1092890713;9041.23149532297;11719.589814356457;12023.519059237533;12075.758484830078;12105.69735756613 03:45:10 INFO - PROCESS | 4468 | |3;mootools.html;1628.1940439482455;1661.7839680841494;1868.1686649440996;1950.327137137687;1974.4274160493467;8031.678732850693;8565.957170214147;8615;8865.689700860472;8939.55302234888;8572.314214862812;8625.051244363114;8724.65101395945;8733.606987685553;8736;2420.3102115896972;2449.755024497545;2465.7410971847967;2469.987650061747;2476.455179860428;2367.95264094718;2371.087131454394;2389.569877422072;2392.138830021191;2415.5651982643117;2360.7757263060066;2403.146882856578;2409.6867407237037;2424.963625545618;2451.0563433078214;2376.619740841474;2400.615901455759;2402.4474370894704;2413.4569721812627;2418.7460316666848;2417.286900364379;2418.6372044193513;2443.230382429547;2450.3751543356507;2459.7786199241973;8850.026497085315;8904.065073167289;8926.330525210635;8929.464232146092;8940.105989401072;5401.810936617238;5551.139573366135;5603.187537806995;5622.269105016363;5634;3455.4298540740747;3541.5218945442293;3569.8929032129076;3618.764780289273;3621.885178746276;1179.4987130469517;1201.591458903977;1207.8887423570336;1211.3216598704753;1245.1470742541387;12373.195742276723;12405.565805196866;12448.937755311255;12469.127161098726;12501.062420318513;4776.164171270014;4849.4908034655855;4918.48355922623;4927.679700819435;5024.2463630454995;10364.5335959882;10466.842997355046;10519.737006574744;10533.631322903662;10567.15462762977;5508;5544.279243698294;5587.8603034923635;5593.244911936837;5596.076647353222;4545.840895568639;4942.678725882806;4983.426905905795;5011.774470148852;5074.16276314404;4139.068709540389;4151.4395556600075;4174.290370636999;4184.623383895403;4202.768847713344;1307.7253776706807;1323.7964126813135;1329.5413082486527;1336.0447280194708;1342.9865701343058;999.8250306196387;1051.5268129341828;1083.1984331594563;1090.2749671468384;1109.545086514525;6097.237845269341;6145.4161854623735;6168.259808822881;6240.4071613196675;6384.776532821422;1007.2093406675871;1018.032868774667;1052.5316234275826;1075.3225467955294;1105.9778804424027;4170.645495132887;4171.687123465752;4219.936700949488;4229.365595160689;4254.085371645111;10555.10281626055;10903.83644245337;11000.064994475559;11118.555257789598;11141.164412669083;10888.401137937331;11263.493142808593;11309.886901131047;11353.148513861493;11353.829692554618;8134.064582572962;8476.110008449024;8476.449030812977;8591.183837535424;8598.527081010605;6236.906446403217;6301;6400.551961362846;6411.839704007437;6479.416852483299;9863.556139973862;9937;10202.081812636898;10286.331388460025;10341.63804266847;10156.746081348025;10386.324888882198;10440.060394564525;10444.895551044696;10529.42088185157;7379.446541509516;7630.084389873251;7711.190325016017;7841.529508229524;8003.4797738146835;8453.492790432594;8453.619587118717;8475.83048339042;8496.91503084986;8523.360747943805;7576.62116894142;7672.079350477979;7699.076110866732;7930.563818990011;7990.920090799018;7559.962200188964;7618.542887426772;7634.885476717965;7676.6545505453505;7713.575753333621;6933.341332573397;6968.442524597918;7039.718411263492;7040.3663670269925;7053.576785392893;5102.872428189325;5170.457102004236;5197;5244.737763111905;5360.356757189163;5488.5334746545395;5489.4236105209975;5594.496495315441;5629.54963602919;5635.9436405635415 03:45:10 INFO - PROCESS | 4468 | |4;prototype.html;355.30537798603734;363.31515094047717;366.6919787378602;369.8649992752646;372.53619244041175;5521.889562208753;5661.575381846357;5670.1778242154915;5786.855328616787;5811.12833075039;5453.400125986138;5671.177679236508;5683.460071293231;5694.857628559278;5716.856628674272;4394.8901277468;4436.715091727763;4438.600525952664;4440.42274504314;4455.465344158705;4199.643030342425;4402.185595664796;4417.580329868657;4450.910981780363;4478.8208471661255;4346.608805207531;4350.56494350564;4354.303311470166;4371.31164333934;4372.366006928994;4366.301391777316;4366.847160349373;4368.453943257093;4386.8903277418;4391.8682439526865;3800.277947190025;3816.732828701992;3866.903327416837;3867.9806600967095;3877.689784817208;5436.021516127095;5476.972615136939;5502.80740174092;5514.558835293167;5540.556755459554;5012.521306214676;5018.322526458918;5019.7741101650145;5041.596672266247;5045.344105266292;5788;5938.2280303560265;6007.519398448114;6016.518678505753;6016.548758843104;4235.639970602502;4265.466816647919;4267.530571637118;4268.274393353137;4280.272353699878;6260.373962603703;6285.811425657238;6287.308396076428;6308.400701933355;6333.651649159295;4245.341971994346;4341.479022517318;4346.1525002624185;4350.782460876943;4360.8909777255185;4328.11273688893;4385.6052955233545;4406.272964960745;4411.139827733561;4431.047324825178;5016.698998060128;5018.89962200754;5021.59827213822;5021.924671129936;5026.2460630904925;5783.8554036149435;5951.077582974646;6041.124037014608;6068.695230525458;6073.878522429615;1595.15456807892;1610.9113998730181;1615.3942271648132;1615.7495588183851;1620.2951716003577;1046.5186014433446;1063.787242551493;1064.3986147826454;1069.7806949575474;1074.7850429913892;6192;6206.875862482815;6221.657808820558;6286.842828929313;6287.088372186007;6594.153636981653;6605.669716514155;6666.100161453963;6672.132622759011;6678.465722742169;6017.518598512109;6152;6196.8760624787255;6211.81364559064;6216.968915155395;3516.9824150879595;3523.365794157025;3546.9536486736474;3561.198730285717;3562.412201986643;6138.202033735675;6457.902156633384;6473.741050357933;6474.4496717778575;6840.828979275459;6306.211723534559;6362.331955144643;6386.648734319564;6402.391772781578;6409.262934762469;6208.81373558794;6464.709088091047;6465.870682586322;6483.286838447767;6484.286728459866;6182.567220294536;6221.191245138103;6237.812865614039;6273.498120150468;6275.560710750204;5915.290165180206;6149.292831324455;6158.445739883432;6171.537134715004;6205.441510264098;6451.41937225652;6472.967635161794;6479.838004049937;6492.837679058061;6497.935020649922;4368.366586844953;4410.536893626123;4422.579854913778;4454.26504626733;4459.554044595644;6113;6136.557908891317;6246.094316324198;6250.843728906813;6274.560780745304;5959.67221802805;6070;6079.392060793885;6102.694865256631;6142;5918.73365698536;6005.939940600538;6048.60684055535;6103;6127.84680382994;5957;5963.73163207648;5964.31410387811;5964.522838172849;5984.593620499266;6072.332043475126;6114.510839132948;6122.510199183966;6138.202033735586;6156.199694039746;5594;5933.347331793586;5940.346561878104;5962.224910761746;5970.910436343545 03:45:10 INFO - PROCESS | 4468 | |5;yui.html;808.365433134989;899.5637115998744;908.0556221529612;909.8635204719292;914.5015966298366;14290.571282861505;14510.927445362784;14655.26723663818;14729.968902176839;14765.18791466469;12334.383280835968;14010.299485025733;14036.298185090756;14054.859451405482;14066.507672231473;865.1305438034766;919.5586118663012;922.3912217936163;923.8290916180528;924.4499522783966;912.6075787411411;920.6639576554543;930.986035209469;933.4959122074072;933.8319102561536;978.3787295067648;978.6232300564299;980.2648013989508;982.3221976835961;982.6462473509531;969.4086607169621;970.8786401699823;974.4445665970364;976.8974257702981;980.0493521284343;711.9928800711979;716.7455553278616;717.5551158281846;718.4180813541049;718.859822334645;14373.137611743328;14421.27893605326;14467.276636168255;14569.490067847575;14678.412863485555;14557.272136393243;15060.096394216273;15076.849231507764;15134.318955646911;15399.461018864398;12118.151729378947;12122.39388030595;12284.938575307066;12495.500179992789;12509.499620015189;3917.6474117329576;3944.375723235297;3947.98026009871;4013.8795836124964;4032.4152997815154;56254.43745562574;56694.43305566933;57618.42381576172;57757.42242577562;57804.42195578032;11536.480858361394;11614.937315030948;11729.296242225493;11837.467313970892;12097.455614497369;21318.253861114787;21541.89229053876;21594.676079858815;21630.675539866916;21746.456338591663;8122.593870306461;8355.874661880076;8450.239478446969;8606.827863442697;8754.912450875538;4797.112534181188;4808.543188397097;4821.228603423436;4856.714014492615;4954.133026720381;3345.531625572422;3414.6585341465657;3419.743519236067;3422.9144271393416;3426.297608990151;635.659921941759;640.9455196308272;646.253577118429;647.5305403582365;655.1973832055788;792.9048514178336;804.7947773317767;807.7172989453644;821.4906757810196;834.2075028722737;10364.222683298784;10570.312929659547;10705.892941070646;10709.46452677363;10800.78398432027;700.28219587071;777.8599852026576;810.7324582887633;820.4420993724206;821.2977903892206;4822.324874517571;4973.303737476756;4995.50134959518;5078.4413714491375;5106.540411362921;65013;67600;67665.32334676689;68204;68314.31685683179;56147.438525615034;58236;58634.70682646645;58736.706316469;59417.92037278674;51735.48264517382;51816.74091629518;51894;52338;52666.47333526692;9304.627814887328;9390.577424016072;9576.473293968898;9744.658936937172;9861;33869.98390048303;35397;35869.1032724184;36103.45844812383;36447.81776091103;47968;48216.758916205195;48382;48391.27413088877;49352.75323623359;12618.432170552163;12719.364031798557;12839.935800320938;12893.548725794552;12939.482420703443;13296.734065318833;13347.265900375573;13427.865721342661;13512.527061552799;13622.114562553403;13031.02267329935;13077.346132693518;13106.082574219714;13106.868931310564;13178.406971686489;12248.265104093784;12388.070894682754;12392.504299827906;12466.314352710326;12497.937510312753;11565.074794016627;11944.522219111139;12347.75304493923;12877.871221288042;13035.283059431822;10630.681079567625;10837.45812709377;10838.891611083789;10856.837147442953;10865.18511111654;10692.679219623424;11068.778624427627;11081.778364432828;11093.223474356717;11493.482793274155 03:45:10 INFO - PROCESS | 4468 | __end_tp_report 03:45:10 INFO - PROCESS | 4468 | __start_cc_report 03:45:10 INFO - PROCESS | 4468 | _x_x_mozilla_cycle_collect,341 03:45:10 INFO - PROCESS | 4468 | __end_cc_report 03:45:10 INFO - PROCESS | 4468 | __startTimestamp1461926710304__endTimestamp 03:45:10 INFO - PROCESS | 4468 | 03:45:10 INFO - PROCESS | 4468 | ------- Summary: start ------- 03:45:10 INFO - PROCESS | 4468 | Number of tests: 6 03:45:10 INFO - PROCESS | 4468 | 03:45:10 INFO - PROCESS | 4468 | [#0] dojo.html Cycles:165 Average:5683.88 Median:5909.11 stddev:651.87 (11.0%) stddev-sans-first:627.25 03:45:10 INFO - PROCESS | 4468 | Values: 3333.8 3336.8 3428.9 3444.6 3454.5 5632.5 5641.7 5662.2 5664.7 5691.6 5627.4 5660.3 5663.3 5700.2 5727.9 5099.3 5121.6 5142.3 5166.1 5178.4 5081.5 5183.3 5189.1 5263.7 5288.4 5170.6 5193.7 5275.1 5283.1 5283.6 5170.0 5190.1 5196.3 5198.4 5233.3 5011.7 5035.3 5082.3 5098.2 5180.0 5601.3 5604.4 5629.0 5634.2 5695.2 6156.5 6172.9 6173.3 6193.1 6210.6 6074.1 6082.0 6153.6 6242.1 6247.4 5759.6 5774.4 5778.5 5782.1 5805.2 6241.4 6248.2 6274.1 6281.3 6321.4 5849.9 6005.4 6014.3 6062.8 6119.4 6089.9 6113.3 6118.5 6120.0 6122.0 6039.5 6043.2 6105.8 6112.3 6114.7 5881.4 5974.3 6054.2 6071.8 6114.4 4547.3 4592.3 4593.2 4598.9 4612.3 4069.9 4142.2 4144.6 4159.5 4182.2 5741.0 5751.1 5813.6 5882.5 5917.7 6212.9 6239.3 6243.5 6249.4 6258.3 5767.5 5915.2 5932.4 5945.4 5985.9 5248.2 5285.0 5308.4 5330.6 5330.8 6245.3 6264.0 6285.5 6295.6 6295.7 5973.6 6090.6 6092.9 6094.6 6110.3 6395.0 6460.2 6466.5 6473.4 6475.9 6096.5 6104.3 6128.6 6130.8 6160.0 5966.4 6044.8 6114.5 6213.7 6276.3 5890.3 5927.5 5934.1 5951.3 5953.8 5904.7 5908.5 5912.0 5925.1 5931.3 5746.9 5834.0 5886.4 5989.3 6001.2 6020.0 6036.8 6040.9 6050.8 6052.7 5876.3 5880.1 5881.5 5890.3 5909.1 03:45:10 INFO - PROCESS | 4468 | 03:45:10 INFO - PROCESS | 4468 | [#1] ext.html Cycles:180 Average:55422.81 Median:233062.29 stddev:101330.35 (43.5%) stddev-sans-first:101531.19 03:45:10 INFO - PROCESS | 4468 | Values: 663.7 666.6 669.3 674.8 681.4 40548.0 42012.6 42194.4 42233.6 42284.6 44725.0 46032.5 46035.0 46096.5 46151.5 8912.3 9131.1 9137.2 9138.0 9142.4 8993.6 9108.2 9211.6 9222.8 9237.0 9203.3 9208.4 9281.4 9287.4 9292.0 9032.4 9097.6 9182.5 9226.4 9250.9 9075.4 9210.3 9228.1 9241.0 9291.9 45782.5 45794.3 45834.5 45850.5 45934.8 4048.7 4126.3 4209.9 4395.1 4687.5 34612.0 34837.0 34934.5 34937.5 36372.0 4295.4 4300.1 4325.6 4337.1 4379.7 333766.0 335769.0 337091.0 337314.0 337851.0 36886.8 64316.0 64835.0 65245.0 65303.0 38394.4 38484.2 38512.0 38521.4 38551.0 16878.8 16980.7 17077.7 17090.7 17121.3 12824.7 12850.7 12872.9 12907.9 12910.5 9498.9 9623.2 9662.1 9665.9 9698.7 3557.3 3671.1 3702.1 3725.6 3755.8 1042.9 1082.0 1110.0 1141.1 1144.6 33752.0 33958.0 34203.5 34300.2 35035.1 1213.8 1233.6 1242.0 1259.6 1266.1 18064.3 18252.7 18262.5 18450.6 18570.7 309424.0 315960.0 323880.0 333490.0 423840.0 65089.3 67157.7 67170.0 67183.7 67441.7 1545.3 1558.4 1569.0 1585.1 1615.1 34743.3 34985.3 35174.5 35271.0 35342.5 56334.0 57475.7 57486.7 57489.0 57646.7 456566.0 456819.0 460852.0 461882.0 464410.0 32124.2 32236.8 32422.4 43591.6 43598.0 46365.5 46430.8 47194.0 47829.3 48006.0 42048.4 42395.6 43338.8 43505.6 44846.3 42219.8 42475.4 43062.0 43157.6 43970.0 41415.8 41760.0 41899.6 44074.1 44250.8 33841.3 34874.8 35428.1 37182.0 37273.3 27791.7 27802.3 28448.4 28515.4 29234.3 03:45:10 INFO - PROCESS | 4468 | 03:45:10 INFO - PROCESS | 4468 | [#2] jquery.html Cycles:180 Average:28434.82 Median:23890.88 stddev:74440.24 (311.6%) stddev-sans-first:74619.38 03:45:10 INFO - PROCESS | 4468 | Values: 437.7 443.5 446.7 446.8 449.6 18773.7 19556.3 20130.7 21441.5 21555.7 19250.9 19615.8 20219.7 20467.2 20513.9 5775.0 5923.3 5942.6 5943.2 5962.6 5823.6 5875.6 5911.5 5917.4 5931.6 5804.4 5846.8 5852.9 5854.2 5857.9 5608.9 5796.8 5808.9 5837.2 5841.6 5147.1 5195.2 5205.2 5276.5 5301.9 23773.9 24007.9 24016.5 24055.9 24210.2 2574.5 2673.2 2884.0 3041.5 3094.7 14481.3 14937.6 14998.6 15300.0 15509.8 2071.6 2099.5 2120.3 2180.3 2181.2 81786.0 85045.0 85696.0 86627.1 86741.6 10609.8 11094.8 11243.0 11249.6 11579.4 16086.5 16222.7 16291.2 16340.3 16347.9 8330.2 8592.3 8605.6 8723.4 8784.3 8291.8 8319.2 8320.8 8405.7 8461.5 6822.7 6963.8 7024.1 7026.8 7070.4 2067.0 2110.4 2111.1 2119.2 2131.4 1123.0 1169.8 1185.9 1200.0 1250.8 19997.6 20061.3 20092.3 20095.2 20139.8 1076.6 1103.1 1113.6 1114.5 1131.6 11486.9 11564.3 11579.8 11632.7 11689.6 387490.0 390931.0 395500.0 522266.0 523704.0 86542.6 94866.5 97440.5 104351.5 104767.5 1164.5 1185.7 1200.4 1221.8 1252.0 17546.2 17672.6 17787.8 17806.7 17964.5 40351.4 41184.0 41432.2 41491.0 43092.8 58877.7 59331.7 59818.7 60032.4 60890.0 7972.9 8297.0 8514.7 8687.8 8852.0 9379.5 12007.5 12989.5 13076.5 13088.1 11523.5 11545.1 11601.9 11607.5 11700.8 10515.9 11358.1 11435.7 11745.7 11752.6 11564.6 12030.2 12122.6 12175.5 12407.5 8619.3 8674.2 8835.6 8893.8 8907.1 9041.2 11719.6 12023.5 12075.8 12105.7 03:45:10 INFO - PROCESS | 4468 | 03:45:10 INFO - PROCESS | 4468 | [#3] mootools.html Cycles:180 Average:5935.83 Median:4241.73 stddev:3283.45 (77.4%) stddev-sans-first:3276.70 03:45:10 INFO - PROCESS | 4468 | Values: 1628.2 1661.8 1868.2 1950.3 1974.4 8031.7 8566.0 8615.0 8865.7 8939.6 8572.3 8625.1 8724.7 8733.6 8736.0 2420.3 2449.8 2465.7 2470.0 2476.5 2368.0 2371.1 2389.6 2392.1 2415.6 2360.8 2403.1 2409.7 2425.0 2451.1 2376.6 2400.6 2402.4 2413.5 2418.7 2417.3 2418.6 2443.2 2450.4 2459.8 8850.0 8904.1 8926.3 8929.5 8940.1 5401.8 5551.1 5603.2 5622.3 5634.0 3455.4 3541.5 3569.9 3618.8 3621.9 1179.5 1201.6 1207.9 1211.3 1245.1 12373.2 12405.6 12448.9 12469.1 12501.1 4776.2 4849.5 4918.5 4927.7 5024.2 10364.5 10466.8 10519.7 10533.6 10567.2 5508.0 5544.3 5587.9 5593.2 5596.1 4545.8 4942.7 4983.4 5011.8 5074.2 4139.1 4151.4 4174.3 4184.6 4202.8 1307.7 1323.8 1329.5 1336.0 1343.0 999.8 1051.5 1083.2 1090.3 1109.5 6097.2 6145.4 6168.3 6240.4 6384.8 1007.2 1018.0 1052.5 1075.3 1106.0 4170.6 4171.7 4219.9 4229.4 4254.1 10555.1 10903.8 11000.1 11118.6 11141.2 10888.4 11263.5 11309.9 11353.1 11353.8 8134.1 8476.1 8476.4 8591.2 8598.5 6236.9 6301.0 6400.6 6411.8 6479.4 9863.6 9937.0 10202.1 10286.3 10341.6 10156.7 10386.3 10440.1 10444.9 10529.4 7379.4 7630.1 7711.2 7841.5 8003.5 8453.5 8453.6 8475.8 8496.9 8523.4 7576.6 7672.1 7699.1 7930.6 7990.9 7560.0 7618.5 7634.9 7676.7 7713.6 6933.3 6968.4 7039.7 7040.4 7053.6 5102.9 5170.5 5197.0 5244.7 5360.4 5488.5 5489.4 5594.5 5629.5 5635.9 03:45:10 INFO - PROCESS | 4468 | 03:45:10 INFO - PROCESS | 4468 | [#4] prototype.html Cycles:180 Average:5109.39 Median:5787.43 stddev:1521.01 (26.3%) stddev-sans-first:1482.83 03:45:10 INFO - PROCESS | 4468 | Values: 355.3 363.3 366.7 369.9 372.5 5521.9 5661.6 5670.2 5786.9 5811.1 5453.4 5671.2 5683.5 5694.9 5716.9 4394.9 4436.7 4438.6 4440.4 4455.5 4199.6 4402.2 4417.6 4450.9 4478.8 4346.6 4350.6 4354.3 4371.3 4372.4 4366.3 4366.8 4368.5 4386.9 4391.9 3800.3 3816.7 3866.9 3868.0 3877.7 5436.0 5477.0 5502.8 5514.6 5540.6 5012.5 5018.3 5019.8 5041.6 5045.3 5788.0 5938.2 6007.5 6016.5 6016.5 4235.6 4265.5 4267.5 4268.3 4280.3 6260.4 6285.8 6287.3 6308.4 6333.7 4245.3 4341.5 4346.2 4350.8 4360.9 4328.1 4385.6 4406.3 4411.1 4431.0 5016.7 5018.9 5021.6 5021.9 5026.2 5783.9 5951.1 6041.1 6068.7 6073.9 1595.2 1610.9 1615.4 1615.7 1620.3 1046.5 1063.8 1064.4 1069.8 1074.8 6192.0 6206.9 6221.7 6286.8 6287.1 6594.2 6605.7 6666.1 6672.1 6678.5 6017.5 6152.0 6196.9 6211.8 6217.0 3517.0 3523.4 3547.0 3561.2 3562.4 6138.2 6457.9 6473.7 6474.4 6840.8 6306.2 6362.3 6386.6 6402.4 6409.3 6208.8 6464.7 6465.9 6483.3 6484.3 6182.6 6221.2 6237.8 6273.5 6275.6 5915.3 6149.3 6158.4 6171.5 6205.4 6451.4 6473.0 6479.8 6492.8 6497.9 4368.4 4410.5 4422.6 4454.3 4459.6 6113.0 6136.6 6246.1 6250.8 6274.6 5959.7 6070.0 6079.4 6102.7 6142.0 5918.7 6005.9 6048.6 6103.0 6127.8 5957.0 5963.7 5964.3 5964.5 5984.6 6072.3 6114.5 6122.5 6138.2 6156.2 5594.0 5933.3 5940.3 5962.2 5970.9 03:45:10 INFO - PROCESS | 4468 | 03:45:10 INFO - PROCESS | 4468 | [#5] yui.html Cycles:180 Average:15608.20 Median:26382.56 stddev:18137.06 (68.7%) stddev-sans-first:18153.89 03:45:10 INFO - PROCESS | 4468 | Values: 808.4 899.6 908.1 909.9 914.5 14290.6 14510.9 14655.3 14730.0 14765.2 12334.4 14010.3 14036.3 14054.9 14066.5 865.1 919.6 922.4 923.8 924.4 912.6 920.7 931.0 933.5 933.8 978.4 978.6 980.3 982.3 982.6 969.4 970.9 974.4 976.9 980.0 712.0 716.7 717.6 718.4 718.9 14373.1 14421.3 14467.3 14569.5 14678.4 14557.3 15060.1 15076.8 15134.3 15399.5 12118.2 12122.4 12284.9 12495.5 12509.5 3917.6 3944.4 3948.0 4013.9 4032.4 56254.4 56694.4 57618.4 57757.4 57804.4 11536.5 11614.9 11729.3 11837.5 12097.5 21318.3 21541.9 21594.7 21630.7 21746.5 8122.6 8355.9 8450.2 8606.8 8754.9 4797.1 4808.5 4821.2 4856.7 4954.1 3345.5 3414.7 3419.7 3422.9 3426.3 635.7 640.9 646.3 647.5 655.2 792.9 804.8 807.7 821.5 834.2 10364.2 10570.3 10705.9 10709.5 10800.8 700.3 777.9 810.7 820.4 821.3 4822.3 4973.3 4995.5 5078.4 5106.5 65013.0 67600.0 67665.3 68204.0 68314.3 56147.4 58236.0 58634.7 58736.7 59417.9 51735.5 51816.7 51894.0 52338.0 52666.5 9304.6 9390.6 9576.5 9744.7 9861.0 33870.0 35397.0 35869.1 36103.5 36447.8 47968.0 48216.8 48382.0 48391.3 49352.8 12618.4 12719.4 12839.9 12893.5 12939.5 13296.7 13347.3 13427.9 13512.5 13622.1 13031.0 13077.3 13106.1 13106.9 13178.4 12248.3 12388.1 12392.5 12466.3 12497.9 11565.1 11944.5 12347.8 12877.9 13035.3 10630.7 10837.5 10838.9 10856.8 10865.2 10692.7 11068.8 11081.8 11093.2 11493.5 03:45:10 INFO - PROCESS | 4468 | -------- Summary: end -------- 03:45:10 INFO - PROCESS | 4468 | 03:45:10 INFO - TEST-INFO | 4468: exit 0 03:45:10 INFO - TEST-OK | dromaeo_css | took 1109473ms 03:45:10 INFO - TEST-START | kraken 03:45:10 INFO - operating with platform_type : linux_ 03:45:10 INFO - Initialising browser for kraken test... 03:45:10 INFO - TEST-INFO | started process 4710 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwzfOvd/profile http://localhost:59099/getInfo.html) 03:45:14 INFO - PROCESS | 4710 | 03:45:14 INFO - PROCESS | 4710 | (process:4787): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:45:15 INFO - PROCESS | 4710 | __metrics Screen width/height:1600/1200 03:45:15 INFO - PROCESS | 4710 | colorDepth:24 03:45:15 INFO - PROCESS | 4710 | Browser inner width/height: 1024/697 03:45:15 INFO - PROCESS | 4710 | __metrics 03:45:16 ERROR - PROCESS | 4710 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 03:45:16 INFO - TEST-INFO | 4710: exit 0 03:45:16 INFO - Browser initialized. 03:45:16 INFO - Running cycle 1/1 for kraken test... 03:45:16 INFO - TEST-INFO | started process 4838 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwzfOvd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:45:18 INFO - PROCESS | 4838 | 03:45:18 INFO - PROCESS | 4838 | (process:4909): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:45:28 INFO - PROCESS | 4838 | RSS: Main: 152539136 03:45:28 INFO - PROCESS | 4838 | 03:45:31 INFO - PROCESS | 4838 | Cycle 1(1): loaded http://localhost:59099/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59099/tests/kraken/driver.html?testName=audio-beat-detection) 03:45:32 INFO - PROCESS | 4838 | RSS: Main: 157085696 03:45:32 INFO - PROCESS | 4838 | 03:45:34 INFO - PROCESS | 4838 | Cycle 1(1): loaded http://localhost:59099/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59099/tests/kraken/driver.html?testName=audio-dft) 03:45:35 INFO - PROCESS | 4838 | RSS: Main: 157429760 03:45:35 INFO - PROCESS | 4838 | 03:45:38 INFO - PROCESS | 4838 | Cycle 1(1): loaded http://localhost:59099/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59099/tests/kraken/driver.html?testName=audio-fft) 03:45:38 INFO - PROCESS | 4838 | RSS: Main: 157896704 03:45:38 INFO - PROCESS | 4838 | 03:45:41 INFO - PROCESS | 4838 | Cycle 1(1): loaded http://localhost:59099/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59099/tests/kraken/driver.html?testName=audio-oscillator) 03:45:41 INFO - PROCESS | 4838 | RSS: Main: 157847552 03:45:41 INFO - PROCESS | 4838 | 03:45:43 INFO - PROCESS | 4838 | Cycle 1(1): loaded http://localhost:59099/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59099/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:45:44 INFO - PROCESS | 4838 | RSS: Main: 157569024 03:45:44 INFO - PROCESS | 4838 | 03:45:47 INFO - PROCESS | 4838 | Cycle 1(1): loaded http://localhost:59099/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59099/tests/kraken/driver.html?testName=imaging-darkroom) 03:45:48 INFO - PROCESS | 4838 | RSS: Main: 157917184 03:45:48 INFO - PROCESS | 4838 | 03:45:51 INFO - PROCESS | 4838 | Cycle 1(1): loaded http://localhost:59099/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59099/tests/kraken/driver.html?testName=imaging-desaturate) 03:45:52 INFO - PROCESS | 4838 | RSS: Main: 157888512 03:45:52 INFO - PROCESS | 4838 | 03:45:54 INFO - PROCESS | 4838 | Cycle 1(1): loaded http://localhost:59099/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59099/tests/kraken/driver.html?testName=json-parse-financial) 03:45:55 INFO - PROCESS | 4838 | RSS: Main: 157663232 03:45:55 INFO - PROCESS | 4838 | 03:45:57 INFO - PROCESS | 4838 | Cycle 1(1): loaded http://localhost:59099/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59099/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:45:57 INFO - PROCESS | 4838 | RSS: Main: 157704192 03:45:57 INFO - PROCESS | 4838 | 03:45:59 INFO - PROCESS | 4838 | Cycle 1(1): loaded http://localhost:59099/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59099/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:46:00 INFO - PROCESS | 4838 | RSS: Main: 157904896 03:46:00 INFO - PROCESS | 4838 | 03:46:02 INFO - PROCESS | 4838 | Cycle 1(1): loaded http://localhost:59099/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59099/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:46:02 INFO - PROCESS | 4838 | RSS: Main: 157540352 03:46:02 INFO - PROCESS | 4838 | 03:46:05 INFO - PROCESS | 4838 | Cycle 1(1): loaded http://localhost:59099/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59099/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:46:06 INFO - PROCESS | 4838 | RSS: Main: 158228480 03:46:06 INFO - PROCESS | 4838 | 03:46:08 INFO - PROCESS | 4838 | Cycle 1(1): loaded http://localhost:59099/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59099/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:46:09 INFO - PROCESS | 4838 | RSS: Main: 158347264 03:46:09 INFO - PROCESS | 4838 | 03:46:11 INFO - PROCESS | 4838 | Cycle 1(1): loaded http://localhost:59099/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59099/tests/kraken/driver.html?testName=ai-astar) 03:46:11 INFO - PROCESS | 4838 | RSS: Main: 159657984 03:46:11 INFO - PROCESS | 4838 | 03:46:11 INFO - PROCESS | 4838 | __start_tp_report 03:46:11 INFO - PROCESS | 4838 | _x_x_mozilla_page_load 03:46:11 INFO - PROCESS | 4838 | _x_x_mozilla_page_load_details 03:46:11 INFO - PROCESS | 4838 | |i|pagename|runs| 03:46:11 INFO - PROCESS | 4838 | |0;ai-astar;110;107;112;110;113;124;112;112;112;110 03:46:11 INFO - PROCESS | 4838 | |1;audio-beat-detection;152;130;160;185;128;160;158;128;175;128 03:46:11 INFO - PROCESS | 4838 | |2;audio-dft;162;163;162;161;163;161;163;162;165;162 03:46:11 INFO - PROCESS | 4838 | |3;audio-fft;77;74;74;169;74;74;78;75;171;77 03:46:11 INFO - PROCESS | 4838 | |4;audio-oscillator;93;92;162;91;92;93;148;97;93;142 03:46:11 INFO - PROCESS | 4838 | |5;imaging-gaussian-blur;117;118;117;116;118;118;117;117;117;117 03:46:11 INFO - PROCESS | 4838 | |6;imaging-darkroom;147;147;147;147;147;147;147;147;146;146 03:46:11 INFO - PROCESS | 4838 | |7;imaging-desaturate;94;95;97;95;94;95;95;97;94;95 03:46:11 INFO - PROCESS | 4838 | |8;json-parse-financial;58;58;60;59;61;58;62;72;56;62 03:46:11 INFO - PROCESS | 4838 | |9;json-stringify-tinderbox;58;58;57;57;57;57;57;58;57;57 03:46:11 INFO - PROCESS | 4838 | |10;stanford-crypto-aes;73;72;79;72;74;74;73;81;75;73 03:46:11 INFO - PROCESS | 4838 | |11;stanford-crypto-ccm;118;121;120;129;117;120;129;119;197;125 03:46:11 INFO - PROCESS | 4838 | |12;stanford-crypto-pbkdf2;161;167;160;159;171;170;168;155;162;155 03:46:11 INFO - PROCESS | 4838 | |13;stanford-crypto-sha256-iterative;66;65;65;66;67;65;66;63;68;66 03:46:11 INFO - PROCESS | 4838 | __end_tp_report 03:46:11 INFO - PROCESS | 4838 | __start_cc_report 03:46:11 INFO - PROCESS | 4838 | _x_x_mozilla_cycle_collect,843 03:46:11 INFO - PROCESS | 4838 | __end_cc_report 03:46:11 INFO - PROCESS | 4838 | __startTimestamp1461926771292__endTimestamp 03:46:11 INFO - PROCESS | 4838 | 03:46:11 INFO - PROCESS | 4838 | ------- Summary: start ------- 03:46:11 INFO - PROCESS | 4838 | Number of tests: 14 03:46:11 INFO - PROCESS | 4838 | 03:46:11 INFO - PROCESS | 4838 | [#0] ai-astar Cycles:10 Average:112.20 Median:112.00 stddev:4.49 (4.0%) stddev-sans-first:4.69 03:46:11 INFO - PROCESS | 4838 | Values: 110.0 107.0 112.0 110.0 113.0 124.0 112.0 112.0 112.0 110.0 03:46:11 INFO - PROCESS | 4838 | 03:46:11 INFO - PROCESS | 4838 | [#1] audio-beat-detection Cycles:10 Average:150.40 Median:159.00 stddev:21.00 (13.2%) stddev-sans-first:22.26 03:46:11 INFO - PROCESS | 4838 | Values: 152.0 130.0 160.0 185.0 128.0 160.0 158.0 128.0 175.0 128.0 03:46:11 INFO - PROCESS | 4838 | 03:46:11 INFO - PROCESS | 4838 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.50 stddev:1.17 (0.7%) stddev-sans-first:1.24 03:46:11 INFO - PROCESS | 4838 | Values: 162.0 163.0 162.0 161.0 163.0 161.0 163.0 162.0 165.0 162.0 03:46:11 INFO - PROCESS | 4838 | 03:46:11 INFO - PROCESS | 4838 | [#3] audio-fft Cycles:10 Average:94.30 Median:74.50 stddev:39.93 (53.6%) stddev-sans-first:41.86 03:46:11 INFO - PROCESS | 4838 | Values: 77.0 74.0 74.0 169.0 74.0 74.0 78.0 75.0 171.0 77.0 03:46:11 INFO - PROCESS | 4838 | 03:46:11 INFO - PROCESS | 4838 | [#4] audio-oscillator Cycles:10 Average:110.30 Median:92.50 stddev:28.32 (30.6%) stddev-sans-first:29.33 03:46:11 INFO - PROCESS | 4838 | Values: 93.0 92.0 162.0 91.0 92.0 93.0 148.0 97.0 93.0 142.0 03:46:11 INFO - PROCESS | 4838 | 03:46:11 INFO - PROCESS | 4838 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 03:46:11 INFO - PROCESS | 4838 | Values: 117.0 118.0 117.0 116.0 118.0 118.0 117.0 117.0 117.0 117.0 03:46:11 INFO - PROCESS | 4838 | 03:46:11 INFO - PROCESS | 4838 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 03:46:11 INFO - PROCESS | 4838 | Values: 147.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 146.0 146.0 03:46:11 INFO - PROCESS | 4838 | 03:46:11 INFO - PROCESS | 4838 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:1.10 (1.2%) stddev-sans-first:1.09 03:46:11 INFO - PROCESS | 4838 | Values: 94.0 95.0 97.0 95.0 94.0 95.0 95.0 97.0 94.0 95.0 03:46:11 INFO - PROCESS | 4838 | 03:46:11 INFO - PROCESS | 4838 | [#8] json-parse-financial Cycles:10 Average:60.60 Median:60.50 stddev:4.45 (7.4%) stddev-sans-first:4.62 03:46:11 INFO - PROCESS | 4838 | Values: 58.0 58.0 60.0 59.0 61.0 58.0 62.0 72.0 56.0 62.0 03:46:11 INFO - PROCESS | 4838 | 03:46:11 INFO - PROCESS | 4838 | [#9] json-stringify-tinderbox Cycles:10 Average:57.30 Median:57.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 03:46:11 INFO - PROCESS | 4838 | Values: 58.0 58.0 57.0 57.0 57.0 57.0 57.0 58.0 57.0 57.0 03:46:11 INFO - PROCESS | 4838 | 03:46:11 INFO - PROCESS | 4838 | [#10] stanford-crypto-aes Cycles:10 Average:74.60 Median:74.00 stddev:3.03 (4.1%) stddev-sans-first:3.15 03:46:11 INFO - PROCESS | 4838 | Values: 73.0 72.0 79.0 72.0 74.0 74.0 73.0 81.0 75.0 73.0 03:46:11 INFO - PROCESS | 4838 | 03:46:11 INFO - PROCESS | 4838 | [#11] stanford-crypto-ccm Cycles:10 Average:129.50 Median:123.00 stddev:24.10 (19.6%) stddev-sans-first:25.20 03:46:11 INFO - PROCESS | 4838 | Values: 118.0 121.0 120.0 129.0 117.0 120.0 129.0 119.0 197.0 125.0 03:46:11 INFO - PROCESS | 4838 | 03:46:11 INFO - PROCESS | 4838 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.80 Median:164.50 stddev:5.88 (3.6%) stddev-sans-first:6.20 03:46:11 INFO - PROCESS | 4838 | Values: 161.0 167.0 160.0 159.0 171.0 170.0 168.0 155.0 162.0 155.0 03:46:11 INFO - PROCESS | 4838 | 03:46:11 INFO - PROCESS | 4838 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.00 stddev:1.34 (2.0%) stddev-sans-first:1.41 03:46:11 INFO - PROCESS | 4838 | Values: 66.0 65.0 65.0 66.0 67.0 65.0 66.0 63.0 68.0 66.0 03:46:11 INFO - PROCESS | 4838 | -------- Summary: end -------- 03:46:11 INFO - PROCESS | 4838 | 03:46:12 INFO - TEST-INFO | 4838: exit 0 03:46:12 INFO - TEST-OK | kraken | took 61151ms 03:46:12 INFO - SUITE-END | took 1170s 03:46:12 INFO - Completed test suite (00:19:30) 03:46:12 INFO - javascript benchmark 03:46:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3333.7833040852342, 3336.8164750938704, 3428.897133086008, 3444.586649602048, 3454.5163677085197, 5632.464915832995, 5641.68970706611, 5662.235598194243, 5664.716764161796, 5691.573132015094, 5627.352854421742, 5660.264165658469, 5663.3204015518095, 5700.201971723962, 5727.885442291162, 5099.311592934962, 5121.615878809085, 5142.331496905415, 5166.121759300909, 5178.378594568657, 5081.542661160494, 5183.274341592161, 5189.091908915943, 5263.684178949256, 5288.444713305105, 5170.638055336128, 5193.714345710984, 5275.129603615399, 5283.07546179419, 5283.577313814885, 5170.043541944715, 5190.091733946544, 5196.272521846944, 5198.40218374888, 5233.267342572043, 5011.749412529395, 5035.295058691786, 5082.339295891547, 5098.184290513537, 5180.0, 5601.271834661508, 5604.3835178130375, 5628.971855140739, 5634.239377684001, 5695.174199741055, 6156.538259630501, 6172.8765424691255, 6173.290071641729, 6193.0710393440895, 6210.596311239755, 6074.058520929263, 6081.969590152065, 6153.600015998945, 6242.063690446424, 6247.406496382836, 5759.625624334405, 5774.422557744234, 5778.5377169826315, 5782.074868021096, 5805.245318108661, 6241.407066328691, 6248.187735594343, 6274.090256912813, 6281.340459251713, 6321.431071203614, 5849.94150058494, 6005.369436209223, 6014.338422773491, 6062.818115456544, 6119.388061193845, 6089.878202435926, 6113.296970848321, 6118.541109416722, 6120.0, 6122.020476723703, 6039.456448919618, 6043.244594425697, 6105.84735381619, 6112.327643959161, 6114.6636934969, 5881.411858814085, 5974.253218347707, 6054.243219597551, 6071.7571297147615, 6114.388561143939, 4547.272436410225, 4592.311153327028, 4593.19619066662, 4598.908021839545, 4612.285095810154, 4069.9389509157386, 4142.171565686875, 4144.606262405066, 4159.500859896832, 4182.205380977604, 5741.0, 5751.1085781703905, 5813.622114562624, 5882.499987501024, 5917.733701983421, 6212.9068063979075, 6239.313675495692, 6243.469305109116, 6249.406306400884, 6258.280297765815, 5767.538596912237, 5915.201447804578, 5932.436418540232, 5945.40545945402, 5985.910211346833, 5248.160294352885, 5284.9735751320995, 5308.442613525524, 5330.600204984642, 5330.840074797762, 6245.344238854946, 6264.0, 6285.497160227171, 6295.622262664163, 6295.653739044396, 5973.611715238496, 6090.604110732788, 6092.9086063709965, 6094.573379863456, 6110.346130329577, 6394.968025159845, 6460.192475940507, 6466.547341686037, 6473.385028422293, 6475.870482590416, 6096.451319381277, 6104.26748790148, 6128.571000029955, 6130.846728831815, 6160.0, 5966.403359663999, 6044.84887877789, 6114.48026917717, 6213.720382582705, 6276.278228003838, 5890.3226128994, 5927.525797936069, 5934.109883517334, 5951.256092988377, 5953.821385358447, 5904.675242861684, 5908.468237858613, 5912.024515954819, 5925.05199168131, 5931.347551769216, 5746.856328591819, 5834.0, 5886.41135886425, 5989.251343582052, 6001.159837622824, 6020.036794112921, 6036.84907877289, 6040.879182416415, 6050.818475445743, 6052.697365131814, 5876.294844618673, 5880.088586269135, 5881.470667639933, 5890.322612899571, 5909.113632955091], "value": 5640.073204285055, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [663.6781161136851, 666.5634009723633, 669.2972379002048, 674.8156984492215, 681.3901558105496, 40548.0, 42012.579874201285, 42194.36708449376, 42233.57766422335, 42284.57715422852, 44725.0, 46032.53967460324, 46035.0, 46096.53903460965, 46151.53848461514, 8912.287017038654, 9131.08689131085, 9137.177654011137, 9137.954310228473, 9142.405743626643, 8993.595288212013, 9108.22580080694, 9211.631534738635, 9222.769430764218, 9237.030111838261, 9203.263738900872, 9208.401453905475, 9281.35030547862, 9287.396319239228, 9291.953540232324, 9032.367734258605, 9097.59060842257, 9182.494962777044, 9226.354155209137, 9250.907490925072, 9075.364724469224, 9210.263178945735, 9228.123328283802, 9240.953795231047, 9291.860622090675, 45782.542174578164, 45794.313085303744, 45834.54165458336, 45850.54149458496, 45934.77032614849, 4048.655864251542, 4126.319157339036, 4209.894752631178, 4395.142947125312, 4687.460941991681, 34612.0, 34837.0, 34934.47598286028, 34937.47593786095, 36372.0, 4295.355696645497, 4300.1399720056115, 4325.632321252698, 4337.089211265638, 4379.715318504287, 333766.0, 335769.0, 337090.99999999756, 337314.0, 337850.99999999756, 36886.81556592254, 64316.0, 64835.0, 65245.0, 65303.0, 38394.42408363877, 38484.230315394096, 38512.0, 38521.422178667344, 38551.0, 16878.831211687724, 16980.660386792442, 17077.658446830992, 17090.743638845426, 17121.315147393965, 12824.679383015498, 12850.742985140245, 12872.871271287355, 12907.935460322638, 12910.483580656857, 9498.857517137249, 9623.230141588656, 9662.08210220028, 9665.90334096664, 9698.70903872885, 3557.288542291552, 3671.1372827385544, 3702.148505843671, 3725.590185079639, 3755.8122093895195, 1042.9426381548935, 1081.9513121909533, 1109.9788194860748, 1141.1042331769522, 1144.582227486978, 33752.0, 33958.0, 34203.486947695805, 34300.15381234889, 35035.124121896646, 1213.8422005139275, 1233.6299110266884, 1241.962741117768, 1259.6158171757702, 1266.1326991011003, 18064.27742890296, 18252.726209106873, 18262.452126436227, 18450.630987380177, 18570.721439178422, 309424.0, 315960.0, 323880.0, 333490.0, 423840.0, 65089.349106509275, 67157.66421167862, 67170.0, 67183.66408167928, 67441.66279168573, 1545.3200591739599, 1558.3610719604908, 1568.968620627581, 1585.0648117610665, 1615.135902292268, 34743.30513389769, 34985.30029399347, 35174.47238291479, 35271.0, 35342.46986295156, 56334.0, 57475.71262143662, 57486.7125664369, 57489.0, 57646.7117664409, 456566.0, 456819.0, 460852.0, 461882.0, 464410.0, 32124.19689507781, 32236.83881580577, 32422.351552968335, 43591.56408436002, 43598.0, 46365.53634463612, 46430.767846160554, 47194.0, 47829.28256076231, 48006.0, 42048.369274460296, 42395.57604423916, 43338.78330608327, 43505.56494435142, 44846.3273050911, 42219.7889010553, 42475.36286955636, 43062.0, 43157.56842431535, 43970.0, 41415.7929210352, 41760.0, 41899.58100418957, 44074.11851762883, 44250.778746106065, 33841.3231735359, 34874.82562587171, 35428.114297142776, 37182.0, 37273.25453490969, 27791.72208277972, 27802.304942376602, 28448.43103137884, 28515.42969140564, 29234.269143271587], "value": 19922.950398517936, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [437.6979883880122, 443.4634092747775, 446.72526396266306, 446.7833100946041, 449.5818888433757, 18773.71839422408, 19556.31552895649, 20130.698039529383, 21441.46396340092, 21555.67666485004, 19250.89534421013, 19615.803841961577, 20219.696704549442, 20467.18131274747, 20513.897430512865, 5775.047117225663, 5923.348431672513, 5942.6137301075505, 5943.167956486095, 5962.612430192045, 5823.563232757539, 5875.588708790387, 5911.527077833763, 5917.378675239102, 5931.614445061057, 5804.390538993408, 5846.766129354821, 5852.853678658025, 5854.238948936653, 5857.85355366115, 5608.859778505529, 5796.82609521715, 5808.941910580925, 5837.241158649391, 5841.591088623798, 5147.073526765181, 5195.19474481456, 5205.219217117425, 5276.472352764731, 5301.946980530184, 23773.881130594236, 24007.879960600087, 24016.519669606685, 24055.879720601286, 24210.15264465753, 2574.5494538455696, 2673.1579552440917, 2883.956740648871, 3041.4525385430616, 3094.7214750672324, 14481.275936203148, 14937.626559335995, 14998.550043498712, 15300.0, 15509.767353489706, 2071.5753270579494, 2099.4751312171957, 2120.2791051042564, 2180.3240995291353, 2181.2365672014666, 81786.0, 85045.0, 85696.0, 86627.13372866253, 86741.56629216814, 10609.84085238722, 11094.833577496343, 11242.988131068243, 11249.550017999352, 11579.363135027486, 16086.517404477885, 16222.675546489005, 16291.185440727917, 16340.346386144658, 16347.91826040886, 8330.166983301742, 8592.312614990786, 8605.612747426381, 8723.432976856484, 8784.341174411944, 8291.8341633167, 8319.209675080858, 8320.791980200544, 8405.70580029696, 8461.534615596078, 6822.656898119885, 6963.82590435233, 7024.086868707035, 7026.754063607749, 7070.434365250768, 2067.0491573876184, 2110.4090854560745, 2111.0922303409375, 2119.205298013245, 2131.4032071020138, 1122.9775404491863, 1169.8362229287907, 1185.9110566707532, 1200.0039966827512, 1250.7936190528642, 19997.60004799896, 20061.29785457502, 20092.296769612993, 20095.19619215244, 20139.798602014085, 1076.5586109694987, 1103.1285284625217, 1113.5768408004906, 1114.5176914703425, 1131.6491887514896, 11486.885131148749, 11564.306141631529, 11579.826302605468, 11632.651020469399, 11689.590864319878, 387490.0, 390931.0, 395500.0, 522266.0, 523704.0, 86542.56728716442, 94866.5256673726, 97440.51279743556, 104351.47824260982, 104767.4761626187, 1164.4527072276016, 1185.7154282972197, 1200.4117982188666, 1221.8228356888378, 1251.9812202816966, 17546.21042053085, 17672.55818604545, 17787.822121779132, 17806.732899006784, 17964.461066168034, 40351.3947290785, 41184.0, 41432.1713565733, 41491.0, 43092.78453607712, 58877.70561147167, 59331.703341483015, 59818.700906495185, 60032.39967600268, 60890.0, 7972.920270797218, 8297.0, 8514.701985430727, 8687.826243475221, 8851.955740221258, 9379.531023448664, 12007.459664314953, 12989.480420783062, 13076.462964809016, 13088.149270297401, 11523.481443335239, 11545.13411494158, 11601.941990289995, 11607.477663504993, 11700.765984680429, 10515.894841051491, 11358.09121798635, 11435.714107147387, 11745.706357341134, 11752.58865939688, 11564.595239166589, 12030.15788894769, 12122.575709850113, 12175.512979480722, 12407.503699851904, 8619.310455163446, 8674.175953284428, 8835.602397891982, 8893.822123557622, 8907.1092890713, 9041.23149532297, 11719.589814356457, 12023.519059237533, 12075.758484830078, 12105.69735756613], "value": 9786.303063391906, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1628.1940439482455, 1661.7839680841494, 1868.1686649440996, 1950.327137137687, 1974.4274160493467, 8031.678732850693, 8565.957170214147, 8615.0, 8865.689700860472, 8939.55302234888, 8572.314214862812, 8625.051244363114, 8724.65101395945, 8733.606987685553, 8736.0, 2420.3102115896972, 2449.755024497545, 2465.7410971847967, 2469.987650061747, 2476.455179860428, 2367.95264094718, 2371.087131454394, 2389.569877422072, 2392.138830021191, 2415.5651982643117, 2360.7757263060066, 2403.146882856578, 2409.6867407237037, 2424.963625545618, 2451.0563433078214, 2376.619740841474, 2400.615901455759, 2402.4474370894704, 2413.4569721812627, 2418.7460316666848, 2417.286900364379, 2418.6372044193513, 2443.230382429547, 2450.3751543356507, 2459.7786199241973, 8850.026497085315, 8904.065073167289, 8926.330525210635, 8929.464232146092, 8940.105989401072, 5401.810936617238, 5551.139573366135, 5603.187537806995, 5622.269105016363, 5634.0, 3455.4298540740747, 3541.5218945442293, 3569.8929032129076, 3618.764780289273, 3621.885178746276, 1179.4987130469517, 1201.591458903977, 1207.8887423570336, 1211.3216598704753, 1245.1470742541387, 12373.195742276723, 12405.565805196866, 12448.937755311255, 12469.127161098726, 12501.062420318513, 4776.164171270014, 4849.4908034655855, 4918.48355922623, 4927.679700819435, 5024.2463630454995, 10364.5335959882, 10466.842997355046, 10519.737006574744, 10533.631322903662, 10567.15462762977, 5508.0, 5544.279243698294, 5587.8603034923635, 5593.244911936837, 5596.076647353222, 4545.840895568639, 4942.678725882806, 4983.426905905795, 5011.774470148852, 5074.16276314404, 4139.068709540389, 4151.4395556600075, 4174.290370636999, 4184.623383895403, 4202.768847713344, 1307.7253776706807, 1323.7964126813135, 1329.5413082486527, 1336.0447280194708, 1342.9865701343058, 999.8250306196387, 1051.5268129341828, 1083.1984331594563, 1090.2749671468384, 1109.545086514525, 6097.237845269341, 6145.4161854623735, 6168.259808822881, 6240.4071613196675, 6384.776532821422, 1007.2093406675871, 1018.032868774667, 1052.5316234275826, 1075.3225467955294, 1105.9778804424027, 4170.645495132887, 4171.687123465752, 4219.936700949488, 4229.365595160689, 4254.085371645111, 10555.10281626055, 10903.83644245337, 11000.064994475559, 11118.555257789598, 11141.164412669083, 10888.401137937331, 11263.493142808593, 11309.886901131047, 11353.148513861493, 11353.829692554618, 8134.064582572962, 8476.110008449024, 8476.449030812977, 8591.183837535424, 8598.527081010605, 6236.906446403217, 6301.0, 6400.551961362846, 6411.839704007437, 6479.416852483299, 9863.556139973862, 9937.0, 10202.081812636898, 10286.331388460025, 10341.63804266847, 10156.746081348025, 10386.324888882198, 10440.060394564525, 10444.895551044696, 10529.42088185157, 7379.446541509516, 7630.084389873251, 7711.190325016017, 7841.529508229524, 8003.4797738146835, 8453.492790432594, 8453.619587118717, 8475.83048339042, 8496.91503084986, 8523.360747943805, 7576.62116894142, 7672.079350477979, 7699.076110866732, 7930.563818990011, 7990.920090799018, 7559.962200188964, 7618.542887426772, 7634.885476717965, 7676.6545505453505, 7713.575753333621, 6933.341332573397, 6968.442524597918, 7039.718411263492, 7040.3663670269925, 7053.576785392893, 5102.872428189325, 5170.457102004236, 5197.0, 5244.737763111905, 5360.356757189163, 5488.5334746545395, 5489.4236105209975, 5594.496495315441, 5629.54963602919, 5635.9436405635415], "value": 4815.243129521603, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.30537798603734, 363.31515094047717, 366.6919787378602, 369.8649992752646, 372.53619244041175, 5521.889562208753, 5661.575381846357, 5670.1778242154915, 5786.855328616787, 5811.12833075039, 5453.400125986138, 5671.177679236508, 5683.460071293231, 5694.857628559278, 5716.856628674272, 4394.8901277468, 4436.715091727763, 4438.600525952664, 4440.42274504314, 4455.465344158705, 4199.643030342425, 4402.185595664796, 4417.580329868657, 4450.910981780363, 4478.8208471661255, 4346.608805207531, 4350.56494350564, 4354.303311470166, 4371.31164333934, 4372.366006928994, 4366.301391777316, 4366.847160349373, 4368.453943257093, 4386.8903277418, 4391.8682439526865, 3800.277947190025, 3816.732828701992, 3866.903327416837, 3867.9806600967095, 3877.689784817208, 5436.021516127095, 5476.972615136939, 5502.80740174092, 5514.558835293167, 5540.556755459554, 5012.521306214676, 5018.322526458918, 5019.7741101650145, 5041.596672266247, 5045.344105266292, 5788.0, 5938.2280303560265, 6007.519398448114, 6016.518678505753, 6016.548758843104, 4235.639970602502, 4265.466816647919, 4267.530571637118, 4268.274393353137, 4280.272353699878, 6260.373962603703, 6285.811425657238, 6287.308396076428, 6308.400701933355, 6333.651649159295, 4245.341971994346, 4341.479022517318, 4346.1525002624185, 4350.782460876943, 4360.8909777255185, 4328.11273688893, 4385.6052955233545, 4406.272964960745, 4411.139827733561, 4431.047324825178, 5016.698998060128, 5018.89962200754, 5021.59827213822, 5021.924671129936, 5026.2460630904925, 5783.8554036149435, 5951.077582974646, 6041.124037014608, 6068.695230525458, 6073.878522429615, 1595.15456807892, 1610.9113998730181, 1615.3942271648132, 1615.7495588183851, 1620.2951716003577, 1046.5186014433446, 1063.787242551493, 1064.3986147826454, 1069.7806949575474, 1074.7850429913892, 6192.0, 6206.875862482815, 6221.657808820558, 6286.842828929313, 6287.088372186007, 6594.153636981653, 6605.669716514155, 6666.100161453963, 6672.132622759011, 6678.465722742169, 6017.518598512109, 6152.0, 6196.8760624787255, 6211.81364559064, 6216.968915155395, 3516.9824150879595, 3523.365794157025, 3546.9536486736474, 3561.198730285717, 3562.412201986643, 6138.202033735675, 6457.902156633384, 6473.741050357933, 6474.4496717778575, 6840.828979275459, 6306.211723534559, 6362.331955144643, 6386.648734319564, 6402.391772781578, 6409.262934762469, 6208.81373558794, 6464.709088091047, 6465.870682586322, 6483.286838447767, 6484.286728459866, 6182.567220294536, 6221.191245138103, 6237.812865614039, 6273.498120150468, 6275.560710750204, 5915.290165180206, 6149.292831324455, 6158.445739883432, 6171.537134715004, 6205.441510264098, 6451.41937225652, 6472.967635161794, 6479.838004049937, 6492.837679058061, 6497.935020649922, 4368.366586844953, 4410.536893626123, 4422.579854913778, 4454.26504626733, 4459.554044595644, 6113.0, 6136.557908891317, 6246.094316324198, 6250.843728906813, 6274.560780745304, 5959.67221802805, 6070.0, 6079.392060793885, 6102.694865256631, 6142.0, 5918.73365698536, 6005.939940600538, 6048.60684055535, 6103.0, 6127.84680382994, 5957.0, 5963.73163207648, 5964.31410387811, 5964.522838172849, 5984.593620499266, 6072.332043475126, 6114.510839132948, 6122.510199183966, 6138.202033735586, 6156.199694039746, 5594.0, 5933.347331793586, 5940.346561878104, 5962.224910761746, 5970.910436343545], "value": 4632.360141582477, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [808.365433134989, 899.5637115998744, 908.0556221529612, 909.8635204719292, 914.5015966298366, 14290.571282861505, 14510.927445362784, 14655.26723663818, 14729.968902176839, 14765.18791466469, 12334.383280835968, 14010.299485025733, 14036.298185090756, 14054.859451405482, 14066.507672231473, 865.1305438034766, 919.5586118663012, 922.3912217936163, 923.8290916180528, 924.4499522783966, 912.6075787411411, 920.6639576554543, 930.986035209469, 933.4959122074072, 933.8319102561536, 978.3787295067648, 978.6232300564299, 980.2648013989508, 982.3221976835961, 982.6462473509531, 969.4086607169621, 970.8786401699823, 974.4445665970364, 976.8974257702981, 980.0493521284343, 711.9928800711979, 716.7455553278616, 717.5551158281846, 718.4180813541049, 718.859822334645, 14373.137611743328, 14421.27893605326, 14467.276636168255, 14569.490067847575, 14678.412863485555, 14557.272136393243, 15060.096394216273, 15076.849231507764, 15134.318955646911, 15399.461018864398, 12118.151729378947, 12122.39388030595, 12284.938575307066, 12495.500179992789, 12509.499620015189, 3917.6474117329576, 3944.375723235297, 3947.98026009871, 4013.8795836124964, 4032.4152997815154, 56254.43745562574, 56694.43305566933, 57618.42381576172, 57757.42242577562, 57804.42195578032, 11536.480858361394, 11614.937315030948, 11729.296242225493, 11837.467313970892, 12097.455614497369, 21318.253861114787, 21541.89229053876, 21594.676079858815, 21630.675539866916, 21746.456338591663, 8122.593870306461, 8355.874661880076, 8450.239478446969, 8606.827863442697, 8754.912450875538, 4797.112534181188, 4808.543188397097, 4821.228603423436, 4856.714014492615, 4954.133026720381, 3345.531625572422, 3414.6585341465657, 3419.743519236067, 3422.9144271393416, 3426.297608990151, 635.659921941759, 640.9455196308272, 646.253577118429, 647.5305403582365, 655.1973832055788, 792.9048514178336, 804.7947773317767, 807.7172989453644, 821.4906757810196, 834.2075028722737, 10364.222683298784, 10570.312929659547, 10705.892941070646, 10709.46452677363, 10800.78398432027, 700.28219587071, 777.8599852026576, 810.7324582887633, 820.4420993724206, 821.2977903892206, 4822.324874517571, 4973.303737476756, 4995.50134959518, 5078.4413714491375, 5106.540411362921, 65013.0, 67600.0, 67665.32334676689, 68204.0, 68314.31685683179, 56147.438525615034, 58236.0, 58634.70682646645, 58736.706316469, 59417.92037278674, 51735.48264517382, 51816.74091629518, 51894.0, 52338.0, 52666.47333526692, 9304.627814887328, 9390.577424016072, 9576.473293968898, 9744.658936937172, 9861.0, 33869.98390048303, 35397.0, 35869.1032724184, 36103.45844812383, 36447.81776091103, 47968.0, 48216.758916205195, 48382.0, 48391.27413088877, 49352.75323623359, 12618.432170552163, 12719.364031798557, 12839.935800320938, 12893.548725794552, 12939.482420703443, 13296.734065318833, 13347.265900375573, 13427.865721342661, 13512.527061552799, 13622.114562553403, 13031.02267329935, 13077.346132693518, 13106.082574219714, 13106.868931310564, 13178.406971686489, 12248.265104093784, 12388.070894682754, 12392.504299827906, 12466.314352710326, 12497.937510312753, 11565.074794016627, 11944.522219111139, 12347.75304493923, 12877.871221288042, 13035.283059431822, 10630.681079567625, 10837.45812709377, 10838.891611083789, 10856.837147442953, 10865.18511111654, 10692.679219623424, 11068.778624427627, 11081.778364432828, 11093.223474356717, 11493.482793274155], "value": 7185.981585208051, "unit": "score"}], "name": "dromaeo_css", "value": 7488.023662646282, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 107.0, 112.0, 110.0, 113.0, 124.0, 112.0, 112.0, 112.0, 110.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 130.0, 160.0, 185.0, 128.0, 160.0, 158.0, 128.0, 175.0, 128.0], "value": 150.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 161.0, 163.0, 161.0, 163.0, 162.0, 165.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 74.0, 169.0, 74.0, 74.0, 78.0, 75.0, 171.0, 77.0], "value": 94.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 162.0, 91.0, 92.0, 93.0, 148.0, 97.0, 93.0, 142.0], "value": 110.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 116.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 97.0, 95.0, 94.0, 95.0, 95.0, 97.0, 94.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 60.0, 59.0, 61.0, 58.0, 62.0, 72.0, 56.0, 62.0], "value": 60.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 57.0, 57.0, 57.0, 57.0, 57.0, 58.0, 57.0, 57.0], "value": 57.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 79.0, 72.0, 74.0, 74.0, 73.0, 81.0, 75.0, 73.0], "value": 74.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 121.0, 120.0, 129.0, 117.0, 120.0, 129.0, 119.0, 197.0, 125.0], "value": 129.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 167.0, 160.0, 159.0, 171.0, 170.0, 168.0, 155.0, 162.0, 155.0], "value": 162.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 66.0, 67.0, 65.0, 66.0, 63.0, 68.0, 66.0], "value": 65.7, "unit": "score"}], "name": "kraken", "value": 1539.1999999999998, "alertThreshold": 2.0}]} 03:46:12 INFO - Return code: 0 03:46:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:46:12 ERROR - # TBPL SUCCESS # 03:46:12 INFO - Running post-action listener: _resource_record_post_action 03:46:12 INFO - Running post-run listener: _resource_record_post_run 03:46:13 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 266240; Write bytes: 498921472; Read time: 24; Write time: 523236 03:46:13 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 190590976; Read time: 0; Write time: 262112 03:46:13 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 266240; Write bytes: 250380288; Read time: 24; Write time: 224768 03:46:13 INFO - Running post-run listener: _upload_blobber_files 03:46:13 INFO - Blob upload gear active. 03:46:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:46:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:46:13 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:46:13 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:46:14 INFO - (blobuploader) - INFO - Open directory for files ... 03:46:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:46:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:46:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:15 INFO - (blobuploader) - INFO - Done attempting. 03:46:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:46:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:46:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:16 INFO - (blobuploader) - INFO - Done attempting. 03:46:16 INFO - (blobuploader) - INFO - Iteration through files over. 03:46:16 INFO - Return code: 0 03:46:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:46:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:46:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dbb60ceb499bac646dfc08f9d17534edf8ea2af8f2aee18f8759967b641fd70d4183b016cdbe5339cd25ed39fdf71bb218a8003db74fb420c43f292cd0805428", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0d81a98c825bfc518e8d7ebb836bb62dc9df3426952f7f3030f895876752bd6b9c6b74de0c60c5c5b810c86fe46cd21ab6458e1afde76e721f749179d9d38c68"} 03:46:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:46:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:46:16 INFO - Contents: 03:46:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dbb60ceb499bac646dfc08f9d17534edf8ea2af8f2aee18f8759967b641fd70d4183b016cdbe5339cd25ed39fdf71bb218a8003db74fb420c43f292cd0805428", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0d81a98c825bfc518e8d7ebb836bb62dc9df3426952f7f3030f895876752bd6b9c6b74de0c60c5c5b810c86fe46cd21ab6458e1afde76e721f749179d9d38c68"} 03:46:16 INFO - Running post-run listener: copy_logs_to_upload_dir 03:46:16 INFO - Copying logs to upload dir... 03:46:16 INFO - mkdir: /builds/slave/test/build/upload/logs 03:46:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.431964 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-04-29 03:46:15.999497) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 03:46:16.003503) ========= 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=c6927cf182745ad25b1d38b9000001fe-1461923663.377427-506740734 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/Mozilla-Aurora/sha512/dbb60ceb499bac646dfc08f9d17534edf8ea2af8f2aee18f8759967b641fd70d4183b016cdbe5339cd25ed39fdf71bb218a8003db74fb420c43f292cd0805428", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0d81a98c825bfc518e8d7ebb836bb62dc9df3426952f7f3030f895876752bd6b9c6b74de0c60c5c5b810c86fe46cd21ab6458e1afde76e721f749179d9d38c68"} build_url:https://queue.taskcluster.net/v1/task/I8YlWi5_QtuZvkF-Ziocvg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011231 build_url: 'https://queue.taskcluster.net/v1/task/I8YlWi5_QtuZvkF-Ziocvg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dbb60ceb499bac646dfc08f9d17534edf8ea2af8f2aee18f8759967b641fd70d4183b016cdbe5339cd25ed39fdf71bb218a8003db74fb420c43f292cd0805428", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0d81a98c825bfc518e8d7ebb836bb62dc9df3426952f7f3030f895876752bd6b9c6b74de0c60c5c5b810c86fe46cd21ab6458e1afde76e721f749179d9d38c68"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 03:46:16.028325) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 03:46:16.028747) ========= 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=c6927cf182745ad25b1d38b9000001fe-1461923663.377427-506740734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004544 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 03:46:16.114330) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 03:46:16.114667) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 03:46:16.114986) ========= ========= Total master_lag: 0.17 =========