builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-006 starttime: 1464621255.35 results: success (0) buildid: 20160530035543 builduid: 865ed214ad954ae683a81bd20aaeb948 revision: 04934785596476f6dd8baccc355202aeba59af35 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 08:14:15.352436) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 08:14:15.352919) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 08:14:15.353202) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 08:14:15.368372) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:14:15.368773) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1464621254.736960-1844116046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 08:14: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.3M=0s 2016-05-30 08:14:15 (37.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111806 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:14:15.494578) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:14:15.494914) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1464621254.736960-1844116046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017579 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:14:15.544586) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-30 08:14:15.544977) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 04934785596476f6dd8baccc355202aeba59af35 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 04934785596476f6dd8baccc355202aeba59af35 --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=e31afd3c0f0de4e86ebe4d94000001b5-1464621254.736960-1844116046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 08:14:15,795 truncating revision to first 12 chars 2016-05-30 08:14:15,795 Setting DEBUG logging. 2016-05-30 08:14:15,795 attempt 1/10 2016-05-30 08:14:15,795 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/049347855964?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 08:14:16,695 unpacking tar archive at: mozilla-aurora-049347855964/testing/mozharness/ program finished with exit code 0 elapsedTime=1.262194 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-30 08:14:16.821075) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 08:14:16.821588) ========= script_repo_revision: 04934785596476f6dd8baccc355202aeba59af35 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 08:14:16.822002) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 08:14:16.822276) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 08:14:16.832049) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-05-30 08:14:16.832635) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1464621254.736960-1844116046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:14:17 INFO - MultiFileLogger online at 20160530 08:14:17 in /builds/slave/test 08:14:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:14:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:14:17 INFO - {'append_to_log': False, 08:14:17 INFO - 'base_work_dir': '/builds/slave/test', 08:14:17 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:14:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:14:17 INFO - 'branch': 'Mozilla-Aurora', 08:14:17 INFO - 'buildbot_json_path': 'buildprops.json', 08:14:17 INFO - 'config_files': ('talos/linux_config.py',), 08:14:17 INFO - 'default_actions': ('clobber', 08:14:17 INFO - 'read-buildbot-config', 08:14:17 INFO - 'download-and-extract', 08:14:17 INFO - 'populate-webroot', 08:14:17 INFO - 'create-virtualenv', 08:14:17 INFO - 'install', 08:14:17 INFO - 'run-tests'), 08:14:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:14:17 INFO - 'download_minidump_stackwalk': True, 08:14:17 INFO - 'download_symbols': 'ondemand', 08:14:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:14:17 INFO - 'tooltool.py': '/tools/tooltool.py', 08:14:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:14:17 INFO - '/tools/misc-python/virtualenv.py')}, 08:14:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:14:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:14:17 INFO - 'installer_path': 'installer.exe', 08:14:17 INFO - 'log_level': 'info', 08:14:17 INFO - 'log_name': 'talos', 08:14:17 INFO - 'log_to_console': True, 08:14:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:14:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:14:17 INFO - 'opt_config_files': (), 08:14:17 INFO - 'pip_index': False, 08:14:17 INFO - 'sps_profile': False, 08:14:17 INFO - 'sps_profile_interval': 0, 08:14:17 INFO - 'suite': 'dromaeojs', 08:14:17 INFO - 'system_bits': '32', 08:14:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:14:17 INFO - 'title': 'talos-linux64-ix-006', 08:14:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:14:17 INFO - 'use_talos_json': True, 08:14:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:14:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:14:17 INFO - 'work_dir': 'build'} 08:14:17 INFO - ##### 08:14:17 INFO - ##### Running clobber step. 08:14:17 INFO - ##### 08:14:17 INFO - Running pre-action listener: _resource_record_pre_action 08:14:17 INFO - Running main action method: clobber 08:14:17 INFO - rmtree: /builds/slave/test/build 08:14:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:14:18 INFO - Running post-action listener: _resource_record_post_action 08:14:18 INFO - ##### 08:14:18 INFO - ##### Running read-buildbot-config step. 08:14:18 INFO - ##### 08:14:18 INFO - Running pre-action listener: _resource_record_pre_action 08:14:18 INFO - Running main action method: read_buildbot_config 08:14:18 INFO - Using buildbot properties: 08:14:18 INFO - { 08:14:18 INFO - "project": "", 08:14:18 INFO - "product": "firefox", 08:14:18 INFO - "script_repo_revision": "production", 08:14:18 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 08:14:18 INFO - "repository": "", 08:14:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 08:14:18 INFO - "buildid": "20160530035543", 08:14:18 INFO - "pgo_build": "True", 08:14:18 INFO - "basedir": "/builds/slave/test", 08:14:18 INFO - "buildnumber": 270, 08:14:18 INFO - "slavename": "talos-linux64-ix-006", 08:14:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:14:18 INFO - "platform": "ubuntu64_hw", 08:14:18 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:14:18 INFO - "branch": "mozilla-aurora", 08:14:18 INFO - "repo_path": "releases/mozilla-aurora", 08:14:18 INFO - "revision": "04934785596476f6dd8baccc355202aeba59af35", 08:14:18 INFO - "stage_platform": "linux64-pgo", 08:14:18 INFO - "builduid": "865ed214ad954ae683a81bd20aaeb948", 08:14:18 INFO - "slavebuilddir": "test" 08:14:18 INFO - } 08:14:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 08:14:18 INFO - Running post-action listener: _resource_record_post_action 08:14:18 INFO - ##### 08:14:18 INFO - ##### Running download-and-extract step. 08:14:18 INFO - ##### 08:14:18 INFO - Running pre-action listener: _resource_record_pre_action 08:14:18 INFO - Running main action method: download_and_extract 08:14:18 INFO - mkdir: /builds/slave/test/build/tests 08:14: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')]} 08:14:18 INFO - https://queue.taskcluster.net/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:14:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 08:14:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 08:14:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 08:14:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:14:18 INFO - Downloaded 1361 bytes. 08:14:18 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 08:14:18 INFO - Using the following test package requirements: 08:14:18 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 08:14:18 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 08:14:18 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:14:18 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 08:14:18 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 08:14:18 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 08:14:18 INFO - u'jsshell-linux-x86_64.zip'], 08:14:18 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 08:14:18 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:14:18 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 08:14:18 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 08:14:18 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:14:18 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 08:14:18 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:14:18 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 08:14:18 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:14:18 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 08:14:18 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:14:18 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:14: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')]} 08:14:18 INFO - https://queue.taskcluster.net/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:14:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 08:14:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 08:14:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 08:14:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:14:19 INFO - Downloaded 24135385 bytes. 08:14:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:14:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:14:21 INFO - Return code: 0 08:14:21 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:14:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:21 INFO - https://queue.taskcluster.net/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:14:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 08:14:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 08:14:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 08:14:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:14:22 INFO - Downloaded 24135385 bytes. 08:14:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:14:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:14:23 INFO - Return code: 0 08:14:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:23 INFO - https://queue.taskcluster.net/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:14:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 08:14:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 08:14:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 08:14:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:14:25 INFO - Downloaded 10840145 bytes. 08:14:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:14:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:14:25 INFO - Return code: 0 08:14:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:25 INFO - https://queue.taskcluster.net/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:14:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 08:14:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 08:14:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 08:14:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:14:26 INFO - Downloaded 62736116 bytes. 08:14:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 08:14:26 INFO - mkdir: /builds/slave/test/properties 08:14:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:14:26 INFO - Writing to file /builds/slave/test/properties/build_url 08:14:26 INFO - Contents: 08:14:26 INFO - build_url:https://queue.taskcluster.net/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 08:14:27 INFO - Running post-action listener: _resource_record_post_action 08:14:27 INFO - Running post-action listener: set_extra_try_arguments 08:14:27 INFO - ##### 08:14:27 INFO - ##### Running populate-webroot step. 08:14:27 INFO - ##### 08:14:27 INFO - Running pre-action listener: _resource_record_pre_action 08:14:27 INFO - Running main action method: populate_webroot 08:14:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:14:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:14:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:14:27 INFO - '--tppagecycles', 08:14:27 INFO - '7'], 08:14:27 INFO - 'tests': ['tsvgm']}}, 08:14:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:14:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:14:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:14:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:14:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:14:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:14:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:27 INFO - 'talos_options': ['--disable-e10s'], 08:14:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:14:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:14:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:27 INFO - 'talos_options': ['--disable-e10s'], 08:14:27 INFO - 'tests': ['damp', 'tps']}, 08:14:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:27 INFO - 'tests': ['damp', 'tps']}, 08:14:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:14:27 INFO - 'tests': ['dromaeo_dom']}, 08:14:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:14:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:14:27 INFO - 'tests': ['a11yr', 08:14:27 INFO - 'ts_paint', 08:14:27 INFO - 'tpaint', 08:14:27 INFO - 'sessionrestore', 08:14:27 INFO - 'sessionrestore_no_auto_restore', 08:14:27 INFO - 'tabpaint']}, 08:14:27 INFO - 'other-e10s': {'tests': ['a11yr', 08:14:27 INFO - 'ts_paint', 08:14:27 INFO - 'tpaint', 08:14:27 INFO - 'sessionrestore', 08:14:27 INFO - 'sessionrestore_no_auto_restore', 08:14:27 INFO - 'tabpaint']}, 08:14:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:14:27 INFO - 'ts_paint', 08:14:27 INFO - 'tpaint', 08:14:27 INFO - 'sessionrestore', 08:14:27 INFO - 'sessionrestore_no_auto_restore', 08:14:27 INFO - 'tabpaint']}, 08:14:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:14:27 INFO - 'ts_paint', 08:14:27 INFO - 'tpaint', 08:14:27 INFO - 'sessionrestore', 08:14:27 INFO - 'sessionrestore_no_auto_restore', 08:14:27 INFO - 'tabpaint']}, 08:14:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:14:27 INFO - 'tests': ['a11yr', 08:14:27 INFO - 'ts_paint', 08:14:27 INFO - 'tpaint', 08:14:27 INFO - 'sessionrestore', 08:14:27 INFO - 'sessionrestore_no_auto_restore', 08:14:27 INFO - 'tabpaint']}, 08:14:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:14:27 INFO - 'tests': ['a11yr', 08:14:27 INFO - 'ts_paint', 08:14:27 INFO - 'tpaint', 08:14:27 INFO - 'sessionrestore', 08:14:27 INFO - 'sessionrestore_no_auto_restore', 08:14:27 INFO - 'tabpaint']}, 08:14:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:14:27 INFO - 'tests': ['tsvgx', 08:14:27 INFO - 'tsvgr_opacity', 08:14:27 INFO - 'tart', 08:14:27 INFO - 'tscrollx', 08:14:27 INFO - 'cart']}, 08:14:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:14:27 INFO - 'tsvgr_opacity', 08:14:27 INFO - 'tart', 08:14:27 INFO - 'tscrollx', 08:14:27 INFO - 'cart']}, 08:14:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:27 INFO - 'talos_options': ['--disable-e10s'], 08:14:27 INFO - 'tests': ['tp5o']}, 08:14:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:27 INFO - 'tests': ['tp5o']}, 08:14:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:27 INFO - 'talos_options': ['--disable-e10s', 08:14:27 INFO - '--xperf_path', 08:14:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:14:27 INFO - 'tests': ['tp5n']}, 08:14:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:27 INFO - 'talos_options': ['--xperf_path', 08:14:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:14:27 INFO - 'tests': ['tp5n']}}, 08:14:27 INFO - 'talos.zip': {'path': '', 08:14:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:14:27 INFO - Running post-action listener: _resource_record_post_action 08:14:27 INFO - ##### 08:14:27 INFO - ##### Running create-virtualenv step. 08:14:27 INFO - ##### 08:14:27 INFO - Running pre-action listener: _resource_record_pre_action 08:14:27 INFO - Running main action method: create_virtualenv 08:14:27 INFO - Creating virtualenv /builds/slave/test/build/venv 08:14:27 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:14:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:14:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:14:27 INFO - Using real prefix '/usr' 08:14:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:14:28 INFO - Installing distribute.............................................................................................................................................................................................done. 08:14:30 INFO - Installing pip.................done. 08:14:30 INFO - Return code: 0 08:14:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:30 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 0x7f2979eb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2735410>, '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 0x2736310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27367a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1464621254.736960-1844116046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:14:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:14:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:14:30 INFO - Using env: {'DISPLAY': ':0', 08:14:30 INFO - 'HOME': '/home/cltbld', 08:14:30 INFO - 'LANG': 'en_US.UTF-8', 08:14:30 INFO - 'LANGUAGE': 'en_US:en', 08:14:30 INFO - 'LOGNAME': 'cltbld', 08:14:30 INFO - 'MAIL': '/var/mail/cltbld', 08:14:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:30 INFO - 'MOZ_NO_REMOTE': '1', 08:14:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:30 INFO - 'NO_EM_RESTART': '1', 08:14:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:30 INFO - 'PWD': '/builds/slave/test', 08:14:30 INFO - 'SHELL': '/bin/bash', 08:14:30 INFO - 'SHLVL': '1', 08:14:30 INFO - 'TERM': 'linux', 08:14:30 INFO - 'TMOUT': '86400', 08:14:30 INFO - 'USER': 'cltbld', 08:14:30 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1464621254.736960-1844116046', 08:14:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:30 INFO - '_': '/tools/buildbot/bin/python'} 08:14:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:30 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:14:30 INFO - Cleaning up... 08:14:30 INFO - Return code: 0 08:14:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:30 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 0x7f2979eb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2735410>, '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 0x2736310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27367a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1464621254.736960-1844116046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:14:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:14:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:14:30 INFO - Using env: {'DISPLAY': ':0', 08:14:30 INFO - 'HOME': '/home/cltbld', 08:14:30 INFO - 'LANG': 'en_US.UTF-8', 08:14:30 INFO - 'LANGUAGE': 'en_US:en', 08:14:30 INFO - 'LOGNAME': 'cltbld', 08:14:30 INFO - 'MAIL': '/var/mail/cltbld', 08:14:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:30 INFO - 'MOZ_NO_REMOTE': '1', 08:14:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:30 INFO - 'NO_EM_RESTART': '1', 08:14:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:30 INFO - 'PWD': '/builds/slave/test', 08:14:30 INFO - 'SHELL': '/bin/bash', 08:14:30 INFO - 'SHLVL': '1', 08:14:30 INFO - 'TERM': 'linux', 08:14:30 INFO - 'TMOUT': '86400', 08:14:30 INFO - 'USER': 'cltbld', 08:14:30 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1464621254.736960-1844116046', 08:14:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:30 INFO - '_': '/tools/buildbot/bin/python'} 08:14:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:30 INFO - Downloading/unpacking psutil>=0.7.1 08:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:14:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:32 INFO - Installing collected packages: psutil 08:14:32 INFO - Running setup.py install for psutil 08:14:32 INFO - building 'psutil._psutil_linux' extension 08:14:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:14:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:14:32 INFO - building 'psutil._psutil_posix' extension 08:14:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:14:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:14:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:33 INFO - Successfully installed psutil 08:14:33 INFO - Cleaning up... 08:14:33 INFO - Return code: 0 08:14:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:14:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:33 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 0x7f2979eb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2735410>, '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 0x2736310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27367a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1464621254.736960-1844116046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:14:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:14:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:14:33 INFO - Using env: {'DISPLAY': ':0', 08:14:33 INFO - 'HOME': '/home/cltbld', 08:14:33 INFO - 'LANG': 'en_US.UTF-8', 08:14:33 INFO - 'LANGUAGE': 'en_US:en', 08:14:33 INFO - 'LOGNAME': 'cltbld', 08:14:33 INFO - 'MAIL': '/var/mail/cltbld', 08:14:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:33 INFO - 'MOZ_NO_REMOTE': '1', 08:14:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:33 INFO - 'NO_EM_RESTART': '1', 08:14:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:33 INFO - 'PWD': '/builds/slave/test', 08:14:33 INFO - 'SHELL': '/bin/bash', 08:14:33 INFO - 'SHLVL': '1', 08:14:33 INFO - 'TERM': 'linux', 08:14:33 INFO - 'TMOUT': '86400', 08:14:33 INFO - 'USER': 'cltbld', 08:14:33 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1464621254.736960-1844116046', 08:14:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:33 INFO - '_': '/tools/buildbot/bin/python'} 08:14:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:14:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:14:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:14:35 INFO - Installing collected packages: mozsystemmonitor 08:14:35 INFO - Running setup.py install for mozsystemmonitor 08:14:35 INFO - Successfully installed mozsystemmonitor 08:14:35 INFO - Cleaning up... 08:14:35 INFO - Return code: 0 08:14:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:14:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:35 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 0x7f2979eb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2735410>, '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 0x2736310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27367a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1464621254.736960-1844116046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:14:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:14:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:14:35 INFO - Using env: {'DISPLAY': ':0', 08:14:35 INFO - 'HOME': '/home/cltbld', 08:14:35 INFO - 'LANG': 'en_US.UTF-8', 08:14:35 INFO - 'LANGUAGE': 'en_US:en', 08:14:35 INFO - 'LOGNAME': 'cltbld', 08:14:35 INFO - 'MAIL': '/var/mail/cltbld', 08:14:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:35 INFO - 'MOZ_NO_REMOTE': '1', 08:14:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:35 INFO - 'NO_EM_RESTART': '1', 08:14:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:35 INFO - 'PWD': '/builds/slave/test', 08:14:35 INFO - 'SHELL': '/bin/bash', 08:14:35 INFO - 'SHLVL': '1', 08:14:35 INFO - 'TERM': 'linux', 08:14:35 INFO - 'TMOUT': '86400', 08:14:35 INFO - 'USER': 'cltbld', 08:14:35 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1464621254.736960-1844116046', 08:14:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:35 INFO - '_': '/tools/buildbot/bin/python'} 08:14:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:35 INFO - Downloading/unpacking blobuploader==1.2.4 08:14:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:37 INFO - Downloading blobuploader-1.2.4.tar.gz 08:14:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:14:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:14:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14:38 INFO - Downloading docopt-0.6.1.tar.gz 08:14:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:14:38 INFO - Installing collected packages: blobuploader, requests, docopt 08:14:38 INFO - Running setup.py install for blobuploader 08:14:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:14:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:14:38 INFO - Running setup.py install for requests 08:14:38 INFO - Running setup.py install for docopt 08:14:38 INFO - Successfully installed blobuploader requests docopt 08:14:38 INFO - Cleaning up... 08:14:38 INFO - Return code: 0 08:14:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:38 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 0x7f2979eb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2735410>, '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 0x2736310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27367a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1464621254.736960-1844116046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:14:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:14:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:14:38 INFO - Using env: {'DISPLAY': ':0', 08:14:38 INFO - 'HOME': '/home/cltbld', 08:14:38 INFO - 'LANG': 'en_US.UTF-8', 08:14:38 INFO - 'LANGUAGE': 'en_US:en', 08:14:38 INFO - 'LOGNAME': 'cltbld', 08:14:38 INFO - 'MAIL': '/var/mail/cltbld', 08:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:38 INFO - 'MOZ_NO_REMOTE': '1', 08:14:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:38 INFO - 'NO_EM_RESTART': '1', 08:14:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:38 INFO - 'PWD': '/builds/slave/test', 08:14:38 INFO - 'SHELL': '/bin/bash', 08:14:38 INFO - 'SHLVL': '1', 08:14:38 INFO - 'TERM': 'linux', 08:14:38 INFO - 'TMOUT': '86400', 08:14:38 INFO - 'USER': 'cltbld', 08:14:38 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1464621254.736960-1844116046', 08:14:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:38 INFO - '_': '/tools/buildbot/bin/python'} 08:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:14:39 INFO - Running setup.py (path:/tmp/pip-uLM4Yg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:14:39 INFO - Running setup.py (path:/tmp/pip-1C6yKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:14:39 INFO - Running setup.py (path:/tmp/pip-WRtxY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:14:39 INFO - Running setup.py (path:/tmp/pip-oFwwKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:14:39 INFO - Running setup.py (path:/tmp/pip-OdBRW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:14:39 INFO - Running setup.py (path:/tmp/pip-VeMeV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:14:39 INFO - Running setup.py (path:/tmp/pip-3MfYQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:14:39 INFO - Running setup.py (path:/tmp/pip-GVFkWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:14:39 INFO - Running setup.py (path:/tmp/pip-wIiK1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:14:39 INFO - Running setup.py (path:/tmp/pip-pPp8hE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:14:39 INFO - Running setup.py (path:/tmp/pip-F9uuzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:14:39 INFO - Running setup.py (path:/tmp/pip-BBcfSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:14:39 INFO - Running setup.py (path:/tmp/pip-v1TKHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:14:39 INFO - Running setup.py (path:/tmp/pip-vAj9sB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:40 INFO - Running setup.py (path:/tmp/pip-y46NrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:14:40 INFO - Running setup.py (path:/tmp/pip-BcVNy6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:14:40 INFO - Running setup.py (path:/tmp/pip-eeCes7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:14:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:14:40 INFO - Running setup.py install for manifestparser 08:14:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:14:40 INFO - Running setup.py install for mozcrash 08:14:40 INFO - Running setup.py install for mozdebug 08:14:40 INFO - Running setup.py install for mozdevice 08:14:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:14:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:14:40 INFO - Running setup.py install for mozfile 08:14:40 INFO - Running setup.py install for mozhttpd 08:14:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:14:40 INFO - Running setup.py install for mozinfo 08:14:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:14:40 INFO - Running setup.py install for mozInstall 08:14:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:14:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:14:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:14:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:14:41 INFO - Running setup.py install for mozleak 08:14:41 INFO - Running setup.py install for mozlog 08:14:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:14:41 INFO - Running setup.py install for moznetwork 08:14:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:14:41 INFO - Running setup.py install for mozprocess 08:14:41 INFO - Running setup.py install for mozprofile 08:14:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:14:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:14:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:14:41 INFO - Running setup.py install for mozrunner 08:14:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:14:41 INFO - Running setup.py install for mozscreenshot 08:14:41 INFO - Running setup.py install for moztest 08:14:41 INFO - Running setup.py install for mozversion 08:14:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:14:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:14:42 INFO - Cleaning up... 08:14:42 INFO - Return code: 0 08:14:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:42 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 0x7f2979eb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2735410>, '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 0x2736310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27367a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1464621254.736960-1844116046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:14:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:14:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:14:42 INFO - Using env: {'DISPLAY': ':0', 08:14:42 INFO - 'HOME': '/home/cltbld', 08:14:42 INFO - 'LANG': 'en_US.UTF-8', 08:14:42 INFO - 'LANGUAGE': 'en_US:en', 08:14:42 INFO - 'LOGNAME': 'cltbld', 08:14:42 INFO - 'MAIL': '/var/mail/cltbld', 08:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:42 INFO - 'MOZ_NO_REMOTE': '1', 08:14:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:42 INFO - 'NO_EM_RESTART': '1', 08:14:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:42 INFO - 'PWD': '/builds/slave/test', 08:14:42 INFO - 'SHELL': '/bin/bash', 08:14:42 INFO - 'SHLVL': '1', 08:14:42 INFO - 'TERM': 'linux', 08:14:42 INFO - 'TMOUT': '86400', 08:14:42 INFO - 'USER': 'cltbld', 08:14:42 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1464621254.736960-1844116046', 08:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:42 INFO - '_': '/tools/buildbot/bin/python'} 08:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:14:42 INFO - Running setup.py (path:/tmp/pip-p1iytc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:14:42 INFO - Running setup.py (path:/tmp/pip-kZHD8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:14:42 INFO - Running setup.py (path:/tmp/pip-L7vFJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:14:42 INFO - Running setup.py (path:/tmp/pip-_6B5bv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:14:42 INFO - Running setup.py (path:/tmp/pip-YJ5F88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:14:42 INFO - Running setup.py (path:/tmp/pip-uJxOt3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:14:42 INFO - Running setup.py (path:/tmp/pip-ejCndq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:14:42 INFO - Running setup.py (path:/tmp/pip-qCJaBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:14:42 INFO - Running setup.py (path:/tmp/pip-rQwwzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:14: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)) 08:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:14:42 INFO - Running setup.py (path:/tmp/pip-hz3gY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:14: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)) 08:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:14:42 INFO - Running setup.py (path:/tmp/pip-p6kPVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:14:43 INFO - Running setup.py (path:/tmp/pip-JhF1HI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:14:43 INFO - Running setup.py (path:/tmp/pip-oWB8vF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:14:43 INFO - Running setup.py (path:/tmp/pip-97hcSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:43 INFO - Running setup.py (path:/tmp/pip-dJa1bk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:14:43 INFO - Running setup.py (path:/tmp/pip-Wbunzr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:14:43 INFO - Running setup.py (path:/tmp/pip-ernNE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:14:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:45 INFO - Downloading blessings-1.6.tar.gz 08:14:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:14:45 INFO - Installing collected packages: blessings 08:14:45 INFO - Running setup.py install for blessings 08:14:45 INFO - Successfully installed blessings 08:14:45 INFO - Cleaning up... 08:14:45 INFO - Return code: 0 08:14:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:14:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:14:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:14:45 INFO - Reading from file tmpfile_stdout 08:14:45 INFO - Current package versions: 08:14:45 INFO - argparse == 1.2.1 08:14:45 INFO - blessings == 1.6 08:14:45 INFO - blobuploader == 1.2.4 08:14:45 INFO - docopt == 0.6.1 08:14:45 INFO - manifestparser == 1.1 08:14:45 INFO - mozInstall == 1.12 08:14:45 INFO - mozcrash == 0.17 08:14:45 INFO - mozdebug == 0.1 08:14:45 INFO - mozdevice == 0.48 08:14:45 INFO - mozfile == 1.2 08:14:45 INFO - mozhttpd == 0.7 08:14:45 INFO - mozinfo == 0.9 08:14:45 INFO - mozleak == 0.1 08:14:45 INFO - mozlog == 3.1 08:14:45 INFO - moznetwork == 0.27 08:14:45 INFO - mozprocess == 0.22 08:14:45 INFO - mozprofile == 0.28 08:14:45 INFO - mozrunner == 6.11 08:14:45 INFO - mozscreenshot == 0.1 08:14:45 INFO - mozsystemmonitor == 0.0 08:14:45 INFO - moztest == 0.7 08:14:45 INFO - mozversion == 1.4 08:14:45 INFO - psutil == 3.1.1 08:14:45 INFO - requests == 1.2.3 08:14:45 INFO - wsgiref == 0.1.2 08:14:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14: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')]} 08:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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')]} 08:14:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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 0x7f2979eb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2735410>, '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 0x2736310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27367a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1464621254.736960-1844116046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:14: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 08:14: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 08:14:45 INFO - Using env: {'DISPLAY': ':0', 08:14:45 INFO - 'HOME': '/home/cltbld', 08:14:45 INFO - 'LANG': 'en_US.UTF-8', 08:14:45 INFO - 'LANGUAGE': 'en_US:en', 08:14:45 INFO - 'LOGNAME': 'cltbld', 08:14:45 INFO - 'MAIL': '/var/mail/cltbld', 08:14:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:45 INFO - 'MOZ_NO_REMOTE': '1', 08:14:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:45 INFO - 'NO_EM_RESTART': '1', 08:14:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:45 INFO - 'PWD': '/builds/slave/test', 08:14:45 INFO - 'SHELL': '/bin/bash', 08:14:45 INFO - 'SHLVL': '1', 08:14:45 INFO - 'TERM': 'linux', 08:14:45 INFO - 'TMOUT': '86400', 08:14:45 INFO - 'USER': 'cltbld', 08:14:45 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1464621254.736960-1844116046', 08:14:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:45 INFO - '_': '/tools/buildbot/bin/python'} 08:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:14:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:14:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:14:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:14:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:14:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:14:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:14:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:14:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:14:46 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:14:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:14:46 INFO - Cleaning up... 08:14:46 INFO - Return code: 0 08:14:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:46 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 0x7f2979eb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2735410>, '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 0x2736310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27367a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1464621254.736960-1844116046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:14:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:14:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:14:46 INFO - Using env: {'DISPLAY': ':0', 08:14:46 INFO - 'HOME': '/home/cltbld', 08:14:46 INFO - 'LANG': 'en_US.UTF-8', 08:14:46 INFO - 'LANGUAGE': 'en_US:en', 08:14:46 INFO - 'LOGNAME': 'cltbld', 08:14:46 INFO - 'MAIL': '/var/mail/cltbld', 08:14:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:46 INFO - 'MOZ_NO_REMOTE': '1', 08:14:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:46 INFO - 'NO_EM_RESTART': '1', 08:14:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:46 INFO - 'PWD': '/builds/slave/test', 08:14:46 INFO - 'SHELL': '/bin/bash', 08:14:46 INFO - 'SHLVL': '1', 08:14:46 INFO - 'TERM': 'linux', 08:14:46 INFO - 'TMOUT': '86400', 08:14:46 INFO - 'USER': 'cltbld', 08:14:46 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1464621254.736960-1844116046', 08:14:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:46 INFO - '_': '/tools/buildbot/bin/python'} 08:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:46 INFO - Downloading/unpacking jsonschema 08:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:14:48 INFO - Downloading/unpacking functools32 (from jsonschema) 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14:48 INFO - Downloading functools32-3.2.3-2.tar.gz 08:14:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:14:48 INFO - warning: no files found matching '*.txt' 08:14:48 INFO - no previously-included directories found matching 'build' 08:14:48 INFO - no previously-included directories found matching 'dist' 08:14:48 INFO - no previously-included directories found matching '.git*' 08:14:48 INFO - Installing collected packages: jsonschema, functools32 08:14:48 INFO - Running setup.py install for functools32 08:14:48 INFO - warning: no files found matching '*.txt' 08:14:48 INFO - no previously-included directories found matching 'build' 08:14:48 INFO - no previously-included directories found matching 'dist' 08:14:48 INFO - no previously-included directories found matching '.git*' 08:14:48 INFO - Successfully installed jsonschema functools32 08:14:48 INFO - Cleaning up... 08:14:48 INFO - Return code: 0 08:14:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:48 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 0x7f2979eb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2735410>, '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 0x2736310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27367a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1464621254.736960-1844116046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:14:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:14:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:14:48 INFO - Using env: {'DISPLAY': ':0', 08:14:48 INFO - 'HOME': '/home/cltbld', 08:14:48 INFO - 'LANG': 'en_US.UTF-8', 08:14:48 INFO - 'LANGUAGE': 'en_US:en', 08:14:48 INFO - 'LOGNAME': 'cltbld', 08:14:48 INFO - 'MAIL': '/var/mail/cltbld', 08:14:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:48 INFO - 'MOZ_NO_REMOTE': '1', 08:14:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:48 INFO - 'NO_EM_RESTART': '1', 08:14:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:48 INFO - 'PWD': '/builds/slave/test', 08:14:48 INFO - 'SHELL': '/bin/bash', 08:14:48 INFO - 'SHLVL': '1', 08:14:48 INFO - 'TERM': 'linux', 08:14:48 INFO - 'TMOUT': '86400', 08:14:48 INFO - 'USER': 'cltbld', 08:14:48 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1464621254.736960-1844116046', 08:14:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:48 INFO - '_': '/tools/buildbot/bin/python'} 08:14:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:48 INFO - Downloading/unpacking flake8 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:14:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:14:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:14:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:14:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:14:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:14:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:14:51 INFO - no previously-included directories found matching 'docs/_build' 08:14:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:14:51 INFO - Running setup.py install for pep8 08:14:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:14:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:14:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:14:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:14:51 INFO - no previously-included directories found matching 'docs/_build' 08:14:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:14:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:14:51 INFO - Cleaning up... 08:14:51 INFO - Return code: 0 08:14:51 INFO - Running post-action listener: _resource_record_post_action 08:14:51 INFO - Running post-action listener: _start_resource_monitoring 08:14:51 INFO - Starting resource monitoring. 08:14:51 INFO - ##### 08:14:51 INFO - ##### Running install step. 08:14:51 INFO - ##### 08:14:51 INFO - Running pre-action listener: _resource_record_pre_action 08:14:51 INFO - Running main action method: install 08:14:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:14:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:14:51 INFO - Reading from file tmpfile_stdout 08:14:51 INFO - Detecting whether we're running mozinstall >=1.0... 08:14:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:14:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:14:52 INFO - Reading from file tmpfile_stdout 08:14:52 INFO - Output received: 08:14:52 INFO - Usage: mozinstall [options] installer 08:14:52 INFO - Options: 08:14:52 INFO - -h, --help show this help message and exit 08:14:52 INFO - -d DEST, --destination=DEST 08:14:52 INFO - Directory to install application into. [default: 08:14:52 INFO - "/builds/slave/test"] 08:14:52 INFO - --app=APP Application being installed. [default: firefox] 08:14:52 INFO - mkdir: /builds/slave/test/build/application 08:14:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:14:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:15:07 INFO - Reading from file tmpfile_stdout 08:15:07 INFO - Output received: 08:15:07 INFO - /builds/slave/test/build/application/firefox/firefox 08:15:07 INFO - Running post-action listener: _resource_record_post_action 08:15:07 INFO - ##### 08:15:07 INFO - ##### Running run-tests step. 08:15:07 INFO - ##### 08:15:07 INFO - Running pre-action listener: _resource_record_pre_action 08:15:07 INFO - Running main action method: run_tests 08:15:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:15:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:15:07 INFO - Python 2.7.3 08:15:07 INFO - Return code: 0 08:15:07 INFO - grabbing minidump binary from tooltool 08:15:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:07 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 0x2735410>, '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 0x2736310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27367a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:15:07 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:15:07 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:15:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:15:07 INFO - Return code: 0 08:15:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:15:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:15:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:15:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:15:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:15:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:15:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:15:08 INFO - Return code: 0 08:15:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:15:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:15:08 INFO - Using env: {'DISPLAY': ':0', 08:15:08 INFO - 'HOME': '/home/cltbld', 08:15:08 INFO - 'LANG': 'en_US.UTF-8', 08:15:08 INFO - 'LANGUAGE': 'en_US:en', 08:15:08 INFO - 'LOGNAME': 'cltbld', 08:15:08 INFO - 'MAIL': '/var/mail/cltbld', 08:15:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:15:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:15:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:08 INFO - 'MOZ_NO_REMOTE': '1', 08:15:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:15:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:08 INFO - 'NO_EM_RESTART': '1', 08:15:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:08 INFO - 'PWD': '/builds/slave/test', 08:15:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:15:08 INFO - 'SHELL': '/bin/bash', 08:15:08 INFO - 'SHLVL': '1', 08:15:08 INFO - 'TERM': 'linux', 08:15:08 INFO - 'TMOUT': '86400', 08:15:08 INFO - 'USER': 'cltbld', 08:15:08 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1464621254.736960-1844116046', 08:15:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:08 INFO - '_': '/tools/buildbot/bin/python'} 08:15:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:15:08 INFO - mozversion application_buildid: 20160530035543 08:15:08 INFO - mozversion application_changeset: 04934785596476f6dd8baccc355202aeba59af35 08:15:08 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:15:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:15:08 INFO - mozversion application_name: Firefox 08:15:08 INFO - mozversion application_remotingname: firefox-dev 08:15:08 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:15:08 INFO - mozversion application_vendor: Mozilla 08:15:08 INFO - mozversion application_version: 48.0a2 08:15:08 INFO - mozversion platform_buildid: 20160530035543 08:15:08 INFO - mozversion platform_changeset: 04934785596476f6dd8baccc355202aeba59af35 08:15:08 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:15:08 INFO - mozversion platform_version: 48.0a2 08:15:08 INFO - using testdate: 1464621308 08:15:08 INFO - actual date: 1464621308 08:15:08 INFO - starting webserver on 'localhost:49263' 08:15:08 INFO - SUITE-START | Running 2 tests 08:15:08 INFO - TEST-START | dromaeo_css 08:15:08 INFO - operating with platform_type : linux_ 08:15:08 INFO - Initialising browser for dromaeo_css test... 08:15:08 INFO - TEST-INFO | started process 2929 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBMiY1Y/profile http://localhost:49263/getInfo.html) 08:15:12 INFO - PROCESS | 2929 | __metrics Screen width/height:1600/1200 08:15:12 INFO - PROCESS | 2929 | colorDepth:24 08:15:12 INFO - PROCESS | 2929 | Browser inner width/height: 1024/697 08:15:12 INFO - PROCESS | 2929 | __metrics 08:15:13 ERROR - PROCESS | 2929 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:15:14 INFO - TEST-INFO | 2929: exit 0 08:15:14 INFO - Browser initialized. 08:15:14 INFO - Running cycle 1/1 for dromaeo_css test... 08:15:14 INFO - TEST-INFO | started process 3019 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBMiY1Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:15:26 INFO - PROCESS | 3019 | RSS: Main: 141914112 08:15:26 INFO - PROCESS | 3019 | 08:16:17 INFO - PROCESS | 3019 | 1464621377245 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:18:24 INFO - PROCESS | 3019 | Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49263/tests/dromaeo/cssquery-ext.html) 08:18:25 INFO - PROCESS | 3019 | RSS: Main: 250482688 08:18:25 INFO - PROCESS | 3019 | 08:21:27 INFO - PROCESS | 3019 | Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-ext.html (next: http://localhost:49263/tests/dromaeo/cssquery-jquery.html) 08:21:28 INFO - PROCESS | 3019 | RSS: Main: 227192832 08:21:28 INFO - PROCESS | 3019 | 08:24:30 INFO - PROCESS | 3019 | Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49263/tests/dromaeo/cssquery-mootools.html) 08:24:30 INFO - PROCESS | 3019 | RSS: Main: 226799616 08:24:30 INFO - PROCESS | 3019 | 08:27:32 INFO - PROCESS | 3019 | Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49263/tests/dromaeo/cssquery-prototype.html) 08:27:33 INFO - PROCESS | 3019 | RSS: Main: 223842304 08:27:33 INFO - PROCESS | 3019 | 08:30:35 INFO - PROCESS | 3019 | Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49263/tests/dromaeo/cssquery-yui.html) 08:30:36 INFO - PROCESS | 3019 | RSS: Main: 213032960 08:30:36 INFO - PROCESS | 3019 | 08:33:38 INFO - PROCESS | 3019 | Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-yui.html (next: http://localhost:49263/tests/dromaeo/cssquery-dojo.html) 08:33:39 INFO - PROCESS | 3019 | RSS: Main: 257069056 08:33:39 INFO - PROCESS | 3019 | 08:33:39 INFO - PROCESS | 3019 | __start_tp_report 08:33:39 INFO - PROCESS | 3019 | _x_x_mozilla_page_load 08:33:39 INFO - PROCESS | 3019 | _x_x_mozilla_page_load_details 08:33:39 INFO - PROCESS | 3019 | |i|pagename|runs| 08:33:39 INFO - PROCESS | 3019 | |0;dojo.html;3301.9339613207735;3346.0463767826172;3370.8314584270797;3395.5925288965327;3407.028996735931;5497.532709719679;5497.972510137449;5506.146547285172;5531.19797629344;5532.806351777688;5516.613837031409;5531.032069387851;5547.278853749017;5548.140038294061;5563;4961.404631444214;5048.545630893219;5133.537981581657;5169.172932330828;5203.271541984125;4902.926456103161;5024.522670346311;5027.49725027498;5029.220470827009;5029.346184995946;5035.723035233061;5115.079285728568;5163.793448262084;5187.740612969336;5188.740562971855;5139.614528910328;5150.201718733602;5160.14857548504;5162.664426812264;5196.402413722432;4974.37820272466;4993.975030124826;5058.974705126488;5068.594512438996;5088.363954505687;5386.703731294777;5411.377691565481;5450.31871016123;5465.562754979592;5471.124620060771;5921.585489015771;5942.465178133989;5945.108233764927;5948.583599148062;5950.702464876739;5930.881382372371;5984.072468767348;6002.54980876436;6027.608205466675;6070.119832624245;5565.916511252334;5574.832755017356;5581.609287349887;5602.635828671123;5603.271574695264;5911.9113213301835;6094.756209751649;6122.326544080148;6135.6932153393045;6140.048292514667;5742.052561327418;5820.156077368758;5820.650760954356;5822.1266809978;5832.066869300891;5954.49386802118;5971.552133589998;5974.761009559569;5976.342602313742;5984.760609575568;5674.801381951612;5907.291125064934;5930.11048342752;5947.375525569752;5948.345681974979;5894.263217097863;5907.350191478934;5921.496672782776;5921.644701317935;5961.731722072517;4492.5507449255465;4512.075024619945;4533.591976722111;4534.2745160774775;4536.183486972377;3868.825902834379;4005.118873847749;4024.678025757932;4069.694772892045;4112.527059388209;5694.686792226385;5726.341470730919;5727.083666613322;5727.770889164387;5733.426657334233;5987.461128498456;6001.12983617373;6002.639841609517;6004.219451471368;6010.459058684739;5512.91730624041;5595.356533998561;5606.187102870061;5711.628744131701;5724.799632012943;4957.231629097496;4983.9252411213865;4986.027724593742;4986.675866068694;4994.32576602154;6049.274087109487;6051.576389652682;6053.939460605426;6055.455009049207;6058;5771.278590176228;5913.34953155144;6023.578349515492;6029.939700602938;6033.18551995475;6071.332153463204;6096.481799047131;6109.450149486567;6111.694415279129;6120.357362476876;5666.688332141772;5821.330546987151;5848.298204215522;5848.941510584839;5851.444112809277;5918.940810591839;5994.970025149846;5995.1906492624685;5996.280446346292;6039.305479869696;5832.650040997553;5845.1232315151365;5848.327442344185;5849.473547380756;5853.882922341444;5631.605787594829;5758.654480731169;5765.4811067004175;5806;5825.854353641193;5645.520130788929;5648.4633959773755;5653.321601407857;5655.547556195576;5686.573506987075;5746.971265143815;5748.856278593069;5754.856128596651;5761.683107429131;5764.711764411846;5501.504864562208;5636.4927156556105;5693.572982026448;5719.942800572107;5823.970880145742 08:33:39 INFO - PROCESS | 3019 | |1;ext.html;620.6400287833058;667.3860048755145;668.7525615522256;671.7044500419818;694.9895751563728;31945.68054319456;32357.51463728046;32518.187045323877;32575.1856203595;32578.348433031355;39807.800960995155;40077.19845603086;40247;40261.39607905884;40314.59685403145;8596.226339629447;8753.824923501526;8755.3433492488;8758.737237882873;8760.211580957712;8743.081976392483;8858.29133669305;8860.379773415863;8861.778455538632;8865.645374185026;8825.426347287437;8865.512396818172;8870.512121833297;8879.067697891725;8879.156480134377;9006.909930900705;9049.819003619956;9063.320250981169;9068.31987600926;9070.45577265363;9006.639734410615;9107.772305692344;9114.13415725505;9118.270538356915;9120.361574689774;43213.13573728539;43652.345214821806;43680.3447948281;43795.78102109501;43827;3869.941950870739;3919.902002449933;3937.074787424953;4002.8398864045403;4159.168166366739;33604.663953360396;33653.495197572054;34055.489167662505;34164.145896352544;34759.30481390384;4563.269876819693;4612.607928326062;4637.373954516164;4662.463816661059;4664.346991421204;308553;312360;312907;312932.4353378241;313656;59398.40601594015;59847.700761495915;59983;60189.69905150534;60203;67967.66016169888;68531;68599.65700171568;68678.65660671765;68681.65659171672;19186.520336991685;19372.837629742262;19379.90310048469;19404;19411.417657470298;15320.923395382952;15421.614459638598;15438.768418473732;15440.536783896501;15444;19499.805001950084;19518;19652.21391144367;19789.802101979083;20408.163265305895;7269.402560028749;7533.20901305366;7613.42899282556;7715.341201641674;7791.571463569445;1114.0363585498646;1153.2388623508612;1164.9708757281135;1189.8631657359515;1254.4292346982102;33502.83248583742;34085.31829363448;34102.82948585291;34132.14669633279;34317.14207144841;1209.0931801149138;1221.071985291185;1280.0911352939331;1294.8899343555715;1336.1048097774515;17906.28374864991;17909.910450447664;18033.368832091077;18142.45572632823;18247.817521824876;465459;467251;469842;470247;470567;61596.692016540524;62283.37716622867;62334;62440;62488;1460.488828909873;1520.475435974587;1535.9692806143814;1544.2896267716976;1583.8891277610687;29720.256993575334;30416.847915760278;30907.609157587514;31209;32778.344433111684;49336.75331623319;49472;49623;49750.25374619456;49809;292734;294800;294982;295062;295263;27093.322666933484;29821.85089074541;29875.253118672208;30227.09318720442;30308.090757277318;44039;44133.117337652424;44302.55697442984;44984;45130.54869451263;40285.194296113325;40302;40776;40847;41917.371239430824;39996.400053999794;40489.79755101324;40646.79676601598;40777.38833917553;41727.58272417237;41621.79189104035;41779;42075.36886946637;42143;42380;35109.47335789914;36751.26497470089;36905.81547092248;37081;37084;27995.580066298615;28479.715202847707;28602.14193574196;28625.713742862306;28642.427151457272 08:33:39 INFO - PROCESS | 3019 | |2;jquery.html;418.12611641668923;418.8439905859827;425.9637930775884;427.6279636716055;433.50580338414204;13993.650158746012;18644;19129.61740765184;19175.32886348976;20153.496162595944;15984.76022859658;17410;18469.53826154347;19092.23631054756;19205;5203.68777873327;5731.14032895067;5768.942310576883;5795.101759227306;5796.623219490741;5731.770729170828;5761.193432919374;5773.509251713609;5773.942260577403;5774.047282198432;4142.420061191436;5725.885482290351;6009.57932944694;6211.378862113797;6213.596116252452;6306.621602703853;6311.431971122621;6333.49332053437;6342.587731797418;6367.363263673618;5438.755256013449;5446.7276636168035;5456.91814622781;5468.398476167618;5568.220449137124;23021.654675179885;23368.415789605227;23802.523949521084;23853.761462385326;23947.281581552583;2520.4959008198434;2839.985800071007;3091.134482344947;3164.5095010273444;3231.450653388906;14593.635159121108;14686.853131468655;14736.115833049944;14791.40834366624;14819.851801482062;1999.8100180482832;2052;2053.240301088607;2122.395117391536;2126.696157118757;74340.88488672729;75811;75928.62035689842;75959;77100.61449692716;10246.53890574926;10358.482075896174;10506.894931050745;10529.262951593315;10693.83959240612;14491.637709057359;14515.85484145145;14518.927405363116;14531.200783956772;14585.489507867174;8664.740057798275;8827.470351778913;8867.955660221787;8892.955535222283;8924.107589241024;9060.54697265134;9104.499252541042;9142.908570914205;9233.492157931243;9263.53682315895;5954.642721436728;6363.204599425072;6599.1091202687985;6687.197536295578;6792.694328755218;1916.211911668519;1923.7883832778384;1927.5277556998626;1929.7394851695121;1993.4418362858423;1038.901304376083;1067.5729708116814;1068.871735391758;1084.815581351172;1141.686036340013;18253;18734.344297949778;18856.811431885504;18943.43169704911;19087.618247635248;1023.22746326523;1095.8465814785936;1144;1177.0465922602718;1220.1580909172642;8787.325166971174;10663.84004239937;10780.083692886192;10905.127589792797;11125.388103654215;502199;502965.36655850575;506161;524786;525689;90549;97625;98360;98481;100427;1106.4744246482855;1112.8497652816766;1123.0622430270816;1133.5465813674596;1138.476300901578;16881.831181688027;17060.74408883843;17076.402325918534;17194.570135746708;17232.827671723124;38365.84902452931;39060.80469597634;39439.2112157761;39486.21027579375;39693.80153099216;57732.13401798892;58736.412635873094;58824.41175588189;58985;59518.40481595129;8409.117042710428;8678.349123815613;8829.779255518664;8942.016378198263;8984.955075224581;12349.93825030869;13327.800082998569;13745.175289482662;13748.243846588533;13793.931030345186;11701.707457313294;11924.105692072955;11951.282923024646;12273.754524909631;12512.562060327844;11940.104492163297;11949.10381721357;12014.098942579167;12076.879231207575;12146.149769516049;12048.75902481963;12179.330136842558;12548.937255313665;12893.22640641527;13149.145305555108;8742.56287185651;8860.601272942604;8933.330000250136;8943.418677785923;8985.101489850962;9183.862242066241;12173.254324629914;12824.487020519075;12943.352832358156;13141.277229752455 08:33:39 INFO - PROCESS | 3019 | |3;mootools.html;1382.5230295548033;1562.0237351655217;1573.370651739304;1724.879258451908;1822.152698994968;7411.295926886951;8378;8507.872381914269;8511.191436813508;8513;8333.250007499324;8507.70223042192;8529.78675533112;8532.57337133144;8541.145885411455;2057.310800881706;2373.6439534069855;2393.44950661348;2398.0647547456506;2447.963280550793;2439.402346425128;2457.717362503317;2468.02513007362;2472.159465781634;2472.5054989002183;2397.0292031727176;2424.806015518763;2425.551273014498;2425.757424257578;2427.1383658801137;2050.2516581447812;2303.4471726785537;2345.5543446745064;2347.01425401331;2349.565330413879;2279.0541925101065;2291;2299.011425087212;2301.6777651128855;2349.5300939812105;8131.227533384319;8172.141925097839;8175.877361839577;8187.590620468953;8196.67213311467;5216.556592689626;5276.1030624793875;5323.148296272617;5323.361196656388;5381.2197231401615;3583.516225309602;3591.2637909228547;3633.65480279373;3641.4901913732097;3691.1325838427947;1121.545773961547;1145.747935454207;1170.6654413968083;1210.915235933485;1219.0735041368534;11919.165658403828;11941.820872686916;11986.520539178422;12000.279983201035;12004.279743215347;4742.891592461244;4769.427668679711;4804.73573953429;4826.686265392738;4861.197902346144;10260.58957641686;10275.7431064224;10284.588616455258;10287.639932602324;10292.485375731183;4715.905681886343;5397.082495975694;5452.700101494456;5453.10023846061;5471.972640136773;4305.182015417061;4305.590968857953;4898.363212782316;4975.626827987915;4994.800207991712;4113.71204015722;4131.049858532494;4197.685173611992;4207.789610519461;4230.957690423118;1326.8142460055599;1358.4498278197345;1366.364640442199;1369.6030049349806;1382.9723405532034;1081.3403823667556;1082.6373164989816;1086.0605576176551;1095.5015467962057;1100.1528822806395;5860.443257890493;5951.196588460589;5971.4028597140805;6030.728617212236;6141.815745527552;961.0293603460416;973.6835528453281;986.6842610364614;1011.6712068577594;1031.169908223887;4151.190517849051;4164.7709375984;4181.937270940938;4194.161167766459;4238.745675259433;10574.788504229873;11017.669469915916;11023;11077.446127693584;11096;10789.730256743644;10792.219283818082;10794.676159715222;10796.622118225981;10815.945920270347;8095.433319667567;8160.020797504338;8269.95865020671;8276.048254450694;8295.004599448104;6034.607750496204;6094.329623741473;6243.906341404791;6286.52851036165;6399.328070552711;9407;9459.621615135318;9776.120149186607;9784.217262619115;9806.705798826046;9765.511724413609;9838;9905;9996.500174991366;10018.448985305879;6777.932220677927;6929;7525.924740752523;8015.078265999485;8150.429469937285;8112.43212975086;8157.75526734199;8205.097439281555;8214.876776848232;8246.0929297776;7097.432205423657;7145.82135446618;7164.570125792469;7319.74380896666;7419.666115024945;7001.929980700128;7011.474139439664;7061;7075.5047146699235;7194.460415468756;6471.902921456088;6570.178727659043;6571.638559879061;6573.967130164318;6583;5005.174146265826;5107.336046313955;5128.640995130305;5145.279660847559;5174.301469301596;5006.098902197639;5026.321446604661;5054.317667114892;5078.136716758087;5262 08:33:39 INFO - PROCESS | 3019 | |4;prototype.html;362.78233060163905;364.813944888107;365.1546669460201;367.6599145790147;370.3833117858765;6225.315215326311;6256.593321434109;6257.874842503153;6271.623702577843;6281.80645677321;6219.657918814463;6233.594816336935;6242.406971337727;6243.375662433755;6247.37526247375;4635.351050852875;4694.483606803249;4747.786349614258;4752.714837109767;4767.5709186173235;4718.90562188756;4731.550502702238;4746.667733258673;4755.90488190236;4764.737939413331;4583.472900616439;4793.44875339337;4793.9520604794025;4799.160146974283;4808.206645903421;4668.649851261152;4759.666823322352;4788.473267940523;4792.0895029944195;4812.085703716282;4221.6833737469815;4222.59885310895;4223.324268117087;4226.894327641803;4240.300350442173;6015.789447369321;6020.6688632125215;6022.217111775485;6022.638641681513;6025.819225423201;5538.833834984957;5548.805791797267;5561.110222364443;5563.415841336642;5570.6657600544095;6426.710798014054;6549.279579246279;6552.967235163841;6555.704993275266;6557.704903279364;4657.930131048037;4663.160631086403;4670.369500117508;4675.550579320422;4687.695299805536;6793.150856142982;6835.008923706035;6838.384545390889;6858.725650973955;6913.654317284116;4781.043791241766;4784.043191361741;4785.808567657325;4788.138135135709;4789.137955168034;4841.685290456109;4845.176320025604;4850.223964165716;4850.587700045465;4853.102176097363;5542.778288868481;5546.362168350611;5549.223108764776;5553.972230138905;5555.083411237181;6436.034594810722;6562.934370656328;6596.86806263872;6605.801825945133;6615.735370585123;1665.5086749408954;1693.7459381092935;1698.6857431375236;1700.0904516084083;1702.3105642214923;1058.1323314881722;1134.3364131982883;1140.298716289476;1159.0611604600301;1167.3812879174052;6278.340774218733;6313.273973493016;6379.71291291893;6405.327440618761;6407.359264073555;6735.259121496631;6738.696758645872;6755.088063111515;6757.526973111835;6757.831054223684;6383.234011918599;6384.3934826191435;6386.584871983399;6392.872142557123;6398.552101352953;3600.42393217084;3638.7089032877307;3641.344557979536;3641.5083963665097;3643.5081264029545;6680.331966803281;6895.689693963784;6908.585484870823;6918.515703900679;6920.7231710731;6790.219124800711;6840.179178498612;6844.315568443116;6849.726010959605;6852.45180385568;6886.10480637514;6891.483138764513;6900.551464154814;6913.032175495435;6918.930810691829;6737.663116844236;6745.156855393076;6758.560693554903;6764.5603035802515;6813.080234168324;6541.738330466728;6610.867782644416;6750.122484077038;6771.153605799275;6780.966095169492;7018.368346848808;7039.859202815813;7040.788776336718;7043.225245223124;7061.2232654409;4651.720896746206;4696.530346965276;4705.717656940457;4718.056388722201;4718.197906355859;6889.483288753263;6924.376806087476;6938.132733408324;6938.27148149437;6948.5483443576;6499.447546958561;6627.668616569249;6688.431483323972;6689.732410703517;6709.93290067093;6624.701888414937;6632.270450250565;6640.402363787282;6652.534322597372;6660.367265109807;6522.184726909137;6535.967320163369;6543.247526534509;6545.410913017851;6551.115599394021;6678.165229346332;6697.933020669731;6708.530402871752;6709.7316107355155;6711.731530738716;6111.419415155553;6146.231721034871;6499.1876015498065;6528.543001989815;6532.093218517714 08:33:39 INFO - PROCESS | 3019 | |5;yui.html;815.1807433529303;914.323400683494;927.4528028463205;935.4948327902931;940.4404379394258;15385;15457.84542154578;15497.612559686013;15531.223438828056;15551.611209719762;13725.107867988574;13899.444022239099;14041.578752637437;14070.507532236348;14175.574732758034;723.1502983993812;730.7150211417552;736.517580984456;865.3942240431722;866.5970323799432;740.5852722475404;865.9610317535726;893.1515060692336;894.8791913091715;895.2345744388551;930.6370515498961;935.046252822121;935.1209862729047;935.2985261054209;935.9532023398837;753.3784627682129;926.0091701878993;929.061647735785;929.8791157149561;929.9581518831635;667.6227931218895;677.9830504237384;678.0845858091586;678.3115138134797;678.4165617568887;14751.483698070624;14779;14865;14872.62818429537;14874.776878346833;13776.24230667313;14931.477398291008;14973.550793476214;14987.250637468083;14995.700085998327;11780.823287650692;11796.764064718658;12039.27764334134;12235.143539952207;12404.25574465535;4057.736247143926;4064.085580744309;4164.895877603054;4166.812493437803;4215.325547912319;62555;62637.68681156565;63272.683636581525;63876.680616597085;64093;11911.70220744471;11913.22564033335;11969.820452693217;12054.97532709712;12255.142140050111;19678.311259106147;19982.800171998384;20005.699914501292;20030.69953950692;20034.59930801405;8825.823483530421;8913.643454261886;9025.954870225738;9115.544222788967;9337.579808908615;5018.573421259161;5104.489551044866;5110.28456016158;5186.870328241749;5293.708846013429;3647.6534729200685;3773.52830896138;3779.3008293465796;3779.6976241901134;3780.5085338906315;685.174364890306;692.1175501235964;700.352174238827;712.2770388056127;724.5290561135199;797.9082405523322;828.5401602110886;830.3647709502236;834.7287131682106;843.9578021098921;10296.948515257376;10371.325863818827;10374.636887709044;10480.109190718722;10524.789504210026;785.5640119733489;795.1491903663025;807.0879905706514;820.9835803283901;825.5211977053294;4720.103180395782;4744.264638980963;4754.595859351924;4888.926666100011;4956.4547899731;64028.67985660135;66756.6662166686;68320;68867.65566172237;71181.6440917792;56313.43686563082;56666;56690.43309566934;57362;58421.415785842444;51523.742381288605;52030.21954670683;52042.47957520452;52551.211731824056;52790.73604631952;10062.39625622465;10210.132138768287;10384.067572865595;10417.114545263737;10428.843567346345;37928.810355948044;39545.406818897165;40144;40209.39685904772;41066;45861.31208031949;46535;49351;49626.255606165214;49749.25376119433;12219.938900305442;12231.266124032587;12548.874511254771;12767.042471814466;13002.284874332003;13928.651783705489;13986.790198146833;14081.788773168206;14109.435622575393;14320.355583998537;13182.670433239246;13289.867101328862;13378.397972091474;13458.730825383242;14062.296885155905;13307.733845323233;13390;13781.104228225133;13810.93094534521;13896.305184740924;13153.60539183826;13183.670408239486;13269.800952985519;13359;13397.866021340053;10909.618163364245;10935.781284374427;11155.27490713101;11198.44007799623;11239.494222760159;10873.728156796144;10888.94555527249;10939;11047.171462140212;11069 08:33:39 INFO - PROCESS | 3019 | __end_tp_report 08:33:39 INFO - PROCESS | 3019 | __start_cc_report 08:33:39 INFO - PROCESS | 3019 | _x_x_mozilla_cycle_collect,831 08:33:39 INFO - PROCESS | 3019 | __end_cc_report 08:33:39 INFO - PROCESS | 3019 | __startTimestamp1464622419189__endTimestamp 08:33:39 INFO - PROCESS | 3019 | 08:33:39 INFO - PROCESS | 3019 | ------- Summary: start ------- 08:33:39 INFO - PROCESS | 3019 | Number of tests: 6 08:33:39 INFO - PROCESS | 3019 | 08:33:39 INFO - PROCESS | 3019 | [#0] dojo.html Cycles:165 Average:5514.03 Median:5724.80 stddev:610.07 (10.7%) stddev-sans-first:586.74 08:33:39 INFO - PROCESS | 3019 | Values: 3301.9 3346.0 3370.8 3395.6 3407.0 5497.5 5498.0 5506.1 5531.2 5532.8 5516.6 5531.0 5547.3 5548.1 5563.0 4961.4 5048.5 5133.5 5169.2 5203.3 4902.9 5024.5 5027.5 5029.2 5029.3 5035.7 5115.1 5163.8 5187.7 5188.7 5139.6 5150.2 5160.1 5162.7 5196.4 4974.4 4994.0 5059.0 5068.6 5088.4 5386.7 5411.4 5450.3 5465.6 5471.1 5921.6 5942.5 5945.1 5948.6 5950.7 5930.9 5984.1 6002.5 6027.6 6070.1 5565.9 5574.8 5581.6 5602.6 5603.3 5911.9 6094.8 6122.3 6135.7 6140.0 5742.1 5820.2 5820.7 5822.1 5832.1 5954.5 5971.6 5974.8 5976.3 5984.8 5674.8 5907.3 5930.1 5947.4 5948.3 5894.3 5907.4 5921.5 5921.6 5961.7 4492.6 4512.1 4533.6 4534.3 4536.2 3868.8 4005.1 4024.7 4069.7 4112.5 5694.7 5726.3 5727.1 5727.8 5733.4 5987.5 6001.1 6002.6 6004.2 6010.5 5512.9 5595.4 5606.2 5711.6 5724.8 4957.2 4983.9 4986.0 4986.7 4994.3 6049.3 6051.6 6053.9 6055.5 6058.0 5771.3 5913.3 6023.6 6029.9 6033.2 6071.3 6096.5 6109.5 6111.7 6120.4 5666.7 5821.3 5848.3 5848.9 5851.4 5918.9 5995.0 5995.2 5996.3 6039.3 5832.7 5845.1 5848.3 5849.5 5853.9 5631.6 5758.7 5765.5 5806.0 5825.9 5645.5 5648.5 5653.3 5655.5 5686.6 5747.0 5748.9 5754.9 5761.7 5764.7 5501.5 5636.5 5693.6 5719.9 5824.0 08:33:39 INFO - PROCESS | 3019 | 08:33:39 INFO - PROCESS | 3019 | [#1] ext.html Cycles:180 Average:53649.85 Median:40308.30 stddev:96674.72 (239.8%) stddev-sans-first:96863.93 08:33:39 INFO - PROCESS | 3019 | Values: 620.6 667.4 668.8 671.7 695.0 31945.7 32357.5 32518.2 32575.2 32578.3 39807.8 40077.2 40247.0 40261.4 40314.6 8596.2 8753.8 8755.3 8758.7 8760.2 8743.1 8858.3 8860.4 8861.8 8865.6 8825.4 8865.5 8870.5 8879.1 8879.2 9006.9 9049.8 9063.3 9068.3 9070.5 9006.6 9107.8 9114.1 9118.3 9120.4 43213.1 43652.3 43680.3 43795.8 43827.0 3869.9 3919.9 3937.1 4002.8 4159.2 33604.7 33653.5 34055.5 34164.1 34759.3 4563.3 4612.6 4637.4 4662.5 4664.3 308553.0 312360.0 312907.0 312932.4 313656.0 59398.4 59847.7 59983.0 60189.7 60203.0 67967.7 68531.0 68599.7 68678.7 68681.7 19186.5 19372.8 19379.9 19404.0 19411.4 15320.9 15421.6 15438.8 15440.5 15444.0 19499.8 19518.0 19652.2 19789.8 20408.2 7269.4 7533.2 7613.4 7715.3 7791.6 1114.0 1153.2 1165.0 1189.9 1254.4 33502.8 34085.3 34102.8 34132.1 34317.1 1209.1 1221.1 1280.1 1294.9 1336.1 17906.3 17909.9 18033.4 18142.5 18247.8 465459.0 467251.0 469842.0 470247.0 470567.0 61596.7 62283.4 62334.0 62440.0 62488.0 1460.5 1520.5 1536.0 1544.3 1583.9 29720.3 30416.8 30907.6 31209.0 32778.3 49336.8 49472.0 49623.0 49750.3 49809.0 292734.0 294800.0 294982.0 295062.0 295263.0 27093.3 29821.9 29875.3 30227.1 30308.1 44039.0 44133.1 44302.6 44984.0 45130.5 40285.2 40302.0 40776.0 40847.0 41917.4 39996.4 40489.8 40646.8 40777.4 41727.6 41621.8 41779.0 42075.4 42143.0 42380.0 35109.5 36751.3 36905.8 37081.0 37084.0 27995.6 28479.7 28602.1 28625.7 28642.4 08:33:39 INFO - PROCESS | 3019 | 08:33:39 INFO - PROCESS | 3019 | [#2] jquery.html Cycles:180 Average:29805.78 Median:23585.47 stddev:84340.90 (357.6%) stddev-sans-first:84548.64 08:33:39 INFO - PROCESS | 3019 | Values: 418.1 418.8 426.0 427.6 433.5 13993.7 18644.0 19129.6 19175.3 20153.5 15984.8 17410.0 18469.5 19092.2 19205.0 5203.7 5731.1 5768.9 5795.1 5796.6 5731.8 5761.2 5773.5 5773.9 5774.0 4142.4 5725.9 6009.6 6211.4 6213.6 6306.6 6311.4 6333.5 6342.6 6367.4 5438.8 5446.7 5456.9 5468.4 5568.2 23021.7 23368.4 23802.5 23853.8 23947.3 2520.5 2840.0 3091.1 3164.5 3231.5 14593.6 14686.9 14736.1 14791.4 14819.9 1999.8 2052.0 2053.2 2122.4 2126.7 74340.9 75811.0 75928.6 75959.0 77100.6 10246.5 10358.5 10506.9 10529.3 10693.8 14491.6 14515.9 14518.9 14531.2 14585.5 8664.7 8827.5 8868.0 8893.0 8924.1 9060.5 9104.5 9142.9 9233.5 9263.5 5954.6 6363.2 6599.1 6687.2 6792.7 1916.2 1923.8 1927.5 1929.7 1993.4 1038.9 1067.6 1068.9 1084.8 1141.7 18253.0 18734.3 18856.8 18943.4 19087.6 1023.2 1095.8 1144.0 1177.0 1220.2 8787.3 10663.8 10780.1 10905.1 11125.4 502199.0 502965.4 506161.0 524786.0 525689.0 90549.0 97625.0 98360.0 98481.0 100427.0 1106.5 1112.8 1123.1 1133.5 1138.5 16881.8 17060.7 17076.4 17194.6 17232.8 38365.8 39060.8 39439.2 39486.2 39693.8 57732.1 58736.4 58824.4 58985.0 59518.4 8409.1 8678.3 8829.8 8942.0 8985.0 12349.9 13327.8 13745.2 13748.2 13793.9 11701.7 11924.1 11951.3 12273.8 12512.6 11940.1 11949.1 12014.1 12076.9 12146.1 12048.8 12179.3 12548.9 12893.2 13149.1 8742.6 8860.6 8933.3 8943.4 8985.1 9183.9 12173.3 12824.5 12943.4 13141.3 08:33:39 INFO - PROCESS | 3019 | 08:33:39 INFO - PROCESS | 3019 | [#3] mootools.html Cycles:180 Average:5715.03 Median:4879.78 stddev:3155.84 (64.7%) stddev-sans-first:3147.89 08:33:39 INFO - PROCESS | 3019 | Values: 1382.5 1562.0 1573.4 1724.9 1822.2 7411.3 8378.0 8507.9 8511.2 8513.0 8333.3 8507.7 8529.8 8532.6 8541.1 2057.3 2373.6 2393.4 2398.1 2448.0 2439.4 2457.7 2468.0 2472.2 2472.5 2397.0 2424.8 2425.6 2425.8 2427.1 2050.3 2303.4 2345.6 2347.0 2349.6 2279.1 2291.0 2299.0 2301.7 2349.5 8131.2 8172.1 8175.9 8187.6 8196.7 5216.6 5276.1 5323.1 5323.4 5381.2 3583.5 3591.3 3633.7 3641.5 3691.1 1121.5 1145.7 1170.7 1210.9 1219.1 11919.2 11941.8 11986.5 12000.3 12004.3 4742.9 4769.4 4804.7 4826.7 4861.2 10260.6 10275.7 10284.6 10287.6 10292.5 4715.9 5397.1 5452.7 5453.1 5472.0 4305.2 4305.6 4898.4 4975.6 4994.8 4113.7 4131.0 4197.7 4207.8 4231.0 1326.8 1358.4 1366.4 1369.6 1383.0 1081.3 1082.6 1086.1 1095.5 1100.2 5860.4 5951.2 5971.4 6030.7 6141.8 961.0 973.7 986.7 1011.7 1031.2 4151.2 4164.8 4181.9 4194.2 4238.7 10574.8 11017.7 11023.0 11077.4 11096.0 10789.7 10792.2 10794.7 10796.6 10815.9 8095.4 8160.0 8270.0 8276.0 8295.0 6034.6 6094.3 6243.9 6286.5 6399.3 9407.0 9459.6 9776.1 9784.2 9806.7 9765.5 9838.0 9905.0 9996.5 10018.4 6777.9 6929.0 7525.9 8015.1 8150.4 8112.4 8157.8 8205.1 8214.9 8246.1 7097.4 7145.8 7164.6 7319.7 7419.7 7001.9 7011.5 7061.0 7075.5 7194.5 6471.9 6570.2 6571.6 6574.0 6583.0 5005.2 5107.3 5128.6 5145.3 5174.3 5006.1 5026.3 5054.3 5078.1 5262.0 08:33:39 INFO - PROCESS | 3019 | 08:33:39 INFO - PROCESS | 3019 | [#4] prototype.html Cycles:180 Average:5528.02 Median:6274.98 stddev:1646.51 (26.2%) stddev-sans-first:1604.84 08:33:39 INFO - PROCESS | 3019 | Values: 362.8 364.8 365.2 367.7 370.4 6225.3 6256.6 6257.9 6271.6 6281.8 6219.7 6233.6 6242.4 6243.4 6247.4 4635.4 4694.5 4747.8 4752.7 4767.6 4718.9 4731.6 4746.7 4755.9 4764.7 4583.5 4793.4 4794.0 4799.2 4808.2 4668.6 4759.7 4788.5 4792.1 4812.1 4221.7 4222.6 4223.3 4226.9 4240.3 6015.8 6020.7 6022.2 6022.6 6025.8 5538.8 5548.8 5561.1 5563.4 5570.7 6426.7 6549.3 6553.0 6555.7 6557.7 4657.9 4663.2 4670.4 4675.6 4687.7 6793.2 6835.0 6838.4 6858.7 6913.7 4781.0 4784.0 4785.8 4788.1 4789.1 4841.7 4845.2 4850.2 4850.6 4853.1 5542.8 5546.4 5549.2 5554.0 5555.1 6436.0 6562.9 6596.9 6605.8 6615.7 1665.5 1693.7 1698.7 1700.1 1702.3 1058.1 1134.3 1140.3 1159.1 1167.4 6278.3 6313.3 6379.7 6405.3 6407.4 6735.3 6738.7 6755.1 6757.5 6757.8 6383.2 6384.4 6386.6 6392.9 6398.6 3600.4 3638.7 3641.3 3641.5 3643.5 6680.3 6895.7 6908.6 6918.5 6920.7 6790.2 6840.2 6844.3 6849.7 6852.5 6886.1 6891.5 6900.6 6913.0 6918.9 6737.7 6745.2 6758.6 6764.6 6813.1 6541.7 6610.9 6750.1 6771.2 6781.0 7018.4 7039.9 7040.8 7043.2 7061.2 4651.7 4696.5 4705.7 4718.1 4718.2 6889.5 6924.4 6938.1 6938.3 6948.5 6499.4 6627.7 6688.4 6689.7 6709.9 6624.7 6632.3 6640.4 6652.5 6660.4 6522.2 6536.0 6543.2 6545.4 6551.1 6678.2 6697.9 6708.5 6709.7 6711.7 6111.4 6146.2 6499.2 6528.5 6532.1 08:33:39 INFO - PROCESS | 3019 | 08:33:39 INFO - PROCESS | 3019 | [#5] yui.html Cycles:180 Average:15986.31 Median:22565.04 stddev:18606.58 (82.5%) stddev-sans-first:18623.90 08:33:39 INFO - PROCESS | 3019 | Values: 815.2 914.3 927.5 935.5 940.4 15385.0 15457.8 15497.6 15531.2 15551.6 13725.1 13899.4 14041.6 14070.5 14175.6 723.2 730.7 736.5 865.4 866.6 740.6 866.0 893.2 894.9 895.2 930.6 935.0 935.1 935.3 936.0 753.4 926.0 929.1 929.9 930.0 667.6 678.0 678.1 678.3 678.4 14751.5 14779.0 14865.0 14872.6 14874.8 13776.2 14931.5 14973.6 14987.3 14995.7 11780.8 11796.8 12039.3 12235.1 12404.3 4057.7 4064.1 4164.9 4166.8 4215.3 62555.0 62637.7 63272.7 63876.7 64093.0 11911.7 11913.2 11969.8 12055.0 12255.1 19678.3 19982.8 20005.7 20030.7 20034.6 8825.8 8913.6 9026.0 9115.5 9337.6 5018.6 5104.5 5110.3 5186.9 5293.7 3647.7 3773.5 3779.3 3779.7 3780.5 685.2 692.1 700.4 712.3 724.5 797.9 828.5 830.4 834.7 844.0 10296.9 10371.3 10374.6 10480.1 10524.8 785.6 795.1 807.1 821.0 825.5 4720.1 4744.3 4754.6 4888.9 4956.5 64028.7 66756.7 68320.0 68867.7 71181.6 56313.4 56666.0 56690.4 57362.0 58421.4 51523.7 52030.2 52042.5 52551.2 52790.7 10062.4 10210.1 10384.1 10417.1 10428.8 37928.8 39545.4 40144.0 40209.4 41066.0 45861.3 46535.0 49351.0 49626.3 49749.3 12219.9 12231.3 12548.9 12767.0 13002.3 13928.7 13986.8 14081.8 14109.4 14320.4 13182.7 13289.9 13378.4 13458.7 14062.3 13307.7 13390.0 13781.1 13810.9 13896.3 13153.6 13183.7 13269.8 13359.0 13397.9 10909.6 10935.8 11155.3 11198.4 11239.5 10873.7 10888.9 10939.0 11047.2 11069.0 08:33:39 INFO - PROCESS | 3019 | -------- Summary: end -------- 08:33:39 INFO - PROCESS | 3019 | 08:33:39 INFO - TEST-INFO | 3019: exit 0 08:33:39 INFO - TEST-OK | dromaeo_css | took 1110991ms 08:33:39 INFO - TEST-START | kraken 08:33:39 INFO - operating with platform_type : linux_ 08:33:39 INFO - Initialising browser for kraken test... 08:33:39 INFO - TEST-INFO | started process 3208 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd2xhJG/profile http://localhost:49263/getInfo.html) 08:33:43 INFO - PROCESS | 3208 | __metrics Screen width/height:1600/1200 08:33:43 INFO - PROCESS | 3208 | colorDepth:24 08:33:43 INFO - PROCESS | 3208 | Browser inner width/height: 1024/697 08:33:43 INFO - PROCESS | 3208 | __metrics 08:33:44 ERROR - PROCESS | 3208 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:33:45 INFO - TEST-INFO | 3208: exit 0 08:33:45 INFO - Browser initialized. 08:33:45 INFO - Running cycle 1/1 for kraken test... 08:33:45 INFO - TEST-INFO | started process 3298 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd2xhJG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:33:57 INFO - PROCESS | 3298 | RSS: Main: 141885440 08:33:57 INFO - PROCESS | 3298 | 08:33:59 INFO - PROCESS | 3298 | Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49263/tests/kraken/driver.html?testName=audio-beat-detection) 08:34:00 INFO - PROCESS | 3298 | RSS: Main: 197029888 08:34:00 INFO - PROCESS | 3298 | 08:34:03 INFO - PROCESS | 3298 | Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49263/tests/kraken/driver.html?testName=audio-dft) 08:34:03 INFO - PROCESS | 3298 | RSS: Main: 180436992 08:34:03 INFO - PROCESS | 3298 | 08:34:06 INFO - PROCESS | 3298 | Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49263/tests/kraken/driver.html?testName=audio-fft) 08:34:07 INFO - PROCESS | 3298 | RSS: Main: 272207872 08:34:07 INFO - PROCESS | 3298 | 08:34:09 INFO - PROCESS | 3298 | Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49263/tests/kraken/driver.html?testName=audio-oscillator) 08:34:09 INFO - PROCESS | 3298 | RSS: Main: 177868800 08:34:09 INFO - PROCESS | 3298 | 08:34:11 INFO - PROCESS | 3298 | Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49263/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:34:12 INFO - PROCESS | 3298 | RSS: Main: 176390144 08:34:12 INFO - PROCESS | 3298 | 08:34:15 INFO - PROCESS | 3298 | Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49263/tests/kraken/driver.html?testName=imaging-darkroom) 08:34:16 INFO - PROCESS | 3298 | RSS: Main: 211210240 08:34:16 INFO - PROCESS | 3298 | 08:34:19 INFO - PROCESS | 3298 | Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49263/tests/kraken/driver.html?testName=imaging-desaturate) 08:34:19 INFO - PROCESS | 3298 | RSS: Main: 211607552 08:34:19 INFO - PROCESS | 3298 | 08:34:22 INFO - PROCESS | 3298 | Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49263/tests/kraken/driver.html?testName=json-parse-financial) 08:34:23 INFO - PROCESS | 3298 | RSS: Main: 212131840 08:34:23 INFO - PROCESS | 3298 | 08:34:24 INFO - PROCESS | 3298 | Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49263/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:34:25 INFO - PROCESS | 3298 | RSS: Main: 192053248 08:34:25 INFO - PROCESS | 3298 | 08:34:27 INFO - PROCESS | 3298 | Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:34:27 INFO - PROCESS | 3298 | RSS: Main: 196128768 08:34:27 INFO - PROCESS | 3298 | 08:34:29 INFO - PROCESS | 3298 | Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:34:30 INFO - PROCESS | 3298 | RSS: Main: 206884864 08:34:30 INFO - PROCESS | 3298 | 08:34:32 INFO - PROCESS | 3298 | Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:34:33 INFO - PROCESS | 3298 | RSS: Main: 212787200 08:34:33 INFO - PROCESS | 3298 | 08:34:35 INFO - PROCESS | 3298 | Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:34:36 INFO - PROCESS | 3298 | RSS: Main: 210116608 08:34:36 INFO - PROCESS | 3298 | 08:34:38 INFO - PROCESS | 3298 | Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49263/tests/kraken/driver.html?testName=ai-astar) 08:34:38 INFO - PROCESS | 3298 | RSS: Main: 274866176 08:34:38 INFO - PROCESS | 3298 | 08:34:38 INFO - PROCESS | 3298 | __start_tp_report 08:34:38 INFO - PROCESS | 3298 | _x_x_mozilla_page_load 08:34:38 INFO - PROCESS | 3298 | _x_x_mozilla_page_load_details 08:34:38 INFO - PROCESS | 3298 | |i|pagename|runs| 08:34:38 INFO - PROCESS | 3298 | |0;ai-astar;111;111;111;110;110;112;107;110;109;109 08:34:38 INFO - PROCESS | 3298 | |1;audio-beat-detection;159;133;153;180;132;160;159;133;183;127 08:34:38 INFO - PROCESS | 3298 | |2;audio-dft;161;161;161;160;161;161;161;166;161;158 08:34:38 INFO - PROCESS | 3298 | |3;audio-fft;75;76;76;170;76;76;77;77;162;77 08:34:38 INFO - PROCESS | 3298 | |4;audio-oscillator;91;91;157;92;92;92;152;92;92;152 08:34:38 INFO - PROCESS | 3298 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;116;117;117 08:34:38 INFO - PROCESS | 3298 | |6;imaging-darkroom;144;144;147;145;145;145;145;145;145;145 08:34:38 INFO - PROCESS | 3298 | |7;imaging-desaturate;94;94;95;94;94;95;95;95;94;94 08:34:38 INFO - PROCESS | 3298 | |8;json-parse-financial;54;53;55;52;54;54;54;72;54;53 08:34:38 INFO - PROCESS | 3298 | |9;json-stringify-tinderbox;59;62;59;59;60;60;59;60;59;60 08:34:38 INFO - PROCESS | 3298 | |10;stanford-crypto-aes;73;71;71;74;74;73;73;73;73;73 08:34:38 INFO - PROCESS | 3298 | |11;stanford-crypto-ccm;112;123;119;114;113;111;115;118;128;114 08:34:38 INFO - PROCESS | 3298 | |12;stanford-crypto-pbkdf2;157;157;160;161;159;160;164;165;162;172 08:34:38 INFO - PROCESS | 3298 | |13;stanford-crypto-sha256-iterative;70;69;69;67;66;66;67;66;68;66 08:34:38 INFO - PROCESS | 3298 | __end_tp_report 08:34:38 INFO - PROCESS | 3298 | __start_cc_report 08:34:38 INFO - PROCESS | 3298 | _x_x_mozilla_cycle_collect,1587 08:34:38 INFO - PROCESS | 3298 | __end_cc_report 08:34:38 INFO - PROCESS | 3298 | __startTimestamp1464622478503__endTimestamp 08:34:38 INFO - PROCESS | 3298 | 08:34:38 INFO - PROCESS | 3298 | ------- Summary: start ------- 08:34:38 INFO - PROCESS | 3298 | Number of tests: 14 08:34:38 INFO - PROCESS | 3298 | 08:34:38 INFO - PROCESS | 3298 | [#0] ai-astar Cycles:10 Average:110.00 Median:110.50 stddev:1.41 (1.3%) stddev-sans-first:1.45 08:34:38 INFO - PROCESS | 3298 | Values: 111.0 111.0 111.0 110.0 110.0 112.0 107.0 110.0 109.0 109.0 08:34:38 INFO - PROCESS | 3298 | 08:34:38 INFO - PROCESS | 3298 | [#1] audio-beat-detection Cycles:10 Average:151.90 Median:159.00 stddev:20.15 (12.7%) stddev-sans-first:21.21 08:34:38 INFO - PROCESS | 3298 | Values: 159.0 133.0 153.0 180.0 132.0 160.0 159.0 133.0 183.0 127.0 08:34:38 INFO - PROCESS | 3298 | 08:34:38 INFO - PROCESS | 3298 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:1.97 (1.2%) stddev-sans-first:2.09 08:34:38 INFO - PROCESS | 3298 | Values: 161.0 161.0 161.0 160.0 161.0 161.0 161.0 166.0 161.0 158.0 08:34:38 INFO - PROCESS | 3298 | 08:34:38 INFO - PROCESS | 3298 | [#3] audio-fft Cycles:10 Average:94.20 Median:76.00 stddev:37.89 (49.9%) stddev-sans-first:39.55 08:34:38 INFO - PROCESS | 3298 | Values: 75.0 76.0 76.0 170.0 76.0 76.0 77.0 77.0 162.0 77.0 08:34:38 INFO - PROCESS | 3298 | 08:34:38 INFO - PROCESS | 3298 | [#4] audio-oscillator Cycles:10 Average:110.30 Median:92.00 stddev:29.96 (32.6%) stddev-sans-first:30.95 08:34:38 INFO - PROCESS | 3298 | Values: 91.0 91.0 157.0 92.0 92.0 92.0 152.0 92.0 92.0 152.0 08:34:38 INFO - PROCESS | 3298 | 08:34:38 INFO - PROCESS | 3298 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:34:38 INFO - PROCESS | 3298 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 08:34:38 INFO - PROCESS | 3298 | 08:34:38 INFO - PROCESS | 3298 | [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 08:34:38 INFO - PROCESS | 3298 | Values: 144.0 144.0 147.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 08:34:38 INFO - PROCESS | 3298 | 08:34:38 INFO - PROCESS | 3298 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 08:34:38 INFO - PROCESS | 3298 | Values: 94.0 94.0 95.0 94.0 94.0 95.0 95.0 95.0 94.0 94.0 08:34:38 INFO - PROCESS | 3298 | 08:34:38 INFO - PROCESS | 3298 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:54.00 stddev:5.85 (10.8%) stddev-sans-first:6.18 08:34:38 INFO - PROCESS | 3298 | Values: 54.0 53.0 55.0 52.0 54.0 54.0 54.0 72.0 54.0 53.0 08:34:38 INFO - PROCESS | 3298 | 08:34:38 INFO - PROCESS | 3298 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:60.00 stddev:0.95 (1.6%) stddev-sans-first:0.97 08:34:38 INFO - PROCESS | 3298 | Values: 59.0 62.0 59.0 59.0 60.0 60.0 59.0 60.0 59.0 60.0 08:34:38 INFO - PROCESS | 3298 | 08:34:38 INFO - PROCESS | 3298 | [#10] stanford-crypto-aes Cycles:10 Average:72.80 Median:73.00 stddev:1.03 (1.4%) stddev-sans-first:1.09 08:34:38 INFO - PROCESS | 3298 | Values: 73.0 71.0 71.0 74.0 74.0 73.0 73.0 73.0 73.0 73.0 08:34:38 INFO - PROCESS | 3298 | 08:34:38 INFO - PROCESS | 3298 | [#11] stanford-crypto-ccm Cycles:10 Average:116.70 Median:116.50 stddev:5.38 (4.6%) stddev-sans-first:5.43 08:34:38 INFO - PROCESS | 3298 | Values: 112.0 123.0 119.0 114.0 113.0 111.0 115.0 118.0 128.0 114.0 08:34:38 INFO - PROCESS | 3298 | 08:34:38 INFO - PROCESS | 3298 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.70 Median:161.50 stddev:4.47 (2.8%) stddev-sans-first:4.41 08:34:38 INFO - PROCESS | 3298 | Values: 157.0 157.0 160.0 161.0 159.0 160.0 164.0 165.0 162.0 172.0 08:34:38 INFO - PROCESS | 3298 | 08:34:38 INFO - PROCESS | 3298 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.50 stddev:1.51 (2.2%) stddev-sans-first:1.27 08:34:38 INFO - PROCESS | 3298 | Values: 70.0 69.0 69.0 67.0 66.0 66.0 67.0 66.0 68.0 66.0 08:34:38 INFO - PROCESS | 3298 | -------- Summary: end -------- 08:34:38 INFO - PROCESS | 3298 | 08:34:39 INFO - TEST-INFO | 3298: exit 0 08:34:39 INFO - TEST-OK | kraken | took 59588ms 08:34:39 INFO - SUITE-END | took 1170s 08:34:39 INFO - Completed test suite (00:19:30) 08:34:39 INFO - javascript benchmark 08:34:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3301.9339613207735, 3346.0463767826172, 3370.8314584270797, 3395.5925288965327, 3407.028996735931, 5497.532709719679, 5497.972510137449, 5506.146547285172, 5531.19797629344, 5532.806351777688, 5516.613837031409, 5531.032069387851, 5547.278853749017, 5548.140038294061, 5563.0, 4961.404631444214, 5048.545630893219, 5133.537981581657, 5169.172932330828, 5203.271541984125, 4902.926456103161, 5024.522670346311, 5027.49725027498, 5029.220470827009, 5029.346184995946, 5035.723035233061, 5115.079285728568, 5163.793448262084, 5187.740612969336, 5188.740562971855, 5139.614528910328, 5150.201718733602, 5160.14857548504, 5162.664426812264, 5196.402413722432, 4974.37820272466, 4993.975030124826, 5058.974705126488, 5068.594512438996, 5088.363954505687, 5386.703731294777, 5411.377691565481, 5450.31871016123, 5465.562754979592, 5471.124620060771, 5921.585489015771, 5942.465178133989, 5945.108233764927, 5948.583599148062, 5950.702464876739, 5930.881382372371, 5984.072468767348, 6002.54980876436, 6027.608205466675, 6070.119832624245, 5565.916511252334, 5574.832755017356, 5581.609287349887, 5602.635828671123, 5603.271574695264, 5911.9113213301835, 6094.756209751649, 6122.326544080148, 6135.6932153393045, 6140.048292514667, 5742.052561327418, 5820.156077368758, 5820.650760954356, 5822.1266809978, 5832.066869300891, 5954.49386802118, 5971.552133589998, 5974.761009559569, 5976.342602313742, 5984.760609575568, 5674.801381951612, 5907.291125064934, 5930.11048342752, 5947.375525569752, 5948.345681974979, 5894.263217097863, 5907.350191478934, 5921.496672782776, 5921.644701317935, 5961.731722072517, 4492.5507449255465, 4512.075024619945, 4533.591976722111, 4534.2745160774775, 4536.183486972377, 3868.825902834379, 4005.118873847749, 4024.678025757932, 4069.694772892045, 4112.527059388209, 5694.686792226385, 5726.341470730919, 5727.083666613322, 5727.770889164387, 5733.426657334233, 5987.461128498456, 6001.12983617373, 6002.639841609517, 6004.219451471368, 6010.459058684739, 5512.91730624041, 5595.356533998561, 5606.187102870061, 5711.628744131701, 5724.799632012943, 4957.231629097496, 4983.9252411213865, 4986.027724593742, 4986.675866068694, 4994.32576602154, 6049.274087109487, 6051.576389652682, 6053.939460605426, 6055.455009049207, 6058.0, 5771.278590176228, 5913.34953155144, 6023.578349515492, 6029.939700602938, 6033.18551995475, 6071.332153463204, 6096.481799047131, 6109.450149486567, 6111.694415279129, 6120.357362476876, 5666.688332141772, 5821.330546987151, 5848.298204215522, 5848.941510584839, 5851.444112809277, 5918.940810591839, 5994.970025149846, 5995.1906492624685, 5996.280446346292, 6039.305479869696, 5832.650040997553, 5845.1232315151365, 5848.327442344185, 5849.473547380756, 5853.882922341444, 5631.605787594829, 5758.654480731169, 5765.4811067004175, 5806.0, 5825.854353641193, 5645.520130788929, 5648.4633959773755, 5653.321601407857, 5655.547556195576, 5686.573506987075, 5746.971265143815, 5748.856278593069, 5754.856128596651, 5761.683107429131, 5764.711764411846, 5501.504864562208, 5636.4927156556105, 5693.572982026448, 5719.942800572107, 5823.970880145742], "value": 5474.618848447155, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [620.6400287833058, 667.3860048755145, 668.7525615522256, 671.7044500419818, 694.9895751563728, 31945.68054319456, 32357.51463728046, 32518.187045323877, 32575.1856203595, 32578.348433031355, 39807.800960995155, 40077.19845603086, 40247.0, 40261.39607905884, 40314.59685403145, 8596.226339629447, 8753.824923501526, 8755.3433492488, 8758.737237882873, 8760.211580957712, 8743.081976392483, 8858.29133669305, 8860.379773415863, 8861.778455538632, 8865.645374185026, 8825.426347287437, 8865.512396818172, 8870.512121833297, 8879.067697891725, 8879.156480134377, 9006.909930900705, 9049.819003619956, 9063.320250981169, 9068.31987600926, 9070.45577265363, 9006.639734410615, 9107.772305692344, 9114.13415725505, 9118.270538356915, 9120.361574689774, 43213.13573728539, 43652.345214821806, 43680.3447948281, 43795.78102109501, 43827.0, 3869.941950870739, 3919.902002449933, 3937.074787424953, 4002.8398864045403, 4159.168166366739, 33604.663953360396, 33653.495197572054, 34055.489167662505, 34164.145896352544, 34759.30481390384, 4563.269876819693, 4612.607928326062, 4637.373954516164, 4662.463816661059, 4664.346991421204, 308553.0, 312360.0, 312907.0, 312932.4353378241, 313656.0, 59398.40601594015, 59847.700761495915, 59983.0, 60189.69905150534, 60203.0, 67967.66016169888, 68531.0, 68599.65700171568, 68678.65660671765, 68681.65659171672, 19186.520336991685, 19372.837629742262, 19379.90310048469, 19404.0, 19411.417657470298, 15320.923395382952, 15421.614459638598, 15438.768418473732, 15440.536783896501, 15444.0, 19499.805001950084, 19518.0, 19652.21391144367, 19789.802101979083, 20408.163265305895, 7269.402560028749, 7533.20901305366, 7613.42899282556, 7715.341201641674, 7791.571463569445, 1114.0363585498646, 1153.2388623508612, 1164.9708757281135, 1189.8631657359515, 1254.4292346982102, 33502.83248583742, 34085.31829363448, 34102.82948585291, 34132.14669633279, 34317.14207144841, 1209.0931801149138, 1221.071985291185, 1280.0911352939331, 1294.8899343555715, 1336.1048097774515, 17906.28374864991, 17909.910450447664, 18033.368832091077, 18142.45572632823, 18247.817521824876, 465459.0, 467251.0, 469842.0, 470247.0, 470567.0, 61596.692016540524, 62283.37716622867, 62334.0, 62440.0, 62488.0, 1460.488828909873, 1520.475435974587, 1535.9692806143814, 1544.2896267716976, 1583.8891277610687, 29720.256993575334, 30416.847915760278, 30907.609157587514, 31209.0, 32778.344433111684, 49336.75331623319, 49472.0, 49623.0, 49750.25374619456, 49809.0, 292734.0, 294800.0, 294982.0, 295062.0, 295263.0, 27093.322666933484, 29821.85089074541, 29875.253118672208, 30227.09318720442, 30308.090757277318, 44039.0, 44133.117337652424, 44302.55697442984, 44984.0, 45130.54869451263, 40285.194296113325, 40302.0, 40776.0, 40847.0, 41917.371239430824, 39996.400053999794, 40489.79755101324, 40646.79676601598, 40777.38833917553, 41727.58272417237, 41621.79189104035, 41779.0, 42075.36886946637, 42143.0, 42380.0, 35109.47335789914, 36751.26497470089, 36905.81547092248, 37081.0, 37084.0, 27995.580066298615, 28479.715202847707, 28602.14193574196, 28625.713742862306, 28642.427151457272], "value": 20378.531408488565, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.12611641668923, 418.8439905859827, 425.9637930775884, 427.6279636716055, 433.50580338414204, 13993.650158746012, 18644.0, 19129.61740765184, 19175.32886348976, 20153.496162595944, 15984.76022859658, 17410.0, 18469.53826154347, 19092.23631054756, 19205.0, 5203.68777873327, 5731.14032895067, 5768.942310576883, 5795.101759227306, 5796.623219490741, 5731.770729170828, 5761.193432919374, 5773.509251713609, 5773.942260577403, 5774.047282198432, 4142.420061191436, 5725.885482290351, 6009.57932944694, 6211.378862113797, 6213.596116252452, 6306.621602703853, 6311.431971122621, 6333.49332053437, 6342.587731797418, 6367.363263673618, 5438.755256013449, 5446.7276636168035, 5456.91814622781, 5468.398476167618, 5568.220449137124, 23021.654675179885, 23368.415789605227, 23802.523949521084, 23853.761462385326, 23947.281581552583, 2520.4959008198434, 2839.985800071007, 3091.134482344947, 3164.5095010273444, 3231.450653388906, 14593.635159121108, 14686.853131468655, 14736.115833049944, 14791.40834366624, 14819.851801482062, 1999.8100180482832, 2052.0, 2053.240301088607, 2122.395117391536, 2126.696157118757, 74340.88488672729, 75811.0, 75928.62035689842, 75959.0, 77100.61449692716, 10246.53890574926, 10358.482075896174, 10506.894931050745, 10529.262951593315, 10693.83959240612, 14491.637709057359, 14515.85484145145, 14518.927405363116, 14531.200783956772, 14585.489507867174, 8664.740057798275, 8827.470351778913, 8867.955660221787, 8892.955535222283, 8924.107589241024, 9060.54697265134, 9104.499252541042, 9142.908570914205, 9233.492157931243, 9263.53682315895, 5954.642721436728, 6363.204599425072, 6599.1091202687985, 6687.197536295578, 6792.694328755218, 1916.211911668519, 1923.7883832778384, 1927.5277556998626, 1929.7394851695121, 1993.4418362858423, 1038.901304376083, 1067.5729708116814, 1068.871735391758, 1084.815581351172, 1141.686036340013, 18253.0, 18734.344297949778, 18856.811431885504, 18943.43169704911, 19087.618247635248, 1023.22746326523, 1095.8465814785936, 1144.0, 1177.0465922602718, 1220.1580909172642, 8787.325166971174, 10663.84004239937, 10780.083692886192, 10905.127589792797, 11125.388103654215, 502199.0, 502965.36655850575, 506161.0, 524786.0, 525689.0, 90549.0, 97625.0, 98360.0, 98481.0, 100427.0, 1106.4744246482855, 1112.8497652816766, 1123.0622430270816, 1133.5465813674596, 1138.476300901578, 16881.831181688027, 17060.74408883843, 17076.402325918534, 17194.570135746708, 17232.827671723124, 38365.84902452931, 39060.80469597634, 39439.2112157761, 39486.21027579375, 39693.80153099216, 57732.13401798892, 58736.412635873094, 58824.41175588189, 58985.0, 59518.40481595129, 8409.117042710428, 8678.349123815613, 8829.779255518664, 8942.016378198263, 8984.955075224581, 12349.93825030869, 13327.800082998569, 13745.175289482662, 13748.243846588533, 13793.931030345186, 11701.707457313294, 11924.105692072955, 11951.282923024646, 12273.754524909631, 12512.562060327844, 11940.104492163297, 11949.10381721357, 12014.098942579167, 12076.879231207575, 12146.149769516049, 12048.75902481963, 12179.330136842558, 12548.937255313665, 12893.22640641527, 13149.145305555108, 8742.56287185651, 8860.601272942604, 8933.330000250136, 8943.418677785923, 8985.101489850962, 9183.862242066241, 12173.254324629914, 12824.487020519075, 12943.352832358156, 13141.277229752455], "value": 9645.407571817525, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1382.5230295548033, 1562.0237351655217, 1573.370651739304, 1724.879258451908, 1822.152698994968, 7411.295926886951, 8378.0, 8507.872381914269, 8511.191436813508, 8513.0, 8333.250007499324, 8507.70223042192, 8529.78675533112, 8532.57337133144, 8541.145885411455, 2057.310800881706, 2373.6439534069855, 2393.44950661348, 2398.0647547456506, 2447.963280550793, 2439.402346425128, 2457.717362503317, 2468.02513007362, 2472.159465781634, 2472.5054989002183, 2397.0292031727176, 2424.806015518763, 2425.551273014498, 2425.757424257578, 2427.1383658801137, 2050.2516581447812, 2303.4471726785537, 2345.5543446745064, 2347.01425401331, 2349.565330413879, 2279.0541925101065, 2291.0, 2299.011425087212, 2301.6777651128855, 2349.5300939812105, 8131.227533384319, 8172.141925097839, 8175.877361839577, 8187.590620468953, 8196.67213311467, 5216.556592689626, 5276.1030624793875, 5323.148296272617, 5323.361196656388, 5381.2197231401615, 3583.516225309602, 3591.2637909228547, 3633.65480279373, 3641.4901913732097, 3691.1325838427947, 1121.545773961547, 1145.747935454207, 1170.6654413968083, 1210.915235933485, 1219.0735041368534, 11919.165658403828, 11941.820872686916, 11986.520539178422, 12000.279983201035, 12004.279743215347, 4742.891592461244, 4769.427668679711, 4804.73573953429, 4826.686265392738, 4861.197902346144, 10260.58957641686, 10275.7431064224, 10284.588616455258, 10287.639932602324, 10292.485375731183, 4715.905681886343, 5397.082495975694, 5452.700101494456, 5453.10023846061, 5471.972640136773, 4305.182015417061, 4305.590968857953, 4898.363212782316, 4975.626827987915, 4994.800207991712, 4113.71204015722, 4131.049858532494, 4197.685173611992, 4207.789610519461, 4230.957690423118, 1326.8142460055599, 1358.4498278197345, 1366.364640442199, 1369.6030049349806, 1382.9723405532034, 1081.3403823667556, 1082.6373164989816, 1086.0605576176551, 1095.5015467962057, 1100.1528822806395, 5860.443257890493, 5951.196588460589, 5971.4028597140805, 6030.728617212236, 6141.815745527552, 961.0293603460416, 973.6835528453281, 986.6842610364614, 1011.6712068577594, 1031.169908223887, 4151.190517849051, 4164.7709375984, 4181.937270940938, 4194.161167766459, 4238.745675259433, 10574.788504229873, 11017.669469915916, 11023.0, 11077.446127693584, 11096.0, 10789.730256743644, 10792.219283818082, 10794.676159715222, 10796.622118225981, 10815.945920270347, 8095.433319667567, 8160.020797504338, 8269.95865020671, 8276.048254450694, 8295.004599448104, 6034.607750496204, 6094.329623741473, 6243.906341404791, 6286.52851036165, 6399.328070552711, 9407.0, 9459.621615135318, 9776.120149186607, 9784.217262619115, 9806.705798826046, 9765.511724413609, 9838.0, 9905.0, 9996.500174991366, 10018.448985305879, 6777.932220677927, 6929.0, 7525.924740752523, 8015.078265999485, 8150.429469937285, 8112.43212975086, 8157.75526734199, 8205.097439281555, 8214.876776848232, 8246.0929297776, 7097.432205423657, 7145.82135446618, 7164.570125792469, 7319.74380896666, 7419.666115024945, 7001.929980700128, 7011.474139439664, 7061.0, 7075.5047146699235, 7194.460415468756, 6471.902921456088, 6570.178727659043, 6571.638559879061, 6573.967130164318, 6583.0, 5005.174146265826, 5107.336046313955, 5128.640995130305, 5145.279660847559, 5174.301469301596, 5006.098902197639, 5026.321446604661, 5054.317667114892, 5078.136716758087, 5262.0], "value": 4649.871448676843, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.78233060163905, 364.813944888107, 365.1546669460201, 367.6599145790147, 370.3833117858765, 6225.315215326311, 6256.593321434109, 6257.874842503153, 6271.623702577843, 6281.80645677321, 6219.657918814463, 6233.594816336935, 6242.406971337727, 6243.375662433755, 6247.37526247375, 4635.351050852875, 4694.483606803249, 4747.786349614258, 4752.714837109767, 4767.5709186173235, 4718.90562188756, 4731.550502702238, 4746.667733258673, 4755.90488190236, 4764.737939413331, 4583.472900616439, 4793.44875339337, 4793.9520604794025, 4799.160146974283, 4808.206645903421, 4668.649851261152, 4759.666823322352, 4788.473267940523, 4792.0895029944195, 4812.085703716282, 4221.6833737469815, 4222.59885310895, 4223.324268117087, 4226.894327641803, 4240.300350442173, 6015.789447369321, 6020.6688632125215, 6022.217111775485, 6022.638641681513, 6025.819225423201, 5538.833834984957, 5548.805791797267, 5561.110222364443, 5563.415841336642, 5570.6657600544095, 6426.710798014054, 6549.279579246279, 6552.967235163841, 6555.704993275266, 6557.704903279364, 4657.930131048037, 4663.160631086403, 4670.369500117508, 4675.550579320422, 4687.695299805536, 6793.150856142982, 6835.008923706035, 6838.384545390889, 6858.725650973955, 6913.654317284116, 4781.043791241766, 4784.043191361741, 4785.808567657325, 4788.138135135709, 4789.137955168034, 4841.685290456109, 4845.176320025604, 4850.223964165716, 4850.587700045465, 4853.102176097363, 5542.778288868481, 5546.362168350611, 5549.223108764776, 5553.972230138905, 5555.083411237181, 6436.034594810722, 6562.934370656328, 6596.86806263872, 6605.801825945133, 6615.735370585123, 1665.5086749408954, 1693.7459381092935, 1698.6857431375236, 1700.0904516084083, 1702.3105642214923, 1058.1323314881722, 1134.3364131982883, 1140.298716289476, 1159.0611604600301, 1167.3812879174052, 6278.340774218733, 6313.273973493016, 6379.71291291893, 6405.327440618761, 6407.359264073555, 6735.259121496631, 6738.696758645872, 6755.088063111515, 6757.526973111835, 6757.831054223684, 6383.234011918599, 6384.3934826191435, 6386.584871983399, 6392.872142557123, 6398.552101352953, 3600.42393217084, 3638.7089032877307, 3641.344557979536, 3641.5083963665097, 3643.5081264029545, 6680.331966803281, 6895.689693963784, 6908.585484870823, 6918.515703900679, 6920.7231710731, 6790.219124800711, 6840.179178498612, 6844.315568443116, 6849.726010959605, 6852.45180385568, 6886.10480637514, 6891.483138764513, 6900.551464154814, 6913.032175495435, 6918.930810691829, 6737.663116844236, 6745.156855393076, 6758.560693554903, 6764.5603035802515, 6813.080234168324, 6541.738330466728, 6610.867782644416, 6750.122484077038, 6771.153605799275, 6780.966095169492, 7018.368346848808, 7039.859202815813, 7040.788776336718, 7043.225245223124, 7061.2232654409, 4651.720896746206, 4696.530346965276, 4705.717656940457, 4718.056388722201, 4718.197906355859, 6889.483288753263, 6924.376806087476, 6938.132733408324, 6938.27148149437, 6948.5483443576, 6499.447546958561, 6627.668616569249, 6688.431483323972, 6689.732410703517, 6709.93290067093, 6624.701888414937, 6632.270450250565, 6640.402363787282, 6652.534322597372, 6660.367265109807, 6522.184726909137, 6535.967320163369, 6543.247526534509, 6545.410913017851, 6551.115599394021, 6678.165229346332, 6697.933020669731, 6708.530402871752, 6709.7316107355155, 6711.731530738716, 6111.419415155553, 6146.231721034871, 6499.1876015498065, 6528.543001989815, 6532.093218517714], "value": 4997.587490129646, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [815.1807433529303, 914.323400683494, 927.4528028463205, 935.4948327902931, 940.4404379394258, 15385.0, 15457.84542154578, 15497.612559686013, 15531.223438828056, 15551.611209719762, 13725.107867988574, 13899.444022239099, 14041.578752637437, 14070.507532236348, 14175.574732758034, 723.1502983993812, 730.7150211417552, 736.517580984456, 865.3942240431722, 866.5970323799432, 740.5852722475404, 865.9610317535726, 893.1515060692336, 894.8791913091715, 895.2345744388551, 930.6370515498961, 935.046252822121, 935.1209862729047, 935.2985261054209, 935.9532023398837, 753.3784627682129, 926.0091701878993, 929.061647735785, 929.8791157149561, 929.9581518831635, 667.6227931218895, 677.9830504237384, 678.0845858091586, 678.3115138134797, 678.4165617568887, 14751.483698070624, 14779.0, 14865.0, 14872.62818429537, 14874.776878346833, 13776.24230667313, 14931.477398291008, 14973.550793476214, 14987.250637468083, 14995.700085998327, 11780.823287650692, 11796.764064718658, 12039.27764334134, 12235.143539952207, 12404.25574465535, 4057.736247143926, 4064.085580744309, 4164.895877603054, 4166.812493437803, 4215.325547912319, 62555.0, 62637.68681156565, 63272.683636581525, 63876.680616597085, 64093.0, 11911.70220744471, 11913.22564033335, 11969.820452693217, 12054.97532709712, 12255.142140050111, 19678.311259106147, 19982.800171998384, 20005.699914501292, 20030.69953950692, 20034.59930801405, 8825.823483530421, 8913.643454261886, 9025.954870225738, 9115.544222788967, 9337.579808908615, 5018.573421259161, 5104.489551044866, 5110.28456016158, 5186.870328241749, 5293.708846013429, 3647.6534729200685, 3773.52830896138, 3779.3008293465796, 3779.6976241901134, 3780.5085338906315, 685.174364890306, 692.1175501235964, 700.352174238827, 712.2770388056127, 724.5290561135199, 797.9082405523322, 828.5401602110886, 830.3647709502236, 834.7287131682106, 843.9578021098921, 10296.948515257376, 10371.325863818827, 10374.636887709044, 10480.109190718722, 10524.789504210026, 785.5640119733489, 795.1491903663025, 807.0879905706514, 820.9835803283901, 825.5211977053294, 4720.103180395782, 4744.264638980963, 4754.595859351924, 4888.926666100011, 4956.4547899731, 64028.67985660135, 66756.6662166686, 68320.0, 68867.65566172237, 71181.6440917792, 56313.43686563082, 56666.0, 56690.43309566934, 57362.0, 58421.415785842444, 51523.742381288605, 52030.21954670683, 52042.47957520452, 52551.211731824056, 52790.73604631952, 10062.39625622465, 10210.132138768287, 10384.067572865595, 10417.114545263737, 10428.843567346345, 37928.810355948044, 39545.406818897165, 40144.0, 40209.39685904772, 41066.0, 45861.31208031949, 46535.0, 49351.0, 49626.255606165214, 49749.25376119433, 12219.938900305442, 12231.266124032587, 12548.874511254771, 12767.042471814466, 13002.284874332003, 13928.651783705489, 13986.790198146833, 14081.788773168206, 14109.435622575393, 14320.355583998537, 13182.670433239246, 13289.867101328862, 13378.397972091474, 13458.730825383242, 14062.296885155905, 13307.733845323233, 13390.0, 13781.104228225133, 13810.93094534521, 13896.305184740924, 13153.60539183826, 13183.670408239486, 13269.800952985519, 13359.0, 13397.866021340053, 10909.618163364245, 10935.781284374427, 11155.27490713101, 11198.44007799623, 11239.494222760159, 10873.728156796144, 10888.94555527249, 10939.0, 11047.171462140212, 11069.0], "value": 7275.937868425175, "unit": "score"}], "name": "dromaeo_css", "value": 7527.70970800224, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 111.0, 110.0, 110.0, 112.0, 107.0, 110.0, 109.0, 109.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 133.0, 153.0, 180.0, 132.0, 160.0, 159.0, 133.0, 183.0, 127.0], "value": 151.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 160.0, 161.0, 161.0, 161.0, 166.0, 161.0, 158.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 170.0, 76.0, 76.0, 77.0, 77.0, 162.0, 77.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 157.0, 92.0, 92.0, 92.0, 152.0, 92.0, 92.0, 152.0], "value": 110.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 144.0, 147.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 145.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 55.0, 52.0, 54.0, 54.0, 54.0, 72.0, 54.0, 53.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 62.0, 59.0, 59.0, 60.0, 60.0, 59.0, 60.0, 59.0, 60.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 71.0, 71.0, 74.0, 74.0, 73.0, 73.0, 73.0, 73.0, 73.0], "value": 72.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 123.0, 119.0, 114.0, 113.0, 111.0, 115.0, 118.0, 128.0, 114.0], "value": 116.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 157.0, 160.0, 161.0, 159.0, 160.0, 164.0, 165.0, 162.0, 172.0], "value": 161.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 69.0, 67.0, 66.0, 66.0, 67.0, 66.0, 68.0, 66.0], "value": 67.4, "unit": "score"}], "name": "kraken", "value": 1517.5, "alertThreshold": 2.0}]} 08:34:39 INFO - Return code: 0 08:34:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:34:39 ERROR - # TBPL SUCCESS # 08:34:39 INFO - Running post-action listener: _resource_record_post_action 08:34:39 INFO - Running post-run listener: _resource_record_post_run 08:34:40 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 266240; Write bytes: 500637696; Read time: 32; Write time: 422732 08:34:40 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248733696; Read time: 0; Write time: 281276 08:34:40 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 266240; Write bytes: 251305984; Read time: 32; Write time: 141456 08:34:40 INFO - Running post-run listener: _upload_blobber_files 08:34:40 INFO - Blob upload gear active. 08:34:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:34:40 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 08:34:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:34:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:34:41 INFO - (blobuploader) - INFO - Open directory for files ... 08:34:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:34:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:34:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:34:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:34:42 INFO - (blobuploader) - INFO - Done attempting. 08:34:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:34:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:34:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:34:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:34:42 INFO - (blobuploader) - INFO - Done attempting. 08:34:42 INFO - (blobuploader) - INFO - Iteration through files over. 08:34:42 INFO - Return code: 0 08:34:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:34:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:34:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0280bd9ea2aea3917117c8f1cbec08babbe3c061560a106ecbc2a3524e10ad1b51c6ec5250f977d402d4fc241ec125474482a81d23f5cb8114dad6c308f4407c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f449895e2c9ec88284bb4db096fb50175c285d0cbe9120a3cf5403c36545d72daee02b5b488a9466bdb267d63cb5678a28597fe383e0f069d44b31e5e4a4ec63"} 08:34:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:34:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:34:42 INFO - Contents: 08:34:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0280bd9ea2aea3917117c8f1cbec08babbe3c061560a106ecbc2a3524e10ad1b51c6ec5250f977d402d4fc241ec125474482a81d23f5cb8114dad6c308f4407c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f449895e2c9ec88284bb4db096fb50175c285d0cbe9120a3cf5403c36545d72daee02b5b488a9466bdb267d63cb5678a28597fe383e0f069d44b31e5e4a4ec63"} 08:34:42 INFO - Running post-run listener: copy_logs_to_upload_dir 08:34:42 INFO - Copying logs to upload dir... 08:34:42 INFO - mkdir: /builds/slave/test/build/upload/logs 08:34:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.855660 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-05-30 08:34:42.706350) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 08:34:42.712222) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1464621254.736960-1844116046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0280bd9ea2aea3917117c8f1cbec08babbe3c061560a106ecbc2a3524e10ad1b51c6ec5250f977d402d4fc241ec125474482a81d23f5cb8114dad6c308f4407c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f449895e2c9ec88284bb4db096fb50175c285d0cbe9120a3cf5403c36545d72daee02b5b488a9466bdb267d63cb5678a28597fe383e0f069d44b31e5e4a4ec63"} build_url:https://queue.taskcluster.net/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011427 build_url: 'https://queue.taskcluster.net/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0280bd9ea2aea3917117c8f1cbec08babbe3c061560a106ecbc2a3524e10ad1b51c6ec5250f977d402d4fc241ec125474482a81d23f5cb8114dad6c308f4407c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f449895e2c9ec88284bb4db096fb50175c285d0cbe9120a3cf5403c36545d72daee02b5b488a9466bdb267d63cb5678a28597fe383e0f069d44b31e5e4a4ec63"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 08:34:42.741361) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:34:42.741729) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1464621254.736960-1844116046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004566 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:34:42.825371) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 08:34:42.825735) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 08:34:42.826020) ========= ========= Total master_lag: 0.17 =========