builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-016 starttime: 1461294325.47 results: success (0) buildid: 20160421173029 builduid: 62b745ca7e644f65a7621ca5830f3d3b revision: 467bd00c72db8f6f34c4d9740378abb90365269f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 20:05:25.466985) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 20:05:25.467444) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 20:05:25.467738) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 20:05:25.484338) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 20:05:25.484674) ========= 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=00204705a9daa57ed339a427000001b9-1461291818.529804-488681429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-21 20:05:25-- 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% 40.9M=0s 2016-04-21 20:05:25 (40.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122881 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 20:05:25.621120) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 20:05:25.621406) ========= 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=00204705a9daa57ed339a427000001b9-1461291818.529804-488681429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020532 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 20:05:25.670724) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 20:05:25.671099) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 467bd00c72db8f6f34c4d9740378abb90365269f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 467bd00c72db8f6f34c4d9740378abb90365269f --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=00204705a9daa57ed339a427000001b9-1461291818.529804-488681429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-21 20:05:25,748 truncating revision to first 12 chars 2016-04-21 20:05:25,748 Setting DEBUG logging. 2016-04-21 20:05:25,748 attempt 1/10 2016-04-21 20:05:25,748 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/467bd00c72db?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-21 20:05:26,017 unpacking tar archive at: fx-team-467bd00c72db/testing/mozharness/ program finished with exit code 0 elapsedTime=0.542391 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 20:05:26.226196) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 20:05:26.226516) ========= script_repo_revision: 467bd00c72db8f6f34c4d9740378abb90365269f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 20:05:26.226934) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 20:05:26.227226) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 20:05:26.237303) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-04-21 20:05:26.237630) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=00204705a9daa57ed339a427000001b9-1461291818.529804-488681429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:05:26 INFO - MultiFileLogger online at 20160421 20:05:26 in /builds/slave/test 20:05:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:05:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:05:26 INFO - {'append_to_log': False, 20:05:26 INFO - 'base_work_dir': '/builds/slave/test', 20:05:26 INFO - 'blob_upload_branch': 'Fx-Team', 20:05:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:05:26 INFO - 'branch': 'Fx-Team', 20:05:26 INFO - 'buildbot_json_path': 'buildprops.json', 20:05:26 INFO - 'config_files': ('talos/linux_config.py',), 20:05:26 INFO - 'default_actions': ('clobber', 20:05:26 INFO - 'read-buildbot-config', 20:05:26 INFO - 'download-and-extract', 20:05:26 INFO - 'populate-webroot', 20:05:26 INFO - 'create-virtualenv', 20:05:26 INFO - 'install', 20:05:26 INFO - 'run-tests'), 20:05:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:05:26 INFO - 'download_minidump_stackwalk': True, 20:05:26 INFO - 'download_symbols': 'ondemand', 20:05:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:05:26 INFO - 'tooltool.py': '/tools/tooltool.py', 20:05:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:05:26 INFO - '/tools/misc-python/virtualenv.py')}, 20:05:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:05:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:05:26 INFO - 'installer_path': 'installer.exe', 20:05:26 INFO - 'log_level': 'info', 20:05:26 INFO - 'log_name': 'talos', 20:05:26 INFO - 'log_to_console': True, 20:05:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:05:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:05:26 INFO - 'opt_config_files': (), 20:05:26 INFO - 'pip_index': False, 20:05:26 INFO - 'sps_profile': False, 20:05:26 INFO - 'sps_profile_interval': 0, 20:05:26 INFO - 'suite': 'dromaeojs-e10s', 20:05:26 INFO - 'system_bits': '32', 20:05:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:05:26 INFO - 'title': 'talos-linux64-ix-016', 20:05:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:05:26 INFO - 'use_talos_json': True, 20:05:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:05:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:05:26 INFO - 'work_dir': 'build'} 20:05:26 INFO - ##### 20:05:26 INFO - ##### Running clobber step. 20:05:26 INFO - ##### 20:05:26 INFO - Running pre-action listener: _resource_record_pre_action 20:05:26 INFO - Running main action method: clobber 20:05:26 INFO - rmtree: /builds/slave/test/build 20:05:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:05:26 INFO - Running post-action listener: _resource_record_post_action 20:05:26 INFO - ##### 20:05:26 INFO - ##### Running read-buildbot-config step. 20:05:26 INFO - ##### 20:05:26 INFO - Running pre-action listener: _resource_record_pre_action 20:05:26 INFO - Running main action method: read_buildbot_config 20:05:26 INFO - Using buildbot properties: 20:05:26 INFO - { 20:05:26 INFO - "project": "", 20:05:26 INFO - "product": "firefox", 20:05:26 INFO - "script_repo_revision": "production", 20:05:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 20:05:26 INFO - "repository": "", 20:05:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 20:05:26 INFO - "buildid": "20160421173029", 20:05:26 INFO - "pgo_build": "True", 20:05:26 INFO - "basedir": "/builds/slave/test", 20:05:26 INFO - "buildnumber": 400, 20:05:26 INFO - "slavename": "talos-linux64-ix-016", 20:05:26 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:05:26 INFO - "platform": "ubuntu64_hw", 20:05:26 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:05:26 INFO - "branch": "fx-team", 20:05:26 INFO - "repo_path": "integration/fx-team", 20:05:26 INFO - "revision": "467bd00c72db8f6f34c4d9740378abb90365269f", 20:05:26 INFO - "stage_platform": "linux64-pgo", 20:05:26 INFO - "builduid": "62b745ca7e644f65a7621ca5830f3d3b", 20:05:26 INFO - "slavebuilddir": "test" 20:05:26 INFO - } 20:05:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 20:05:26 INFO - Running post-action listener: _resource_record_post_action 20:05:26 INFO - ##### 20:05:26 INFO - ##### Running download-and-extract step. 20:05:26 INFO - ##### 20:05:26 INFO - Running pre-action listener: _resource_record_pre_action 20:05:26 INFO - Running main action method: download_and_extract 20:05:26 INFO - mkdir: /builds/slave/test/build/tests 20:05:26 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')]} 20:05:26 INFO - https://queue.taskcluster.net/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:05:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 20:05:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 20:05:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/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 20:05:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/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 20:05:27 INFO - Downloaded 1361 bytes. 20:05:27 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 20:05:27 INFO - Using the following test package requirements: 20:05:27 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 20:05:27 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:05:27 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:05:27 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:27 INFO - u'jsshell-linux-x86_64.zip'], 20:05:27 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:05:27 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 20:05:27 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:05:27 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:05:27 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:05:27 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:05:27 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:05:27 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')]} 20:05:27 INFO - https://queue.taskcluster.net/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:05:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:05:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:05:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/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 20:05:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/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 20:05:30 INFO - Downloaded 23853953 bytes. 20:05:30 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'] 20:05:30 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 20:05:31 INFO - Return code: 0 20:05:31 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 20:05: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')]} 20:05:31 INFO - https://queue.taskcluster.net/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:05:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:05:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:05:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/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 20:05:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/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 20:05:35 INFO - Downloaded 23853953 bytes. 20:05: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'] 20:05: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 20:05:36 INFO - Return code: 0 20:05: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')]} 20:05:36 INFO - https://queue.taskcluster.net/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:05:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 20:05:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 20:05:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/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 20:05:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/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 20:05:37 INFO - Downloaded 10845952 bytes. 20:05: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'] 20:05: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 20:05:38 INFO - Return code: 0 20:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:38 INFO - https://queue.taskcluster.net/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:05:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 20:05:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 20:05:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/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 20:05:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/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 20:05:39 INFO - Downloaded 58331147 bytes. 20:05:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 20:05:39 INFO - mkdir: /builds/slave/test/properties 20:05:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:05:39 INFO - Writing to file /builds/slave/test/properties/build_url 20:05:39 INFO - Contents: 20:05:39 INFO - build_url:https://queue.taskcluster.net/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 20:05:40 INFO - Running post-action listener: _resource_record_post_action 20:05:40 INFO - Running post-action listener: set_extra_try_arguments 20:05:40 INFO - ##### 20:05:40 INFO - ##### Running populate-webroot step. 20:05:40 INFO - ##### 20:05:40 INFO - Running pre-action listener: _resource_record_pre_action 20:05:40 INFO - Running main action method: populate_webroot 20:05:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:05:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:05:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:05:40 INFO - '--tppagecycles', 20:05:40 INFO - '7'], 20:05:40 INFO - 'tests': ['tsvgm']}}, 20:05:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:05:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:05:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:05:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:05:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:05:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:05:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:40 INFO - 'talos_options': ['--disable-e10s'], 20:05:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:05:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:05:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:40 INFO - 'talos_options': ['--disable-e10s'], 20:05:40 INFO - 'tests': ['damp', 'tps']}, 20:05:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:40 INFO - 'tests': ['damp', 'tps']}, 20:05:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:05:40 INFO - 'tests': ['dromaeo_dom']}, 20:05:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:05:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:05:40 INFO - 'tests': ['a11yr', 20:05:40 INFO - 'ts_paint', 20:05:40 INFO - 'tpaint', 20:05:40 INFO - 'sessionrestore', 20:05:40 INFO - 'sessionrestore_no_auto_restore', 20:05:40 INFO - 'tabpaint']}, 20:05:40 INFO - 'other-e10s': {'tests': ['a11yr', 20:05:40 INFO - 'ts_paint', 20:05:40 INFO - 'tpaint', 20:05:40 INFO - 'sessionrestore', 20:05:40 INFO - 'sessionrestore_no_auto_restore', 20:05:40 INFO - 'tabpaint']}, 20:05:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:05:40 INFO - 'ts_paint', 20:05:40 INFO - 'tpaint', 20:05:40 INFO - 'sessionrestore', 20:05:40 INFO - 'sessionrestore_no_auto_restore', 20:05:40 INFO - 'tabpaint']}, 20:05:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:05:40 INFO - 'ts_paint', 20:05:40 INFO - 'tpaint', 20:05:40 INFO - 'sessionrestore', 20:05:40 INFO - 'sessionrestore_no_auto_restore', 20:05:40 INFO - 'tabpaint']}, 20:05:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:05:40 INFO - 'tests': ['a11yr', 20:05:40 INFO - 'ts_paint', 20:05:40 INFO - 'tpaint', 20:05:40 INFO - 'sessionrestore', 20:05:40 INFO - 'sessionrestore_no_auto_restore', 20:05:40 INFO - 'tabpaint']}, 20:05:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:05:40 INFO - 'tests': ['a11yr', 20:05:40 INFO - 'ts_paint', 20:05:40 INFO - 'tpaint', 20:05:40 INFO - 'sessionrestore', 20:05:40 INFO - 'sessionrestore_no_auto_restore', 20:05:40 INFO - 'tabpaint']}, 20:05:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:05:40 INFO - 'tests': ['tsvgx', 20:05:40 INFO - 'tsvgr_opacity', 20:05:40 INFO - 'tart', 20:05:40 INFO - 'tscrollx', 20:05:40 INFO - 'cart']}, 20:05:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:05:40 INFO - 'tsvgr_opacity', 20:05:40 INFO - 'tart', 20:05:40 INFO - 'tscrollx', 20:05:40 INFO - 'cart']}, 20:05:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:40 INFO - 'talos_options': ['--disable-e10s'], 20:05:40 INFO - 'tests': ['tp5o']}, 20:05:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:40 INFO - 'tests': ['tp5o']}, 20:05:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:40 INFO - 'talos_options': ['--disable-e10s', 20:05:40 INFO - '--xperf_path', 20:05:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:05:40 INFO - 'tests': ['tp5n']}, 20:05:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:40 INFO - 'talos_options': ['--xperf_path', 20:05:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:05:40 INFO - 'tests': ['tp5n']}}, 20:05:40 INFO - 'talos.zip': {'path': '', 20:05:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:05:40 INFO - Running post-action listener: _resource_record_post_action 20:05:40 INFO - ##### 20:05:40 INFO - ##### Running create-virtualenv step. 20:05:40 INFO - ##### 20:05:40 INFO - Running pre-action listener: _resource_record_pre_action 20:05:40 INFO - Running main action method: create_virtualenv 20:05:40 INFO - Creating virtualenv /builds/slave/test/build/venv 20:05: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 20:05:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:05:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:05:40 INFO - Using real prefix '/usr' 20:05:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:05:40 INFO - Installing distribute.............................................................................................................................................................................................done. 20:05:42 INFO - Installing pip.................done. 20:05:42 INFO - Return code: 0 20:05:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:05:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:42 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 0x7f0de25cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1331410>, '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 0x1332310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13327a0>, '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': '00204705a9daa57ed339a427000001b9-1461291818.529804-488681429', '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 20:05:42 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 20:05:42 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 20:05:42 INFO - Using env: {'DISPLAY': ':0', 20:05:42 INFO - 'HOME': '/home/cltbld', 20:05:42 INFO - 'LANG': 'en_US.UTF-8', 20:05:42 INFO - 'LANGUAGE': 'en_US:en', 20:05:42 INFO - 'LOGNAME': 'cltbld', 20:05:42 INFO - 'MAIL': '/var/mail/cltbld', 20:05:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:42 INFO - 'MOZ_NO_REMOTE': '1', 20:05:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:42 INFO - 'NO_EM_RESTART': '1', 20:05:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:42 INFO - 'PWD': '/builds/slave/test', 20:05:42 INFO - 'SHELL': '/bin/bash', 20:05:42 INFO - 'SHLVL': '1', 20:05:42 INFO - 'TERM': 'linux', 20:05:42 INFO - 'TMOUT': '86400', 20:05:42 INFO - 'USER': 'cltbld', 20:05:42 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461291818.529804-488681429', 20:05:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:42 INFO - '_': '/tools/buildbot/bin/python'} 20:05:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05: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 20:05:43 INFO - Cleaning up... 20:05:43 INFO - Return code: 0 20:05:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:05: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')]} 20:05:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05: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')]} 20:05:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05: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 0x7f0de25cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1331410>, '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 0x1332310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13327a0>, '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': '00204705a9daa57ed339a427000001b9-1461291818.529804-488681429', '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 20:05: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 20:05: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 20:05:43 INFO - Using env: {'DISPLAY': ':0', 20:05:43 INFO - 'HOME': '/home/cltbld', 20:05:43 INFO - 'LANG': 'en_US.UTF-8', 20:05:43 INFO - 'LANGUAGE': 'en_US:en', 20:05:43 INFO - 'LOGNAME': 'cltbld', 20:05:43 INFO - 'MAIL': '/var/mail/cltbld', 20:05:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:43 INFO - 'MOZ_NO_REMOTE': '1', 20:05:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:43 INFO - 'NO_EM_RESTART': '1', 20:05:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:43 INFO - 'PWD': '/builds/slave/test', 20:05:43 INFO - 'SHELL': '/bin/bash', 20:05:43 INFO - 'SHLVL': '1', 20:05:43 INFO - 'TERM': 'linux', 20:05:43 INFO - 'TMOUT': '86400', 20:05:43 INFO - 'USER': 'cltbld', 20:05:43 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461291818.529804-488681429', 20:05:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:43 INFO - '_': '/tools/buildbot/bin/python'} 20:05:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:43 INFO - Downloading/unpacking psutil>=0.7.1 20:05: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 20:05: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 20:05: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 20:05: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 20:05: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 20:05: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 20:05:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:05:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:05:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:05:45 INFO - Installing collected packages: psutil 20:05:45 INFO - Running setup.py install for psutil 20:05:45 INFO - building 'psutil._psutil_linux' extension 20:05: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 20:05: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 20:05:45 INFO - building 'psutil._psutil_posix' extension 20:05: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 20:05: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_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 20:05:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:05:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:05:45 INFO - Successfully installed psutil 20:05:45 INFO - Cleaning up... 20:05:45 INFO - Return code: 0 20:05:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:05:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0de25cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1331410>, '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 0x1332310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13327a0>, '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': '00204705a9daa57ed339a427000001b9-1461291818.529804-488681429', '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 20:05:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 20:05:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 20:05:45 INFO - Using env: {'DISPLAY': ':0', 20:05:45 INFO - 'HOME': '/home/cltbld', 20:05:45 INFO - 'LANG': 'en_US.UTF-8', 20:05:45 INFO - 'LANGUAGE': 'en_US:en', 20:05:45 INFO - 'LOGNAME': 'cltbld', 20:05:45 INFO - 'MAIL': '/var/mail/cltbld', 20:05:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:45 INFO - 'MOZ_NO_REMOTE': '1', 20:05:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:45 INFO - 'NO_EM_RESTART': '1', 20:05:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:45 INFO - 'PWD': '/builds/slave/test', 20:05:45 INFO - 'SHELL': '/bin/bash', 20:05:45 INFO - 'SHLVL': '1', 20:05:45 INFO - 'TERM': 'linux', 20:05:45 INFO - 'TMOUT': '86400', 20:05:45 INFO - 'USER': 'cltbld', 20:05:45 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461291818.529804-488681429', 20:05:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:45 INFO - '_': '/tools/buildbot/bin/python'} 20:05:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:05: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 20:05: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 20:05: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 20:05: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 20:05: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 20:05: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 20:05:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:05:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:05:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:05:47 INFO - Installing collected packages: mozsystemmonitor 20:05:47 INFO - Running setup.py install for mozsystemmonitor 20:05:48 INFO - Successfully installed mozsystemmonitor 20:05:48 INFO - Cleaning up... 20:05:48 INFO - Return code: 0 20:05:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:05: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')]} 20:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05: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')]} 20:05:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05: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 0x7f0de25cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1331410>, '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 0x1332310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13327a0>, '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': '00204705a9daa57ed339a427000001b9-1461291818.529804-488681429', '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 20:05: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 20:05: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 20:05:48 INFO - Using env: {'DISPLAY': ':0', 20:05:48 INFO - 'HOME': '/home/cltbld', 20:05:48 INFO - 'LANG': 'en_US.UTF-8', 20:05:48 INFO - 'LANGUAGE': 'en_US:en', 20:05:48 INFO - 'LOGNAME': 'cltbld', 20:05:48 INFO - 'MAIL': '/var/mail/cltbld', 20:05:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:48 INFO - 'MOZ_NO_REMOTE': '1', 20:05:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:48 INFO - 'NO_EM_RESTART': '1', 20:05:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:48 INFO - 'PWD': '/builds/slave/test', 20:05:48 INFO - 'SHELL': '/bin/bash', 20:05:48 INFO - 'SHLVL': '1', 20:05:48 INFO - 'TERM': 'linux', 20:05:48 INFO - 'TMOUT': '86400', 20:05:48 INFO - 'USER': 'cltbld', 20:05:48 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461291818.529804-488681429', 20:05:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:48 INFO - '_': '/tools/buildbot/bin/python'} 20:05:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:48 INFO - Downloading/unpacking blobuploader==1.2.4 20:05: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 20:05: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 20:05: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 20:05: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 20:05: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 20:05: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 20:05:50 INFO - Downloading blobuploader-1.2.4.tar.gz 20:05:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:05:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:05: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 20:05: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 20:05: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 20:05: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 20:05: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 20:05: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 20:05:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:05:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:05: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 20:05: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 20:05: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 20:05: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 20:05: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 20:05: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 20:05:50 INFO - Downloading docopt-0.6.1.tar.gz 20:05:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:05:50 INFO - Installing collected packages: blobuploader, requests, docopt 20:05:50 INFO - Running setup.py install for blobuploader 20:05:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:05:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:05:51 INFO - Running setup.py install for requests 20:05:51 INFO - Running setup.py install for docopt 20:05:51 INFO - Successfully installed blobuploader requests docopt 20:05:51 INFO - Cleaning up... 20:05:51 INFO - Return code: 0 20:05:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:05: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')]} 20:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05: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')]} 20:05:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05: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 0x7f0de25cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1331410>, '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 0x1332310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13327a0>, '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': '00204705a9daa57ed339a427000001b9-1461291818.529804-488681429', '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 20:05: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 20:05: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 20:05:51 INFO - Using env: {'DISPLAY': ':0', 20:05:51 INFO - 'HOME': '/home/cltbld', 20:05:51 INFO - 'LANG': 'en_US.UTF-8', 20:05:51 INFO - 'LANGUAGE': 'en_US:en', 20:05:51 INFO - 'LOGNAME': 'cltbld', 20:05:51 INFO - 'MAIL': '/var/mail/cltbld', 20:05:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:51 INFO - 'MOZ_NO_REMOTE': '1', 20:05:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:51 INFO - 'NO_EM_RESTART': '1', 20:05:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:51 INFO - 'PWD': '/builds/slave/test', 20:05:51 INFO - 'SHELL': '/bin/bash', 20:05:51 INFO - 'SHLVL': '1', 20:05:51 INFO - 'TERM': 'linux', 20:05:51 INFO - 'TMOUT': '86400', 20:05:51 INFO - 'USER': 'cltbld', 20:05:51 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461291818.529804-488681429', 20:05:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:51 INFO - '_': '/tools/buildbot/bin/python'} 20:05:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:05:51 INFO - Running setup.py (path:/tmp/pip-53ZwUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:05:51 INFO - Running setup.py (path:/tmp/pip-bA6ROA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:05:51 INFO - Running setup.py (path:/tmp/pip-mEykOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:05:51 INFO - Running setup.py (path:/tmp/pip-BTUMzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:05:52 INFO - Running setup.py (path:/tmp/pip-eB9EIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:05:52 INFO - Running setup.py (path:/tmp/pip-cFjIep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:05:52 INFO - Running setup.py (path:/tmp/pip-ktfkMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:05:52 INFO - Running setup.py (path:/tmp/pip-9gfCKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:05:52 INFO - Running setup.py (path:/tmp/pip-1XdG5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:05:52 INFO - Running setup.py (path:/tmp/pip-j7TRQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:05:52 INFO - Running setup.py (path:/tmp/pip-9UJR16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:05:52 INFO - Running setup.py (path:/tmp/pip-nxtvL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:05:52 INFO - Running setup.py (path:/tmp/pip-JXh8Dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:05:52 INFO - Running setup.py (path:/tmp/pip-38j32a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:05:52 INFO - Running setup.py (path:/tmp/pip-Y462BF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:05:52 INFO - Running setup.py (path:/tmp/pip-NKqgXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:05:52 INFO - Running setup.py (path:/tmp/pip-pFolMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:05:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:05:52 INFO - Running setup.py install for manifestparser 20:05:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:05:53 INFO - Running setup.py install for mozcrash 20:05:53 INFO - Running setup.py install for mozdebug 20:05:53 INFO - Running setup.py install for mozdevice 20:05:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:05:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:05:53 INFO - Running setup.py install for mozfile 20:05:53 INFO - Running setup.py install for mozhttpd 20:05:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:05:53 INFO - Running setup.py install for mozinfo 20:05:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:05:53 INFO - Running setup.py install for mozInstall 20:05:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:05:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:05:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:05:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:05:53 INFO - Running setup.py install for mozleak 20:05:53 INFO - Running setup.py install for mozlog 20:05:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:05:53 INFO - Running setup.py install for moznetwork 20:05:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:05:54 INFO - Running setup.py install for mozprocess 20:05:54 INFO - Running setup.py install for mozprofile 20:05:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:05:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:05:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:05:54 INFO - Running setup.py install for mozrunner 20:05:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:05:54 INFO - Running setup.py install for mozscreenshot 20:05:54 INFO - Running setup.py install for moztest 20:05:54 INFO - Running setup.py install for mozversion 20:05:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:05:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:05:54 INFO - Cleaning up... 20:05:54 INFO - Return code: 0 20:05:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:05:54 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')]} 20:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:54 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')]} 20:05:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:54 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 0x7f0de25cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1331410>, '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 0x1332310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13327a0>, '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': '00204705a9daa57ed339a427000001b9-1461291818.529804-488681429', '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 20:05:54 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 20:05:54 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 20:05:54 INFO - Using env: {'DISPLAY': ':0', 20:05:54 INFO - 'HOME': '/home/cltbld', 20:05:54 INFO - 'LANG': 'en_US.UTF-8', 20:05:54 INFO - 'LANGUAGE': 'en_US:en', 20:05:54 INFO - 'LOGNAME': 'cltbld', 20:05:54 INFO - 'MAIL': '/var/mail/cltbld', 20:05:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:54 INFO - 'MOZ_NO_REMOTE': '1', 20:05:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:54 INFO - 'NO_EM_RESTART': '1', 20:05:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:54 INFO - 'PWD': '/builds/slave/test', 20:05:54 INFO - 'SHELL': '/bin/bash', 20:05:54 INFO - 'SHLVL': '1', 20:05:54 INFO - 'TERM': 'linux', 20:05:54 INFO - 'TMOUT': '86400', 20:05:54 INFO - 'USER': 'cltbld', 20:05:54 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461291818.529804-488681429', 20:05:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:54 INFO - '_': '/tools/buildbot/bin/python'} 20:05:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:05:54 INFO - Running setup.py (path:/tmp/pip-3eFEHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:05: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)) 20:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:05:55 INFO - Running setup.py (path:/tmp/pip-0gdHtN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:05: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)) 20:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:05:55 INFO - Running setup.py (path:/tmp/pip-dxA4kG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:05: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)) 20:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:05:55 INFO - Running setup.py (path:/tmp/pip-7HMfqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:05: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)) 20:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:05:55 INFO - Running setup.py (path:/tmp/pip-PiC3jv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:05: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)) 20:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:05:55 INFO - Running setup.py (path:/tmp/pip-jG7bxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:05: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)) 20:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:05:55 INFO - Running setup.py (path:/tmp/pip-oqel2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:05: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)) 20:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:05:55 INFO - Running setup.py (path:/tmp/pip-wZ8R9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:05: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)) 20:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:05:55 INFO - Running setup.py (path:/tmp/pip-hLgvrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:05:55 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)) 20:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:05:55 INFO - Running setup.py (path:/tmp/pip-uwTg9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:05:55 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)) 20:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:05:55 INFO - Running setup.py (path:/tmp/pip-EdYt6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:05:55 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)) 20:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:05:55 INFO - Running setup.py (path:/tmp/pip-2ollhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:05:55 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)) 20:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:05:55 INFO - Running setup.py (path:/tmp/pip-uKnS3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:05:55 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)) 20:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:05:55 INFO - Running setup.py (path:/tmp/pip-jPe2GP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:05:55 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)) 20:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:05:55 INFO - Running setup.py (path:/tmp/pip-YsaTvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:05: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)) 20:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:05:56 INFO - Running setup.py (path:/tmp/pip-HAPlV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:05: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)) 20:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:05:56 INFO - Running setup.py (path:/tmp/pip-7LWHRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:05: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)) 20:05: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)) 20:05: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)) 20:05: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)) 20:05: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)) 20:05: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)) 20:05:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:05: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 20:05: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 20:05: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 20:05: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 20:05: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 20:05: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 20:05:58 INFO - Downloading blessings-1.6.tar.gz 20:05:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:05:58 INFO - Installing collected packages: blessings 20:05:58 INFO - Running setup.py install for blessings 20:05:58 INFO - Successfully installed blessings 20:05:58 INFO - Cleaning up... 20:05:58 INFO - Return code: 0 20:05:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:05:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:05:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:05:58 INFO - Reading from file tmpfile_stdout 20:05:58 INFO - Current package versions: 20:05:58 INFO - argparse == 1.2.1 20:05:58 INFO - blessings == 1.6 20:05:58 INFO - blobuploader == 1.2.4 20:05:58 INFO - docopt == 0.6.1 20:05:58 INFO - manifestparser == 1.1 20:05:58 INFO - mozInstall == 1.12 20:05:58 INFO - mozcrash == 0.17 20:05:58 INFO - mozdebug == 0.1 20:05:58 INFO - mozdevice == 0.48 20:05:58 INFO - mozfile == 1.2 20:05:58 INFO - mozhttpd == 0.7 20:05:58 INFO - mozinfo == 0.9 20:05:58 INFO - mozleak == 0.1 20:05:58 INFO - mozlog == 3.1 20:05:58 INFO - moznetwork == 0.27 20:05:58 INFO - mozprocess == 0.22 20:05:58 INFO - mozprofile == 0.28 20:05:58 INFO - mozrunner == 6.11 20:05:58 INFO - mozscreenshot == 0.1 20:05:58 INFO - mozsystemmonitor == 0.0 20:05:58 INFO - moztest == 0.7 20:05:58 INFO - mozversion == 1.4 20:05:58 INFO - psutil == 3.1.1 20:05:58 INFO - requests == 1.2.3 20:05:58 INFO - wsgiref == 0.1.2 20:05:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:05: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')]} 20:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05: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')]} 20:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05: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 0x7f0de25cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1331410>, '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 0x1332310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13327a0>, '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': '00204705a9daa57ed339a427000001b9-1461291818.529804-488681429', '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 20:05: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 20:05: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 20:05:58 INFO - Using env: {'DISPLAY': ':0', 20:05:58 INFO - 'HOME': '/home/cltbld', 20:05:58 INFO - 'LANG': 'en_US.UTF-8', 20:05:58 INFO - 'LANGUAGE': 'en_US:en', 20:05:58 INFO - 'LOGNAME': 'cltbld', 20:05:58 INFO - 'MAIL': '/var/mail/cltbld', 20:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:58 INFO - 'MOZ_NO_REMOTE': '1', 20:05:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:58 INFO - 'NO_EM_RESTART': '1', 20:05:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:58 INFO - 'PWD': '/builds/slave/test', 20:05:58 INFO - 'SHELL': '/bin/bash', 20:05:58 INFO - 'SHLVL': '1', 20:05:58 INFO - 'TERM': 'linux', 20:05:58 INFO - 'TMOUT': '86400', 20:05:58 INFO - 'USER': 'cltbld', 20:05:58 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461291818.529804-488681429', 20:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:58 INFO - '_': '/tools/buildbot/bin/python'} 20:05:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:58 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)) 20:05:58 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)) 20:05:58 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)) 20:05:58 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)) 20:05:58 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)) 20:05:58 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)) 20:05:58 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)) 20:05:58 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)) 20:05:58 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)) 20:05:58 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)) 20:05:58 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)) 20:05:58 INFO - Cleaning up... 20:05:58 INFO - Return code: 0 20:05:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:05: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')]} 20:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05: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')]} 20:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:58 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 0x7f0de25cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1331410>, '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 0x1332310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13327a0>, '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': '00204705a9daa57ed339a427000001b9-1461291818.529804-488681429', '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 20:05:58 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 20:05:58 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 20:05:58 INFO - Using env: {'DISPLAY': ':0', 20:05:58 INFO - 'HOME': '/home/cltbld', 20:05:58 INFO - 'LANG': 'en_US.UTF-8', 20:05:58 INFO - 'LANGUAGE': 'en_US:en', 20:05:58 INFO - 'LOGNAME': 'cltbld', 20:05:58 INFO - 'MAIL': '/var/mail/cltbld', 20:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:58 INFO - 'MOZ_NO_REMOTE': '1', 20:05:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:58 INFO - 'NO_EM_RESTART': '1', 20:05:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:58 INFO - 'PWD': '/builds/slave/test', 20:05:58 INFO - 'SHELL': '/bin/bash', 20:05:58 INFO - 'SHLVL': '1', 20:05:58 INFO - 'TERM': 'linux', 20:05:58 INFO - 'TMOUT': '86400', 20:05:58 INFO - 'USER': 'cltbld', 20:05:58 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461291818.529804-488681429', 20:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:58 INFO - '_': '/tools/buildbot/bin/python'} 20:05:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:58 INFO - Downloading/unpacking jsonschema 20:05:58 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 20:05:58 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 20:05:58 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 20:05:58 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 20:05:58 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 20:05:58 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 20:06:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:06:00 INFO - Downloading/unpacking functools32 (from jsonschema) 20:06:00 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 20:06:00 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 20:06:00 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 20:06:00 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 20:06:00 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 20:06:00 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 20:06:00 INFO - Downloading functools32-3.2.3-2.tar.gz 20:06:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:06:01 INFO - warning: no files found matching '*.txt' 20:06:01 INFO - no previously-included directories found matching 'build' 20:06:01 INFO - no previously-included directories found matching 'dist' 20:06:01 INFO - no previously-included directories found matching '.git*' 20:06:01 INFO - Installing collected packages: jsonschema, functools32 20:06:01 INFO - Running setup.py install for functools32 20:06:01 INFO - warning: no files found matching '*.txt' 20:06:01 INFO - no previously-included directories found matching 'build' 20:06:01 INFO - no previously-included directories found matching 'dist' 20:06:01 INFO - no previously-included directories found matching '.git*' 20:06:01 INFO - Successfully installed jsonschema functools32 20:06:01 INFO - Cleaning up... 20:06:01 INFO - Return code: 0 20:06:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:06: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')]} 20:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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')]} 20:06:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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 0x7f0de25cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1331410>, '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 0x1332310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13327a0>, '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': '00204705a9daa57ed339a427000001b9-1461291818.529804-488681429', '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 20:06: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 20:06: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 20:06:01 INFO - Using env: {'DISPLAY': ':0', 20:06:01 INFO - 'HOME': '/home/cltbld', 20:06:01 INFO - 'LANG': 'en_US.UTF-8', 20:06:01 INFO - 'LANGUAGE': 'en_US:en', 20:06:01 INFO - 'LOGNAME': 'cltbld', 20:06:01 INFO - 'MAIL': '/var/mail/cltbld', 20:06:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:01 INFO - 'MOZ_NO_REMOTE': '1', 20:06:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:01 INFO - 'NO_EM_RESTART': '1', 20:06:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:01 INFO - 'PWD': '/builds/slave/test', 20:06:01 INFO - 'SHELL': '/bin/bash', 20:06:01 INFO - 'SHLVL': '1', 20:06:01 INFO - 'TERM': 'linux', 20:06:01 INFO - 'TMOUT': '86400', 20:06:01 INFO - 'USER': 'cltbld', 20:06:01 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461291818.529804-488681429', 20:06:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:01 INFO - '_': '/tools/buildbot/bin/python'} 20:06:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:01 INFO - Downloading/unpacking flake8 20:06: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 20:06: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 20:06: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 20:06: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 20:06: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 20:06: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 20:06:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:06:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:06:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:06:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:06:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:06:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:06:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:06:04 INFO - no previously-included directories found matching 'docs/_build' 20:06:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:06:04 INFO - Running setup.py install for pep8 20:06:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:06:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:06:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:06:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:06:04 INFO - no previously-included directories found matching 'docs/_build' 20:06:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:06:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:06:04 INFO - Cleaning up... 20:06:04 INFO - Return code: 0 20:06:04 INFO - Running post-action listener: _resource_record_post_action 20:06:04 INFO - Running post-action listener: _start_resource_monitoring 20:06:04 INFO - Starting resource monitoring. 20:06:04 INFO - ##### 20:06:04 INFO - ##### Running install step. 20:06:04 INFO - ##### 20:06:04 INFO - Running pre-action listener: _resource_record_pre_action 20:06:04 INFO - Running main action method: install 20:06:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:06:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:06:04 INFO - Reading from file tmpfile_stdout 20:06:04 INFO - Detecting whether we're running mozinstall >=1.0... 20:06:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:06:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:06:04 INFO - Reading from file tmpfile_stdout 20:06:04 INFO - Output received: 20:06:04 INFO - Usage: mozinstall [options] installer 20:06:04 INFO - Options: 20:06:04 INFO - -h, --help show this help message and exit 20:06:04 INFO - -d DEST, --destination=DEST 20:06:04 INFO - Directory to install application into. [default: 20:06:04 INFO - "/builds/slave/test"] 20:06:04 INFO - --app=APP Application being installed. [default: firefox] 20:06:04 INFO - mkdir: /builds/slave/test/build/application 20:06:04 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'] 20:06:04 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 20:06:21 INFO - Reading from file tmpfile_stdout 20:06:21 INFO - Output received: 20:06:21 INFO - /builds/slave/test/build/application/firefox/firefox 20:06:21 INFO - Running post-action listener: _resource_record_post_action 20:06:21 INFO - ##### 20:06:21 INFO - ##### Running run-tests step. 20:06:21 INFO - ##### 20:06:21 INFO - Running pre-action listener: _resource_record_pre_action 20:06:21 INFO - Running main action method: run_tests 20:06:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:06:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:06:21 INFO - Python 2.7.3 20:06:21 INFO - Return code: 0 20:06:21 INFO - grabbing minidump binary from tooltool 20:06: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')]} 20:06: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 0x1331410>, '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 0x1332310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13327a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:06: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 20:06: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 20:06:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:06:21 INFO - Return code: 0 20:06:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:06:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:06:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:06:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:06:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:06:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:06:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:06:22 INFO - Return code: 0 20:06:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 20:06:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 20:06:22 INFO - Using env: {'DISPLAY': ':0', 20:06:22 INFO - 'HOME': '/home/cltbld', 20:06:22 INFO - 'LANG': 'en_US.UTF-8', 20:06:22 INFO - 'LANGUAGE': 'en_US:en', 20:06:22 INFO - 'LOGNAME': 'cltbld', 20:06:22 INFO - 'MAIL': '/var/mail/cltbld', 20:06:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:06:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:06:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:22 INFO - 'MOZ_NO_REMOTE': '1', 20:06:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:06:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:22 INFO - 'NO_EM_RESTART': '1', 20:06:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:22 INFO - 'PWD': '/builds/slave/test', 20:06:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:06:22 INFO - 'SHELL': '/bin/bash', 20:06:22 INFO - 'SHLVL': '1', 20:06:22 INFO - 'TERM': 'linux', 20:06:22 INFO - 'TMOUT': '86400', 20:06:22 INFO - 'USER': 'cltbld', 20:06:22 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461291818.529804-488681429', 20:06:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:22 INFO - '_': '/tools/buildbot/bin/python'} 20:06:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 20:06:22 INFO - mozversion application_buildid: 20160421173029 20:06:22 INFO - mozversion application_changeset: 467bd00c72db8f6f34c4d9740378abb90365269f 20:06:22 INFO - mozversion application_display_name: Nightly 20:06:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:06:22 INFO - mozversion application_name: Firefox 20:06:22 INFO - mozversion application_remotingname: firefox 20:06:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:06:22 INFO - mozversion application_vendor: Mozilla 20:06:22 INFO - mozversion application_version: 48.0a1 20:06:22 INFO - mozversion platform_buildid: 20160421173029 20:06:22 INFO - mozversion platform_changeset: 467bd00c72db8f6f34c4d9740378abb90365269f 20:06:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:06:22 INFO - mozversion platform_version: 48.0a1 20:06:22 INFO - using testdate: 1461294382 20:06:22 INFO - actual date: 1461294382 20:06:22 INFO - starting webserver on 'localhost:59252' 20:06:22 INFO - SUITE-START | Running 2 tests 20:06:22 INFO - TEST-START | dromaeo_css 20:06:22 INFO - operating with platform_type : linux_ 20:06:22 INFO - Initialising browser for dromaeo_css test... 20:06:22 INFO - TEST-INFO | started process 13620 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_aqSHp/profile http://localhost:59252/getInfo.html) 20:06:25 INFO - PROCESS | 13620 | 20:06:25 INFO - PROCESS | 13620 | (process:13693): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:06:26 INFO - PROCESS | 13620 | __metrics Screen width/height:1600/1200 20:06:26 INFO - PROCESS | 13620 | colorDepth:24 20:06:26 INFO - PROCESS | 13620 | Browser inner width/height: 1024/697 20:06:26 INFO - PROCESS | 13620 | __metrics 20:06:27 ERROR - PROCESS | 13620 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 20:06:28 INFO - TEST-INFO | 13620: exit 0 20:06:28 INFO - Browser initialized. 20:06:28 INFO - Running cycle 1/1 for dromaeo_css test... 20:06:28 INFO - TEST-INFO | started process 13744 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_aqSHp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:06:30 INFO - PROCESS | 13744 | 20:06:30 INFO - PROCESS | 13744 | (process:13806): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:06:40 INFO - PROCESS | 13744 | RSS: Main: 163753984 20:06:40 INFO - PROCESS | 13744 | 20:07:29 INFO - PROCESS | 13744 | 1461294449818 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] 20:09:36 INFO - PROCESS | 13744 | Cycle 1(1): loaded http://localhost:59252/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59252/tests/dromaeo/cssquery-ext.html) 20:09:37 INFO - PROCESS | 13744 | RSS: Main: 168448000 20:09:37 INFO - PROCESS | 13744 | 20:12:39 INFO - PROCESS | 13744 | Cycle 1(1): loaded http://localhost:59252/tests/dromaeo/cssquery-ext.html (next: http://localhost:59252/tests/dromaeo/cssquery-jquery.html) 20:12:40 INFO - PROCESS | 13744 | RSS: Main: 165752832 20:12:40 INFO - PROCESS | 13744 | 20:15:42 INFO - PROCESS | 13744 | Cycle 1(1): loaded http://localhost:59252/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59252/tests/dromaeo/cssquery-mootools.html) 20:15:42 INFO - PROCESS | 13744 | RSS: Main: 166928384 20:15:42 INFO - PROCESS | 13744 | 20:18:44 INFO - PROCESS | 13744 | Cycle 1(1): loaded http://localhost:59252/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59252/tests/dromaeo/cssquery-prototype.html) 20:18:45 INFO - PROCESS | 13744 | RSS: Main: 164777984 20:18:45 INFO - PROCESS | 13744 | 20:21:47 INFO - PROCESS | 13744 | Cycle 1(1): loaded http://localhost:59252/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59252/tests/dromaeo/cssquery-yui.html) 20:21:48 INFO - PROCESS | 13744 | RSS: Main: 166039552 20:21:48 INFO - PROCESS | 13744 | 20:24:50 INFO - PROCESS | 13744 | Cycle 1(1): loaded http://localhost:59252/tests/dromaeo/cssquery-yui.html (next: http://localhost:59252/tests/dromaeo/cssquery-dojo.html) 20:24:50 INFO - PROCESS | 13744 | RSS: Main: 168185856 20:24:50 INFO - PROCESS | 13744 | 20:24:50 INFO - PROCESS | 13744 | __start_tp_report 20:24:50 INFO - PROCESS | 13744 | _x_x_mozilla_page_load 20:24:50 INFO - PROCESS | 13744 | _x_x_mozilla_page_load_details 20:24:50 INFO - PROCESS | 13744 | |i|pagename|runs| 20:24:50 INFO - PROCESS | 13744 | |0;dojo.html;3132.2326030122617;3137.748980081593;3171.635261944877;3177.253345463814;3200.9519857202145;5372.489613486718;5387.542058924996;5391.272178255939;5400.756965936533;5451.591130665196;5392.083345831208;5405.837824865251;5430.70131142787;5509.504144626982;5567.4432556744305;4911.0914480821075;4967.180415231483;5019.749012549376;5048.964962182744;5074.594032477411;539.5556615519148;4954.554090131887;4977.950220497803;5018.447970723218;5020.6234532410035;4962.379702537183;4965.627577931651;4997.250412438127;5002.4997500249865;5023.572996295319;4898.363212782351;5037.420696619863;5042.445331013586;5051.974740126276;5096.745162741848;4928.581070609002;4946.455889852114;4959.925601115986;4970.8508744737355;5016.272640467148;5328.786848526054;5359.410464848864;5366.034113859543;5366.651167674088;5392.1911713242935;5680.971595142039;5755.079187330007;5811.622244554091;5816.156657284712;5824.504917082053;5817.505512031483;5840.123981402781;5846.093855452412;5857.824265272048;5899.911501327483;5448.863778405532;5449.237106805051;5456.154296084113;5457.754401051962;5466.945330546683;5788.681622510718;5920.2007728956905;5923.674197919156;5935.080062590306;6020.578559500793;5729.512991395694;5730.7421166047625;5742.454466825645;5743.712814359265;5767.682777447197;5778.3643799182055;5792.1311803229855;5793.275840519935;5802.24570805801;5816.854578635568;5610.5231055360755;5752.33848107473;5759.827205183851;5812.099124635688;5865.912011319833;5677.914831277534;5806.535477161817;5807.680577568274;5829.125631155361;5903.822885313448;4350.825966961349;4381.978090109529;4387.846425375161;4393.121375724868;4425.623821975104;3856.9421458678144;3885.9805700971315;3929.646331830149;3942.940855887164;3961.286968345668;5496.560275177976;5551.694656793915;5553.4724201200825;5564.86087847799;5566.888662226733;5768.94231057684;5874.647521148745;5878.323992740804;5898.439648233411;5927.051671732502;5477.068898287301;5546.251256080458;5566.053770858964;5611.046122159243;5639.182318563868;4964.453910069889;4983.377077865267;4991.975040124777;4999.775010124553;5039.949600503948;5907.054871220584;5980.521558275327;5982.820515384546;5984.281886173687;6007.729652165663;5850.912236316459;5917.970410147922;5924.229850119629;5944.048952167633;5945.524358051432;5878.794242201673;5940;5941.405859414024;5943.64338139713;5945.31628862669;5618.101103823368;5704.714764261853;5731.197632331394;5733.655980641175;5739.569532285179;5864.912026319694;5867.559933004956;5872.148538461814;5893.557983151195;5941.821745347646;5690;5691.231683722644;5719.342275638189;5727.656340619409;5738.885222295447;5611.074172761449;5677.971610141923;5685.118806584986;5733.254676891977;5739.827805165852;5484.808031718871;5619.129034999582;5633.6056476047925;5653.321601407857;5681.9147712783515;5679.290088738908;5680.346760122474;5705.657660540381;5742.856428589319;5756.165356023437;5523.8895222094525;5619.960307342991;5630.74661640219;5634;5639.605227634026 20:24:50 INFO - PROCESS | 13744 | |1;ext.html;603.9698015099244;650.3464018661244;652.4617190817576;662.1094627725711;667.863088066946;31454;35756.82121589391;37564.62435375645;37579.62420375796;37766.433503497436;39429.8028509857;40288.395674064916;40303.59696403035;40465.59534404655;40494.19011619766;8464.23821856033;8567.657293708275;8616.612252448655;8649.524276164808;8675.522846243453;8372.372072094588;8477.533735644538;8481.448705834102;8491.915080849205;8654.48073115612;8673.219410253076;8741.912580874205;8783.472991620523;8796;8824.602892869836;8603.44077634955;8659.220670139686;8709.695160669346;8710.12898710127;8727.127287271222;8637.093105223923;8795.07651696569;8805.075467075929;8822.823543529157;8825.426347287406;39472.802635986925;40149.79925100385;40184.799076004725;40257.396139057935;40275.59724402748;3535.8762443314617;3573.446115852047;3707.277080969212;3779.9622003779887;4072.450219220427;31228.37543249145;31405.214869628213;31692.207694807585;32510.512342314883;32560.185995350068;4278.272693642057;4291.7854107294825;4299.763513006784;4386.627136693353;4481.686281960264;292782;295350;295686;296629;297419;35273.64726352755;36557.26885462276;36678.26643467115;58632;59183.112253316234;33956.66043339535;33981;33981.32037359239;34058.48912266318;34097.65902340945;13428.664283392993;13462.663433414244;13514.864851351558;13534.323283835769;13609.047366684435;12477.875221247672;12616.747665046647;12645.810312845315;12647.367631618383;12676.492940282285;8422.410431269753;8459.534725590152;8530.616122274512;8570;8613.181747733955;3292.8188949608;3314.320564284316;3337.4159522083537;3362.0922350965593;3362.310726301151;1046.5709059285657;1056.0917610854658;1090.0407641275785;1112.4826955465746;1126.915481338903;31035;31194;31371.529427058613;31463.84268078645;32237.51643725346;1131.6378758797107;1145.7593905279984;1167.643868620079;1195.8266051422495;1232.8643849176583;16683.49949501517;16820.49538513822;16825.91587042057;16904.66190676204;16928;485910;494185;494364;494985;496408;55903.440965590635;57158.42841571531;57568.71215643979;57623.71188144032;57653;1392.8607139286194;1416.7024924765708;1422.5234546426857;1424.6295963049681;1516.8483151684743;29914.850425748602;30839.845800770854;31481.527777082905;31771.364572708877;32306.676933230367;50627;51206.231906522175;51210;51291;51303.74348128385;411077;415365;416045;416228.269727869;416250;26554.601680974414;26621.866890665424;26742.866285668446;27026.72973270242;28922.27694307575;46829.531704682515;47482;47803.28295075507;47982.76008619935;48241;39459.40810887896;39569.80215098906;39953;40594.79702601468;41041.58958410497;39416;39683;40007.99980000523;40017.399739003355;40260;37365.81317093397;41123.7943810279;44408.55591444044;44714.3292850601;44935.77532112318;32971;34253;34458;34634.653653463145;35272.647273526934;26481.205563833115;27253.727462725117;27594.724052759215;27626.309342266602;27627.171184864485 20:24:50 INFO - PROCESS | 13744 | |2;jquery.html;376.63847675077267;383.28134747348713;387.50399488654523;388.9824957876895;392.7643413951628;16734.91632541837;18754.624907501842;19472.805271947276;19546.022698865054;19609.70585441216;17933;18111.547211319692;18395.08024598768;18488.260469581233;18826.058697065127;4121.690873184523;5421.484958928905;5526.281583394173;5588.888222235553;5594.720263986785;6008.399160083978;6022.397760223987;6040.546958978072;6041.788537401192;6050.757969681207;5754.712264386785;5906.527477801787;5926.555508336871;5975.850603734898;6083.574149809515;6021.578489505737;6028.125921741344;6053.455189032964;6057.545684073712;6066.393360663942;5158.484151584849;5460.781568737246;5465.207544906006;5521.1442226454965;5540.501354878081;21721.34835954924;21960.45098872525;21994;22006.889965550068;22267.44331391712;2386.4153282445736;2514.9874250628814;2748.169131887225;2751.380939288664;2755.077049188524;9054.592543335566;13332.200067995951;14011.859881401157;14259.358328875122;14635.780463293058;1916.9041547922689;1933.168737442899;1999.085905053357;2014.4359579317668;2048.354768247997;76233;77863.22136778616;78082.60958695227;79468.60265698635;81125.78311325394;10559.524821383056;10670.946645266724;10741.087007604441;11019.338839669645;11041.171912106463;14589;14685.632859178393;14857;14859.405623775145;14873.70252594942;7688.923110768821;7860.371170306362;7944.523328600187;7963.601819908981;8005.759107338372;7481.588512631857;7512.962435187898;7537;7644.847103058019;7644.923550764421;4556.11155824611;4562.087582483517;4573.314002899591;4648.697834640805;4725.385699858996;1919.654462196818;1945.5136215946013;1945.9491874387954;1952.6094781043848;2011.1352118588854;893.1559676106017;985.1626117799813;1031.2729525684374;1055.7782865598156;1068.780899915531;18265;18441.354552590594;18450.907745461187;18937.81062189388;19075.90462047681;963.2871674960479;976.5703090640095;978.7161723100363;987.9506024698736;995.7012896131132;10300.381977081399;10357.792844143074;10498.685039448828;10576.841347379795;10771.515281812337;170429;170576;373392;373602;376082;89319.55340223257;96945.51527242319;97402;97914.53128203083;98601.50699246458;1044.9111825494765;1063.4948399510172;1079.1798233342715;1083.1226706367868;1096.8464414982068;15641.687166256383;17031.48905532836;17196.570085747455;17236.482905512854;17317.22072506715;38731.2253754929;40241.396379054924;40883.38674919819;40914.1817163661;42024.36963445612;51061.234081488066;54986.72506637441;55466.168007479115;56253;56319;8269.875951860848;8356.164383561596;8398.916010840057;8750.081241469554;8760.167784060504;13128.803067953797;13694.794578081535;13851.099678520864;13918.51285205013;14096.154230746188;5771.538276937918;9164.129407706258;11931.522739090338;11985.700357491132;12006.39968001579;11542.480588373712;11727.296362218294;11801.881981180079;11999.820002699791;12205.816912746493;10973;12121.454534546143;12149.635510934686;12284.938575307066;12415.503379864704;8383.371247156365;8430.494170349799;8663.306935445024;8674.913250867663;8708.998465176586;10555.472226388496;11797.823032654345;12007.279563225886;12023.939880300542;12055.457504412147 20:24:50 INFO - PROCESS | 13744 | |3;mootools.html;1432.3339647064117;1488.1443170177147;1612.2583611538691;1724.1637805664259;1730.7749992500974;7383.889241661366;7922.405819563542;7948.205179482056;8213.54825484598;8232.259096681304;7944.245296696819;7976.162502937181;7984.92015079849;8015.519068855872;8066.798330041737;2228.576570451613;2239.902447800582;2253.143805353963;2254.211026140854;2264.7961683448484;2243.069126312578;2245.393743689203;2301.6777651128855;2302.2747834432184;2302.366849116498;2184.552166805801;2225.2434172381386;2248.1344682297354;2255.954880902381;2259.164109279569;2193.9122435102577;2197.165077270635;2204.7244094488187;2212.513247085639;2214.977850221493;2157.244964262511;2157.6332023556033;2159.8272138228904;2162.902669379882;2168.056895250571;8159;8206.261436470746;8235.588220589007;8312.8753068704;8319.251267385904;4966.2054071348775;5066.062778385974;5117.948820511784;5118.10433174193;5123.257127716498;3167.667394923523;3196.105090574643;3261.1031966209484;3317.552130462405;3342.398368293706;1026.5534492495788;1063.6330465989222;1067.4502631144967;1068.3376306689825;1072.528087641443;11172.888271117346;11227.21409501327;11251.718707032389;11318.943405283004;11384.032357249644;4300.16146851361;4445.82216711328;4488.775561221926;4562.133194692998;4571.742770738074;9442.433453992646;9474.573644186028;9475.810483790423;9482.620695172254;9520.952395237979;5055.51972562606;5072.036313100499;5078.695278283241;5091.134507133796;5092.032513822362;4117.547069822317;4622.445306563234;4669.089527542097;4699.694519856198;4753.762311884392;3808.2193150404655;3856.9228615428096;3946.131850992777;3951.9329780959556;3964.1080756829483;1246.2211118051218;1255.75512775008;1273.045216087934;1279.9552015679405;1311.3639884655934;942.1991307388802;954.341504361988;963.7638778499313;980.0738302304396;981.288565789811;5594.888102238014;5852.268466441695;5914.733836977346;5973.880522389615;6001.7599296027665;963.5086106085946;967.2407160379069;997.5560875410517;1000.174855744014;1014.5028935821394;3808.8476460941806;4010.639042486132;4125.855595054159;4261.765602891871;4285.828566857291;9826.508674566243;10041.648542300984;10119.747006324753;10285.897141028494;10295.588176472857;9560.713178604654;9982.850257246148;10101.747456313651;10179.9491002546;10217;7371.520851144658;7397.556146631219;7400.148982866932;7427.034485516956;7468.253174682488;5714.542836573148;6005.699715014319;6006.699665016819;6028.125921741235;6194.5354098443695;8818.294536437197;9345.112214339626;9359.719208423758;9370;9407.82402199725;9206.03336649669;9263;9273.072692730942;9337.346385752931;9347.813043739223;6780.423663988616;6971.442284617117;7232.493725439169;7253.057102576631;7411.8147046324275;8039.919600804151;8058.879116813136;8126.55303958288;8133.471324363897;8133.715319963773;6921.342472465108;7030.718771249093;7035.085438892911;7096.53872498286;7100.857982840417;6913.688884000131;6981.371676549135;7021.859562808818;7062.858742825218;7164.641767911479;6682.198136223684;6704.631245281556;6790.626515541692;6802.421794147355;6812.114425124702;4954.108260513142;5101.642884998015;5112.667676601009;5115.56517696;5151.871203219949;5244.685318880879;5249.238860365149;5253.868653283698;5358;5366.490183432567 20:24:50 INFO - PROCESS | 13744 | |4;prototype.html;314.9275666596681;317.17692587734825;327.75254682714547;328.390835001073;330.5256956267756;5810.15752715856;5957.940420595793;6023.36754640763;6078.392160783925;6112.69436528174;5943.643381397119;5952.880942381161;5959.553033522481;5960.701964901748;5962.910556341659;4555.863324100274;4555.908881822362;4559.612432943204;4561;4566.1552612766745;4420.46954365475;4575.977120114395;4578.793954272049;4580.175568397687;4591.977040114812;4516.525764794698;4543.250363689987;4557.635389168859;4564.497905230422;4577.56513131252;4579.175748365293;4585.418030779376;4585.931211031837;4586.701864378805;4606.286025666027;3693.1874987502706;3910.1397692507603;3920.313945059632;4008.579099194601;4027.597240275949;5702.800401985952;5705.743241554099;5763.711814409305;5783.5951483396175;5786.247787787603;5140.126178549618;5154.226865970097;5178.482151784829;5188.573142385836;5200.427952925175;5960.31785696434;6263.561550691454;6265.780697675605;6270.278917924452;6290.528210384239;4281;4285.8499952501825;4299.978500107511;4306.6124048835445;4320.1575692739925;6399.648019358887;6498.122753428274;6544.247411547685;6575;6579.407853293179;4309.202797482413;4353.651707863363;4361.193179261783;4368;4374.168907907488;4421.977890110529;4422.402975598317;4424.203643344164;4424.203643344229;4431.158079964861;5156.381234251839;5173.275741396207;5177.094008548489;5177.818776342885;5184.792608295701;5944.7324870380935;6138.355472675394;6199.256089269316;6305.495560355161;6316.368363163647;1522.2997421186158;1532.9770053448983;1539.468883235282;1541.876649868008;1545.6676814484715;981.7153025622632;986.5954958467138;1009.8939611340703;1011.3173607814696;1021.2442792333619;6040.124181993587;6060.757569697163;6060.999935010674;6062.878367502026;6082.2701275847185;6351.793159299718;6408.903866442007;6446.323136070739;6460.3862633049785;6460.3862633049785;5944.167816505693;5957.880842383215;6015.699215039318;6017.578769486182;6026.841479379302;3474.1314671332166;3482.495038219444;3499.8775042873376;3505.702015328726;3508.7017603503477;6422.710978006001;6538.476921846241;6545.312742162099;6713.160854893138;6731.124953755981;6633.635150066696;6642.136522252173;6668.266490686021;6681.966590167115;6709.463242940553;6334.904976425358;6722.798316050526;6741.056252124707;6752.662366881636;6800.93199068003;6535.117759102651;6579.868402632016;6589.374009469093;6606.240282367589;6624.403803657694;6290.685465726787;6498.732747114267;6573.967130164318;6587.308332625197;6590.7693230736695;6762.763303284361;6775.457963362821;6792.72829086831;6794.694238759169;6810.148731408574;4389.561043895585;4427.512973572969;4430.867073987785;4438.068005718706;4463.665225108195;6385.744570217139;6387.457066149429;6575.671216439255;6589.80230593083;6651.700673469609;6425.068365086942;6442.645654489048;6445.774397896051;6456.806295811133;6459.547831651739;6255.155554000334;6420.646864422315;6429.5499315049365;6441.291457939529;6468.579542329733;6243.562950593415;6260.154879091265;6283.403076707706;6307.769984853093;6311.084892690626;6468.8059358219325;6476.4495017924;6495.967520162369;6500.902486462613;6505.121808555974;6151.661658608819;6177;6248.531360148098;6249.7500099997305;6273.749050037947 20:24:50 INFO - PROCESS | 13744 | |5;yui.html;733.2960358056266;787.7676085554764;818.8730746734257;827.4910929778187;840.504102579478;13292.136011159268;13339.666508337297;13544.59366219015;13650.52223172188;13678.863211367896;12897.355132243374;13003.869961300408;13060.934695326534;13078.73842523149;13084.411201495932;796.2037962037962;827.4662842466605;829.8132920092991;831.7380025292014;833.3125171733313;808.0747544062045;811.5090370325956;814.2997022560593;815.8776183572481;817.3093735793275;850.6937502499095;850.8128211793396;854.8717692346136;857.661223816592;858.2361698088706;842.7345386203357;849.3163003781953;850.6172222499869;853.9957300213521;855.1662129423825;620.4942971478231;620.9627422354628;623.950083993284;628.0892705576932;628.4344090318704;13352.666183345396;13457.932710336385;13464.124831885896;13476.326183690777;13527.256000919946;12566.246025238515;12582.622521324374;12594.433250503658;12707.364631768467;12836.808708033792;10864.837027444595;11189.384583847885;11256.718582035433;11353.659390218307;11562.190646654737;3670.6696397324367;3712.7401081924004;3730.3658378075793;3757.511523501927;3777;57847;58281.417185828024;58552.70723646397;59454.108188377206;59750;10132.392056476636;10171.440570768531;10496.632617858491;10506.422146781848;10595.470226488798;19323.51691207703;19578.804211957697;19588.90205548963;20017.899910500353;20106.69839952402;7948.284654381134;7969.960150199212;8001.439899207;8124.5937703114605;8274.751757447286;4547.681662283609;4585.72485650862;4596.770161491912;4692.366530518405;4808.63935204861;3254.723348515355;3380.881669141568;3385.81378024211;3387.983060084684;3388.1360253135294;585.2362666719886;589.2634207240949;597.1878245585999;598.5331441475569;599.3736545310161;634.5906890055888;665.896785998171;670;673.9022841687928;743.31614914279;8890.688825891062;8978.86531702025;9133.178013978773;9351.719448416557;9472.100150485692;648.9740410383532;685.1948959972013;748.2031636307315;769.442154438028;771.4676872957641;4197.895052623648;4409.559044095629;4458.464984201916;4471.7987690554;4487.506374298824;65094.67452662707;65296.34187046353;65312;65857.67071164613;66309;48693.756531217114;49263.50736492661;51678.22482662763;52134.21798672947;56700;48725.26912096321;48881.26678099831;49099;49268.50731492711;50782;9416.717498475056;9495.667651632437;9546.856797148188;9608.471534065693;10007.149392301735;33871.32257354888;34133.82933085418;34182.8290858554;34305.656943430244;35010.29979400449;42399;43883.561164387946;46468.30297545472;46555.767221165035;46847;11267.380294083903;11341.4896329667;12294.139410241198;12308.446119924445;12484.063695223076;13002;13285.800712989507;13895.513657021957;14001;14076.648083797987;12754;12902.870971290542;12920.676983075122;13032.152910060815;13391.062625616114;12724.809127863275;12738.936305318784;12758.425870836021;12905.483780648668;13102.868971310547;12351.75296494083;12561.623151305475;12816.231026138088;12860.356982151043;13221.40503677356;10354.482275886327;10700.143988480748;10771.89228107709;10934.671959841218;11123.833142502706;10458;10584.788304234025;10611.2041596879;10623.734406639896;10680.092192163753 20:24:50 INFO - PROCESS | 13744 | __end_tp_report 20:24:50 INFO - PROCESS | 13744 | __start_cc_report 20:24:50 INFO - PROCESS | 13744 | _x_x_mozilla_cycle_collect,343 20:24:50 INFO - PROCESS | 13744 | __end_cc_report 20:24:50 INFO - PROCESS | 13744 | __startTimestamp1461295490709__endTimestamp 20:24:50 INFO - PROCESS | 13744 | 20:24:50 INFO - PROCESS | 13744 | ------- Summary: start ------- 20:24:50 INFO - PROCESS | 13744 | Number of tests: 6 20:24:50 INFO - PROCESS | 13744 | 20:24:50 INFO - PROCESS | 13744 | [#0] dojo.html Cycles:165 Average:5382.38 Median:5633.61 stddev:719.83 (12.8%) stddev-sans-first:700.06 20:24:50 INFO - PROCESS | 13744 | Values: 3132.2 3137.7 3171.6 3177.3 3201.0 5372.5 5387.5 5391.3 5400.8 5451.6 5392.1 5405.8 5430.7 5509.5 5567.4 4911.1 4967.2 5019.7 5049.0 5074.6 539.6 4954.6 4978.0 5018.4 5020.6 4962.4 4965.6 4997.3 5002.5 5023.6 4898.4 5037.4 5042.4 5052.0 5096.7 4928.6 4946.5 4959.9 4970.9 5016.3 5328.8 5359.4 5366.0 5366.7 5392.2 5681.0 5755.1 5811.6 5816.2 5824.5 5817.5 5840.1 5846.1 5857.8 5899.9 5448.9 5449.2 5456.2 5457.8 5466.9 5788.7 5920.2 5923.7 5935.1 6020.6 5729.5 5730.7 5742.5 5743.7 5767.7 5778.4 5792.1 5793.3 5802.2 5816.9 5610.5 5752.3 5759.8 5812.1 5865.9 5677.9 5806.5 5807.7 5829.1 5903.8 4350.8 4382.0 4387.8 4393.1 4425.6 3856.9 3886.0 3929.6 3942.9 3961.3 5496.6 5551.7 5553.5 5564.9 5566.9 5768.9 5874.6 5878.3 5898.4 5927.1 5477.1 5546.3 5566.1 5611.0 5639.2 4964.5 4983.4 4992.0 4999.8 5039.9 5907.1 5980.5 5982.8 5984.3 6007.7 5850.9 5918.0 5924.2 5944.0 5945.5 5878.8 5940.0 5941.4 5943.6 5945.3 5618.1 5704.7 5731.2 5733.7 5739.6 5864.9 5867.6 5872.1 5893.6 5941.8 5690.0 5691.2 5719.3 5727.7 5738.9 5611.1 5678.0 5685.1 5733.3 5739.8 5484.8 5619.1 5633.6 5653.3 5681.9 5679.3 5680.3 5705.7 5742.9 5756.2 5523.9 5620.0 5630.7 5634.0 5639.6 20:24:50 INFO - PROCESS | 13744 | 20:24:50 INFO - PROCESS | 13744 | [#1] ext.html Cycles:180 Average:54770.80 Median:39466.11 stddev:108651.47 (275.3%) stddev-sans-first:108880.16 20:24:50 INFO - PROCESS | 13744 | Values: 604.0 650.3 652.5 662.1 667.9 31454.0 35756.8 37564.6 37579.6 37766.4 39429.8 40288.4 40303.6 40465.6 40494.2 8464.2 8567.7 8616.6 8649.5 8675.5 8372.4 8477.5 8481.4 8491.9 8654.5 8673.2 8741.9 8783.5 8796.0 8824.6 8603.4 8659.2 8709.7 8710.1 8727.1 8637.1 8795.1 8805.1 8822.8 8825.4 39472.8 40149.8 40184.8 40257.4 40275.6 3535.9 3573.4 3707.3 3780.0 4072.5 31228.4 31405.2 31692.2 32510.5 32560.2 4278.3 4291.8 4299.8 4386.6 4481.7 292782.0 295350.0 295686.0 296629.0 297419.0 35273.6 36557.3 36678.3 58632.0 59183.1 33956.7 33981.0 33981.3 34058.5 34097.7 13428.7 13462.7 13514.9 13534.3 13609.0 12477.9 12616.7 12645.8 12647.4 12676.5 8422.4 8459.5 8530.6 8570.0 8613.2 3292.8 3314.3 3337.4 3362.1 3362.3 1046.6 1056.1 1090.0 1112.5 1126.9 31035.0 31194.0 31371.5 31463.8 32237.5 1131.6 1145.8 1167.6 1195.8 1232.9 16683.5 16820.5 16825.9 16904.7 16928.0 485910.0 494185.0 494364.0 494985.0 496408.0 55903.4 57158.4 57568.7 57623.7 57653.0 1392.9 1416.7 1422.5 1424.6 1516.8 29914.9 30839.8 31481.5 31771.4 32306.7 50627.0 51206.2 51210.0 51291.0 51303.7 411077.0 415365.0 416045.0 416228.3 416250.0 26554.6 26621.9 26742.9 27026.7 28922.3 46829.5 47482.0 47803.3 47982.8 48241.0 39459.4 39569.8 39953.0 40594.8 41041.6 39416.0 39683.0 40008.0 40017.4 40260.0 37365.8 41123.8 44408.6 44714.3 44935.8 32971.0 34253.0 34458.0 34634.7 35272.6 26481.2 27253.7 27594.7 27626.3 27627.2 20:24:50 INFO - PROCESS | 13744 | 20:24:50 INFO - PROCESS | 13744 | [#2] jquery.html Cycles:180 Average:23386.11 Median:2753.23 stddev:52774.74 (1916.8%) stddev-sans-first:52894.51 20:24:50 INFO - PROCESS | 13744 | Values: 376.6 383.3 387.5 389.0 392.8 16734.9 18754.6 19472.8 19546.0 19609.7 17933.0 18111.5 18395.1 18488.3 18826.1 4121.7 5421.5 5526.3 5588.9 5594.7 6008.4 6022.4 6040.5 6041.8 6050.8 5754.7 5906.5 5926.6 5975.9 6083.6 6021.6 6028.1 6053.5 6057.5 6066.4 5158.5 5460.8 5465.2 5521.1 5540.5 21721.3 21960.5 21994.0 22006.9 22267.4 2386.4 2515.0 2748.2 2751.4 2755.1 9054.6 13332.2 14011.9 14259.4 14635.8 1916.9 1933.2 1999.1 2014.4 2048.4 76233.0 77863.2 78082.6 79468.6 81125.8 10559.5 10670.9 10741.1 11019.3 11041.2 14589.0 14685.6 14857.0 14859.4 14873.7 7688.9 7860.4 7944.5 7963.6 8005.8 7481.6 7513.0 7537.0 7644.8 7644.9 4556.1 4562.1 4573.3 4648.7 4725.4 1919.7 1945.5 1945.9 1952.6 2011.1 893.2 985.2 1031.3 1055.8 1068.8 18265.0 18441.4 18450.9 18937.8 19075.9 963.3 976.6 978.7 988.0 995.7 10300.4 10357.8 10498.7 10576.8 10771.5 170429.0 170576.0 373392.0 373602.0 376082.0 89319.6 96945.5 97402.0 97914.5 98601.5 1044.9 1063.5 1079.2 1083.1 1096.8 15641.7 17031.5 17196.6 17236.5 17317.2 38731.2 40241.4 40883.4 40914.2 42024.4 51061.2 54986.7 55466.2 56253.0 56319.0 8269.9 8356.2 8398.9 8750.1 8760.2 13128.8 13694.8 13851.1 13918.5 14096.2 5771.5 9164.1 11931.5 11985.7 12006.4 11542.5 11727.3 11801.9 11999.8 12205.8 10973.0 12121.5 12149.6 12284.9 12415.5 8383.4 8430.5 8663.3 8674.9 8709.0 10555.5 11797.8 12007.3 12023.9 12055.5 20:24:50 INFO - PROCESS | 13744 | 20:24:50 INFO - PROCESS | 13744 | [#3] mootools.html Cycles:180 Average:5466.15 Median:5118.03 stddev:2982.75 (58.3%) stddev-sans-first:2975.71 20:24:50 INFO - PROCESS | 13744 | Values: 1432.3 1488.1 1612.3 1724.2 1730.8 7383.9 7922.4 7948.2 8213.5 8232.3 7944.2 7976.2 7984.9 8015.5 8066.8 2228.6 2239.9 2253.1 2254.2 2264.8 2243.1 2245.4 2301.7 2302.3 2302.4 2184.6 2225.2 2248.1 2256.0 2259.2 2193.9 2197.2 2204.7 2212.5 2215.0 2157.2 2157.6 2159.8 2162.9 2168.1 8159.0 8206.3 8235.6 8312.9 8319.3 4966.2 5066.1 5117.9 5118.1 5123.3 3167.7 3196.1 3261.1 3317.6 3342.4 1026.6 1063.6 1067.5 1068.3 1072.5 11172.9 11227.2 11251.7 11318.9 11384.0 4300.2 4445.8 4488.8 4562.1 4571.7 9442.4 9474.6 9475.8 9482.6 9521.0 5055.5 5072.0 5078.7 5091.1 5092.0 4117.5 4622.4 4669.1 4699.7 4753.8 3808.2 3856.9 3946.1 3951.9 3964.1 1246.2 1255.8 1273.0 1280.0 1311.4 942.2 954.3 963.8 980.1 981.3 5594.9 5852.3 5914.7 5973.9 6001.8 963.5 967.2 997.6 1000.2 1014.5 3808.8 4010.6 4125.9 4261.8 4285.8 9826.5 10041.6 10119.7 10285.9 10295.6 9560.7 9982.9 10101.7 10179.9 10217.0 7371.5 7397.6 7400.1 7427.0 7468.3 5714.5 6005.7 6006.7 6028.1 6194.5 8818.3 9345.1 9359.7 9370.0 9407.8 9206.0 9263.0 9273.1 9337.3 9347.8 6780.4 6971.4 7232.5 7253.1 7411.8 8039.9 8058.9 8126.6 8133.5 8133.7 6921.3 7030.7 7035.1 7096.5 7100.9 6913.7 6981.4 7021.9 7062.9 7164.6 6682.2 6704.6 6790.6 6802.4 6812.1 4954.1 5101.6 5112.7 5115.6 5151.9 5244.7 5249.2 5253.9 5358.0 5366.5 20:24:50 INFO - PROCESS | 13744 | 20:24:50 INFO - PROCESS | 13744 | [#4] prototype.html Cycles:180 Average:5267.49 Median:6020.47 stddev:1610.41 (26.7%) stddev-sans-first:1571.44 20:24:50 INFO - PROCESS | 13744 | Values: 314.9 317.2 327.8 328.4 330.5 5810.2 5957.9 6023.4 6078.4 6112.7 5943.6 5952.9 5959.6 5960.7 5962.9 4555.9 4555.9 4559.6 4561.0 4566.2 4420.5 4576.0 4578.8 4580.2 4592.0 4516.5 4543.3 4557.6 4564.5 4577.6 4579.2 4585.4 4585.9 4586.7 4606.3 3693.2 3910.1 3920.3 4008.6 4027.6 5702.8 5705.7 5763.7 5783.6 5786.2 5140.1 5154.2 5178.5 5188.6 5200.4 5960.3 6263.6 6265.8 6270.3 6290.5 4281.0 4285.8 4300.0 4306.6 4320.2 6399.6 6498.1 6544.2 6575.0 6579.4 4309.2 4353.7 4361.2 4368.0 4374.2 4422.0 4422.4 4424.2 4424.2 4431.2 5156.4 5173.3 5177.1 5177.8 5184.8 5944.7 6138.4 6199.3 6305.5 6316.4 1522.3 1533.0 1539.5 1541.9 1545.7 981.7 986.6 1009.9 1011.3 1021.2 6040.1 6060.8 6061.0 6062.9 6082.3 6351.8 6408.9 6446.3 6460.4 6460.4 5944.2 5957.9 6015.7 6017.6 6026.8 3474.1 3482.5 3499.9 3505.7 3508.7 6422.7 6538.5 6545.3 6713.2 6731.1 6633.6 6642.1 6668.3 6682.0 6709.5 6334.9 6722.8 6741.1 6752.7 6800.9 6535.1 6579.9 6589.4 6606.2 6624.4 6290.7 6498.7 6574.0 6587.3 6590.8 6762.8 6775.5 6792.7 6794.7 6810.1 4389.6 4427.5 4430.9 4438.1 4463.7 6385.7 6387.5 6575.7 6589.8 6651.7 6425.1 6442.6 6445.8 6456.8 6459.5 6255.2 6420.6 6429.5 6441.3 6468.6 6243.6 6260.2 6283.4 6307.8 6311.1 6468.8 6476.4 6496.0 6500.9 6505.1 6151.7 6177.0 6248.5 6249.8 6273.7 20:24:50 INFO - PROCESS | 13744 | 20:24:50 INFO - PROCESS | 13744 | [#5] yui.html Cycles:180 Average:14839.80 Median:4465.13 stddev:17412.15 (390.0%) stddev-sans-first:17428.77 20:24:50 INFO - PROCESS | 13744 | Values: 733.3 787.8 818.9 827.5 840.5 13292.1 13339.7 13544.6 13650.5 13678.9 12897.4 13003.9 13060.9 13078.7 13084.4 796.2 827.5 829.8 831.7 833.3 808.1 811.5 814.3 815.9 817.3 850.7 850.8 854.9 857.7 858.2 842.7 849.3 850.6 854.0 855.2 620.5 621.0 624.0 628.1 628.4 13352.7 13457.9 13464.1 13476.3 13527.3 12566.2 12582.6 12594.4 12707.4 12836.8 10864.8 11189.4 11256.7 11353.7 11562.2 3670.7 3712.7 3730.4 3757.5 3777.0 57847.0 58281.4 58552.7 59454.1 59750.0 10132.4 10171.4 10496.6 10506.4 10595.5 19323.5 19578.8 19588.9 20017.9 20106.7 7948.3 7970.0 8001.4 8124.6 8274.8 4547.7 4585.7 4596.8 4692.4 4808.6 3254.7 3380.9 3385.8 3388.0 3388.1 585.2 589.3 597.2 598.5 599.4 634.6 665.9 670.0 673.9 743.3 8890.7 8978.9 9133.2 9351.7 9472.1 649.0 685.2 748.2 769.4 771.5 4197.9 4409.6 4458.5 4471.8 4487.5 65094.7 65296.3 65312.0 65857.7 66309.0 48693.8 49263.5 51678.2 52134.2 56700.0 48725.3 48881.3 49099.0 49268.5 50782.0 9416.7 9495.7 9546.9 9608.5 10007.1 33871.3 34133.8 34182.8 34305.7 35010.3 42399.0 43883.6 46468.3 46555.8 46847.0 11267.4 11341.5 12294.1 12308.4 12484.1 13002.0 13285.8 13895.5 14001.0 14076.6 12754.0 12902.9 12920.7 13032.2 13391.1 12724.8 12738.9 12758.4 12905.5 13102.9 12351.8 12561.6 12816.2 12860.4 13221.4 10354.5 10700.1 10771.9 10934.7 11123.8 10458.0 10584.8 10611.2 10623.7 10680.1 20:24:50 INFO - PROCESS | 13744 | -------- Summary: end -------- 20:24:50 INFO - PROCESS | 13744 | 20:24:51 INFO - TEST-INFO | 13744: exit 0 20:24:51 INFO - TEST-OK | dromaeo_css | took 1108989ms 20:24:51 INFO - TEST-START | kraken 20:24:51 INFO - operating with platform_type : linux_ 20:24:51 INFO - Initialising browser for kraken test... 20:24:51 INFO - TEST-INFO | started process 13982 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2vwGhJ/profile http://localhost:59252/getInfo.html) 20:24:55 INFO - PROCESS | 13982 | 20:24:55 INFO - PROCESS | 13982 | (process:14052): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:24:56 INFO - PROCESS | 13982 | __metrics Screen width/height:1600/1200 20:24:56 INFO - PROCESS | 13982 | colorDepth:24 20:24:56 INFO - PROCESS | 13982 | Browser inner width/height: 1024/697 20:24:56 INFO - PROCESS | 13982 | __metrics 20:24:56 ERROR - PROCESS | 13982 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 20:24:57 INFO - TEST-INFO | 13982: exit 0 20:24:57 INFO - Browser initialized. 20:24:57 INFO - Running cycle 1/1 for kraken test... 20:24:57 INFO - TEST-INFO | started process 14103 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2vwGhJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:24:59 INFO - PROCESS | 14103 | 20:24:59 INFO - PROCESS | 14103 | (process:14166): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:25:09 INFO - PROCESS | 14103 | RSS: Main: 163692544 20:25:09 INFO - PROCESS | 14103 | 20:25:11 INFO - PROCESS | 14103 | Cycle 1(1): loaded http://localhost:59252/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59252/tests/kraken/driver.html?testName=audio-beat-detection) 20:25:12 INFO - PROCESS | 14103 | RSS: Main: 168693760 20:25:12 INFO - PROCESS | 14103 | 20:25:15 INFO - PROCESS | 14103 | Cycle 1(1): loaded http://localhost:59252/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59252/tests/kraken/driver.html?testName=audio-dft) 20:25:16 INFO - PROCESS | 14103 | RSS: Main: 171950080 20:25:16 INFO - PROCESS | 14103 | 20:25:18 INFO - PROCESS | 14103 | Cycle 1(1): loaded http://localhost:59252/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59252/tests/kraken/driver.html?testName=audio-fft) 20:25:19 INFO - PROCESS | 14103 | RSS: Main: 164171776 20:25:19 INFO - PROCESS | 14103 | 20:25:21 INFO - PROCESS | 14103 | Cycle 1(1): loaded http://localhost:59252/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59252/tests/kraken/driver.html?testName=audio-oscillator) 20:25:22 INFO - PROCESS | 14103 | RSS: Main: 164470784 20:25:22 INFO - PROCESS | 14103 | 20:25:24 INFO - PROCESS | 14103 | Cycle 1(1): loaded http://localhost:59252/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59252/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:25:25 INFO - PROCESS | 14103 | RSS: Main: 165142528 20:25:25 INFO - PROCESS | 14103 | 20:25:28 INFO - PROCESS | 14103 | Cycle 1(1): loaded http://localhost:59252/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59252/tests/kraken/driver.html?testName=imaging-darkroom) 20:25:28 INFO - PROCESS | 14103 | RSS: Main: 165289984 20:25:28 INFO - PROCESS | 14103 | 20:25:32 INFO - PROCESS | 14103 | Cycle 1(1): loaded http://localhost:59252/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59252/tests/kraken/driver.html?testName=imaging-desaturate) 20:25:32 INFO - PROCESS | 14103 | RSS: Main: 165638144 20:25:32 INFO - PROCESS | 14103 | 20:25:35 INFO - PROCESS | 14103 | Cycle 1(1): loaded http://localhost:59252/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59252/tests/kraken/driver.html?testName=json-parse-financial) 20:25:36 INFO - PROCESS | 14103 | RSS: Main: 166457344 20:25:36 INFO - PROCESS | 14103 | 20:25:37 INFO - PROCESS | 14103 | Cycle 1(1): loaded http://localhost:59252/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59252/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:25:38 INFO - PROCESS | 14103 | RSS: Main: 166232064 20:25:38 INFO - PROCESS | 14103 | 20:25:40 INFO - PROCESS | 14103 | Cycle 1(1): loaded http://localhost:59252/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59252/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:25:40 INFO - PROCESS | 14103 | RSS: Main: 166051840 20:25:40 INFO - PROCESS | 14103 | 20:25:42 INFO - PROCESS | 14103 | Cycle 1(1): loaded http://localhost:59252/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59252/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:25:43 INFO - PROCESS | 14103 | RSS: Main: 166236160 20:25:43 INFO - PROCESS | 14103 | 20:25:46 INFO - PROCESS | 14103 | Cycle 1(1): loaded http://localhost:59252/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59252/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:25:46 INFO - PROCESS | 14103 | RSS: Main: 166727680 20:25:46 INFO - PROCESS | 14103 | 20:25:49 INFO - PROCESS | 14103 | Cycle 1(1): loaded http://localhost:59252/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59252/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:25:50 INFO - PROCESS | 14103 | RSS: Main: 166604800 20:25:50 INFO - PROCESS | 14103 | 20:25:52 INFO - PROCESS | 14103 | Cycle 1(1): loaded http://localhost:59252/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59252/tests/kraken/driver.html?testName=ai-astar) 20:25:52 INFO - PROCESS | 14103 | RSS: Main: 168464384 20:25:52 INFO - PROCESS | 14103 | 20:25:52 INFO - PROCESS | 14103 | __start_tp_report 20:25:52 INFO - PROCESS | 14103 | _x_x_mozilla_page_load 20:25:52 INFO - PROCESS | 14103 | _x_x_mozilla_page_load_details 20:25:52 INFO - PROCESS | 14103 | |i|pagename|runs| 20:25:52 INFO - PROCESS | 14103 | |0;ai-astar;111;106;113;113;112;123;111;109;112;111 20:25:52 INFO - PROCESS | 14103 | |1;audio-beat-detection;161;128;157;180;125;169;157;139;189;134 20:25:52 INFO - PROCESS | 14103 | |2;audio-dft;163;167;161;162;160;163;176;162;166;161 20:25:52 INFO - PROCESS | 14103 | |3;audio-fft;76;74;73;172;73;73;73;78;156;76 20:25:52 INFO - PROCESS | 14103 | |4;audio-oscillator;92;93;145;93;93;93;147;93;93;152 20:25:52 INFO - PROCESS | 14103 | |5;imaging-gaussian-blur;117;117;117;117;118;118;118;120;118;118 20:25:52 INFO - PROCESS | 14103 | |6;imaging-darkroom;147;146;146;147;146;146;148;146;146;146 20:25:52 INFO - PROCESS | 14103 | |7;imaging-desaturate;95;95;95;95;96;95;94;95;95;95 20:25:52 INFO - PROCESS | 14103 | |8;json-parse-financial;67;57;57;61;57;57;62;76;56;55 20:25:52 INFO - PROCESS | 14103 | |9;json-stringify-tinderbox;61;62;61;62;62;61;61;61;60;62 20:25:52 INFO - PROCESS | 14103 | |10;stanford-crypto-aes;77;85;77;85;79;77;77;78;79;78 20:25:52 INFO - PROCESS | 14103 | |11;stanford-crypto-ccm;131;125;137;124;127;130;136;126;181;129 20:25:52 INFO - PROCESS | 14103 | |12;stanford-crypto-pbkdf2;171;172;176;172;176;172;171;169;169;173 20:25:52 INFO - PROCESS | 14103 | |13;stanford-crypto-sha256-iterative;71;73;76;72;70;71;68;74;68;65 20:25:52 INFO - PROCESS | 14103 | __end_tp_report 20:25:52 INFO - PROCESS | 14103 | __start_cc_report 20:25:52 INFO - PROCESS | 14103 | _x_x_mozilla_cycle_collect,849 20:25:52 INFO - PROCESS | 14103 | __end_cc_report 20:25:52 INFO - PROCESS | 14103 | __startTimestamp1461295552411__endTimestamp 20:25:52 INFO - PROCESS | 14103 | 20:25:52 INFO - PROCESS | 14103 | ------- Summary: start ------- 20:25:52 INFO - PROCESS | 14103 | Number of tests: 14 20:25:52 INFO - PROCESS | 14103 | 20:25:52 INFO - PROCESS | 14103 | [#0] ai-astar Cycles:10 Average:112.10 Median:112.00 stddev:4.36 (3.9%) stddev-sans-first:4.60 20:25:52 INFO - PROCESS | 14103 | Values: 111.0 106.0 113.0 113.0 112.0 123.0 111.0 109.0 112.0 111.0 20:25:52 INFO - PROCESS | 14103 | 20:25:52 INFO - PROCESS | 14103 | [#1] audio-beat-detection Cycles:10 Average:153.90 Median:159.00 stddev:21.95 (13.8%) stddev-sans-first:23.13 20:25:52 INFO - PROCESS | 14103 | Values: 161.0 128.0 157.0 180.0 125.0 169.0 157.0 139.0 189.0 134.0 20:25:52 INFO - PROCESS | 14103 | 20:25:52 INFO - PROCESS | 14103 | [#2] audio-dft Cycles:10 Average:164.10 Median:163.00 stddev:4.72 (2.9%) stddev-sans-first:4.99 20:25:52 INFO - PROCESS | 14103 | Values: 163.0 167.0 161.0 162.0 160.0 163.0 176.0 162.0 166.0 161.0 20:25:52 INFO - PROCESS | 14103 | 20:25:52 INFO - PROCESS | 14103 | [#3] audio-fft Cycles:10 Average:92.40 Median:73.50 stddev:37.96 (51.6%) stddev-sans-first:39.80 20:25:52 INFO - PROCESS | 14103 | Values: 76.0 74.0 73.0 172.0 73.0 73.0 73.0 78.0 156.0 76.0 20:25:52 INFO - PROCESS | 14103 | 20:25:52 INFO - PROCESS | 14103 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:93.00 stddev:26.69 (28.7%) stddev-sans-first:27.56 20:25:52 INFO - PROCESS | 14103 | Values: 92.0 93.0 145.0 93.0 93.0 93.0 147.0 93.0 93.0 152.0 20:25:52 INFO - PROCESS | 14103 | 20:25:52 INFO - PROCESS | 14103 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.92 (0.8%) stddev-sans-first:0.93 20:25:52 INFO - PROCESS | 14103 | Values: 117.0 117.0 117.0 117.0 118.0 118.0 118.0 120.0 118.0 118.0 20:25:52 INFO - PROCESS | 14103 | 20:25:52 INFO - PROCESS | 14103 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 20:25:52 INFO - PROCESS | 14103 | Values: 147.0 146.0 146.0 147.0 146.0 146.0 148.0 146.0 146.0 146.0 20:25:52 INFO - PROCESS | 14103 | 20:25:52 INFO - PROCESS | 14103 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 20:25:52 INFO - PROCESS | 14103 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 94.0 95.0 95.0 95.0 20:25:52 INFO - PROCESS | 14103 | 20:25:52 INFO - PROCESS | 14103 | [#8] json-parse-financial Cycles:10 Average:60.50 Median:59.00 stddev:6.54 (11.1%) stddev-sans-first:6.50 20:25:52 INFO - PROCESS | 14103 | Values: 67.0 57.0 57.0 61.0 57.0 57.0 62.0 76.0 56.0 55.0 20:25:52 INFO - PROCESS | 14103 | 20:25:52 INFO - PROCESS | 14103 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.50 stddev:0.67 (1.1%) stddev-sans-first:0.71 20:25:52 INFO - PROCESS | 14103 | Values: 61.0 62.0 61.0 62.0 62.0 61.0 61.0 61.0 60.0 62.0 20:25:52 INFO - PROCESS | 14103 | 20:25:52 INFO - PROCESS | 14103 | [#10] stanford-crypto-aes Cycles:10 Average:79.20 Median:78.50 stddev:3.16 (4.0%) stddev-sans-first:3.24 20:25:52 INFO - PROCESS | 14103 | Values: 77.0 85.0 77.0 85.0 79.0 77.0 77.0 78.0 79.0 78.0 20:25:52 INFO - PROCESS | 14103 | 20:25:52 INFO - PROCESS | 14103 | [#11] stanford-crypto-ccm Cycles:10 Average:134.60 Median:130.50 stddev:16.87 (12.9%) stddev-sans-first:17.85 20:25:52 INFO - PROCESS | 14103 | Values: 131.0 125.0 137.0 124.0 127.0 130.0 136.0 126.0 181.0 129.0 20:25:52 INFO - PROCESS | 14103 | 20:25:52 INFO - PROCESS | 14103 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.10 Median:172.00 stddev:2.42 (1.4%) stddev-sans-first:2.54 20:25:52 INFO - PROCESS | 14103 | Values: 171.0 172.0 176.0 172.0 176.0 172.0 171.0 169.0 169.0 173.0 20:25:52 INFO - PROCESS | 14103 | 20:25:52 INFO - PROCESS | 14103 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:71.50 stddev:3.22 (4.5%) stddev-sans-first:3.42 20:25:52 INFO - PROCESS | 14103 | Values: 71.0 73.0 76.0 72.0 70.0 71.0 68.0 74.0 68.0 65.0 20:25:52 INFO - PROCESS | 14103 | -------- Summary: end -------- 20:25:52 INFO - PROCESS | 14103 | 20:25:53 INFO - TEST-INFO | 14103: exit 0 20:25:53 INFO - TEST-OK | kraken | took 61904ms 20:25:53 INFO - SUITE-END | took 1170s 20:25:53 INFO - Completed test suite (00:19:31) 20:25:53 INFO - javascript benchmark 20:25:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3132.2326030122617, 3137.748980081593, 3171.635261944877, 3177.253345463814, 3200.9519857202145, 5372.489613486718, 5387.542058924996, 5391.272178255939, 5400.756965936533, 5451.591130665196, 5392.083345831208, 5405.837824865251, 5430.70131142787, 5509.504144626982, 5567.4432556744305, 4911.0914480821075, 4967.180415231483, 5019.749012549376, 5048.964962182744, 5074.594032477411, 539.5556615519148, 4954.554090131887, 4977.950220497803, 5018.447970723218, 5020.6234532410035, 4962.379702537183, 4965.627577931651, 4997.250412438127, 5002.4997500249865, 5023.572996295319, 4898.363212782351, 5037.420696619863, 5042.445331013586, 5051.974740126276, 5096.745162741848, 4928.581070609002, 4946.455889852114, 4959.925601115986, 4970.8508744737355, 5016.272640467148, 5328.786848526054, 5359.410464848864, 5366.034113859543, 5366.651167674088, 5392.1911713242935, 5680.971595142039, 5755.079187330007, 5811.622244554091, 5816.156657284712, 5824.504917082053, 5817.505512031483, 5840.123981402781, 5846.093855452412, 5857.824265272048, 5899.911501327483, 5448.863778405532, 5449.237106805051, 5456.154296084113, 5457.754401051962, 5466.945330546683, 5788.681622510718, 5920.2007728956905, 5923.674197919156, 5935.080062590306, 6020.578559500793, 5729.512991395694, 5730.7421166047625, 5742.454466825645, 5743.712814359265, 5767.682777447197, 5778.3643799182055, 5792.1311803229855, 5793.275840519935, 5802.24570805801, 5816.854578635568, 5610.5231055360755, 5752.33848107473, 5759.827205183851, 5812.099124635688, 5865.912011319833, 5677.914831277534, 5806.535477161817, 5807.680577568274, 5829.125631155361, 5903.822885313448, 4350.825966961349, 4381.978090109529, 4387.846425375161, 4393.121375724868, 4425.623821975104, 3856.9421458678144, 3885.9805700971315, 3929.646331830149, 3942.940855887164, 3961.286968345668, 5496.560275177976, 5551.694656793915, 5553.4724201200825, 5564.86087847799, 5566.888662226733, 5768.94231057684, 5874.647521148745, 5878.323992740804, 5898.439648233411, 5927.051671732502, 5477.068898287301, 5546.251256080458, 5566.053770858964, 5611.046122159243, 5639.182318563868, 4964.453910069889, 4983.377077865267, 4991.975040124777, 4999.775010124553, 5039.949600503948, 5907.054871220584, 5980.521558275327, 5982.820515384546, 5984.281886173687, 6007.729652165663, 5850.912236316459, 5917.970410147922, 5924.229850119629, 5944.048952167633, 5945.524358051432, 5878.794242201673, 5940.0, 5941.405859414024, 5943.64338139713, 5945.31628862669, 5618.101103823368, 5704.714764261853, 5731.197632331394, 5733.655980641175, 5739.569532285179, 5864.912026319694, 5867.559933004956, 5872.148538461814, 5893.557983151195, 5941.821745347646, 5690.0, 5691.231683722644, 5719.342275638189, 5727.656340619409, 5738.885222295447, 5611.074172761449, 5677.971610141923, 5685.118806584986, 5733.254676891977, 5739.827805165852, 5484.808031718871, 5619.129034999582, 5633.6056476047925, 5653.321601407857, 5681.9147712783515, 5679.290088738908, 5680.346760122474, 5705.657660540381, 5742.856428589319, 5756.165356023437, 5523.8895222094525, 5619.960307342991, 5630.74661640219, 5634.0, 5639.605227634026], "value": 5335.982631816428, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.9698015099244, 650.3464018661244, 652.4617190817576, 662.1094627725711, 667.863088066946, 31454.0, 35756.82121589391, 37564.62435375645, 37579.62420375796, 37766.433503497436, 39429.8028509857, 40288.395674064916, 40303.59696403035, 40465.59534404655, 40494.19011619766, 8464.23821856033, 8567.657293708275, 8616.612252448655, 8649.524276164808, 8675.522846243453, 8372.372072094588, 8477.533735644538, 8481.448705834102, 8491.915080849205, 8654.48073115612, 8673.219410253076, 8741.912580874205, 8783.472991620523, 8796.0, 8824.602892869836, 8603.44077634955, 8659.220670139686, 8709.695160669346, 8710.12898710127, 8727.127287271222, 8637.093105223923, 8795.07651696569, 8805.075467075929, 8822.823543529157, 8825.426347287406, 39472.802635986925, 40149.79925100385, 40184.799076004725, 40257.396139057935, 40275.59724402748, 3535.8762443314617, 3573.446115852047, 3707.277080969212, 3779.9622003779887, 4072.450219220427, 31228.37543249145, 31405.214869628213, 31692.207694807585, 32510.512342314883, 32560.185995350068, 4278.272693642057, 4291.7854107294825, 4299.763513006784, 4386.627136693353, 4481.686281960264, 292782.0, 295350.0, 295686.0, 296629.0, 297419.0, 35273.64726352755, 36557.26885462276, 36678.26643467115, 58632.0, 59183.112253316234, 33956.66043339535, 33981.0, 33981.32037359239, 34058.48912266318, 34097.65902340945, 13428.664283392993, 13462.663433414244, 13514.864851351558, 13534.323283835769, 13609.047366684435, 12477.875221247672, 12616.747665046647, 12645.810312845315, 12647.367631618383, 12676.492940282285, 8422.410431269753, 8459.534725590152, 8530.616122274512, 8570.0, 8613.181747733955, 3292.8188949608, 3314.320564284316, 3337.4159522083537, 3362.0922350965593, 3362.310726301151, 1046.5709059285657, 1056.0917610854658, 1090.0407641275785, 1112.4826955465746, 1126.915481338903, 31035.0, 31194.0, 31371.529427058613, 31463.84268078645, 32237.51643725346, 1131.6378758797107, 1145.7593905279984, 1167.643868620079, 1195.8266051422495, 1232.8643849176583, 16683.49949501517, 16820.49538513822, 16825.91587042057, 16904.66190676204, 16928.0, 485910.0, 494185.0, 494364.0, 494985.0, 496408.0, 55903.440965590635, 57158.42841571531, 57568.71215643979, 57623.71188144032, 57653.0, 1392.8607139286194, 1416.7024924765708, 1422.5234546426857, 1424.6295963049681, 1516.8483151684743, 29914.850425748602, 30839.845800770854, 31481.527777082905, 31771.364572708877, 32306.676933230367, 50627.0, 51206.231906522175, 51210.0, 51291.0, 51303.74348128385, 411077.0, 415365.0, 416045.0, 416228.269727869, 416250.0, 26554.601680974414, 26621.866890665424, 26742.866285668446, 27026.72973270242, 28922.27694307575, 46829.531704682515, 47482.0, 47803.28295075507, 47982.76008619935, 48241.0, 39459.40810887896, 39569.80215098906, 39953.0, 40594.79702601468, 41041.58958410497, 39416.0, 39683.0, 40007.99980000523, 40017.399739003355, 40260.0, 37365.81317093397, 41123.7943810279, 44408.55591444044, 44714.3292850601, 44935.77532112318, 32971.0, 34253.0, 34458.0, 34634.653653463145, 35272.647273526934, 26481.205563833115, 27253.727462725117, 27594.724052759215, 27626.309342266602, 27627.171184864485], "value": 18357.132085991198, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.63847675077267, 383.28134747348713, 387.50399488654523, 388.9824957876895, 392.7643413951628, 16734.91632541837, 18754.624907501842, 19472.805271947276, 19546.022698865054, 19609.70585441216, 17933.0, 18111.547211319692, 18395.08024598768, 18488.260469581233, 18826.058697065127, 4121.690873184523, 5421.484958928905, 5526.281583394173, 5588.888222235553, 5594.720263986785, 6008.399160083978, 6022.397760223987, 6040.546958978072, 6041.788537401192, 6050.757969681207, 5754.712264386785, 5906.527477801787, 5926.555508336871, 5975.850603734898, 6083.574149809515, 6021.578489505737, 6028.125921741344, 6053.455189032964, 6057.545684073712, 6066.393360663942, 5158.484151584849, 5460.781568737246, 5465.207544906006, 5521.1442226454965, 5540.501354878081, 21721.34835954924, 21960.45098872525, 21994.0, 22006.889965550068, 22267.44331391712, 2386.4153282445736, 2514.9874250628814, 2748.169131887225, 2751.380939288664, 2755.077049188524, 9054.592543335566, 13332.200067995951, 14011.859881401157, 14259.358328875122, 14635.780463293058, 1916.9041547922689, 1933.168737442899, 1999.085905053357, 2014.4359579317668, 2048.354768247997, 76233.0, 77863.22136778616, 78082.60958695227, 79468.60265698635, 81125.78311325394, 10559.524821383056, 10670.946645266724, 10741.087007604441, 11019.338839669645, 11041.171912106463, 14589.0, 14685.632859178393, 14857.0, 14859.405623775145, 14873.70252594942, 7688.923110768821, 7860.371170306362, 7944.523328600187, 7963.601819908981, 8005.759107338372, 7481.588512631857, 7512.962435187898, 7537.0, 7644.847103058019, 7644.923550764421, 4556.11155824611, 4562.087582483517, 4573.314002899591, 4648.697834640805, 4725.385699858996, 1919.654462196818, 1945.5136215946013, 1945.9491874387954, 1952.6094781043848, 2011.1352118588854, 893.1559676106017, 985.1626117799813, 1031.2729525684374, 1055.7782865598156, 1068.780899915531, 18265.0, 18441.354552590594, 18450.907745461187, 18937.81062189388, 19075.90462047681, 963.2871674960479, 976.5703090640095, 978.7161723100363, 987.9506024698736, 995.7012896131132, 10300.381977081399, 10357.792844143074, 10498.685039448828, 10576.841347379795, 10771.515281812337, 170429.0, 170576.0, 373392.0, 373602.0, 376082.0, 89319.55340223257, 96945.51527242319, 97402.0, 97914.53128203083, 98601.50699246458, 1044.9111825494765, 1063.4948399510172, 1079.1798233342715, 1083.1226706367868, 1096.8464414982068, 15641.687166256383, 17031.48905532836, 17196.570085747455, 17236.482905512854, 17317.22072506715, 38731.2253754929, 40241.396379054924, 40883.38674919819, 40914.1817163661, 42024.36963445612, 51061.234081488066, 54986.72506637441, 55466.168007479115, 56253.0, 56319.0, 8269.875951860848, 8356.164383561596, 8398.916010840057, 8750.081241469554, 8760.167784060504, 13128.803067953797, 13694.794578081535, 13851.099678520864, 13918.51285205013, 14096.154230746188, 5771.538276937918, 9164.129407706258, 11931.522739090338, 11985.700357491132, 12006.39968001579, 11542.480588373712, 11727.296362218294, 11801.881981180079, 11999.820002699791, 12205.816912746493, 10973.0, 12121.454534546143, 12149.635510934686, 12284.938575307066, 12415.503379864704, 8383.371247156365, 8430.494170349799, 8663.306935445024, 8674.913250867663, 8708.998465176586, 10555.472226388496, 11797.823032654345, 12007.279563225886, 12023.939880300542, 12055.457504412147], "value": 9079.898662693051, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1432.3339647064117, 1488.1443170177147, 1612.2583611538691, 1724.1637805664259, 1730.7749992500974, 7383.889241661366, 7922.405819563542, 7948.205179482056, 8213.54825484598, 8232.259096681304, 7944.245296696819, 7976.162502937181, 7984.92015079849, 8015.519068855872, 8066.798330041737, 2228.576570451613, 2239.902447800582, 2253.143805353963, 2254.211026140854, 2264.7961683448484, 2243.069126312578, 2245.393743689203, 2301.6777651128855, 2302.2747834432184, 2302.366849116498, 2184.552166805801, 2225.2434172381386, 2248.1344682297354, 2255.954880902381, 2259.164109279569, 2193.9122435102577, 2197.165077270635, 2204.7244094488187, 2212.513247085639, 2214.977850221493, 2157.244964262511, 2157.6332023556033, 2159.8272138228904, 2162.902669379882, 2168.056895250571, 8159.0, 8206.261436470746, 8235.588220589007, 8312.8753068704, 8319.251267385904, 4966.2054071348775, 5066.062778385974, 5117.948820511784, 5118.10433174193, 5123.257127716498, 3167.667394923523, 3196.105090574643, 3261.1031966209484, 3317.552130462405, 3342.398368293706, 1026.5534492495788, 1063.6330465989222, 1067.4502631144967, 1068.3376306689825, 1072.528087641443, 11172.888271117346, 11227.21409501327, 11251.718707032389, 11318.943405283004, 11384.032357249644, 4300.16146851361, 4445.82216711328, 4488.775561221926, 4562.133194692998, 4571.742770738074, 9442.433453992646, 9474.573644186028, 9475.810483790423, 9482.620695172254, 9520.952395237979, 5055.51972562606, 5072.036313100499, 5078.695278283241, 5091.134507133796, 5092.032513822362, 4117.547069822317, 4622.445306563234, 4669.089527542097, 4699.694519856198, 4753.762311884392, 3808.2193150404655, 3856.9228615428096, 3946.131850992777, 3951.9329780959556, 3964.1080756829483, 1246.2211118051218, 1255.75512775008, 1273.045216087934, 1279.9552015679405, 1311.3639884655934, 942.1991307388802, 954.341504361988, 963.7638778499313, 980.0738302304396, 981.288565789811, 5594.888102238014, 5852.268466441695, 5914.733836977346, 5973.880522389615, 6001.7599296027665, 963.5086106085946, 967.2407160379069, 997.5560875410517, 1000.174855744014, 1014.5028935821394, 3808.8476460941806, 4010.639042486132, 4125.855595054159, 4261.765602891871, 4285.828566857291, 9826.508674566243, 10041.648542300984, 10119.747006324753, 10285.897141028494, 10295.588176472857, 9560.713178604654, 9982.850257246148, 10101.747456313651, 10179.9491002546, 10217.0, 7371.520851144658, 7397.556146631219, 7400.148982866932, 7427.034485516956, 7468.253174682488, 5714.542836573148, 6005.699715014319, 6006.699665016819, 6028.125921741235, 6194.5354098443695, 8818.294536437197, 9345.112214339626, 9359.719208423758, 9370.0, 9407.82402199725, 9206.03336649669, 9263.0, 9273.072692730942, 9337.346385752931, 9347.813043739223, 6780.423663988616, 6971.442284617117, 7232.493725439169, 7253.057102576631, 7411.8147046324275, 8039.919600804151, 8058.879116813136, 8126.55303958288, 8133.471324363897, 8133.715319963773, 6921.342472465108, 7030.718771249093, 7035.085438892911, 7096.53872498286, 7100.857982840417, 6913.688884000131, 6981.371676549135, 7021.859562808818, 7062.858742825218, 7164.641767911479, 6682.198136223684, 6704.631245281556, 6790.626515541692, 6802.421794147355, 6812.114425124702, 4954.108260513142, 5101.642884998015, 5112.667676601009, 5115.56517696, 5151.871203219949, 5244.685318880879, 5249.238860365149, 5253.868653283698, 5358.0, 5366.490183432567], "value": 4441.016172852356, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.9275666596681, 317.17692587734825, 327.75254682714547, 328.390835001073, 330.5256956267756, 5810.15752715856, 5957.940420595793, 6023.36754640763, 6078.392160783925, 6112.69436528174, 5943.643381397119, 5952.880942381161, 5959.553033522481, 5960.701964901748, 5962.910556341659, 4555.863324100274, 4555.908881822362, 4559.612432943204, 4561.0, 4566.1552612766745, 4420.46954365475, 4575.977120114395, 4578.793954272049, 4580.175568397687, 4591.977040114812, 4516.525764794698, 4543.250363689987, 4557.635389168859, 4564.497905230422, 4577.56513131252, 4579.175748365293, 4585.418030779376, 4585.931211031837, 4586.701864378805, 4606.286025666027, 3693.1874987502706, 3910.1397692507603, 3920.313945059632, 4008.579099194601, 4027.597240275949, 5702.800401985952, 5705.743241554099, 5763.711814409305, 5783.5951483396175, 5786.247787787603, 5140.126178549618, 5154.226865970097, 5178.482151784829, 5188.573142385836, 5200.427952925175, 5960.31785696434, 6263.561550691454, 6265.780697675605, 6270.278917924452, 6290.528210384239, 4281.0, 4285.8499952501825, 4299.978500107511, 4306.6124048835445, 4320.1575692739925, 6399.648019358887, 6498.122753428274, 6544.247411547685, 6575.0, 6579.407853293179, 4309.202797482413, 4353.651707863363, 4361.193179261783, 4368.0, 4374.168907907488, 4421.977890110529, 4422.402975598317, 4424.203643344164, 4424.203643344229, 4431.158079964861, 5156.381234251839, 5173.275741396207, 5177.094008548489, 5177.818776342885, 5184.792608295701, 5944.7324870380935, 6138.355472675394, 6199.256089269316, 6305.495560355161, 6316.368363163647, 1522.2997421186158, 1532.9770053448983, 1539.468883235282, 1541.876649868008, 1545.6676814484715, 981.7153025622632, 986.5954958467138, 1009.8939611340703, 1011.3173607814696, 1021.2442792333619, 6040.124181993587, 6060.757569697163, 6060.999935010674, 6062.878367502026, 6082.2701275847185, 6351.793159299718, 6408.903866442007, 6446.323136070739, 6460.3862633049785, 6460.3862633049785, 5944.167816505693, 5957.880842383215, 6015.699215039318, 6017.578769486182, 6026.841479379302, 3474.1314671332166, 3482.495038219444, 3499.8775042873376, 3505.702015328726, 3508.7017603503477, 6422.710978006001, 6538.476921846241, 6545.312742162099, 6713.160854893138, 6731.124953755981, 6633.635150066696, 6642.136522252173, 6668.266490686021, 6681.966590167115, 6709.463242940553, 6334.904976425358, 6722.798316050526, 6741.056252124707, 6752.662366881636, 6800.93199068003, 6535.117759102651, 6579.868402632016, 6589.374009469093, 6606.240282367589, 6624.403803657694, 6290.685465726787, 6498.732747114267, 6573.967130164318, 6587.308332625197, 6590.7693230736695, 6762.763303284361, 6775.457963362821, 6792.72829086831, 6794.694238759169, 6810.148731408574, 4389.561043895585, 4427.512973572969, 4430.867073987785, 4438.068005718706, 4463.665225108195, 6385.744570217139, 6387.457066149429, 6575.671216439255, 6589.80230593083, 6651.700673469609, 6425.068365086942, 6442.645654489048, 6445.774397896051, 6456.806295811133, 6459.547831651739, 6255.155554000334, 6420.646864422315, 6429.5499315049365, 6441.291457939529, 6468.579542329733, 6243.562950593415, 6260.154879091265, 6283.403076707706, 6307.769984853093, 6311.084892690626, 6468.8059358219325, 6476.4495017924, 6495.967520162369, 6500.902486462613, 6505.121808555974, 6151.661658608819, 6177.0, 6248.531360148098, 6249.7500099997305, 6273.749050037947], "value": 4733.637104225906, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [733.2960358056266, 787.7676085554764, 818.8730746734257, 827.4910929778187, 840.504102579478, 13292.136011159268, 13339.666508337297, 13544.59366219015, 13650.52223172188, 13678.863211367896, 12897.355132243374, 13003.869961300408, 13060.934695326534, 13078.73842523149, 13084.411201495932, 796.2037962037962, 827.4662842466605, 829.8132920092991, 831.7380025292014, 833.3125171733313, 808.0747544062045, 811.5090370325956, 814.2997022560593, 815.8776183572481, 817.3093735793275, 850.6937502499095, 850.8128211793396, 854.8717692346136, 857.661223816592, 858.2361698088706, 842.7345386203357, 849.3163003781953, 850.6172222499869, 853.9957300213521, 855.1662129423825, 620.4942971478231, 620.9627422354628, 623.950083993284, 628.0892705576932, 628.4344090318704, 13352.666183345396, 13457.932710336385, 13464.124831885896, 13476.326183690777, 13527.256000919946, 12566.246025238515, 12582.622521324374, 12594.433250503658, 12707.364631768467, 12836.808708033792, 10864.837027444595, 11189.384583847885, 11256.718582035433, 11353.659390218307, 11562.190646654737, 3670.6696397324367, 3712.7401081924004, 3730.3658378075793, 3757.511523501927, 3777.0, 57847.0, 58281.417185828024, 58552.70723646397, 59454.108188377206, 59750.0, 10132.392056476636, 10171.440570768531, 10496.632617858491, 10506.422146781848, 10595.470226488798, 19323.51691207703, 19578.804211957697, 19588.90205548963, 20017.899910500353, 20106.69839952402, 7948.284654381134, 7969.960150199212, 8001.439899207, 8124.5937703114605, 8274.751757447286, 4547.681662283609, 4585.72485650862, 4596.770161491912, 4692.366530518405, 4808.63935204861, 3254.723348515355, 3380.881669141568, 3385.81378024211, 3387.983060084684, 3388.1360253135294, 585.2362666719886, 589.2634207240949, 597.1878245585999, 598.5331441475569, 599.3736545310161, 634.5906890055888, 665.896785998171, 670.0, 673.9022841687928, 743.31614914279, 8890.688825891062, 8978.86531702025, 9133.178013978773, 9351.719448416557, 9472.100150485692, 648.9740410383532, 685.1948959972013, 748.2031636307315, 769.442154438028, 771.4676872957641, 4197.895052623648, 4409.559044095629, 4458.464984201916, 4471.7987690554, 4487.506374298824, 65094.67452662707, 65296.34187046353, 65312.0, 65857.67071164613, 66309.0, 48693.756531217114, 49263.50736492661, 51678.22482662763, 52134.21798672947, 56700.0, 48725.26912096321, 48881.26678099831, 49099.0, 49268.50731492711, 50782.0, 9416.717498475056, 9495.667651632437, 9546.856797148188, 9608.471534065693, 10007.149392301735, 33871.32257354888, 34133.82933085418, 34182.8290858554, 34305.656943430244, 35010.29979400449, 42399.0, 43883.561164387946, 46468.30297545472, 46555.767221165035, 46847.0, 11267.380294083903, 11341.4896329667, 12294.139410241198, 12308.446119924445, 12484.063695223076, 13002.0, 13285.800712989507, 13895.513657021957, 14001.0, 14076.648083797987, 12754.0, 12902.870971290542, 12920.676983075122, 13032.152910060815, 13391.062625616114, 12724.809127863275, 12738.936305318784, 12758.425870836021, 12905.483780648668, 13102.868971310547, 12351.75296494083, 12561.623151305475, 12816.231026138088, 12860.356982151043, 13221.40503677356, 10354.482275886327, 10700.143988480748, 10771.89228107709, 10934.671959841218, 11123.833142502706, 10458.0, 10584.788304234025, 10611.2041596879, 10623.734406639896, 10680.092192163753], "value": 6699.081351500988, "unit": "score"}], "name": "dromaeo_css", "value": 7073.569263878979, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 113.0, 113.0, 112.0, 123.0, 111.0, 109.0, 112.0, 111.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 128.0, 157.0, 180.0, 125.0, 169.0, 157.0, 139.0, 189.0, 134.0], "value": 153.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 167.0, 161.0, 162.0, 160.0, 163.0, 176.0, 162.0, 166.0, 161.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 73.0, 172.0, 73.0, 73.0, 73.0, 78.0, 156.0, 76.0], "value": 92.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 145.0, 93.0, 93.0, 93.0, 147.0, 93.0, 93.0, 152.0], "value": 109.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 120.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 148.0, 146.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 57.0, 57.0, 61.0, 57.0, 57.0, 62.0, 76.0, 56.0, 55.0], "value": 60.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 62.0, 62.0, 61.0, 61.0, 61.0, 60.0, 62.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 85.0, 77.0, 85.0, 79.0, 77.0, 77.0, 78.0, 79.0, 78.0], "value": 79.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 125.0, 137.0, 124.0, 127.0, 130.0, 136.0, 126.0, 181.0, 129.0], "value": 134.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 172.0, 176.0, 172.0, 176.0, 172.0, 171.0, 169.0, 169.0, 173.0], "value": 172.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 73.0, 76.0, 72.0, 70.0, 71.0, 68.0, 74.0, 68.0, 65.0], "value": 70.8, "unit": "score"}], "name": "kraken", "value": 1569.5999999999997, "alertThreshold": 2.0}]} 20:25:53 INFO - Return code: 0 20:25:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:25:53 ERROR - # TBPL SUCCESS # 20:25:53 INFO - Running post-action listener: _resource_record_post_action 20:25:53 INFO - Running post-run listener: _resource_record_post_run 20:25:54 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 16384; Write bytes: 545353728; Read time: 192; Write time: 562140 20:25:54 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 4096; Write bytes: 255754240; Read time: 96; Write time: 363932 20:25:54 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 12288; Write bytes: 289529856; Read time: 96; Write time: 198188 20:25:54 INFO - Running post-run listener: _upload_blobber_files 20:25:54 INFO - Blob upload gear active. 20:25:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:25:54 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 20:25:54 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:25:54 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:25:55 INFO - (blobuploader) - INFO - Open directory for files ... 20:25:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:25:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:25:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:25:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:25:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:25:56 INFO - (blobuploader) - INFO - Done attempting. 20:25:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:25:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:25:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:25:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:25:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:25:56 INFO - (blobuploader) - INFO - Done attempting. 20:25:56 INFO - (blobuploader) - INFO - Iteration through files over. 20:25:56 INFO - Return code: 0 20:25:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:25:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:25:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4b0465623165583016e8bbb63aef5a17f0a54c7fe8f58911f78849fcbed63af08d36916a8c86a7f0dea860bf374d2cdc136e3410537419ecc1cc15452a14b428", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1b40fb4d1594682eef36cce2cba1b28f82b8cb80d4b9c7ec4159645a097a99d32046443c3f059ac3e159b739cb72e1f2a541ada6134f780af4896ff61d1f32db"} 20:25:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:25:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:25:56 INFO - Contents: 20:25:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4b0465623165583016e8bbb63aef5a17f0a54c7fe8f58911f78849fcbed63af08d36916a8c86a7f0dea860bf374d2cdc136e3410537419ecc1cc15452a14b428", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1b40fb4d1594682eef36cce2cba1b28f82b8cb80d4b9c7ec4159645a097a99d32046443c3f059ac3e159b739cb72e1f2a541ada6134f780af4896ff61d1f32db"} 20:25:56 INFO - Running post-run listener: copy_logs_to_upload_dir 20:25:56 INFO - Copying logs to upload dir... 20:25:56 INFO - mkdir: /builds/slave/test/build/upload/logs 20:25:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.591804 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-04-21 20:25:56.852123) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 20:25:56.855327) ========= 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=00204705a9daa57ed339a427000001b9-1461291818.529804-488681429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4b0465623165583016e8bbb63aef5a17f0a54c7fe8f58911f78849fcbed63af08d36916a8c86a7f0dea860bf374d2cdc136e3410537419ecc1cc15452a14b428", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1b40fb4d1594682eef36cce2cba1b28f82b8cb80d4b9c7ec4159645a097a99d32046443c3f059ac3e159b739cb72e1f2a541ada6134f780af4896ff61d1f32db"} build_url:https://queue.taskcluster.net/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011166 build_url: 'https://queue.taskcluster.net/v1/task/Am8ZGxC7Q1CgSx-TEbSocw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4b0465623165583016e8bbb63aef5a17f0a54c7fe8f58911f78849fcbed63af08d36916a8c86a7f0dea860bf374d2cdc136e3410537419ecc1cc15452a14b428", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1b40fb4d1594682eef36cce2cba1b28f82b8cb80d4b9c7ec4159645a097a99d32046443c3f059ac3e159b739cb72e1f2a541ada6134f780af4896ff61d1f32db"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 20:25:56.879271) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 20:25:56.879552) ========= 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=00204705a9daa57ed339a427000001b9-1461291818.529804-488681429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004574 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 20:25:56.962557) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 20:25:56.962848) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 20:25:56.963132) ========= ========= Total master_lag: 0.17 =========