builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-029 starttime: 1468612635.41 results: success (0) buildid: 20160715100204 builduid: 60e0b95a8bfe483e8c339e79c06a3d0d revision: b9a4d34cb07363b0616321353610e47c1ddaa2ae ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 12:57:15.413554) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 12:57:15.414074) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 12:57:15.414376) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 12:57:15.429669) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 12:57:15.430060) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1468612634.497432-246536648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-15 12:57:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2016-07-15 12:57:15 (46.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096837 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 12:57:15.541157) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 12:57:15.541519) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1468612634.497432-246536648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020772 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 12:57:15.594001) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 12:57:15.594836) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b9a4d34cb07363b0616321353610e47c1ddaa2ae --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-beta --rev b9a4d34cb07363b0616321353610e47c1ddaa2ae --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=9ee515b9ec57ce2c386832a8000001b4-1468612634.497432-246536648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-15 12:57:15,902 truncating revision to first 12 chars 2016-07-15 12:57:15,902 Setting DEBUG logging. 2016-07-15 12:57:15,902 attempt 1/10 2016-07-15 12:57:15,902 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/b9a4d34cb073?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-15 12:57:16,526 unpacking tar archive at: mozilla-beta-b9a4d34cb073/testing/mozharness/ program finished with exit code 0 elapsedTime=0.963082 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 12:57:16.573823) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 12:57:16.574192) ========= script_repo_revision: b9a4d34cb07363b0616321353610e47c1ddaa2ae ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 12:57:16.574609) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 12:57:16.574902) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 12:57:16.584275) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 21 secs) (at 2016-07-15 12:57:16.584717) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=9ee515b9ec57ce2c386832a8000001b4-1468612634.497432-246536648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:57:16 INFO - MultiFileLogger online at 20160715 12:57:16 in /builds/slave/test 12:57:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 12:57:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:57:16 INFO - {'append_to_log': False, 12:57:16 INFO - 'base_work_dir': '/builds/slave/test', 12:57:16 INFO - 'blob_upload_branch': 'Mozilla-Beta', 12:57:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:57:16 INFO - 'branch': 'Mozilla-Beta', 12:57:16 INFO - 'buildbot_json_path': 'buildprops.json', 12:57:16 INFO - 'config_files': ('talos/linux_config.py',), 12:57:16 INFO - 'default_actions': ('clobber', 12:57:16 INFO - 'read-buildbot-config', 12:57:16 INFO - 'download-and-extract', 12:57:16 INFO - 'populate-webroot', 12:57:16 INFO - 'create-virtualenv', 12:57:16 INFO - 'install', 12:57:16 INFO - 'run-tests'), 12:57:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:57:16 INFO - 'download_minidump_stackwalk': True, 12:57:16 INFO - 'download_symbols': 'ondemand', 12:57:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:57:16 INFO - 'tooltool.py': '/tools/tooltool.py', 12:57:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:57:16 INFO - '/tools/misc-python/virtualenv.py')}, 12:57:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:57:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:57:16 INFO - 'installer_path': 'installer.exe', 12:57:16 INFO - 'log_level': 'info', 12:57:16 INFO - 'log_name': 'talos', 12:57:16 INFO - 'log_to_console': True, 12:57:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:57:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:57:16 INFO - 'opt_config_files': (), 12:57:16 INFO - 'pip_index': False, 12:57:16 INFO - 'sps_profile': False, 12:57:16 INFO - 'sps_profile_interval': 0, 12:57:16 INFO - 'suite': 'dromaeojs-e10s', 12:57:16 INFO - 'system_bits': '32', 12:57:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:57:16 INFO - 'title': 'talos-linux64-ix-029', 12:57:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:57:16 INFO - 'use_talos_json': True, 12:57:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:57:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:57:16 INFO - 'work_dir': 'build'} 12:57:16 INFO - ##### 12:57:16 INFO - ##### Running clobber step. 12:57:16 INFO - ##### 12:57:16 INFO - Running pre-action listener: _resource_record_pre_action 12:57:16 INFO - Running main action method: clobber 12:57:16 INFO - rmtree: /builds/slave/test/build 12:57:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:57:17 INFO - Running post-action listener: _resource_record_post_action 12:57:17 INFO - ##### 12:57:17 INFO - ##### Running read-buildbot-config step. 12:57:17 INFO - ##### 12:57:17 INFO - Running pre-action listener: _resource_record_pre_action 12:57:17 INFO - Running main action method: read_buildbot_config 12:57:17 INFO - Using buildbot properties: 12:57:17 INFO - { 12:57:17 INFO - "project": "", 12:57:17 INFO - "product": "firefox", 12:57:17 INFO - "script_repo_revision": "production", 12:57:17 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 12:57:17 INFO - "repository": "", 12:57:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 12:57:17 INFO - "buildid": "20160715100204", 12:57:17 INFO - "pgo_build": "True", 12:57:17 INFO - "basedir": "/builds/slave/test", 12:57:17 INFO - "buildnumber": 50, 12:57:17 INFO - "slavename": "talos-linux64-ix-029", 12:57:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:57:17 INFO - "platform": "ubuntu64_hw", 12:57:17 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 12:57:17 INFO - "branch": "mozilla-beta", 12:57:17 INFO - "repo_path": "releases/mozilla-beta", 12:57:17 INFO - "revision": "b9a4d34cb07363b0616321353610e47c1ddaa2ae", 12:57:17 INFO - "stage_platform": "linux64-pgo", 12:57:17 INFO - "builduid": "60e0b95a8bfe483e8c339e79c06a3d0d", 12:57:17 INFO - "slavebuilddir": "test" 12:57:17 INFO - } 12:57:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/RKYuVrs3SBK3BczW4sF4Dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 12:57:17 INFO - Running post-action listener: _resource_record_post_action 12:57:17 INFO - ##### 12:57:17 INFO - ##### Running download-and-extract step. 12:57:17 INFO - ##### 12:57:17 INFO - Running pre-action listener: _resource_record_pre_action 12:57:17 INFO - Running main action method: download_and_extract 12:57:17 INFO - mkdir: /builds/slave/test/build/tests 12:57:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:17 INFO - https://queue.taskcluster.net/v1/task/RKYuVrs3SBK3BczW4sF4Dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:57:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RKYuVrs3SBK3BczW4sF4Dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 12:57:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RKYuVrs3SBK3BczW4sF4Dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 12:57:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RKYuVrs3SBK3BczW4sF4Dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 12:57:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RKYuVrs3SBK3BczW4sF4Dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:57:18 INFO - Downloaded 1327 bytes. 12:57:18 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 12:57:18 INFO - Using the following test package requirements: 12:57:18 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 12:57:18 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:57:18 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 12:57:18 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:57:18 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 12:57:18 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:57:18 INFO - u'jsshell-linux-x86_64.zip'], 12:57:18 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:57:18 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 12:57:18 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 12:57:18 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:57:18 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 12:57:18 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:57:18 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 12:57:18 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:57:18 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 12:57:18 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:57:18 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 12:57:18 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:57: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')]} 12:57:18 INFO - https://queue.taskcluster.net/v1/task/RKYuVrs3SBK3BczW4sF4Dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:57:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RKYuVrs3SBK3BczW4sF4Dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 12:57:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RKYuVrs3SBK3BczW4sF4Dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 12:57:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RKYuVrs3SBK3BczW4sF4Dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 12:57:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RKYuVrs3SBK3BczW4sF4Dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:57:19 INFO - Downloaded 24200514 bytes. 12:57:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:57:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:57:20 INFO - Return code: 0 12:57:20 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:57:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:20 INFO - https://queue.taskcluster.net/v1/task/RKYuVrs3SBK3BczW4sF4Dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:57:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RKYuVrs3SBK3BczW4sF4Dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 12:57:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RKYuVrs3SBK3BczW4sF4Dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 12:57:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RKYuVrs3SBK3BczW4sF4Dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 12:57:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RKYuVrs3SBK3BczW4sF4Dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:57:21 INFO - Downloaded 24200514 bytes. 12:57:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:57:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:57:23 INFO - Return code: 0 12:57:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:23 INFO - https://queue.taskcluster.net/v1/task/RKYuVrs3SBK3BczW4sF4Dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:57:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RKYuVrs3SBK3BczW4sF4Dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 12:57:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RKYuVrs3SBK3BczW4sF4Dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 12:57:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RKYuVrs3SBK3BczW4sF4Dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 12:57:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RKYuVrs3SBK3BczW4sF4Dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:57:24 INFO - Downloaded 10840145 bytes. 12:57:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:57:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 12:57:24 INFO - Return code: 0 12:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:24 INFO - https://queue.taskcluster.net/v1/task/RKYuVrs3SBK3BczW4sF4Dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:57:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RKYuVrs3SBK3BczW4sF4Dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 12:57:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RKYuVrs3SBK3BczW4sF4Dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 12:57:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RKYuVrs3SBK3BczW4sF4Dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 12:57:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RKYuVrs3SBK3BczW4sF4Dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:57:25 INFO - Downloaded 56051584 bytes. 12:57:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RKYuVrs3SBK3BczW4sF4Dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 12:57:25 INFO - mkdir: /builds/slave/test/properties 12:57:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:57:25 INFO - Writing to file /builds/slave/test/properties/build_url 12:57:25 INFO - Contents: 12:57:25 INFO - build_url:https://queue.taskcluster.net/v1/task/RKYuVrs3SBK3BczW4sF4Dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 12:57:26 INFO - Running post-action listener: _resource_record_post_action 12:57:26 INFO - Running post-action listener: set_extra_try_arguments 12:57:26 INFO - ##### 12:57:26 INFO - ##### Running populate-webroot step. 12:57:26 INFO - ##### 12:57:26 INFO - Running pre-action listener: _resource_record_pre_action 12:57:26 INFO - Running main action method: populate_webroot 12:57:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:57:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:57:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:57:26 INFO - '--tppagecycles', 12:57:26 INFO - '7'], 12:57:26 INFO - 'tests': ['tsvgm']}}, 12:57:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:57:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:57:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:57:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:57:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:57:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:57:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:26 INFO - 'talos_options': ['--disable-e10s'], 12:57:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:57:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:57:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:26 INFO - 'talos_options': ['--disable-e10s'], 12:57:26 INFO - 'tests': ['damp', 'tps']}, 12:57:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:26 INFO - 'tests': ['damp', 'tps']}, 12:57:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:57:26 INFO - 'tests': ['dromaeo_dom']}, 12:57:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:57:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:57:26 INFO - 'tests': ['a11yr', 12:57:26 INFO - 'ts_paint', 12:57:26 INFO - 'tpaint', 12:57:26 INFO - 'sessionrestore', 12:57:26 INFO - 'sessionrestore_no_auto_restore', 12:57:26 INFO - 'tabpaint']}, 12:57:26 INFO - 'other-e10s': {'tests': ['a11yr', 12:57:26 INFO - 'ts_paint', 12:57:26 INFO - 'tpaint', 12:57:26 INFO - 'sessionrestore', 12:57:26 INFO - 'sessionrestore_no_auto_restore', 12:57:26 INFO - 'tabpaint']}, 12:57:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:57:26 INFO - 'ts_paint', 12:57:26 INFO - 'tpaint', 12:57:26 INFO - 'sessionrestore', 12:57:26 INFO - 'sessionrestore_no_auto_restore', 12:57:26 INFO - 'tabpaint']}, 12:57:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:57:26 INFO - 'ts_paint', 12:57:26 INFO - 'tpaint', 12:57:26 INFO - 'sessionrestore', 12:57:26 INFO - 'sessionrestore_no_auto_restore', 12:57:26 INFO - 'tabpaint']}, 12:57:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:57:26 INFO - 'tests': ['a11yr', 12:57:26 INFO - 'ts_paint', 12:57:26 INFO - 'tpaint', 12:57:26 INFO - 'sessionrestore', 12:57:26 INFO - 'sessionrestore_no_auto_restore', 12:57:26 INFO - 'tabpaint']}, 12:57:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:57:26 INFO - 'tests': ['a11yr', 12:57:26 INFO - 'ts_paint', 12:57:26 INFO - 'tpaint', 12:57:26 INFO - 'sessionrestore', 12:57:26 INFO - 'sessionrestore_no_auto_restore', 12:57:26 INFO - 'tabpaint']}, 12:57:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:57:26 INFO - 'tests': ['tsvgx', 12:57:26 INFO - 'tsvgr_opacity', 12:57:26 INFO - 'tart', 12:57:26 INFO - 'tscrollx', 12:57:26 INFO - 'cart']}, 12:57:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:57:26 INFO - 'tsvgr_opacity', 12:57:26 INFO - 'tart', 12:57:26 INFO - 'tscrollx', 12:57:26 INFO - 'cart']}, 12:57:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:26 INFO - 'talos_options': ['--disable-e10s'], 12:57:26 INFO - 'tests': ['tp5o']}, 12:57:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:26 INFO - 'tests': ['tp5o']}, 12:57:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:26 INFO - 'talos_options': ['--disable-e10s', 12:57:26 INFO - '--xperf_path', 12:57:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:57:26 INFO - 'tests': ['tp5n']}, 12:57:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:26 INFO - 'talos_options': ['--xperf_path', 12:57:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:57:26 INFO - 'tests': ['tp5n']}}, 12:57:26 INFO - 'talos.zip': {'path': '', 12:57:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:57:26 INFO - Running post-action listener: _resource_record_post_action 12:57:26 INFO - ##### 12:57:26 INFO - ##### Running create-virtualenv step. 12:57:26 INFO - ##### 12:57:26 INFO - Running pre-action listener: _resource_record_pre_action 12:57:26 INFO - Running main action method: create_virtualenv 12:57:26 INFO - Creating virtualenv /builds/slave/test/build/venv 12:57:26 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 12:57:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:57:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:57:26 INFO - Using real prefix '/usr' 12:57:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:57:27 INFO - Installing distribute.............................................................................................................................................................................................done. 12:57:29 INFO - Installing pip.................done. 12:57:29 INFO - Return code: 0 12:57:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:57:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:29 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 0x7f88d4583f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19115a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a0410>, '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 0x19a1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a17a0>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468612634.497432-246536648', '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 12:57:29 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 12:57:29 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 12:57:29 INFO - Using env: {'DISPLAY': ':0', 12:57:29 INFO - 'HOME': '/home/cltbld', 12:57:29 INFO - 'LANG': 'en_US.UTF-8', 12:57:29 INFO - 'LANGUAGE': 'en_US:en', 12:57:29 INFO - 'LOGNAME': 'cltbld', 12:57:29 INFO - 'MAIL': '/var/mail/cltbld', 12:57:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:29 INFO - 'MOZ_NO_REMOTE': '1', 12:57:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:29 INFO - 'NO_EM_RESTART': '1', 12:57:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:29 INFO - 'PWD': '/builds/slave/test', 12:57:29 INFO - 'SHELL': '/bin/bash', 12:57:29 INFO - 'SHLVL': '1', 12:57:29 INFO - 'TERM': 'linux', 12:57:29 INFO - 'TMOUT': '86400', 12:57:29 INFO - 'USER': 'cltbld', 12:57:29 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468612634.497432-246536648', 12:57:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:29 INFO - '_': '/tools/buildbot/bin/python'} 12:57:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:29 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 12:57:29 INFO - Cleaning up... 12:57:29 INFO - Return code: 0 12:57:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:57:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:29 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 0x7f88d4583f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19115a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a0410>, '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 0x19a1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a17a0>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468612634.497432-246536648', '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 12:57:29 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 12:57:29 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 12:57:29 INFO - Using env: {'DISPLAY': ':0', 12:57:29 INFO - 'HOME': '/home/cltbld', 12:57:29 INFO - 'LANG': 'en_US.UTF-8', 12:57:29 INFO - 'LANGUAGE': 'en_US:en', 12:57:29 INFO - 'LOGNAME': 'cltbld', 12:57:29 INFO - 'MAIL': '/var/mail/cltbld', 12:57:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:29 INFO - 'MOZ_NO_REMOTE': '1', 12:57:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:29 INFO - 'NO_EM_RESTART': '1', 12:57:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:29 INFO - 'PWD': '/builds/slave/test', 12:57:29 INFO - 'SHELL': '/bin/bash', 12:57:29 INFO - 'SHLVL': '1', 12:57:29 INFO - 'TERM': 'linux', 12:57:29 INFO - 'TMOUT': '86400', 12:57:29 INFO - 'USER': 'cltbld', 12:57:29 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468612634.497432-246536648', 12:57:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:29 INFO - '_': '/tools/buildbot/bin/python'} 12:57:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:29 INFO - Downloading/unpacking psutil>=0.7.1 12:57:29 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 12:57:29 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 12:57:29 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 12:57:29 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 12:57:29 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 12:57:29 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 12:57:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:57:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:57:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:57:31 INFO - Installing collected packages: psutil 12:57:31 INFO - Running setup.py install for psutil 12:57:31 INFO - building 'psutil._psutil_linux' extension 12:57:31 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 12:57:31 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 12:57:31 INFO - building 'psutil._psutil_posix' extension 12:57:31 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 12:57:31 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 12:57:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:57:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:57:32 INFO - Successfully installed psutil 12:57:32 INFO - Cleaning up... 12:57:32 INFO - Return code: 0 12:57:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:57:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:32 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 0x7f88d4583f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19115a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a0410>, '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 0x19a1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a17a0>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468612634.497432-246536648', '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 12:57:32 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 12:57:32 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 12:57:32 INFO - Using env: {'DISPLAY': ':0', 12:57:32 INFO - 'HOME': '/home/cltbld', 12:57:32 INFO - 'LANG': 'en_US.UTF-8', 12:57:32 INFO - 'LANGUAGE': 'en_US:en', 12:57:32 INFO - 'LOGNAME': 'cltbld', 12:57:32 INFO - 'MAIL': '/var/mail/cltbld', 12:57:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:32 INFO - 'MOZ_NO_REMOTE': '1', 12:57:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:32 INFO - 'NO_EM_RESTART': '1', 12:57:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:32 INFO - 'PWD': '/builds/slave/test', 12:57:32 INFO - 'SHELL': '/bin/bash', 12:57:32 INFO - 'SHLVL': '1', 12:57:32 INFO - 'TERM': 'linux', 12:57:32 INFO - 'TMOUT': '86400', 12:57:32 INFO - 'USER': 'cltbld', 12:57:32 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468612634.497432-246536648', 12:57:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:32 INFO - '_': '/tools/buildbot/bin/python'} 12:57:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:57:32 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 12:57:32 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 12:57:32 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 12:57:32 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 12:57:32 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 12:57:32 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 12:57:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:57:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:57:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:57:34 INFO - Installing collected packages: mozsystemmonitor 12:57:34 INFO - Running setup.py install for mozsystemmonitor 12:57:34 INFO - Successfully installed mozsystemmonitor 12:57:34 INFO - Cleaning up... 12:57:34 INFO - Return code: 0 12:57:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:57:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f88d4583f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19115a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a0410>, '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 0x19a1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a17a0>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468612634.497432-246536648', '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 12:57:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:57:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:57:34 INFO - Using env: {'DISPLAY': ':0', 12:57:34 INFO - 'HOME': '/home/cltbld', 12:57:34 INFO - 'LANG': 'en_US.UTF-8', 12:57:34 INFO - 'LANGUAGE': 'en_US:en', 12:57:34 INFO - 'LOGNAME': 'cltbld', 12:57:34 INFO - 'MAIL': '/var/mail/cltbld', 12:57:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:34 INFO - 'MOZ_NO_REMOTE': '1', 12:57:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:34 INFO - 'NO_EM_RESTART': '1', 12:57:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:34 INFO - 'PWD': '/builds/slave/test', 12:57:34 INFO - 'SHELL': '/bin/bash', 12:57:34 INFO - 'SHLVL': '1', 12:57:34 INFO - 'TERM': 'linux', 12:57:34 INFO - 'TMOUT': '86400', 12:57:34 INFO - 'USER': 'cltbld', 12:57:34 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468612634.497432-246536648', 12:57:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:34 INFO - '_': '/tools/buildbot/bin/python'} 12:57:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:34 INFO - Downloading/unpacking blobuploader==1.2.4 12:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:36 INFO - Downloading blobuploader-1.2.4.tar.gz 12:57:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:57:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:57:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:57:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:57:37 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 12:57:37 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 12:57:37 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 12:57:37 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 12:57:37 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 12:57:37 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 12:57:37 INFO - Downloading docopt-0.6.1.tar.gz 12:57:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:57:37 INFO - Installing collected packages: blobuploader, requests, docopt 12:57:37 INFO - Running setup.py install for blobuploader 12:57:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:57:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:57:37 INFO - Running setup.py install for requests 12:57:37 INFO - Running setup.py install for docopt 12:57:37 INFO - Successfully installed blobuploader requests docopt 12:57:37 INFO - Cleaning up... 12:57:37 INFO - Return code: 0 12:57:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:57:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:37 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 0x7f88d4583f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19115a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a0410>, '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 0x19a1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a17a0>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468612634.497432-246536648', '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 12:57:37 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 12:57:37 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 12:57:37 INFO - Using env: {'DISPLAY': ':0', 12:57:37 INFO - 'HOME': '/home/cltbld', 12:57:37 INFO - 'LANG': 'en_US.UTF-8', 12:57:37 INFO - 'LANGUAGE': 'en_US:en', 12:57:37 INFO - 'LOGNAME': 'cltbld', 12:57:37 INFO - 'MAIL': '/var/mail/cltbld', 12:57:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:37 INFO - 'MOZ_NO_REMOTE': '1', 12:57:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:37 INFO - 'NO_EM_RESTART': '1', 12:57:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:37 INFO - 'PWD': '/builds/slave/test', 12:57:37 INFO - 'SHELL': '/bin/bash', 12:57:37 INFO - 'SHLVL': '1', 12:57:37 INFO - 'TERM': 'linux', 12:57:37 INFO - 'TMOUT': '86400', 12:57:37 INFO - 'USER': 'cltbld', 12:57:37 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468612634.497432-246536648', 12:57:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:37 INFO - '_': '/tools/buildbot/bin/python'} 12:57:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:57:38 INFO - Running setup.py (path:/tmp/pip-InEIYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:57:38 INFO - Running setup.py (path:/tmp/pip-mlbYa0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:57:38 INFO - Running setup.py (path:/tmp/pip-saH5JP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:57:38 INFO - Running setup.py (path:/tmp/pip-I4EKj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:57:38 INFO - Running setup.py (path:/tmp/pip-gtNzEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:57:38 INFO - Running setup.py (path:/tmp/pip-kgoV8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:57:38 INFO - Running setup.py (path:/tmp/pip-YLghmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:57:38 INFO - Running setup.py (path:/tmp/pip-YaJxFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:57:38 INFO - Running setup.py (path:/tmp/pip-jmpgYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:57:38 INFO - Running setup.py (path:/tmp/pip-ONdP1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:57:38 INFO - Running setup.py (path:/tmp/pip-aoFDZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:57:38 INFO - Running setup.py (path:/tmp/pip-OtNqjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:57:39 INFO - Running setup.py (path:/tmp/pip-JtNVqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:57:39 INFO - Running setup.py (path:/tmp/pip-FOtfWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:57:39 INFO - Running setup.py (path:/tmp/pip-9Yr0ax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:57:39 INFO - Running setup.py (path:/tmp/pip-nRK2y4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:57:39 INFO - Running setup.py (path:/tmp/pip-cCU6tk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:57:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:57:39 INFO - Running setup.py install for manifestparser 12:57:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:57:39 INFO - Running setup.py install for mozcrash 12:57:39 INFO - Running setup.py install for mozdebug 12:57:39 INFO - Running setup.py install for mozdevice 12:57:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:57:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:57:39 INFO - Running setup.py install for mozfile 12:57:39 INFO - Running setup.py install for mozhttpd 12:57:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:57:39 INFO - Running setup.py install for mozinfo 12:57:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:57:40 INFO - Running setup.py install for mozInstall 12:57:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:57:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:57:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:57:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:57:40 INFO - Running setup.py install for mozleak 12:57:40 INFO - Running setup.py install for mozlog 12:57:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:57:40 INFO - Running setup.py install for moznetwork 12:57:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:57:40 INFO - Running setup.py install for mozprocess 12:57:40 INFO - Running setup.py install for mozprofile 12:57:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:57:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:57:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:57:40 INFO - Running setup.py install for mozrunner 12:57:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:57:40 INFO - Running setup.py install for mozscreenshot 12:57:40 INFO - Running setup.py install for moztest 12:57:41 INFO - Running setup.py install for mozversion 12:57:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:57:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:57:41 INFO - Cleaning up... 12:57:41 INFO - Return code: 0 12:57:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:57: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')]} 12:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57: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')]} 12:57:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:41 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 0x7f88d4583f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19115a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a0410>, '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 0x19a1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a17a0>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468612634.497432-246536648', '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 12:57:41 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 12:57:41 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 12:57:41 INFO - Using env: {'DISPLAY': ':0', 12:57:41 INFO - 'HOME': '/home/cltbld', 12:57:41 INFO - 'LANG': 'en_US.UTF-8', 12:57:41 INFO - 'LANGUAGE': 'en_US:en', 12:57:41 INFO - 'LOGNAME': 'cltbld', 12:57:41 INFO - 'MAIL': '/var/mail/cltbld', 12:57:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:41 INFO - 'MOZ_NO_REMOTE': '1', 12:57:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:41 INFO - 'NO_EM_RESTART': '1', 12:57:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:41 INFO - 'PWD': '/builds/slave/test', 12:57:41 INFO - 'SHELL': '/bin/bash', 12:57:41 INFO - 'SHLVL': '1', 12:57:41 INFO - 'TERM': 'linux', 12:57:41 INFO - 'TMOUT': '86400', 12:57:41 INFO - 'USER': 'cltbld', 12:57:41 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468612634.497432-246536648', 12:57:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:41 INFO - '_': '/tools/buildbot/bin/python'} 12:57:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:57:41 INFO - Running setup.py (path:/tmp/pip-VXJYey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:57:41 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)) 12:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:57:41 INFO - Running setup.py (path:/tmp/pip-AIrmV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:57:41 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)) 12:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:57:41 INFO - Running setup.py (path:/tmp/pip-aD9bvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:57:41 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)) 12:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:57:41 INFO - Running setup.py (path:/tmp/pip-XaopGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:57:41 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)) 12:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:57:41 INFO - Running setup.py (path:/tmp/pip-XdrAQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:57:41 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)) 12:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:57:41 INFO - Running setup.py (path:/tmp/pip-iVxySX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:57:41 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)) 12:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:57:41 INFO - Running setup.py (path:/tmp/pip-Qrv0Re-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:57:41 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)) 12:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:57:41 INFO - Running setup.py (path:/tmp/pip-5ST8Yn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:57:41 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)) 12:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:57:41 INFO - Running setup.py (path:/tmp/pip-1OdSlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:57:42 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)) 12:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:57:42 INFO - Running setup.py (path:/tmp/pip-xm8405-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:57:42 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)) 12:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:57:42 INFO - Running setup.py (path:/tmp/pip-rwbYOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:57:42 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)) 12:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:57:42 INFO - Running setup.py (path:/tmp/pip-vc7Reh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:57:42 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)) 12:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:57:42 INFO - Running setup.py (path:/tmp/pip-RJMmo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:57:42 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)) 12:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:57:42 INFO - Running setup.py (path:/tmp/pip-qvzA4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:57:42 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)) 12:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:57:42 INFO - Running setup.py (path:/tmp/pip-EU8FZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:57:42 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)) 12:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:57:42 INFO - Running setup.py (path:/tmp/pip-yR1vLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:57:42 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)) 12:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:57:42 INFO - Running setup.py (path:/tmp/pip-S82qnZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:57:42 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)) 12:57:42 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)) 12:57:42 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)) 12:57:42 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)) 12:57:42 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)) 12:57:42 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)) 12:57:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:57:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:44 INFO - Downloading blessings-1.6.tar.gz 12:57:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:57:44 INFO - Installing collected packages: blessings 12:57:44 INFO - Running setup.py install for blessings 12:57:44 INFO - Successfully installed blessings 12:57:44 INFO - Cleaning up... 12:57:44 INFO - Return code: 0 12:57:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:57:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:57:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:57:44 INFO - Reading from file tmpfile_stdout 12:57:44 INFO - Current package versions: 12:57:44 INFO - argparse == 1.2.1 12:57:44 INFO - blessings == 1.6 12:57:44 INFO - blobuploader == 1.2.4 12:57:44 INFO - docopt == 0.6.1 12:57:44 INFO - manifestparser == 1.1 12:57:44 INFO - mozInstall == 1.12 12:57:44 INFO - mozcrash == 0.17 12:57:44 INFO - mozdebug == 0.1 12:57:44 INFO - mozdevice == 0.48 12:57:44 INFO - mozfile == 1.2 12:57:44 INFO - mozhttpd == 0.7 12:57:44 INFO - mozinfo == 0.9 12:57:44 INFO - mozleak == 0.1 12:57:44 INFO - mozlog == 3.1 12:57:44 INFO - moznetwork == 0.27 12:57:44 INFO - mozprocess == 0.22 12:57:44 INFO - mozprofile == 0.28 12:57:44 INFO - mozrunner == 6.11 12:57:44 INFO - mozscreenshot == 0.1 12:57:44 INFO - mozsystemmonitor == 0.0 12:57:44 INFO - moztest == 0.7 12:57:44 INFO - mozversion == 1.4 12:57:44 INFO - psutil == 3.1.1 12:57:44 INFO - requests == 1.2.3 12:57:44 INFO - wsgiref == 0.1.2 12:57:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:57:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:45 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 0x7f88d4583f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19115a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a0410>, '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 0x19a1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a17a0>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468612634.497432-246536648', '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 12:57:45 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 12:57:45 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 12:57:45 INFO - Using env: {'DISPLAY': ':0', 12:57:45 INFO - 'HOME': '/home/cltbld', 12:57:45 INFO - 'LANG': 'en_US.UTF-8', 12:57:45 INFO - 'LANGUAGE': 'en_US:en', 12:57:45 INFO - 'LOGNAME': 'cltbld', 12:57:45 INFO - 'MAIL': '/var/mail/cltbld', 12:57:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:45 INFO - 'MOZ_NO_REMOTE': '1', 12:57:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:45 INFO - 'NO_EM_RESTART': '1', 12:57:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:45 INFO - 'PWD': '/builds/slave/test', 12:57:45 INFO - 'SHELL': '/bin/bash', 12:57:45 INFO - 'SHLVL': '1', 12:57:45 INFO - 'TERM': 'linux', 12:57:45 INFO - 'TMOUT': '86400', 12:57:45 INFO - 'USER': 'cltbld', 12:57:45 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468612634.497432-246536648', 12:57:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:45 INFO - '_': '/tools/buildbot/bin/python'} 12:57:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:45 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)) 12:57:45 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)) 12:57:45 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)) 12:57:45 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)) 12:57:45 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)) 12:57:45 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)) 12:57:45 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)) 12:57:45 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)) 12:57:45 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)) 12:57:45 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)) 12:57:45 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)) 12:57:45 INFO - Cleaning up... 12:57:45 INFO - Return code: 0 12:57:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:57:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88d4583f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19115a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a0410>, '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 0x19a1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a17a0>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468612634.497432-246536648', '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 12:57:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:57:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:57:45 INFO - Using env: {'DISPLAY': ':0', 12:57:45 INFO - 'HOME': '/home/cltbld', 12:57:45 INFO - 'LANG': 'en_US.UTF-8', 12:57:45 INFO - 'LANGUAGE': 'en_US:en', 12:57:45 INFO - 'LOGNAME': 'cltbld', 12:57:45 INFO - 'MAIL': '/var/mail/cltbld', 12:57:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:45 INFO - 'MOZ_NO_REMOTE': '1', 12:57:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:45 INFO - 'NO_EM_RESTART': '1', 12:57:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:45 INFO - 'PWD': '/builds/slave/test', 12:57:45 INFO - 'SHELL': '/bin/bash', 12:57:45 INFO - 'SHLVL': '1', 12:57:45 INFO - 'TERM': 'linux', 12:57:45 INFO - 'TMOUT': '86400', 12:57:45 INFO - 'USER': 'cltbld', 12:57:45 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468612634.497432-246536648', 12:57:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:45 INFO - '_': '/tools/buildbot/bin/python'} 12:57:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:45 INFO - Downloading/unpacking jsonschema 12:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:57:47 INFO - Downloading/unpacking functools32 (from jsonschema) 12:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:47 INFO - Downloading functools32-3.2.3-2.tar.gz 12:57:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:57:47 INFO - warning: no files found matching '*.txt' 12:57:47 INFO - no previously-included directories found matching 'build' 12:57:47 INFO - no previously-included directories found matching 'dist' 12:57:47 INFO - no previously-included directories found matching '.git*' 12:57:47 INFO - Installing collected packages: jsonschema, functools32 12:57:47 INFO - Running setup.py install for functools32 12:57:47 INFO - warning: no files found matching '*.txt' 12:57:47 INFO - no previously-included directories found matching 'build' 12:57:47 INFO - no previously-included directories found matching 'dist' 12:57:47 INFO - no previously-included directories found matching '.git*' 12:57:47 INFO - Successfully installed jsonschema functools32 12:57:47 INFO - Cleaning up... 12:57:47 INFO - Return code: 0 12:57:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:57: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')]} 12:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57: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')]} 12:57:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88d4583f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19115a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a0410>, '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 0x19a1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a17a0>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468612634.497432-246536648', '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 12:57:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 12:57:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 12:57:47 INFO - Using env: {'DISPLAY': ':0', 12:57:47 INFO - 'HOME': '/home/cltbld', 12:57:47 INFO - 'LANG': 'en_US.UTF-8', 12:57:47 INFO - 'LANGUAGE': 'en_US:en', 12:57:47 INFO - 'LOGNAME': 'cltbld', 12:57:47 INFO - 'MAIL': '/var/mail/cltbld', 12:57:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:47 INFO - 'MOZ_NO_REMOTE': '1', 12:57:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:47 INFO - 'NO_EM_RESTART': '1', 12:57:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:47 INFO - 'PWD': '/builds/slave/test', 12:57:47 INFO - 'SHELL': '/bin/bash', 12:57:47 INFO - 'SHLVL': '1', 12:57:47 INFO - 'TERM': 'linux', 12:57:47 INFO - 'TMOUT': '86400', 12:57:47 INFO - 'USER': 'cltbld', 12:57:47 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468612634.497432-246536648', 12:57:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:47 INFO - '_': '/tools/buildbot/bin/python'} 12:57:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:48 INFO - Downloading/unpacking flake8 12:57:48 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 12:57:48 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 12:57:48 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 12:57:48 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 12:57:48 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 12:57:48 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 12:57:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:57:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:57:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:57:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:57:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:57:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:57:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:57:50 INFO - no previously-included directories found matching 'docs/_build' 12:57:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:57:50 INFO - Running setup.py install for pep8 12:57:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:57:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:57:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:57:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:57:50 INFO - no previously-included directories found matching 'docs/_build' 12:57:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:57:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:57:50 INFO - Cleaning up... 12:57:50 INFO - Return code: 0 12:57:50 INFO - Running post-action listener: _resource_record_post_action 12:57:50 INFO - Running post-action listener: _start_resource_monitoring 12:57:51 INFO - Starting resource monitoring. 12:57:51 INFO - ##### 12:57:51 INFO - ##### Running install step. 12:57:51 INFO - ##### 12:57:51 INFO - Running pre-action listener: _resource_record_pre_action 12:57:51 INFO - Running main action method: install 12:57:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:57:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:57:51 INFO - Reading from file tmpfile_stdout 12:57:51 INFO - Detecting whether we're running mozinstall >=1.0... 12:57:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:57:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:57:51 INFO - Reading from file tmpfile_stdout 12:57:51 INFO - Output received: 12:57:51 INFO - Usage: mozinstall [options] installer 12:57:51 INFO - Options: 12:57:51 INFO - -h, --help show this help message and exit 12:57:51 INFO - -d DEST, --destination=DEST 12:57:51 INFO - Directory to install application into. [default: 12:57:51 INFO - "/builds/slave/test"] 12:57:51 INFO - --app=APP Application being installed. [default: firefox] 12:57:51 INFO - mkdir: /builds/slave/test/build/application 12:57:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:57:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:58:04 INFO - Reading from file tmpfile_stdout 12:58:04 INFO - Output received: 12:58:04 INFO - /builds/slave/test/build/application/firefox/firefox 12:58:04 INFO - Running post-action listener: _resource_record_post_action 12:58:04 INFO - ##### 12:58:04 INFO - ##### Running run-tests step. 12:58:04 INFO - ##### 12:58:04 INFO - Running pre-action listener: _resource_record_pre_action 12:58:04 INFO - Running main action method: run_tests 12:58:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:58:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:58:04 INFO - Python 2.7.3 12:58:04 INFO - Return code: 0 12:58:04 INFO - grabbing minidump binary from tooltool 12:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:58:04 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 0x19a0410>, '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 0x19a1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a17a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:58:04 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 12:58:04 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 12:58:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:58:04 INFO - Return code: 0 12:58:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:58:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:58:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:58:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:58:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:58:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:58:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:58:05 INFO - Return code: 0 12:58:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RKYuVrs3SBK3BczW4sF4Dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 12:58:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RKYuVrs3SBK3BczW4sF4Dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --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 12:58:05 INFO - Using env: {'DISPLAY': ':0', 12:58:05 INFO - 'HOME': '/home/cltbld', 12:58:05 INFO - 'LANG': 'en_US.UTF-8', 12:58:05 INFO - 'LANGUAGE': 'en_US:en', 12:58:05 INFO - 'LOGNAME': 'cltbld', 12:58:05 INFO - 'MAIL': '/var/mail/cltbld', 12:58:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:58:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:58:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:05 INFO - 'MOZ_NO_REMOTE': '1', 12:58:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:58:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:58:05 INFO - 'NO_EM_RESTART': '1', 12:58:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:58:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:58:05 INFO - 'PWD': '/builds/slave/test', 12:58:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:58:05 INFO - 'SHELL': '/bin/bash', 12:58:05 INFO - 'SHLVL': '1', 12:58:05 INFO - 'TERM': 'linux', 12:58:05 INFO - 'TMOUT': '86400', 12:58:05 INFO - 'USER': 'cltbld', 12:58:05 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468612634.497432-246536648', 12:58:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:05 INFO - '_': '/tools/buildbot/bin/python'} 12:58:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RKYuVrs3SBK3BczW4sF4Dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 12:58:05 INFO - mozversion application_buildid: 20160715100204 12:58:05 INFO - mozversion application_changeset: b9a4d34cb07363b0616321353610e47c1ddaa2ae 12:58:05 INFO - mozversion application_display_name: Firefox 12:58:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:58:05 INFO - mozversion application_name: Firefox 12:58:05 INFO - mozversion application_remotingname: firefox 12:58:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:58:05 INFO - mozversion application_vendor: Mozilla 12:58:05 INFO - mozversion application_version: 48.0 12:58:05 INFO - mozversion platform_buildid: 20160715100204 12:58:05 INFO - mozversion platform_changeset: b9a4d34cb07363b0616321353610e47c1ddaa2ae 12:58:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:58:05 INFO - mozversion platform_version: 48.0 12:58:05 INFO - using testdate: 1468612685 12:58:05 INFO - actual date: 1468612685 12:58:05 INFO - starting webserver on 'localhost:32935' 12:58:05 INFO - SUITE-START | Running 2 tests 12:58:05 INFO - TEST-START | dromaeo_css 12:58:05 INFO - operating with platform_type : linux_ 12:58:05 INFO - Initialising browser for dromaeo_css test... 12:58:05 INFO - TEST-INFO | started process 28491 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_uejrJ/profile http://localhost:32935/getInfo.html) 12:58:09 INFO - PROCESS | 28491 | 12:58:09 INFO - PROCESS | 28491 | (process:28564): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:58:10 INFO - PROCESS | 28491 | __metrics Screen width/height:1600/1200 12:58:10 INFO - PROCESS | 28491 | colorDepth:24 12:58:10 INFO - PROCESS | 28491 | Browser inner width/height: 1024/697 12:58:10 INFO - PROCESS | 28491 | __metrics 12:58:10 ERROR - PROCESS | 28491 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 12:58:11 INFO - TEST-INFO | 28491: exit 0 12:58:11 INFO - Browser initialized. 12:58:11 INFO - Running cycle 1/1 for dromaeo_css test... 12:58:11 INFO - TEST-INFO | started process 28614 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_uejrJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:58:13 INFO - PROCESS | 28614 | 12:58:13 INFO - PROCESS | 28614 | (process:28681): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:58:23 INFO - PROCESS | 28614 | RSS: Main: 150740992 12:58:23 INFO - PROCESS | 28614 | 12:59:13 INFO - PROCESS | 28614 | 1468612753089 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 13:01:20 INFO - PROCESS | 28614 | Cycle 1(1): loaded http://localhost:32935/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32935/tests/dromaeo/cssquery-ext.html) 13:01:21 INFO - PROCESS | 28614 | RSS: Main: 154624000 13:01:21 INFO - PROCESS | 28614 | 13:04:22 INFO - PROCESS | 28614 | Cycle 1(1): loaded http://localhost:32935/tests/dromaeo/cssquery-ext.html (next: http://localhost:32935/tests/dromaeo/cssquery-jquery.html) 13:04:23 INFO - PROCESS | 28614 | RSS: Main: 152010752 13:04:23 INFO - PROCESS | 28614 | 13:07:25 INFO - PROCESS | 28614 | Cycle 1(1): loaded http://localhost:32935/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32935/tests/dromaeo/cssquery-mootools.html) 13:07:25 INFO - PROCESS | 28614 | RSS: Main: 151842816 13:07:25 INFO - PROCESS | 28614 | 13:10:27 INFO - PROCESS | 28614 | Cycle 1(1): loaded http://localhost:32935/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32935/tests/dromaeo/cssquery-prototype.html) 13:10:28 INFO - PROCESS | 28614 | RSS: Main: 153546752 13:10:28 INFO - PROCESS | 28614 | 13:13:30 INFO - PROCESS | 28614 | Cycle 1(1): loaded http://localhost:32935/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32935/tests/dromaeo/cssquery-yui.html) 13:13:30 INFO - PROCESS | 28614 | RSS: Main: 152207360 13:13:30 INFO - PROCESS | 28614 | 13:16:33 INFO - PROCESS | 28614 | Cycle 1(1): loaded http://localhost:32935/tests/dromaeo/cssquery-yui.html (next: http://localhost:32935/tests/dromaeo/cssquery-dojo.html) 13:16:33 INFO - PROCESS | 28614 | RSS: Main: 155770880 13:16:33 INFO - PROCESS | 28614 | 13:16:33 INFO - PROCESS | 28614 | __start_tp_report 13:16:33 INFO - PROCESS | 28614 | _x_x_mozilla_page_load 13:16:33 INFO - PROCESS | 28614 | _x_x_mozilla_page_load_details 13:16:33 INFO - PROCESS | 28614 | |i|pagename|runs| 13:16:33 INFO - PROCESS | 28614 | |0;dojo.html;3292.341531693661;3373.021823671135;3381.8816341428055;3415.4706020566805;3422.82885855707;5312.601554883389;5326.813561525348;5328.307320048389;5333.839984800457;5361.91957120643;5289.127293996486;5314.441983591715;5324.094903866342;5341.839744807662;5366.356037275523;4850.054239423313;4858.34412354332;4887.8778030549165;4922.630802689795;4947.084789313971;4953.554180123788;4974.477679843619;4981.37732783402;5005.674631148963;5006.97496512517;5064.898702025957;5079.161938280198;5123.743812809364;5131.025105229995;5135.332406787131;4957.3059771632;4964.156093464084;4966.180580204262;4968.875778105558;4992.32603598515;4900.607951363882;4908.828191013297;4913.213885778294;4943.060818444484;4991.276264941564;5302.125149350352;5306.363236411656;5313.814016509404;5315.920261196085;5335.5464785492895;5783.537317014629;5814.941850581482;5817.243758311435;5822.417758224186;5835.883282334372;5891.05743081105;5979.581429299951;6001.4298641628975;6018.759249630009;6063.060225665029;5496.422875598045;5555.083411237181;5564.360098588673;5566.916496252559;5579.163125531162;5691.943080569141;6018.277806663141;6018.939810601925;6021.789237376671;6024.789132380433;5819.73811178498;5840.766369345263;5886.705664716747;5887.264091988502;5888.676122813201;5804.535637149018;5809.651420914759;5809.767609295581;5811.854703632358;5821.79623713168;5705.971470142623;5767.596268261265;5772.6536407815665;5773.480386765127;5823.155642431909;5890.057590785454;5908.054711246266;5918.2898052234;5919.200907877467;5940.376260492672;4565.429321334833;4566.337881007302;4568.634509239253;4578.107269082497;4600.171969045537;4049.4735684360844;4062.431259623655;4082.1631565528996;4094.6928980325997;4116.547179810218;5556.972215138899;5692;5743.052396354555;5770.567207459458;5775.191473193756;5984.222051133324;5989.700514974234;5994.520438364921;6004.6697431640805;6006.249218847644;5607.523360514402;5674.0637794764225;5778.27771528559;5786.508146807484;5791.768329266866;5030.3963524377305;5095.337606111182;5104.183330667075;5109.20807274873;5141.434442211354;6192.907106393408;6219.564630475914;6260.530460215411;6264.968675156595;6270.9372906271265;5812.622179558315;5924.259467566554;5943.465088142088;5960.046392577254;5971.940280597225;6166.321704612579;6194.442500175006;6199.504039676905;6204.627722336674;6214.1921550198185;5774.48029677331;5786.3056433228285;5790.652560846363;5797.507211887037;5828.184054232495;5798.449147330997;5847.356790753099;5894.646321220741;5956.612820166675;5964.642121472725;5706.714664266853;5710.885782284414;5724.227229323988;5726.312842458931;5726.398728133652;5652.7738890443925;5655.632383895034;5657.547396208376;5692.31692196939;5716.828495145152;5525.419830917695;5625.549956003591;5715.742791574472;5720.170575266647;5761.020626493422;5583.609147359646;5600.159976003632;5630;5636.464535869086;5668.943310566841;5516.3380394352935;5529.225908372911;5538.390777014606;5569.053260945568;5620.606557540933 13:16:33 INFO - PROCESS | 28614 | |1;ext.html;658.4205898809047;681.9283975182609;694.1531331775234;729.165105953683;750.2984709296807;31921.52117718236;38460.615393846056;38668.80665596671;39195.21609567807;39254.21491570167;42724.14551708964;43208.78395608025;43338.566614333846;43375.56624433755;43439.13121737563;8658.87011694825;8776.56117194141;8828.690995815148;8838.29293656506;8840.734777956639;8589;8679.783005424852;8723.127687231257;8761.868571971425;8766.824663506726;9044.909550904473;9111.088891110869;9118.17936385725;9136.680216192435;9142.680006199784;8966.148215919477;8998.415103018348;9001.099890010979;9045.14071163245;9048.321375896801;8875.600597973107;8956.283497320199;8971.551422428853;8975.820483590292;8979;42239.366409503884;42728;42829.57170428287;42832.357514637304;42955.140897182195;3840.558335791364;3924.2936271471126;4170.4995400551825;4493.707908985938;4664.39475467334;32848.1787955303;32875;33267.6673233267;33580.83209583937;34164.31671366584;4268.146370725836;4347.217500849846;4351.0862718829085;4511.796969136397;4606.401167848192;271778;272003;274560;274749;275122;39397.40903886444;61998;62432.68783656053;62469.68765156145;62514.374856250855;37516.24967500689;37744.43383349252;37894.62105378966;37926.24147517034;37963.24073518514;16682.916585416995;16888.493345199662;17065;17102.657946841242;17116.315347385964;13050.347482625832;13080.28058456775;13093.279869607262;13115.278659673619;13126.14680045794;9331.20684741791;9421;9456.905430945602;9492.240620750323;9533.523323833919;3640.8361623726996;3706.314331848617;3714.33142034431;3717.219383929351;3796.2217745362136;1144.4792619358172;1159.605734050427;1210.5218438716659;1219.8597161326384;1237.3256575166556;33272;33501.16247093842;33838.66161338404;33953.32093358119;34334.82832585821;1218.6465924881861;1235.9443825027715;1246.4079562207878;1330.0755974597562;1367.6717587778862;17609.647807043788;17678.911605442147;17714.5571360717;17744.733828992576;17851.196696148705;514682;522125;588219;591072;598906;58597.70701146467;59697;60114.39885601176;60130.69934650299;60227;1579.842015798411;1586.1038513239982;1594.8165960914412;1602.1908935987485;1659.3694396129636;30385.544216837206;30633.387332253675;30927.536086958262;31283.530747038356;31889;49106.26340604965;49820.25269620886;53650.46349536454;54101;54110.18834717561;442549;445933;448139;449687;450029;30736;30933.535996959614;31199.064028079192;31300.530492043094;31339.216519587193;49638.25542616936;49984.75007624939;50179;50198;51580.22629660633;41433.58566414297;41874;42273.365899510914;42296.365554516095;43426.34860477032;41007.38488922609;41177.588224117375;41270.1745965073;42578.78710606427;43181.3522797152;43048.354274685276;43983.560164397946;44222;44279.335809962235;44444;35175.12062198466;35282.794205198836;36219.980048736084;36770;36912.44631330586;28920.566191507565;29230.561541577317;29369.55945660774;29405.705942941153;29494 13:16:33 INFO - PROCESS | 28614 | |2;jquery.html;431.5770544866031;433.1034758050835;440.1680823244071;446.6069858524498;451.93221016847446;18164.455066347997;18651;18948;19399.515012124702;19955.600887982233;19625.705614415794;19703;20296.492587685316;20328.288509902155;20478.590428191463;5493.450654934494;5687.544996400299;5767.279090113736;5782.190493330937;5857;5721.628094173865;5746.25298711169;5749.856253593652;5767.798127065554;5783.277090363705;5947.434993675594;5959.0763431668165;5964.7315870785915;5978.611390259641;5993.310769261525;5759.049756790125;5857.6778277194735;5918.644881307114;5920.911186332187;5926.4073592640825;5773.047447171211;5775;5779.046457334534;5800.071988481823;5801.0428279333855;14344.56966291013;14502.98479106463;25183;25910.74089259102;26064.869675651502;2469.790067844235;2475.443025319307;2536.087008676875;2580.4839032193636;2947.8673459694364;15905.284262208228;16332.428365007168;16529;16534.751978720327;17193;2237.3511681612313;2338.8362814602983;2350.048230466664;2353.658719485682;2356.658284548748;76188;76423.61788191079;79533.60233198798;87906.5604671979;94431;18293.81706182948;18902;19090.61818763617;19091.809081909003;19388.224471021284;35465.82267088648;35469.82265088658;35799.82100089535;35801.82099089488;35897.820510897276;10439.895601044043;10608.20438467118;10626.840597391045;10640.946795266129;10995.505202265756;9155.954220228989;9276.814463710689;9290;9332.72001839946;9379.577918993662;9479.383840050512;9579.13787759105;9699.66051188205;9843.163331116935;9930.702078937644;3681.337359275303;3832.9616703832603;3838.9808050960123;3884.8446062157764;4016.859409920697;1079.2768844873954;1115.2249186815086;1136.363636363639;1137.1073707139856;1147.9655610331704;16956;19506.5123371914;19634.312799051964;19951.700724489143;20220.494487637927;1104.469854469859;1106.5739690219323;1139.8575178102737;1141.3380239461092;1161.73280145567;10859.34843909368;11083.113350931906;11226.270292430965;11235.494402751732;11273.718157045976;499473.01053979446;502556;517401;524235;526731;91810;97057;97480.51259743657;97542;99210;1108.41808050774;1124.2804605052772;1125.0886781706843;1128.9435528223555;1146.696125526736;17111.7433238504;17199.484015479557;17238;17337.82662173362;17450.91274543619;38615;39604.80197598993;41109.794451027556;41187.588124118374;42465.36301955411;60010.099848501435;61132.388676114446;61548.07677884925;61781.69109154426;62147;8674.696385626472;8689.217970382695;8730.388872779098;8756.956215219137;8953.731388058368;12535.185212961129;13998.160110393408;14016.29918504091;14027.649308767363;14194;11510.884891150981;11978.64064078079;12176.817347739969;12364.4436000382;12652.810207847073;11264.15518836107;11541.076713863038;11630.476628551905;11769.588064417705;11964.102692297938;11743.236689615147;11749.236299640495;11921.046316294849;12548.18436801605;12880.484780608671;9313.487758173365;9411.152996230097;9434.575444105169;9474.38416502925;9532.285078618992;11816.527338906692;12816.102872799187;12968.15706979081;12984.545540906023;13037.869621303666 13:16:33 INFO - PROCESS | 28614 | |3;mootools.html;1519.1113198778714;1546.6983938132062;1782.6523827853573;1930.749002629658;1945.8735182213163;7777.92222077779;8542.273906717928;8544;8733.650653973842;8748;8555.443896146746;8649.610767515462;8734.344924130684;8780.736577902657;8785.912140878589;2457.397937505309;2476.0590975429313;2498.475320182755;2504.686914135733;2505.073122944513;2428.5992811186134;2461.729209786922;2462.581361168606;2462.642916777066;2463.0763463701114;2387.988060059697;2403.927882163538;2413.1071503543712;2421.6609674645565;2422.8667423291713;2383.797377222938;2442.400227850752;2446.804255659543;2462.8645424501647;2466.962995555059;2485.6768620079456;2488.855126641747;2506.2982364937848;2515.748425157488;2519.8362106463023;8886.422382545114;8891.688790892353;8908.51003194824;8930.86603700945;8966.372353935227;5486.31421072366;5584.162375643646;5593.133064375028;5613.326400831927;5617.157426386034;3438.7420943429343;3492.6856582907662;3546.929061418783;3583.050491619723;3584.301061293049;1208.7038675524466;1316.1642357103212;1318.162966516269;1337.4182230729566;1357.7963305504254;11981.580644677395;12022.458989345501;12065.638030859089;12098.213616114925;12129.908308252212;4504.774761261924;4597.609203217697;4645.907081858344;4713.481517033124;4746.905061898743;9733.805323893483;9771.413715177112;9788.755281118029;9799.412035277906;9812.558434870449;5276.551493123051;5297;5311.840644780663;5318.65428747138;5324.201369794562;4898.2652602109965;4935.8025678972435;5063.1645778446145;5066.290719299301;5111.207762796773;4070.004469833545;4087.305158123126;4101.179764047202;4129.690273229459;4132.8140233689555;1311.2984553264148;1315.421214665544;1336.6658335416146;1338.5850386380253;1346.562367230654;901.9278457723366;945.645382981382;984.4585477987079;1062.4103622489592;1074.4198133008244;5880.941190588125;5904.439078287556;5952.494038006818;5994.760209591567;6111.54163437744;975.6390135649855;1000.4397537379091;1047.8899715529913;1060.8620879285643;1060.931039482431;4090;4161.875143745692;4187.853425130106;4247.660187185018;4300.419443375167;10694.946525267324;10992.065674417765;11137.554497820158;11164.609238676607;11181.440927953732;10835.83746243807;10867.565297388015;10936.070434013198;10989.285696429706;11010.284331518425;8319.916800831914;8399.412041157182;8509.702160424355;8527.062023177445;8538.957305213435;5826.242588463472;5832.300123985149;5852.18069470266;5900.173975643327;5996.67018313997;9394.67118650844;9404.153626173676;9586;9646;9798.069183427562;9441.669541566287;9502.334836561375;9587.760305992406;9650.71047868565;9713.882903465908;6975.860482790417;7477.364424024019;7510.760724480618;7603.505772124794;7801.648925798466;8350.164983501601;8354.122817104117;8387.287080598218;8397.790055248668;8412.116727743743;7459.589722565311;7475.514091584029;7485.026946496921;7557.584332861746;7690.769276921701;7258.383037441666;7270.309320614533;7303.488755787256;7353.411727061715;7379.262073792578;7015.438764898898;7021.5787052777;7036.155661320469;7050.894236586353;7064.823379415556;5016.523430274118;5113.105206588758;5121.436641969306;5168.767405466688;5212.530872221519;5105.872353191051;5110.872228194176;5134.5635620972635;5134.768935397841;5197.766100525561 13:16:33 INFO - PROCESS | 28614 | |4;prototype.html;366.6187165348038;367.9043448703338;371.41131306878594;372.45063531291333;380.55475094139854;6199.07013947908;6278.843028924279;6339.651319177444;6384;6440;6317.74729010839;6321.546044409789;6393.104965304861;6413.294537600872;6418.903716444257;4838.854834354975;4863.294822250771;4877.365942427479;4877.3903262092235;4883.8779030524165;4884.609231261508;4886.657933944625;4893.143699852511;4893.559579637832;4898.338724272213;4764.428268607772;4833.782479788418;4833.975830120845;4846.273059041137;4853.441854186761;4618.607418369443;4819.831305904277;4847.466778654345;4856.830010949618;4858.295547145662;4208.831646734127;4228.217779710763;4240.681948853818;4242.66058715302;4243.342281946272;6089.969550152221;6091.42131497507;6112.388761123896;6113.694315284218;6116.174316467309;5640.915386269209;5642.689652069134;5648.774049038034;5657.6322539035245;5669.376368599451;6717.865642687168;6720.563163394412;6722.0253063305545;6727.495437842182;6729.798106056826;4735.242361222222;4739.36018637483;4740.525947405266;4741.454732705714;4746.691465054795;6799.422049125781;7064.823379415556;7067.116610423697;7067.82330441743;7074.46941479386;4768.928466073012;4813.302071199656;4825.613950883921;4831.202851529459;4831.371921650163;4855.490173531799;4883.926741098886;4887.535684110004;4888.315635810989;4889.63327750413;5640.492355687926;5646.435356464321;5647.6329038613185;5649.152627105885;5659.405762394971;6642.435392991553;6848.1097457331225;6849.109615750021;6853.485988550879;6863.313668633196;1686.1400685650406;1690.661867626455;1695.3811858671495;1696.134971164715;1696.6182608912895;1083.2633809009792;1093.3986307530827;1109.1459576126338;1128.3850301585655;1146.4267866066966;6611.206655201407;6729.831754206184;6734.831629209211;6811.318868113248;6840.521163518506;7039.120109986252;7073.434125269966;7105.609191494414;7108.751193708195;7117.75087871922;6799.762008329685;6802.625855577891;6806.217285012287;6812;6818.454523638097;3784.848606055727;3786.772793632336;3807.638274363931;3818.8472461101246;3819.102510909934;7311.305425984523;7456;7515;7531.284527969834;7553.282438168365;7217.819554511179;7222.783316500513;7242.6378681065735;7248.130224373003;7253.202147763742;7415.036045314075;7425.85148297031;7443.702251909971;7462.141853686679;7467.215942326086;6982.1272340957385;7078.044463997295;7078.823029424306;7109.573425594481;7112.03987461686;6965.79102626922;6987;7003.054587630605;7003.649817509002;7006.894896576454;7492.662830172546;7495.662695178839;7511.737089201852;7525.473216874766;7527.360174385239;4769.2130798417875;4820.975895120642;4827.034593081468;4836.516348365276;4839.564439200489;6995.300469952964;7009.614471204132;7031.578105313698;7042.119735033121;7054.153501579844;6690.330966903271;6821.181458224846;6821.1814582250445;6833.692483838338;6862.382385585322;6773.525853190229;6796.456283497209;6816.113905192492;6829.760958366433;6836.213835408992;6700.865982680417;6727.932720672927;6729.226138994079;6730.192376914802;6731.427828634425;6744.089547911165;6879.58722476633;6905.067815844997;6910.93089069123;6910.965445172742;6645.501587380869;6758.7296508139125;6762.594244345355;6765.797026089225;6795.762148324982 13:16:33 INFO - PROCESS | 28614 | |5;yui.html;813.4427916876939;898.7393655839809;929.1648447748144;934.1779234273838;948.117985798191;14428.927855360722;14748.262586870667;14816.259187040645;14874.107553546768;14879.628009299786;12984.74030519389;14205.076670016442;14222.573322800306;14232.217228052454;14292;890.9732708018754;911.0616065452562;912.1562554636968;912.4525284829116;913.3925939250423;899.3884158772032;902.9097090290984;904.4482865452069;904.9547522623875;909.2589539525299;949.5204921514626;950.6387572722356;951.0632027452954;952.2572393533055;954.7326748510428;928.0441145620022;931.3852857114272;940.1820416237848;943.6744323208517;946.4605175050224;686.8591938652614;689.1385767790263;690.6788343420334;692.19705142035;694.5207806613421;14104.365303561364;14146.71706565863;14153.716925661533;14154.363053662508;14207.573772786833;14943.925280373638;15007.774883376758;15051.924740376338;15229.238538073163;15390.76913846282;12045.217060891015;12203.45084471201;12291.07816913735;12397.62807115788;12583.24500529962;4084.7549147050977;4088;4114.341705327163;4225.471816022997;4284.871453856358;53674.19488707672;54046.18930716042;54083.729581352236;54260;55294.44705552974;11211.38337391435;11636.592719254786;11661.067114630809;11702.590409335633;11765.235259708092;18991.62016759657;19041.904790476237;19073.61852762937;19088.809111908704;19113;7957.084935232407;7984.68061277554;7989.920100799034;8004.799880003046;8146.185381461806;4745.122152401747;4824.228123500223;4851.447536788194;4965.900681986413;5015.047141043263;3562.6437356264164;3589.3718599245026;3617.6744093031753;3620.0587847159927;3631.418972964313;644.6712176789871;649.023220053816;655.8849955076389;668.8829454845383;675.645286224736;706.6396137969673;765.4412279036335;775.5114278004934;853.2193043365376;878.6485405837589;10266.794664106676;10340.224483163793;10368.222383321281;10419.791604167875;10447.738806529745;674.2785219814751;715.9642017899084;749.8837680159584;767.3055884424605;839.546644811807;4545.840895568639;4668.229742092584;4740.312654665055;4741.35991641124;4835.758212089452;65261.347386526475;65969;66242.66878665576;66601;67031.3296867025;55311.723441382535;56160.719196403756;56319.71840140773;56587.71706141443;56678.43321566814;50234.49765502371;50580.241296380584;50703.74648126662;50764;50914.74542627263;8834.911650883667;9139.314551408805;9367.156955874005;9485.167884377326;9514.143727064597;37089;37335;37598.62401375951;37614.811925940194;38539.229215414976;43667.56332436635;45201.32198016967;46025.53974460346;49429.25856112233;50097;11473.426328683365;11675;12390.75218495607;12411.503539858666;13017.869821301665;13539.11995720275;13845.861541384456;13988.720225595227;14137.717245655234;14293.928530357281;12460.252384856938;12581.182223155465;13506.392212350664;13787.379567919266;13892.097013694078;13531.188128712309;13731.176129432266;13800.654983625489;13804.17174969505;13854.445822167001;10622.468876555986;12568.057395695176;12997.285149316878;13047.739045219232;13415.530456433979;11670.299782013106;11673.863246758892;11847.703807404883;11979.700507487383;12167.087468440079;10859.565617375216;11833.46749396262;12008.336922566665;12082.918855691742;12218.938905305416 13:16:33 INFO - PROCESS | 28614 | __end_tp_report 13:16:33 INFO - PROCESS | 28614 | __start_cc_report 13:16:33 INFO - PROCESS | 28614 | _x_x_mozilla_cycle_collect,324 13:16:33 INFO - PROCESS | 28614 | __end_cc_report 13:16:33 INFO - PROCESS | 28614 | __startTimestamp1468613793303__endTimestamp 13:16:33 INFO - PROCESS | 28614 | 13:16:33 INFO - PROCESS | 28614 | ------- Summary: start ------- 13:16:33 INFO - PROCESS | 28614 | Number of tests: 6 13:16:33 INFO - PROCESS | 28614 | 13:16:33 INFO - PROCESS | 28614 | [#0] dojo.html Cycles:165 Average:5466.19 Median:5674.06 stddev:604.71 (10.7%) stddev-sans-first:582.03 13:16:33 INFO - PROCESS | 28614 | Values: 3292.3 3373.0 3381.9 3415.5 3422.8 5312.6 5326.8 5328.3 5333.8 5361.9 5289.1 5314.4 5324.1 5341.8 5366.4 4850.1 4858.3 4887.9 4922.6 4947.1 4953.6 4974.5 4981.4 5005.7 5007.0 5064.9 5079.2 5123.7 5131.0 5135.3 4957.3 4964.2 4966.2 4968.9 4992.3 4900.6 4908.8 4913.2 4943.1 4991.3 5302.1 5306.4 5313.8 5315.9 5335.5 5783.5 5814.9 5817.2 5822.4 5835.9 5891.1 5979.6 6001.4 6018.8 6063.1 5496.4 5555.1 5564.4 5566.9 5579.2 5691.9 6018.3 6018.9 6021.8 6024.8 5819.7 5840.8 5886.7 5887.3 5888.7 5804.5 5809.7 5809.8 5811.9 5821.8 5706.0 5767.6 5772.7 5773.5 5823.2 5890.1 5908.1 5918.3 5919.2 5940.4 4565.4 4566.3 4568.6 4578.1 4600.2 4049.5 4062.4 4082.2 4094.7 4116.5 5557.0 5692.0 5743.1 5770.6 5775.2 5984.2 5989.7 5994.5 6004.7 6006.2 5607.5 5674.1 5778.3 5786.5 5791.8 5030.4 5095.3 5104.2 5109.2 5141.4 6192.9 6219.6 6260.5 6265.0 6270.9 5812.6 5924.3 5943.5 5960.0 5971.9 6166.3 6194.4 6199.5 6204.6 6214.2 5774.5 5786.3 5790.7 5797.5 5828.2 5798.4 5847.4 5894.6 5956.6 5964.6 5706.7 5710.9 5724.2 5726.3 5726.4 5652.8 5655.6 5657.5 5692.3 5716.8 5525.4 5625.5 5715.7 5720.2 5761.0 5583.6 5600.2 5630.0 5636.5 5668.9 5516.3 5529.2 5538.4 5569.1 5620.6 13:16:33 INFO - PROCESS | 28614 | 13:16:33 INFO - PROCESS | 28614 | [#1] ext.html Cycles:180 Average:58521.70 Median:42284.87 stddev:118401.71 (280.0%) stddev-sans-first:118654.15 13:16:33 INFO - PROCESS | 28614 | Values: 658.4 681.9 694.2 729.2 750.3 31921.5 38460.6 38668.8 39195.2 39254.2 42724.1 43208.8 43338.6 43375.6 43439.1 8658.9 8776.6 8828.7 8838.3 8840.7 8589.0 8679.8 8723.1 8761.9 8766.8 9044.9 9111.1 9118.2 9136.7 9142.7 8966.1 8998.4 9001.1 9045.1 9048.3 8875.6 8956.3 8971.6 8975.8 8979.0 42239.4 42728.0 42829.6 42832.4 42955.1 3840.6 3924.3 4170.5 4493.7 4664.4 32848.2 32875.0 33267.7 33580.8 34164.3 4268.1 4347.2 4351.1 4511.8 4606.4 271778.0 272003.0 274560.0 274749.0 275122.0 39397.4 61998.0 62432.7 62469.7 62514.4 37516.2 37744.4 37894.6 37926.2 37963.2 16682.9 16888.5 17065.0 17102.7 17116.3 13050.3 13080.3 13093.3 13115.3 13126.1 9331.2 9421.0 9456.9 9492.2 9533.5 3640.8 3706.3 3714.3 3717.2 3796.2 1144.5 1159.6 1210.5 1219.9 1237.3 33272.0 33501.2 33838.7 33953.3 34334.8 1218.6 1235.9 1246.4 1330.1 1367.7 17609.6 17678.9 17714.6 17744.7 17851.2 514682.0 522125.0 588219.0 591072.0 598906.0 58597.7 59697.0 60114.4 60130.7 60227.0 1579.8 1586.1 1594.8 1602.2 1659.4 30385.5 30633.4 30927.5 31283.5 31889.0 49106.3 49820.3 53650.5 54101.0 54110.2 442549.0 445933.0 448139.0 449687.0 450029.0 30736.0 30933.5 31199.1 31300.5 31339.2 49638.3 49984.8 50179.0 50198.0 51580.2 41433.6 41874.0 42273.4 42296.4 43426.3 41007.4 41177.6 41270.2 42578.8 43181.4 43048.4 43983.6 44222.0 44279.3 44444.0 35175.1 35282.8 36220.0 36770.0 36912.4 28920.6 29230.6 29369.6 29405.7 29494.0 13:16:33 INFO - PROCESS | 28614 | 13:16:33 INFO - PROCESS | 28614 | [#2] jquery.html Cycles:180 Average:31294.31 Median:2558.29 stddev:84597.37 (3306.8%) stddev-sans-first:84802.95 13:16:33 INFO - PROCESS | 28614 | Values: 431.6 433.1 440.2 446.6 451.9 18164.5 18651.0 18948.0 19399.5 19955.6 19625.7 19703.0 20296.5 20328.3 20478.6 5493.5 5687.5 5767.3 5782.2 5857.0 5721.6 5746.3 5749.9 5767.8 5783.3 5947.4 5959.1 5964.7 5978.6 5993.3 5759.0 5857.7 5918.6 5920.9 5926.4 5773.0 5775.0 5779.0 5800.1 5801.0 14344.6 14503.0 25183.0 25910.7 26064.9 2469.8 2475.4 2536.1 2580.5 2947.9 15905.3 16332.4 16529.0 16534.8 17193.0 2237.4 2338.8 2350.0 2353.7 2356.7 76188.0 76423.6 79533.6 87906.6 94431.0 18293.8 18902.0 19090.6 19091.8 19388.2 35465.8 35469.8 35799.8 35801.8 35897.8 10439.9 10608.2 10626.8 10640.9 10995.5 9156.0 9276.8 9290.0 9332.7 9379.6 9479.4 9579.1 9699.7 9843.2 9930.7 3681.3 3833.0 3839.0 3884.8 4016.9 1079.3 1115.2 1136.4 1137.1 1148.0 16956.0 19506.5 19634.3 19951.7 20220.5 1104.5 1106.6 1139.9 1141.3 1161.7 10859.3 11083.1 11226.3 11235.5 11273.7 499473.0 502556.0 517401.0 524235.0 526731.0 91810.0 97057.0 97480.5 97542.0 99210.0 1108.4 1124.3 1125.1 1128.9 1146.7 17111.7 17199.5 17238.0 17337.8 17450.9 38615.0 39604.8 41109.8 41187.6 42465.4 60010.1 61132.4 61548.1 61781.7 62147.0 8674.7 8689.2 8730.4 8757.0 8953.7 12535.2 13998.2 14016.3 14027.6 14194.0 11510.9 11978.6 12176.8 12364.4 12652.8 11264.2 11541.1 11630.5 11769.6 11964.1 11743.2 11749.2 11921.0 12548.2 12880.5 9313.5 9411.2 9434.6 9474.4 9532.3 11816.5 12816.1 12968.2 12984.5 13037.9 13:16:33 INFO - PROCESS | 28614 | 13:16:33 INFO - PROCESS | 28614 | [#3] mootools.html Cycles:180 Average:5789.48 Median:5128.00 stddev:3163.29 (61.7%) stddev-sans-first:3155.88 13:16:33 INFO - PROCESS | 28614 | Values: 1519.1 1546.7 1782.7 1930.7 1945.9 7777.9 8542.3 8544.0 8733.7 8748.0 8555.4 8649.6 8734.3 8780.7 8785.9 2457.4 2476.1 2498.5 2504.7 2505.1 2428.6 2461.7 2462.6 2462.6 2463.1 2388.0 2403.9 2413.1 2421.7 2422.9 2383.8 2442.4 2446.8 2462.9 2467.0 2485.7 2488.9 2506.3 2515.7 2519.8 8886.4 8891.7 8908.5 8930.9 8966.4 5486.3 5584.2 5593.1 5613.3 5617.2 3438.7 3492.7 3546.9 3583.1 3584.3 1208.7 1316.2 1318.2 1337.4 1357.8 11981.6 12022.5 12065.6 12098.2 12129.9 4504.8 4597.6 4645.9 4713.5 4746.9 9733.8 9771.4 9788.8 9799.4 9812.6 5276.6 5297.0 5311.8 5318.7 5324.2 4898.3 4935.8 5063.2 5066.3 5111.2 4070.0 4087.3 4101.2 4129.7 4132.8 1311.3 1315.4 1336.7 1338.6 1346.6 901.9 945.6 984.5 1062.4 1074.4 5880.9 5904.4 5952.5 5994.8 6111.5 975.6 1000.4 1047.9 1060.9 1060.9 4090.0 4161.9 4187.9 4247.7 4300.4 10694.9 10992.1 11137.6 11164.6 11181.4 10835.8 10867.6 10936.1 10989.3 11010.3 8319.9 8399.4 8509.7 8527.1 8539.0 5826.2 5832.3 5852.2 5900.2 5996.7 9394.7 9404.2 9586.0 9646.0 9798.1 9441.7 9502.3 9587.8 9650.7 9713.9 6975.9 7477.4 7510.8 7603.5 7801.6 8350.2 8354.1 8387.3 8397.8 8412.1 7459.6 7475.5 7485.0 7557.6 7690.8 7258.4 7270.3 7303.5 7353.4 7379.3 7015.4 7021.6 7036.2 7050.9 7064.8 5016.5 5113.1 5121.4 5168.8 5212.5 5105.9 5110.9 5134.6 5134.8 5197.8 13:16:33 INFO - PROCESS | 28614 | 13:16:33 INFO - PROCESS | 28614 | [#4] prototype.html Cycles:180 Average:5718.43 Median:6626.82 stddev:1750.94 (26.4%) stddev-sans-first:1709.15 13:16:33 INFO - PROCESS | 28614 | Values: 366.6 367.9 371.4 372.5 380.6 6199.1 6278.8 6339.7 6384.0 6440.0 6317.7 6321.5 6393.1 6413.3 6418.9 4838.9 4863.3 4877.4 4877.4 4883.9 4884.6 4886.7 4893.1 4893.6 4898.3 4764.4 4833.8 4834.0 4846.3 4853.4 4618.6 4819.8 4847.5 4856.8 4858.3 4208.8 4228.2 4240.7 4242.7 4243.3 6090.0 6091.4 6112.4 6113.7 6116.2 5640.9 5642.7 5648.8 5657.6 5669.4 6717.9 6720.6 6722.0 6727.5 6729.8 4735.2 4739.4 4740.5 4741.5 4746.7 6799.4 7064.8 7067.1 7067.8 7074.5 4768.9 4813.3 4825.6 4831.2 4831.4 4855.5 4883.9 4887.5 4888.3 4889.6 5640.5 5646.4 5647.6 5649.2 5659.4 6642.4 6848.1 6849.1 6853.5 6863.3 1686.1 1690.7 1695.4 1696.1 1696.6 1083.3 1093.4 1109.1 1128.4 1146.4 6611.2 6729.8 6734.8 6811.3 6840.5 7039.1 7073.4 7105.6 7108.8 7117.8 6799.8 6802.6 6806.2 6812.0 6818.5 3784.8 3786.8 3807.6 3818.8 3819.1 7311.3 7456.0 7515.0 7531.3 7553.3 7217.8 7222.8 7242.6 7248.1 7253.2 7415.0 7425.9 7443.7 7462.1 7467.2 6982.1 7078.0 7078.8 7109.6 7112.0 6965.8 6987.0 7003.1 7003.6 7006.9 7492.7 7495.7 7511.7 7525.5 7527.4 4769.2 4821.0 4827.0 4836.5 4839.6 6995.3 7009.6 7031.6 7042.1 7054.2 6690.3 6821.2 6821.2 6833.7 6862.4 6773.5 6796.5 6816.1 6829.8 6836.2 6700.9 6727.9 6729.2 6730.2 6731.4 6744.1 6879.6 6905.1 6910.9 6911.0 6645.5 6758.7 6762.6 6765.8 6795.8 13:16:33 INFO - PROCESS | 28614 | 13:16:33 INFO - PROCESS | 28614 | [#5] yui.html Cycles:180 Average:15407.99 Median:44434.44 stddev:17615.78 (39.6%) stddev-sans-first:17631.10 13:16:33 INFO - PROCESS | 28614 | Values: 813.4 898.7 929.2 934.2 948.1 14428.9 14748.3 14816.3 14874.1 14879.6 12984.7 14205.1 14222.6 14232.2 14292.0 891.0 911.1 912.2 912.5 913.4 899.4 902.9 904.4 905.0 909.3 949.5 950.6 951.1 952.3 954.7 928.0 931.4 940.2 943.7 946.5 686.9 689.1 690.7 692.2 694.5 14104.4 14146.7 14153.7 14154.4 14207.6 14943.9 15007.8 15051.9 15229.2 15390.8 12045.2 12203.5 12291.1 12397.6 12583.2 4084.8 4088.0 4114.3 4225.5 4284.9 53674.2 54046.2 54083.7 54260.0 55294.4 11211.4 11636.6 11661.1 11702.6 11765.2 18991.6 19041.9 19073.6 19088.8 19113.0 7957.1 7984.7 7989.9 8004.8 8146.2 4745.1 4824.2 4851.4 4965.9 5015.0 3562.6 3589.4 3617.7 3620.1 3631.4 644.7 649.0 655.9 668.9 675.6 706.6 765.4 775.5 853.2 878.6 10266.8 10340.2 10368.2 10419.8 10447.7 674.3 716.0 749.9 767.3 839.5 4545.8 4668.2 4740.3 4741.4 4835.8 65261.3 65969.0 66242.7 66601.0 67031.3 55311.7 56160.7 56319.7 56587.7 56678.4 50234.5 50580.2 50703.7 50764.0 50914.7 8834.9 9139.3 9367.2 9485.2 9514.1 37089.0 37335.0 37598.6 37614.8 38539.2 43667.6 45201.3 46025.5 49429.3 50097.0 11473.4 11675.0 12390.8 12411.5 13017.9 13539.1 13845.9 13988.7 14137.7 14293.9 12460.3 12581.2 13506.4 13787.4 13892.1 13531.2 13731.2 13800.7 13804.2 13854.4 10622.5 12568.1 12997.3 13047.7 13415.5 11670.3 11673.9 11847.7 11979.7 12167.1 10859.6 11833.5 12008.3 12082.9 12218.9 13:16:33 INFO - PROCESS | 28614 | -------- Summary: end -------- 13:16:33 INFO - PROCESS | 28614 | 13:16:34 INFO - TEST-INFO | 28614: exit 0 13:16:34 INFO - TEST-OK | dromaeo_css | took 1108186ms 13:16:34 INFO - TEST-START | kraken 13:16:34 INFO - operating with platform_type : linux_ 13:16:34 INFO - Initialising browser for kraken test... 13:16:34 INFO - TEST-INFO | started process 28855 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3XCewm/profile http://localhost:32935/getInfo.html) 13:16:37 INFO - PROCESS | 28855 | 13:16:37 INFO - PROCESS | 28855 | (process:28932): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:16:38 INFO - PROCESS | 28855 | __metrics Screen width/height:1600/1200 13:16:38 INFO - PROCESS | 28855 | colorDepth:24 13:16:38 INFO - PROCESS | 28855 | Browser inner width/height: 1024/697 13:16:38 INFO - PROCESS | 28855 | __metrics 13:16:38 ERROR - PROCESS | 28855 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 13:16:39 INFO - TEST-INFO | 28855: exit 0 13:16:39 INFO - Browser initialized. 13:16:39 INFO - Running cycle 1/1 for kraken test... 13:16:39 INFO - TEST-INFO | started process 28982 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3XCewm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:16:41 INFO - PROCESS | 28982 | 13:16:41 INFO - PROCESS | 28982 | (process:29052): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:16:51 INFO - PROCESS | 28982 | RSS: Main: 151117824 13:16:51 INFO - PROCESS | 28982 | 13:16:54 INFO - PROCESS | 28982 | Cycle 1(1): loaded http://localhost:32935/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32935/tests/kraken/driver.html?testName=audio-beat-detection) 13:16:54 INFO - PROCESS | 28982 | RSS: Main: 156356608 13:16:54 INFO - PROCESS | 28982 | 13:16:57 INFO - PROCESS | 28982 | Cycle 1(1): loaded http://localhost:32935/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32935/tests/kraken/driver.html?testName=audio-dft) 13:16:58 INFO - PROCESS | 28982 | RSS: Main: 155893760 13:16:58 INFO - PROCESS | 28982 | 13:17:00 INFO - PROCESS | 28982 | Cycle 1(1): loaded http://localhost:32935/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32935/tests/kraken/driver.html?testName=audio-fft) 13:17:01 INFO - PROCESS | 28982 | RSS: Main: 156360704 13:17:01 INFO - PROCESS | 28982 | 13:17:03 INFO - PROCESS | 28982 | Cycle 1(1): loaded http://localhost:32935/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32935/tests/kraken/driver.html?testName=audio-oscillator) 13:17:04 INFO - PROCESS | 28982 | RSS: Main: 156745728 13:17:04 INFO - PROCESS | 28982 | 13:17:06 INFO - PROCESS | 28982 | Cycle 1(1): loaded http://localhost:32935/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32935/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:17:07 INFO - PROCESS | 28982 | RSS: Main: 156000256 13:17:07 INFO - PROCESS | 28982 | 13:17:10 INFO - PROCESS | 28982 | Cycle 1(1): loaded http://localhost:32935/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32935/tests/kraken/driver.html?testName=imaging-darkroom) 13:17:10 INFO - PROCESS | 28982 | RSS: Main: 156311552 13:17:10 INFO - PROCESS | 28982 | 13:17:14 INFO - PROCESS | 28982 | Cycle 1(1): loaded http://localhost:32935/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32935/tests/kraken/driver.html?testName=imaging-desaturate) 13:17:14 INFO - PROCESS | 28982 | RSS: Main: 156753920 13:17:14 INFO - PROCESS | 28982 | 13:17:17 INFO - PROCESS | 28982 | Cycle 1(1): loaded http://localhost:32935/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32935/tests/kraken/driver.html?testName=json-parse-financial) 13:17:18 INFO - PROCESS | 28982 | RSS: Main: 156680192 13:17:18 INFO - PROCESS | 28982 | 13:17:19 INFO - PROCESS | 28982 | Cycle 1(1): loaded http://localhost:32935/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32935/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:17:20 INFO - PROCESS | 28982 | RSS: Main: 155852800 13:17:20 INFO - PROCESS | 28982 | 13:17:21 INFO - PROCESS | 28982 | Cycle 1(1): loaded http://localhost:32935/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32935/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:17:22 INFO - PROCESS | 28982 | RSS: Main: 155967488 13:17:22 INFO - PROCESS | 28982 | 13:17:24 INFO - PROCESS | 28982 | Cycle 1(1): loaded http://localhost:32935/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32935/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:17:25 INFO - PROCESS | 28982 | RSS: Main: 156631040 13:17:25 INFO - PROCESS | 28982 | 13:17:27 INFO - PROCESS | 28982 | Cycle 1(1): loaded http://localhost:32935/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32935/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:17:28 INFO - PROCESS | 28982 | RSS: Main: 156930048 13:17:28 INFO - PROCESS | 28982 | 13:17:30 INFO - PROCESS | 28982 | Cycle 1(1): loaded http://localhost:32935/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32935/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:17:31 INFO - PROCESS | 28982 | RSS: Main: 156979200 13:17:31 INFO - PROCESS | 28982 | 13:17:33 INFO - PROCESS | 28982 | Cycle 1(1): loaded http://localhost:32935/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32935/tests/kraken/driver.html?testName=ai-astar) 13:17:33 INFO - PROCESS | 28982 | RSS: Main: 158109696 13:17:33 INFO - PROCESS | 28982 | 13:17:33 INFO - PROCESS | 28982 | __start_tp_report 13:17:33 INFO - PROCESS | 28982 | _x_x_mozilla_page_load 13:17:33 INFO - PROCESS | 28982 | _x_x_mozilla_page_load_details 13:17:33 INFO - PROCESS | 28982 | |i|pagename|runs| 13:17:33 INFO - PROCESS | 28982 | |0;ai-astar;108;114;105;110;112;113;102;110;110;111 13:17:33 INFO - PROCESS | 28982 | |1;audio-beat-detection;156;127;161;180;129;152;156;129;187;128 13:17:33 INFO - PROCESS | 28982 | |2;audio-dft;162;162;161;162;162;162;164;161;164;163 13:17:33 INFO - PROCESS | 28982 | |3;audio-fft;74;76;76;185;75;77;74;78;161;72 13:17:33 INFO - PROCESS | 28982 | |4;audio-oscillator;92;92;149;92;94;93;153;93;93;142 13:17:33 INFO - PROCESS | 28982 | |5;imaging-gaussian-blur;118;118;117;117;117;118;118;117;117;118 13:17:33 INFO - PROCESS | 28982 | |6;imaging-darkroom;147;147;146;146;146;146;147;146;146;146 13:17:33 INFO - PROCESS | 28982 | |7;imaging-desaturate;95;95;95;96;95;95;95;95;96;97 13:17:33 INFO - PROCESS | 28982 | |8;json-parse-financial;53;54;57;54;58;55;56;70;53;52 13:17:33 INFO - PROCESS | 28982 | |9;json-stringify-tinderbox;58;57;57;58;58;57;57;58;57;58 13:17:33 INFO - PROCESS | 28982 | |10;stanford-crypto-aes;73;73;73;72;73;73;73;73;75;73 13:17:33 INFO - PROCESS | 28982 | |11;stanford-crypto-ccm;115;114;120;119;116;118;117;118;133;128 13:17:33 INFO - PROCESS | 28982 | |12;stanford-crypto-pbkdf2;163;160;160;160;157;159;160;158;162;159 13:17:33 INFO - PROCESS | 28982 | |13;stanford-crypto-sha256-iterative;66;66;67;69;66;70;71;66;66;68 13:17:33 INFO - PROCESS | 28982 | __end_tp_report 13:17:33 INFO - PROCESS | 28982 | __start_cc_report 13:17:33 INFO - PROCESS | 28982 | _x_x_mozilla_cycle_collect,817 13:17:33 INFO - PROCESS | 28982 | __end_cc_report 13:17:33 INFO - PROCESS | 28982 | __startTimestamp1468613853375__endTimestamp 13:17:33 INFO - PROCESS | 28982 | 13:17:33 INFO - PROCESS | 28982 | ------- Summary: start ------- 13:17:33 INFO - PROCESS | 28982 | Number of tests: 14 13:17:33 INFO - PROCESS | 28982 | 13:17:33 INFO - PROCESS | 28982 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.50 stddev:3.66 (3.3%) stddev-sans-first:3.84 13:17:33 INFO - PROCESS | 28982 | Values: 108.0 114.0 105.0 110.0 112.0 113.0 102.0 110.0 110.0 111.0 13:17:33 INFO - PROCESS | 28982 | 13:17:33 INFO - PROCESS | 28982 | [#1] audio-beat-detection Cycles:10 Average:150.50 Median:156.00 stddev:22.01 (14.1%) stddev-sans-first:23.25 13:17:33 INFO - PROCESS | 28982 | Values: 156.0 127.0 161.0 180.0 129.0 152.0 156.0 129.0 187.0 128.0 13:17:33 INFO - PROCESS | 28982 | 13:17:33 INFO - PROCESS | 28982 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 13:17:33 INFO - PROCESS | 28982 | Values: 162.0 162.0 161.0 162.0 162.0 162.0 164.0 161.0 164.0 163.0 13:17:33 INFO - PROCESS | 28982 | 13:17:33 INFO - PROCESS | 28982 | [#3] audio-fft Cycles:10 Average:94.80 Median:75.50 stddev:41.64 (55.1%) stddev-sans-first:43.48 13:17:33 INFO - PROCESS | 28982 | Values: 74.0 76.0 76.0 185.0 75.0 77.0 74.0 78.0 161.0 72.0 13:17:33 INFO - PROCESS | 28982 | 13:17:33 INFO - PROCESS | 28982 | [#4] audio-oscillator Cycles:10 Average:109.30 Median:92.50 stddev:26.84 (29.0%) stddev-sans-first:27.73 13:17:33 INFO - PROCESS | 28982 | Values: 92.0 92.0 149.0 92.0 94.0 93.0 153.0 93.0 93.0 142.0 13:17:33 INFO - PROCESS | 28982 | 13:17:33 INFO - PROCESS | 28982 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 13:17:33 INFO - PROCESS | 28982 | Values: 118.0 118.0 117.0 117.0 117.0 118.0 118.0 117.0 117.0 118.0 13:17:33 INFO - PROCESS | 28982 | 13:17:33 INFO - PROCESS | 28982 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 13:17:33 INFO - PROCESS | 28982 | Values: 147.0 147.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 13:17:33 INFO - PROCESS | 28982 | 13:17:33 INFO - PROCESS | 28982 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 13:17:33 INFO - PROCESS | 28982 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 97.0 13:17:33 INFO - PROCESS | 28982 | 13:17:33 INFO - PROCESS | 28982 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:55.50 stddev:5.20 (9.4%) stddev-sans-first:5.39 13:17:33 INFO - PROCESS | 28982 | Values: 53.0 54.0 57.0 54.0 58.0 55.0 56.0 70.0 53.0 52.0 13:17:33 INFO - PROCESS | 28982 | 13:17:33 INFO - PROCESS | 28982 | [#9] json-stringify-tinderbox Cycles:10 Average:57.50 Median:58.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 13:17:33 INFO - PROCESS | 28982 | Values: 58.0 57.0 57.0 58.0 58.0 57.0 57.0 58.0 57.0 58.0 13:17:33 INFO - PROCESS | 28982 | 13:17:33 INFO - PROCESS | 28982 | [#10] stanford-crypto-aes Cycles:10 Average:73.10 Median:73.00 stddev:0.74 (1.0%) stddev-sans-first:0.78 13:17:33 INFO - PROCESS | 28982 | Values: 73.0 73.0 73.0 72.0 73.0 73.0 73.0 73.0 75.0 73.0 13:17:33 INFO - PROCESS | 28982 | 13:17:33 INFO - PROCESS | 28982 | [#11] stanford-crypto-ccm Cycles:10 Average:119.80 Median:118.50 stddev:6.03 (5.1%) stddev-sans-first:6.14 13:17:33 INFO - PROCESS | 28982 | Values: 115.0 114.0 120.0 119.0 116.0 118.0 117.0 118.0 133.0 128.0 13:17:33 INFO - PROCESS | 28982 | 13:17:33 INFO - PROCESS | 28982 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.80 Median:160.00 stddev:1.75 (1.1%) stddev-sans-first:1.42 13:17:33 INFO - PROCESS | 28982 | Values: 163.0 160.0 160.0 160.0 157.0 159.0 160.0 158.0 162.0 159.0 13:17:33 INFO - PROCESS | 28982 | 13:17:33 INFO - PROCESS | 28982 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.50 stddev:1.90 (2.8%) stddev-sans-first:1.94 13:17:33 INFO - PROCESS | 28982 | Values: 66.0 66.0 67.0 69.0 66.0 70.0 71.0 66.0 66.0 68.0 13:17:33 INFO - PROCESS | 28982 | -------- Summary: end -------- 13:17:33 INFO - PROCESS | 28982 | 13:17:34 INFO - TEST-INFO | 28982: exit 0 13:17:34 INFO - TEST-OK | kraken | took 60263ms 13:17:34 INFO - SUITE-END | took 1168s 13:17:34 INFO - Completed test suite (00:19:28) 13:17:34 INFO - javascript benchmark 13:17:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3292.341531693661, 3373.021823671135, 3381.8816341428055, 3415.4706020566805, 3422.82885855707, 5312.601554883389, 5326.813561525348, 5328.307320048389, 5333.839984800457, 5361.91957120643, 5289.127293996486, 5314.441983591715, 5324.094903866342, 5341.839744807662, 5366.356037275523, 4850.054239423313, 4858.34412354332, 4887.8778030549165, 4922.630802689795, 4947.084789313971, 4953.554180123788, 4974.477679843619, 4981.37732783402, 5005.674631148963, 5006.97496512517, 5064.898702025957, 5079.161938280198, 5123.743812809364, 5131.025105229995, 5135.332406787131, 4957.3059771632, 4964.156093464084, 4966.180580204262, 4968.875778105558, 4992.32603598515, 4900.607951363882, 4908.828191013297, 4913.213885778294, 4943.060818444484, 4991.276264941564, 5302.125149350352, 5306.363236411656, 5313.814016509404, 5315.920261196085, 5335.5464785492895, 5783.537317014629, 5814.941850581482, 5817.243758311435, 5822.417758224186, 5835.883282334372, 5891.05743081105, 5979.581429299951, 6001.4298641628975, 6018.759249630009, 6063.060225665029, 5496.422875598045, 5555.083411237181, 5564.360098588673, 5566.916496252559, 5579.163125531162, 5691.943080569141, 6018.277806663141, 6018.939810601925, 6021.789237376671, 6024.789132380433, 5819.73811178498, 5840.766369345263, 5886.705664716747, 5887.264091988502, 5888.676122813201, 5804.535637149018, 5809.651420914759, 5809.767609295581, 5811.854703632358, 5821.79623713168, 5705.971470142623, 5767.596268261265, 5772.6536407815665, 5773.480386765127, 5823.155642431909, 5890.057590785454, 5908.054711246266, 5918.2898052234, 5919.200907877467, 5940.376260492672, 4565.429321334833, 4566.337881007302, 4568.634509239253, 4578.107269082497, 4600.171969045537, 4049.4735684360844, 4062.431259623655, 4082.1631565528996, 4094.6928980325997, 4116.547179810218, 5556.972215138899, 5692.0, 5743.052396354555, 5770.567207459458, 5775.191473193756, 5984.222051133324, 5989.700514974234, 5994.520438364921, 6004.6697431640805, 6006.249218847644, 5607.523360514402, 5674.0637794764225, 5778.27771528559, 5786.508146807484, 5791.768329266866, 5030.3963524377305, 5095.337606111182, 5104.183330667075, 5109.20807274873, 5141.434442211354, 6192.907106393408, 6219.564630475914, 6260.530460215411, 6264.968675156595, 6270.9372906271265, 5812.622179558315, 5924.259467566554, 5943.465088142088, 5960.046392577254, 5971.940280597225, 6166.321704612579, 6194.442500175006, 6199.504039676905, 6204.627722336674, 6214.1921550198185, 5774.48029677331, 5786.3056433228285, 5790.652560846363, 5797.507211887037, 5828.184054232495, 5798.449147330997, 5847.356790753099, 5894.646321220741, 5956.612820166675, 5964.642121472725, 5706.714664266853, 5710.885782284414, 5724.227229323988, 5726.312842458931, 5726.398728133652, 5652.7738890443925, 5655.632383895034, 5657.547396208376, 5692.31692196939, 5716.828495145152, 5525.419830917695, 5625.549956003591, 5715.742791574472, 5720.170575266647, 5761.020626493422, 5583.609147359646, 5600.159976003632, 5630.0, 5636.464535869086, 5668.943310566841, 5516.3380394352935, 5529.225908372911, 5538.390777014606, 5569.053260945568, 5620.606557540933], "value": 5427.834265368549, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [658.4205898809047, 681.9283975182609, 694.1531331775234, 729.165105953683, 750.2984709296807, 31921.52117718236, 38460.615393846056, 38668.80665596671, 39195.21609567807, 39254.21491570167, 42724.14551708964, 43208.78395608025, 43338.566614333846, 43375.56624433755, 43439.13121737563, 8658.87011694825, 8776.56117194141, 8828.690995815148, 8838.29293656506, 8840.734777956639, 8589.0, 8679.783005424852, 8723.127687231257, 8761.868571971425, 8766.824663506726, 9044.909550904473, 9111.088891110869, 9118.17936385725, 9136.680216192435, 9142.680006199784, 8966.148215919477, 8998.415103018348, 9001.099890010979, 9045.14071163245, 9048.321375896801, 8875.600597973107, 8956.283497320199, 8971.551422428853, 8975.820483590292, 8979.0, 42239.366409503884, 42728.0, 42829.57170428287, 42832.357514637304, 42955.140897182195, 3840.558335791364, 3924.2936271471126, 4170.4995400551825, 4493.707908985938, 4664.39475467334, 32848.1787955303, 32875.0, 33267.6673233267, 33580.83209583937, 34164.31671366584, 4268.146370725836, 4347.217500849846, 4351.0862718829085, 4511.796969136397, 4606.401167848192, 271778.0, 272003.0, 274560.0, 274749.0, 275122.0, 39397.40903886444, 61998.0, 62432.68783656053, 62469.68765156145, 62514.374856250855, 37516.24967500689, 37744.43383349252, 37894.62105378966, 37926.24147517034, 37963.24073518514, 16682.916585416995, 16888.493345199662, 17065.0, 17102.657946841242, 17116.315347385964, 13050.347482625832, 13080.28058456775, 13093.279869607262, 13115.278659673619, 13126.14680045794, 9331.20684741791, 9421.0, 9456.905430945602, 9492.240620750323, 9533.523323833919, 3640.8361623726996, 3706.314331848617, 3714.33142034431, 3717.219383929351, 3796.2217745362136, 1144.4792619358172, 1159.605734050427, 1210.5218438716659, 1219.8597161326384, 1237.3256575166556, 33272.0, 33501.16247093842, 33838.66161338404, 33953.32093358119, 34334.82832585821, 1218.6465924881861, 1235.9443825027715, 1246.4079562207878, 1330.0755974597562, 1367.6717587778862, 17609.647807043788, 17678.911605442147, 17714.5571360717, 17744.733828992576, 17851.196696148705, 514682.0, 522125.0, 588219.0, 591072.0, 598906.0, 58597.70701146467, 59697.0, 60114.39885601176, 60130.69934650299, 60227.0, 1579.842015798411, 1586.1038513239982, 1594.8165960914412, 1602.1908935987485, 1659.3694396129636, 30385.544216837206, 30633.387332253675, 30927.536086958262, 31283.530747038356, 31889.0, 49106.26340604965, 49820.25269620886, 53650.46349536454, 54101.0, 54110.18834717561, 442549.0, 445933.0, 448139.0, 449687.0, 450029.0, 30736.0, 30933.535996959614, 31199.064028079192, 31300.530492043094, 31339.216519587193, 49638.25542616936, 49984.75007624939, 50179.0, 50198.0, 51580.22629660633, 41433.58566414297, 41874.0, 42273.365899510914, 42296.365554516095, 43426.34860477032, 41007.38488922609, 41177.588224117375, 41270.1745965073, 42578.78710606427, 43181.3522797152, 43048.354274685276, 43983.560164397946, 44222.0, 44279.335809962235, 44444.0, 35175.12062198466, 35282.794205198836, 36219.980048736084, 36770.0, 36912.44631330586, 28920.566191507565, 29230.561541577317, 29369.55945660774, 29405.705942941153, 29494.0], "value": 19652.333790007597, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [431.5770544866031, 433.1034758050835, 440.1680823244071, 446.6069858524498, 451.93221016847446, 18164.455066347997, 18651.0, 18948.0, 19399.515012124702, 19955.600887982233, 19625.705614415794, 19703.0, 20296.492587685316, 20328.288509902155, 20478.590428191463, 5493.450654934494, 5687.544996400299, 5767.279090113736, 5782.190493330937, 5857.0, 5721.628094173865, 5746.25298711169, 5749.856253593652, 5767.798127065554, 5783.277090363705, 5947.434993675594, 5959.0763431668165, 5964.7315870785915, 5978.611390259641, 5993.310769261525, 5759.049756790125, 5857.6778277194735, 5918.644881307114, 5920.911186332187, 5926.4073592640825, 5773.047447171211, 5775.0, 5779.046457334534, 5800.071988481823, 5801.0428279333855, 14344.56966291013, 14502.98479106463, 25183.0, 25910.74089259102, 26064.869675651502, 2469.790067844235, 2475.443025319307, 2536.087008676875, 2580.4839032193636, 2947.8673459694364, 15905.284262208228, 16332.428365007168, 16529.0, 16534.751978720327, 17193.0, 2237.3511681612313, 2338.8362814602983, 2350.048230466664, 2353.658719485682, 2356.658284548748, 76188.0, 76423.61788191079, 79533.60233198798, 87906.5604671979, 94431.0, 18293.81706182948, 18902.0, 19090.61818763617, 19091.809081909003, 19388.224471021284, 35465.82267088648, 35469.82265088658, 35799.82100089535, 35801.82099089488, 35897.820510897276, 10439.895601044043, 10608.20438467118, 10626.840597391045, 10640.946795266129, 10995.505202265756, 9155.954220228989, 9276.814463710689, 9290.0, 9332.72001839946, 9379.577918993662, 9479.383840050512, 9579.13787759105, 9699.66051188205, 9843.163331116935, 9930.702078937644, 3681.337359275303, 3832.9616703832603, 3838.9808050960123, 3884.8446062157764, 4016.859409920697, 1079.2768844873954, 1115.2249186815086, 1136.363636363639, 1137.1073707139856, 1147.9655610331704, 16956.0, 19506.5123371914, 19634.312799051964, 19951.700724489143, 20220.494487637927, 1104.469854469859, 1106.5739690219323, 1139.8575178102737, 1141.3380239461092, 1161.73280145567, 10859.34843909368, 11083.113350931906, 11226.270292430965, 11235.494402751732, 11273.718157045976, 499473.01053979446, 502556.0, 517401.0, 524235.0, 526731.0, 91810.0, 97057.0, 97480.51259743657, 97542.0, 99210.0, 1108.41808050774, 1124.2804605052772, 1125.0886781706843, 1128.9435528223555, 1146.696125526736, 17111.7433238504, 17199.484015479557, 17238.0, 17337.82662173362, 17450.91274543619, 38615.0, 39604.80197598993, 41109.794451027556, 41187.588124118374, 42465.36301955411, 60010.099848501435, 61132.388676114446, 61548.07677884925, 61781.69109154426, 62147.0, 8674.696385626472, 8689.217970382695, 8730.388872779098, 8756.956215219137, 8953.731388058368, 12535.185212961129, 13998.160110393408, 14016.29918504091, 14027.649308767363, 14194.0, 11510.884891150981, 11978.64064078079, 12176.817347739969, 12364.4436000382, 12652.810207847073, 11264.15518836107, 11541.076713863038, 11630.476628551905, 11769.588064417705, 11964.102692297938, 11743.236689615147, 11749.236299640495, 11921.046316294849, 12548.18436801605, 12880.484780608671, 9313.487758173365, 9411.152996230097, 9434.575444105169, 9474.38416502925, 9532.285078618992, 11816.527338906692, 12816.102872799187, 12968.15706979081, 12984.545540906023, 13037.869621303666], "value": 10597.754019196505, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1519.1113198778714, 1546.6983938132062, 1782.6523827853573, 1930.749002629658, 1945.8735182213163, 7777.92222077779, 8542.273906717928, 8544.0, 8733.650653973842, 8748.0, 8555.443896146746, 8649.610767515462, 8734.344924130684, 8780.736577902657, 8785.912140878589, 2457.397937505309, 2476.0590975429313, 2498.475320182755, 2504.686914135733, 2505.073122944513, 2428.5992811186134, 2461.729209786922, 2462.581361168606, 2462.642916777066, 2463.0763463701114, 2387.988060059697, 2403.927882163538, 2413.1071503543712, 2421.6609674645565, 2422.8667423291713, 2383.797377222938, 2442.400227850752, 2446.804255659543, 2462.8645424501647, 2466.962995555059, 2485.6768620079456, 2488.855126641747, 2506.2982364937848, 2515.748425157488, 2519.8362106463023, 8886.422382545114, 8891.688790892353, 8908.51003194824, 8930.86603700945, 8966.372353935227, 5486.31421072366, 5584.162375643646, 5593.133064375028, 5613.326400831927, 5617.157426386034, 3438.7420943429343, 3492.6856582907662, 3546.929061418783, 3583.050491619723, 3584.301061293049, 1208.7038675524466, 1316.1642357103212, 1318.162966516269, 1337.4182230729566, 1357.7963305504254, 11981.580644677395, 12022.458989345501, 12065.638030859089, 12098.213616114925, 12129.908308252212, 4504.774761261924, 4597.609203217697, 4645.907081858344, 4713.481517033124, 4746.905061898743, 9733.805323893483, 9771.413715177112, 9788.755281118029, 9799.412035277906, 9812.558434870449, 5276.551493123051, 5297.0, 5311.840644780663, 5318.65428747138, 5324.201369794562, 4898.2652602109965, 4935.8025678972435, 5063.1645778446145, 5066.290719299301, 5111.207762796773, 4070.004469833545, 4087.305158123126, 4101.179764047202, 4129.690273229459, 4132.8140233689555, 1311.2984553264148, 1315.421214665544, 1336.6658335416146, 1338.5850386380253, 1346.562367230654, 901.9278457723366, 945.645382981382, 984.4585477987079, 1062.4103622489592, 1074.4198133008244, 5880.941190588125, 5904.439078287556, 5952.494038006818, 5994.760209591567, 6111.54163437744, 975.6390135649855, 1000.4397537379091, 1047.8899715529913, 1060.8620879285643, 1060.931039482431, 4090.0, 4161.875143745692, 4187.853425130106, 4247.660187185018, 4300.419443375167, 10694.946525267324, 10992.065674417765, 11137.554497820158, 11164.609238676607, 11181.440927953732, 10835.83746243807, 10867.565297388015, 10936.070434013198, 10989.285696429706, 11010.284331518425, 8319.916800831914, 8399.412041157182, 8509.702160424355, 8527.062023177445, 8538.957305213435, 5826.242588463472, 5832.300123985149, 5852.18069470266, 5900.173975643327, 5996.67018313997, 9394.67118650844, 9404.153626173676, 9586.0, 9646.0, 9798.069183427562, 9441.669541566287, 9502.334836561375, 9587.760305992406, 9650.71047868565, 9713.882903465908, 6975.860482790417, 7477.364424024019, 7510.760724480618, 7603.505772124794, 7801.648925798466, 8350.164983501601, 8354.122817104117, 8387.287080598218, 8397.790055248668, 8412.116727743743, 7459.589722565311, 7475.514091584029, 7485.026946496921, 7557.584332861746, 7690.769276921701, 7258.383037441666, 7270.309320614533, 7303.488755787256, 7353.411727061715, 7379.262073792578, 7015.438764898898, 7021.5787052777, 7036.155661320469, 7050.894236586353, 7064.823379415556, 5016.523430274118, 5113.105206588758, 5121.436641969306, 5168.767405466688, 5212.530872221519, 5105.872353191051, 5110.872228194176, 5134.5635620972635, 5134.768935397841, 5197.766100525561], "value": 4725.559509278895, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.6187165348038, 367.9043448703338, 371.41131306878594, 372.45063531291333, 380.55475094139854, 6199.07013947908, 6278.843028924279, 6339.651319177444, 6384.0, 6440.0, 6317.74729010839, 6321.546044409789, 6393.104965304861, 6413.294537600872, 6418.903716444257, 4838.854834354975, 4863.294822250771, 4877.365942427479, 4877.3903262092235, 4883.8779030524165, 4884.609231261508, 4886.657933944625, 4893.143699852511, 4893.559579637832, 4898.338724272213, 4764.428268607772, 4833.782479788418, 4833.975830120845, 4846.273059041137, 4853.441854186761, 4618.607418369443, 4819.831305904277, 4847.466778654345, 4856.830010949618, 4858.295547145662, 4208.831646734127, 4228.217779710763, 4240.681948853818, 4242.66058715302, 4243.342281946272, 6089.969550152221, 6091.42131497507, 6112.388761123896, 6113.694315284218, 6116.174316467309, 5640.915386269209, 5642.689652069134, 5648.774049038034, 5657.6322539035245, 5669.376368599451, 6717.865642687168, 6720.563163394412, 6722.0253063305545, 6727.495437842182, 6729.798106056826, 4735.242361222222, 4739.36018637483, 4740.525947405266, 4741.454732705714, 4746.691465054795, 6799.422049125781, 7064.823379415556, 7067.116610423697, 7067.82330441743, 7074.46941479386, 4768.928466073012, 4813.302071199656, 4825.613950883921, 4831.202851529459, 4831.371921650163, 4855.490173531799, 4883.926741098886, 4887.535684110004, 4888.315635810989, 4889.63327750413, 5640.492355687926, 5646.435356464321, 5647.6329038613185, 5649.152627105885, 5659.405762394971, 6642.435392991553, 6848.1097457331225, 6849.109615750021, 6853.485988550879, 6863.313668633196, 1686.1400685650406, 1690.661867626455, 1695.3811858671495, 1696.134971164715, 1696.6182608912895, 1083.2633809009792, 1093.3986307530827, 1109.1459576126338, 1128.3850301585655, 1146.4267866066966, 6611.206655201407, 6729.831754206184, 6734.831629209211, 6811.318868113248, 6840.521163518506, 7039.120109986252, 7073.434125269966, 7105.609191494414, 7108.751193708195, 7117.75087871922, 6799.762008329685, 6802.625855577891, 6806.217285012287, 6812.0, 6818.454523638097, 3784.848606055727, 3786.772793632336, 3807.638274363931, 3818.8472461101246, 3819.102510909934, 7311.305425984523, 7456.0, 7515.0, 7531.284527969834, 7553.282438168365, 7217.819554511179, 7222.783316500513, 7242.6378681065735, 7248.130224373003, 7253.202147763742, 7415.036045314075, 7425.85148297031, 7443.702251909971, 7462.141853686679, 7467.215942326086, 6982.1272340957385, 7078.044463997295, 7078.823029424306, 7109.573425594481, 7112.03987461686, 6965.79102626922, 6987.0, 7003.054587630605, 7003.649817509002, 7006.894896576454, 7492.662830172546, 7495.662695178839, 7511.737089201852, 7525.473216874766, 7527.360174385239, 4769.2130798417875, 4820.975895120642, 4827.034593081468, 4836.516348365276, 4839.564439200489, 6995.300469952964, 7009.614471204132, 7031.578105313698, 7042.119735033121, 7054.153501579844, 6690.330966903271, 6821.181458224846, 6821.1814582250445, 6833.692483838338, 6862.382385585322, 6773.525853190229, 6796.456283497209, 6816.113905192492, 6829.760958366433, 6836.213835408992, 6700.865982680417, 6727.932720672927, 6729.226138994079, 6730.192376914802, 6731.427828634425, 6744.089547911165, 6879.58722476633, 6905.067815844997, 6910.93089069123, 6910.965445172742, 6645.501587380869, 6758.7296508139125, 6762.594244345355, 6765.797026089225, 6795.762148324982], "value": 5148.509677269822, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [813.4427916876939, 898.7393655839809, 929.1648447748144, 934.1779234273838, 948.117985798191, 14428.927855360722, 14748.262586870667, 14816.259187040645, 14874.107553546768, 14879.628009299786, 12984.74030519389, 14205.076670016442, 14222.573322800306, 14232.217228052454, 14292.0, 890.9732708018754, 911.0616065452562, 912.1562554636968, 912.4525284829116, 913.3925939250423, 899.3884158772032, 902.9097090290984, 904.4482865452069, 904.9547522623875, 909.2589539525299, 949.5204921514626, 950.6387572722356, 951.0632027452954, 952.2572393533055, 954.7326748510428, 928.0441145620022, 931.3852857114272, 940.1820416237848, 943.6744323208517, 946.4605175050224, 686.8591938652614, 689.1385767790263, 690.6788343420334, 692.19705142035, 694.5207806613421, 14104.365303561364, 14146.71706565863, 14153.716925661533, 14154.363053662508, 14207.573772786833, 14943.925280373638, 15007.774883376758, 15051.924740376338, 15229.238538073163, 15390.76913846282, 12045.217060891015, 12203.45084471201, 12291.07816913735, 12397.62807115788, 12583.24500529962, 4084.7549147050977, 4088.0, 4114.341705327163, 4225.471816022997, 4284.871453856358, 53674.19488707672, 54046.18930716042, 54083.729581352236, 54260.0, 55294.44705552974, 11211.38337391435, 11636.592719254786, 11661.067114630809, 11702.590409335633, 11765.235259708092, 18991.62016759657, 19041.904790476237, 19073.61852762937, 19088.809111908704, 19113.0, 7957.084935232407, 7984.68061277554, 7989.920100799034, 8004.799880003046, 8146.185381461806, 4745.122152401747, 4824.228123500223, 4851.447536788194, 4965.900681986413, 5015.047141043263, 3562.6437356264164, 3589.3718599245026, 3617.6744093031753, 3620.0587847159927, 3631.418972964313, 644.6712176789871, 649.023220053816, 655.8849955076389, 668.8829454845383, 675.645286224736, 706.6396137969673, 765.4412279036335, 775.5114278004934, 853.2193043365376, 878.6485405837589, 10266.794664106676, 10340.224483163793, 10368.222383321281, 10419.791604167875, 10447.738806529745, 674.2785219814751, 715.9642017899084, 749.8837680159584, 767.3055884424605, 839.546644811807, 4545.840895568639, 4668.229742092584, 4740.312654665055, 4741.35991641124, 4835.758212089452, 65261.347386526475, 65969.0, 66242.66878665576, 66601.0, 67031.3296867025, 55311.723441382535, 56160.719196403756, 56319.71840140773, 56587.71706141443, 56678.43321566814, 50234.49765502371, 50580.241296380584, 50703.74648126662, 50764.0, 50914.74542627263, 8834.911650883667, 9139.314551408805, 9367.156955874005, 9485.167884377326, 9514.143727064597, 37089.0, 37335.0, 37598.62401375951, 37614.811925940194, 38539.229215414976, 43667.56332436635, 45201.32198016967, 46025.53974460346, 49429.25856112233, 50097.0, 11473.426328683365, 11675.0, 12390.75218495607, 12411.503539858666, 13017.869821301665, 13539.11995720275, 13845.861541384456, 13988.720225595227, 14137.717245655234, 14293.928530357281, 12460.252384856938, 12581.182223155465, 13506.392212350664, 13787.379567919266, 13892.097013694078, 13531.188128712309, 13731.176129432266, 13800.654983625489, 13804.17174969505, 13854.445822167001, 10622.468876555986, 12568.057395695176, 12997.285149316878, 13047.739045219232, 13415.530456433979, 11670.299782013106, 11673.863246758892, 11847.703807404883, 11979.700507487383, 12167.087468440079, 10859.565617375216, 11833.46749396262, 12008.336922566665, 12082.918855691742, 12218.938905305416], "value": 7149.529276445439, "unit": "score"}], "name": "dromaeo_css", "value": 7625.7785670794465, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 114.0, 105.0, 110.0, 112.0, 113.0, 102.0, 110.0, 110.0, 111.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 127.0, 161.0, 180.0, 129.0, 152.0, 156.0, 129.0, 187.0, 128.0], "value": 150.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 162.0, 162.0, 162.0, 164.0, 161.0, 164.0, 163.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 185.0, 75.0, 77.0, 74.0, 78.0, 161.0, 72.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 149.0, 92.0, 94.0, 93.0, 153.0, 93.0, 93.0, 142.0], "value": 109.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 97.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 57.0, 54.0, 58.0, 55.0, 56.0, 70.0, 53.0, 52.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 57.0, 58.0, 58.0, 57.0, 57.0, 58.0, 57.0, 58.0], "value": 57.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 72.0, 73.0, 73.0, 73.0, 73.0, 75.0, 73.0], "value": 73.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 120.0, 119.0, 116.0, 118.0, 117.0, 118.0, 133.0, 128.0], "value": 119.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 160.0, 160.0, 157.0, 159.0, 160.0, 158.0, 162.0, 159.0], "value": 159.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 69.0, 66.0, 70.0, 71.0, 66.0, 66.0, 68.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1519.4999999999998, "alertThreshold": 2.0}]} 13:17:34 INFO - Return code: 0 13:17:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:17:34 ERROR - # TBPL SUCCESS # 13:17:34 INFO - Running post-action listener: _resource_record_post_action 13:17:34 INFO - Running post-run listener: _resource_record_post_run 13:17:35 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 464924672; Read time: 0; Write time: 348908 13:17:35 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 242331648; Read time: 0; Write time: 240484 13:17:35 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 0; Write bytes: 221995008; Read time: 0; Write time: 108424 13:17:35 INFO - Running post-run listener: _upload_blobber_files 13:17:35 INFO - Blob upload gear active. 13:17:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:17:35 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:17:35 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:17:35 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:17:36 INFO - (blobuploader) - INFO - Open directory for files ... 13:17:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:17:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:17:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:17:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:17:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:17:37 INFO - (blobuploader) - INFO - Done attempting. 13:17:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:17:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:17:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:17:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:17:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:17:37 INFO - (blobuploader) - INFO - Done attempting. 13:17:37 INFO - (blobuploader) - INFO - Iteration through files over. 13:17:37 INFO - Return code: 0 13:17:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:17:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:17:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d3f611c49b89524c0e5daaeca4a6a8c62888a53ccf8f76a192e7efa20a9b8456d614b8f021c6f345776efa32faf9cb972cfe93c95a2be0fad62dad22496d630d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ab7c69f2993353d47504c2051ad47eb175908e5a5e67f4b7cfb3a0be6ab5498a83639815ec53f8502df0821e8a7deb5fd5fd248034c0689810a51c952442b351"} 13:17:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:17:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:17:37 INFO - Contents: 13:17:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d3f611c49b89524c0e5daaeca4a6a8c62888a53ccf8f76a192e7efa20a9b8456d614b8f021c6f345776efa32faf9cb972cfe93c95a2be0fad62dad22496d630d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ab7c69f2993353d47504c2051ad47eb175908e5a5e67f4b7cfb3a0be6ab5498a83639815ec53f8502df0821e8a7deb5fd5fd248034c0689810a51c952442b351"} 13:17:37 INFO - Running post-run listener: copy_logs_to_upload_dir 13:17:37 INFO - Copying logs to upload dir... 13:17:37 INFO - mkdir: /builds/slave/test/build/upload/logs 13:17:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1221.032792 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 21 secs) (at 2016-07-15 13:17:37.635851) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 13:17:37.639328) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1468612634.497432-246536648 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-Beta/sha512/d3f611c49b89524c0e5daaeca4a6a8c62888a53ccf8f76a192e7efa20a9b8456d614b8f021c6f345776efa32faf9cb972cfe93c95a2be0fad62dad22496d630d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ab7c69f2993353d47504c2051ad47eb175908e5a5e67f4b7cfb3a0be6ab5498a83639815ec53f8502df0821e8a7deb5fd5fd248034c0689810a51c952442b351"} build_url:https://queue.taskcluster.net/v1/task/RKYuVrs3SBK3BczW4sF4Dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011324 build_url: 'https://queue.taskcluster.net/v1/task/RKYuVrs3SBK3BczW4sF4Dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d3f611c49b89524c0e5daaeca4a6a8c62888a53ccf8f76a192e7efa20a9b8456d614b8f021c6f345776efa32faf9cb972cfe93c95a2be0fad62dad22496d630d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ab7c69f2993353d47504c2051ad47eb175908e5a5e67f4b7cfb3a0be6ab5498a83639815ec53f8502df0821e8a7deb5fd5fd248034c0689810a51c952442b351"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 13:17:37.668812) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 13:17:37.669522) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1468612634.497432-246536648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004484 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 13:17:37.753069) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 13:17:37.753738) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 13:17:37.754401) ========= ========= Total master_lag: 0.18 =========