builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-015 starttime: 1460992047.7 results: success (0) buildid: 20160418030305 builduid: 77bf842e77b14c10a37b789d99c2991a revision: 1f16d3da9280e40ada252acf8110b91ee1edbb08 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 08:07:27.701014) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 08:07:27.701920) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 08:07:27.702243) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 08:07:27.717495) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 08:07:27.717883) ========= 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=20e666a3d4cfbb71505a330e000001b4-1460990935.338468-70303664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-18 08:07:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-04-18 08:07:28 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112878 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 08:07:27.845796) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 08:07:27.846235) ========= 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=20e666a3d4cfbb71505a330e000001b4-1460990935.338468-70303664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016964 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 08:07:27.896467) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 08:07:27.896897) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1f16d3da9280e40ada252acf8110b91ee1edbb08 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 1f16d3da9280e40ada252acf8110b91ee1edbb08 --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=20e666a3d4cfbb71505a330e000001b4-1460990935.338468-70303664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-18 08:07:28,302 truncating revision to first 12 chars 2016-04-18 08:07:28,302 Setting DEBUG logging. 2016-04-18 08:07:28,302 attempt 1/10 2016-04-18 08:07:28,303 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1f16d3da9280?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-18 08:07:28,657 unpacking tar archive at: mozilla-central-1f16d3da9280/testing/mozharness/ program finished with exit code 0 elapsedTime=0.615237 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 08:07:28.527568) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 08:07:28.528171) ========= script_repo_revision: 1f16d3da9280e40ada252acf8110b91ee1edbb08 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 08:07:28.528929) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 08:07:28.529452) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 08:07:28.540353) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-04-18 08:07:28.541034) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=20e666a3d4cfbb71505a330e000001b4-1460990935.338468-70303664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:07:29 INFO - MultiFileLogger online at 20160418 08:07:29 in /builds/slave/test 08:07:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:07:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:07:29 INFO - {'append_to_log': False, 08:07:29 INFO - 'base_work_dir': '/builds/slave/test', 08:07:29 INFO - 'blob_upload_branch': 'Firefox', 08:07:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:07:29 INFO - 'branch': 'Firefox', 08:07:29 INFO - 'buildbot_json_path': 'buildprops.json', 08:07:29 INFO - 'config_files': ('talos/linux_config.py',), 08:07:29 INFO - 'default_actions': ('clobber', 08:07:29 INFO - 'read-buildbot-config', 08:07:29 INFO - 'download-and-extract', 08:07:29 INFO - 'populate-webroot', 08:07:29 INFO - 'create-virtualenv', 08:07:29 INFO - 'install', 08:07:29 INFO - 'run-tests'), 08:07:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:07:29 INFO - 'download_minidump_stackwalk': True, 08:07:29 INFO - 'download_symbols': 'ondemand', 08:07:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:07:29 INFO - 'tooltool.py': '/tools/tooltool.py', 08:07:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:07:29 INFO - '/tools/misc-python/virtualenv.py')}, 08:07:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:07:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:07:29 INFO - 'installer_path': 'installer.exe', 08:07:29 INFO - 'log_level': 'info', 08:07:29 INFO - 'log_name': 'talos', 08:07:29 INFO - 'log_to_console': True, 08:07:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:07:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:07:29 INFO - 'opt_config_files': (), 08:07:29 INFO - 'pip_index': False, 08:07:29 INFO - 'sps_profile': False, 08:07:29 INFO - 'sps_profile_interval': 0, 08:07:29 INFO - 'suite': 'dromaeojs', 08:07:29 INFO - 'system_bits': '32', 08:07:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:07:29 INFO - 'title': 'talos-linux64-ix-015', 08:07:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:07:29 INFO - 'use_talos_json': True, 08:07:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:07:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:07:29 INFO - 'work_dir': 'build'} 08:07:29 INFO - ##### 08:07:29 INFO - ##### Running clobber step. 08:07:29 INFO - ##### 08:07:29 INFO - Running pre-action listener: _resource_record_pre_action 08:07:29 INFO - Running main action method: clobber 08:07:29 INFO - rmtree: /builds/slave/test/build 08:07:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:07:30 INFO - Running post-action listener: _resource_record_post_action 08:07:30 INFO - ##### 08:07:30 INFO - ##### Running read-buildbot-config step. 08:07:30 INFO - ##### 08:07:30 INFO - Running pre-action listener: _resource_record_pre_action 08:07:30 INFO - Running main action method: read_buildbot_config 08:07:30 INFO - Using buildbot properties: 08:07:30 INFO - { 08:07:30 INFO - "project": "", 08:07:30 INFO - "product": "firefox", 08:07:30 INFO - "script_repo_revision": "production", 08:07:30 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:07:30 INFO - "repository": "", 08:07:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 08:07:30 INFO - "buildid": "20160418030305", 08:07:30 INFO - "stage_platform": "linux64-pgo", 08:07:30 INFO - "basedir": "/builds/slave/test", 08:07:30 INFO - "nightly_build": "True", 08:07:30 INFO - "buildnumber": 406, 08:07:30 INFO - "slavename": "talos-linux64-ix-015", 08:07:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:07:30 INFO - "platform": "ubuntu64_hw", 08:07:30 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 08:07:30 INFO - "branch": "mozilla-central", 08:07:30 INFO - "repo_path": "mozilla-central", 08:07:30 INFO - "revision": "1f16d3da9280e40ada252acf8110b91ee1edbb08", 08:07:30 INFO - "pgo_build": "True", 08:07:30 INFO - "builduid": "77bf842e77b14c10a37b789d99c2991a", 08:07:30 INFO - "slavebuilddir": "test" 08:07:30 INFO - } 08:07:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 08:07:30 INFO - Running post-action listener: _resource_record_post_action 08:07:30 INFO - ##### 08:07:30 INFO - ##### Running download-and-extract step. 08:07:30 INFO - ##### 08:07:30 INFO - Running pre-action listener: _resource_record_pre_action 08:07:30 INFO - Running main action method: download_and_extract 08:07:30 INFO - mkdir: /builds/slave/test/build/tests 08:07: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:07:30 INFO - https://queue.taskcluster.net/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:07:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:07:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:07:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:07:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:07:31 INFO - Downloaded 1361 bytes. 08:07:31 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:07:31 INFO - Using the following test package requirements: 08:07:31 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:07:31 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:31 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:07:31 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:31 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:07:31 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:31 INFO - u'jsshell-linux-x86_64.zip'], 08:07:31 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:31 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:07:31 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:07:31 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:31 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:07:31 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:31 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:07:31 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:31 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:07:31 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:31 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:07:31 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:31 INFO - https://queue.taskcluster.net/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:07:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:07:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:07:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:07:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:07:32 INFO - Downloaded 23774931 bytes. 08:07:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:07:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:07:33 INFO - Return code: 0 08:07:33 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:07: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:07:33 INFO - https://queue.taskcluster.net/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:07:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:07:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:07:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:07:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:07:35 INFO - Downloaded 23774931 bytes. 08:07:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:07:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:07:36 INFO - Return code: 0 08:07:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:36 INFO - https://queue.taskcluster.net/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:07:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:07:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:07:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:07:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:07:37 INFO - Downloaded 10841076 bytes. 08:07:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:07:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:07:37 INFO - Return code: 0 08:07:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:37 INFO - https://queue.taskcluster.net/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:07:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:07:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:07:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:07:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:07:39 INFO - Downloaded 58220647 bytes. 08:07:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:07:39 INFO - mkdir: /builds/slave/test/properties 08:07:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:07:39 INFO - Writing to file /builds/slave/test/properties/build_url 08:07:39 INFO - Contents: 08:07:39 INFO - build_url:https://queue.taskcluster.net/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:07:40 INFO - Running post-action listener: _resource_record_post_action 08:07:40 INFO - Running post-action listener: set_extra_try_arguments 08:07:40 INFO - ##### 08:07:40 INFO - ##### Running populate-webroot step. 08:07:40 INFO - ##### 08:07:40 INFO - Running pre-action listener: _resource_record_pre_action 08:07:40 INFO - Running main action method: populate_webroot 08:07:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:07:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:07:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:07:40 INFO - '--tppagecycles', 08:07:40 INFO - '7'], 08:07:40 INFO - 'tests': ['tsvgm']}}, 08:07:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:07:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:07:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:07:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:07:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:07:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:07:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:40 INFO - 'talos_options': ['--disable-e10s'], 08:07:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:07:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:07:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:40 INFO - 'talos_options': ['--disable-e10s'], 08:07:40 INFO - 'tests': ['damp', 'tps']}, 08:07:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:40 INFO - 'tests': ['damp', 'tps']}, 08:07:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:07:40 INFO - 'tests': ['dromaeo_dom']}, 08:07:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:07:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:07:40 INFO - 'tests': ['a11yr', 08:07:40 INFO - 'ts_paint', 08:07:40 INFO - 'tpaint', 08:07:40 INFO - 'sessionrestore', 08:07:40 INFO - 'sessionrestore_no_auto_restore', 08:07:40 INFO - 'tabpaint']}, 08:07:40 INFO - 'other-e10s': {'tests': ['a11yr', 08:07:40 INFO - 'ts_paint', 08:07:40 INFO - 'tpaint', 08:07:40 INFO - 'sessionrestore', 08:07:40 INFO - 'sessionrestore_no_auto_restore', 08:07:40 INFO - 'tabpaint']}, 08:07:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:07:40 INFO - 'ts_paint', 08:07:40 INFO - 'tpaint', 08:07:40 INFO - 'sessionrestore', 08:07:40 INFO - 'sessionrestore_no_auto_restore', 08:07:40 INFO - 'tabpaint']}, 08:07:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:07:40 INFO - 'ts_paint', 08:07:40 INFO - 'tpaint', 08:07:40 INFO - 'sessionrestore', 08:07:40 INFO - 'sessionrestore_no_auto_restore', 08:07:40 INFO - 'tabpaint']}, 08:07:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:07:40 INFO - 'tests': ['a11yr', 08:07:40 INFO - 'ts_paint', 08:07:40 INFO - 'tpaint', 08:07:40 INFO - 'sessionrestore', 08:07:40 INFO - 'sessionrestore_no_auto_restore', 08:07:40 INFO - 'tabpaint']}, 08:07:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:07:40 INFO - 'tests': ['a11yr', 08:07:40 INFO - 'ts_paint', 08:07:40 INFO - 'tpaint', 08:07:40 INFO - 'sessionrestore', 08:07:40 INFO - 'sessionrestore_no_auto_restore', 08:07:40 INFO - 'tabpaint']}, 08:07:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:07:40 INFO - 'tests': ['tsvgx', 08:07:40 INFO - 'tsvgr_opacity', 08:07:40 INFO - 'tart', 08:07:40 INFO - 'tscrollx', 08:07:40 INFO - 'cart']}, 08:07:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:07:40 INFO - 'tsvgr_opacity', 08:07:40 INFO - 'tart', 08:07:40 INFO - 'tscrollx', 08:07:40 INFO - 'cart']}, 08:07:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:40 INFO - 'talos_options': ['--disable-e10s'], 08:07:40 INFO - 'tests': ['tp5o']}, 08:07:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:40 INFO - 'tests': ['tp5o']}, 08:07:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:40 INFO - 'talos_options': ['--disable-e10s', 08:07:40 INFO - '--xperf_path', 08:07:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:07:40 INFO - 'tests': ['tp5n']}, 08:07:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:40 INFO - 'talos_options': ['--xperf_path', 08:07:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:07:40 INFO - 'tests': ['tp5n']}}, 08:07:40 INFO - 'talos.zip': {'path': '', 08:07:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:07:40 INFO - Running post-action listener: _resource_record_post_action 08:07:40 INFO - ##### 08:07:40 INFO - ##### Running create-virtualenv step. 08:07:40 INFO - ##### 08:07:40 INFO - Running pre-action listener: _resource_record_pre_action 08:07:40 INFO - Running main action method: create_virtualenv 08:07:40 INFO - Creating virtualenv /builds/slave/test/build/venv 08:07:40 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:07:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:07:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:07:40 INFO - Using real prefix '/usr' 08:07:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:07:41 INFO - Installing distribute.............................................................................................................................................................................................done. 08:07:43 INFO - Installing pip.................done. 08:07:43 INFO - Return code: 0 08:07:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:07:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:43 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 0x7f2484fe0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10239a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2810>, '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 0x10b3710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3ba0>, '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': '20e666a3d4cfbb71505a330e000001b4-1460990935.338468-70303664', '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:07:43 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:07:43 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:07:43 INFO - Using env: {'DISPLAY': ':0', 08:07:43 INFO - 'HOME': '/home/cltbld', 08:07:43 INFO - 'LANG': 'en_US.UTF-8', 08:07:43 INFO - 'LANGUAGE': 'en_US:en', 08:07:43 INFO - 'LOGNAME': 'cltbld', 08:07:43 INFO - 'MAIL': '/var/mail/cltbld', 08:07:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:43 INFO - 'MOZ_NO_REMOTE': '1', 08:07:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:43 INFO - 'NO_EM_RESTART': '1', 08:07:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:43 INFO - 'PWD': '/builds/slave/test', 08:07:43 INFO - 'SHELL': '/bin/bash', 08:07:43 INFO - 'SHLVL': '1', 08:07:43 INFO - 'TERM': 'linux', 08:07:43 INFO - 'TMOUT': '86400', 08:07:43 INFO - 'USER': 'cltbld', 08:07:43 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1460990935.338468-70303664', 08:07:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:43 INFO - '_': '/tools/buildbot/bin/python'} 08:07:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:43 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:07:43 INFO - Cleaning up... 08:07:43 INFO - Return code: 0 08:07:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:07:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:43 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 0x7f2484fe0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10239a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2810>, '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 0x10b3710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3ba0>, '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': '20e666a3d4cfbb71505a330e000001b4-1460990935.338468-70303664', '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:07:43 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:07:43 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:07:43 INFO - Using env: {'DISPLAY': ':0', 08:07:43 INFO - 'HOME': '/home/cltbld', 08:07:43 INFO - 'LANG': 'en_US.UTF-8', 08:07:43 INFO - 'LANGUAGE': 'en_US:en', 08:07:43 INFO - 'LOGNAME': 'cltbld', 08:07:43 INFO - 'MAIL': '/var/mail/cltbld', 08:07:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:43 INFO - 'MOZ_NO_REMOTE': '1', 08:07:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:43 INFO - 'NO_EM_RESTART': '1', 08:07:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:43 INFO - 'PWD': '/builds/slave/test', 08:07:43 INFO - 'SHELL': '/bin/bash', 08:07:43 INFO - 'SHLVL': '1', 08:07:43 INFO - 'TERM': 'linux', 08:07:43 INFO - 'TMOUT': '86400', 08:07:43 INFO - 'USER': 'cltbld', 08:07:43 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1460990935.338468-70303664', 08:07:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:43 INFO - '_': '/tools/buildbot/bin/python'} 08:07:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:43 INFO - Downloading/unpacking psutil>=0.7.1 08:07: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:07: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:07: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:07: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:07: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:07: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:07:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:07:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:07:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:07:45 INFO - Installing collected packages: psutil 08:07:45 INFO - Running setup.py install for psutil 08:07:45 INFO - building 'psutil._psutil_linux' extension 08:07:45 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:07:45 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:07:45 INFO - building 'psutil._psutil_posix' extension 08:07:45 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:07:46 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:07:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:07:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:07:46 INFO - Successfully installed psutil 08:07:46 INFO - Cleaning up... 08:07:46 INFO - Return code: 0 08:07:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:07: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:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07: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:07:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07: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', '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 0x7f2484fe0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10239a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2810>, '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 0x10b3710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3ba0>, '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': '20e666a3d4cfbb71505a330e000001b4-1460990935.338468-70303664', '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:07: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:07: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 mozsystemmonitor==0.0.0 08:07:46 INFO - Using env: {'DISPLAY': ':0', 08:07:46 INFO - 'HOME': '/home/cltbld', 08:07:46 INFO - 'LANG': 'en_US.UTF-8', 08:07:46 INFO - 'LANGUAGE': 'en_US:en', 08:07:46 INFO - 'LOGNAME': 'cltbld', 08:07:46 INFO - 'MAIL': '/var/mail/cltbld', 08:07:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:46 INFO - 'MOZ_NO_REMOTE': '1', 08:07:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:46 INFO - 'NO_EM_RESTART': '1', 08:07:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:46 INFO - 'PWD': '/builds/slave/test', 08:07:46 INFO - 'SHELL': '/bin/bash', 08:07:46 INFO - 'SHLVL': '1', 08:07:46 INFO - 'TERM': 'linux', 08:07:46 INFO - 'TMOUT': '86400', 08:07:46 INFO - 'USER': 'cltbld', 08:07:46 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1460990935.338468-70303664', 08:07:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:46 INFO - '_': '/tools/buildbot/bin/python'} 08:07:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:07: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:07: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:07: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:07: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:07: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:07: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:07:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:07:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:07:48 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:07:48 INFO - Installing collected packages: mozsystemmonitor 08:07:48 INFO - Running setup.py install for mozsystemmonitor 08:07:48 INFO - Successfully installed mozsystemmonitor 08:07:48 INFO - Cleaning up... 08:07:48 INFO - Return code: 0 08:07:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:07: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:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07: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:07:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07: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', '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 0x7f2484fe0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10239a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2810>, '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 0x10b3710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3ba0>, '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': '20e666a3d4cfbb71505a330e000001b4-1460990935.338468-70303664', '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:07: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:07: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 blobuploader==1.2.4 08:07:48 INFO - Using env: {'DISPLAY': ':0', 08:07:48 INFO - 'HOME': '/home/cltbld', 08:07:48 INFO - 'LANG': 'en_US.UTF-8', 08:07:48 INFO - 'LANGUAGE': 'en_US:en', 08:07:48 INFO - 'LOGNAME': 'cltbld', 08:07:48 INFO - 'MAIL': '/var/mail/cltbld', 08:07:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:48 INFO - 'MOZ_NO_REMOTE': '1', 08:07:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:48 INFO - 'NO_EM_RESTART': '1', 08:07:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:48 INFO - 'PWD': '/builds/slave/test', 08:07:48 INFO - 'SHELL': '/bin/bash', 08:07:48 INFO - 'SHLVL': '1', 08:07:48 INFO - 'TERM': 'linux', 08:07:48 INFO - 'TMOUT': '86400', 08:07:48 INFO - 'USER': 'cltbld', 08:07:48 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1460990935.338468-70303664', 08:07:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:48 INFO - '_': '/tools/buildbot/bin/python'} 08:07:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:48 INFO - Downloading/unpacking blobuploader==1.2.4 08:07: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:07: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:07: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:07: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:07: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:07: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:07:50 INFO - Downloading blobuploader-1.2.4.tar.gz 08:07:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:07:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:07: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:07: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:07: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:07: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:07: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:07: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:07:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:07:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:07: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:07: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:07: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:07: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:07: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:07: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:07:51 INFO - Downloading docopt-0.6.1.tar.gz 08:07:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:07:51 INFO - Installing collected packages: blobuploader, requests, docopt 08:07:51 INFO - Running setup.py install for blobuploader 08:07:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:07:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:07:51 INFO - Running setup.py install for requests 08:07:51 INFO - Running setup.py install for docopt 08:07:51 INFO - Successfully installed blobuploader requests docopt 08:07:51 INFO - Cleaning up... 08:07:51 INFO - Return code: 0 08:07:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:51 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 0x7f2484fe0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10239a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2810>, '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 0x10b3710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3ba0>, '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': '20e666a3d4cfbb71505a330e000001b4-1460990935.338468-70303664', '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:07:51 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:07:51 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:07:51 INFO - Using env: {'DISPLAY': ':0', 08:07:51 INFO - 'HOME': '/home/cltbld', 08:07:51 INFO - 'LANG': 'en_US.UTF-8', 08:07:51 INFO - 'LANGUAGE': 'en_US:en', 08:07:51 INFO - 'LOGNAME': 'cltbld', 08:07:51 INFO - 'MAIL': '/var/mail/cltbld', 08:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:51 INFO - 'MOZ_NO_REMOTE': '1', 08:07:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:51 INFO - 'NO_EM_RESTART': '1', 08:07:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:51 INFO - 'PWD': '/builds/slave/test', 08:07:51 INFO - 'SHELL': '/bin/bash', 08:07:51 INFO - 'SHLVL': '1', 08:07:51 INFO - 'TERM': 'linux', 08:07:51 INFO - 'TMOUT': '86400', 08:07:51 INFO - 'USER': 'cltbld', 08:07:51 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1460990935.338468-70303664', 08:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:51 INFO - '_': '/tools/buildbot/bin/python'} 08:07:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:07:52 INFO - Running setup.py (path:/tmp/pip-76I2DV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:07:52 INFO - Running setup.py (path:/tmp/pip-UWYcat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:07:52 INFO - Running setup.py (path:/tmp/pip-Pf16A3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:07:52 INFO - Running setup.py (path:/tmp/pip-GIr5jA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:07:52 INFO - Running setup.py (path:/tmp/pip-IsiBY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:07:52 INFO - Running setup.py (path:/tmp/pip-jPlzWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:07:52 INFO - Running setup.py (path:/tmp/pip-6KcY3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:07:52 INFO - Running setup.py (path:/tmp/pip-2RmbXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:07:52 INFO - Running setup.py (path:/tmp/pip-3dMSmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:07:52 INFO - Running setup.py (path:/tmp/pip-rcieyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:07:52 INFO - Running setup.py (path:/tmp/pip-YB_f01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:07:52 INFO - Running setup.py (path:/tmp/pip-z5wSpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:07:53 INFO - Running setup.py (path:/tmp/pip-inJBC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:07:53 INFO - Running setup.py (path:/tmp/pip-uQDMoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:07:53 INFO - Running setup.py (path:/tmp/pip-bRDFOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:07:53 INFO - Running setup.py (path:/tmp/pip-7ORKLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:07:53 INFO - Running setup.py (path:/tmp/pip-vsmX9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:07:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:07:53 INFO - Running setup.py install for manifestparser 08:07:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:07:53 INFO - Running setup.py install for mozcrash 08:07:53 INFO - Running setup.py install for mozdebug 08:07:53 INFO - Running setup.py install for mozdevice 08:07:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:07:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:07:53 INFO - Running setup.py install for mozfile 08:07:53 INFO - Running setup.py install for mozhttpd 08:07:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:07:54 INFO - Running setup.py install for mozinfo 08:07:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:07:54 INFO - Running setup.py install for mozInstall 08:07:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:07:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:07:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:07:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:07:54 INFO - Running setup.py install for mozleak 08:07:54 INFO - Running setup.py install for mozlog 08:07:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:07:54 INFO - Running setup.py install for moznetwork 08:07:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:07:54 INFO - Running setup.py install for mozprocess 08:07:54 INFO - Running setup.py install for mozprofile 08:07:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:07:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:07:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:07:54 INFO - Running setup.py install for mozrunner 08:07:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:07:54 INFO - Running setup.py install for mozscreenshot 08:07:54 INFO - Running setup.py install for moztest 08:07:55 INFO - Running setup.py install for mozversion 08:07:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:07:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:07:55 INFO - Cleaning up... 08:07:55 INFO - Return code: 0 08:07:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:55 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 0x7f2484fe0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10239a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2810>, '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 0x10b3710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3ba0>, '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': '20e666a3d4cfbb71505a330e000001b4-1460990935.338468-70303664', '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:07:55 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:07:55 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:07:55 INFO - Using env: {'DISPLAY': ':0', 08:07:55 INFO - 'HOME': '/home/cltbld', 08:07:55 INFO - 'LANG': 'en_US.UTF-8', 08:07:55 INFO - 'LANGUAGE': 'en_US:en', 08:07:55 INFO - 'LOGNAME': 'cltbld', 08:07:55 INFO - 'MAIL': '/var/mail/cltbld', 08:07:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:55 INFO - 'MOZ_NO_REMOTE': '1', 08:07:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:55 INFO - 'NO_EM_RESTART': '1', 08:07:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:55 INFO - 'PWD': '/builds/slave/test', 08:07:55 INFO - 'SHELL': '/bin/bash', 08:07:55 INFO - 'SHLVL': '1', 08:07:55 INFO - 'TERM': 'linux', 08:07:55 INFO - 'TMOUT': '86400', 08:07:55 INFO - 'USER': 'cltbld', 08:07:55 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1460990935.338468-70303664', 08:07:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:55 INFO - '_': '/tools/buildbot/bin/python'} 08:07:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:07:55 INFO - Running setup.py (path:/tmp/pip-SHc9rD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:07:55 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:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:07:55 INFO - Running setup.py (path:/tmp/pip-0a7xCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:07:55 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:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:07:55 INFO - Running setup.py (path:/tmp/pip-QtEtra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:07:55 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:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:07:55 INFO - Running setup.py (path:/tmp/pip-rj6Z6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:07:55 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:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:07:55 INFO - Running setup.py (path:/tmp/pip-Bw_kN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:07:55 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:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:07:55 INFO - Running setup.py (path:/tmp/pip-42aJDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:07:55 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:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:07:55 INFO - Running setup.py (path:/tmp/pip-KaAXKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:07:55 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:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:07:55 INFO - Running setup.py (path:/tmp/pip-gMwTjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:07:55 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:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:07:55 INFO - Running setup.py (path:/tmp/pip-_Zp9HZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:07:56 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:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:07:56 INFO - Running setup.py (path:/tmp/pip-lmlN8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:07:56 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:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:07:56 INFO - Running setup.py (path:/tmp/pip-dXyHBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:07:56 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:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:07:56 INFO - Running setup.py (path:/tmp/pip-YH273t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:07:56 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:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:07:56 INFO - Running setup.py (path:/tmp/pip-W492pl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:07:56 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:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:07:56 INFO - Running setup.py (path:/tmp/pip-T81yNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:07:56 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:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:07:56 INFO - Running setup.py (path:/tmp/pip-EYoMiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:07:56 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:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:07:56 INFO - Running setup.py (path:/tmp/pip-Z4fDTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:07:56 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:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:07:56 INFO - Running setup.py (path:/tmp/pip-3UIYkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:07:56 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:07:56 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:07:56 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:07:56 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:07:56 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:07:56 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:07:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:07:56 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:07:56 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:07:56 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:07:56 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:07:56 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:07:56 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:07:58 INFO - Downloading blessings-1.6.tar.gz 08:07:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:07:58 INFO - Installing collected packages: blessings 08:07:58 INFO - Running setup.py install for blessings 08:07:58 INFO - Successfully installed blessings 08:07:58 INFO - Cleaning up... 08:07:58 INFO - Return code: 0 08:07:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:07:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:07:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:07:58 INFO - Reading from file tmpfile_stdout 08:07:58 INFO - Current package versions: 08:07:58 INFO - argparse == 1.2.1 08:07:58 INFO - blessings == 1.6 08:07:58 INFO - blobuploader == 1.2.4 08:07:58 INFO - docopt == 0.6.1 08:07:58 INFO - manifestparser == 1.1 08:07:58 INFO - mozInstall == 1.12 08:07:58 INFO - mozcrash == 0.17 08:07:58 INFO - mozdebug == 0.1 08:07:58 INFO - mozdevice == 0.48 08:07:58 INFO - mozfile == 1.2 08:07:58 INFO - mozhttpd == 0.7 08:07:58 INFO - mozinfo == 0.9 08:07:58 INFO - mozleak == 0.1 08:07:58 INFO - mozlog == 3.1 08:07:58 INFO - moznetwork == 0.27 08:07:58 INFO - mozprocess == 0.22 08:07:58 INFO - mozprofile == 0.28 08:07:58 INFO - mozrunner == 6.11 08:07:58 INFO - mozscreenshot == 0.1 08:07:58 INFO - mozsystemmonitor == 0.0 08:07:58 INFO - moztest == 0.7 08:07:58 INFO - mozversion == 1.4 08:07:58 INFO - psutil == 3.1.1 08:07:58 INFO - requests == 1.2.3 08:07:58 INFO - wsgiref == 0.1.2 08:07:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:07:58 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:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:58 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:07:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:58 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 0x7f2484fe0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10239a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2810>, '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 0x10b3710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3ba0>, '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': '20e666a3d4cfbb71505a330e000001b4-1460990935.338468-70303664', '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:07:58 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:07:58 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:07:58 INFO - Using env: {'DISPLAY': ':0', 08:07:58 INFO - 'HOME': '/home/cltbld', 08:07:58 INFO - 'LANG': 'en_US.UTF-8', 08:07:58 INFO - 'LANGUAGE': 'en_US:en', 08:07:58 INFO - 'LOGNAME': 'cltbld', 08:07:58 INFO - 'MAIL': '/var/mail/cltbld', 08:07:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:58 INFO - 'MOZ_NO_REMOTE': '1', 08:07:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:58 INFO - 'NO_EM_RESTART': '1', 08:07:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:58 INFO - 'PWD': '/builds/slave/test', 08:07:58 INFO - 'SHELL': '/bin/bash', 08:07:58 INFO - 'SHLVL': '1', 08:07:58 INFO - 'TERM': 'linux', 08:07:58 INFO - 'TMOUT': '86400', 08:07:58 INFO - 'USER': 'cltbld', 08:07:58 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1460990935.338468-70303664', 08:07:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:58 INFO - '_': '/tools/buildbot/bin/python'} 08:07:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:59 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:07:59 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:07:59 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:07:59 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:07:59 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:07:59 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:07:59 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:07:59 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:07:59 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:07:59 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:07:59 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:07:59 INFO - Cleaning up... 08:07:59 INFO - Return code: 0 08:07:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:07:59 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:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:59 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:07:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:59 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 0x7f2484fe0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10239a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2810>, '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 0x10b3710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3ba0>, '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': '20e666a3d4cfbb71505a330e000001b4-1460990935.338468-70303664', '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:07:59 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:07:59 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:07:59 INFO - Using env: {'DISPLAY': ':0', 08:07:59 INFO - 'HOME': '/home/cltbld', 08:07:59 INFO - 'LANG': 'en_US.UTF-8', 08:07:59 INFO - 'LANGUAGE': 'en_US:en', 08:07:59 INFO - 'LOGNAME': 'cltbld', 08:07:59 INFO - 'MAIL': '/var/mail/cltbld', 08:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:59 INFO - 'MOZ_NO_REMOTE': '1', 08:07:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:59 INFO - 'NO_EM_RESTART': '1', 08:07:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:59 INFO - 'PWD': '/builds/slave/test', 08:07:59 INFO - 'SHELL': '/bin/bash', 08:07:59 INFO - 'SHLVL': '1', 08:07:59 INFO - 'TERM': 'linux', 08:07:59 INFO - 'TMOUT': '86400', 08:07:59 INFO - 'USER': 'cltbld', 08:07:59 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1460990935.338468-70303664', 08:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:59 INFO - '_': '/tools/buildbot/bin/python'} 08:07:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:59 INFO - Downloading/unpacking jsonschema 08:07:59 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:07:59 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:07:59 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:07:59 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:07:59 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:07:59 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:08:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:08:01 INFO - Downloading/unpacking functools32 (from jsonschema) 08:08:01 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:08:01 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:08:01 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:08:01 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:08:01 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:08:01 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:08:01 INFO - Downloading functools32-3.2.3-2.tar.gz 08:08:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:08:01 INFO - warning: no files found matching '*.txt' 08:08:01 INFO - no previously-included directories found matching 'build' 08:08:01 INFO - no previously-included directories found matching 'dist' 08:08:01 INFO - no previously-included directories found matching '.git*' 08:08:01 INFO - Installing collected packages: jsonschema, functools32 08:08:01 INFO - Running setup.py install for functools32 08:08:01 INFO - warning: no files found matching '*.txt' 08:08:01 INFO - no previously-included directories found matching 'build' 08:08:01 INFO - no previously-included directories found matching 'dist' 08:08:01 INFO - no previously-included directories found matching '.git*' 08:08:01 INFO - Successfully installed jsonschema functools32 08:08:01 INFO - Cleaning up... 08:08:01 INFO - Return code: 0 08:08:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:08:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2484fe0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10239a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2810>, '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 0x10b3710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3ba0>, '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': '20e666a3d4cfbb71505a330e000001b4-1460990935.338468-70303664', '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:08:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:08:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:08:01 INFO - Using env: {'DISPLAY': ':0', 08:08:01 INFO - 'HOME': '/home/cltbld', 08:08:01 INFO - 'LANG': 'en_US.UTF-8', 08:08:01 INFO - 'LANGUAGE': 'en_US:en', 08:08:01 INFO - 'LOGNAME': 'cltbld', 08:08:01 INFO - 'MAIL': '/var/mail/cltbld', 08:08:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:01 INFO - 'MOZ_NO_REMOTE': '1', 08:08:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:01 INFO - 'NO_EM_RESTART': '1', 08:08:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:01 INFO - 'PWD': '/builds/slave/test', 08:08:01 INFO - 'SHELL': '/bin/bash', 08:08:01 INFO - 'SHLVL': '1', 08:08:01 INFO - 'TERM': 'linux', 08:08:01 INFO - 'TMOUT': '86400', 08:08:01 INFO - 'USER': 'cltbld', 08:08:01 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1460990935.338468-70303664', 08:08:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:01 INFO - '_': '/tools/buildbot/bin/python'} 08:08:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:01 INFO - Downloading/unpacking flake8 08:08:01 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:08:01 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:08:01 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:08:01 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:08:01 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:08:01 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:08:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:08:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:08:04 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:08:04 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:08:04 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:08:04 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:08:04 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:08:04 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:08:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:08:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:08:04 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:08:04 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:08:04 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:08:04 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:08:04 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:08:04 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:08:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:08:04 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:08:04 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:08:04 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:08:04 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:08:04 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:08:04 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:08:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:08:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:08:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:08:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:08:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:08:04 INFO - no previously-included directories found matching 'docs/_build' 08:08:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:08:04 INFO - Running setup.py install for pep8 08:08:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:08:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:08:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:08:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:08:04 INFO - no previously-included directories found matching 'docs/_build' 08:08:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:08:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:08:04 INFO - Cleaning up... 08:08:05 INFO - Return code: 0 08:08:05 INFO - Running post-action listener: _resource_record_post_action 08:08:05 INFO - Running post-action listener: _start_resource_monitoring 08:08:05 INFO - Starting resource monitoring. 08:08:05 INFO - ##### 08:08:05 INFO - ##### Running install step. 08:08:05 INFO - ##### 08:08:05 INFO - Running pre-action listener: _resource_record_pre_action 08:08:05 INFO - Running main action method: install 08:08:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:08:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:08:05 INFO - Reading from file tmpfile_stdout 08:08:05 INFO - Detecting whether we're running mozinstall >=1.0... 08:08:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:08:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:08:05 INFO - Reading from file tmpfile_stdout 08:08:05 INFO - Output received: 08:08:05 INFO - Usage: mozinstall [options] installer 08:08:05 INFO - Options: 08:08:05 INFO - -h, --help show this help message and exit 08:08:05 INFO - -d DEST, --destination=DEST 08:08:05 INFO - Directory to install application into. [default: 08:08:05 INFO - "/builds/slave/test"] 08:08:05 INFO - --app=APP Application being installed. [default: firefox] 08:08:05 INFO - mkdir: /builds/slave/test/build/application 08:08:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:08:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:08:21 INFO - Reading from file tmpfile_stdout 08:08:21 INFO - Output received: 08:08:21 INFO - /builds/slave/test/build/application/firefox/firefox 08:08:21 INFO - Running post-action listener: _resource_record_post_action 08:08:21 INFO - ##### 08:08:21 INFO - ##### Running run-tests step. 08:08:21 INFO - ##### 08:08:21 INFO - Running pre-action listener: _resource_record_pre_action 08:08:21 INFO - Running main action method: run_tests 08:08:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:08:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:08:21 INFO - Python 2.7.3 08:08:21 INFO - Return code: 0 08:08:21 INFO - grabbing minidump binary from tooltool 08:08: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:08:21 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 0x10b2810>, '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 0x10b3710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:08:21 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:08:21 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:08:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:08:21 INFO - Return code: 0 08:08:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:08:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:08:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:08:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:08:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:08:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:08:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:08:22 INFO - Return code: 0 08:08:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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:08:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --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:08:22 INFO - Using env: {'DISPLAY': ':0', 08:08:22 INFO - 'HOME': '/home/cltbld', 08:08:22 INFO - 'LANG': 'en_US.UTF-8', 08:08:22 INFO - 'LANGUAGE': 'en_US:en', 08:08:22 INFO - 'LOGNAME': 'cltbld', 08:08:22 INFO - 'MAIL': '/var/mail/cltbld', 08:08:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:08:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:08:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:22 INFO - 'MOZ_NO_REMOTE': '1', 08:08:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:08:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:22 INFO - 'NO_EM_RESTART': '1', 08:08:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:22 INFO - 'PWD': '/builds/slave/test', 08:08:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:08:22 INFO - 'SHELL': '/bin/bash', 08:08:22 INFO - 'SHLVL': '1', 08:08:22 INFO - 'TERM': 'linux', 08:08:22 INFO - 'TMOUT': '86400', 08:08:22 INFO - 'USER': 'cltbld', 08:08:22 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1460990935.338468-70303664', 08:08:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:22 INFO - '_': '/tools/buildbot/bin/python'} 08:08:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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:08:23 INFO - mozversion application_buildid: 20160418030305 08:08:23 INFO - mozversion application_changeset: 1f16d3da9280e40ada252acf8110b91ee1edbb08 08:08:23 INFO - mozversion application_display_name: Nightly 08:08:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:08:23 INFO - mozversion application_name: Firefox 08:08:23 INFO - mozversion application_remotingname: firefox 08:08:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:08:23 INFO - mozversion application_vendor: Mozilla 08:08:23 INFO - mozversion application_version: 48.0a1 08:08:23 INFO - mozversion platform_buildid: 20160418030305 08:08:23 INFO - mozversion platform_changeset: 1f16d3da9280e40ada252acf8110b91ee1edbb08 08:08:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:08:23 INFO - mozversion platform_version: 48.0a1 08:08:23 INFO - using testdate: 1460992103 08:08:23 INFO - actual date: 1460992103 08:08:23 INFO - starting webserver on 'localhost:48033' 08:08:23 INFO - SUITE-START | Running 2 tests 08:08:23 INFO - TEST-START | dromaeo_css 08:08:23 INFO - operating with platform_type : linux_ 08:08:23 INFO - Initialising browser for dromaeo_css test... 08:08:23 INFO - TEST-INFO | started process 3046 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr664vk/profile http://localhost:48033/getInfo.html) 08:08:26 INFO - PROCESS | 3046 | __metrics Screen width/height:1600/1200 08:08:26 INFO - PROCESS | 3046 | colorDepth:24 08:08:26 INFO - PROCESS | 3046 | Browser inner width/height: 1024/697 08:08:26 INFO - PROCESS | 3046 | __metrics 08:08:27 ERROR - PROCESS | 3046 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:08:28 INFO - TEST-INFO | 3046: exit 0 08:08:28 INFO - Browser initialized. 08:08:28 INFO - Running cycle 1/1 for dromaeo_css test... 08:08:28 INFO - TEST-INFO | started process 3128 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr664vk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:08:40 INFO - PROCESS | 3128 | RSS: Main: 153018368 08:08:40 INFO - PROCESS | 3128 | 08:09:31 INFO - PROCESS | 3128 | 1460992171321 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:11:38 INFO - PROCESS | 3128 | Cycle 1(1): loaded http://localhost:48033/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48033/tests/dromaeo/cssquery-ext.html) 08:11:39 INFO - PROCESS | 3128 | RSS: Main: 252387328 08:11:39 INFO - PROCESS | 3128 | 08:14:42 INFO - PROCESS | 3128 | Cycle 1(1): loaded http://localhost:48033/tests/dromaeo/cssquery-ext.html (next: http://localhost:48033/tests/dromaeo/cssquery-jquery.html) 08:14:42 INFO - PROCESS | 3128 | RSS: Main: 229236736 08:14:42 INFO - PROCESS | 3128 | 08:17:44 INFO - PROCESS | 3128 | Cycle 1(1): loaded http://localhost:48033/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48033/tests/dromaeo/cssquery-mootools.html) 08:17:45 INFO - PROCESS | 3128 | RSS: Main: 229535744 08:17:45 INFO - PROCESS | 3128 | 08:20:47 INFO - PROCESS | 3128 | Cycle 1(1): loaded http://localhost:48033/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48033/tests/dromaeo/cssquery-prototype.html) 08:20:47 INFO - PROCESS | 3128 | RSS: Main: 225038336 08:20:47 INFO - PROCESS | 3128 | 08:23:50 INFO - PROCESS | 3128 | Cycle 1(1): loaded http://localhost:48033/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48033/tests/dromaeo/cssquery-yui.html) 08:23:50 INFO - PROCESS | 3128 | RSS: Main: 205529088 08:23:50 INFO - PROCESS | 3128 | 08:26:53 INFO - PROCESS | 3128 | Cycle 1(1): loaded http://localhost:48033/tests/dromaeo/cssquery-yui.html (next: http://localhost:48033/tests/dromaeo/cssquery-dojo.html) 08:26:53 INFO - PROCESS | 3128 | RSS: Main: 279289856 08:26:53 INFO - PROCESS | 3128 | 08:26:53 INFO - PROCESS | 3128 | __start_tp_report 08:26:53 INFO - PROCESS | 3128 | _x_x_mozilla_page_load 08:26:53 INFO - PROCESS | 3128 | _x_x_mozilla_page_load_details 08:26:53 INFO - PROCESS | 3128 | |i|pagename|runs| 08:26:53 INFO - PROCESS | 3128 | |0;dojo.html;3040.7111324424177;3066.693330666935;3111.564380986661;3111.813291202528;3136.9648016154665;5245.44922783108;5246.449122842104;5263.105272103747;5299.496547827955;5325.281087053247;5343.679379237239;5367.275417818593;5413.891722165555;5414.16080507521;5468.6171967962255;4782.880427989293;4818.397700287464;4896.167651499236;4907.411110666725;4951.752412379385;4863;4882.932149954434;4914.410270767513;4920.3357546731095;4936.876578085541;4747.90504189916;4808.951910480903;4850.417949846041;4900.313956046157;4911.5088491150955;4827.51724827518;4856.1016212000895;4872.3422337984275;4883.12103821312;4914.11545921734;4779.354787103731;4807.158747219222;4838.467768545457;4854.805807767721;4882.951170488321;5299.655522391032;5317.308749862493;5337.839864804062;5354.759035843396;5387.4073851876265;5657.20799088128;5668.178114173463;5672.376038635747;5677.034904066319;5677.716114194273;5646.632968857052;5711.600187986843;5715.057015592422;5720.71396430181;5725.112607545837;5278.155495120801;5307.734613269321;5308.991291654612;5313.362396512443;5356.009138309386;5804.01331773591;5805.8548536286935;5810;5810.1865738796605;5828.708564571754;5487.396386397493;5546.27898373217;5575.33096028471;5590.86022849432;5624.072028115397;5567.638103523258;5588.21764952907;5589.636673616284;5590.468905453975;5643.351014633287;5499.3675727291875;5552.500274975271;5557.444255574491;5558.666480011212;5576.553875689935;5476.123820188751;5608.579356548275;5654.349749778746;5775.971120144372;5793.044147715664;4306.461692288464;4331.891702707395;4332.241857674894;4335.132973405269;4364.476262848479;3847.304791924335;3875.9612403876163;3895.376739721631;3923.2741942740686;3926;5218.452062533455;5235.554977826851;5299.5760339172775;5299.973500132474;5307.203919412042;5688;5690.402507736628;5692.686902220417;5707.029804933171;5708.743106560215;5292.206169074592;5297.284866543045;5297.894042119213;5310.6813591184655;5352.518273355417;4647.372604698322;4791.928121078186;4816.686915350491;4854.514548545188;4863.10032643962;5898.528117750569;5934.109883517507;5935.317438494542;5936.5547583931375;5939.198208241918;5572.108462645957;5734;5735.225744524602;5739.713014349182;5742.454466825645;5847.883042339215;5936.1095835625;5947.345791962967;5973.880522389441;5987.401259873977;5569;5571.1086226203615;5575.303087114111;5578.721063946705;5590.189422533628;5650.378458369658;5668.971655141863;5677.914831277451;5678.375378708256;5705.7432415542235;5567.582431317586;5578.051731205624;5579.163125531203;5589.301337332833;5643.209950606836;5505.394406615189;5558.194061860927;5568.526675232489;5570.470805273492;5570.5265052470995;5299.5230429261555;5325.227841962971;5403.027455058127;5469.507744303032;5525.143602741421;5590.776368945197;5599.440055994368;5600.327960644749;5608.775648973995;5608.775648974159;5451;5481.177823326533;5481.835544933659;5483.396826349019;5490.368607610176 08:26:53 INFO - PROCESS | 3128 | |1;ext.html;594.4887396838718;644.5294934697671;647.8024202618202;656.4518626946499;668.8027032025554;30377.544336834937;37142.814285928565;38307.42538861912;38335.42496862549;38382.61617383825;40744.38883416751;41342.37986430206;41514.58485415145;41519.79240103795;41530.7923460383;7758.107817600963;8456.365772567051;8649.351298652595;8670.566471676391;9898.851517227247;9976.152027077671;10098;10135.89864101357;10142.645007424742;10149.289549731522;10100.949495252513;10210.897891021106;10213.080822725953;10222.182225421986;10240.078392944633;7932.643031063587;10096.899031009669;10225;10597.099246564052;10599;9773.804523909554;9928.751781205456;9932.900670993342;9938.850917236246;9954.552045157912;37361.439578406345;37985.620143798486;38016.809915950245;38051.80974095112;38099.23801523954;3536.7701099428455;3558.1460449491938;3572.7141828653644;3602.783832970004;3709.350863598859;30755.384892302252;30880;31115;31418.528722069186;32116.518252226237;4321.611055005033;4357.869263922087;4375.846845360397;4386.473623165209;4401.5598440156045;302655;305001;306216;307068;307317;58543.70728146332;58661.70669146627;58943;59164.40835591675;59281;61127.69436152791;61260.099192064525;61313.693431532556;61387.69306153441;61496.38503614996;16035.759463608056;16355.427560035341;16388.344466221217;16399.590010249838;16408.425705100504;12177;12267.263964162179;12316.322602256962;12335.321557314433;12335.50657973671;17184;17203.741943870853;17499.12504374776;17501.38745143914;17530.211140498708;5010.323606313174;5834.241548598655;5845.327787304429;5972.910406343908;6107.541934354941;1033.4884232305058;1054.314695447965;1059.3220338983058;1114.9888501114885;1129.5538262386312;30325.241868953453;31166.844165779024;31666.208344791565;31734.523982140287;31875.710043250612;1126.6901602059336;1152.8558930133734;1160.066146751856;1164.301419148504;1179.257068047125;16091.597710057107;16847.915760421118;17002;17072.317107315568;17238.310467581156;381987;385096;385678;387166;388623;54794.452055478934;54800.725996369765;55096.44903550993;55178.44821551813;55327.44672553223;1360.2722543439213;1380.8469927610558;1383.5157694806937;1395.5185461015933;1411.7811739180443;29775.851120744257;30636.234094146934;31139.68860311368;31218.843905780326;31802;48844;48979;49081.26378104403;49263.75368123136;49267.26099108588;259950.90171843895;262144;262325;262746;262817;36408.81795591005;38839.6116038836;40659.18681626292;42128.36807447952;42591.3611295837;43361;43433.56566434421;43591.12817743564;44162.33756493591;44169.55830441655;35927.862362667656;36982.44526332161;37037.44443833399;37180.44229336616;37314;36128.27743445064;36783.63216367802;36886.26227475489;37232;37366.252674946896;37052.62947370492;38357;38402.07859694751;38472;38996.22007559776;31598.91193132117;33026.33947321088;33142.5028624566;33424.83287583644;33804.32391352209;26278.868605656848;26616.201513954613;26803.597946030433;26809.329766755985;27351.452970940867 08:26:53 INFO - PROCESS | 3128 | |2;jquery.html;391.87460012795907;395.7486995757695;396.5122898834434;399.5305516018677;402.2337447163155;14327.570172894804;16618.418355357564;17941.372051978167;18551.257949682014;18578.62842743146;15267.312970916308;16987.3205071797;17668;17695.380661676845;18242.270309187617;4718.57532822046;5026.52248036436;5032.798688052473;5034.748262586874;5042.672226305297;4789.114013907439;4922.384701912261;4957.206846904496;5078.746062696869;5082.720450375228;5047.798088076491;5050.368703912011;5054.166062599685;5062.544371006608;5085.491450854922;4973.502649735034;5030.924536131943;5057.924131138036;5071.391433028023;5230.529252367267;5042.722650254234;5044.949550504484;5064.873378165538;5082.23766435034;5083.161278389061;12773.61679149627;15791.763123553155;20770.06534705942;22083.227087051877;22451.55096898053;2300.5513924784673;2346.554154710617;2581.935451613706;2681.1554360376417;2734.644496215479;9969.601215951427;10092.142167915736;10123.088921996981;10186.796264074677;10393.168546516335;1851.8703690741654;1919.424172748184;1987.4534503011644;2011.5071807407278;2036.1855257896812;65857;71664;75614.62192689002;78131;79468.60265698635;10295.330803497749;10994.725131871768;10996.780064398827;11002.779944401067;11112.388818614892;15321.387144514318;15382.153981530899;15393.384264629512;15405.922970385076;15462;7105.609191494414;7468.813279667943;7505.399568034544;7819.609019549;7909.920900791033;7530.774076777706;7543.811404714926;7551.169371369145;7696.037995250594;7725.5364678119495;4603.723776573416;4651.62786977041;4671.159191345522;4711.8350857719815;4722.173619616553;1874.8687591868438;1910.2645481489449;1942.805719428046;1954.257382194757;1985.7120717495882;977.9511024448749;983.7688143286322;1061.5276202089997;1067.80779459698;1081.7944590527932;19054.809451905305;19108;19129.713054304197;19200.423987280403;19564.119614617375;1025.5846382215216;1026.7997740440692;1064.1699474409972;1088.1784252889017;1102.4212288548576;10511.1591072714;10947.726306842233;11034.779304413867;11044.613438529774;11096.500657470433;458146;465967;495995;500430;500457;89011;90663.8402543761;90852.54573727089;90859;92877;1022.25375475903;1024.5491983527224;1025.676911772804;1026.14829691356;1049.7113293844102;15891.682166356839;16858.915705421394;16881.91559042197;16883.155842207594;17228.31086756566;34068.318633627685;36572.085697857765;37124.44313335356;38065;39802.800985996044;49600;50461.49538504715;50840;51166.48833511617;51767.74116129546;7277.2722727726805;7606.429517786078;7676.117246516722;7741.225877412214;8586.78533036679;9243.2143267823;12136.514539418324;12924.547640832525;12926.482940682643;13042.739145217232;11210.775784484102;11282.153838461983;11311.660650180507;11570;11735.882641173479;10404.739881503023;11077.72305692332;11235.382053986783;11419.543218271176;11615.477303521193;11168.776624467628;11199.272047317225;11563.479643415898;11581.536738530365;11724.41377931083;8273.751787446387;8277.54473503963;8365.372597055124;8469.195426434479;8534.487930724177;11299.09607231436;11324.773504530029;11473.368964706688;12040.638780836589;12183.086268530073 08:26:53 INFO - PROCESS | 3128 | |3;mootools.html;1351.2433037499006;1510.6525499135198;1535.4088675859794;1708.273983556988;1821.4262507310189;8151.144129866368;8445.704400345981;8453.1969462901;8454;8461.23848853603;8364.665413383473;8492.278156356702;8505.192006759364;8528.232459078681;8534.91465085349;2079.396974877284;2153.267888917768;2300.620397634397;2312.3409828198965;2331.7901388875;2336;2364.408897775556;2367.4081479630095;2367.75138610446;2371.2412028150998;2327.93016209514;2349.647552867075;2351.341624345186;2353.411647088228;2380.9047638094457;2013.0739859664498;2257.322803159062;2259.9096036158535;2266.3087758233733;2324.2910912171783;2334.043042352644;2355.2698663414394;2355.5759963206615;2359.4691194481275;2359.6460530920326;8335.374846886507;8363;8399.328053755686;8413.49519028854;8462.238398544161;4984.675996060245;5137.588992880561;5145.30538377318;5176.120059589879;5190.8183213587345;3328.9500657490157;3388.2545839915424;3449.7930124192376;3479.234568394949;3533.1873669056004;1143.891330323618;1152.7463957929326;1168.8428455828753;1175.300696085836;1220.2983284611385;11587.826182607268;11865.288082714978;11895.04839612829;11895.04839612829;11949.402529873472;4488;4528.252838281646;4636.698614590041;4649.209634362167;4656.32483289921;10247.231457640706;10269.7432564185;10284.897151028394;10286;10304.690859274233;5082.440931497532;5086.135356989321;5091.847244582668;5094.643374963717;5121.743912804345;4257.148570285955;4659.5573420525;4681.719096854132;4797.808087676523;4846;3905.5313362396696;3972.3445631471063;3998.4402183693724;4010.6590939770444;4054.412110244057;1278.181963543333;1284.7880099783617;1307.1503522710314;1309.5678426119357;1313.4746101559263;899.3794281945437;946.3328353510758;947.2185447006248;952.9952350238204;955.302629080761;5808.128780682847;5901.911471327933;5922.378150294243;6021.397860213943;6046.969765151146;1014.9898501014895;1081.2053140941402;1095.27164435651;1100.1318175961612;1113.3653817324048;4086.979565102215;4188.392683061;4191.7484950903045;4199.391088292181;4232.936505952413;10408.47957602117;10631.202659800545;10765.569377224823;10770.946145269223;10816.67549973502;10043.497825108716;10578.471076446302;10704.1436685065;10726.624568140078;10730.463476826128;7895;8109.635066422025;8187.5087494750505;8188.303994160563;8202.507849529047;5828.300603927386;5886.117082437498;5890.175375447527;5890.911636325544;6029.969850150721;9538.570764315762;9713.320067595483;9727.173190278905;9792.216622670312;9807.9019209807;9834;9987.350822196535;10016.699499015042;10068;10130.746731331776;7035.1909530404655;7338.743143989935;7564.281393267631;7627.8855817161675;7755.2244775521995;8137.308328792119;8137.8372432552205;8154.510729356258;8187.959060204661;8209.055958564602;7171.1753148386515;7429.4799364044;7435.628218589157;7497.550146991198;7580.204078571671;7266.237045110187;7354.96322518384;7376;7401.629918504161;7431.554106753612;6941.236463989058;6969.477289203432;7020.964895175492;7027.262137475492;7044.295570442915;5083.5678967288195;5181.792728290826;5233.685978841282;5289.418164002033;5496.890062198654;5230.424653288212;5265.6050796189675;5321.255024296524;5443.755031023693;5453.809116680897 08:26:53 INFO - PROCESS | 3128 | |4;prototype.html;331.2315428206561;333.2834406027042;334.2095943094582;339.04727715120515;347.0906225688696;5558.360788509322;5654.717264136797;5654.869026194762;5757.740901659425;5818.5926985111055;5685.459881311279;5702.146802289262;5713.514351280146;5725.942740572593;5733.512651424634;4367.737935723851;4381.408509851177;4385.780710964447;4387.890302742425;4392.692511524195;4008.6993475489307;4088.2436749201343;4320.719153255044;4331.177076355482;4344.4786625604975;4283.97858010711;4313.137372525492;4319.69762116652;4323.62200789566;4331.480222373304;4139.441175441307;4322.351647252905;4322.708964248953;4336.457942757155;4341.6526677865695;3690.760100593453;3781.508403907502;3792.563855156637;3797.297499962488;3804.5434547854156;5445.50990410861;5449.891002179974;5450.591205659552;5452.482014208644;5460.590455715837;4733.526647335273;4965.131102057126;4983.476734942851;4994.101061808873;4996.650234483587;5943.4056594340655;5956.612820166719;5961.344252132262;5962.4633782959745;5966.134910437962;4173.64524015456;4184.916301673949;4185;4194.224068547329;4198.349255865346;6007.519398448114;6160.137580738656;6229.127922090911;6256.593321434092;6259.968700156515;4237.618614324664;4237.87286381409;4238.385434112037;4250.36244563318;4268.338407546835;4284.978575107105;4304.311310190355;4306.4832220133785;4307.483102027777;4319.244132276839;4811.687240329367;4944.307796908363;4964.652474326835;4974.134699487692;4978.780198851232;5927.3776253493625;5932.762689492458;5937.2578427696535;5987.9101813472835;5987.940120598825;1458.6353411647087;1478.4234148681808;1478.733827910965;1481.525911708243;1485.532057401915;972.2222222222194;995.4873240281261;1004.4073996342194;1004.9849252261222;1014.4623349624711;5704.058830293038;5714.085746280575;5734.197212390269;5750.856228594235;5753.424657534297;6139.508839292846;6146.508279337731;6153.230846144232;6163.907541386883;6166.229221347332;5539.778408863681;5680.7727690892725;5718.68547229898;5720.914186287209;5728.742206600713;3273.2471531547876;3274.312394397203;3280.7375409967144;3285.4250506161325;3295.20914980403;6100.664463454464;6367.522435817332;6388.105665206875;6397.816403965281;6439.8068057958335;6034.577579569388;6215.160953271341;6294.213223347082;6309.1167236586;6353.301136875032;6260.652255404223;6392.904106438407;6421.389967953037;6426.710798014195;6443.806685799434;6162.537809664203;6173.536984726254;6211.16149319836;6220;6249.687515624291;5996.280446346466;6082.939170608237;6112.991356426318;6128.540359472968;6157.876842463215;6400.775972840928;6416.45460135875;6422.3577642235405;6424.261209960914;6438.130852335063;3982.5420076691553;4218.186179942654;4247.5540068292385;4257.403963445058;4288.807003684904;6101.847453813512;6114.633122012693;6153.876922461615;6169.660668663267;6175;5954.702264886651;5961.105834124916;5962;5978.461938425563;6007.219061521974;5822.970885145547;5951.880962380815;5977.491913187428;5982.58121931478;5983.940160598512;5789.102689083199;5825.854353641193;5844.795432159854;5884.882302353843;5887.764489420375;5942.346341902301;5977.432143946318;6014.27828660546;6034.09488576717;6046.27444706638;5834.824955251349;5848.093545500455;5874.236349274567;5878.441548052928;5888.646681199141 08:26:53 INFO - PROCESS | 3128 | |5;yui.html;811.3792948394479;837.1921096142223;838.8028813228894;839.24048735894;850.6512329944716;13510.392032358543;13649.181049137058;13651.658708532292;14435.278236088207;14712.11727296363;12163;12894.935525322384;12954.676133096676;12971.870281297184;12982.09125361225;802.2258520527689;826.6528058215533;827.3711978896052;827.6854795177824;829.9626516806758;831.3349320543541;832.937529685273;837.0583094019229;837.6984285657159;838.0069617503278;861.9310455163603;863.2705363967438;863.4948555095277;864.6627815152095;867.8915135608049;722.2596838240793;738.018435480812;738.2764890407377;839.307571253712;866.4801119328384;630.8738252349549;634.7810005548125;635.3678090300181;635.6376865186845;636.6593872278308;14173.149611023371;14230.573082807532;14255.073420227653;14258.64353391163;14263.714725705531;14012.509562165376;14293.857061429357;14316;14330.713385732228;14347;11695.941520292345;11891.583794567236;11986.760264794742;12074.758504829942;12363.320017399039;3848.3650197717343;3892.9221415571815;3953.1500727343473;3972.642462178389;4031.254217969685;54938.72530637361;55389.1691624626;57378.71310643462;57512.71243643797;57780;11062.944685276521;11255;11294.60468883585;11458.484368203452;11594.76810463786;20280.188792448138;20320.69518957217;20343.18627254923;20364.185432582828;20397.49006274855;8086.797830054295;8338.8332233355;8381;8450.323974082059;8615.310775137974;4457.465104187453;4508.256137737237;4515.14212299662;4517.796699148546;4550.362949187116;3209.8234597096916;3299.1916980339493;3312.039508542544;3313.519539666735;3319.6016478022307;641.6631268584031;646.5344951634816;662.4270006444391;678.4640134293852;701.5054386657395;673.8584897171551;675.7499725101744;765.1965436291871;769.6151924037981;783.8549868274388;9124.361294709306;9157.862632060524;9281.118293762082;9291.48896810682;9369.156775890202;638.6934271549682;659.5317324699517;713.3651050565002;750.2722359311459;772.1853444615872;4650.813967441332;4753.239481682914;4769.260764581495;4821.099776063697;4843.660943733905;51602;53213.467865321625;53264.46735532673;53290.46709532855;67382;47180.292295615596;47584.7620761894;47838.521614784106;47938.520614794106;50021;44126.11747765027;44702.99999999935;44846.77576612096;45233.547664522936;46241;8952.865707014269;8958.82082358336;9031.142041506046;9108.726738197865;9149.176574108362;30736.385272294876;31567.36865262636;32237;32921;33371.33257334888;38975.220495590496;40431.79784101061;44090.779546103346;44162;44823.55176448194;12295.32375719344;12339.876601233873;12389.75220495603;12403.379831008233;12752.107352485236;13811.378487967864;14037.578872633838;14339.856601433852;14750.114993100018;14802.111873287206;13090.607281781562;13127.540536081191;13599.252041137832;13629.931850340685;13964.4414223434;12733.426995785027;13067.411966461723;13205.537806176737;13542.59372218835;13577.642235776739;11935.820962685393;12426.62720118398;12535.623931282076;12729.618111456672;12990.090693651731;10933.671989840317;11091.500882460146;11213;11297.943510282395;11742.941285293518;11121.499532521218;11231.494582743959;11250.212485125963;11573.13201509907;11611.535538578362 08:26:53 INFO - PROCESS | 3128 | __end_tp_report 08:26:53 INFO - PROCESS | 3128 | __start_cc_report 08:26:53 INFO - PROCESS | 3128 | _x_x_mozilla_cycle_collect,856 08:26:53 INFO - PROCESS | 3128 | __end_cc_report 08:26:53 INFO - PROCESS | 3128 | __startTimestamp1460993213604__endTimestamp 08:26:53 INFO - PROCESS | 3128 | 08:26:53 INFO - PROCESS | 3128 | ------- Summary: start ------- 08:26:53 INFO - PROCESS | 3128 | Number of tests: 6 08:26:53 INFO - PROCESS | 3128 | 08:26:53 INFO - PROCESS | 3128 | [#0] dojo.html Cycles:165 Average:5274.52 Median:5481.84 stddev:594.10 (10.8%) stddev-sans-first:569.49 08:26:53 INFO - PROCESS | 3128 | Values: 3040.7 3066.7 3111.6 3111.8 3137.0 5245.4 5246.4 5263.1 5299.5 5325.3 5343.7 5367.3 5413.9 5414.2 5468.6 4782.9 4818.4 4896.2 4907.4 4951.8 4863.0 4882.9 4914.4 4920.3 4936.9 4747.9 4809.0 4850.4 4900.3 4911.5 4827.5 4856.1 4872.3 4883.1 4914.1 4779.4 4807.2 4838.5 4854.8 4883.0 5299.7 5317.3 5337.8 5354.8 5387.4 5657.2 5668.2 5672.4 5677.0 5677.7 5646.6 5711.6 5715.1 5720.7 5725.1 5278.2 5307.7 5309.0 5313.4 5356.0 5804.0 5805.9 5810.0 5810.2 5828.7 5487.4 5546.3 5575.3 5590.9 5624.1 5567.6 5588.2 5589.6 5590.5 5643.4 5499.4 5552.5 5557.4 5558.7 5576.6 5476.1 5608.6 5654.3 5776.0 5793.0 4306.5 4331.9 4332.2 4335.1 4364.5 3847.3 3876.0 3895.4 3923.3 3926.0 5218.5 5235.6 5299.6 5300.0 5307.2 5688.0 5690.4 5692.7 5707.0 5708.7 5292.2 5297.3 5297.9 5310.7 5352.5 4647.4 4791.9 4816.7 4854.5 4863.1 5898.5 5934.1 5935.3 5936.6 5939.2 5572.1 5734.0 5735.2 5739.7 5742.5 5847.9 5936.1 5947.3 5973.9 5987.4 5569.0 5571.1 5575.3 5578.7 5590.2 5650.4 5669.0 5677.9 5678.4 5705.7 5567.6 5578.1 5579.2 5589.3 5643.2 5505.4 5558.2 5568.5 5570.5 5570.5 5299.5 5325.2 5403.0 5469.5 5525.1 5590.8 5599.4 5600.3 5608.8 5608.8 5451.0 5481.2 5481.8 5483.4 5490.4 08:26:53 INFO - PROCESS | 3128 | 08:26:53 INFO - PROCESS | 3128 | [#1] ext.html Cycles:180 Average:49229.25 Median:36596.23 stddev:84355.43 (230.5%) stddev-sans-first:84513.04 08:26:53 INFO - PROCESS | 3128 | Values: 594.5 644.5 647.8 656.5 668.8 30377.5 37142.8 38307.4 38335.4 38382.6 40744.4 41342.4 41514.6 41519.8 41530.8 7758.1 8456.4 8649.4 8670.6 9898.9 9976.2 10098.0 10135.9 10142.6 10149.3 10100.9 10210.9 10213.1 10222.2 10240.1 7932.6 10096.9 10225.0 10597.1 10599.0 9773.8 9928.8 9932.9 9938.9 9954.6 37361.4 37985.6 38016.8 38051.8 38099.2 3536.8 3558.1 3572.7 3602.8 3709.4 30755.4 30880.0 31115.0 31418.5 32116.5 4321.6 4357.9 4375.8 4386.5 4401.6 302655.0 305001.0 306216.0 307068.0 307317.0 58543.7 58661.7 58943.0 59164.4 59281.0 61127.7 61260.1 61313.7 61387.7 61496.4 16035.8 16355.4 16388.3 16399.6 16408.4 12177.0 12267.3 12316.3 12335.3 12335.5 17184.0 17203.7 17499.1 17501.4 17530.2 5010.3 5834.2 5845.3 5972.9 6107.5 1033.5 1054.3 1059.3 1115.0 1129.6 30325.2 31166.8 31666.2 31734.5 31875.7 1126.7 1152.9 1160.1 1164.3 1179.3 16091.6 16847.9 17002.0 17072.3 17238.3 381987.0 385096.0 385678.0 387166.0 388623.0 54794.5 54800.7 55096.4 55178.4 55327.4 1360.3 1380.8 1383.5 1395.5 1411.8 29775.9 30636.2 31139.7 31218.8 31802.0 48844.0 48979.0 49081.3 49263.8 49267.3 259950.9 262144.0 262325.0 262746.0 262817.0 36408.8 38839.6 40659.2 42128.4 42591.4 43361.0 43433.6 43591.1 44162.3 44169.6 35927.9 36982.4 37037.4 37180.4 37314.0 36128.3 36783.6 36886.3 37232.0 37366.3 37052.6 38357.0 38402.1 38472.0 38996.2 31598.9 33026.3 33142.5 33424.8 33804.3 26278.9 26616.2 26803.6 26809.3 27351.5 08:26:53 INFO - PROCESS | 3128 | 08:26:53 INFO - PROCESS | 3128 | [#2] jquery.html Cycles:180 Average:27843.89 Median:12376.05 stddev:79783.67 (644.7%) stddev-sans-first:79980.86 08:26:53 INFO - PROCESS | 3128 | Values: 391.9 395.7 396.5 399.5 402.2 14327.6 16618.4 17941.4 18551.3 18578.6 15267.3 16987.3 17668.0 17695.4 18242.3 4718.6 5026.5 5032.8 5034.7 5042.7 4789.1 4922.4 4957.2 5078.7 5082.7 5047.8 5050.4 5054.2 5062.5 5085.5 4973.5 5030.9 5057.9 5071.4 5230.5 5042.7 5044.9 5064.9 5082.2 5083.2 12773.6 15791.8 20770.1 22083.2 22451.6 2300.6 2346.6 2581.9 2681.2 2734.6 9969.6 10092.1 10123.1 10186.8 10393.2 1851.9 1919.4 1987.5 2011.5 2036.2 65857.0 71664.0 75614.6 78131.0 79468.6 10295.3 10994.7 10996.8 11002.8 11112.4 15321.4 15382.2 15393.4 15405.9 15462.0 7105.6 7468.8 7505.4 7819.6 7909.9 7530.8 7543.8 7551.2 7696.0 7725.5 4603.7 4651.6 4671.2 4711.8 4722.2 1874.9 1910.3 1942.8 1954.3 1985.7 978.0 983.8 1061.5 1067.8 1081.8 19054.8 19108.0 19129.7 19200.4 19564.1 1025.6 1026.8 1064.2 1088.2 1102.4 10511.2 10947.7 11034.8 11044.6 11096.5 458146.0 465967.0 495995.0 500430.0 500457.0 89011.0 90663.8 90852.5 90859.0 92877.0 1022.3 1024.5 1025.7 1026.1 1049.7 15891.7 16858.9 16881.9 16883.2 17228.3 34068.3 36572.1 37124.4 38065.0 39802.8 49600.0 50461.5 50840.0 51166.5 51767.7 7277.3 7606.4 7676.1 7741.2 8586.8 9243.2 12136.5 12924.5 12926.5 13042.7 11210.8 11282.2 11311.7 11570.0 11735.9 10404.7 11077.7 11235.4 11419.5 11615.5 11168.8 11199.3 11563.5 11581.5 11724.4 8273.8 8277.5 8365.4 8469.2 8534.5 11299.1 11324.8 11473.4 12040.6 12183.1 08:26:53 INFO - PROCESS | 3128 | 08:26:53 INFO - PROCESS | 3128 | [#3] mootools.html Cycles:180 Average:5694.44 Median:4739.76 stddev:3167.08 (66.8%) stddev-sans-first:3159.14 08:26:53 INFO - PROCESS | 3128 | Values: 1351.2 1510.7 1535.4 1708.3 1821.4 8151.1 8445.7 8453.2 8454.0 8461.2 8364.7 8492.3 8505.2 8528.2 8534.9 2079.4 2153.3 2300.6 2312.3 2331.8 2336.0 2364.4 2367.4 2367.8 2371.2 2327.9 2349.6 2351.3 2353.4 2380.9 2013.1 2257.3 2259.9 2266.3 2324.3 2334.0 2355.3 2355.6 2359.5 2359.6 8335.4 8363.0 8399.3 8413.5 8462.2 4984.7 5137.6 5145.3 5176.1 5190.8 3329.0 3388.3 3449.8 3479.2 3533.2 1143.9 1152.7 1168.8 1175.3 1220.3 11587.8 11865.3 11895.0 11895.0 11949.4 4488.0 4528.3 4636.7 4649.2 4656.3 10247.2 10269.7 10284.9 10286.0 10304.7 5082.4 5086.1 5091.8 5094.6 5121.7 4257.1 4659.6 4681.7 4797.8 4846.0 3905.5 3972.3 3998.4 4010.7 4054.4 1278.2 1284.8 1307.2 1309.6 1313.5 899.4 946.3 947.2 953.0 955.3 5808.1 5901.9 5922.4 6021.4 6047.0 1015.0 1081.2 1095.3 1100.1 1113.4 4087.0 4188.4 4191.7 4199.4 4232.9 10408.5 10631.2 10765.6 10770.9 10816.7 10043.5 10578.5 10704.1 10726.6 10730.5 7895.0 8109.6 8187.5 8188.3 8202.5 5828.3 5886.1 5890.2 5890.9 6030.0 9538.6 9713.3 9727.2 9792.2 9807.9 9834.0 9987.4 10016.7 10068.0 10130.7 7035.2 7338.7 7564.3 7627.9 7755.2 8137.3 8137.8 8154.5 8188.0 8209.1 7171.2 7429.5 7435.6 7497.6 7580.2 7266.2 7355.0 7376.0 7401.6 7431.6 6941.2 6969.5 7021.0 7027.3 7044.3 5083.6 5181.8 5233.7 5289.4 5496.9 5230.4 5265.6 5321.3 5443.8 5453.8 08:26:53 INFO - PROCESS | 3128 | 08:26:53 INFO - PROCESS | 3128 | [#4] prototype.html Cycles:180 Average:4995.99 Median:5727.34 stddev:1507.50 (26.3%) stddev-sans-first:1470.50 08:26:53 INFO - PROCESS | 3128 | Values: 331.2 333.3 334.2 339.0 347.1 5558.4 5654.7 5654.9 5757.7 5818.6 5685.5 5702.1 5713.5 5725.9 5733.5 4367.7 4381.4 4385.8 4387.9 4392.7 4008.7 4088.2 4320.7 4331.2 4344.5 4284.0 4313.1 4319.7 4323.6 4331.5 4139.4 4322.4 4322.7 4336.5 4341.7 3690.8 3781.5 3792.6 3797.3 3804.5 5445.5 5449.9 5450.6 5452.5 5460.6 4733.5 4965.1 4983.5 4994.1 4996.7 5943.4 5956.6 5961.3 5962.5 5966.1 4173.6 4184.9 4185.0 4194.2 4198.3 6007.5 6160.1 6229.1 6256.6 6260.0 4237.6 4237.9 4238.4 4250.4 4268.3 4285.0 4304.3 4306.5 4307.5 4319.2 4811.7 4944.3 4964.7 4974.1 4978.8 5927.4 5932.8 5937.3 5987.9 5987.9 1458.6 1478.4 1478.7 1481.5 1485.5 972.2 995.5 1004.4 1005.0 1014.5 5704.1 5714.1 5734.2 5750.9 5753.4 6139.5 6146.5 6153.2 6163.9 6166.2 5539.8 5680.8 5718.7 5720.9 5728.7 3273.2 3274.3 3280.7 3285.4 3295.2 6100.7 6367.5 6388.1 6397.8 6439.8 6034.6 6215.2 6294.2 6309.1 6353.3 6260.7 6392.9 6421.4 6426.7 6443.8 6162.5 6173.5 6211.2 6220.0 6249.7 5996.3 6082.9 6113.0 6128.5 6157.9 6400.8 6416.5 6422.4 6424.3 6438.1 3982.5 4218.2 4247.6 4257.4 4288.8 6101.8 6114.6 6153.9 6169.7 6175.0 5954.7 5961.1 5962.0 5978.5 6007.2 5823.0 5951.9 5977.5 5982.6 5983.9 5789.1 5825.9 5844.8 5884.9 5887.8 5942.3 5977.4 6014.3 6034.1 6046.3 5834.8 5848.1 5874.2 5878.4 5888.6 08:26:53 INFO - PROCESS | 3128 | 08:26:53 INFO - PROCESS | 3128 | [#5] yui.html Cycles:180 Average:14383.07 Median:24580.23 stddev:15842.75 (64.5%) stddev-sans-first:15854.41 08:26:53 INFO - PROCESS | 3128 | Values: 811.4 837.2 838.8 839.2 850.7 13510.4 13649.2 13651.7 14435.3 14712.1 12163.0 12894.9 12954.7 12971.9 12982.1 802.2 826.7 827.4 827.7 830.0 831.3 832.9 837.1 837.7 838.0 861.9 863.3 863.5 864.7 867.9 722.3 738.0 738.3 839.3 866.5 630.9 634.8 635.4 635.6 636.7 14173.1 14230.6 14255.1 14258.6 14263.7 14012.5 14293.9 14316.0 14330.7 14347.0 11695.9 11891.6 11986.8 12074.8 12363.3 3848.4 3892.9 3953.2 3972.6 4031.3 54938.7 55389.2 57378.7 57512.7 57780.0 11062.9 11255.0 11294.6 11458.5 11594.8 20280.2 20320.7 20343.2 20364.2 20397.5 8086.8 8338.8 8381.0 8450.3 8615.3 4457.5 4508.3 4515.1 4517.8 4550.4 3209.8 3299.2 3312.0 3313.5 3319.6 641.7 646.5 662.4 678.5 701.5 673.9 675.7 765.2 769.6 783.9 9124.4 9157.9 9281.1 9291.5 9369.2 638.7 659.5 713.4 750.3 772.2 4650.8 4753.2 4769.3 4821.1 4843.7 51602.0 53213.5 53264.5 53290.5 67382.0 47180.3 47584.8 47838.5 47938.5 50021.0 44126.1 44703.0 44846.8 45233.5 46241.0 8952.9 8958.8 9031.1 9108.7 9149.2 30736.4 31567.4 32237.0 32921.0 33371.3 38975.2 40431.8 44090.8 44162.0 44823.6 12295.3 12339.9 12389.8 12403.4 12752.1 13811.4 14037.6 14339.9 14750.1 14802.1 13090.6 13127.5 13599.3 13629.9 13964.4 12733.4 13067.4 13205.5 13542.6 13577.6 11935.8 12426.6 12535.6 12729.6 12990.1 10933.7 11091.5 11213.0 11297.9 11742.9 11121.5 11231.5 11250.2 11573.1 11611.5 08:26:53 INFO - PROCESS | 3128 | -------- Summary: end -------- 08:26:53 INFO - PROCESS | 3128 | 08:26:54 INFO - TEST-INFO | 3128: exit 0 08:26:54 INFO - TEST-OK | dromaeo_css | took 1111177ms 08:26:54 INFO - TEST-START | kraken 08:26:54 INFO - operating with platform_type : linux_ 08:26:54 INFO - Initialising browser for kraken test... 08:26:54 INFO - TEST-INFO | started process 3328 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC16FAF/profile http://localhost:48033/getInfo.html) 08:26:58 INFO - PROCESS | 3328 | __metrics Screen width/height:1600/1200 08:26:58 INFO - PROCESS | 3328 | colorDepth:24 08:26:58 INFO - PROCESS | 3328 | Browser inner width/height: 1024/697 08:26:58 INFO - PROCESS | 3328 | __metrics 08:26:58 ERROR - PROCESS | 3328 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:26:59 INFO - TEST-INFO | 3328: exit 0 08:26:59 INFO - Browser initialized. 08:26:59 INFO - Running cycle 1/1 for kraken test... 08:26:59 INFO - TEST-INFO | started process 3407 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC16FAF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:27:11 INFO - PROCESS | 3407 | RSS: Main: 152449024 08:27:11 INFO - PROCESS | 3407 | 08:27:14 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:48033/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48033/tests/kraken/driver.html?testName=audio-beat-detection) 08:27:14 INFO - PROCESS | 3407 | RSS: Main: 207884288 08:27:14 INFO - PROCESS | 3407 | 08:27:17 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:48033/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48033/tests/kraken/driver.html?testName=audio-dft) 08:27:18 INFO - PROCESS | 3407 | RSS: Main: 194203648 08:27:18 INFO - PROCESS | 3407 | 08:27:21 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:48033/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48033/tests/kraken/driver.html?testName=audio-fft) 08:27:21 INFO - PROCESS | 3407 | RSS: Main: 264974336 08:27:21 INFO - PROCESS | 3407 | 08:27:23 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:48033/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48033/tests/kraken/driver.html?testName=audio-oscillator) 08:27:24 INFO - PROCESS | 3407 | RSS: Main: 172531712 08:27:24 INFO - PROCESS | 3407 | 08:27:26 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:48033/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48033/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:27:27 INFO - PROCESS | 3407 | RSS: Main: 176439296 08:27:27 INFO - PROCESS | 3407 | 08:27:30 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:48033/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48033/tests/kraken/driver.html?testName=imaging-darkroom) 08:27:30 INFO - PROCESS | 3407 | RSS: Main: 213090304 08:27:30 INFO - PROCESS | 3407 | 08:27:34 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:48033/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48033/tests/kraken/driver.html?testName=imaging-desaturate) 08:27:34 INFO - PROCESS | 3407 | RSS: Main: 214106112 08:27:34 INFO - PROCESS | 3407 | 08:27:37 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:48033/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48033/tests/kraken/driver.html?testName=json-parse-financial) 08:27:38 INFO - PROCESS | 3407 | RSS: Main: 214315008 08:27:38 INFO - PROCESS | 3407 | 08:27:39 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:48033/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48033/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:27:40 INFO - PROCESS | 3407 | RSS: Main: 203939840 08:27:40 INFO - PROCESS | 3407 | 08:27:41 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:48033/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48033/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:27:42 INFO - PROCESS | 3407 | RSS: Main: 204460032 08:27:42 INFO - PROCESS | 3407 | 08:27:44 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:48033/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48033/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:27:45 INFO - PROCESS | 3407 | RSS: Main: 218013696 08:27:45 INFO - PROCESS | 3407 | 08:27:47 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:48033/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48033/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:27:48 INFO - PROCESS | 3407 | RSS: Main: 222822400 08:27:48 INFO - PROCESS | 3407 | 08:27:51 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:48033/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48033/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:27:51 INFO - PROCESS | 3407 | RSS: Main: 219561984 08:27:51 INFO - PROCESS | 3407 | 08:27:53 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:48033/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48033/tests/kraken/driver.html?testName=ai-astar) 08:27:53 INFO - PROCESS | 3407 | RSS: Main: 282992640 08:27:53 INFO - PROCESS | 3407 | 08:27:53 INFO - PROCESS | 3407 | __start_tp_report 08:27:53 INFO - PROCESS | 3407 | _x_x_mozilla_page_load 08:27:53 INFO - PROCESS | 3407 | _x_x_mozilla_page_load_details 08:27:53 INFO - PROCESS | 3407 | |i|pagename|runs| 08:27:53 INFO - PROCESS | 3407 | |0;ai-astar;109;111;105;109;111;112;99;110;110;112 08:27:53 INFO - PROCESS | 3407 | |1;audio-beat-detection;159;127;151;192;134;148;155;130;209;128 08:27:53 INFO - PROCESS | 3407 | |2;audio-dft;163;162;161;162;163;161;162;162;161;162 08:27:53 INFO - PROCESS | 3407 | |3;audio-fft;71;73;107;120;73;72;76;128;101;76 08:27:53 INFO - PROCESS | 3407 | |4;audio-oscillator;93;92;145;92;92;92;150;92;92;143 08:27:53 INFO - PROCESS | 3407 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;117;117 08:27:53 INFO - PROCESS | 3407 | |6;imaging-darkroom;145;145;145;145;145;147;146;145;145;145 08:27:53 INFO - PROCESS | 3407 | |7;imaging-desaturate;95;94;96;94;94;95;95;94;94;95 08:27:53 INFO - PROCESS | 3407 | |8;json-parse-financial;57;57;56;57;57;59;56;72;56;53 08:27:53 INFO - PROCESS | 3407 | |9;json-stringify-tinderbox;61;60;60;60;60;60;59;60;60;60 08:27:53 INFO - PROCESS | 3407 | |10;stanford-crypto-aes;77;77;76;77;78;77;76;78;78;78 08:27:53 INFO - PROCESS | 3407 | |11;stanford-crypto-ccm;150;126;127;127;122;123;122;123;158;126 08:27:53 INFO - PROCESS | 3407 | |12;stanford-crypto-pbkdf2;169;172;164;165;170;168;166;173;171;164 08:27:53 INFO - PROCESS | 3407 | |13;stanford-crypto-sha256-iterative;69;68;67;68;67;69;67;68;68;67 08:27:53 INFO - PROCESS | 3407 | __end_tp_report 08:27:53 INFO - PROCESS | 3407 | __start_cc_report 08:27:53 INFO - PROCESS | 3407 | _x_x_mozilla_cycle_collect,1630 08:27:53 INFO - PROCESS | 3407 | __end_cc_report 08:27:53 INFO - PROCESS | 3407 | __startTimestamp1460993273815__endTimestamp 08:27:53 INFO - PROCESS | 3407 | 08:27:53 INFO - PROCESS | 3407 | ------- Summary: start ------- 08:27:53 INFO - PROCESS | 3407 | Number of tests: 14 08:27:53 INFO - PROCESS | 3407 | 08:27:53 INFO - PROCESS | 3407 | [#0] ai-astar Cycles:10 Average:108.80 Median:111.00 stddev:3.99 (3.6%) stddev-sans-first:4.24 08:27:53 INFO - PROCESS | 3407 | Values: 109.0 111.0 105.0 109.0 111.0 112.0 99.0 110.0 110.0 112.0 08:27:53 INFO - PROCESS | 3407 | 08:27:53 INFO - PROCESS | 3407 | [#1] audio-beat-detection Cycles:10 Average:153.30 Median:153.00 stddev:27.72 (18.1%) stddev-sans-first:29.33 08:27:53 INFO - PROCESS | 3407 | Values: 159.0 127.0 151.0 192.0 134.0 148.0 155.0 130.0 209.0 128.0 08:27:53 INFO - PROCESS | 3407 | 08:27:53 INFO - PROCESS | 3407 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 08:27:53 INFO - PROCESS | 3407 | Values: 163.0 162.0 161.0 162.0 163.0 161.0 162.0 162.0 161.0 162.0 08:27:53 INFO - PROCESS | 3407 | 08:27:53 INFO - PROCESS | 3407 | [#3] audio-fft Cycles:10 Average:89.70 Median:72.50 stddev:22.13 (30.5%) stddev-sans-first:22.42 08:27:53 INFO - PROCESS | 3407 | Values: 71.0 73.0 107.0 120.0 73.0 72.0 76.0 128.0 101.0 76.0 08:27:53 INFO - PROCESS | 3407 | 08:27:53 INFO - PROCESS | 3407 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:92.00 stddev:26.07 (28.3%) stddev-sans-first:27.06 08:27:53 INFO - PROCESS | 3407 | Values: 93.0 92.0 145.0 92.0 92.0 92.0 150.0 92.0 92.0 143.0 08:27:53 INFO - PROCESS | 3407 | 08:27:53 INFO - PROCESS | 3407 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:27:53 INFO - PROCESS | 3407 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 08:27:53 INFO - PROCESS | 3407 | 08:27:53 INFO - PROCESS | 3407 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 08:27:53 INFO - PROCESS | 3407 | Values: 145.0 145.0 145.0 145.0 145.0 147.0 146.0 145.0 145.0 145.0 08:27:53 INFO - PROCESS | 3407 | 08:27:53 INFO - PROCESS | 3407 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 08:27:53 INFO - PROCESS | 3407 | Values: 95.0 94.0 96.0 94.0 94.0 95.0 95.0 94.0 94.0 95.0 08:27:53 INFO - PROCESS | 3407 | 08:27:53 INFO - PROCESS | 3407 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:57.00 stddev:5.14 (9.0%) stddev-sans-first:5.44 08:27:53 INFO - PROCESS | 3407 | Values: 57.0 57.0 56.0 57.0 57.0 59.0 56.0 72.0 56.0 53.0 08:27:53 INFO - PROCESS | 3407 | 08:27:53 INFO - PROCESS | 3407 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:0.47 (0.8%) stddev-sans-first:0.33 08:27:53 INFO - PROCESS | 3407 | Values: 61.0 60.0 60.0 60.0 60.0 60.0 59.0 60.0 60.0 60.0 08:27:53 INFO - PROCESS | 3407 | 08:27:53 INFO - PROCESS | 3407 | [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:77.50 stddev:0.79 (1.0%) stddev-sans-first:0.83 08:27:53 INFO - PROCESS | 3407 | Values: 77.0 77.0 76.0 77.0 78.0 77.0 76.0 78.0 78.0 78.0 08:27:53 INFO - PROCESS | 3407 | 08:27:53 INFO - PROCESS | 3407 | [#11] stanford-crypto-ccm Cycles:10 Average:130.40 Median:126.50 stddev:12.73 (10.1%) stddev-sans-first:11.36 08:27:53 INFO - PROCESS | 3407 | Values: 150.0 126.0 127.0 127.0 122.0 123.0 122.0 123.0 158.0 126.0 08:27:53 INFO - PROCESS | 3407 | 08:27:53 INFO - PROCESS | 3407 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.20 Median:169.50 stddev:3.33 (2.0%) stddev-sans-first:3.52 08:27:53 INFO - PROCESS | 3407 | Values: 169.0 172.0 164.0 165.0 170.0 168.0 166.0 173.0 171.0 164.0 08:27:53 INFO - PROCESS | 3407 | 08:27:53 INFO - PROCESS | 3407 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:0.79 (1.2%) stddev-sans-first:0.71 08:27:53 INFO - PROCESS | 3407 | Values: 69.0 68.0 67.0 68.0 67.0 69.0 67.0 68.0 68.0 67.0 08:27:53 INFO - PROCESS | 3407 | -------- Summary: end -------- 08:27:53 INFO - PROCESS | 3407 | 08:27:54 INFO - TEST-INFO | 3407: exit 0 08:27:54 INFO - TEST-OK | kraken | took 60466ms 08:27:54 INFO - SUITE-END | took 1171s 08:27:54 INFO - Completed test suite (00:19:31) 08:27:54 INFO - javascript benchmark 08:27:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3040.7111324424177, 3066.693330666935, 3111.564380986661, 3111.813291202528, 3136.9648016154665, 5245.44922783108, 5246.449122842104, 5263.105272103747, 5299.496547827955, 5325.281087053247, 5343.679379237239, 5367.275417818593, 5413.891722165555, 5414.16080507521, 5468.6171967962255, 4782.880427989293, 4818.397700287464, 4896.167651499236, 4907.411110666725, 4951.752412379385, 4863.0, 4882.932149954434, 4914.410270767513, 4920.3357546731095, 4936.876578085541, 4747.90504189916, 4808.951910480903, 4850.417949846041, 4900.313956046157, 4911.5088491150955, 4827.51724827518, 4856.1016212000895, 4872.3422337984275, 4883.12103821312, 4914.11545921734, 4779.354787103731, 4807.158747219222, 4838.467768545457, 4854.805807767721, 4882.951170488321, 5299.655522391032, 5317.308749862493, 5337.839864804062, 5354.759035843396, 5387.4073851876265, 5657.20799088128, 5668.178114173463, 5672.376038635747, 5677.034904066319, 5677.716114194273, 5646.632968857052, 5711.600187986843, 5715.057015592422, 5720.71396430181, 5725.112607545837, 5278.155495120801, 5307.734613269321, 5308.991291654612, 5313.362396512443, 5356.009138309386, 5804.01331773591, 5805.8548536286935, 5810.0, 5810.1865738796605, 5828.708564571754, 5487.396386397493, 5546.27898373217, 5575.33096028471, 5590.86022849432, 5624.072028115397, 5567.638103523258, 5588.21764952907, 5589.636673616284, 5590.468905453975, 5643.351014633287, 5499.3675727291875, 5552.500274975271, 5557.444255574491, 5558.666480011212, 5576.553875689935, 5476.123820188751, 5608.579356548275, 5654.349749778746, 5775.971120144372, 5793.044147715664, 4306.461692288464, 4331.891702707395, 4332.241857674894, 4335.132973405269, 4364.476262848479, 3847.304791924335, 3875.9612403876163, 3895.376739721631, 3923.2741942740686, 3926.0, 5218.452062533455, 5235.554977826851, 5299.5760339172775, 5299.973500132474, 5307.203919412042, 5688.0, 5690.402507736628, 5692.686902220417, 5707.029804933171, 5708.743106560215, 5292.206169074592, 5297.284866543045, 5297.894042119213, 5310.6813591184655, 5352.518273355417, 4647.372604698322, 4791.928121078186, 4816.686915350491, 4854.514548545188, 4863.10032643962, 5898.528117750569, 5934.109883517507, 5935.317438494542, 5936.5547583931375, 5939.198208241918, 5572.108462645957, 5734.0, 5735.225744524602, 5739.713014349182, 5742.454466825645, 5847.883042339215, 5936.1095835625, 5947.345791962967, 5973.880522389441, 5987.401259873977, 5569.0, 5571.1086226203615, 5575.303087114111, 5578.721063946705, 5590.189422533628, 5650.378458369658, 5668.971655141863, 5677.914831277451, 5678.375378708256, 5705.7432415542235, 5567.582431317586, 5578.051731205624, 5579.163125531203, 5589.301337332833, 5643.209950606836, 5505.394406615189, 5558.194061860927, 5568.526675232489, 5570.470805273492, 5570.5265052470995, 5299.5230429261555, 5325.227841962971, 5403.027455058127, 5469.507744303032, 5525.143602741421, 5590.776368945197, 5599.440055994368, 5600.327960644749, 5608.775648973995, 5608.775648974159, 5451.0, 5481.177823326533, 5481.835544933659, 5483.396826349019, 5490.368607610176], "value": 5234.804877113173, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.4887396838718, 644.5294934697671, 647.8024202618202, 656.4518626946499, 668.8027032025554, 30377.544336834937, 37142.814285928565, 38307.42538861912, 38335.42496862549, 38382.61617383825, 40744.38883416751, 41342.37986430206, 41514.58485415145, 41519.79240103795, 41530.7923460383, 7758.107817600963, 8456.365772567051, 8649.351298652595, 8670.566471676391, 9898.851517227247, 9976.152027077671, 10098.0, 10135.89864101357, 10142.645007424742, 10149.289549731522, 10100.949495252513, 10210.897891021106, 10213.080822725953, 10222.182225421986, 10240.078392944633, 7932.643031063587, 10096.899031009669, 10225.0, 10597.099246564052, 10599.0, 9773.804523909554, 9928.751781205456, 9932.900670993342, 9938.850917236246, 9954.552045157912, 37361.439578406345, 37985.620143798486, 38016.809915950245, 38051.80974095112, 38099.23801523954, 3536.7701099428455, 3558.1460449491938, 3572.7141828653644, 3602.783832970004, 3709.350863598859, 30755.384892302252, 30880.0, 31115.0, 31418.528722069186, 32116.518252226237, 4321.611055005033, 4357.869263922087, 4375.846845360397, 4386.473623165209, 4401.5598440156045, 302655.0, 305001.0, 306216.0, 307068.0, 307317.0, 58543.70728146332, 58661.70669146627, 58943.0, 59164.40835591675, 59281.0, 61127.69436152791, 61260.099192064525, 61313.693431532556, 61387.69306153441, 61496.38503614996, 16035.759463608056, 16355.427560035341, 16388.344466221217, 16399.590010249838, 16408.425705100504, 12177.0, 12267.263964162179, 12316.322602256962, 12335.321557314433, 12335.50657973671, 17184.0, 17203.741943870853, 17499.12504374776, 17501.38745143914, 17530.211140498708, 5010.323606313174, 5834.241548598655, 5845.327787304429, 5972.910406343908, 6107.541934354941, 1033.4884232305058, 1054.314695447965, 1059.3220338983058, 1114.9888501114885, 1129.5538262386312, 30325.241868953453, 31166.844165779024, 31666.208344791565, 31734.523982140287, 31875.710043250612, 1126.6901602059336, 1152.8558930133734, 1160.066146751856, 1164.301419148504, 1179.257068047125, 16091.597710057107, 16847.915760421118, 17002.0, 17072.317107315568, 17238.310467581156, 381987.0, 385096.0, 385678.0, 387166.0, 388623.0, 54794.452055478934, 54800.725996369765, 55096.44903550993, 55178.44821551813, 55327.44672553223, 1360.2722543439213, 1380.8469927610558, 1383.5157694806937, 1395.5185461015933, 1411.7811739180443, 29775.851120744257, 30636.234094146934, 31139.68860311368, 31218.843905780326, 31802.0, 48844.0, 48979.0, 49081.26378104403, 49263.75368123136, 49267.26099108588, 259950.90171843895, 262144.0, 262325.0, 262746.0, 262817.0, 36408.81795591005, 38839.6116038836, 40659.18681626292, 42128.36807447952, 42591.3611295837, 43361.0, 43433.56566434421, 43591.12817743564, 44162.33756493591, 44169.55830441655, 35927.862362667656, 36982.44526332161, 37037.44443833399, 37180.44229336616, 37314.0, 36128.27743445064, 36783.63216367802, 36886.26227475489, 37232.0, 37366.252674946896, 37052.62947370492, 38357.0, 38402.07859694751, 38472.0, 38996.22007559776, 31598.91193132117, 33026.33947321088, 33142.5028624566, 33424.83287583644, 33804.32391352209, 26278.868605656848, 26616.201513954613, 26803.597946030433, 26809.329766755985, 27351.452970940867], "value": 19374.2170748775, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.87460012795907, 395.7486995757695, 396.5122898834434, 399.5305516018677, 402.2337447163155, 14327.570172894804, 16618.418355357564, 17941.372051978167, 18551.257949682014, 18578.62842743146, 15267.312970916308, 16987.3205071797, 17668.0, 17695.380661676845, 18242.270309187617, 4718.57532822046, 5026.52248036436, 5032.798688052473, 5034.748262586874, 5042.672226305297, 4789.114013907439, 4922.384701912261, 4957.206846904496, 5078.746062696869, 5082.720450375228, 5047.798088076491, 5050.368703912011, 5054.166062599685, 5062.544371006608, 5085.491450854922, 4973.502649735034, 5030.924536131943, 5057.924131138036, 5071.391433028023, 5230.529252367267, 5042.722650254234, 5044.949550504484, 5064.873378165538, 5082.23766435034, 5083.161278389061, 12773.61679149627, 15791.763123553155, 20770.06534705942, 22083.227087051877, 22451.55096898053, 2300.5513924784673, 2346.554154710617, 2581.935451613706, 2681.1554360376417, 2734.644496215479, 9969.601215951427, 10092.142167915736, 10123.088921996981, 10186.796264074677, 10393.168546516335, 1851.8703690741654, 1919.424172748184, 1987.4534503011644, 2011.5071807407278, 2036.1855257896812, 65857.0, 71664.0, 75614.62192689002, 78131.0, 79468.60265698635, 10295.330803497749, 10994.725131871768, 10996.780064398827, 11002.779944401067, 11112.388818614892, 15321.387144514318, 15382.153981530899, 15393.384264629512, 15405.922970385076, 15462.0, 7105.609191494414, 7468.813279667943, 7505.399568034544, 7819.609019549, 7909.920900791033, 7530.774076777706, 7543.811404714926, 7551.169371369145, 7696.037995250594, 7725.5364678119495, 4603.723776573416, 4651.62786977041, 4671.159191345522, 4711.8350857719815, 4722.173619616553, 1874.8687591868438, 1910.2645481489449, 1942.805719428046, 1954.257382194757, 1985.7120717495882, 977.9511024448749, 983.7688143286322, 1061.5276202089997, 1067.80779459698, 1081.7944590527932, 19054.809451905305, 19108.0, 19129.713054304197, 19200.423987280403, 19564.119614617375, 1025.5846382215216, 1026.7997740440692, 1064.1699474409972, 1088.1784252889017, 1102.4212288548576, 10511.1591072714, 10947.726306842233, 11034.779304413867, 11044.613438529774, 11096.500657470433, 458146.0, 465967.0, 495995.0, 500430.0, 500457.0, 89011.0, 90663.8402543761, 90852.54573727089, 90859.0, 92877.0, 1022.25375475903, 1024.5491983527224, 1025.676911772804, 1026.14829691356, 1049.7113293844102, 15891.682166356839, 16858.915705421394, 16881.91559042197, 16883.155842207594, 17228.31086756566, 34068.318633627685, 36572.085697857765, 37124.44313335356, 38065.0, 39802.800985996044, 49600.0, 50461.49538504715, 50840.0, 51166.48833511617, 51767.74116129546, 7277.2722727726805, 7606.429517786078, 7676.117246516722, 7741.225877412214, 8586.78533036679, 9243.2143267823, 12136.514539418324, 12924.547640832525, 12926.482940682643, 13042.739145217232, 11210.775784484102, 11282.153838461983, 11311.660650180507, 11570.0, 11735.882641173479, 10404.739881503023, 11077.72305692332, 11235.382053986783, 11419.543218271176, 11615.477303521193, 11168.776624467628, 11199.272047317225, 11563.479643415898, 11581.536738530365, 11724.41377931083, 8273.751787446387, 8277.54473503963, 8365.372597055124, 8469.195426434479, 8534.487930724177, 11299.09607231436, 11324.773504530029, 11473.368964706688, 12040.638780836589, 12183.086268530073], "value": 8803.623875674404, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1351.2433037499006, 1510.6525499135198, 1535.4088675859794, 1708.273983556988, 1821.4262507310189, 8151.144129866368, 8445.704400345981, 8453.1969462901, 8454.0, 8461.23848853603, 8364.665413383473, 8492.278156356702, 8505.192006759364, 8528.232459078681, 8534.91465085349, 2079.396974877284, 2153.267888917768, 2300.620397634397, 2312.3409828198965, 2331.7901388875, 2336.0, 2364.408897775556, 2367.4081479630095, 2367.75138610446, 2371.2412028150998, 2327.93016209514, 2349.647552867075, 2351.341624345186, 2353.411647088228, 2380.9047638094457, 2013.0739859664498, 2257.322803159062, 2259.9096036158535, 2266.3087758233733, 2324.2910912171783, 2334.043042352644, 2355.2698663414394, 2355.5759963206615, 2359.4691194481275, 2359.6460530920326, 8335.374846886507, 8363.0, 8399.328053755686, 8413.49519028854, 8462.238398544161, 4984.675996060245, 5137.588992880561, 5145.30538377318, 5176.120059589879, 5190.8183213587345, 3328.9500657490157, 3388.2545839915424, 3449.7930124192376, 3479.234568394949, 3533.1873669056004, 1143.891330323618, 1152.7463957929326, 1168.8428455828753, 1175.300696085836, 1220.2983284611385, 11587.826182607268, 11865.288082714978, 11895.04839612829, 11895.04839612829, 11949.402529873472, 4488.0, 4528.252838281646, 4636.698614590041, 4649.209634362167, 4656.32483289921, 10247.231457640706, 10269.7432564185, 10284.897151028394, 10286.0, 10304.690859274233, 5082.440931497532, 5086.135356989321, 5091.847244582668, 5094.643374963717, 5121.743912804345, 4257.148570285955, 4659.5573420525, 4681.719096854132, 4797.808087676523, 4846.0, 3905.5313362396696, 3972.3445631471063, 3998.4402183693724, 4010.6590939770444, 4054.412110244057, 1278.181963543333, 1284.7880099783617, 1307.1503522710314, 1309.5678426119357, 1313.4746101559263, 899.3794281945437, 946.3328353510758, 947.2185447006248, 952.9952350238204, 955.302629080761, 5808.128780682847, 5901.911471327933, 5922.378150294243, 6021.397860213943, 6046.969765151146, 1014.9898501014895, 1081.2053140941402, 1095.27164435651, 1100.1318175961612, 1113.3653817324048, 4086.979565102215, 4188.392683061, 4191.7484950903045, 4199.391088292181, 4232.936505952413, 10408.47957602117, 10631.202659800545, 10765.569377224823, 10770.946145269223, 10816.67549973502, 10043.497825108716, 10578.471076446302, 10704.1436685065, 10726.624568140078, 10730.463476826128, 7895.0, 8109.635066422025, 8187.5087494750505, 8188.303994160563, 8202.507849529047, 5828.300603927386, 5886.117082437498, 5890.175375447527, 5890.911636325544, 6029.969850150721, 9538.570764315762, 9713.320067595483, 9727.173190278905, 9792.216622670312, 9807.9019209807, 9834.0, 9987.350822196535, 10016.699499015042, 10068.0, 10130.746731331776, 7035.1909530404655, 7338.743143989935, 7564.281393267631, 7627.8855817161675, 7755.2244775521995, 8137.308328792119, 8137.8372432552205, 8154.510729356258, 8187.959060204661, 8209.055958564602, 7171.1753148386515, 7429.4799364044, 7435.628218589157, 7497.550146991198, 7580.204078571671, 7266.237045110187, 7354.96322518384, 7376.0, 7401.629918504161, 7431.554106753612, 6941.236463989058, 6969.477289203432, 7020.964895175492, 7027.262137475492, 7044.295570442915, 5083.5678967288195, 5181.792728290826, 5233.685978841282, 5289.418164002033, 5496.890062198654, 5230.424653288212, 5265.6050796189675, 5321.255024296524, 5443.755031023693, 5453.809116680897], "value": 4606.236228787849, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.2315428206561, 333.2834406027042, 334.2095943094582, 339.04727715120515, 347.0906225688696, 5558.360788509322, 5654.717264136797, 5654.869026194762, 5757.740901659425, 5818.5926985111055, 5685.459881311279, 5702.146802289262, 5713.514351280146, 5725.942740572593, 5733.512651424634, 4367.737935723851, 4381.408509851177, 4385.780710964447, 4387.890302742425, 4392.692511524195, 4008.6993475489307, 4088.2436749201343, 4320.719153255044, 4331.177076355482, 4344.4786625604975, 4283.97858010711, 4313.137372525492, 4319.69762116652, 4323.62200789566, 4331.480222373304, 4139.441175441307, 4322.351647252905, 4322.708964248953, 4336.457942757155, 4341.6526677865695, 3690.760100593453, 3781.508403907502, 3792.563855156637, 3797.297499962488, 3804.5434547854156, 5445.50990410861, 5449.891002179974, 5450.591205659552, 5452.482014208644, 5460.590455715837, 4733.526647335273, 4965.131102057126, 4983.476734942851, 4994.101061808873, 4996.650234483587, 5943.4056594340655, 5956.612820166719, 5961.344252132262, 5962.4633782959745, 5966.134910437962, 4173.64524015456, 4184.916301673949, 4185.0, 4194.224068547329, 4198.349255865346, 6007.519398448114, 6160.137580738656, 6229.127922090911, 6256.593321434092, 6259.968700156515, 4237.618614324664, 4237.87286381409, 4238.385434112037, 4250.36244563318, 4268.338407546835, 4284.978575107105, 4304.311310190355, 4306.4832220133785, 4307.483102027777, 4319.244132276839, 4811.687240329367, 4944.307796908363, 4964.652474326835, 4974.134699487692, 4978.780198851232, 5927.3776253493625, 5932.762689492458, 5937.2578427696535, 5987.9101813472835, 5987.940120598825, 1458.6353411647087, 1478.4234148681808, 1478.733827910965, 1481.525911708243, 1485.532057401915, 972.2222222222194, 995.4873240281261, 1004.4073996342194, 1004.9849252261222, 1014.4623349624711, 5704.058830293038, 5714.085746280575, 5734.197212390269, 5750.856228594235, 5753.424657534297, 6139.508839292846, 6146.508279337731, 6153.230846144232, 6163.907541386883, 6166.229221347332, 5539.778408863681, 5680.7727690892725, 5718.68547229898, 5720.914186287209, 5728.742206600713, 3273.2471531547876, 3274.312394397203, 3280.7375409967144, 3285.4250506161325, 3295.20914980403, 6100.664463454464, 6367.522435817332, 6388.105665206875, 6397.816403965281, 6439.8068057958335, 6034.577579569388, 6215.160953271341, 6294.213223347082, 6309.1167236586, 6353.301136875032, 6260.652255404223, 6392.904106438407, 6421.389967953037, 6426.710798014195, 6443.806685799434, 6162.537809664203, 6173.536984726254, 6211.16149319836, 6220.0, 6249.687515624291, 5996.280446346466, 6082.939170608237, 6112.991356426318, 6128.540359472968, 6157.876842463215, 6400.775972840928, 6416.45460135875, 6422.3577642235405, 6424.261209960914, 6438.130852335063, 3982.5420076691553, 4218.186179942654, 4247.5540068292385, 4257.403963445058, 4288.807003684904, 6101.847453813512, 6114.633122012693, 6153.876922461615, 6169.660668663267, 6175.0, 5954.702264886651, 5961.105834124916, 5962.0, 5978.461938425563, 6007.219061521974, 5822.970885145547, 5951.880962380815, 5977.491913187428, 5982.58121931478, 5983.940160598512, 5789.102689083199, 5825.854353641193, 5844.795432159854, 5884.882302353843, 5887.764489420375, 5942.346341902301, 5977.432143946318, 6014.27828660546, 6034.09488576717, 6046.27444706638, 5834.824955251349, 5848.093545500455, 5874.236349274567, 5878.441548052928, 5888.646681199141], "value": 4509.7572088767065, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [811.3792948394479, 837.1921096142223, 838.8028813228894, 839.24048735894, 850.6512329944716, 13510.392032358543, 13649.181049137058, 13651.658708532292, 14435.278236088207, 14712.11727296363, 12163.0, 12894.935525322384, 12954.676133096676, 12971.870281297184, 12982.09125361225, 802.2258520527689, 826.6528058215533, 827.3711978896052, 827.6854795177824, 829.9626516806758, 831.3349320543541, 832.937529685273, 837.0583094019229, 837.6984285657159, 838.0069617503278, 861.9310455163603, 863.2705363967438, 863.4948555095277, 864.6627815152095, 867.8915135608049, 722.2596838240793, 738.018435480812, 738.2764890407377, 839.307571253712, 866.4801119328384, 630.8738252349549, 634.7810005548125, 635.3678090300181, 635.6376865186845, 636.6593872278308, 14173.149611023371, 14230.573082807532, 14255.073420227653, 14258.64353391163, 14263.714725705531, 14012.509562165376, 14293.857061429357, 14316.0, 14330.713385732228, 14347.0, 11695.941520292345, 11891.583794567236, 11986.760264794742, 12074.758504829942, 12363.320017399039, 3848.3650197717343, 3892.9221415571815, 3953.1500727343473, 3972.642462178389, 4031.254217969685, 54938.72530637361, 55389.1691624626, 57378.71310643462, 57512.71243643797, 57780.0, 11062.944685276521, 11255.0, 11294.60468883585, 11458.484368203452, 11594.76810463786, 20280.188792448138, 20320.69518957217, 20343.18627254923, 20364.185432582828, 20397.49006274855, 8086.797830054295, 8338.8332233355, 8381.0, 8450.323974082059, 8615.310775137974, 4457.465104187453, 4508.256137737237, 4515.14212299662, 4517.796699148546, 4550.362949187116, 3209.8234597096916, 3299.1916980339493, 3312.039508542544, 3313.519539666735, 3319.6016478022307, 641.6631268584031, 646.5344951634816, 662.4270006444391, 678.4640134293852, 701.5054386657395, 673.8584897171551, 675.7499725101744, 765.1965436291871, 769.6151924037981, 783.8549868274388, 9124.361294709306, 9157.862632060524, 9281.118293762082, 9291.48896810682, 9369.156775890202, 638.6934271549682, 659.5317324699517, 713.3651050565002, 750.2722359311459, 772.1853444615872, 4650.813967441332, 4753.239481682914, 4769.260764581495, 4821.099776063697, 4843.660943733905, 51602.0, 53213.467865321625, 53264.46735532673, 53290.46709532855, 67382.0, 47180.292295615596, 47584.7620761894, 47838.521614784106, 47938.520614794106, 50021.0, 44126.11747765027, 44702.99999999935, 44846.77576612096, 45233.547664522936, 46241.0, 8952.865707014269, 8958.82082358336, 9031.142041506046, 9108.726738197865, 9149.176574108362, 30736.385272294876, 31567.36865262636, 32237.0, 32921.0, 33371.33257334888, 38975.220495590496, 40431.79784101061, 44090.779546103346, 44162.0, 44823.55176448194, 12295.32375719344, 12339.876601233873, 12389.75220495603, 12403.379831008233, 12752.107352485236, 13811.378487967864, 14037.578872633838, 14339.856601433852, 14750.114993100018, 14802.111873287206, 13090.607281781562, 13127.540536081191, 13599.252041137832, 13629.931850340685, 13964.4414223434, 12733.426995785027, 13067.411966461723, 13205.537806176737, 13542.59372218835, 13577.642235776739, 11935.820962685393, 12426.62720118398, 12535.623931282076, 12729.618111456672, 12990.090693651731, 10933.671989840317, 11091.500882460146, 11213.0, 11297.943510282395, 11742.941285293518, 11121.499532521218, 11231.494582743959, 11250.212485125963, 11573.13201509907, 11611.535538578362], "value": 6770.962857965994, "unit": "score"}], "name": "dromaeo_css", "value": 7076.679454529698, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 105.0, 109.0, 111.0, 112.0, 99.0, 110.0, 110.0, 112.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 127.0, 151.0, 192.0, 134.0, 148.0, 155.0, 130.0, 209.0, 128.0], "value": 153.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 161.0, 162.0, 163.0, 161.0, 162.0, 162.0, 161.0, 162.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 73.0, 107.0, 120.0, 73.0, 72.0, 76.0, 128.0, 101.0, 76.0], "value": 89.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 145.0, 92.0, 92.0, 92.0, 150.0, 92.0, 92.0, 143.0], "value": 108.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 147.0, 146.0, 145.0, 145.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 96.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 56.0, 57.0, 57.0, 59.0, 56.0, 72.0, 56.0, 53.0], "value": 58.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 60.0, 60.0, 60.0, 59.0, 60.0, 60.0, 60.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 77.0, 78.0, 77.0, 76.0, 78.0, 78.0, 78.0], "value": 77.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 126.0, 127.0, 127.0, 122.0, 123.0, 122.0, 123.0, 158.0, 126.0], "value": 130.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 172.0, 164.0, 165.0, 170.0, 168.0, 166.0, 173.0, 171.0, 164.0], "value": 168.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 67.0, 68.0, 67.0, 69.0, 67.0, 68.0, 68.0, 67.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1540.4000000000003, "alertThreshold": 2.0}]} 08:27:55 INFO - Return code: 0 08:27:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:27:55 ERROR - # TBPL SUCCESS # 08:27:55 INFO - Running post-action listener: _resource_record_post_action 08:27:55 INFO - Running post-run listener: _resource_record_post_run 08:27:56 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 549617664; Read time: 16; Write time: 592356 08:27:56 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 257478656; Read time: 0; Write time: 370756 08:27:56 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292139008; Read time: 16; Write time: 221600 08:27:56 INFO - Running post-run listener: _upload_blobber_files 08:27:56 INFO - Blob upload gear active. 08:27:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:27:56 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:27:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:27:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:27:56 INFO - (blobuploader) - INFO - Open directory for files ... 08:27:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:27:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:27:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:27:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:27:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:27:57 INFO - (blobuploader) - INFO - Done attempting. 08:27:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:27:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:27:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:27:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:27:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:27:58 INFO - (blobuploader) - INFO - Done attempting. 08:27:58 INFO - (blobuploader) - INFO - Iteration through files over. 08:27:58 INFO - Return code: 0 08:27:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:27:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:27:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56ba0d40172fc0aca83e023519a2da6699b8ac866bdfec02f7c8ed414f166dcdf6822535b9cff75aa73c4fd07b8707b5c631d539969fb116dfc775062d22a63c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aac2034cea6d829aacf886e81a612fe2cd60e7663becb3a88fbcd4b249a1889df0c220538deeab51e5ff0337f3d2f1955fda111c9663010c6db58877b38232af"} 08:27:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:27:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:27:58 INFO - Contents: 08:27:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56ba0d40172fc0aca83e023519a2da6699b8ac866bdfec02f7c8ed414f166dcdf6822535b9cff75aa73c4fd07b8707b5c631d539969fb116dfc775062d22a63c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aac2034cea6d829aacf886e81a612fe2cd60e7663becb3a88fbcd4b249a1889df0c220538deeab51e5ff0337f3d2f1955fda111c9663010c6db58877b38232af"} 08:27:58 INFO - Running post-run listener: copy_logs_to_upload_dir 08:27:58 INFO - Copying logs to upload dir... 08:27:58 INFO - mkdir: /builds/slave/test/build/upload/logs 08:27:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.498846 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-04-18 08:27:58.065444) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 08:27:58.069469) ========= 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=20e666a3d4cfbb71505a330e000001b4-1460990935.338468-70303664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56ba0d40172fc0aca83e023519a2da6699b8ac866bdfec02f7c8ed414f166dcdf6822535b9cff75aa73c4fd07b8707b5c631d539969fb116dfc775062d22a63c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aac2034cea6d829aacf886e81a612fe2cd60e7663becb3a88fbcd4b249a1889df0c220538deeab51e5ff0337f3d2f1955fda111c9663010c6db58877b38232af"} build_url:https://queue.taskcluster.net/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011200 build_url: 'https://queue.taskcluster.net/v1/task/DBUdd8JESiWo8mrsTZ-I5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56ba0d40172fc0aca83e023519a2da6699b8ac866bdfec02f7c8ed414f166dcdf6822535b9cff75aa73c4fd07b8707b5c631d539969fb116dfc775062d22a63c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aac2034cea6d829aacf886e81a612fe2cd60e7663becb3a88fbcd4b249a1889df0c220538deeab51e5ff0337f3d2f1955fda111c9663010c6db58877b38232af"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 08:27:58.096087) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 08:27:58.096424) ========= 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=20e666a3d4cfbb71505a330e000001b4-1460990935.338468-70303664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004516 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 08:27:58.177985) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 08:27:58.178325) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 08:27:58.178662) ========= ========= Total master_lag: 0.18 =========