builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-017 starttime: 1461974067.92 results: success (0) buildid: 20160429140836 builduid: ff0606aa01fa426aa68dbe9a89f6f859 revision: 7c17eb91821968d66808c032fb3f38885d0dedda ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 16:54:27.921420) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 16:54:27.921874) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 16:54:27.922173) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 16:54:27.984714) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 16:54:27.984977) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1461973881.71588-142695310 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-29 16:54:28-- 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% 229M=0s 2016-04-29 16:54:28 (229 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.194415 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 16:54:28.207045) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 16:54:28.207332) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1461973881.71588-142695310 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.090032 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 16:54:28.314343) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 16:54:28.315111) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7c17eb91821968d66808c032fb3f38885d0dedda --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 7c17eb91821968d66808c032fb3f38885d0dedda --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1461973881.71588-142695310 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-29 16:54:28,369 truncating revision to first 12 chars 2016-04-29 16:54:28,370 Setting DEBUG logging. 2016-04-29 16:54:28,370 attempt 1/10 2016-04-29 16:54:28,370 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7c17eb918219?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-29 16:54:28,628 unpacking tar archive at: mozilla-aurora-7c17eb918219/testing/mozharness/ program finished with exit code 0 elapsedTime=0.539395 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 16:54:28.872568) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 16:54:28.873271) ========= script_repo_revision: 7c17eb91821968d66808c032fb3f38885d0dedda ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 16:54:28.874165) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 16:54:28.874883) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 16:54:28.886267) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-04-29 16:54:28.886573) ========= /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=0333a256a5e4f052382dd180000001b1-1461973881.71588-142695310 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:54:29 INFO - MultiFileLogger online at 20160429 16:54:29 in /builds/slave/test 16:54:29 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 16:54:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:54:29 INFO - {'append_to_log': False, 16:54:29 INFO - 'base_work_dir': '/builds/slave/test', 16:54:29 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:54:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:54:29 INFO - 'branch': 'Mozilla-Aurora', 16:54:29 INFO - 'buildbot_json_path': 'buildprops.json', 16:54:29 INFO - 'config_files': ('talos/linux_config.py',), 16:54:29 INFO - 'default_actions': ('clobber', 16:54:29 INFO - 'read-buildbot-config', 16:54:29 INFO - 'download-and-extract', 16:54:29 INFO - 'populate-webroot', 16:54:29 INFO - 'create-virtualenv', 16:54:29 INFO - 'install', 16:54:29 INFO - 'run-tests'), 16:54:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:54:29 INFO - 'download_minidump_stackwalk': True, 16:54:29 INFO - 'download_symbols': 'ondemand', 16:54:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:54:29 INFO - 'tooltool.py': '/tools/tooltool.py', 16:54:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:54:29 INFO - '/tools/misc-python/virtualenv.py')}, 16:54:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:54:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:54:29 INFO - 'installer_path': 'installer.exe', 16:54:29 INFO - 'log_level': 'info', 16:54:29 INFO - 'log_name': 'talos', 16:54:29 INFO - 'log_to_console': True, 16:54:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:54:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:54:29 INFO - 'opt_config_files': (), 16:54:29 INFO - 'pip_index': False, 16:54:29 INFO - 'sps_profile': False, 16:54:29 INFO - 'sps_profile_interval': 0, 16:54:29 INFO - 'suite': 'dromaeojs-e10s', 16:54:29 INFO - 'system_bits': '32', 16:54:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:54:29 INFO - 'title': 'talos-linux64-ix-017', 16:54:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:54:29 INFO - 'use_talos_json': True, 16:54:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:54:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:54:29 INFO - 'work_dir': 'build'} 16:54:29 INFO - ##### 16:54:29 INFO - ##### Running clobber step. 16:54:29 INFO - ##### 16:54:29 INFO - Running pre-action listener: _resource_record_pre_action 16:54:29 INFO - Running main action method: clobber 16:54:29 INFO - rmtree: /builds/slave/test/build 16:54:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:54:31 INFO - Running post-action listener: _resource_record_post_action 16:54:31 INFO - ##### 16:54:31 INFO - ##### Running read-buildbot-config step. 16:54:31 INFO - ##### 16:54:31 INFO - Running pre-action listener: _resource_record_pre_action 16:54:31 INFO - Running main action method: read_buildbot_config 16:54:31 INFO - Using buildbot properties: 16:54:31 INFO - { 16:54:31 INFO - "project": "", 16:54:31 INFO - "product": "firefox", 16:54:31 INFO - "script_repo_revision": "production", 16:54:31 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 16:54:31 INFO - "repository": "", 16:54:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 16:54:31 INFO - "buildid": "20160429140836", 16:54:31 INFO - "pgo_build": "True", 16:54:31 INFO - "basedir": "/builds/slave/test", 16:54:31 INFO - "buildnumber": 243, 16:54:31 INFO - "slavename": "talos-linux64-ix-017", 16:54:31 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:54:31 INFO - "platform": "ubuntu64_hw", 16:54:31 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 16:54:31 INFO - "branch": "mozilla-aurora", 16:54:31 INFO - "repo_path": "releases/mozilla-aurora", 16:54:31 INFO - "revision": "7c17eb91821968d66808c032fb3f38885d0dedda", 16:54:31 INFO - "stage_platform": "linux64-pgo", 16:54:31 INFO - "builduid": "ff0606aa01fa426aa68dbe9a89f6f859", 16:54:31 INFO - "slavebuilddir": "test" 16:54:31 INFO - } 16:54:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/Jw-dlIJzQ6CuQnD3EWWSxw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 16:54:31 INFO - Running post-action listener: _resource_record_post_action 16:54:31 INFO - ##### 16:54:31 INFO - ##### Running download-and-extract step. 16:54:31 INFO - ##### 16:54:31 INFO - Running pre-action listener: _resource_record_pre_action 16:54:31 INFO - Running main action method: download_and_extract 16:54:31 INFO - mkdir: /builds/slave/test/build/tests 16:54:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:54:31 INFO - https://queue.taskcluster.net/v1/task/Jw-dlIJzQ6CuQnD3EWWSxw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:54:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jw-dlIJzQ6CuQnD3EWWSxw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 16:54:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jw-dlIJzQ6CuQnD3EWWSxw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 16:54:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jw-dlIJzQ6CuQnD3EWWSxw/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 16:54:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jw-dlIJzQ6CuQnD3EWWSxw/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 16:54:41 INFO - Downloaded 1361 bytes. 16:54:41 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 16:54:41 INFO - Using the following test package requirements: 16:54:41 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 16:54:41 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:54:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 16:54:41 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:54:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 16:54:41 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:54:41 INFO - u'jsshell-linux-x86_64.zip'], 16:54:41 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:54:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 16:54:41 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 16:54:41 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:54:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 16:54:41 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:54:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 16:54:41 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:54:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 16:54:41 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:54:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 16:54:41 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:54:41 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')]} 16:54:41 INFO - https://queue.taskcluster.net/v1/task/Jw-dlIJzQ6CuQnD3EWWSxw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:54:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jw-dlIJzQ6CuQnD3EWWSxw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 16:54:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jw-dlIJzQ6CuQnD3EWWSxw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 16:54:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jw-dlIJzQ6CuQnD3EWWSxw/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 16:54:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jw-dlIJzQ6CuQnD3EWWSxw/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 16:54:45 INFO - Downloaded 23820742 bytes. 16:54:45 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'] 16:54:45 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 16:54:47 INFO - Return code: 0 16:54:47 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 16:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:54:47 INFO - https://queue.taskcluster.net/v1/task/Jw-dlIJzQ6CuQnD3EWWSxw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:54:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jw-dlIJzQ6CuQnD3EWWSxw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 16:54:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jw-dlIJzQ6CuQnD3EWWSxw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 16:54:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jw-dlIJzQ6CuQnD3EWWSxw/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 16:54:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jw-dlIJzQ6CuQnD3EWWSxw/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 16:54:48 INFO - Downloaded 23820742 bytes. 16:54:48 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'] 16:54:48 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 16:54:50 INFO - Return code: 0 16:54:50 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')]} 16:54:50 INFO - https://queue.taskcluster.net/v1/task/Jw-dlIJzQ6CuQnD3EWWSxw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:54:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jw-dlIJzQ6CuQnD3EWWSxw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 16:54:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jw-dlIJzQ6CuQnD3EWWSxw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 16:54:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jw-dlIJzQ6CuQnD3EWWSxw/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 16:54:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jw-dlIJzQ6CuQnD3EWWSxw/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 16:54:51 INFO - Downloaded 10840145 bytes. 16:54:51 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'] 16:54:51 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 16:54:51 INFO - Return code: 0 16:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:54:51 INFO - https://queue.taskcluster.net/v1/task/Jw-dlIJzQ6CuQnD3EWWSxw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:54:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jw-dlIJzQ6CuQnD3EWWSxw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 16:54:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jw-dlIJzQ6CuQnD3EWWSxw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 16:54:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jw-dlIJzQ6CuQnD3EWWSxw/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 16:54:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jw-dlIJzQ6CuQnD3EWWSxw/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 16:54:57 INFO - Downloaded 62683022 bytes. 16:54:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Jw-dlIJzQ6CuQnD3EWWSxw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 16:54:57 INFO - mkdir: /builds/slave/test/properties 16:54:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:54:57 INFO - Writing to file /builds/slave/test/properties/build_url 16:54:57 INFO - Contents: 16:54:57 INFO - build_url:https://queue.taskcluster.net/v1/task/Jw-dlIJzQ6CuQnD3EWWSxw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 16:54:58 INFO - Running post-action listener: _resource_record_post_action 16:54:58 INFO - Running post-action listener: set_extra_try_arguments 16:54:58 INFO - ##### 16:54:58 INFO - ##### Running populate-webroot step. 16:54:58 INFO - ##### 16:54:58 INFO - Running pre-action listener: _resource_record_pre_action 16:54:58 INFO - Running main action method: populate_webroot 16:54:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:54:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:54:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:54:58 INFO - '--tppagecycles', 16:54:58 INFO - '7'], 16:54:58 INFO - 'tests': ['tsvgm']}}, 16:54:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:54:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:54:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:54:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:54:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:54:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:54:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:58 INFO - 'talos_options': ['--disable-e10s'], 16:54:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:54:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:54:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:58 INFO - 'talos_options': ['--disable-e10s'], 16:54:58 INFO - 'tests': ['damp', 'tps']}, 16:54:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:58 INFO - 'tests': ['damp', 'tps']}, 16:54:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:54:58 INFO - 'tests': ['dromaeo_dom']}, 16:54:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:54:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:54:58 INFO - 'tests': ['a11yr', 16:54:58 INFO - 'ts_paint', 16:54:58 INFO - 'tpaint', 16:54:58 INFO - 'sessionrestore', 16:54:58 INFO - 'sessionrestore_no_auto_restore', 16:54:58 INFO - 'tabpaint']}, 16:54:58 INFO - 'other-e10s': {'tests': ['a11yr', 16:54:58 INFO - 'ts_paint', 16:54:58 INFO - 'tpaint', 16:54:58 INFO - 'sessionrestore', 16:54:58 INFO - 'sessionrestore_no_auto_restore', 16:54:58 INFO - 'tabpaint']}, 16:54:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:54:58 INFO - 'ts_paint', 16:54:58 INFO - 'tpaint', 16:54:58 INFO - 'sessionrestore', 16:54:58 INFO - 'sessionrestore_no_auto_restore', 16:54:58 INFO - 'tabpaint']}, 16:54:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:54:58 INFO - 'ts_paint', 16:54:58 INFO - 'tpaint', 16:54:58 INFO - 'sessionrestore', 16:54:58 INFO - 'sessionrestore_no_auto_restore', 16:54:58 INFO - 'tabpaint']}, 16:54:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:54:58 INFO - 'tests': ['a11yr', 16:54:58 INFO - 'ts_paint', 16:54:58 INFO - 'tpaint', 16:54:58 INFO - 'sessionrestore', 16:54:58 INFO - 'sessionrestore_no_auto_restore', 16:54:58 INFO - 'tabpaint']}, 16:54:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:54:58 INFO - 'tests': ['a11yr', 16:54:58 INFO - 'ts_paint', 16:54:58 INFO - 'tpaint', 16:54:58 INFO - 'sessionrestore', 16:54:58 INFO - 'sessionrestore_no_auto_restore', 16:54:58 INFO - 'tabpaint']}, 16:54:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:54:58 INFO - 'tests': ['tsvgx', 16:54:58 INFO - 'tsvgr_opacity', 16:54:58 INFO - 'tart', 16:54:58 INFO - 'tscrollx', 16:54:58 INFO - 'cart']}, 16:54:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:54:58 INFO - 'tsvgr_opacity', 16:54:58 INFO - 'tart', 16:54:58 INFO - 'tscrollx', 16:54:58 INFO - 'cart']}, 16:54:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:58 INFO - 'talos_options': ['--disable-e10s'], 16:54:58 INFO - 'tests': ['tp5o']}, 16:54:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:58 INFO - 'tests': ['tp5o']}, 16:54:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:58 INFO - 'talos_options': ['--disable-e10s', 16:54:58 INFO - '--xperf_path', 16:54:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:54:58 INFO - 'tests': ['tp5n']}, 16:54:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:58 INFO - 'talos_options': ['--xperf_path', 16:54:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:54:58 INFO - 'tests': ['tp5n']}}, 16:54:58 INFO - 'talos.zip': {'path': '', 16:54:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:54:58 INFO - Running post-action listener: _resource_record_post_action 16:54:58 INFO - ##### 16:54:58 INFO - ##### Running create-virtualenv step. 16:54:58 INFO - ##### 16:54:58 INFO - Running pre-action listener: _resource_record_pre_action 16:54:58 INFO - Running main action method: create_virtualenv 16:54:58 INFO - Creating virtualenv /builds/slave/test/build/venv 16:54:58 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 16:54:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:54:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:54:58 INFO - Using real prefix '/usr' 16:54:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:54:59 INFO - Installing distribute.............................................................................................................................................................................................done. 16:55:01 INFO - Installing pip.................done. 16:55:01 INFO - Return code: 0 16:55:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:55:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:55:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f59d98a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x208d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211c640>, '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 0x211d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211d9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461973881.71588-142695310', '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 16:55:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:55:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:55:01 INFO - Using env: {'DISPLAY': ':0', 16:55:01 INFO - 'HOME': '/home/cltbld', 16:55:01 INFO - 'LANG': 'en_US.UTF-8', 16:55:01 INFO - 'LANGUAGE': 'en_US:en', 16:55:01 INFO - 'LOGNAME': 'cltbld', 16:55:01 INFO - 'MAIL': '/var/mail/cltbld', 16:55:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:01 INFO - 'MOZ_NO_REMOTE': '1', 16:55:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:01 INFO - 'NO_EM_RESTART': '1', 16:55:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:01 INFO - 'PWD': '/builds/slave/test', 16:55:01 INFO - 'SHELL': '/bin/bash', 16:55:01 INFO - 'SHLVL': '1', 16:55:01 INFO - 'TERM': 'linux', 16:55:01 INFO - 'TMOUT': '86400', 16:55:01 INFO - 'USER': 'cltbld', 16:55:01 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461973881.71588-142695310', 16:55:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:01 INFO - '_': '/tools/buildbot/bin/python'} 16:55:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:01 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 16:55:01 INFO - Cleaning up... 16:55:01 INFO - Return code: 0 16:55:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:55:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:55:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f59d98a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x208d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211c640>, '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 0x211d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211d9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461973881.71588-142695310', '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 16:55:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:55:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:55:01 INFO - Using env: {'DISPLAY': ':0', 16:55:01 INFO - 'HOME': '/home/cltbld', 16:55:01 INFO - 'LANG': 'en_US.UTF-8', 16:55:01 INFO - 'LANGUAGE': 'en_US:en', 16:55:01 INFO - 'LOGNAME': 'cltbld', 16:55:01 INFO - 'MAIL': '/var/mail/cltbld', 16:55:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:01 INFO - 'MOZ_NO_REMOTE': '1', 16:55:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:01 INFO - 'NO_EM_RESTART': '1', 16:55:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:01 INFO - 'PWD': '/builds/slave/test', 16:55:01 INFO - 'SHELL': '/bin/bash', 16:55:01 INFO - 'SHLVL': '1', 16:55:01 INFO - 'TERM': 'linux', 16:55:01 INFO - 'TMOUT': '86400', 16:55:01 INFO - 'USER': 'cltbld', 16:55:01 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461973881.71588-142695310', 16:55:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:01 INFO - '_': '/tools/buildbot/bin/python'} 16:55:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:02 INFO - Downloading/unpacking psutil>=0.7.1 16:55:02 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 16:55:02 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 16:55:02 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 16:55:02 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 16:55:02 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 16:55:02 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 16:55:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:55:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:55:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:55:04 INFO - Installing collected packages: psutil 16:55:04 INFO - Running setup.py install for psutil 16:55:04 INFO - building 'psutil._psutil_linux' extension 16:55:04 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 16:55:04 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 16:55:04 INFO - building 'psutil._psutil_posix' extension 16:55:04 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 16:55: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 16:55:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:55:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:55:05 INFO - Successfully installed psutil 16:55:05 INFO - Cleaning up... 16:55:05 INFO - Return code: 0 16:55:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:55: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')]} 16:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55: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')]} 16:55:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55: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 0x7f59d98a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x208d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211c640>, '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 0x211d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211d9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461973881.71588-142695310', '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 16:55: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 16:55: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 16:55:05 INFO - Using env: {'DISPLAY': ':0', 16:55:05 INFO - 'HOME': '/home/cltbld', 16:55:05 INFO - 'LANG': 'en_US.UTF-8', 16:55:05 INFO - 'LANGUAGE': 'en_US:en', 16:55:05 INFO - 'LOGNAME': 'cltbld', 16:55:05 INFO - 'MAIL': '/var/mail/cltbld', 16:55:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:05 INFO - 'MOZ_NO_REMOTE': '1', 16:55:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:05 INFO - 'NO_EM_RESTART': '1', 16:55:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:05 INFO - 'PWD': '/builds/slave/test', 16:55:05 INFO - 'SHELL': '/bin/bash', 16:55:05 INFO - 'SHLVL': '1', 16:55:05 INFO - 'TERM': 'linux', 16:55:05 INFO - 'TMOUT': '86400', 16:55:05 INFO - 'USER': 'cltbld', 16:55:05 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461973881.71588-142695310', 16:55:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:05 INFO - '_': '/tools/buildbot/bin/python'} 16:55:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:55:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:55:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:55:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:55:07 INFO - Installing collected packages: mozsystemmonitor 16:55:07 INFO - Running setup.py install for mozsystemmonitor 16:55:07 INFO - Successfully installed mozsystemmonitor 16:55:07 INFO - Cleaning up... 16:55:07 INFO - Return code: 0 16:55:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:55:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:55:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f59d98a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x208d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211c640>, '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 0x211d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211d9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461973881.71588-142695310', '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 16:55:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:55:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:55:07 INFO - Using env: {'DISPLAY': ':0', 16:55:07 INFO - 'HOME': '/home/cltbld', 16:55:07 INFO - 'LANG': 'en_US.UTF-8', 16:55:07 INFO - 'LANGUAGE': 'en_US:en', 16:55:07 INFO - 'LOGNAME': 'cltbld', 16:55:07 INFO - 'MAIL': '/var/mail/cltbld', 16:55:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:07 INFO - 'MOZ_NO_REMOTE': '1', 16:55:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:07 INFO - 'NO_EM_RESTART': '1', 16:55:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:07 INFO - 'PWD': '/builds/slave/test', 16:55:07 INFO - 'SHELL': '/bin/bash', 16:55:07 INFO - 'SHLVL': '1', 16:55:07 INFO - 'TERM': 'linux', 16:55:07 INFO - 'TMOUT': '86400', 16:55:07 INFO - 'USER': 'cltbld', 16:55:07 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461973881.71588-142695310', 16:55:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:07 INFO - '_': '/tools/buildbot/bin/python'} 16:55:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:07 INFO - Downloading/unpacking blobuploader==1.2.4 16:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:55:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:09 INFO - Downloading blobuploader-1.2.4.tar.gz 16:55:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:55:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:55:09 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 16:55:09 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 16:55:09 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 16:55:09 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 16:55:09 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 16:55:09 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 16:55:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:55:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:55: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 16:55: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 16:55: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 16:55: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 16:55: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 16:55: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 16:55:10 INFO - Downloading docopt-0.6.1.tar.gz 16:55:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:55:10 INFO - Installing collected packages: blobuploader, requests, docopt 16:55:10 INFO - Running setup.py install for blobuploader 16:55:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:55:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:55:10 INFO - Running setup.py install for requests 16:55:11 INFO - Running setup.py install for docopt 16:55:11 INFO - Successfully installed blobuploader requests docopt 16:55:11 INFO - Cleaning up... 16:55:11 INFO - Return code: 0 16:55:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:55: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')]} 16:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55: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')]} 16:55:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55: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 0x7f59d98a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x208d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211c640>, '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 0x211d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211d9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461973881.71588-142695310', '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 16:55: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 16:55: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 16:55:11 INFO - Using env: {'DISPLAY': ':0', 16:55:11 INFO - 'HOME': '/home/cltbld', 16:55:11 INFO - 'LANG': 'en_US.UTF-8', 16:55:11 INFO - 'LANGUAGE': 'en_US:en', 16:55:11 INFO - 'LOGNAME': 'cltbld', 16:55:11 INFO - 'MAIL': '/var/mail/cltbld', 16:55:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:11 INFO - 'MOZ_NO_REMOTE': '1', 16:55:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:11 INFO - 'NO_EM_RESTART': '1', 16:55:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:11 INFO - 'PWD': '/builds/slave/test', 16:55:11 INFO - 'SHELL': '/bin/bash', 16:55:11 INFO - 'SHLVL': '1', 16:55:11 INFO - 'TERM': 'linux', 16:55:11 INFO - 'TMOUT': '86400', 16:55:11 INFO - 'USER': 'cltbld', 16:55:11 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461973881.71588-142695310', 16:55:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:11 INFO - '_': '/tools/buildbot/bin/python'} 16:55:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:55:11 INFO - Running setup.py (path:/tmp/pip-TIRwpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:55:11 INFO - Running setup.py (path:/tmp/pip-lHXD6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:55:11 INFO - Running setup.py (path:/tmp/pip-p_K_pq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:55:11 INFO - Running setup.py (path:/tmp/pip-zuTxDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:55:11 INFO - Running setup.py (path:/tmp/pip-uq4hF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:55:11 INFO - Running setup.py (path:/tmp/pip-PldKIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:55:11 INFO - Running setup.py (path:/tmp/pip-JJIF4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:55:11 INFO - Running setup.py (path:/tmp/pip-Q1GfCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:55:11 INFO - Running setup.py (path:/tmp/pip-qW4qwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:55:12 INFO - Running setup.py (path:/tmp/pip-B9VXOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:55:12 INFO - Running setup.py (path:/tmp/pip-WYbq6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:55:12 INFO - Running setup.py (path:/tmp/pip-NMXZgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:55:12 INFO - Running setup.py (path:/tmp/pip-FH9Kx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:55:12 INFO - Running setup.py (path:/tmp/pip-z4srMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:55:12 INFO - Running setup.py (path:/tmp/pip-0lO3Rg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:55:12 INFO - Running setup.py (path:/tmp/pip-1Pg1Nw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:55:12 INFO - Running setup.py (path:/tmp/pip-I8JSAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:55:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:55:12 INFO - Running setup.py install for manifestparser 16:55:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:55:12 INFO - Running setup.py install for mozcrash 16:55:12 INFO - Running setup.py install for mozdebug 16:55:12 INFO - Running setup.py install for mozdevice 16:55:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:55:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:55:13 INFO - Running setup.py install for mozfile 16:55:13 INFO - Running setup.py install for mozhttpd 16:55:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:55:13 INFO - Running setup.py install for mozinfo 16:55:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:55:13 INFO - Running setup.py install for mozInstall 16:55:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:55:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:55:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:55:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:55:13 INFO - Running setup.py install for mozleak 16:55:13 INFO - Running setup.py install for mozlog 16:55:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:55:13 INFO - Running setup.py install for moznetwork 16:55:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:55:13 INFO - Running setup.py install for mozprocess 16:55:13 INFO - Running setup.py install for mozprofile 16:55:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:55:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:55:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:55:13 INFO - Running setup.py install for mozrunner 16:55:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:55:14 INFO - Running setup.py install for mozscreenshot 16:55:14 INFO - Running setup.py install for moztest 16:55:14 INFO - Running setup.py install for mozversion 16:55:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:55:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:55:14 INFO - Cleaning up... 16:55:14 INFO - Return code: 0 16:55:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:55: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')]} 16:55:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55: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')]} 16:55:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55: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 0x7f59d98a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x208d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211c640>, '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 0x211d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211d9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461973881.71588-142695310', '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 16:55: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 16:55: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 16:55:14 INFO - Using env: {'DISPLAY': ':0', 16:55:14 INFO - 'HOME': '/home/cltbld', 16:55:14 INFO - 'LANG': 'en_US.UTF-8', 16:55:14 INFO - 'LANGUAGE': 'en_US:en', 16:55:14 INFO - 'LOGNAME': 'cltbld', 16:55:14 INFO - 'MAIL': '/var/mail/cltbld', 16:55:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:14 INFO - 'MOZ_NO_REMOTE': '1', 16:55:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:14 INFO - 'NO_EM_RESTART': '1', 16:55:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:14 INFO - 'PWD': '/builds/slave/test', 16:55:14 INFO - 'SHELL': '/bin/bash', 16:55:14 INFO - 'SHLVL': '1', 16:55:14 INFO - 'TERM': 'linux', 16:55:14 INFO - 'TMOUT': '86400', 16:55:14 INFO - 'USER': 'cltbld', 16:55:14 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461973881.71588-142695310', 16:55:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:14 INFO - '_': '/tools/buildbot/bin/python'} 16:55:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:55:14 INFO - Running setup.py (path:/tmp/pip-Jq4HIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:55:14 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)) 16:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:55:14 INFO - Running setup.py (path:/tmp/pip-_VCnfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:55:14 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)) 16:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:55:14 INFO - Running setup.py (path:/tmp/pip-DFvTZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:55:14 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)) 16:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:55:14 INFO - Running setup.py (path:/tmp/pip-YTeyWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:55:14 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)) 16:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:55:14 INFO - Running setup.py (path:/tmp/pip-7dH1ZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:55:14 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)) 16:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:55:14 INFO - Running setup.py (path:/tmp/pip-6RodM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:55: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)) 16:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:55:15 INFO - Running setup.py (path:/tmp/pip-Q_cPfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:55: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)) 16:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:55:15 INFO - Running setup.py (path:/tmp/pip-KrVg5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:55: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)) 16:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:55:15 INFO - Running setup.py (path:/tmp/pip-HRt3xq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:55: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)) 16:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:55:15 INFO - Running setup.py (path:/tmp/pip-QJndqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:55: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)) 16:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:55:15 INFO - Running setup.py (path:/tmp/pip-1YYpDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:55: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)) 16:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:55:15 INFO - Running setup.py (path:/tmp/pip-6XhdU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:55: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)) 16:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:55:15 INFO - Running setup.py (path:/tmp/pip-lrBwcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:55:15 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)) 16:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:55:15 INFO - Running setup.py (path:/tmp/pip-qiGmJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:55:15 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)) 16:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:55:15 INFO - Running setup.py (path:/tmp/pip-CnwYxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:55:15 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)) 16:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:55:15 INFO - Running setup.py (path:/tmp/pip-Eocast-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:55:15 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)) 16:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:55:15 INFO - Running setup.py (path:/tmp/pip-299g4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:55:15 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)) 16:55:15 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)) 16:55:15 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)) 16:55:15 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)) 16:55:15 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)) 16:55:15 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)) 16:55:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:55:15 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 16:55:15 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 16:55:15 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 16:55:15 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 16:55:15 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 16:55:15 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 16:55:17 INFO - Downloading blessings-1.6.tar.gz 16:55:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:55:17 INFO - Installing collected packages: blessings 16:55:17 INFO - Running setup.py install for blessings 16:55:17 INFO - Successfully installed blessings 16:55:17 INFO - Cleaning up... 16:55:18 INFO - Return code: 0 16:55:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:55:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:55:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:55:18 INFO - Reading from file tmpfile_stdout 16:55:18 INFO - Current package versions: 16:55:18 INFO - argparse == 1.2.1 16:55:18 INFO - blessings == 1.6 16:55:18 INFO - blobuploader == 1.2.4 16:55:18 INFO - docopt == 0.6.1 16:55:18 INFO - manifestparser == 1.1 16:55:18 INFO - mozInstall == 1.12 16:55:18 INFO - mozcrash == 0.17 16:55:18 INFO - mozdebug == 0.1 16:55:18 INFO - mozdevice == 0.48 16:55:18 INFO - mozfile == 1.2 16:55:18 INFO - mozhttpd == 0.7 16:55:18 INFO - mozinfo == 0.9 16:55:18 INFO - mozleak == 0.1 16:55:18 INFO - mozlog == 3.1 16:55:18 INFO - moznetwork == 0.27 16:55:18 INFO - mozprocess == 0.22 16:55:18 INFO - mozprofile == 0.28 16:55:18 INFO - mozrunner == 6.11 16:55:18 INFO - mozscreenshot == 0.1 16:55:18 INFO - mozsystemmonitor == 0.0 16:55:18 INFO - moztest == 0.7 16:55:18 INFO - mozversion == 1.4 16:55:18 INFO - psutil == 3.1.1 16:55:18 INFO - requests == 1.2.3 16:55:18 INFO - wsgiref == 0.1.2 16:55:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:55: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')]} 16:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55: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')]} 16:55:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55: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 0x7f59d98a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x208d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211c640>, '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 0x211d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211d9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461973881.71588-142695310', '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 16:55: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 16:55: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 16:55:18 INFO - Using env: {'DISPLAY': ':0', 16:55:18 INFO - 'HOME': '/home/cltbld', 16:55:18 INFO - 'LANG': 'en_US.UTF-8', 16:55:18 INFO - 'LANGUAGE': 'en_US:en', 16:55:18 INFO - 'LOGNAME': 'cltbld', 16:55:18 INFO - 'MAIL': '/var/mail/cltbld', 16:55:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:18 INFO - 'MOZ_NO_REMOTE': '1', 16:55:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:18 INFO - 'NO_EM_RESTART': '1', 16:55:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:18 INFO - 'PWD': '/builds/slave/test', 16:55:18 INFO - 'SHELL': '/bin/bash', 16:55:18 INFO - 'SHLVL': '1', 16:55:18 INFO - 'TERM': 'linux', 16:55:18 INFO - 'TMOUT': '86400', 16:55:18 INFO - 'USER': 'cltbld', 16:55:18 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461973881.71588-142695310', 16:55:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:18 INFO - '_': '/tools/buildbot/bin/python'} 16:55:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55: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)) 16:55: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)) 16:55: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)) 16:55: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)) 16:55: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)) 16:55: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)) 16:55: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)) 16:55: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)) 16:55: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)) 16:55: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)) 16:55: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)) 16:55:18 INFO - Cleaning up... 16:55:18 INFO - Return code: 0 16:55:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:55: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')]} 16:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55: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')]} 16:55:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55: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 0x7f59d98a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x208d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211c640>, '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 0x211d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211d9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461973881.71588-142695310', '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 16:55: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 16:55: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 16:55:18 INFO - Using env: {'DISPLAY': ':0', 16:55:18 INFO - 'HOME': '/home/cltbld', 16:55:18 INFO - 'LANG': 'en_US.UTF-8', 16:55:18 INFO - 'LANGUAGE': 'en_US:en', 16:55:18 INFO - 'LOGNAME': 'cltbld', 16:55:18 INFO - 'MAIL': '/var/mail/cltbld', 16:55:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:18 INFO - 'MOZ_NO_REMOTE': '1', 16:55:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:18 INFO - 'NO_EM_RESTART': '1', 16:55:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:18 INFO - 'PWD': '/builds/slave/test', 16:55:18 INFO - 'SHELL': '/bin/bash', 16:55:18 INFO - 'SHLVL': '1', 16:55:18 INFO - 'TERM': 'linux', 16:55:18 INFO - 'TMOUT': '86400', 16:55:18 INFO - 'USER': 'cltbld', 16:55:18 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461973881.71588-142695310', 16:55:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:18 INFO - '_': '/tools/buildbot/bin/python'} 16:55:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:18 INFO - Downloading/unpacking jsonschema 16:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:55:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:55:20 INFO - Downloading/unpacking functools32 (from jsonschema) 16:55: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 16:55: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 16:55: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 16:55: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 16:55: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 16:55: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 16:55:20 INFO - Downloading functools32-3.2.3-2.tar.gz 16:55:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:55:20 INFO - warning: no files found matching '*.txt' 16:55:20 INFO - no previously-included directories found matching 'build' 16:55:20 INFO - no previously-included directories found matching 'dist' 16:55:20 INFO - no previously-included directories found matching '.git*' 16:55:20 INFO - Installing collected packages: jsonschema, functools32 16:55:20 INFO - Running setup.py install for functools32 16:55:20 INFO - warning: no files found matching '*.txt' 16:55:20 INFO - no previously-included directories found matching 'build' 16:55:20 INFO - no previously-included directories found matching 'dist' 16:55:20 INFO - no previously-included directories found matching '.git*' 16:55:21 INFO - Successfully installed jsonschema functools32 16:55:21 INFO - Cleaning up... 16:55:21 INFO - Return code: 0 16:55:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:55: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')]} 16:55:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55: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')]} 16:55:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55: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 0x7f59d98a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x208d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211c640>, '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 0x211d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211d9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461973881.71588-142695310', '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 16:55: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 16:55: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 16:55:21 INFO - Using env: {'DISPLAY': ':0', 16:55:21 INFO - 'HOME': '/home/cltbld', 16:55:21 INFO - 'LANG': 'en_US.UTF-8', 16:55:21 INFO - 'LANGUAGE': 'en_US:en', 16:55:21 INFO - 'LOGNAME': 'cltbld', 16:55:21 INFO - 'MAIL': '/var/mail/cltbld', 16:55:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:21 INFO - 'MOZ_NO_REMOTE': '1', 16:55:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:21 INFO - 'NO_EM_RESTART': '1', 16:55:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:21 INFO - 'PWD': '/builds/slave/test', 16:55:21 INFO - 'SHELL': '/bin/bash', 16:55:21 INFO - 'SHLVL': '1', 16:55:21 INFO - 'TERM': 'linux', 16:55:21 INFO - 'TMOUT': '86400', 16:55:21 INFO - 'USER': 'cltbld', 16:55:21 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461973881.71588-142695310', 16:55:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:21 INFO - '_': '/tools/buildbot/bin/python'} 16:55:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:21 INFO - Downloading/unpacking flake8 16:55: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 16:55: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 16:55: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 16:55: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 16:55: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 16:55: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 16:55:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:55:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:55: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 16:55: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 16:55: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 16:55: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 16:55: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 16:55: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 16:55:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:55:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:55: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 16:55: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 16:55: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 16:55: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 16:55: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 16:55: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 16:55:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:55: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 16:55: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 16:55: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 16:55: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 16:55: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 16:55: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 16:55:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:55:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:55:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:55:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:55:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:55:23 INFO - no previously-included directories found matching 'docs/_build' 16:55:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:55:23 INFO - Running setup.py install for pep8 16:55:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:55:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:55:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:55:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:55:23 INFO - no previously-included directories found matching 'docs/_build' 16:55:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:55:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:55:24 INFO - Cleaning up... 16:55:24 INFO - Return code: 0 16:55:24 INFO - Running post-action listener: _resource_record_post_action 16:55:24 INFO - Running post-action listener: _start_resource_monitoring 16:55:24 INFO - Starting resource monitoring. 16:55:24 INFO - ##### 16:55:24 INFO - ##### Running install step. 16:55:24 INFO - ##### 16:55:24 INFO - Running pre-action listener: _resource_record_pre_action 16:55:24 INFO - Running main action method: install 16:55:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:55:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:55:24 INFO - Reading from file tmpfile_stdout 16:55:24 INFO - Detecting whether we're running mozinstall >=1.0... 16:55:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:55:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:55:24 INFO - Reading from file tmpfile_stdout 16:55:24 INFO - Output received: 16:55:24 INFO - Usage: mozinstall [options] installer 16:55:24 INFO - Options: 16:55:24 INFO - -h, --help show this help message and exit 16:55:24 INFO - -d DEST, --destination=DEST 16:55:24 INFO - Directory to install application into. [default: 16:55:24 INFO - "/builds/slave/test"] 16:55:24 INFO - --app=APP Application being installed. [default: firefox] 16:55:24 INFO - mkdir: /builds/slave/test/build/application 16:55: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'] 16:55: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 16:55:39 INFO - Reading from file tmpfile_stdout 16:55:39 INFO - Output received: 16:55:39 INFO - /builds/slave/test/build/application/firefox/firefox 16:55:39 INFO - Running post-action listener: _resource_record_post_action 16:55:39 INFO - ##### 16:55:39 INFO - ##### Running run-tests step. 16:55:39 INFO - ##### 16:55:39 INFO - Running pre-action listener: _resource_record_pre_action 16:55:39 INFO - Running main action method: run_tests 16:55:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:55:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:55:39 INFO - Python 2.7.3 16:55:39 INFO - Return code: 0 16:55:39 INFO - grabbing minidump binary from tooltool 16:55:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:55:39 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 0x211c640>, '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 0x211d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211d9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:55:39 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 16:55:39 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 16:55:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:55:40 INFO - Return code: 0 16:55:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:55:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:55:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:55:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:55:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:55:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:55:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:55:41 INFO - Return code: 0 16:55: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/Jw-dlIJzQ6CuQnD3EWWSxw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:55: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/Jw-dlIJzQ6CuQnD3EWWSxw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:55:41 INFO - Using env: {'DISPLAY': ':0', 16:55:41 INFO - 'HOME': '/home/cltbld', 16:55:41 INFO - 'LANG': 'en_US.UTF-8', 16:55:41 INFO - 'LANGUAGE': 'en_US:en', 16:55:41 INFO - 'LOGNAME': 'cltbld', 16:55:41 INFO - 'MAIL': '/var/mail/cltbld', 16:55:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:55:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:55:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:41 INFO - 'MOZ_NO_REMOTE': '1', 16:55:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:55:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:41 INFO - 'NO_EM_RESTART': '1', 16:55:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:41 INFO - 'PWD': '/builds/slave/test', 16:55:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:55:41 INFO - 'SHELL': '/bin/bash', 16:55:41 INFO - 'SHLVL': '1', 16:55:41 INFO - 'TERM': 'linux', 16:55:41 INFO - 'TMOUT': '86400', 16:55:41 INFO - 'USER': 'cltbld', 16:55:41 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461973881.71588-142695310', 16:55:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:41 INFO - '_': '/tools/buildbot/bin/python'} 16:55: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/Jw-dlIJzQ6CuQnD3EWWSxw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:55:41 INFO - mozversion application_buildid: 20160429140836 16:55:41 INFO - mozversion application_changeset: 7c17eb91821968d66808c032fb3f38885d0dedda 16:55:41 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:55:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:55:41 INFO - mozversion application_name: Firefox 16:55:41 INFO - mozversion application_remotingname: firefox-dev 16:55:41 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:55:41 INFO - mozversion application_vendor: Mozilla 16:55:41 INFO - mozversion application_version: 48.0a2 16:55:41 INFO - mozversion platform_buildid: 20160429140836 16:55:41 INFO - mozversion platform_changeset: 7c17eb91821968d66808c032fb3f38885d0dedda 16:55:41 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:55:41 INFO - mozversion platform_version: 48.0a2 16:55:41 INFO - using testdate: 1461974141 16:55:41 INFO - actual date: 1461974141 16:55:41 INFO - starting webserver on 'localhost:45446' 16:55:41 INFO - SUITE-START | Running 2 tests 16:55:41 INFO - TEST-START | dromaeo_css 16:55:41 INFO - operating with platform_type : linux_ 16:55:41 INFO - Initialising browser for dromaeo_css test... 16:55:41 INFO - TEST-INFO | started process 3276 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw_gtEF/profile http://localhost:45446/getInfo.html) 16:55:46 INFO - PROCESS | 3276 | 16:55:46 INFO - PROCESS | 3276 | (process:3351): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:55:47 INFO - PROCESS | 3276 | __metrics Screen width/height:1600/1200 16:55:47 INFO - PROCESS | 3276 | colorDepth:24 16:55:47 INFO - PROCESS | 3276 | Browser inner width/height: 1024/697 16:55:47 INFO - PROCESS | 3276 | __metrics 16:55:47 ERROR - PROCESS | 3276 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 16:55:48 INFO - TEST-INFO | 3276: exit 0 16:55:48 INFO - Browser initialized. 16:55:48 INFO - Running cycle 1/1 for dromaeo_css test... 16:55:48 INFO - TEST-INFO | started process 3402 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw_gtEF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:55:50 INFO - PROCESS | 3402 | 16:55:50 INFO - PROCESS | 3402 | (process:3472): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:56:00 INFO - PROCESS | 3402 | RSS: Main: 152416256 16:56:00 INFO - PROCESS | 3402 | 16:56:50 INFO - PROCESS | 3402 | 1461974210288 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] 16:58:57 INFO - PROCESS | 3402 | Cycle 1(1): loaded http://localhost:45446/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45446/tests/dromaeo/cssquery-ext.html) 16:58:58 INFO - PROCESS | 3402 | RSS: Main: 155623424 16:58:58 INFO - PROCESS | 3402 | 17:02:00 INFO - PROCESS | 3402 | Cycle 1(1): loaded http://localhost:45446/tests/dromaeo/cssquery-ext.html (next: http://localhost:45446/tests/dromaeo/cssquery-jquery.html) 17:02:01 INFO - PROCESS | 3402 | RSS: Main: 153915392 17:02:01 INFO - PROCESS | 3402 | 17:05:03 INFO - PROCESS | 3402 | Cycle 1(1): loaded http://localhost:45446/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45446/tests/dromaeo/cssquery-mootools.html) 17:05:03 INFO - PROCESS | 3402 | RSS: Main: 153866240 17:05:03 INFO - PROCESS | 3402 | 17:08:05 INFO - PROCESS | 3402 | Cycle 1(1): loaded http://localhost:45446/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45446/tests/dromaeo/cssquery-prototype.html) 17:08:05 INFO - PROCESS | 3402 | RSS: Main: 153464832 17:08:05 INFO - PROCESS | 3402 | 17:11:08 INFO - PROCESS | 3402 | Cycle 1(1): loaded http://localhost:45446/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45446/tests/dromaeo/cssquery-yui.html) 17:11:08 INFO - PROCESS | 3402 | RSS: Main: 154841088 17:11:08 INFO - PROCESS | 3402 | 17:14:11 INFO - PROCESS | 3402 | Cycle 1(1): loaded http://localhost:45446/tests/dromaeo/cssquery-yui.html (next: http://localhost:45446/tests/dromaeo/cssquery-dojo.html) 17:14:11 INFO - PROCESS | 3402 | RSS: Main: 156012544 17:14:11 INFO - PROCESS | 3402 | 17:14:11 INFO - PROCESS | 3402 | __start_tp_report 17:14:11 INFO - PROCESS | 3402 | _x_x_mozilla_page_load 17:14:11 INFO - PROCESS | 3402 | _x_x_mozilla_page_load_details 17:14:11 INFO - PROCESS | 3402 | |i|pagename|runs| 17:14:11 INFO - PROCESS | 3402 | |0;dojo.html;3307.6526964668706;3368.7473439492037;3391.118309239597;3418.846151923162;3423.0586588688107;5602.24369710089;5631.5776316776255;5641.492265696086;5652.547796176306;5665.773369065238;5574.554035677146;5615.2138700581845;5638.295213098363;5664.461876121762;5687.146927960797;5062.367204099488;5132.23016547519;5138.563222126124;5143.897122057557;5157.6647517911215;5021.673591216578;5145.125328694112;5255.842324730245;5267.420583735786;5270.789168433277;5040.042391945537;5074.340335756347;5113.616478764089;5120.92318615221;5126.436092029874;5162.328897243353;5171.612129090333;5191.948080519184;5194.6104042196985;5203.427622961472;4944.802207911679;5059.949400506021;5116.513931176532;5157.329547158845;5175.663581867167;5436.510714035756;5459.645123066988;5466.726663666801;5512.531434828044;5583.469570390806;5948.7323070461935;5995.100734889757;5998.700064996733;6009.06859436788;6018.2778066631845;5992.820215393545;6014.2181516403025;6069.998450255703;6072.9696351518405;6081.483073938721;5554.527865131468;5678.375378708339;5715.999999999958;5741.971290143564;5771.740271687742;6138.416850399205;6151.6001459904965;6160.229971253593;6166.938330616636;6175.104609831639;5829.970850145722;5872.354041055481;5930.2883653960935;5933.851653708692;5949.791757288474;5963.701814909324;6084.756609735649;6087.29996050451;6098.32918378978;6129.448349648553;5910.231669882888;5941.821745347646;5961.374055724174;5965.970170149121;5985.700714964321;5820.417958204146;5864.237649105589;5959.404059594006;5965;5991.370906054889;4543.659225558096;4580.610648094883;4584.564466375689;4604.332371806069;4609.585137337655;4081.9795901020307;4104.712670113123;4129.8023125699365;4143.7928103594695;4148.315527937917;5687.488126068591;5762.30852297727;5802.21670074543;5829.125631155276;5837.09525023622;5977.910331345033;6066.150738896558;6082.695865206722;6130.948521380002;6158.630482171084;5785.942140578541;5788.5369170466265;5791.7683292667825;5792.073268277056;5798.217240672455;5066.290719299301;5126.69239845603;5174.327337446108;5179.896402071938;5229.712365819916;6190.783322583688;6192.473639740672;6193.566450348522;6204.968975155095;6212.565120441616;5952.5237980960555;5961.8807623846415;5984.848861674885;5998.9100163496705;6055.333913269625;5987.760489580368;6162.876742465215;6206.100115483139;6313.08460273267;6337.207849018872;5920.615160014585;5920.644761314335;5925.377835327401;5940.227770389822;5966.0454327307425;5992.940070599238;6004.099385092271;6019.879602408015;6024.307204671519;6032.8793424132145;5800.56495762811;5828.970855145697;5908.763649453974;5917.5857689961285;5945.672987985529;5937.851553711192;5948.910766338595;5959.731812068554;5976.910346344721;5998.160257563857;5699.9145012825675;5873.324567674601;5883.441073098049;5897.3807750187325;5911.9949608565785;5944.464998150187;6001.099835024781;6005.099235114768;6014.0678194879865;6023.27720673522;5773.364929857628;5784.074548072288;5786.594938354275;5799.159121927381;5840 17:14:11 INFO - PROCESS | 3402 | |1;ext.html;669.5212922760226;677.2753154125085;684.0389253099394;703.419678765019;770.7379490973075;37894.43158352627;38433;38664.806675966654;38701.61298387015;39061.60938390615;43205.567944320544;43717.34423983643;44011.55988440115;44075.11849763003;44089.77955110228;8739.4756314621;8915.910840891605;8972;8976.955115224448;8982.461052336848;8719.738407847775;8815.77960550985;8827.33794965377;8833.1608497193;8846.690365837198;8807.119288071173;8884.600192991298;8885.68900088497;8893.377463577552;8905.599248033854;8770.210681038738;8817.29461643067;8835.0281469039;8857.557122143899;8859.379843410963;8767.868481972775;8824.02935677075;8848.778780530474;8871.201591856763;8877.112288771135;39894.401583976265;40529.59470405288;40745.185096298206;41046.1790764183;41138;3722.758020728671;3886.0867696091395;3901;3911.7457365271166;4005.998500374906;33103.83448082744;33348;33365.666343336496;33430.1642458938;33882.49176262334;4330.675199360029;4440.866773996785;4451.910961780779;4492.68551201416;4495.190865644183;281571;282228;284582;287097;287352.9999999979;36531.452028219595;60422.69788651029;61003.69498152481;61519.6924015386;61905.38094618996;38288.80855595704;38451.42322865159;38612.80693596514;38628.22743545113;38722;17398.478045658652;17416.564585885455;17468.126593670266;17610;17642.823571764377;14803.333849976776;14910.627234319229;14961.251937403304;14979.70040599182;14983.700325993637;9448.90551094494;9585.664501742405;9680.661176858775;9694.46680432583;9729.513524323755;3591.1560783215923;3618.9638103619154;3652.6529979652423;3672.6878215351994;3688.2623475305045;1121.697141771717;1198.9040876729841;1211.0009242375077;1225.718084840474;1227.2820400065882;33480.66519334824;34277.45751441191;34393.82803085969;34478.13804654904;34643.82678086594;1219.8170274458903;1229.244014930811;1234.975300493985;1276.3171703138962;1285.9421326040163;17986.27297983692;18084.4018424001;18152.283655047453;18159.653873439835;18220.36228731988;398426;402826;406796;409072;508212;65624.34375656278;66496.66751666211;66519;66635;66963.33036669668;1577.747560390332;1581.1303782919579;1581.8892677512695;1587.2857214253631;1652.3060314667869;33919.491207631414;34145.48781768226;34168.48747268743;34584;34821.82589087039;57883;59106;59203;59239.40760592339;59262;438411;450645;454062;454270;454471;31827.522587160747;32185.907915985386;32214.516782248753;32392.676073238967;32540.349193016482;51760;51953.22070169026;52431;53148;53452;43029.56970430256;43310.56689433191;45338.77330613458;45487.77256113698;46098;43515;43744.562554374046;43767.34348984832;44977.32534012058;45190.32214516851;44027.77986110049;44939.32591011072;45398.09203815971;45565.54434455746;45853.54146458493;37539.06152346213;38978.6102138975;39172.6082739169;39280.410793837545;39802.60197397989;29369.80140884345;29806;30305.848470757504;30464.238394040327;30797.692023080377 17:14:11 INFO - PROCESS | 3402 | |2;jquery.html;413.2705774308348;416.7112911234653;424.3528618856246;434.63273533863895;446.5668301747305;18777;19069.427917162473;19122.808771912278;19150.52123696908;19411.41765747028;18983.81016189838;19517;19641.705374419395;19683.901580492115;20046.699299510517;5652.491275785179;5895;5919.260092488439;5930.110483427477;5941.940580594182;4233.068724880522;5855.092460668603;5860.706964651772;6234.594751341148;6526.314736952623;6435.742570297182;6439.452646525051;6461.19235095613;6465;6477.028445733131;6334.429901308881;6360;6381;6405.903911441332;6425.132607098076;5584.5811564132855;5792.739326730307;5813.186153938452;5827.504662103726;5827.650340979555;23975;24215.87892060546;24433.267001989967;24467.755322446905;24527.754722452904;2610.138654244095;2750.4499100180046;3060.9540856887165;3200.8399580020905;3269.5095735639607;14279.57161285163;15341.232938353038;15422.228888555639;15432.614184645361;15476.226188690633;1903.1816318982833;1980.1485361294638;2013.1041686449537;2296.552172326397;2436.926892193237;83759;92542;96917.51541242319;98199.50900245525;101095;18382.448526544224;18427.170777315052;18525.258989640264;18937.337193198447;18985.240590376507;34266.65733342685;34926.65073349285;34956.12609684727;35229.8238508811;35365.29269414649;10802.72993175177;10902.563897444172;11072.833907491395;11164.888351116548;11330.886691133148;9736.902630973742;9782.804343913082;9788.706338809847;9835.508224588742;9836.163896080534;9026.323025772961;9175.587098580447;9295.58169882357;9376.578053987587;9470.479123648265;2058.8147066764063;2152.2144417287577;2162.7729088445803;2195.5279614882875;3484.591991131221;1011.585250047477;1112.4882554025078;1117.3240189685287;1140.105017561227;1160.5821904114512;19265.80734192668;19858.50353741139;19870.304539341054;20002.799972000386;20219.494512637302;1085.3379438542484;1094.1301665176204;1112.9666110016713;1148.9138314626268;1169.128998895828;10338.689839304832;11273.54905803775;11350.262232954832;11357.261777984404;11403.942980285046;493324;496304;509172;510156;516909;99056;99417;100120;101420;104096.47951760193;1108.3239224073309;1114.5597488991802;1126.7295848996182;1128.7234627516311;1135.5174051028114;17523.56191095182;17709.468715938543;17779.46661600154;18020.54948626295;18081.728774068135;33180;38772;40139.79930100331;41858.790706046275;41892.371614425196;55862.16206756983;57302.42697572971;57998.42001580099;58823.70588147032;59083.113753294594;9008.369414140947;9065.818683626423;9076.273898088006;9200.079992001014;9278.025807290407;11695.590654327058;13553.59339219825;13578.25319607431;13595;13823.723525529635;11811.173217874666;12043.458044388199;12110.697232569257;12183.451744671689;12316;11673.649790506299;11821.881781182077;11857.28856268592;11897.762044758883;12074.094442916641;12034.63896083119;12103.334316612318;12339.13626046204;12352.567660131852;12550.246985180918;8562.315014798925;8665.913340866762;8761.29909607217;8867.68963086289;8947.284217262473;11613;11634.301941883514;11731.88268117308;11830.52677892909;11911.702207444883 17:14:11 INFO - PROCESS | 3402 | |3;mootools.html;1574.2758331167659;1620.513845846246;1800.0909540681962;1846.8984205868671;1893.9431817045493;7368.778936631909;8002.759917202478;8163.95918020409;8300;8325.33397328213;8212.630431630576;8254.42219044667;8266.751997440086;8317.667293308275;8329.333653307736;2334.8132149428006;2373.050779688121;2373.549025685123;2377.6909001829736;2384.237044145874;2342.4612339161918;2416.5287768885073;2463.310273123528;2466.963875172423;2480.838745481547;2392.9880350598223;2400.23192578375;2418.854868707874;2420.9636855447184;2432.2460037388464;2341.005072844043;2345.4019225097663;2346.636271377931;2353.776391242829;2376.750441203666;2312.3756585721762;2372.3001714494267;2377.7859992600575;2394.916177933764;2405.615101583738;8372.41393102483;8415.495070295801;8420.663173473054;8465.746027619181;8467.449615775016;5204.271402003723;5323.361196656388;5390.865228369283;5421.918671219895;5434.347878254595;3562.1985053363046;3630.2013557017412;3649.908752281188;3688.188598508324;3713.4986776785327;1238.182799352432;1251.9687007824787;1288.15625765124;1323.2325251354287;1334.8665133486575;11488.483018264198;11488.942555287254;11558.95969362753;11589.014933730643;11616.651500455;4666.136764698474;4684.6252299816615;4750.738709371018;4753.833615823499;4783.115123702126;9856.359336643238;9944.30389872702;9953.900460995297;9956;9970.45162516054;5348.732563371816;5370.140777475585;5371.355437347544;5377.354717433933;5437.619366644297;4351.325544540601;4768.213244814567;4871.439784424837;4916.680415772963;4932.778024988884;4010.1378203685763;4016.397540368968;4104.774237416911;4121.216968775923;4138.8551400700835;1328.3756634381825;1330.5010621017118;1353.6818847570812;1369.233229391524;1390.2909516146838;897.7935074932802;911.2300106410073;930.55798495714;955.6702937486556;967.849983252597;5804.564657650693;5809.7095145242565;5817.447342502455;5838.065909454467;5873.177755114288;983.8868530119128;1036.6423583863555;1038.0346277961416;1057.6245432871374;1065.307550092446;3919.3729003359326;3932.2135572884963;4011.7592944423427;4024.4164596133396;4072.7759973201164;9903.80192396148;10150.695479135638;10274.537645805956;10466.267361284637;10561.313514621525;10287.382757034602;10436.217283703601;10440.582376704999;10476.161907047417;10499.94750026245;7903.130655627876;8136.471129376571;8140.674373025013;8197.754067377988;8237.546934918637;5734.799282025109;5856.59003869725;5865.266841644794;5867.266591676041;5979.820605381846;9627.326087173831;9756.26827987918;9790.461524616214;9802.85295720579;9865.161461275871;9561.521923903916;9812.116909478182;9944.701658950244;10005.449700266556;10078.496075196357;6534.183227096613;6826.078479405217;6985.5808651481075;7155.24869888675;7273.418126549969;8026.919730802851;8107.22981316774;8118.959405202936;8153.1846815317995;8167.55078470666;6941.548799328028;7148.821279467847;7219.205887352492;7339.339459448675;7373.3732632726815;7314.184039144861;7373.18894921569;7377;7386.891966205112;7439.55362678241;6808.931910681028;6821.386075253053;6821.863562728817;6875.965620171867;6879.828004299732;4946.109700253989;4964.652474326763;4971.825986090469;4972.353594032753;4995.750212489288;5083.345773001063;5106.872328191825;5151.175811870083;5233;5234.7906083756225 17:14:11 INFO - PROCESS | 3402 | |4;prototype.html;344.49703432987855;347.7878494118587;352.2215902854691;360.28843035005866;362.72070505710604;5718.828435146942;5731.764611801401;5768.336641286253;5773.653580785156;5787.768489260435;5669.9433005669935;5674.262345895038;5677.716114194284;5700.828975130742;5707.77168913244;4053.7770422626745;4354.47746270448;4391.967887546424;4411.757353345564;4443.911121777563;4388.188185185735;4427.380166776654;4437.733735975852;4438.578335058164;4443.488998765151;4377.233984052794;4393.275109606911;4419.337099435078;4430.933535996946;4432.667549933752;4278.7860606969525;4386.934195987063;4389.802458889341;4390.604845563883;4393.472783265996;3859.9228015439535;3892.5718171001167;3893.162969961472;3904.2777086238852;3909.4331321958443;5441.5102640762125;5468.152436372368;5510.228568000483;5513.724313784295;5520.751566179491;4910.312556242129;5061.721605311706;5090.981803639287;5107.897842043176;5124.641275110744;5928.458600763789;5972.25346831646;5992.730327135246;5999.2002399280045;6006.429389208019;4311.439512863339;4328.11273688893;4330.133973205371;4336.739795612273;4383.715058521186;6029.698515074228;6212.409821066992;6217.942949698562;6248.750049997994;6319.210098737658;4374.19077470669;4407.757573333497;4415.62467190286;4424.203643344229;4431.667624928144;4406.559344065632;4448.933266001012;4462.330650402466;4462.6388951370145;4485.304777759387;4834.516548345137;5093.032323858455;5117.948820511821;5142.537171654494;5159.664621799571;6084.269887613426;6085.17850090241;6096.207493025879;6125.601835880653;6145.201123853871;1587.9603009924845;1625.3579835964965;1637.1977730912006;1641.3188526761498;1646.0864220357817;1084.487140439083;1085.3270971997254;1111.927724697892;1115.1413411672966;1116.938568378747;6235.251769787655;6287.654179020198;6315.747370105236;6316.526260530479;6331.905021424683;6485.286618471964;6598.47212223021;6623.9006414903815;6673.399394054559;6697.196336439659;6234.937650623527;6266.905996410058;6274.403931626488;6288.465480434214;6299.842503937347;3536.328097661436;3547.113221694576;3550.1479644885044;3559.857605695743;3578.8389522471552;6706.865862682719;6892.758753443605;6902.206246281641;6961.199462061826;6968.65156742171;6711.228208756055;6769.289224631441;6787.321267873173;6787.898181527281;6800.591964482147;6169.210928830678;6544.247411547638;6607.735690572419;6612.057634352667;6964.164300283897;6270.592411493239;6288.685565721604;6288.779892703734;6335.651539165206;6354;6031.336552979081;6231.844203894939;6240.906386404116;6260.906086408617;6272.466840318624;6526.934730652632;6566.244881838458;6617.239017513048;6624.8343791405605;6640.236372816995;4351.282038463744;4431.3574531692075;4450.265706158448;4465.330200469825;4490.955090449184;6074.240719910012;6315.715792789428;6335.782476133317;6366.586171898812;6367.713452894724;6139.508839292936;6152.046432802923;6169.352218017044;6179.567430279837;6215.533834962305;5968.299034775068;6108.694565271808;6135.067453752054;6144.2319710036245;6172.4136207060255;5889.440503152194;5998.910016349845;6078.3588431124235;6096.9390306096375;6100.1459795629535;6140.508759299335;6143.815685529441;6187.628742275478;6197;6206.658633775005;5940.227770389822;6000.8799824004145;6038.969805150946;6077.604955677867;6079 17:14:11 INFO - PROCESS | 3402 | |5;yui.html;750.1448348882271;772.7449941519295;810.4245985350401;896.5920506169692;911.3074063711581;14173.29133543324;15006.549803505912;15121.924390378046;16389.262483188257;16817.747733784003;15703.685926281467;15720.921395393036;15783.28975196116;15790.526284211492;15799.447019354326;746.9439792015594;912.6258234124027;917.4495302818323;920.9539523023822;922.1378011559214;887.3389324952919;901.4816480523692;909.154486327715;915.4873270968279;918.6692790595414;955.5652178258875;963.0802583532744;963.5952899782073;964.0215181590692;967.6419724701835;957.2294303086013;958.0850287974968;958.5782255807458;959.9616015359377;962.1340793286064;703.707961196103;704.1163340008308;705.5413980912397;705.8094314535098;710.3855165282046;15148.545543633709;15262.542123736306;15289;15383.461578844799;15390.692186156326;14595.270236488239;14620.488282910153;14691.706165876623;14709.411623535047;14820.3330850112;10399.428031458267;10703.78592428147;10775.137988960865;10857;11247.60633377836;3970.4441378207075;3971.285168669638;3979.6816254699843;4035.616616421435;4115.32097203961;57337.42662573363;57763.711181443825;58496.415035849524;58675.41324586785;58845.705771471294;11096.223264371578;11139.610113645984;11146.88531146895;11222.719432014264;11236.213465057532;20707.482312941996;20720.58558828815;20734;20852.687209691867;20892.686609700868;8362.289205417486;8618.827623447496;8779.736607901774;8808.20726134651;8987.41581797181;5086.847394578169;5093.541581257705;5133.922991155136;5177.715225662625;5218.582513398995;3539.486774417695;3585.515955345995;3592.946105808415;3594.3530164570107;3602.1534939289245;643.3052303512195;643.83904023994;651.6448535548137;660.5046215338496;668.1848145262771;721.913370395556;796.2475460689593;799.2207597592417;833.1918039501674;850.2815121222557;10213.897861021444;10516.316439431412;10518.158547316349;10717.892821071846;10823.67528974132;688.1088989758275;758.4539131825077;778.8208711996273;808.1756608259542;828.8963879515061;4399.142167277414;4672.789724462407;4763.237881938942;4855.684380515255;5018.698878067327;66483.66758166178;69413;69605.65197174084;70074.64962675257;70144.2985570148;60351.69824150939;61104.69447652733;61745.69127154425;62155.378446215866;62696;54930.45069549253;55742.72128639412;55785.16322255088;56161.438385616435;56417.43582564204;9725.221982241545;9735.41587504752;9772.267079969173;9938.850917236103;9946.751331216778;37603.81198094101;37737.43393849149;37785.811070944466;37989.430158548195;38131.23737525178;45044.32433513434;48045.519544804105;50364.74817625889;51371.74314128405;51414.74292628513;13370.264635445144;13425.462981480632;13443.596692099252;13534.86465135336;13741.381637826122;14727;15179.089254644316;15313.234338282818;15548.533543993699;15567;14336.49822256216;14349.713005740035;14383.640408989859;14443.133411995314;14698;12637.684057898627;12698.936505317415;12906.548270810477;12920.806187907378;12954.80567791465;11140.665780026613;11405.372704501;12057.577984770842;12234.694132646755;14274.500392486214;10522.842157367493;10619.469026548488;10749.89250107489;10761.89238107609;10936.781264374828;10313.845292320471;10403.791924161626;10410.895891040993;10479.895201047892;10699.14406847466 17:14:11 INFO - PROCESS | 3402 | __end_tp_report 17:14:11 INFO - PROCESS | 3402 | __start_cc_report 17:14:11 INFO - PROCESS | 3402 | _x_x_mozilla_cycle_collect,328 17:14:11 INFO - PROCESS | 3402 | __end_cc_report 17:14:11 INFO - PROCESS | 3402 | __startTimestamp1461975251343__endTimestamp 17:14:11 INFO - PROCESS | 3402 | 17:14:11 INFO - PROCESS | 3402 | ------- Summary: start ------- 17:14:11 INFO - PROCESS | 3402 | Number of tests: 6 17:14:11 INFO - PROCESS | 3402 | 17:14:11 INFO - PROCESS | 3402 | [#0] dojo.html Cycles:165 Average:5603.96 Median:5829.97 stddev:621.22 (10.7%) stddev-sans-first:596.43 17:14:11 INFO - PROCESS | 3402 | Values: 3307.7 3368.7 3391.1 3418.8 3423.1 5602.2 5631.6 5641.5 5652.5 5665.8 5574.6 5615.2 5638.3 5664.5 5687.1 5062.4 5132.2 5138.6 5143.9 5157.7 5021.7 5145.1 5255.8 5267.4 5270.8 5040.0 5074.3 5113.6 5120.9 5126.4 5162.3 5171.6 5191.9 5194.6 5203.4 4944.8 5059.9 5116.5 5157.3 5175.7 5436.5 5459.6 5466.7 5512.5 5583.5 5948.7 5995.1 5998.7 6009.1 6018.3 5992.8 6014.2 6070.0 6073.0 6081.5 5554.5 5678.4 5716.0 5742.0 5771.7 6138.4 6151.6 6160.2 6166.9 6175.1 5830.0 5872.4 5930.3 5933.9 5949.8 5963.7 6084.8 6087.3 6098.3 6129.4 5910.2 5941.8 5961.4 5966.0 5985.7 5820.4 5864.2 5959.4 5965.0 5991.4 4543.7 4580.6 4584.6 4604.3 4609.6 4082.0 4104.7 4129.8 4143.8 4148.3 5687.5 5762.3 5802.2 5829.1 5837.1 5977.9 6066.2 6082.7 6130.9 6158.6 5785.9 5788.5 5791.8 5792.1 5798.2 5066.3 5126.7 5174.3 5179.9 5229.7 6190.8 6192.5 6193.6 6205.0 6212.6 5952.5 5961.9 5984.8 5998.9 6055.3 5987.8 6162.9 6206.1 6313.1 6337.2 5920.6 5920.6 5925.4 5940.2 5966.0 5992.9 6004.1 6019.9 6024.3 6032.9 5800.6 5829.0 5908.8 5917.6 5945.7 5937.9 5948.9 5959.7 5976.9 5998.2 5699.9 5873.3 5883.4 5897.4 5912.0 5944.5 6001.1 6005.1 6014.1 6023.3 5773.4 5784.1 5786.6 5799.2 5840.0 17:14:11 INFO - PROCESS | 3402 | 17:14:11 INFO - PROCESS | 3402 | [#1] ext.html Cycles:180 Average:55954.37 Median:223770.59 stddev:104153.15 (46.5%) stddev-sans-first:104362.62 17:14:11 INFO - PROCESS | 3402 | Values: 669.5 677.3 684.0 703.4 770.7 37894.4 38433.0 38664.8 38701.6 39061.6 43205.6 43717.3 44011.6 44075.1 44089.8 8739.5 8915.9 8972.0 8977.0 8982.5 8719.7 8815.8 8827.3 8833.2 8846.7 8807.1 8884.6 8885.7 8893.4 8905.6 8770.2 8817.3 8835.0 8857.6 8859.4 8767.9 8824.0 8848.8 8871.2 8877.1 39894.4 40529.6 40745.2 41046.2 41138.0 3722.8 3886.1 3901.0 3911.7 4006.0 33103.8 33348.0 33365.7 33430.2 33882.5 4330.7 4440.9 4451.9 4492.7 4495.2 281571.0 282228.0 284582.0 287097.0 287353.0 36531.5 60422.7 61003.7 61519.7 61905.4 38288.8 38451.4 38612.8 38628.2 38722.0 17398.5 17416.6 17468.1 17610.0 17642.8 14803.3 14910.6 14961.3 14979.7 14983.7 9448.9 9585.7 9680.7 9694.5 9729.5 3591.2 3619.0 3652.7 3672.7 3688.3 1121.7 1198.9 1211.0 1225.7 1227.3 33480.7 34277.5 34393.8 34478.1 34643.8 1219.8 1229.2 1235.0 1276.3 1285.9 17986.3 18084.4 18152.3 18159.7 18220.4 398426.0 402826.0 406796.0 409072.0 508212.0 65624.3 66496.7 66519.0 66635.0 66963.3 1577.7 1581.1 1581.9 1587.3 1652.3 33919.5 34145.5 34168.5 34584.0 34821.8 57883.0 59106.0 59203.0 59239.4 59262.0 438411.0 450645.0 454062.0 454270.0 454471.0 31827.5 32185.9 32214.5 32392.7 32540.3 51760.0 51953.2 52431.0 53148.0 53452.0 43029.6 43310.6 45338.8 45487.8 46098.0 43515.0 43744.6 43767.3 44977.3 45190.3 44027.8 44939.3 45398.1 45565.5 45853.5 37539.1 38978.6 39172.6 39280.4 39802.6 29369.8 29806.0 30305.8 30464.2 30797.7 17:14:11 INFO - PROCESS | 3402 | 17:14:11 INFO - PROCESS | 3402 | [#2] jquery.html Cycles:180 Average:31356.44 Median:2246.04 stddev:83449.86 (3715.4%) stddev-sans-first:83651.61 17:14:11 INFO - PROCESS | 3402 | Values: 413.3 416.7 424.4 434.6 446.6 18777.0 19069.4 19122.8 19150.5 19411.4 18983.8 19517.0 19641.7 19683.9 20046.7 5652.5 5895.0 5919.3 5930.1 5941.9 4233.1 5855.1 5860.7 6234.6 6526.3 6435.7 6439.5 6461.2 6465.0 6477.0 6334.4 6360.0 6381.0 6405.9 6425.1 5584.6 5792.7 5813.2 5827.5 5827.7 23975.0 24215.9 24433.3 24467.8 24527.8 2610.1 2750.4 3061.0 3200.8 3269.5 14279.6 15341.2 15422.2 15432.6 15476.2 1903.2 1980.1 2013.1 2296.6 2436.9 83759.0 92542.0 96917.5 98199.5 101095.0 18382.4 18427.2 18525.3 18937.3 18985.2 34266.7 34926.7 34956.1 35229.8 35365.3 10802.7 10902.6 11072.8 11164.9 11330.9 9736.9 9782.8 9788.7 9835.5 9836.2 9026.3 9175.6 9295.6 9376.6 9470.5 2058.8 2152.2 2162.8 2195.5 3484.6 1011.6 1112.5 1117.3 1140.1 1160.6 19265.8 19858.5 19870.3 20002.8 20219.5 1085.3 1094.1 1113.0 1148.9 1169.1 10338.7 11273.5 11350.3 11357.3 11403.9 493324.0 496304.0 509172.0 510156.0 516909.0 99056.0 99417.0 100120.0 101420.0 104096.5 1108.3 1114.6 1126.7 1128.7 1135.5 17523.6 17709.5 17779.5 18020.5 18081.7 33180.0 38772.0 40139.8 41858.8 41892.4 55862.2 57302.4 57998.4 58823.7 59083.1 9008.4 9065.8 9076.3 9200.1 9278.0 11695.6 13553.6 13578.3 13595.0 13823.7 11811.2 12043.5 12110.7 12183.5 12316.0 11673.6 11821.9 11857.3 11897.8 12074.1 12034.6 12103.3 12339.1 12352.6 12550.2 8562.3 8665.9 8761.3 8867.7 8947.3 11613.0 11634.3 11731.9 11830.5 11911.7 17:14:11 INFO - PROCESS | 3402 | 17:14:11 INFO - PROCESS | 3402 | [#3] mootools.html Cycles:180 Average:5646.05 Median:5095.11 stddev:3058.56 (60.0%) stddev-sans-first:3051.83 17:14:11 INFO - PROCESS | 3402 | Values: 1574.3 1620.5 1800.1 1846.9 1893.9 7368.8 8002.8 8164.0 8300.0 8325.3 8212.6 8254.4 8266.8 8317.7 8329.3 2334.8 2373.1 2373.5 2377.7 2384.2 2342.5 2416.5 2463.3 2467.0 2480.8 2393.0 2400.2 2418.9 2421.0 2432.2 2341.0 2345.4 2346.6 2353.8 2376.8 2312.4 2372.3 2377.8 2394.9 2405.6 8372.4 8415.5 8420.7 8465.7 8467.4 5204.3 5323.4 5390.9 5421.9 5434.3 3562.2 3630.2 3649.9 3688.2 3713.5 1238.2 1252.0 1288.2 1323.2 1334.9 11488.5 11488.9 11559.0 11589.0 11616.7 4666.1 4684.6 4750.7 4753.8 4783.1 9856.4 9944.3 9953.9 9956.0 9970.5 5348.7 5370.1 5371.4 5377.4 5437.6 4351.3 4768.2 4871.4 4916.7 4932.8 4010.1 4016.4 4104.8 4121.2 4138.9 1328.4 1330.5 1353.7 1369.2 1390.3 897.8 911.2 930.6 955.7 967.8 5804.6 5809.7 5817.4 5838.1 5873.2 983.9 1036.6 1038.0 1057.6 1065.3 3919.4 3932.2 4011.8 4024.4 4072.8 9903.8 10150.7 10274.5 10466.3 10561.3 10287.4 10436.2 10440.6 10476.2 10499.9 7903.1 8136.5 8140.7 8197.8 8237.5 5734.8 5856.6 5865.3 5867.3 5979.8 9627.3 9756.3 9790.5 9802.9 9865.2 9561.5 9812.1 9944.7 10005.4 10078.5 6534.2 6826.1 6985.6 7155.2 7273.4 8026.9 8107.2 8119.0 8153.2 8167.6 6941.5 7148.8 7219.2 7339.3 7373.4 7314.2 7373.2 7377.0 7386.9 7439.6 6808.9 6821.4 6821.9 6876.0 6879.8 4946.1 4964.7 4971.8 4972.4 4995.8 5083.3 5106.9 5151.2 5233.0 5234.8 17:14:11 INFO - PROCESS | 3402 | 17:14:11 INFO - PROCESS | 3402 | [#4] prototype.html Cycles:180 Average:5177.74 Median:5908.95 stddev:1558.45 (26.4%) stddev-sans-first:1520.01 17:14:11 INFO - PROCESS | 3402 | Values: 344.5 347.8 352.2 360.3 362.7 5718.8 5731.8 5768.3 5773.7 5787.8 5669.9 5674.3 5677.7 5700.8 5707.8 4053.8 4354.5 4392.0 4411.8 4443.9 4388.2 4427.4 4437.7 4438.6 4443.5 4377.2 4393.3 4419.3 4430.9 4432.7 4278.8 4386.9 4389.8 4390.6 4393.5 3859.9 3892.6 3893.2 3904.3 3909.4 5441.5 5468.2 5510.2 5513.7 5520.8 4910.3 5061.7 5091.0 5107.9 5124.6 5928.5 5972.3 5992.7 5999.2 6006.4 4311.4 4328.1 4330.1 4336.7 4383.7 6029.7 6212.4 6217.9 6248.8 6319.2 4374.2 4407.8 4415.6 4424.2 4431.7 4406.6 4448.9 4462.3 4462.6 4485.3 4834.5 5093.0 5117.9 5142.5 5159.7 6084.3 6085.2 6096.2 6125.6 6145.2 1588.0 1625.4 1637.2 1641.3 1646.1 1084.5 1085.3 1111.9 1115.1 1116.9 6235.3 6287.7 6315.7 6316.5 6331.9 6485.3 6598.5 6623.9 6673.4 6697.2 6234.9 6266.9 6274.4 6288.5 6299.8 3536.3 3547.1 3550.1 3559.9 3578.8 6706.9 6892.8 6902.2 6961.2 6968.7 6711.2 6769.3 6787.3 6787.9 6800.6 6169.2 6544.2 6607.7 6612.1 6964.2 6270.6 6288.7 6288.8 6335.7 6354.0 6031.3 6231.8 6240.9 6260.9 6272.5 6526.9 6566.2 6617.2 6624.8 6640.2 4351.3 4431.4 4450.3 4465.3 4491.0 6074.2 6315.7 6335.8 6366.6 6367.7 6139.5 6152.0 6169.4 6179.6 6215.5 5968.3 6108.7 6135.1 6144.2 6172.4 5889.4 5998.9 6078.4 6096.9 6100.1 6140.5 6143.8 6187.6 6197.0 6206.7 5940.2 6000.9 6039.0 6077.6 6079.0 17:14:11 INFO - PROCESS | 3402 | 17:14:11 INFO - PROCESS | 3402 | [#5] yui.html Cycles:180 Average:16093.31 Median:24721.73 stddev:18885.69 (76.4%) stddev-sans-first:18903.53 17:14:11 INFO - PROCESS | 3402 | Values: 750.1 772.7 810.4 896.6 911.3 14173.3 15006.5 15121.9 16389.3 16817.7 15703.7 15720.9 15783.3 15790.5 15799.4 746.9 912.6 917.4 921.0 922.1 887.3 901.5 909.2 915.5 918.7 955.6 963.1 963.6 964.0 967.6 957.2 958.1 958.6 960.0 962.1 703.7 704.1 705.5 705.8 710.4 15148.5 15262.5 15289.0 15383.5 15390.7 14595.3 14620.5 14691.7 14709.4 14820.3 10399.4 10703.8 10775.1 10857.0 11247.6 3970.4 3971.3 3979.7 4035.6 4115.3 57337.4 57763.7 58496.4 58675.4 58845.7 11096.2 11139.6 11146.9 11222.7 11236.2 20707.5 20720.6 20734.0 20852.7 20892.7 8362.3 8618.8 8779.7 8808.2 8987.4 5086.8 5093.5 5133.9 5177.7 5218.6 3539.5 3585.5 3592.9 3594.4 3602.2 643.3 643.8 651.6 660.5 668.2 721.9 796.2 799.2 833.2 850.3 10213.9 10516.3 10518.2 10717.9 10823.7 688.1 758.5 778.8 808.2 828.9 4399.1 4672.8 4763.2 4855.7 5018.7 66483.7 69413.0 69605.7 70074.6 70144.3 60351.7 61104.7 61745.7 62155.4 62696.0 54930.5 55742.7 55785.2 56161.4 56417.4 9725.2 9735.4 9772.3 9938.9 9946.8 37603.8 37737.4 37785.8 37989.4 38131.2 45044.3 48045.5 50364.7 51371.7 51414.7 13370.3 13425.5 13443.6 13534.9 13741.4 14727.0 15179.1 15313.2 15548.5 15567.0 14336.5 14349.7 14383.6 14443.1 14698.0 12637.7 12698.9 12906.5 12920.8 12954.8 11140.7 11405.4 12057.6 12234.7 14274.5 10522.8 10619.5 10749.9 10761.9 10936.8 10313.8 10403.8 10410.9 10479.9 10699.1 17:14:11 INFO - PROCESS | 3402 | -------- Summary: end -------- 17:14:11 INFO - PROCESS | 3402 | 17:14:11 INFO - TEST-INFO | 3402: exit 0 17:14:12 INFO - TEST-OK | dromaeo_css | took 1110548ms 17:14:12 INFO - TEST-START | kraken 17:14:12 INFO - operating with platform_type : linux_ 17:14:12 INFO - Initialising browser for kraken test... 17:14:12 INFO - TEST-INFO | started process 3645 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBzd90G/profile http://localhost:45446/getInfo.html) 17:14:15 INFO - PROCESS | 3645 | 17:14:15 INFO - PROCESS | 3645 | (process:3726): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:14:16 INFO - PROCESS | 3645 | __metrics Screen width/height:1600/1200 17:14:16 INFO - PROCESS | 3645 | colorDepth:24 17:14:16 INFO - PROCESS | 3645 | Browser inner width/height: 1024/697 17:14:16 INFO - PROCESS | 3645 | __metrics 17:14:17 ERROR - PROCESS | 3645 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 17:14:18 INFO - TEST-INFO | 3645: exit 0 17:14:18 INFO - Browser initialized. 17:14:18 INFO - Running cycle 1/1 for kraken test... 17:14:18 INFO - TEST-INFO | started process 3777 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBzd90G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:14:19 INFO - PROCESS | 3777 | 17:14:19 INFO - PROCESS | 3777 | (process:3845): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:14:29 INFO - PROCESS | 3777 | RSS: Main: 152563712 17:14:29 INFO - PROCESS | 3777 | 17:14:32 INFO - PROCESS | 3777 | Cycle 1(1): loaded http://localhost:45446/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45446/tests/kraken/driver.html?testName=audio-beat-detection) 17:14:33 INFO - PROCESS | 3777 | RSS: Main: 156528640 17:14:33 INFO - PROCESS | 3777 | 17:14:35 INFO - PROCESS | 3777 | Cycle 1(1): loaded http://localhost:45446/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45446/tests/kraken/driver.html?testName=audio-dft) 17:14:36 INFO - PROCESS | 3777 | RSS: Main: 156905472 17:14:36 INFO - PROCESS | 3777 | 17:14:39 INFO - PROCESS | 3777 | Cycle 1(1): loaded http://localhost:45446/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45446/tests/kraken/driver.html?testName=audio-fft) 17:14:40 INFO - PROCESS | 3777 | RSS: Main: 157167616 17:14:40 INFO - PROCESS | 3777 | 17:14:42 INFO - PROCESS | 3777 | Cycle 1(1): loaded http://localhost:45446/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45446/tests/kraken/driver.html?testName=audio-oscillator) 17:14:42 INFO - PROCESS | 3777 | RSS: Main: 158023680 17:14:42 INFO - PROCESS | 3777 | 17:14:44 INFO - PROCESS | 3777 | Cycle 1(1): loaded http://localhost:45446/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45446/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:14:45 INFO - PROCESS | 3777 | RSS: Main: 157089792 17:14:45 INFO - PROCESS | 3777 | 17:14:48 INFO - PROCESS | 3777 | Cycle 1(1): loaded http://localhost:45446/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45446/tests/kraken/driver.html?testName=imaging-darkroom) 17:14:49 INFO - PROCESS | 3777 | RSS: Main: 156958720 17:14:49 INFO - PROCESS | 3777 | 17:14:52 INFO - PROCESS | 3777 | Cycle 1(1): loaded http://localhost:45446/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45446/tests/kraken/driver.html?testName=imaging-desaturate) 17:14:53 INFO - PROCESS | 3777 | RSS: Main: 157134848 17:14:53 INFO - PROCESS | 3777 | 17:14:56 INFO - PROCESS | 3777 | Cycle 1(1): loaded http://localhost:45446/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45446/tests/kraken/driver.html?testName=json-parse-financial) 17:14:56 INFO - PROCESS | 3777 | RSS: Main: 157421568 17:14:56 INFO - PROCESS | 3777 | 17:14:58 INFO - PROCESS | 3777 | Cycle 1(1): loaded http://localhost:45446/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45446/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:14:58 INFO - PROCESS | 3777 | RSS: Main: 157093888 17:14:58 INFO - PROCESS | 3777 | 17:15:00 INFO - PROCESS | 3777 | Cycle 1(1): loaded http://localhost:45446/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45446/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:15:01 INFO - PROCESS | 3777 | RSS: Main: 157351936 17:15:01 INFO - PROCESS | 3777 | 17:15:03 INFO - PROCESS | 3777 | Cycle 1(1): loaded http://localhost:45446/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45446/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:15:03 INFO - PROCESS | 3777 | RSS: Main: 158208000 17:15:03 INFO - PROCESS | 3777 | 17:15:06 INFO - PROCESS | 3777 | Cycle 1(1): loaded http://localhost:45446/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45446/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:15:07 INFO - PROCESS | 3777 | RSS: Main: 158568448 17:15:07 INFO - PROCESS | 3777 | 17:15:09 INFO - PROCESS | 3777 | Cycle 1(1): loaded http://localhost:45446/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45446/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:15:10 INFO - PROCESS | 3777 | RSS: Main: 158273536 17:15:10 INFO - PROCESS | 3777 | 17:15:12 INFO - PROCESS | 3777 | Cycle 1(1): loaded http://localhost:45446/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45446/tests/kraken/driver.html?testName=ai-astar) 17:15:12 INFO - PROCESS | 3777 | RSS: Main: 159866880 17:15:12 INFO - PROCESS | 3777 | 17:15:12 INFO - PROCESS | 3777 | __start_tp_report 17:15:12 INFO - PROCESS | 3777 | _x_x_mozilla_page_load 17:15:12 INFO - PROCESS | 3777 | _x_x_mozilla_page_load_details 17:15:12 INFO - PROCESS | 3777 | |i|pagename|runs| 17:15:12 INFO - PROCESS | 3777 | |0;ai-astar;114;108;111;111;113;123;112;111;114;111 17:15:12 INFO - PROCESS | 3777 | |1;audio-beat-detection;157;126;151;174;129;156;152;128;181;128 17:15:12 INFO - PROCESS | 3777 | |2;audio-dft;164;165;166;164;165;166;165;163;166;163 17:15:12 INFO - PROCESS | 3777 | |3;audio-fft;76;74;76;190;77;74;76;76;158;76 17:15:12 INFO - PROCESS | 3777 | |4;audio-oscillator;92;92;144;91;93;93;147;93;93;139 17:15:12 INFO - PROCESS | 3777 | |5;imaging-gaussian-blur;117;117;117;118;118;118;117;118;117;117 17:15:12 INFO - PROCESS | 3777 | |6;imaging-darkroom;146;146;146;147;146;146;147;147;147;147 17:15:12 INFO - PROCESS | 3777 | |7;imaging-desaturate;96;95;96;94;95;95;95;95;95;95 17:15:12 INFO - PROCESS | 3777 | |8;json-parse-financial;56;56;58;56;60;56;55;79;62;53 17:15:12 INFO - PROCESS | 3777 | |9;json-stringify-tinderbox;56;56;57;57;57;56;56;57;57;57 17:15:12 INFO - PROCESS | 3777 | |10;stanford-crypto-aes;75;75;75;77;76;82;77;75;76;77 17:15:12 INFO - PROCESS | 3777 | |11;stanford-crypto-ccm;136;131;128;119;119;117;126;127;152;129 17:15:12 INFO - PROCESS | 3777 | |12;stanford-crypto-pbkdf2;163;167;170;167;161;160;161;160;165;160 17:15:12 INFO - PROCESS | 3777 | |13;stanford-crypto-sha256-iterative;67;67;69;69;73;67;67;66;66;65 17:15:12 INFO - PROCESS | 3777 | __end_tp_report 17:15:12 INFO - PROCESS | 3777 | __start_cc_report 17:15:12 INFO - PROCESS | 3777 | _x_x_mozilla_cycle_collect,873 17:15:12 INFO - PROCESS | 3777 | __end_cc_report 17:15:12 INFO - PROCESS | 3777 | __startTimestamp1461975312361__endTimestamp 17:15:12 INFO - PROCESS | 3777 | 17:15:12 INFO - PROCESS | 3777 | ------- Summary: start ------- 17:15:12 INFO - PROCESS | 3777 | Number of tests: 14 17:15:12 INFO - PROCESS | 3777 | 17:15:12 INFO - PROCESS | 3777 | [#0] ai-astar Cycles:10 Average:112.80 Median:112.50 stddev:3.99 (3.6%) stddev-sans-first:4.21 17:15:12 INFO - PROCESS | 3777 | Values: 114.0 108.0 111.0 111.0 113.0 123.0 112.0 111.0 114.0 111.0 17:15:12 INFO - PROCESS | 3777 | 17:15:12 INFO - PROCESS | 3777 | [#1] audio-beat-detection Cycles:10 Average:148.20 Median:154.00 stddev:19.94 (13.0%) stddev-sans-first:20.90 17:15:12 INFO - PROCESS | 3777 | Values: 157.0 126.0 151.0 174.0 129.0 156.0 152.0 128.0 181.0 128.0 17:15:12 INFO - PROCESS | 3777 | 17:15:12 INFO - PROCESS | 3777 | [#2] audio-dft Cycles:10 Average:164.70 Median:165.00 stddev:1.16 (0.7%) stddev-sans-first:1.20 17:15:12 INFO - PROCESS | 3777 | Values: 164.0 165.0 166.0 164.0 165.0 166.0 165.0 163.0 166.0 163.0 17:15:12 INFO - PROCESS | 3777 | 17:15:12 INFO - PROCESS | 3777 | [#3] audio-fft Cycles:10 Average:95.30 Median:76.00 stddev:42.17 (55.5%) stddev-sans-first:44.14 17:15:12 INFO - PROCESS | 3777 | Values: 76.0 74.0 76.0 190.0 77.0 74.0 76.0 76.0 158.0 76.0 17:15:12 INFO - PROCESS | 3777 | 17:15:12 INFO - PROCESS | 3777 | [#4] audio-oscillator Cycles:10 Average:107.70 Median:92.50 stddev:24.67 (26.7%) stddev-sans-first:25.51 17:15:12 INFO - PROCESS | 3777 | Values: 92.0 92.0 144.0 91.0 93.0 93.0 147.0 93.0 93.0 139.0 17:15:12 INFO - PROCESS | 3777 | 17:15:12 INFO - PROCESS | 3777 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 17:15:12 INFO - PROCESS | 3777 | Values: 117.0 117.0 117.0 118.0 118.0 118.0 117.0 118.0 117.0 117.0 17:15:12 INFO - PROCESS | 3777 | 17:15:12 INFO - PROCESS | 3777 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 17:15:12 INFO - PROCESS | 3777 | Values: 146.0 146.0 146.0 147.0 146.0 146.0 147.0 147.0 147.0 147.0 17:15:12 INFO - PROCESS | 3777 | 17:15:12 INFO - PROCESS | 3777 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 17:15:12 INFO - PROCESS | 3777 | Values: 96.0 95.0 96.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 17:15:12 INFO - PROCESS | 3777 | 17:15:12 INFO - PROCESS | 3777 | [#8] json-parse-financial Cycles:10 Average:59.10 Median:57.00 stddev:7.45 (13.1%) stddev-sans-first:7.81 17:15:12 INFO - PROCESS | 3777 | Values: 56.0 56.0 58.0 56.0 60.0 56.0 55.0 79.0 62.0 53.0 17:15:12 INFO - PROCESS | 3777 | 17:15:12 INFO - PROCESS | 3777 | [#9] json-stringify-tinderbox Cycles:10 Average:56.60 Median:57.00 stddev:0.52 (0.9%) stddev-sans-first:0.50 17:15:12 INFO - PROCESS | 3777 | Values: 56.0 56.0 57.0 57.0 57.0 56.0 56.0 57.0 57.0 57.0 17:15:12 INFO - PROCESS | 3777 | 17:15:12 INFO - PROCESS | 3777 | [#10] stanford-crypto-aes Cycles:10 Average:76.50 Median:76.50 stddev:2.12 (2.8%) stddev-sans-first:2.18 17:15:12 INFO - PROCESS | 3777 | Values: 75.0 75.0 75.0 77.0 76.0 82.0 77.0 75.0 76.0 77.0 17:15:12 INFO - PROCESS | 3777 | 17:15:12 INFO - PROCESS | 3777 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:128.50 stddev:10.20 (7.9%) stddev-sans-first:10.44 17:15:12 INFO - PROCESS | 3777 | Values: 136.0 131.0 128.0 119.0 119.0 117.0 126.0 127.0 152.0 129.0 17:15:12 INFO - PROCESS | 3777 | 17:15:12 INFO - PROCESS | 3777 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.40 Median:164.00 stddev:3.63 (2.2%) stddev-sans-first:3.84 17:15:12 INFO - PROCESS | 3777 | Values: 163.0 167.0 170.0 167.0 161.0 160.0 161.0 160.0 165.0 160.0 17:15:12 INFO - PROCESS | 3777 | 17:15:12 INFO - PROCESS | 3777 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.00 stddev:2.27 (3.4%) stddev-sans-first:2.40 17:15:12 INFO - PROCESS | 3777 | Values: 67.0 67.0 69.0 69.0 73.0 67.0 67.0 66.0 66.0 65.0 17:15:12 INFO - PROCESS | 3777 | -------- Summary: end -------- 17:15:12 INFO - PROCESS | 3777 | 17:15:13 INFO - TEST-INFO | 3777: exit 0 17:15:13 INFO - TEST-OK | kraken | took 61229ms 17:15:13 INFO - SUITE-END | took 1171s 17:15:13 INFO - Completed test suite (00:19:32) 17:15:13 INFO - javascript benchmark 17:15:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3307.6526964668706, 3368.7473439492037, 3391.118309239597, 3418.846151923162, 3423.0586588688107, 5602.24369710089, 5631.5776316776255, 5641.492265696086, 5652.547796176306, 5665.773369065238, 5574.554035677146, 5615.2138700581845, 5638.295213098363, 5664.461876121762, 5687.146927960797, 5062.367204099488, 5132.23016547519, 5138.563222126124, 5143.897122057557, 5157.6647517911215, 5021.673591216578, 5145.125328694112, 5255.842324730245, 5267.420583735786, 5270.789168433277, 5040.042391945537, 5074.340335756347, 5113.616478764089, 5120.92318615221, 5126.436092029874, 5162.328897243353, 5171.612129090333, 5191.948080519184, 5194.6104042196985, 5203.427622961472, 4944.802207911679, 5059.949400506021, 5116.513931176532, 5157.329547158845, 5175.663581867167, 5436.510714035756, 5459.645123066988, 5466.726663666801, 5512.531434828044, 5583.469570390806, 5948.7323070461935, 5995.100734889757, 5998.700064996733, 6009.06859436788, 6018.2778066631845, 5992.820215393545, 6014.2181516403025, 6069.998450255703, 6072.9696351518405, 6081.483073938721, 5554.527865131468, 5678.375378708339, 5715.999999999958, 5741.971290143564, 5771.740271687742, 6138.416850399205, 6151.6001459904965, 6160.229971253593, 6166.938330616636, 6175.104609831639, 5829.970850145722, 5872.354041055481, 5930.2883653960935, 5933.851653708692, 5949.791757288474, 5963.701814909324, 6084.756609735649, 6087.29996050451, 6098.32918378978, 6129.448349648553, 5910.231669882888, 5941.821745347646, 5961.374055724174, 5965.970170149121, 5985.700714964321, 5820.417958204146, 5864.237649105589, 5959.404059594006, 5965.0, 5991.370906054889, 4543.659225558096, 4580.610648094883, 4584.564466375689, 4604.332371806069, 4609.585137337655, 4081.9795901020307, 4104.712670113123, 4129.8023125699365, 4143.7928103594695, 4148.315527937917, 5687.488126068591, 5762.30852297727, 5802.21670074543, 5829.125631155276, 5837.09525023622, 5977.910331345033, 6066.150738896558, 6082.695865206722, 6130.948521380002, 6158.630482171084, 5785.942140578541, 5788.5369170466265, 5791.7683292667825, 5792.073268277056, 5798.217240672455, 5066.290719299301, 5126.69239845603, 5174.327337446108, 5179.896402071938, 5229.712365819916, 6190.783322583688, 6192.473639740672, 6193.566450348522, 6204.968975155095, 6212.565120441616, 5952.5237980960555, 5961.8807623846415, 5984.848861674885, 5998.9100163496705, 6055.333913269625, 5987.760489580368, 6162.876742465215, 6206.100115483139, 6313.08460273267, 6337.207849018872, 5920.615160014585, 5920.644761314335, 5925.377835327401, 5940.227770389822, 5966.0454327307425, 5992.940070599238, 6004.099385092271, 6019.879602408015, 6024.307204671519, 6032.8793424132145, 5800.56495762811, 5828.970855145697, 5908.763649453974, 5917.5857689961285, 5945.672987985529, 5937.851553711192, 5948.910766338595, 5959.731812068554, 5976.910346344721, 5998.160257563857, 5699.9145012825675, 5873.324567674601, 5883.441073098049, 5897.3807750187325, 5911.9949608565785, 5944.464998150187, 6001.099835024781, 6005.099235114768, 6014.0678194879865, 6023.27720673522, 5773.364929857628, 5784.074548072288, 5786.594938354275, 5799.159121927381, 5840.0], "value": 5563.541632943696, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.5212922760226, 677.2753154125085, 684.0389253099394, 703.419678765019, 770.7379490973075, 37894.43158352627, 38433.0, 38664.806675966654, 38701.61298387015, 39061.60938390615, 43205.567944320544, 43717.34423983643, 44011.55988440115, 44075.11849763003, 44089.77955110228, 8739.4756314621, 8915.910840891605, 8972.0, 8976.955115224448, 8982.461052336848, 8719.738407847775, 8815.77960550985, 8827.33794965377, 8833.1608497193, 8846.690365837198, 8807.119288071173, 8884.600192991298, 8885.68900088497, 8893.377463577552, 8905.599248033854, 8770.210681038738, 8817.29461643067, 8835.0281469039, 8857.557122143899, 8859.379843410963, 8767.868481972775, 8824.02935677075, 8848.778780530474, 8871.201591856763, 8877.112288771135, 39894.401583976265, 40529.59470405288, 40745.185096298206, 41046.1790764183, 41138.0, 3722.758020728671, 3886.0867696091395, 3901.0, 3911.7457365271166, 4005.998500374906, 33103.83448082744, 33348.0, 33365.666343336496, 33430.1642458938, 33882.49176262334, 4330.675199360029, 4440.866773996785, 4451.910961780779, 4492.68551201416, 4495.190865644183, 281571.0, 282228.0, 284582.0, 287097.0, 287352.9999999979, 36531.452028219595, 60422.69788651029, 61003.69498152481, 61519.6924015386, 61905.38094618996, 38288.80855595704, 38451.42322865159, 38612.80693596514, 38628.22743545113, 38722.0, 17398.478045658652, 17416.564585885455, 17468.126593670266, 17610.0, 17642.823571764377, 14803.333849976776, 14910.627234319229, 14961.251937403304, 14979.70040599182, 14983.700325993637, 9448.90551094494, 9585.664501742405, 9680.661176858775, 9694.46680432583, 9729.513524323755, 3591.1560783215923, 3618.9638103619154, 3652.6529979652423, 3672.6878215351994, 3688.2623475305045, 1121.697141771717, 1198.9040876729841, 1211.0009242375077, 1225.718084840474, 1227.2820400065882, 33480.66519334824, 34277.45751441191, 34393.82803085969, 34478.13804654904, 34643.82678086594, 1219.8170274458903, 1229.244014930811, 1234.975300493985, 1276.3171703138962, 1285.9421326040163, 17986.27297983692, 18084.4018424001, 18152.283655047453, 18159.653873439835, 18220.36228731988, 398426.0, 402826.0, 406796.0, 409072.0, 508212.0, 65624.34375656278, 66496.66751666211, 66519.0, 66635.0, 66963.33036669668, 1577.747560390332, 1581.1303782919579, 1581.8892677512695, 1587.2857214253631, 1652.3060314667869, 33919.491207631414, 34145.48781768226, 34168.48747268743, 34584.0, 34821.82589087039, 57883.0, 59106.0, 59203.0, 59239.40760592339, 59262.0, 438411.0, 450645.0, 454062.0, 454270.0, 454471.0, 31827.522587160747, 32185.907915985386, 32214.516782248753, 32392.676073238967, 32540.349193016482, 51760.0, 51953.22070169026, 52431.0, 53148.0, 53452.0, 43029.56970430256, 43310.56689433191, 45338.77330613458, 45487.77256113698, 46098.0, 43515.0, 43744.562554374046, 43767.34348984832, 44977.32534012058, 45190.32214516851, 44027.77986110049, 44939.32591011072, 45398.09203815971, 45565.54434455746, 45853.54146458493, 37539.06152346213, 38978.6102138975, 39172.6082739169, 39280.410793837545, 39802.60197397989, 29369.80140884345, 29806.0, 30305.848470757504, 30464.238394040327, 30797.692023080377], "value": 19906.96062020411, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.2705774308348, 416.7112911234653, 424.3528618856246, 434.63273533863895, 446.5668301747305, 18777.0, 19069.427917162473, 19122.808771912278, 19150.52123696908, 19411.41765747028, 18983.81016189838, 19517.0, 19641.705374419395, 19683.901580492115, 20046.699299510517, 5652.491275785179, 5895.0, 5919.260092488439, 5930.110483427477, 5941.940580594182, 4233.068724880522, 5855.092460668603, 5860.706964651772, 6234.594751341148, 6526.314736952623, 6435.742570297182, 6439.452646525051, 6461.19235095613, 6465.0, 6477.028445733131, 6334.429901308881, 6360.0, 6381.0, 6405.903911441332, 6425.132607098076, 5584.5811564132855, 5792.739326730307, 5813.186153938452, 5827.504662103726, 5827.650340979555, 23975.0, 24215.87892060546, 24433.267001989967, 24467.755322446905, 24527.754722452904, 2610.138654244095, 2750.4499100180046, 3060.9540856887165, 3200.8399580020905, 3269.5095735639607, 14279.57161285163, 15341.232938353038, 15422.228888555639, 15432.614184645361, 15476.226188690633, 1903.1816318982833, 1980.1485361294638, 2013.1041686449537, 2296.552172326397, 2436.926892193237, 83759.0, 92542.0, 96917.51541242319, 98199.50900245525, 101095.0, 18382.448526544224, 18427.170777315052, 18525.258989640264, 18937.337193198447, 18985.240590376507, 34266.65733342685, 34926.65073349285, 34956.12609684727, 35229.8238508811, 35365.29269414649, 10802.72993175177, 10902.563897444172, 11072.833907491395, 11164.888351116548, 11330.886691133148, 9736.902630973742, 9782.804343913082, 9788.706338809847, 9835.508224588742, 9836.163896080534, 9026.323025772961, 9175.587098580447, 9295.58169882357, 9376.578053987587, 9470.479123648265, 2058.8147066764063, 2152.2144417287577, 2162.7729088445803, 2195.5279614882875, 3484.591991131221, 1011.585250047477, 1112.4882554025078, 1117.3240189685287, 1140.105017561227, 1160.5821904114512, 19265.80734192668, 19858.50353741139, 19870.304539341054, 20002.799972000386, 20219.494512637302, 1085.3379438542484, 1094.1301665176204, 1112.9666110016713, 1148.9138314626268, 1169.128998895828, 10338.689839304832, 11273.54905803775, 11350.262232954832, 11357.261777984404, 11403.942980285046, 493324.0, 496304.0, 509172.0, 510156.0, 516909.0, 99056.0, 99417.0, 100120.0, 101420.0, 104096.47951760193, 1108.3239224073309, 1114.5597488991802, 1126.7295848996182, 1128.7234627516311, 1135.5174051028114, 17523.56191095182, 17709.468715938543, 17779.46661600154, 18020.54948626295, 18081.728774068135, 33180.0, 38772.0, 40139.79930100331, 41858.790706046275, 41892.371614425196, 55862.16206756983, 57302.42697572971, 57998.42001580099, 58823.70588147032, 59083.113753294594, 9008.369414140947, 9065.818683626423, 9076.273898088006, 9200.079992001014, 9278.025807290407, 11695.590654327058, 13553.59339219825, 13578.25319607431, 13595.0, 13823.723525529635, 11811.173217874666, 12043.458044388199, 12110.697232569257, 12183.451744671689, 12316.0, 11673.649790506299, 11821.881781182077, 11857.28856268592, 11897.762044758883, 12074.094442916641, 12034.63896083119, 12103.334316612318, 12339.13626046204, 12352.567660131852, 12550.246985180918, 8562.315014798925, 8665.913340866762, 8761.29909607217, 8867.68963086289, 8947.284217262473, 11613.0, 11634.301941883514, 11731.88268117308, 11830.52677892909, 11911.702207444883], "value": 10521.631789289568, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1574.2758331167659, 1620.513845846246, 1800.0909540681962, 1846.8984205868671, 1893.9431817045493, 7368.778936631909, 8002.759917202478, 8163.95918020409, 8300.0, 8325.33397328213, 8212.630431630576, 8254.42219044667, 8266.751997440086, 8317.667293308275, 8329.333653307736, 2334.8132149428006, 2373.050779688121, 2373.549025685123, 2377.6909001829736, 2384.237044145874, 2342.4612339161918, 2416.5287768885073, 2463.310273123528, 2466.963875172423, 2480.838745481547, 2392.9880350598223, 2400.23192578375, 2418.854868707874, 2420.9636855447184, 2432.2460037388464, 2341.005072844043, 2345.4019225097663, 2346.636271377931, 2353.776391242829, 2376.750441203666, 2312.3756585721762, 2372.3001714494267, 2377.7859992600575, 2394.916177933764, 2405.615101583738, 8372.41393102483, 8415.495070295801, 8420.663173473054, 8465.746027619181, 8467.449615775016, 5204.271402003723, 5323.361196656388, 5390.865228369283, 5421.918671219895, 5434.347878254595, 3562.1985053363046, 3630.2013557017412, 3649.908752281188, 3688.188598508324, 3713.4986776785327, 1238.182799352432, 1251.9687007824787, 1288.15625765124, 1323.2325251354287, 1334.8665133486575, 11488.483018264198, 11488.942555287254, 11558.95969362753, 11589.014933730643, 11616.651500455, 4666.136764698474, 4684.6252299816615, 4750.738709371018, 4753.833615823499, 4783.115123702126, 9856.359336643238, 9944.30389872702, 9953.900460995297, 9956.0, 9970.45162516054, 5348.732563371816, 5370.140777475585, 5371.355437347544, 5377.354717433933, 5437.619366644297, 4351.325544540601, 4768.213244814567, 4871.439784424837, 4916.680415772963, 4932.778024988884, 4010.1378203685763, 4016.397540368968, 4104.774237416911, 4121.216968775923, 4138.8551400700835, 1328.3756634381825, 1330.5010621017118, 1353.6818847570812, 1369.233229391524, 1390.2909516146838, 897.7935074932802, 911.2300106410073, 930.55798495714, 955.6702937486556, 967.849983252597, 5804.564657650693, 5809.7095145242565, 5817.447342502455, 5838.065909454467, 5873.177755114288, 983.8868530119128, 1036.6423583863555, 1038.0346277961416, 1057.6245432871374, 1065.307550092446, 3919.3729003359326, 3932.2135572884963, 4011.7592944423427, 4024.4164596133396, 4072.7759973201164, 9903.80192396148, 10150.695479135638, 10274.537645805956, 10466.267361284637, 10561.313514621525, 10287.382757034602, 10436.217283703601, 10440.582376704999, 10476.161907047417, 10499.94750026245, 7903.130655627876, 8136.471129376571, 8140.674373025013, 8197.754067377988, 8237.546934918637, 5734.799282025109, 5856.59003869725, 5865.266841644794, 5867.266591676041, 5979.820605381846, 9627.326087173831, 9756.26827987918, 9790.461524616214, 9802.85295720579, 9865.161461275871, 9561.521923903916, 9812.116909478182, 9944.701658950244, 10005.449700266556, 10078.496075196357, 6534.183227096613, 6826.078479405217, 6985.5808651481075, 7155.24869888675, 7273.418126549969, 8026.919730802851, 8107.22981316774, 8118.959405202936, 8153.1846815317995, 8167.55078470666, 6941.548799328028, 7148.821279467847, 7219.205887352492, 7339.339459448675, 7373.3732632726815, 7314.184039144861, 7373.18894921569, 7377.0, 7386.891966205112, 7439.55362678241, 6808.931910681028, 6821.386075253053, 6821.863562728817, 6875.965620171867, 6879.828004299732, 4946.109700253989, 4964.652474326763, 4971.825986090469, 4972.353594032753, 4995.750212489288, 5083.345773001063, 5106.872328191825, 5151.175811870083, 5233.0, 5234.7906083756225], "value": 4622.0132366702965, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.49703432987855, 347.7878494118587, 352.2215902854691, 360.28843035005866, 362.72070505710604, 5718.828435146942, 5731.764611801401, 5768.336641286253, 5773.653580785156, 5787.768489260435, 5669.9433005669935, 5674.262345895038, 5677.716114194284, 5700.828975130742, 5707.77168913244, 4053.7770422626745, 4354.47746270448, 4391.967887546424, 4411.757353345564, 4443.911121777563, 4388.188185185735, 4427.380166776654, 4437.733735975852, 4438.578335058164, 4443.488998765151, 4377.233984052794, 4393.275109606911, 4419.337099435078, 4430.933535996946, 4432.667549933752, 4278.7860606969525, 4386.934195987063, 4389.802458889341, 4390.604845563883, 4393.472783265996, 3859.9228015439535, 3892.5718171001167, 3893.162969961472, 3904.2777086238852, 3909.4331321958443, 5441.5102640762125, 5468.152436372368, 5510.228568000483, 5513.724313784295, 5520.751566179491, 4910.312556242129, 5061.721605311706, 5090.981803639287, 5107.897842043176, 5124.641275110744, 5928.458600763789, 5972.25346831646, 5992.730327135246, 5999.2002399280045, 6006.429389208019, 4311.439512863339, 4328.11273688893, 4330.133973205371, 4336.739795612273, 4383.715058521186, 6029.698515074228, 6212.409821066992, 6217.942949698562, 6248.750049997994, 6319.210098737658, 4374.19077470669, 4407.757573333497, 4415.62467190286, 4424.203643344229, 4431.667624928144, 4406.559344065632, 4448.933266001012, 4462.330650402466, 4462.6388951370145, 4485.304777759387, 4834.516548345137, 5093.032323858455, 5117.948820511821, 5142.537171654494, 5159.664621799571, 6084.269887613426, 6085.17850090241, 6096.207493025879, 6125.601835880653, 6145.201123853871, 1587.9603009924845, 1625.3579835964965, 1637.1977730912006, 1641.3188526761498, 1646.0864220357817, 1084.487140439083, 1085.3270971997254, 1111.927724697892, 1115.1413411672966, 1116.938568378747, 6235.251769787655, 6287.654179020198, 6315.747370105236, 6316.526260530479, 6331.905021424683, 6485.286618471964, 6598.47212223021, 6623.9006414903815, 6673.399394054559, 6697.196336439659, 6234.937650623527, 6266.905996410058, 6274.403931626488, 6288.465480434214, 6299.842503937347, 3536.328097661436, 3547.113221694576, 3550.1479644885044, 3559.857605695743, 3578.8389522471552, 6706.865862682719, 6892.758753443605, 6902.206246281641, 6961.199462061826, 6968.65156742171, 6711.228208756055, 6769.289224631441, 6787.321267873173, 6787.898181527281, 6800.591964482147, 6169.210928830678, 6544.247411547638, 6607.735690572419, 6612.057634352667, 6964.164300283897, 6270.592411493239, 6288.685565721604, 6288.779892703734, 6335.651539165206, 6354.0, 6031.336552979081, 6231.844203894939, 6240.906386404116, 6260.906086408617, 6272.466840318624, 6526.934730652632, 6566.244881838458, 6617.239017513048, 6624.8343791405605, 6640.236372816995, 4351.282038463744, 4431.3574531692075, 4450.265706158448, 4465.330200469825, 4490.955090449184, 6074.240719910012, 6315.715792789428, 6335.782476133317, 6366.586171898812, 6367.713452894724, 6139.508839292936, 6152.046432802923, 6169.352218017044, 6179.567430279837, 6215.533834962305, 5968.299034775068, 6108.694565271808, 6135.067453752054, 6144.2319710036245, 6172.4136207060255, 5889.440503152194, 5998.910016349845, 6078.3588431124235, 6096.9390306096375, 6100.1459795629535, 6140.508759299335, 6143.815685529441, 6187.628742275478, 6197.0, 6206.658633775005, 5940.227770389822, 6000.8799824004145, 6038.969805150946, 6077.604955677867, 6079.0], "value": 4686.6026553809415, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.1448348882271, 772.7449941519295, 810.4245985350401, 896.5920506169692, 911.3074063711581, 14173.29133543324, 15006.549803505912, 15121.924390378046, 16389.262483188257, 16817.747733784003, 15703.685926281467, 15720.921395393036, 15783.28975196116, 15790.526284211492, 15799.447019354326, 746.9439792015594, 912.6258234124027, 917.4495302818323, 920.9539523023822, 922.1378011559214, 887.3389324952919, 901.4816480523692, 909.154486327715, 915.4873270968279, 918.6692790595414, 955.5652178258875, 963.0802583532744, 963.5952899782073, 964.0215181590692, 967.6419724701835, 957.2294303086013, 958.0850287974968, 958.5782255807458, 959.9616015359377, 962.1340793286064, 703.707961196103, 704.1163340008308, 705.5413980912397, 705.8094314535098, 710.3855165282046, 15148.545543633709, 15262.542123736306, 15289.0, 15383.461578844799, 15390.692186156326, 14595.270236488239, 14620.488282910153, 14691.706165876623, 14709.411623535047, 14820.3330850112, 10399.428031458267, 10703.78592428147, 10775.137988960865, 10857.0, 11247.60633377836, 3970.4441378207075, 3971.285168669638, 3979.6816254699843, 4035.616616421435, 4115.32097203961, 57337.42662573363, 57763.711181443825, 58496.415035849524, 58675.41324586785, 58845.705771471294, 11096.223264371578, 11139.610113645984, 11146.88531146895, 11222.719432014264, 11236.213465057532, 20707.482312941996, 20720.58558828815, 20734.0, 20852.687209691867, 20892.686609700868, 8362.289205417486, 8618.827623447496, 8779.736607901774, 8808.20726134651, 8987.41581797181, 5086.847394578169, 5093.541581257705, 5133.922991155136, 5177.715225662625, 5218.582513398995, 3539.486774417695, 3585.515955345995, 3592.946105808415, 3594.3530164570107, 3602.1534939289245, 643.3052303512195, 643.83904023994, 651.6448535548137, 660.5046215338496, 668.1848145262771, 721.913370395556, 796.2475460689593, 799.2207597592417, 833.1918039501674, 850.2815121222557, 10213.897861021444, 10516.316439431412, 10518.158547316349, 10717.892821071846, 10823.67528974132, 688.1088989758275, 758.4539131825077, 778.8208711996273, 808.1756608259542, 828.8963879515061, 4399.142167277414, 4672.789724462407, 4763.237881938942, 4855.684380515255, 5018.698878067327, 66483.66758166178, 69413.0, 69605.65197174084, 70074.64962675257, 70144.2985570148, 60351.69824150939, 61104.69447652733, 61745.69127154425, 62155.378446215866, 62696.0, 54930.45069549253, 55742.72128639412, 55785.16322255088, 56161.438385616435, 56417.43582564204, 9725.221982241545, 9735.41587504752, 9772.267079969173, 9938.850917236103, 9946.751331216778, 37603.81198094101, 37737.43393849149, 37785.811070944466, 37989.430158548195, 38131.23737525178, 45044.32433513434, 48045.519544804105, 50364.74817625889, 51371.74314128405, 51414.74292628513, 13370.264635445144, 13425.462981480632, 13443.596692099252, 13534.86465135336, 13741.381637826122, 14727.0, 15179.089254644316, 15313.234338282818, 15548.533543993699, 15567.0, 14336.49822256216, 14349.713005740035, 14383.640408989859, 14443.133411995314, 14698.0, 12637.684057898627, 12698.936505317415, 12906.548270810477, 12920.806187907378, 12954.80567791465, 11140.665780026613, 11405.372704501, 12057.577984770842, 12234.694132646755, 14274.500392486214, 10522.842157367493, 10619.469026548488, 10749.89250107489, 10761.89238107609, 10936.781264374828, 10313.845292320471, 10403.791924161626, 10410.895891040993, 10479.895201047892, 10699.14406847466], "value": 7270.245677079369, "unit": "score"}], "name": "dromaeo_css", "value": 7538.5289821095885, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 111.0, 111.0, 113.0, 123.0, 112.0, 111.0, 114.0, 111.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 126.0, 151.0, 174.0, 129.0, 156.0, 152.0, 128.0, 181.0, 128.0], "value": 148.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 166.0, 164.0, 165.0, 166.0, 165.0, 163.0, 166.0, 163.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 76.0, 190.0, 77.0, 74.0, 76.0, 76.0, 158.0, 76.0], "value": 95.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 144.0, 91.0, 93.0, 93.0, 147.0, 93.0, 93.0, 139.0], "value": 107.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 58.0, 56.0, 60.0, 56.0, 55.0, 79.0, 62.0, 53.0], "value": 59.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 57.0, 57.0, 56.0, 56.0, 57.0, 57.0, 57.0], "value": 56.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 77.0, 76.0, 82.0, 77.0, 75.0, 76.0, 77.0], "value": 76.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 131.0, 128.0, 119.0, 119.0, 117.0, 126.0, 127.0, 152.0, 129.0], "value": 128.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 167.0, 170.0, 167.0, 161.0, 160.0, 161.0, 160.0, 165.0, 160.0], "value": 163.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 69.0, 69.0, 73.0, 67.0, 67.0, 66.0, 66.0, 65.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1539.3, "alertThreshold": 2.0}]} 17:15:13 INFO - Return code: 0 17:15:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:15:13 ERROR - # TBPL SUCCESS # 17:15:13 INFO - Running post-action listener: _resource_record_post_action 17:15:13 INFO - Running post-run listener: _resource_record_post_run 17:15:14 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 8069120; Write bytes: 388882432; Read time: 1716; Write time: 431772 17:15:14 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 15355904; Read time: 0; Write time: 6012 17:15:14 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 6332416; Write bytes: 373526528; Read time: 1676; Write time: 425760 17:15:14 INFO - Running post-run listener: _upload_blobber_files 17:15:14 INFO - Blob upload gear active. 17:15:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:15:14 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 17:15:14 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'] 17:15:14 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 17:15:15 INFO - (blobuploader) - INFO - Open directory for files ... 17:15:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:15:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:15:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:15:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:15:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:15:15 INFO - (blobuploader) - INFO - Done attempting. 17:15:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:15:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:15:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:15:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:15:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:15:16 INFO - (blobuploader) - INFO - Done attempting. 17:15:16 INFO - (blobuploader) - INFO - Iteration through files over. 17:15:16 INFO - Return code: 0 17:15:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:15:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:15:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f5661aca614a85fca1a50b08315ea68a6ed440613d5354c592d5aa9ea7126658c3999c63d0e1d5089db54c27625a91fd6ee3c718f20d4a23e3874d5591d6d54f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/59e7897b0f8a857a83120a1d97a32bb9ebfc16819283cbbab7fee56a85f93e1ef1236f2c930b9d9b11414886fde5b97c0024d5a8ae4457aef1ee19461386d03b"} 17:15:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:15:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:15:16 INFO - Contents: 17:15:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f5661aca614a85fca1a50b08315ea68a6ed440613d5354c592d5aa9ea7126658c3999c63d0e1d5089db54c27625a91fd6ee3c718f20d4a23e3874d5591d6d54f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/59e7897b0f8a857a83120a1d97a32bb9ebfc16819283cbbab7fee56a85f93e1ef1236f2c930b9d9b11414886fde5b97c0024d5a8ae4457aef1ee19461386d03b"} 17:15:16 INFO - Running post-run listener: copy_logs_to_upload_dir 17:15:16 INFO - Copying logs to upload dir... 17:15:16 INFO - mkdir: /builds/slave/test/build/upload/logs 17:15:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.809980 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-04-29 17:15:16.709056) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 17:15:16.713008) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1461973881.71588-142695310 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/f5661aca614a85fca1a50b08315ea68a6ed440613d5354c592d5aa9ea7126658c3999c63d0e1d5089db54c27625a91fd6ee3c718f20d4a23e3874d5591d6d54f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/59e7897b0f8a857a83120a1d97a32bb9ebfc16819283cbbab7fee56a85f93e1ef1236f2c930b9d9b11414886fde5b97c0024d5a8ae4457aef1ee19461386d03b"} build_url:https://queue.taskcluster.net/v1/task/Jw-dlIJzQ6CuQnD3EWWSxw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011186 build_url: 'https://queue.taskcluster.net/v1/task/Jw-dlIJzQ6CuQnD3EWWSxw/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/f5661aca614a85fca1a50b08315ea68a6ed440613d5354c592d5aa9ea7126658c3999c63d0e1d5089db54c27625a91fd6ee3c718f20d4a23e3874d5591d6d54f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/59e7897b0f8a857a83120a1d97a32bb9ebfc16819283cbbab7fee56a85f93e1ef1236f2c930b9d9b11414886fde5b97c0024d5a8ae4457aef1ee19461386d03b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 17:15:16.736882) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 17:15:16.737177) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1461973881.71588-142695310 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004313 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 17:15:16.821483) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 17:15:16.821802) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 17:15:16.822075) ========= ========= Total master_lag: 0.17 =========