builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-066 starttime: 1461711125.33 results: success (0) buildid: 20160426142902 builduid: 94475adab2ed44fbb18e832244c7fdd0 revision: 937d57e8b4f0fa5f16231563ab0425eee9d40c82 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 15:52:05.335135) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 15:52:05.336007) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 15:52:05.336340) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 15:52:05.358188) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 15:52:05.358451) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1461709408.870582-200037354 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-26 15:52:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.1M=0s 2016-04-26 15:52:06 (43.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.068992 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 15:52:05.441772) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 15:52:05.442078) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1461709408.870582-200037354 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019667 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 15:52:05.528988) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-26 15:52:05.529293) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 937d57e8b4f0fa5f16231563ab0425eee9d40c82 --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 937d57e8b4f0fa5f16231563ab0425eee9d40c82 --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=82c74bd3bc9a11c5833d2010000001e6-1461709408.870582-200037354 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-26 15:52:06,485 truncating revision to first 12 chars 2016-04-26 15:52:06,485 Setting DEBUG logging. 2016-04-26 15:52:06,486 attempt 1/10 2016-04-26 15:52:06,486 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/937d57e8b4f0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-26 15:52:07,660 unpacking tar archive at: fx-team-937d57e8b4f0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.495122 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-26 15:52:07.041120) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 15:52:07.041425) ========= script_repo_revision: 937d57e8b4f0fa5f16231563ab0425eee9d40c82 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 15:52:07.041925) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 15:52:07.042217) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 15:52:07.053267) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-04-26 15:52:07.053840) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=82c74bd3bc9a11c5833d2010000001e6-1461709408.870582-200037354 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:52:08 INFO - MultiFileLogger online at 20160426 15:52:08 in /builds/slave/test 15:52:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 15:52:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:52:08 INFO - {'append_to_log': False, 15:52:08 INFO - 'base_work_dir': '/builds/slave/test', 15:52:08 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:52:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:52:08 INFO - 'branch': 'Fx-Team-Non-PGO', 15:52:08 INFO - 'buildbot_json_path': 'buildprops.json', 15:52:08 INFO - 'config_files': ('talos/linux_config.py',), 15:52:08 INFO - 'default_actions': ('clobber', 15:52:08 INFO - 'read-buildbot-config', 15:52:08 INFO - 'download-and-extract', 15:52:08 INFO - 'populate-webroot', 15:52:08 INFO - 'create-virtualenv', 15:52:08 INFO - 'install', 15:52:08 INFO - 'run-tests'), 15:52:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:52:08 INFO - 'download_minidump_stackwalk': True, 15:52:08 INFO - 'download_symbols': 'ondemand', 15:52:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:52:08 INFO - 'tooltool.py': '/tools/tooltool.py', 15:52:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:52:08 INFO - '/tools/misc-python/virtualenv.py')}, 15:52:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:52:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:52:08 INFO - 'installer_path': 'installer.exe', 15:52:08 INFO - 'log_level': 'info', 15:52:08 INFO - 'log_name': 'talos', 15:52:08 INFO - 'log_to_console': True, 15:52:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:52:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:52:08 INFO - 'opt_config_files': (), 15:52:08 INFO - 'pip_index': False, 15:52:08 INFO - 'sps_profile': False, 15:52:08 INFO - 'sps_profile_interval': 0, 15:52:08 INFO - 'suite': 'dromaeojs-e10s', 15:52:08 INFO - 'system_bits': '32', 15:52:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:52:08 INFO - 'title': 'talos-linux64-ix-066', 15:52:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:52:08 INFO - 'use_talos_json': True, 15:52:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:52:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:52:08 INFO - 'work_dir': 'build'} 15:52:08 INFO - ##### 15:52:08 INFO - ##### Running clobber step. 15:52:08 INFO - ##### 15:52:08 INFO - Running pre-action listener: _resource_record_pre_action 15:52:08 INFO - Running main action method: clobber 15:52:08 INFO - rmtree: /builds/slave/test/build 15:52:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:52:09 INFO - Running post-action listener: _resource_record_post_action 15:52:09 INFO - ##### 15:52:09 INFO - ##### Running read-buildbot-config step. 15:52:09 INFO - ##### 15:52:09 INFO - Running pre-action listener: _resource_record_pre_action 15:52:09 INFO - Running main action method: read_buildbot_config 15:52:09 INFO - Using buildbot properties: 15:52:09 INFO - { 15:52:09 INFO - "project": "", 15:52:09 INFO - "product": "firefox", 15:52:09 INFO - "script_repo_revision": "production", 15:52:09 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 15:52:09 INFO - "repository": "", 15:52:09 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 15:52:09 INFO - "buildid": "20160426142902", 15:52:09 INFO - "pgo_build": "False", 15:52:09 INFO - "basedir": "/builds/slave/test", 15:52:09 INFO - "buildnumber": 1211, 15:52:09 INFO - "slavename": "talos-linux64-ix-066", 15:52:09 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:52:09 INFO - "platform": "ubuntu64_hw", 15:52:09 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:52:09 INFO - "branch": "fx-team", 15:52:09 INFO - "repo_path": "integration/fx-team", 15:52:09 INFO - "revision": "937d57e8b4f0fa5f16231563ab0425eee9d40c82", 15:52:09 INFO - "stage_platform": "linux64", 15:52:09 INFO - "builduid": "94475adab2ed44fbb18e832244c7fdd0", 15:52:09 INFO - "slavebuilddir": "test" 15:52:09 INFO - } 15:52:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 15:52:09 INFO - Running post-action listener: _resource_record_post_action 15:52:09 INFO - ##### 15:52:09 INFO - ##### Running download-and-extract step. 15:52:09 INFO - ##### 15:52:09 INFO - Running pre-action listener: _resource_record_pre_action 15:52:09 INFO - Running main action method: download_and_extract 15:52:09 INFO - mkdir: /builds/slave/test/build/tests 15:52:09 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')]} 15:52:09 INFO - https://queue.taskcluster.net/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:52:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:52:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:52:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:52:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:52:10 INFO - Downloaded 1361 bytes. 15:52:10 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:52:10 INFO - Using the following test package requirements: 15:52:10 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:52:10 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:52:10 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:52:10 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:10 INFO - u'jsshell-linux-x86_64.zip'], 15:52:10 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:52:10 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:52:10 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:52:10 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:52:10 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:52:10 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:52:10 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:52:10 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')]} 15:52:10 INFO - https://queue.taskcluster.net/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:52:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:52:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:52:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:52:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:52:15 INFO - Downloaded 22291062 bytes. 15:52:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:52:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:52:16 INFO - Return code: 0 15:52:16 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:52:16 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')]} 15:52:16 INFO - https://queue.taskcluster.net/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:52:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:52:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:52:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:52:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:52:19 INFO - Downloaded 22291062 bytes. 15:52:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:52:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:52:20 INFO - Return code: 0 15:52:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:20 INFO - https://queue.taskcluster.net/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:52:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:52:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:52:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:52:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:52:22 INFO - Downloaded 10840145 bytes. 15:52:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:52:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:52:22 INFO - Return code: 0 15:52:22 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')]} 15:52:22 INFO - https://queue.taskcluster.net/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:52:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:52:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:52:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:52:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:52:24 INFO - Downloaded 54817608 bytes. 15:52:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:52:24 INFO - mkdir: /builds/slave/test/properties 15:52:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:52:24 INFO - Writing to file /builds/slave/test/properties/build_url 15:52:24 INFO - Contents: 15:52:24 INFO - build_url:https://queue.taskcluster.net/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:52:25 INFO - Running post-action listener: _resource_record_post_action 15:52:25 INFO - Running post-action listener: set_extra_try_arguments 15:52:25 INFO - ##### 15:52:25 INFO - ##### Running populate-webroot step. 15:52:25 INFO - ##### 15:52:25 INFO - Running pre-action listener: _resource_record_pre_action 15:52:25 INFO - Running main action method: populate_webroot 15:52:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:52:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:52:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:52:25 INFO - '--tppagecycles', 15:52:25 INFO - '7'], 15:52:25 INFO - 'tests': ['tsvgm']}}, 15:52:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:52:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:52:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:52:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:52:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:52:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:52:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:25 INFO - 'talos_options': ['--disable-e10s'], 15:52:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:52:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:52:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:25 INFO - 'talos_options': ['--disable-e10s'], 15:52:25 INFO - 'tests': ['damp', 'tps']}, 15:52:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:25 INFO - 'tests': ['damp', 'tps']}, 15:52:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:52:25 INFO - 'tests': ['dromaeo_dom']}, 15:52:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:52:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:52:25 INFO - 'tests': ['a11yr', 15:52:25 INFO - 'ts_paint', 15:52:25 INFO - 'tpaint', 15:52:25 INFO - 'sessionrestore', 15:52:25 INFO - 'sessionrestore_no_auto_restore', 15:52:25 INFO - 'tabpaint']}, 15:52:25 INFO - 'other-e10s': {'tests': ['a11yr', 15:52:25 INFO - 'ts_paint', 15:52:25 INFO - 'tpaint', 15:52:25 INFO - 'sessionrestore', 15:52:25 INFO - 'sessionrestore_no_auto_restore', 15:52:25 INFO - 'tabpaint']}, 15:52:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:52:25 INFO - 'ts_paint', 15:52:25 INFO - 'tpaint', 15:52:25 INFO - 'sessionrestore', 15:52:25 INFO - 'sessionrestore_no_auto_restore', 15:52:25 INFO - 'tabpaint']}, 15:52:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:52:25 INFO - 'ts_paint', 15:52:25 INFO - 'tpaint', 15:52:25 INFO - 'sessionrestore', 15:52:25 INFO - 'sessionrestore_no_auto_restore', 15:52:25 INFO - 'tabpaint']}, 15:52:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:52:25 INFO - 'tests': ['a11yr', 15:52:25 INFO - 'ts_paint', 15:52:25 INFO - 'tpaint', 15:52:25 INFO - 'sessionrestore', 15:52:25 INFO - 'sessionrestore_no_auto_restore', 15:52:25 INFO - 'tabpaint']}, 15:52:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:52:25 INFO - 'tests': ['a11yr', 15:52:25 INFO - 'ts_paint', 15:52:25 INFO - 'tpaint', 15:52:25 INFO - 'sessionrestore', 15:52:25 INFO - 'sessionrestore_no_auto_restore', 15:52:25 INFO - 'tabpaint']}, 15:52:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:52:25 INFO - 'tests': ['tsvgx', 15:52:25 INFO - 'tsvgr_opacity', 15:52:25 INFO - 'tart', 15:52:25 INFO - 'tscrollx', 15:52:25 INFO - 'cart']}, 15:52:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:52:25 INFO - 'tsvgr_opacity', 15:52:25 INFO - 'tart', 15:52:25 INFO - 'tscrollx', 15:52:25 INFO - 'cart']}, 15:52:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:25 INFO - 'talos_options': ['--disable-e10s'], 15:52:25 INFO - 'tests': ['tp5o']}, 15:52:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:25 INFO - 'tests': ['tp5o']}, 15:52:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:25 INFO - 'talos_options': ['--disable-e10s', 15:52:25 INFO - '--xperf_path', 15:52:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:52:25 INFO - 'tests': ['tp5n']}, 15:52:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:25 INFO - 'talos_options': ['--xperf_path', 15:52:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:52:25 INFO - 'tests': ['tp5n']}}, 15:52:25 INFO - 'talos.zip': {'path': '', 15:52:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:52:25 INFO - Running post-action listener: _resource_record_post_action 15:52:25 INFO - ##### 15:52:25 INFO - ##### Running create-virtualenv step. 15:52:25 INFO - ##### 15:52:25 INFO - Running pre-action listener: _resource_record_pre_action 15:52:25 INFO - Running main action method: create_virtualenv 15:52:25 INFO - Creating virtualenv /builds/slave/test/build/venv 15:52:25 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 15:52:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:52:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:52:25 INFO - Using real prefix '/usr' 15:52:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:52:25 INFO - Installing distribute.............................................................................................................................................................................................done. 15:52:27 INFO - Installing pip.................done. 15:52:27 INFO - Return code: 0 15:52:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:52: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')]} 15:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52: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')]} 15:52:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:27 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 0x7f8ce665ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26895a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2718410>, '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 0x2719310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27197a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1461709408.870582-200037354', '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 15:52:27 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 15:52:27 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 15:52:27 INFO - Using env: {'DISPLAY': ':0', 15:52:27 INFO - 'HOME': '/home/cltbld', 15:52:27 INFO - 'LANG': 'en_US.UTF-8', 15:52:27 INFO - 'LANGUAGE': 'en_US:en', 15:52:27 INFO - 'LOGNAME': 'cltbld', 15:52:27 INFO - 'MAIL': '/var/mail/cltbld', 15:52:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:27 INFO - 'MOZ_NO_REMOTE': '1', 15:52:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:27 INFO - 'NO_EM_RESTART': '1', 15:52:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:27 INFO - 'PWD': '/builds/slave/test', 15:52:27 INFO - 'SHELL': '/bin/bash', 15:52:27 INFO - 'SHLVL': '1', 15:52:27 INFO - 'TERM': 'linux', 15:52:27 INFO - 'TMOUT': '86400', 15:52:27 INFO - 'USER': 'cltbld', 15:52:27 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1461709408.870582-200037354', 15:52:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:27 INFO - '_': '/tools/buildbot/bin/python'} 15:52:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:28 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 15:52:28 INFO - Cleaning up... 15:52:28 INFO - Return code: 0 15:52:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:52:28 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')]} 15:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:28 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')]} 15:52:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:28 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 0x7f8ce665ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26895a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2718410>, '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 0x2719310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27197a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1461709408.870582-200037354', '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 15:52:28 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 15:52:28 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 15:52:28 INFO - Using env: {'DISPLAY': ':0', 15:52:28 INFO - 'HOME': '/home/cltbld', 15:52:28 INFO - 'LANG': 'en_US.UTF-8', 15:52:28 INFO - 'LANGUAGE': 'en_US:en', 15:52:28 INFO - 'LOGNAME': 'cltbld', 15:52:28 INFO - 'MAIL': '/var/mail/cltbld', 15:52:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:28 INFO - 'MOZ_NO_REMOTE': '1', 15:52:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:28 INFO - 'NO_EM_RESTART': '1', 15:52:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:28 INFO - 'PWD': '/builds/slave/test', 15:52:28 INFO - 'SHELL': '/bin/bash', 15:52:28 INFO - 'SHLVL': '1', 15:52:28 INFO - 'TERM': 'linux', 15:52:28 INFO - 'TMOUT': '86400', 15:52:28 INFO - 'USER': 'cltbld', 15:52:28 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1461709408.870582-200037354', 15:52:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:28 INFO - '_': '/tools/buildbot/bin/python'} 15:52:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:28 INFO - Downloading/unpacking psutil>=0.7.1 15:52:28 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 15:52:28 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 15:52:28 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 15:52:28 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 15:52:28 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 15:52:28 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 15:52:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:52:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:52:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:52:30 INFO - Installing collected packages: psutil 15:52:30 INFO - Running setup.py install for psutil 15:52:30 INFO - building 'psutil._psutil_linux' extension 15:52:30 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 15:52:30 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 15:52:30 INFO - building 'psutil._psutil_posix' extension 15:52:30 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 15:52:30 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 15:52:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:52:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:52:30 INFO - Successfully installed psutil 15:52:30 INFO - Cleaning up... 15:52:30 INFO - Return code: 0 15:52:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:52:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8ce665ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26895a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2718410>, '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 0x2719310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27197a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1461709408.870582-200037354', '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 15:52:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 15:52:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:52:30 INFO - Using env: {'DISPLAY': ':0', 15:52:30 INFO - 'HOME': '/home/cltbld', 15:52:30 INFO - 'LANG': 'en_US.UTF-8', 15:52:30 INFO - 'LANGUAGE': 'en_US:en', 15:52:30 INFO - 'LOGNAME': 'cltbld', 15:52:30 INFO - 'MAIL': '/var/mail/cltbld', 15:52:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:30 INFO - 'MOZ_NO_REMOTE': '1', 15:52:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:30 INFO - 'NO_EM_RESTART': '1', 15:52:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:30 INFO - 'PWD': '/builds/slave/test', 15:52:30 INFO - 'SHELL': '/bin/bash', 15:52:30 INFO - 'SHLVL': '1', 15:52:30 INFO - 'TERM': 'linux', 15:52:30 INFO - 'TMOUT': '86400', 15:52:30 INFO - 'USER': 'cltbld', 15:52:30 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1461709408.870582-200037354', 15:52:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:30 INFO - '_': '/tools/buildbot/bin/python'} 15:52:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:52:31 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 15:52:31 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 15:52:31 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 15:52:31 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 15:52:31 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 15:52:31 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 15:52:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:52:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:52:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:52:33 INFO - Installing collected packages: mozsystemmonitor 15:52:33 INFO - Running setup.py install for mozsystemmonitor 15:52:33 INFO - Successfully installed mozsystemmonitor 15:52:33 INFO - Cleaning up... 15:52:33 INFO - Return code: 0 15:52:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:52:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8ce665ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26895a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2718410>, '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 0x2719310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27197a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1461709408.870582-200037354', '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 15:52:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:52:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:52:33 INFO - Using env: {'DISPLAY': ':0', 15:52:33 INFO - 'HOME': '/home/cltbld', 15:52:33 INFO - 'LANG': 'en_US.UTF-8', 15:52:33 INFO - 'LANGUAGE': 'en_US:en', 15:52:33 INFO - 'LOGNAME': 'cltbld', 15:52:33 INFO - 'MAIL': '/var/mail/cltbld', 15:52:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:33 INFO - 'MOZ_NO_REMOTE': '1', 15:52:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:33 INFO - 'NO_EM_RESTART': '1', 15:52:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:33 INFO - 'PWD': '/builds/slave/test', 15:52:33 INFO - 'SHELL': '/bin/bash', 15:52:33 INFO - 'SHLVL': '1', 15:52:33 INFO - 'TERM': 'linux', 15:52:33 INFO - 'TMOUT': '86400', 15:52:33 INFO - 'USER': 'cltbld', 15:52:33 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1461709408.870582-200037354', 15:52:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:33 INFO - '_': '/tools/buildbot/bin/python'} 15:52:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:33 INFO - Downloading/unpacking blobuploader==1.2.4 15:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:35 INFO - Downloading blobuploader-1.2.4.tar.gz 15:52:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:52:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:52:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:35 INFO - Downloading docopt-0.6.1.tar.gz 15:52:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:52:35 INFO - Installing collected packages: blobuploader, requests, docopt 15:52:35 INFO - Running setup.py install for blobuploader 15:52:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:52:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:52:36 INFO - Running setup.py install for requests 15:52:36 INFO - Running setup.py install for docopt 15:52:36 INFO - Successfully installed blobuploader requests docopt 15:52:36 INFO - Cleaning up... 15:52:36 INFO - Return code: 0 15:52:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:52: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')]} 15:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52: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')]} 15:52:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:36 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 0x7f8ce665ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26895a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2718410>, '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 0x2719310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27197a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1461709408.870582-200037354', '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 15:52:36 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 15:52:36 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 15:52:36 INFO - Using env: {'DISPLAY': ':0', 15:52:36 INFO - 'HOME': '/home/cltbld', 15:52:36 INFO - 'LANG': 'en_US.UTF-8', 15:52:36 INFO - 'LANGUAGE': 'en_US:en', 15:52:36 INFO - 'LOGNAME': 'cltbld', 15:52:36 INFO - 'MAIL': '/var/mail/cltbld', 15:52:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:36 INFO - 'MOZ_NO_REMOTE': '1', 15:52:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:36 INFO - 'NO_EM_RESTART': '1', 15:52:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:36 INFO - 'PWD': '/builds/slave/test', 15:52:36 INFO - 'SHELL': '/bin/bash', 15:52:36 INFO - 'SHLVL': '1', 15:52:36 INFO - 'TERM': 'linux', 15:52:36 INFO - 'TMOUT': '86400', 15:52:36 INFO - 'USER': 'cltbld', 15:52:36 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1461709408.870582-200037354', 15:52:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:36 INFO - '_': '/tools/buildbot/bin/python'} 15:52:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:52:36 INFO - Running setup.py (path:/tmp/pip-Luexj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:52:36 INFO - Running setup.py (path:/tmp/pip-Vvbubf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:52:36 INFO - Running setup.py (path:/tmp/pip-Kxp38m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:52:37 INFO - Running setup.py (path:/tmp/pip-jlAs5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:52:37 INFO - Running setup.py (path:/tmp/pip-hqgdBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:52:37 INFO - Running setup.py (path:/tmp/pip-fpibEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:52:37 INFO - Running setup.py (path:/tmp/pip-LrUSwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:52:37 INFO - Running setup.py (path:/tmp/pip-0UpWKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:52:37 INFO - Running setup.py (path:/tmp/pip-D2pI4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:52:37 INFO - Running setup.py (path:/tmp/pip-8QuvfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:52:37 INFO - Running setup.py (path:/tmp/pip-_FHZHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:52:37 INFO - Running setup.py (path:/tmp/pip-XVjxta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:52:37 INFO - Running setup.py (path:/tmp/pip-qmqe7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:52:37 INFO - Running setup.py (path:/tmp/pip-AaT2H0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:52:37 INFO - Running setup.py (path:/tmp/pip-J68RF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:52:37 INFO - Running setup.py (path:/tmp/pip-Blm669-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:52:37 INFO - Running setup.py (path:/tmp/pip-DjY2ut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:52:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:52:38 INFO - Running setup.py install for manifestparser 15:52:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:52:38 INFO - Running setup.py install for mozcrash 15:52:38 INFO - Running setup.py install for mozdebug 15:52:38 INFO - Running setup.py install for mozdevice 15:52:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:52:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:52:38 INFO - Running setup.py install for mozfile 15:52:38 INFO - Running setup.py install for mozhttpd 15:52:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:52:38 INFO - Running setup.py install for mozinfo 15:52:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:52:38 INFO - Running setup.py install for mozInstall 15:52:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:52:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:52:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:52:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:52:38 INFO - Running setup.py install for mozleak 15:52:38 INFO - Running setup.py install for mozlog 15:52:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:52:39 INFO - Running setup.py install for moznetwork 15:52:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:52:39 INFO - Running setup.py install for mozprocess 15:52:39 INFO - Running setup.py install for mozprofile 15:52:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:52:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:52:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:52:39 INFO - Running setup.py install for mozrunner 15:52:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:52:39 INFO - Running setup.py install for mozscreenshot 15:52:39 INFO - Running setup.py install for moztest 15:52:39 INFO - Running setup.py install for mozversion 15:52:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:52:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:52:39 INFO - Cleaning up... 15:52:39 INFO - Return code: 0 15:52:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:52:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:39 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 0x7f8ce665ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26895a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2718410>, '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 0x2719310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27197a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1461709408.870582-200037354', '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 15:52:39 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 15:52:39 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 15:52:39 INFO - Using env: {'DISPLAY': ':0', 15:52:39 INFO - 'HOME': '/home/cltbld', 15:52:39 INFO - 'LANG': 'en_US.UTF-8', 15:52:39 INFO - 'LANGUAGE': 'en_US:en', 15:52:39 INFO - 'LOGNAME': 'cltbld', 15:52:39 INFO - 'MAIL': '/var/mail/cltbld', 15:52:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:39 INFO - 'MOZ_NO_REMOTE': '1', 15:52:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:39 INFO - 'NO_EM_RESTART': '1', 15:52:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:39 INFO - 'PWD': '/builds/slave/test', 15:52:39 INFO - 'SHELL': '/bin/bash', 15:52:39 INFO - 'SHLVL': '1', 15:52:39 INFO - 'TERM': 'linux', 15:52:39 INFO - 'TMOUT': '86400', 15:52:39 INFO - 'USER': 'cltbld', 15:52:39 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1461709408.870582-200037354', 15:52:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:39 INFO - '_': '/tools/buildbot/bin/python'} 15:52:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:52:40 INFO - Running setup.py (path:/tmp/pip-bYSCh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:52:40 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)) 15:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:52:40 INFO - Running setup.py (path:/tmp/pip-V6MaX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:52:40 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)) 15:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:52:40 INFO - Running setup.py (path:/tmp/pip-hFwneP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:52:40 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)) 15:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:52:40 INFO - Running setup.py (path:/tmp/pip-cPI1TZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:52:40 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)) 15:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:52:40 INFO - Running setup.py (path:/tmp/pip-c3Tep2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:52:40 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)) 15:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:52:40 INFO - Running setup.py (path:/tmp/pip-z80E_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:52:40 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)) 15:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:52:40 INFO - Running setup.py (path:/tmp/pip-wSh8Ef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:52:40 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)) 15:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:52:40 INFO - Running setup.py (path:/tmp/pip-lXt4LH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:52:40 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)) 15:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:52:40 INFO - Running setup.py (path:/tmp/pip-i1tAkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:52:40 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)) 15:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:52:40 INFO - Running setup.py (path:/tmp/pip-vX8GZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:52:40 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)) 15:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:52:40 INFO - Running setup.py (path:/tmp/pip-MdhT88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:52:40 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)) 15:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:52:40 INFO - Running setup.py (path:/tmp/pip-RkOVEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:52:40 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)) 15:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:52:40 INFO - Running setup.py (path:/tmp/pip-917qBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:52:40 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)) 15:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:52:40 INFO - Running setup.py (path:/tmp/pip-_e1VHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:52:41 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)) 15:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:52:41 INFO - Running setup.py (path:/tmp/pip-llDLTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:52:41 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)) 15:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:52:41 INFO - Running setup.py (path:/tmp/pip-Ge7SAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:52:41 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)) 15:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:52:41 INFO - Running setup.py (path:/tmp/pip-okkxWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:52:41 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)) 15:52:41 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)) 15:52:41 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)) 15:52:41 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)) 15:52:41 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)) 15:52:41 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)) 15:52:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:52:41 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 15:52:41 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 15:52:41 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 15:52:41 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 15:52:41 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 15:52:41 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 15:52:43 INFO - Downloading blessings-1.6.tar.gz 15:52:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:52:43 INFO - Installing collected packages: blessings 15:52:43 INFO - Running setup.py install for blessings 15:52:43 INFO - Successfully installed blessings 15:52:43 INFO - Cleaning up... 15:52:43 INFO - Return code: 0 15:52:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:52:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:52:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:52:43 INFO - Reading from file tmpfile_stdout 15:52:43 INFO - Current package versions: 15:52:43 INFO - argparse == 1.2.1 15:52:43 INFO - blessings == 1.6 15:52:43 INFO - blobuploader == 1.2.4 15:52:43 INFO - docopt == 0.6.1 15:52:43 INFO - manifestparser == 1.1 15:52:43 INFO - mozInstall == 1.12 15:52:43 INFO - mozcrash == 0.17 15:52:43 INFO - mozdebug == 0.1 15:52:43 INFO - mozdevice == 0.48 15:52:43 INFO - mozfile == 1.2 15:52:43 INFO - mozhttpd == 0.7 15:52:43 INFO - mozinfo == 0.9 15:52:43 INFO - mozleak == 0.1 15:52:43 INFO - mozlog == 3.1 15:52:43 INFO - moznetwork == 0.27 15:52:43 INFO - mozprocess == 0.22 15:52:43 INFO - mozprofile == 0.28 15:52:43 INFO - mozrunner == 6.11 15:52:43 INFO - mozscreenshot == 0.1 15:52:43 INFO - mozsystemmonitor == 0.0 15:52:43 INFO - moztest == 0.7 15:52:43 INFO - mozversion == 1.4 15:52:43 INFO - psutil == 3.1.1 15:52:43 INFO - requests == 1.2.3 15:52:43 INFO - wsgiref == 0.1.2 15:52:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:52: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')]} 15:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52: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')]} 15:52:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:43 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 0x7f8ce665ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26895a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2718410>, '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 0x2719310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27197a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1461709408.870582-200037354', '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 15:52:43 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 15:52:43 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 15:52:43 INFO - Using env: {'DISPLAY': ':0', 15:52:43 INFO - 'HOME': '/home/cltbld', 15:52:43 INFO - 'LANG': 'en_US.UTF-8', 15:52:43 INFO - 'LANGUAGE': 'en_US:en', 15:52:43 INFO - 'LOGNAME': 'cltbld', 15:52:43 INFO - 'MAIL': '/var/mail/cltbld', 15:52:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:43 INFO - 'MOZ_NO_REMOTE': '1', 15:52:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:43 INFO - 'NO_EM_RESTART': '1', 15:52:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:43 INFO - 'PWD': '/builds/slave/test', 15:52:43 INFO - 'SHELL': '/bin/bash', 15:52:43 INFO - 'SHLVL': '1', 15:52:43 INFO - 'TERM': 'linux', 15:52:43 INFO - 'TMOUT': '86400', 15:52:43 INFO - 'USER': 'cltbld', 15:52:43 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1461709408.870582-200037354', 15:52:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:43 INFO - '_': '/tools/buildbot/bin/python'} 15:52:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:43 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)) 15:52:43 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)) 15:52:43 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)) 15:52:43 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)) 15:52:43 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)) 15:52:43 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)) 15:52:43 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)) 15:52:43 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)) 15:52:43 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)) 15:52:43 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)) 15:52:43 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)) 15:52:43 INFO - Cleaning up... 15:52:43 INFO - Return code: 0 15:52:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:52: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')]} 15:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52: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')]} 15:52:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ce665ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26895a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2718410>, '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 0x2719310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27197a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1461709408.870582-200037354', '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 15:52: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', 'jsonschema'] in /builds/slave/test/build 15:52: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 jsonschema 15:52:43 INFO - Using env: {'DISPLAY': ':0', 15:52:43 INFO - 'HOME': '/home/cltbld', 15:52:43 INFO - 'LANG': 'en_US.UTF-8', 15:52:43 INFO - 'LANGUAGE': 'en_US:en', 15:52:43 INFO - 'LOGNAME': 'cltbld', 15:52:43 INFO - 'MAIL': '/var/mail/cltbld', 15:52:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:43 INFO - 'MOZ_NO_REMOTE': '1', 15:52:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:43 INFO - 'NO_EM_RESTART': '1', 15:52:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:43 INFO - 'PWD': '/builds/slave/test', 15:52:43 INFO - 'SHELL': '/bin/bash', 15:52:43 INFO - 'SHLVL': '1', 15:52:43 INFO - 'TERM': 'linux', 15:52:43 INFO - 'TMOUT': '86400', 15:52:43 INFO - 'USER': 'cltbld', 15:52:43 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1461709408.870582-200037354', 15:52:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:43 INFO - '_': '/tools/buildbot/bin/python'} 15:52:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:44 INFO - Downloading/unpacking jsonschema 15:52:44 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 15:52:44 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 15:52:44 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 15:52:44 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 15:52:44 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 15:52:44 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 15:52:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:52:45 INFO - Downloading/unpacking functools32 (from jsonschema) 15:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:46 INFO - Downloading functools32-3.2.3-2.tar.gz 15:52:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:52:46 INFO - warning: no files found matching '*.txt' 15:52:46 INFO - no previously-included directories found matching 'build' 15:52:46 INFO - no previously-included directories found matching 'dist' 15:52:46 INFO - no previously-included directories found matching '.git*' 15:52:46 INFO - Installing collected packages: jsonschema, functools32 15:52:46 INFO - Running setup.py install for functools32 15:52:46 INFO - warning: no files found matching '*.txt' 15:52:46 INFO - no previously-included directories found matching 'build' 15:52:46 INFO - no previously-included directories found matching 'dist' 15:52:46 INFO - no previously-included directories found matching '.git*' 15:52:46 INFO - Successfully installed jsonschema functools32 15:52:46 INFO - Cleaning up... 15:52:46 INFO - Return code: 0 15:52:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:52:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ce665ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26895a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2718410>, '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 0x2719310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27197a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1461709408.870582-200037354', '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 15:52:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 15:52:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:52:46 INFO - Using env: {'DISPLAY': ':0', 15:52:46 INFO - 'HOME': '/home/cltbld', 15:52:46 INFO - 'LANG': 'en_US.UTF-8', 15:52:46 INFO - 'LANGUAGE': 'en_US:en', 15:52:46 INFO - 'LOGNAME': 'cltbld', 15:52:46 INFO - 'MAIL': '/var/mail/cltbld', 15:52:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:46 INFO - 'MOZ_NO_REMOTE': '1', 15:52:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:46 INFO - 'NO_EM_RESTART': '1', 15:52:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:46 INFO - 'PWD': '/builds/slave/test', 15:52:46 INFO - 'SHELL': '/bin/bash', 15:52:46 INFO - 'SHLVL': '1', 15:52:46 INFO - 'TERM': 'linux', 15:52:46 INFO - 'TMOUT': '86400', 15:52:46 INFO - 'USER': 'cltbld', 15:52:46 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1461709408.870582-200037354', 15:52:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:46 INFO - '_': '/tools/buildbot/bin/python'} 15:52:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:46 INFO - Downloading/unpacking flake8 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:52:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:52:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:52:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:52:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:52:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:52:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:52:49 INFO - no previously-included directories found matching 'docs/_build' 15:52:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:52:49 INFO - Running setup.py install for pep8 15:52:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:52:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:52:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:52:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:52:49 INFO - no previously-included directories found matching 'docs/_build' 15:52:49 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:52:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:52:49 INFO - Cleaning up... 15:52:49 INFO - Return code: 0 15:52:49 INFO - Running post-action listener: _resource_record_post_action 15:52:49 INFO - Running post-action listener: _start_resource_monitoring 15:52:49 INFO - Starting resource monitoring. 15:52:49 INFO - ##### 15:52:49 INFO - ##### Running install step. 15:52:49 INFO - ##### 15:52:49 INFO - Running pre-action listener: _resource_record_pre_action 15:52:49 INFO - Running main action method: install 15:52:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:52:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:52:49 INFO - Reading from file tmpfile_stdout 15:52:49 INFO - Detecting whether we're running mozinstall >=1.0... 15:52:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:52:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:52:49 INFO - Reading from file tmpfile_stdout 15:52:49 INFO - Output received: 15:52:49 INFO - Usage: mozinstall [options] installer 15:52:49 INFO - Options: 15:52:49 INFO - -h, --help show this help message and exit 15:52:49 INFO - -d DEST, --destination=DEST 15:52:49 INFO - Directory to install application into. [default: 15:52:49 INFO - "/builds/slave/test"] 15:52:49 INFO - --app=APP Application being installed. [default: firefox] 15:52:49 INFO - mkdir: /builds/slave/test/build/application 15:52:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:52:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:53:05 INFO - Reading from file tmpfile_stdout 15:53:05 INFO - Output received: 15:53:05 INFO - /builds/slave/test/build/application/firefox/firefox 15:53:05 INFO - Running post-action listener: _resource_record_post_action 15:53:05 INFO - ##### 15:53:05 INFO - ##### Running run-tests step. 15:53:05 INFO - ##### 15:53:05 INFO - Running pre-action listener: _resource_record_pre_action 15:53:05 INFO - Running main action method: run_tests 15:53:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:53:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:53:05 INFO - Python 2.7.3 15:53:05 INFO - Return code: 0 15:53:05 INFO - grabbing minidump binary from tooltool 15:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:05 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 0x2718410>, '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 0x2719310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27197a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:53:05 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 15:53:05 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 15:53:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:53:05 INFO - Return code: 0 15:53:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:53:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:53:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:53:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:53:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:53:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:53:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:53:06 INFO - Return code: 0 15:53:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 15:53:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 15:53:06 INFO - Using env: {'DISPLAY': ':0', 15:53:06 INFO - 'HOME': '/home/cltbld', 15:53:06 INFO - 'LANG': 'en_US.UTF-8', 15:53:06 INFO - 'LANGUAGE': 'en_US:en', 15:53:06 INFO - 'LOGNAME': 'cltbld', 15:53:06 INFO - 'MAIL': '/var/mail/cltbld', 15:53:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:53:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:53:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:06 INFO - 'MOZ_NO_REMOTE': '1', 15:53:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:53:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:06 INFO - 'NO_EM_RESTART': '1', 15:53:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:06 INFO - 'PWD': '/builds/slave/test', 15:53:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:53:06 INFO - 'SHELL': '/bin/bash', 15:53:06 INFO - 'SHLVL': '1', 15:53:06 INFO - 'TERM': 'linux', 15:53:06 INFO - 'TMOUT': '86400', 15:53:06 INFO - 'USER': 'cltbld', 15:53:06 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1461709408.870582-200037354', 15:53:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:06 INFO - '_': '/tools/buildbot/bin/python'} 15:53:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 15:53:06 INFO - mozversion application_buildid: 20160426142902 15:53:06 INFO - mozversion application_changeset: 937d57e8b4f0fa5f16231563ab0425eee9d40c82 15:53:06 INFO - mozversion application_display_name: Nightly 15:53:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:53:06 INFO - mozversion application_name: Firefox 15:53:06 INFO - mozversion application_remotingname: firefox 15:53:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:53:06 INFO - mozversion application_vendor: Mozilla 15:53:06 INFO - mozversion application_version: 49.0a1 15:53:06 INFO - mozversion platform_buildid: 20160426142902 15:53:06 INFO - mozversion platform_changeset: 937d57e8b4f0fa5f16231563ab0425eee9d40c82 15:53:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:53:06 INFO - mozversion platform_version: 49.0a1 15:53:06 INFO - using testdate: 1461711186 15:53:06 INFO - actual date: 1461711186 15:53:06 INFO - starting webserver on 'localhost:47947' 15:53:06 INFO - SUITE-START | Running 2 tests 15:53:06 INFO - TEST-START | dromaeo_css 15:53:06 INFO - operating with platform_type : linux_ 15:53:06 INFO - Initialising browser for dromaeo_css test... 15:53:06 INFO - TEST-INFO | started process 25517 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpft_UYX/profile http://localhost:47947/getInfo.html) 15:53:11 INFO - PROCESS | 25517 | 15:53:11 INFO - PROCESS | 25517 | (process:25585): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:53:11 INFO - PROCESS | 25517 | __metrics Screen width/height:1600/1200 15:53:11 INFO - PROCESS | 25517 | colorDepth:24 15:53:11 INFO - PROCESS | 25517 | Browser inner width/height: 1024/697 15:53:11 INFO - PROCESS | 25517 | __metrics 15:53:12 ERROR - PROCESS | 25517 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 15:53:13 INFO - TEST-INFO | 25517: exit 0 15:53:13 INFO - Browser initialized. 15:53:13 INFO - Running cycle 1/1 for dromaeo_css test... 15:53:13 INFO - TEST-INFO | started process 25636 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpft_UYX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:53:15 INFO - PROCESS | 25636 | 15:53:15 INFO - PROCESS | 25636 | (process:25696): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:53:25 INFO - PROCESS | 25636 | RSS: Main: 166256640 15:53:25 INFO - PROCESS | 25636 | 15:54:15 INFO - PROCESS | 25636 | 1461711255406 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] 15:56:27 INFO - PROCESS | 25636 | Cycle 1(1): loaded http://localhost:47947/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47947/tests/dromaeo/cssquery-ext.html) 15:56:28 INFO - PROCESS | 25636 | RSS: Main: 169517056 15:56:28 INFO - PROCESS | 25636 | 15:59:30 INFO - PROCESS | 25636 | Cycle 1(1): loaded http://localhost:47947/tests/dromaeo/cssquery-ext.html (next: http://localhost:47947/tests/dromaeo/cssquery-jquery.html) 15:59:30 INFO - PROCESS | 25636 | RSS: Main: 167268352 15:59:30 INFO - PROCESS | 25636 | 16:02:32 INFO - PROCESS | 25636 | Cycle 1(1): loaded http://localhost:47947/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47947/tests/dromaeo/cssquery-mootools.html) 16:02:33 INFO - PROCESS | 25636 | RSS: Main: 168292352 16:02:33 INFO - PROCESS | 25636 | 16:05:35 INFO - PROCESS | 25636 | Cycle 1(1): loaded http://localhost:47947/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47947/tests/dromaeo/cssquery-prototype.html) 16:05:35 INFO - PROCESS | 25636 | RSS: Main: 166182912 16:05:35 INFO - PROCESS | 25636 | 16:08:38 INFO - PROCESS | 25636 | Cycle 1(1): loaded http://localhost:47947/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47947/tests/dromaeo/cssquery-yui.html) 16:08:39 INFO - PROCESS | 25636 | RSS: Main: 167645184 16:08:39 INFO - PROCESS | 25636 | 16:11:41 INFO - PROCESS | 25636 | Cycle 1(1): loaded http://localhost:47947/tests/dromaeo/cssquery-yui.html (next: http://localhost:47947/tests/dromaeo/cssquery-dojo.html) 16:11:41 INFO - PROCESS | 25636 | RSS: Main: 169259008 16:11:41 INFO - PROCESS | 25636 | 16:11:41 INFO - PROCESS | 25636 | __start_tp_report 16:11:41 INFO - PROCESS | 25636 | _x_x_mozilla_page_load 16:11:41 INFO - PROCESS | 25636 | _x_x_mozilla_page_load_details 16:11:41 INFO - PROCESS | 25636 | |i|pagename|runs| 16:11:41 INFO - PROCESS | 25636 | |0;dojo.html;2631.776299014584;2729.9044533441333;2746.642936418267;2755.1459047695203;2755.6830964439096;4750.976245118778;4752.90494190116;4764.419819029778;4766.356541866847;4779.832705855296;4616.122936642036;4723.244280915054;4731.4795372509;4748.145333839916;4762.499937506555;4371.125774845028;4405.8237670493145;4462.263726485126;4473.753943533105;4500.482444518873;4406.383106365111;4519.07358991406;4547.477040140377;4559.772011399434;4593.655475839326;4202.432671589327;4300.591443812833;4367.759773212472;4422.292433210703;4515.932261016087;4278.272693642057;4341.5441378655105;4341.5441378655105;4349;4389.253826849444;4300.419443375135;4316.115196384733;4316.2446571849805;4329.9134017319475;4374.628156606692;4634.768261586941;4640.3503509508355;4698.060387922395;4735.928961065587;4750.928736068961;5045.924311135336;5057.2161314995865;5072.112380333427;5085.542301192911;5105.744712764347;5086.135356989321;5096.108181068335;5123.205903085028;5125.569978946969;5134.306868572732;4760.690555113906;4771.761411929389;4775.5224477552665;4788.138135135674;4851.708897466164;5220.791168353299;5226.555742761831;5249.42256351801;5251.186066159751;5255.027819853263;4916.778744956414;4990.8253211137435;5006.799728010911;5012.223105418666;5016.623753218523;4981.227909674007;5016.824411145592;5041.445441001487;5072.087024335655;5098.617603679739;4873.902521949542;4976.303317535548;4981.875453113628;4984.700917944935;4986;5011.223260394645;5040.823571174991;5055.721935293521;5104.157813960729;5156.767945442464;4144.5233798113;4252.893677658021;4278.850240241577;4297.527272000078;4331.436913201327;3719.0702324418894;3745.288395204957;3753.530808648919;3773.3019391412677;3783.1677031053123;4338.154059958278;4417.160739459492;4417.977910110493;4424.867253982386;4433.512313645497;5020.1214787412055;5105.8723531912;5110.182370820651;5121.359830021247;5151.922721159186;4373.868783936487;4393.75834329115;4408.382826404306;4435.2016637005;4442.644588432982;4472.217361961643;4554.70394424368;4556.293774464897;4561.657875659339;4601.378813860086;4798.592119669727;4829.541193586533;4841.080194762983;4850.199717046718;4876.4879687633;5135.255387968649;5140.588752899834;5142.04872098663;5145.202493613346;5176.637635365489;4609.700369475973;4768.809247630056;4837.975810120927;4839.733814640229;4858.17411040117;5048.72232027242;5064.645474816874;5067.949320506747;5068.670536415121;5100.515451032146;5160.071187186342;5160.303359046481;5160.612954028388;5179.98990196908;5199;4832.830850920201;4982.053409852117;5003.849884503471;5051.4443411224;5078.492150784892;4811.615070794258;4925.950740492549;5003.77483013258;5014.84955451337;5039.748012599282;4876.683015603974;4888.899997500534;4901.6323775716255;4908.460069392293;4957.529034741694;4840.104580652591;4931.802727890988;5001.199808030698;5019.146745053276;5045.4450010498085;4898.853034408973;4915.680480768739;4924.384451943507;4934.407871055496;4934.5805606523845 16:11:41 INFO - PROCESS | 25636 | |1;ext.html;577.0709158255211;615.3600255734036;619.1950464396284;623.420219196148;632.2918331468754;32031.67968320316;33099.50350744735;33258.8337058315;33351.833240833796;33353.33293334132;33370.49944250838;33902.49146262808;34041.48937765935;34106;34148.65851341492;7388.482806203568;7553.357964573018;7553.735619253327;7568.772936811904;7574.772756817304;7365.373943214833;7518.548887066766;7538.359239464652;7560.773176804677;7564.357029652459;7524.05949256343;7584.810379740496;7589.089309282866;7593.05086864142;7636.694532218705;7513.211112833128;7523.360514356286;7530.1340345859835;7542.849143017136;7558.546487210758;7517.962410187969;7618.695252189906;7628.694852205905;7630.694772209105;7649.158592554814;25974.610380844304;33355.33289334224;33802;33931.6606833931;33943.83028084844;2764.986175069132;2855.172000119963;2941.691122432135;3052.1148866828594;3449.3273811606746;25433.87283063573;25454.944200489357;25464.236072917844;25873.353166170808;26062.86968565145;3419.504171895061;3478.513008178857;3522.947155792665;3560.483729859182;3585.5338805955057;184034;186754;187100.16098551196;188004;188069;30045.849770751007;47361.05277894423;47462;47553.762231189314;47603.52396475991;32183;32374.35251295008;32513.34973300521;32561.34877302488;32771.67228327734;12498.187617804813;12741.55404560836;12752.553660621834;12791.808122878165;12800.103992720606;10512.684619461428;10602.204834637432;10610.522526486327;10633.521491532745;10635.680929572125;7968.840623187504;7981.960090199628;7984.960075199703;8090.433669643068;8126.674933002732;3176.6664500227143;3226.5160225965824;3241.33552621712;3241.38413701396;3245.172481017373;868.6916144768517;869.8216865542676;872.3926563659314;885.6014793342893;893.5800173918248;24600.384990375383;25799.355016124373;26343.604845927326;26553.86723066411;26727.331816704736;956.660385563115;968.1528662420383;970.0445061614304;970.8883478400074;1061.1298735037196;13402.731945361038;13472.595822125351;13541.341653666186;13554.118982266122;13791.448342066205;268706;271721;273472;274192;274890;43780.12439751187;43789.78105109454;44360;44375.33436998448;44705.55294447014;1203.169812829145;1253.3670496399443;1259.2885019963692;1266.7529831682918;1285.8649841766667;24065;24127.517449650557;25539.872300638377;26667;26750.732492674822;42221.577784221765;42792.78603606962;43061.78469107635;43139;43157.13685726331;240363;243079;244701;245306;246151;35986.820065899505;36065.81967090148;36714.26571468609;37045;37139.81430092832;38190.236195275385;38809.417858732704;39029.6097039026;39072.80463597777;39640.20719585534;33617.15957101092;34011.4898276531;34094.65905341014;34328.65671343354;34537.48193777045;33575.32849343048;33713.831430842685;33820.492692610125;33955.83022084874;34637.82681086579;30835;31652.050438486884;31819.20451988626;33589.328213436085;33832;25574.744252557237;27574;27599.44801104007;27757.306067348476;27798.72201278042;22549;22737.09051637982;22990.655140172577;23093;24043.879780601685 16:11:41 INFO - PROCESS | 25636 | |2;jquery.html;379.28315483735736;379.91831756172417;382.5887171290863;384.7652931711655;392.12360374562866;15006.774898376532;15201.84798152018;16264.674706505863;16301.918490407546;16323.183840807942;15170.696586068272;15613.921930390332;16098.114603696791;16279;16287.267072981715;4657.161710892038;4765.26138448541;4860.441049279325;4865.14859899518;4865.805367785284;3418.282160746246;5189;5456.91814622781;5488.5609151268;5489.670619762827;5472.425395333493;5474.206240095184;5477.75350109246;5480.479354461319;5494.2857428534235;4996.225585034325;5246.213068039787;5259.211118332261;5277.630565860372;5283.682979021271;4926.211806111005;5098.464661210556;5144.305518754995;5165.405978312505;5166.767495462713;11738.823917641243;11920.463579138874;12143.757124857453;12227.633171004883;12333;1828.7165489349172;1913.206019501905;2042.9795702043086;2183.235867446397;2237.0827960536267;8891.422057566302;9027.548622568846;9038.638454461814;9094.09059094092;9289.953550232205;1696.1180186303177;1767.5846176148596;1806.2323512507264;1818.963620727578;1842.9815701842945;57613.71193144049;59523.40476595222;60202.397976020555;61089;61532.99999999955;9818.116369526633;9938;10216.335938164144;10258.43578603184;10390.584376625002;13784.172949623055;13802.309884505936;13906.652333691738;13938.721225575431;13999.370028348545;7207.675654595556;7389;7398.260173982666;7534.510256833289;7550.697972081055;6876.724931002804;6972.651367431709;6987.720491180397;7102.112235970504;7110.253423390573;4366.366876802846;4385.649148068147;4402.779861007001;4439;4466.3523789050405;1703.335699077361;1711;1715.62256303613;1725.7411388291857;1757.499112752885;837.5351679817638;873.5151990645126;925.0887875442684;971.8979507151789;990.3265779270022;14778.482753103804;14810.259487025605;15072.321745521478;15089.54731358061;15351.692966140614;846.593635055177;868.0945325011539;902.8510295801251;906.0939060939061;918.1598837064145;9048.638054477748;9073.95463022694;9149.268058555299;9274.887013558282;9363.34456588046;362579;363787;370028;371161;373104;43973.56026439759;45512;64393.67803161048;66936.33063669398;71351.2864871355;890.1410139215687;929.9349045566745;952.9761755956157;955.2835373469898;967.2793768642406;13596.524121655695;14698.41206351734;14726.852731472549;15105.697886041999;15254.771178432555;32623.673763263014;32708.34583308273;33300.833495833336;33436;33577.83211083929;42520.78739606282;43753;43756.78121609372;43797.78101109474;43905;7385.409167266714;7444.776656700307;7612.08654961386;7639.656215470206;7744.0319960005;8242.29940455068;11210.607628732956;11435.656930292105;11448.656540303471;11460.713482163013;9541.952290238505;9794.951025244829;9876.506174691092;9950.751231219278;10506.844247132962;9956.751081223027;9994.600215991279;10038.749031274276;10108.595656173964;10367.896321036693;9922.503874806374;10174.949125254327;10253.641122560675;10371;10628.574857005633;7667.194944530744;7691.192424795539;7706.190849960898;7815.648295826588;7929.008873890763;9329.673461429089;10404.635837745642;10433.9478302608;10527.473626318806;10545.789084218119 16:11:41 INFO - PROCESS | 25636 | |3;mootools.html;1435.2823588205897;1458.467659304354;1577.7554479055743;1702.7786387769588;1733.575274057856;6422.486201103912;7095.254998225189;7220.819479513008;7582.620868956544;7599.582022988733;7015.228324884259;7097.964510177455;7202.423806095513;7204.531705439143;7210.206877243499;2116.883571403572;2154.429076294783;2162.502624396382;2164.2641501889357;2169.739631244253;2085.051301657742;2086.5618220173783;2145.560160167162;2161.643328850738;2169;2114.4713821544615;2115.428834214761;2129.3079749081535;2138.5295235048266;2207.834412419075;2162.4593851537115;2168.1760930846176;2170.967435488469;2174.891255437222;2178.085204214226;2055.1779288284656;2096.4863608415885;2108.335874199622;2121.777213392587;2172.7718589548185;7281.089863767029;7333.376662983653;7351.522151060164;7352.5220860643885;7376.409887209064;4568.611668008223;4715.504871988426;4732.881677958044;4764.380630518045;4766.142094423002;2856.957145642817;2949.27742703037;2978.4192082543914;3002.609660744089;3010.9548356774667;865.2947847504264;892.2727976698969;913.6208473483497;932.3147486597345;942.8868535775682;10122.190224782073;10181.18550515957;10242.897571024343;10263.384196948207;10290.53692583828;4321.416608757841;4327.329263964028;4331.350297455344;4337.175936572105;4366.366876802846;8862.512561809162;8881.600327985256;8920.063393343735;8927.910720892707;8932.330075244383;4528.252838281713;4611.723296602215;4619.168549661026;4764.833230836974;4776.116418462596;3589.066842620937;4096.959030409717;4235.97882010588;4276.914461710749;4385.276429389179;3520.964790352115;3531.29374125176;3613.9638603613625;3627.383344831332;3640.3993341098953;1172.5661505242945;1183.1599564309436;1192;1197.4132674989194;1200.0699457920007;724.8803947348733;851.8168593752373;866.9783255418665;886.9157430044136;905.0044950554337;4898.044881248123;5091.159958606789;5142.434332223453;5163.01902638505;5221.034108689904;865.6970060478782;931.9720408387759;942.3026960049514;959.0217977662884;971.0435221307007;3471.045462497783;3514.964850351515;3525.7531972761662;3589.8743543976357;3642.1076836174775;8921.955390223007;9169;9213.953930230306;9236;9259.490728009889;9189.218916392048;9199.034101419255;9236.076392360845;9291.72124836256;9298.070192980647;7025.262347453444;7202.315780000891;7237.782866514013;7301.2333704961275;7332.9266707332245;5064.848054558369;5147.073526765218;5223.190405487156;5240.816571419982;5293.047251494614;8739.781505462413;8768.693095741619;8810.986736525125;8877.556122193993;8914.643414263357;8332.375071869512;8649.437786543855;8714.25928796034;8769.166929141722;8797.164269394398;5905.291365036223;6459.450946669585;6495.285518593046;6607.636579988147;6771.762988295386;7324.194338622854;7339.889901651586;7430.7399241026305;7453.217412171643;7472.439567032386;6642.4686025118845;6818.624975626388;6878.140232470942;6915.965420173068;6947.722091116501;6487.0593763903025;6504.1869766279215;6640.568363056579;6660.733570657119;6856.211535673461;6449.129367535323;6478.5141114415665;6481.254655714464;6526.836829079121;6534.1178940844275;4521.321801729767;4551.203539380661;4584.9312260315455;4596.678232523691;4647.419072615923;4586.862394128181;4603.378543896665;4605.815767369401;4626.467956185082;4683.531646835289 16:11:42 INFO - PROCESS | 25636 | |4;prototype.html;287.5471132965578;298.1398664851902;301.42728815251024;303.68720218175287;303.7372672638167;4753.8811529711775;4804.90390192196;4867.975660121699;4946.629002824785;4965.503449655028;4892.3884514435695;4897.951020489794;4902.779374928128;4905.3132561441425;4906.558409743131;3872.825722842472;3876.186000939806;3882.9223415531674;3888.4361767543687;3902.590228026059;3644.7084233261276;3879.8254078566533;3895.2599006188734;3905.2189562087556;3919.941200881989;3735.6451137141926;3801.733878628497;3807.904802379935;3814.1227517670955;3838.2899163654674;3772.924541509168;3787.6591106800383;3812.6377994090517;3818.293615681108;3820.7707537547835;3336.249343897628;3342;3343.849526771301;3349.346877358916;3355.1612096975755;4602.585767280961;4689.343491911135;4714.764261786897;4738.312944623045;4742.525747425264;4287.335463003239;4313.525512193656;4319.97840010798;4325.935110973338;4327.978360108211;5102.770375333119;5118.923216151761;5119.744012799345;5131.640785145041;5161.509656582619;3462.5325581046486;3597.3165098631175;3620.131168519563;3631.2555926035097;3649.8905032849057;5304.230886521472;5311.415744268127;5373.838784836422;5378.489043540857;5384.246205531229;3664.230511592542;3667.5232219811255;3670.0090975436483;3685.447182922583;3692.464592634053;3715.7213209009433;3720.572134204547;3756.567994680592;3757.5490941086696;3761.153740408386;4217.810198541073;4260.233158031522;4276.1661476012505;4349.086691794695;4355.607995280377;5129.666286765393;5134.358205224347;5136.5890728741615;5139.201279552201;5156.1492353761205;1271.6693659648372;1303.1594621469098;1358.076507974567;1360.6462319796924;1363.3455941148304;889.0842432294746;903.5211337990876;908.0556221529667;911.5396724654007;915.4736026784492;4810.903781924342;4817.843717507772;4819.084373968934;4822.879428014257;4861.173600487926;5588.469095435927;5635.436456354331;5649.943500564942;5652.660840349592;5665.773369065274;4743.335932969387;4816.8554943351755;4820.25286080658;4838.419389673261;4846.321514987904;3010.8408262818534;3016.4570377332293;3016.879324826982;3034.969650303513;3038.6657467678538;5261.210818377274;5276.551493123127;5290.973545132327;5298;5324.334458192726;5642.971785141048;5786.3056433228285;5794.275715535558;5826.883462330815;5832.591718579659;5282.683039017671;5301.973490132602;5308.814191503356;5321.201819727072;5337.199420087018;5550.500454958911;5629.577781666473;5638.661680299195;5650.406707295675;5660.688662123458;5479.6164268500825;5561.499465048165;5566.777328906798;5584.636998595079;5597.496225339739;5249.868753281198;5270.235815806764;5271.367435907716;5301.390340110783;5313.1764576490705;3532.947005794864;3871.6902647788675;3898.5321761388814;3902.1025164211824;3903.219356128729;5036.546710796046;5338.519533242027;5342.706151161723;5367.329083864517;5371.62398632092;5026.924596130988;5097.974510127426;5178.404483484297;5208.8437346879655;5209.4009188943755;5134.409542902614;5157.020166168416;5169.327987361619;5196.68819870809;5210.645232239569;4941.085899108676;5099.113328068638;5108.284840122312;5129.615278854027;5145.948540514697;5210.426853046086;5216.061109000417;5221.060209162235;5227.738613069255;5238.611767881591;5083.38999320084;5091.719955402488;5101.362329708786;5125.384953805567;5129.256257842518 16:11:42 INFO - PROCESS | 25636 | |5;yui.html;658.7463826426824;665.5640555436189;702.4275215699201;720.6720941971405;723.9285856931741;12046.698832529191;12228.144029917898;12276.32480213588;12299.954503867182;13582;13545.119567228123;13555;13557.59327220185;13595.388207530661;13803.37884795184;628.990565141521;805.0580820440099;807.2774866494484;809.2756982500658;809.955452450115;774.0981756253985;800.2757504458474;803.2529747334976;805.114374188394;806.3629732511309;835.7952301686065;836.0761358698642;840.2647683277132;843.5318398288947;843.8354520868434;827.8923739913803;829.2081062585277;831.0401486283353;832.4797001873828;832.9791755206138;607.3713706313988;612.301975747648;616.0512810272176;617.9938200617981;618.3692633513836;12647.304398258093;12653.746925061447;12654.367281635881;12665.873341266653;12734.363281835964;12032.217905836093;12269.447874845653;12342.444589993473;12375.257484550955;12568.874311256863;9787.217022638171;9873.506324683736;9953.502324883726;9976.201903847676;10016.348937319124;3247.1443147599825;3282.638909719929;3287.671232876717;3341.465365541502;3366.663333666638;43695.56304436947;44135;44433;44539.554604453864;44876;9345.532723363805;9519.571619277149;9673.564689588986;9904.356216845881;9906.405615663083;16655.750163747554;16738.4141555045;16754.664906701797;16765.32938682439;16830.91584542094;6660.167479065117;6796.4562834973085;6889.448844092461;6963.338482844122;7000.754973576002;3701.796401197906;3709.2025214578994;3735.9626403736156;3739.139997800521;3854.9421758673643;2701.1086341507257;2812.3531587734938;2813.521701310782;2991.805532640415;3149.3858697554215;555.8999380111619;561.2283110722756;572.5762935427754;573.0773454737869;591.6923199936009;610.8289678889918;634.1945728924333;639.8944174211204;659.2813832922138;661.163628010567;7926.643301051467;8045.557494337868;8275.379346549033;8374.874376884352;8408.075111737704;518.1860515808175;602.0187095035064;607.3895734786511;629.116091890894;656.917885264342;3867.7099217558234;3887;3912.726109172331;3952.1700442906736;3981.960180398217;56060.439395606336;58149.4185058144;59129;59502.404975949685;59784;51551;51628;52073.7396313016;52401;52760;46797.53202468;47061.29408058814;47809.282860757114;48318;48375.5162448371;7527.9247207529415;7658.540487570764;7668.386529077772;7888;7941;30929.69070309358;31229;31397;31558;31911.361772764878;40726;42463;42825.357619635106;43140.78429607832;43168.35247471228;9850.458224797705;10247.795044099226;10274.12669923035;10439.791204175723;10752.516136773707;10936.289141205796;11255.493502792231;11350.94324528372;11701.2979221247;12047.75904481923;10671.306365086244;10895.56417743313;11031.117510598971;11702.239354441934;11977.64067077989;10609.840852387066;11023.393713345842;11304.943475282571;11380.772384552429;11640.417979101181;11159.442027898735;11193.888061119611;11331.603393881174;11567.652970410902;11616.186866919235;9857.260705447263;9899.1585715215;10015.499225038864;10204.13264872494;10350.120239779702;9289.256859451363;9424.623015079595;9520.904790952001;9863.802723945624;9921.851172232567 16:11:42 INFO - PROCESS | 25636 | __end_tp_report 16:11:42 INFO - PROCESS | 25636 | __start_cc_report 16:11:42 INFO - PROCESS | 25636 | _x_x_mozilla_cycle_collect,384 16:11:42 INFO - PROCESS | 25636 | __end_cc_report 16:11:42 INFO - PROCESS | 25636 | __startTimestamp1461712301992__endTimestamp 16:11:42 INFO - PROCESS | 25636 | 16:11:42 INFO - PROCESS | 25636 | ------- Summary: start ------- 16:11:42 INFO - PROCESS | 25636 | Number of tests: 6 16:11:42 INFO - PROCESS | 25636 | 16:11:42 INFO - PROCESS | 25636 | [#0] dojo.html Cycles:165 Average:4709.54 Median:4840.10 stddev:488.35 (10.1%) stddev-sans-first:461.85 16:11:42 INFO - PROCESS | 25636 | Values: 2631.8 2729.9 2746.6 2755.1 2755.7 4751.0 4752.9 4764.4 4766.4 4779.8 4616.1 4723.2 4731.5 4748.1 4762.5 4371.1 4405.8 4462.3 4473.8 4500.5 4406.4 4519.1 4547.5 4559.8 4593.7 4202.4 4300.6 4367.8 4422.3 4515.9 4278.3 4341.5 4341.5 4349.0 4389.3 4300.4 4316.1 4316.2 4329.9 4374.6 4634.8 4640.4 4698.1 4735.9 4750.9 5045.9 5057.2 5072.1 5085.5 5105.7 5086.1 5096.1 5123.2 5125.6 5134.3 4760.7 4771.8 4775.5 4788.1 4851.7 5220.8 5226.6 5249.4 5251.2 5255.0 4916.8 4990.8 5006.8 5012.2 5016.6 4981.2 5016.8 5041.4 5072.1 5098.6 4873.9 4976.3 4981.9 4984.7 4986.0 5011.2 5040.8 5055.7 5104.2 5156.8 4144.5 4252.9 4278.9 4297.5 4331.4 3719.1 3745.3 3753.5 3773.3 3783.2 4338.2 4417.2 4418.0 4424.9 4433.5 5020.1 5105.9 5110.2 5121.4 5151.9 4373.9 4393.8 4408.4 4435.2 4442.6 4472.2 4554.7 4556.3 4561.7 4601.4 4798.6 4829.5 4841.1 4850.2 4876.5 5135.3 5140.6 5142.0 5145.2 5176.6 4609.7 4768.8 4838.0 4839.7 4858.2 5048.7 5064.6 5067.9 5068.7 5100.5 5160.1 5160.3 5160.6 5180.0 5199.0 4832.8 4982.1 5003.8 5051.4 5078.5 4811.6 4926.0 5003.8 5014.8 5039.7 4876.7 4888.9 4901.6 4908.5 4957.5 4840.1 4931.8 5001.2 5019.1 5045.4 4898.9 4915.7 4924.4 4934.4 4934.6 16:11:42 INFO - PROCESS | 25636 | 16:11:42 INFO - PROCESS | 25636 | [#1] ext.html Cycles:180 Average:37931.44 Median:33757.92 stddev:61941.37 (183.5%) stddev-sans-first:62051.63 16:11:42 INFO - PROCESS | 25636 | Values: 577.1 615.4 619.2 623.4 632.3 32031.7 33099.5 33258.8 33351.8 33353.3 33370.5 33902.5 34041.5 34106.0 34148.7 7388.5 7553.4 7553.7 7568.8 7574.8 7365.4 7518.5 7538.4 7560.8 7564.4 7524.1 7584.8 7589.1 7593.1 7636.7 7513.2 7523.4 7530.1 7542.8 7558.5 7518.0 7618.7 7628.7 7630.7 7649.2 25974.6 33355.3 33802.0 33931.7 33943.8 2765.0 2855.2 2941.7 3052.1 3449.3 25433.9 25454.9 25464.2 25873.4 26062.9 3419.5 3478.5 3522.9 3560.5 3585.5 184034.0 186754.0 187100.2 188004.0 188069.0 30045.8 47361.1 47462.0 47553.8 47603.5 32183.0 32374.4 32513.3 32561.3 32771.7 12498.2 12741.6 12752.6 12791.8 12800.1 10512.7 10602.2 10610.5 10633.5 10635.7 7968.8 7982.0 7985.0 8090.4 8126.7 3176.7 3226.5 3241.3 3241.4 3245.2 868.7 869.8 872.4 885.6 893.6 24600.4 25799.4 26343.6 26553.9 26727.3 956.7 968.2 970.0 970.9 1061.1 13402.7 13472.6 13541.3 13554.1 13791.4 268706.0 271721.0 273472.0 274192.0 274890.0 43780.1 43789.8 44360.0 44375.3 44705.6 1203.2 1253.4 1259.3 1266.8 1285.9 24065.0 24127.5 25539.9 26667.0 26750.7 42221.6 42792.8 43061.8 43139.0 43157.1 240363.0 243079.0 244701.0 245306.0 246151.0 35986.8 36065.8 36714.3 37045.0 37139.8 38190.2 38809.4 39029.6 39072.8 39640.2 33617.2 34011.5 34094.7 34328.7 34537.5 33575.3 33713.8 33820.5 33955.8 34637.8 30835.0 31652.1 31819.2 33589.3 33832.0 25574.7 27574.0 27599.4 27757.3 27798.7 22549.0 22737.1 22990.7 23093.0 24043.9 16:11:42 INFO - PROCESS | 25636 | 16:11:42 INFO - PROCESS | 25636 | [#2] jquery.html Cycles:180 Average:22186.91 Median:24989.18 stddev:60358.44 (241.5%) stddev-sans-first:60505.55 16:11:42 INFO - PROCESS | 25636 | Values: 379.3 379.9 382.6 384.8 392.1 15006.8 15201.8 16264.7 16301.9 16323.2 15170.7 15613.9 16098.1 16279.0 16287.3 4657.2 4765.3 4860.4 4865.1 4865.8 3418.3 5189.0 5456.9 5488.6 5489.7 5472.4 5474.2 5477.8 5480.5 5494.3 4996.2 5246.2 5259.2 5277.6 5283.7 4926.2 5098.5 5144.3 5165.4 5166.8 11738.8 11920.5 12143.8 12227.6 12333.0 1828.7 1913.2 2043.0 2183.2 2237.1 8891.4 9027.5 9038.6 9094.1 9290.0 1696.1 1767.6 1806.2 1819.0 1843.0 57613.7 59523.4 60202.4 61089.0 61533.0 9818.1 9938.0 10216.3 10258.4 10390.6 13784.2 13802.3 13906.7 13938.7 13999.4 7207.7 7389.0 7398.3 7534.5 7550.7 6876.7 6972.7 6987.7 7102.1 7110.3 4366.4 4385.6 4402.8 4439.0 4466.4 1703.3 1711.0 1715.6 1725.7 1757.5 837.5 873.5 925.1 971.9 990.3 14778.5 14810.3 15072.3 15089.5 15351.7 846.6 868.1 902.9 906.1 918.2 9048.6 9074.0 9149.3 9274.9 9363.3 362579.0 363787.0 370028.0 371161.0 373104.0 43973.6 45512.0 64393.7 66936.3 71351.3 890.1 929.9 953.0 955.3 967.3 13596.5 14698.4 14726.9 15105.7 15254.8 32623.7 32708.3 33300.8 33436.0 33577.8 42520.8 43753.0 43756.8 43797.8 43905.0 7385.4 7444.8 7612.1 7639.7 7744.0 8242.3 11210.6 11435.7 11448.7 11460.7 9542.0 9795.0 9876.5 9950.8 10506.8 9956.8 9994.6 10038.7 10108.6 10367.9 9922.5 10174.9 10253.6 10371.0 10628.6 7667.2 7691.2 7706.2 7815.6 7929.0 9329.7 10404.6 10433.9 10527.5 10545.8 16:11:42 INFO - PROCESS | 25636 | 16:11:42 INFO - PROCESS | 25636 | [#3] mootools.html Cycles:180 Average:5035.89 Median:5192.03 stddev:2745.25 (52.9%) stddev-sans-first:2739.61 16:11:42 INFO - PROCESS | 25636 | Values: 1435.3 1458.5 1577.8 1702.8 1733.6 6422.5 7095.3 7220.8 7582.6 7599.6 7015.2 7098.0 7202.4 7204.5 7210.2 2116.9 2154.4 2162.5 2164.3 2169.7 2085.1 2086.6 2145.6 2161.6 2169.0 2114.5 2115.4 2129.3 2138.5 2207.8 2162.5 2168.2 2171.0 2174.9 2178.1 2055.2 2096.5 2108.3 2121.8 2172.8 7281.1 7333.4 7351.5 7352.5 7376.4 4568.6 4715.5 4732.9 4764.4 4766.1 2857.0 2949.3 2978.4 3002.6 3011.0 865.3 892.3 913.6 932.3 942.9 10122.2 10181.2 10242.9 10263.4 10290.5 4321.4 4327.3 4331.4 4337.2 4366.4 8862.5 8881.6 8920.1 8927.9 8932.3 4528.3 4611.7 4619.2 4764.8 4776.1 3589.1 4097.0 4236.0 4276.9 4385.3 3521.0 3531.3 3614.0 3627.4 3640.4 1172.6 1183.2 1192.0 1197.4 1200.1 724.9 851.8 867.0 886.9 905.0 4898.0 5091.2 5142.4 5163.0 5221.0 865.7 932.0 942.3 959.0 971.0 3471.0 3515.0 3525.8 3589.9 3642.1 8922.0 9169.0 9214.0 9236.0 9259.5 9189.2 9199.0 9236.1 9291.7 9298.1 7025.3 7202.3 7237.8 7301.2 7332.9 5064.8 5147.1 5223.2 5240.8 5293.0 8739.8 8768.7 8811.0 8877.6 8914.6 8332.4 8649.4 8714.3 8769.2 8797.2 5905.3 6459.5 6495.3 6607.6 6771.8 7324.2 7339.9 7430.7 7453.2 7472.4 6642.5 6818.6 6878.1 6916.0 6947.7 6487.1 6504.2 6640.6 6660.7 6856.2 6449.1 6478.5 6481.3 6526.8 6534.1 4521.3 4551.2 4584.9 4596.7 4647.4 4586.9 4603.4 4605.8 4626.5 4683.5 16:11:42 INFO - PROCESS | 25636 | 16:11:42 INFO - PROCESS | 25636 | [#4] prototype.html Cycles:180 Average:4358.48 Median:4904.05 stddev:1293.36 (26.4%) stddev-sans-first:1260.38 16:11:42 INFO - PROCESS | 25636 | Values: 287.5 298.1 301.4 303.7 303.7 4753.9 4804.9 4868.0 4946.6 4965.5 4892.4 4898.0 4902.8 4905.3 4906.6 3872.8 3876.2 3882.9 3888.4 3902.6 3644.7 3879.8 3895.3 3905.2 3919.9 3735.6 3801.7 3807.9 3814.1 3838.3 3772.9 3787.7 3812.6 3818.3 3820.8 3336.2 3342.0 3343.8 3349.3 3355.2 4602.6 4689.3 4714.8 4738.3 4742.5 4287.3 4313.5 4320.0 4325.9 4328.0 5102.8 5118.9 5119.7 5131.6 5161.5 3462.5 3597.3 3620.1 3631.3 3649.9 5304.2 5311.4 5373.8 5378.5 5384.2 3664.2 3667.5 3670.0 3685.4 3692.5 3715.7 3720.6 3756.6 3757.5 3761.2 4217.8 4260.2 4276.2 4349.1 4355.6 5129.7 5134.4 5136.6 5139.2 5156.1 1271.7 1303.2 1358.1 1360.6 1363.3 889.1 903.5 908.1 911.5 915.5 4810.9 4817.8 4819.1 4822.9 4861.2 5588.5 5635.4 5649.9 5652.7 5665.8 4743.3 4816.9 4820.3 4838.4 4846.3 3010.8 3016.5 3016.9 3035.0 3038.7 5261.2 5276.6 5291.0 5298.0 5324.3 5643.0 5786.3 5794.3 5826.9 5832.6 5282.7 5302.0 5308.8 5321.2 5337.2 5550.5 5629.6 5638.7 5650.4 5660.7 5479.6 5561.5 5566.8 5584.6 5597.5 5249.9 5270.2 5271.4 5301.4 5313.2 3532.9 3871.7 3898.5 3902.1 3903.2 5036.5 5338.5 5342.7 5367.3 5371.6 5026.9 5098.0 5178.4 5208.8 5209.4 5134.4 5157.0 5169.3 5196.7 5210.6 4941.1 5099.1 5108.3 5129.6 5145.9 5210.4 5216.1 5221.1 5227.7 5238.6 5083.4 5091.7 5101.4 5125.4 5129.3 16:11:42 INFO - PROCESS | 25636 | 16:11:42 INFO - PROCESS | 25636 | [#5] yui.html Cycles:180 Average:13394.74 Median:48063.64 stddev:15747.10 (32.8%) stddev-sans-first:15762.23 16:11:42 INFO - PROCESS | 25636 | Values: 658.7 665.6 702.4 720.7 723.9 12046.7 12228.1 12276.3 12300.0 13582.0 13545.1 13555.0 13557.6 13595.4 13803.4 629.0 805.1 807.3 809.3 810.0 774.1 800.3 803.3 805.1 806.4 835.8 836.1 840.3 843.5 843.8 827.9 829.2 831.0 832.5 833.0 607.4 612.3 616.1 618.0 618.4 12647.3 12653.7 12654.4 12665.9 12734.4 12032.2 12269.4 12342.4 12375.3 12568.9 9787.2 9873.5 9953.5 9976.2 10016.3 3247.1 3282.6 3287.7 3341.5 3366.7 43695.6 44135.0 44433.0 44539.6 44876.0 9345.5 9519.6 9673.6 9904.4 9906.4 16655.8 16738.4 16754.7 16765.3 16830.9 6660.2 6796.5 6889.4 6963.3 7000.8 3701.8 3709.2 3736.0 3739.1 3854.9 2701.1 2812.4 2813.5 2991.8 3149.4 555.9 561.2 572.6 573.1 591.7 610.8 634.2 639.9 659.3 661.2 7926.6 8045.6 8275.4 8374.9 8408.1 518.2 602.0 607.4 629.1 656.9 3867.7 3887.0 3912.7 3952.2 3982.0 56060.4 58149.4 59129.0 59502.4 59784.0 51551.0 51628.0 52073.7 52401.0 52760.0 46797.5 47061.3 47809.3 48318.0 48375.5 7527.9 7658.5 7668.4 7888.0 7941.0 30929.7 31229.0 31397.0 31558.0 31911.4 40726.0 42463.0 42825.4 43140.8 43168.4 9850.5 10247.8 10274.1 10439.8 10752.5 10936.3 11255.5 11350.9 11701.3 12047.8 10671.3 10895.6 11031.1 11702.2 11977.6 10609.8 11023.4 11304.9 11380.8 11640.4 11159.4 11193.9 11331.6 11567.7 11616.2 9857.3 9899.2 10015.5 10204.1 10350.1 9289.3 9424.6 9520.9 9863.8 9921.9 16:11:42 INFO - PROCESS | 25636 | -------- Summary: end -------- 16:11:42 INFO - PROCESS | 25636 | 16:11:42 INFO - TEST-INFO | 25636: exit 0 16:11:42 INFO - TEST-OK | dromaeo_css | took 1115864ms 16:11:42 INFO - TEST-START | kraken 16:11:42 INFO - operating with platform_type : linux_ 16:11:42 INFO - Initialising browser for kraken test... 16:11:42 INFO - TEST-INFO | started process 25870 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWttfM1/profile http://localhost:47947/getInfo.html) 16:11:46 INFO - PROCESS | 25870 | 16:11:46 INFO - PROCESS | 25870 | (process:25941): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:11:47 INFO - PROCESS | 25870 | __metrics Screen width/height:1600/1200 16:11:47 INFO - PROCESS | 25870 | colorDepth:24 16:11:47 INFO - PROCESS | 25870 | Browser inner width/height: 1024/697 16:11:47 INFO - PROCESS | 25870 | __metrics 16:11:48 ERROR - PROCESS | 25870 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 16:11:49 INFO - TEST-INFO | 25870: exit 0 16:11:49 INFO - Browser initialized. 16:11:49 INFO - Running cycle 1/1 for kraken test... 16:11:49 INFO - TEST-INFO | started process 25992 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWttfM1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:11:51 INFO - PROCESS | 25992 | 16:11:51 INFO - PROCESS | 25992 | (process:26052): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:12:01 INFO - PROCESS | 25992 | RSS: Main: 165945344 16:12:01 INFO - PROCESS | 25992 | 16:12:04 INFO - PROCESS | 25992 | Cycle 1(1): loaded http://localhost:47947/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47947/tests/kraken/driver.html?testName=audio-beat-detection) 16:12:05 INFO - PROCESS | 25992 | RSS: Main: 169758720 16:12:05 INFO - PROCESS | 25992 | 16:12:07 INFO - PROCESS | 25992 | Cycle 1(1): loaded http://localhost:47947/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47947/tests/kraken/driver.html?testName=audio-dft) 16:12:08 INFO - PROCESS | 25992 | RSS: Main: 173555712 16:12:08 INFO - PROCESS | 25992 | 16:12:11 INFO - PROCESS | 25992 | Cycle 1(1): loaded http://localhost:47947/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47947/tests/kraken/driver.html?testName=audio-fft) 16:12:12 INFO - PROCESS | 25992 | RSS: Main: 165658624 16:12:12 INFO - PROCESS | 25992 | 16:12:14 INFO - PROCESS | 25992 | Cycle 1(1): loaded http://localhost:47947/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47947/tests/kraken/driver.html?testName=audio-oscillator) 16:12:14 INFO - PROCESS | 25992 | RSS: Main: 166273024 16:12:14 INFO - PROCESS | 25992 | 16:12:17 INFO - PROCESS | 25992 | Cycle 1(1): loaded http://localhost:47947/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47947/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:12:17 INFO - PROCESS | 25992 | RSS: Main: 166477824 16:12:17 INFO - PROCESS | 25992 | 16:12:20 INFO - PROCESS | 25992 | Cycle 1(1): loaded http://localhost:47947/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47947/tests/kraken/driver.html?testName=imaging-darkroom) 16:12:21 INFO - PROCESS | 25992 | RSS: Main: 166502400 16:12:21 INFO - PROCESS | 25992 | 16:12:25 INFO - PROCESS | 25992 | Cycle 1(1): loaded http://localhost:47947/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47947/tests/kraken/driver.html?testName=imaging-desaturate) 16:12:25 INFO - PROCESS | 25992 | RSS: Main: 166019072 16:12:25 INFO - PROCESS | 25992 | 16:12:28 INFO - PROCESS | 25992 | Cycle 1(1): loaded http://localhost:47947/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47947/tests/kraken/driver.html?testName=json-parse-financial) 16:12:29 INFO - PROCESS | 25992 | RSS: Main: 166662144 16:12:29 INFO - PROCESS | 25992 | 16:12:31 INFO - PROCESS | 25992 | Cycle 1(1): loaded http://localhost:47947/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47947/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:12:31 INFO - PROCESS | 25992 | RSS: Main: 167116800 16:12:31 INFO - PROCESS | 25992 | 16:12:33 INFO - PROCESS | 25992 | Cycle 1(1): loaded http://localhost:47947/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47947/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:12:34 INFO - PROCESS | 25992 | RSS: Main: 166854656 16:12:34 INFO - PROCESS | 25992 | 16:12:36 INFO - PROCESS | 25992 | Cycle 1(1): loaded http://localhost:47947/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47947/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:12:37 INFO - PROCESS | 25992 | RSS: Main: 167206912 16:12:37 INFO - PROCESS | 25992 | 16:12:39 INFO - PROCESS | 25992 | Cycle 1(1): loaded http://localhost:47947/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47947/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:12:40 INFO - PROCESS | 25992 | RSS: Main: 167800832 16:12:40 INFO - PROCESS | 25992 | 16:12:43 INFO - PROCESS | 25992 | Cycle 1(1): loaded http://localhost:47947/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47947/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:12:44 INFO - PROCESS | 25992 | RSS: Main: 165339136 16:12:44 INFO - PROCESS | 25992 | 16:12:46 INFO - PROCESS | 25992 | Cycle 1(1): loaded http://localhost:47947/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47947/tests/kraken/driver.html?testName=ai-astar) 16:12:46 INFO - PROCESS | 25992 | RSS: Main: 166727680 16:12:46 INFO - PROCESS | 25992 | 16:12:46 INFO - PROCESS | 25992 | __start_tp_report 16:12:46 INFO - PROCESS | 25992 | _x_x_mozilla_page_load 16:12:46 INFO - PROCESS | 25992 | _x_x_mozilla_page_load_details 16:12:46 INFO - PROCESS | 25992 | |i|pagename|runs| 16:12:46 INFO - PROCESS | 25992 | |0;ai-astar;113;110;115;113;115;126;116;114;115;114 16:12:46 INFO - PROCESS | 25992 | |1;audio-beat-detection;162;133;157;190;138;160;157;133;200;135 16:12:46 INFO - PROCESS | 25992 | |2;audio-dft;163;163;164;169;164;163;163;163;166;163 16:12:46 INFO - PROCESS | 25992 | |3;audio-fft;78;75;75;183;76;75;75;78;151;75 16:12:46 INFO - PROCESS | 25992 | |4;audio-oscillator;94;94;150;95;95;95;145;94;95;152 16:12:46 INFO - PROCESS | 25992 | |5;imaging-gaussian-blur;118;117;117;118;118;118;118;118;119;118 16:12:46 INFO - PROCESS | 25992 | |6;imaging-darkroom;147;154;148;148;150;147;148;147;147;147 16:12:46 INFO - PROCESS | 25992 | |7;imaging-desaturate;96;96;95;95;96;96;96;95;95;96 16:12:46 INFO - PROCESS | 25992 | |8;json-parse-financial;65;72;66;66;66;65;67;82;66;65 16:12:46 INFO - PROCESS | 25992 | |9;json-stringify-tinderbox;65;66;65;66;66;65;65;64;71;66 16:12:46 INFO - PROCESS | 25992 | |10;stanford-crypto-aes;80;81;79;78;88;80;79;80;82;80 16:12:46 INFO - PROCESS | 25992 | |11;stanford-crypto-ccm;163;134;149;140;133;143;133;142;169;137 16:12:46 INFO - PROCESS | 25992 | |12;stanford-crypto-pbkdf2;222;220;219;230;225;217;229;217;222;224 16:12:46 INFO - PROCESS | 25992 | |13;stanford-crypto-sha256-iterative;76;75;78;77;81;73;79;77;78;77 16:12:46 INFO - PROCESS | 25992 | __end_tp_report 16:12:46 INFO - PROCESS | 25992 | __start_cc_report 16:12:46 INFO - PROCESS | 25992 | _x_x_mozilla_cycle_collect,942 16:12:46 INFO - PROCESS | 25992 | __end_cc_report 16:12:46 INFO - PROCESS | 25992 | __startTimestamp1461712366698__endTimestamp 16:12:46 INFO - PROCESS | 25992 | 16:12:46 INFO - PROCESS | 25992 | ------- Summary: start ------- 16:12:46 INFO - PROCESS | 25992 | Number of tests: 14 16:12:46 INFO - PROCESS | 25992 | 16:12:46 INFO - PROCESS | 25992 | [#0] ai-astar Cycles:10 Average:115.10 Median:115.00 stddev:4.18 (3.6%) stddev-sans-first:4.36 16:12:46 INFO - PROCESS | 25992 | Values: 113.0 110.0 115.0 113.0 115.0 126.0 116.0 114.0 115.0 114.0 16:12:46 INFO - PROCESS | 25992 | 16:12:46 INFO - PROCESS | 25992 | [#1] audio-beat-detection Cycles:10 Average:156.50 Median:158.50 stddev:23.49 (14.8%) stddev-sans-first:24.83 16:12:46 INFO - PROCESS | 25992 | Values: 162.0 133.0 157.0 190.0 138.0 160.0 157.0 133.0 200.0 135.0 16:12:46 INFO - PROCESS | 25992 | 16:12:46 INFO - PROCESS | 25992 | [#2] audio-dft Cycles:10 Average:164.10 Median:163.50 stddev:1.97 (1.2%) stddev-sans-first:2.05 16:12:46 INFO - PROCESS | 25992 | Values: 163.0 163.0 164.0 169.0 164.0 163.0 163.0 163.0 166.0 163.0 16:12:46 INFO - PROCESS | 25992 | 16:12:46 INFO - PROCESS | 25992 | [#3] audio-fft Cycles:10 Average:94.10 Median:75.00 stddev:39.17 (52.2%) stddev-sans-first:41.11 16:12:46 INFO - PROCESS | 25992 | Values: 78.0 75.0 75.0 183.0 76.0 75.0 75.0 78.0 151.0 75.0 16:12:46 INFO - PROCESS | 25992 | 16:12:46 INFO - PROCESS | 25992 | [#4] audio-oscillator Cycles:10 Average:110.90 Median:94.50 stddev:26.35 (27.9%) stddev-sans-first:27.23 16:12:46 INFO - PROCESS | 25992 | Values: 94.0 94.0 150.0 95.0 95.0 95.0 145.0 94.0 95.0 152.0 16:12:46 INFO - PROCESS | 25992 | 16:12:46 INFO - PROCESS | 25992 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 16:12:46 INFO - PROCESS | 25992 | Values: 118.0 117.0 117.0 118.0 118.0 118.0 118.0 118.0 119.0 118.0 16:12:46 INFO - PROCESS | 25992 | 16:12:46 INFO - PROCESS | 25992 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.00 stddev:2.21 (1.5%) stddev-sans-first:2.30 16:12:46 INFO - PROCESS | 25992 | Values: 147.0 154.0 148.0 148.0 150.0 147.0 148.0 147.0 147.0 147.0 16:12:46 INFO - PROCESS | 25992 | 16:12:46 INFO - PROCESS | 25992 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 16:12:46 INFO - PROCESS | 25992 | Values: 96.0 96.0 95.0 95.0 96.0 96.0 96.0 95.0 95.0 96.0 16:12:46 INFO - PROCESS | 25992 | 16:12:46 INFO - PROCESS | 25992 | [#8] json-parse-financial Cycles:10 Average:68.00 Median:66.00 stddev:5.33 (8.1%) stddev-sans-first:5.55 16:12:46 INFO - PROCESS | 25992 | Values: 65.0 72.0 66.0 66.0 66.0 65.0 67.0 82.0 66.0 65.0 16:12:46 INFO - PROCESS | 25992 | 16:12:46 INFO - PROCESS | 25992 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:1.91 (2.9%) stddev-sans-first:2.00 16:12:46 INFO - PROCESS | 25992 | Values: 65.0 66.0 65.0 66.0 66.0 65.0 65.0 64.0 71.0 66.0 16:12:46 INFO - PROCESS | 25992 | 16:12:46 INFO - PROCESS | 25992 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:80.00 stddev:2.79 (3.5%) stddev-sans-first:2.95 16:12:46 INFO - PROCESS | 25992 | Values: 80.0 81.0 79.0 78.0 88.0 80.0 79.0 80.0 82.0 80.0 16:12:46 INFO - PROCESS | 25992 | 16:12:46 INFO - PROCESS | 25992 | [#11] stanford-crypto-ccm Cycles:10 Average:144.30 Median:142.50 stddev:12.57 (8.8%) stddev-sans-first:11.37 16:12:46 INFO - PROCESS | 25992 | Values: 163.0 134.0 149.0 140.0 133.0 143.0 133.0 142.0 169.0 137.0 16:12:46 INFO - PROCESS | 25992 | 16:12:46 INFO - PROCESS | 25992 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:222.50 Median:223.00 stddev:4.55 (2.0%) stddev-sans-first:4.82 16:12:46 INFO - PROCESS | 25992 | Values: 222.0 220.0 219.0 230.0 225.0 217.0 229.0 217.0 222.0 224.0 16:12:46 INFO - PROCESS | 25992 | 16:12:46 INFO - PROCESS | 25992 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.10 Median:77.50 stddev:2.18 (2.8%) stddev-sans-first:2.28 16:12:46 INFO - PROCESS | 25992 | Values: 76.0 75.0 78.0 77.0 81.0 73.0 79.0 77.0 78.0 77.0 16:12:46 INFO - PROCESS | 25992 | -------- Summary: end -------- 16:12:46 INFO - PROCESS | 25992 | 16:12:47 INFO - TEST-INFO | 25992: exit 0 16:12:47 INFO - TEST-OK | kraken | took 65120ms 16:12:47 INFO - SUITE-END | took 1180s 16:12:47 INFO - Completed test suite (00:19:41) 16:12:47 INFO - javascript benchmark 16:12:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2631.776299014584, 2729.9044533441333, 2746.642936418267, 2755.1459047695203, 2755.6830964439096, 4750.976245118778, 4752.90494190116, 4764.419819029778, 4766.356541866847, 4779.832705855296, 4616.122936642036, 4723.244280915054, 4731.4795372509, 4748.145333839916, 4762.499937506555, 4371.125774845028, 4405.8237670493145, 4462.263726485126, 4473.753943533105, 4500.482444518873, 4406.383106365111, 4519.07358991406, 4547.477040140377, 4559.772011399434, 4593.655475839326, 4202.432671589327, 4300.591443812833, 4367.759773212472, 4422.292433210703, 4515.932261016087, 4278.272693642057, 4341.5441378655105, 4341.5441378655105, 4349.0, 4389.253826849444, 4300.419443375135, 4316.115196384733, 4316.2446571849805, 4329.9134017319475, 4374.628156606692, 4634.768261586941, 4640.3503509508355, 4698.060387922395, 4735.928961065587, 4750.928736068961, 5045.924311135336, 5057.2161314995865, 5072.112380333427, 5085.542301192911, 5105.744712764347, 5086.135356989321, 5096.108181068335, 5123.205903085028, 5125.569978946969, 5134.306868572732, 4760.690555113906, 4771.761411929389, 4775.5224477552665, 4788.138135135674, 4851.708897466164, 5220.791168353299, 5226.555742761831, 5249.42256351801, 5251.186066159751, 5255.027819853263, 4916.778744956414, 4990.8253211137435, 5006.799728010911, 5012.223105418666, 5016.623753218523, 4981.227909674007, 5016.824411145592, 5041.445441001487, 5072.087024335655, 5098.617603679739, 4873.902521949542, 4976.303317535548, 4981.875453113628, 4984.700917944935, 4986.0, 5011.223260394645, 5040.823571174991, 5055.721935293521, 5104.157813960729, 5156.767945442464, 4144.5233798113, 4252.893677658021, 4278.850240241577, 4297.527272000078, 4331.436913201327, 3719.0702324418894, 3745.288395204957, 3753.530808648919, 3773.3019391412677, 3783.1677031053123, 4338.154059958278, 4417.160739459492, 4417.977910110493, 4424.867253982386, 4433.512313645497, 5020.1214787412055, 5105.8723531912, 5110.182370820651, 5121.359830021247, 5151.922721159186, 4373.868783936487, 4393.75834329115, 4408.382826404306, 4435.2016637005, 4442.644588432982, 4472.217361961643, 4554.70394424368, 4556.293774464897, 4561.657875659339, 4601.378813860086, 4798.592119669727, 4829.541193586533, 4841.080194762983, 4850.199717046718, 4876.4879687633, 5135.255387968649, 5140.588752899834, 5142.04872098663, 5145.202493613346, 5176.637635365489, 4609.700369475973, 4768.809247630056, 4837.975810120927, 4839.733814640229, 4858.17411040117, 5048.72232027242, 5064.645474816874, 5067.949320506747, 5068.670536415121, 5100.515451032146, 5160.071187186342, 5160.303359046481, 5160.612954028388, 5179.98990196908, 5199.0, 4832.830850920201, 4982.053409852117, 5003.849884503471, 5051.4443411224, 5078.492150784892, 4811.615070794258, 4925.950740492549, 5003.77483013258, 5014.84955451337, 5039.748012599282, 4876.683015603974, 4888.899997500534, 4901.6323775716255, 4908.460069392293, 4957.529034741694, 4840.104580652591, 4931.802727890988, 5001.199808030698, 5019.146745053276, 5045.4450010498085, 4898.853034408973, 4915.680480768739, 4924.384451943507, 4934.407871055496, 4934.5805606523845], "value": 4679.136398390916, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.0709158255211, 615.3600255734036, 619.1950464396284, 623.420219196148, 632.2918331468754, 32031.67968320316, 33099.50350744735, 33258.8337058315, 33351.833240833796, 33353.33293334132, 33370.49944250838, 33902.49146262808, 34041.48937765935, 34106.0, 34148.65851341492, 7388.482806203568, 7553.357964573018, 7553.735619253327, 7568.772936811904, 7574.772756817304, 7365.373943214833, 7518.548887066766, 7538.359239464652, 7560.773176804677, 7564.357029652459, 7524.05949256343, 7584.810379740496, 7589.089309282866, 7593.05086864142, 7636.694532218705, 7513.211112833128, 7523.360514356286, 7530.1340345859835, 7542.849143017136, 7558.546487210758, 7517.962410187969, 7618.695252189906, 7628.694852205905, 7630.694772209105, 7649.158592554814, 25974.610380844304, 33355.33289334224, 33802.0, 33931.6606833931, 33943.83028084844, 2764.986175069132, 2855.172000119963, 2941.691122432135, 3052.1148866828594, 3449.3273811606746, 25433.87283063573, 25454.944200489357, 25464.236072917844, 25873.353166170808, 26062.86968565145, 3419.504171895061, 3478.513008178857, 3522.947155792665, 3560.483729859182, 3585.5338805955057, 184034.0, 186754.0, 187100.16098551196, 188004.0, 188069.0, 30045.849770751007, 47361.05277894423, 47462.0, 47553.762231189314, 47603.52396475991, 32183.0, 32374.35251295008, 32513.34973300521, 32561.34877302488, 32771.67228327734, 12498.187617804813, 12741.55404560836, 12752.553660621834, 12791.808122878165, 12800.103992720606, 10512.684619461428, 10602.204834637432, 10610.522526486327, 10633.521491532745, 10635.680929572125, 7968.840623187504, 7981.960090199628, 7984.960075199703, 8090.433669643068, 8126.674933002732, 3176.6664500227143, 3226.5160225965824, 3241.33552621712, 3241.38413701396, 3245.172481017373, 868.6916144768517, 869.8216865542676, 872.3926563659314, 885.6014793342893, 893.5800173918248, 24600.384990375383, 25799.355016124373, 26343.604845927326, 26553.86723066411, 26727.331816704736, 956.660385563115, 968.1528662420383, 970.0445061614304, 970.8883478400074, 1061.1298735037196, 13402.731945361038, 13472.595822125351, 13541.341653666186, 13554.118982266122, 13791.448342066205, 268706.0, 271721.0, 273472.0, 274192.0, 274890.0, 43780.12439751187, 43789.78105109454, 44360.0, 44375.33436998448, 44705.55294447014, 1203.169812829145, 1253.3670496399443, 1259.2885019963692, 1266.7529831682918, 1285.8649841766667, 24065.0, 24127.517449650557, 25539.872300638377, 26667.0, 26750.732492674822, 42221.577784221765, 42792.78603606962, 43061.78469107635, 43139.0, 43157.13685726331, 240363.0, 243079.0, 244701.0, 245306.0, 246151.0, 35986.820065899505, 36065.81967090148, 36714.26571468609, 37045.0, 37139.81430092832, 38190.236195275385, 38809.417858732704, 39029.6097039026, 39072.80463597777, 39640.20719585534, 33617.15957101092, 34011.4898276531, 34094.65905341014, 34328.65671343354, 34537.48193777045, 33575.32849343048, 33713.831430842685, 33820.492692610125, 33955.83022084874, 34637.82681086579, 30835.0, 31652.050438486884, 31819.20451988626, 33589.328213436085, 33832.0, 25574.744252557237, 27574.0, 27599.44801104007, 27757.306067348476, 27798.72201278042, 22549.0, 22737.09051637982, 22990.655140172577, 23093.0, 24043.879780601685], "value": 15404.446554175092, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.28315483735736, 379.91831756172417, 382.5887171290863, 384.7652931711655, 392.12360374562866, 15006.774898376532, 15201.84798152018, 16264.674706505863, 16301.918490407546, 16323.183840807942, 15170.696586068272, 15613.921930390332, 16098.114603696791, 16279.0, 16287.267072981715, 4657.161710892038, 4765.26138448541, 4860.441049279325, 4865.14859899518, 4865.805367785284, 3418.282160746246, 5189.0, 5456.91814622781, 5488.5609151268, 5489.670619762827, 5472.425395333493, 5474.206240095184, 5477.75350109246, 5480.479354461319, 5494.2857428534235, 4996.225585034325, 5246.213068039787, 5259.211118332261, 5277.630565860372, 5283.682979021271, 4926.211806111005, 5098.464661210556, 5144.305518754995, 5165.405978312505, 5166.767495462713, 11738.823917641243, 11920.463579138874, 12143.757124857453, 12227.633171004883, 12333.0, 1828.7165489349172, 1913.206019501905, 2042.9795702043086, 2183.235867446397, 2237.0827960536267, 8891.422057566302, 9027.548622568846, 9038.638454461814, 9094.09059094092, 9289.953550232205, 1696.1180186303177, 1767.5846176148596, 1806.2323512507264, 1818.963620727578, 1842.9815701842945, 57613.71193144049, 59523.40476595222, 60202.397976020555, 61089.0, 61532.99999999955, 9818.116369526633, 9938.0, 10216.335938164144, 10258.43578603184, 10390.584376625002, 13784.172949623055, 13802.309884505936, 13906.652333691738, 13938.721225575431, 13999.370028348545, 7207.675654595556, 7389.0, 7398.260173982666, 7534.510256833289, 7550.697972081055, 6876.724931002804, 6972.651367431709, 6987.720491180397, 7102.112235970504, 7110.253423390573, 4366.366876802846, 4385.649148068147, 4402.779861007001, 4439.0, 4466.3523789050405, 1703.335699077361, 1711.0, 1715.62256303613, 1725.7411388291857, 1757.499112752885, 837.5351679817638, 873.5151990645126, 925.0887875442684, 971.8979507151789, 990.3265779270022, 14778.482753103804, 14810.259487025605, 15072.321745521478, 15089.54731358061, 15351.692966140614, 846.593635055177, 868.0945325011539, 902.8510295801251, 906.0939060939061, 918.1598837064145, 9048.638054477748, 9073.95463022694, 9149.268058555299, 9274.887013558282, 9363.34456588046, 362579.0, 363787.0, 370028.0, 371161.0, 373104.0, 43973.56026439759, 45512.0, 64393.67803161048, 66936.33063669398, 71351.2864871355, 890.1410139215687, 929.9349045566745, 952.9761755956157, 955.2835373469898, 967.2793768642406, 13596.524121655695, 14698.41206351734, 14726.852731472549, 15105.697886041999, 15254.771178432555, 32623.673763263014, 32708.34583308273, 33300.833495833336, 33436.0, 33577.83211083929, 42520.78739606282, 43753.0, 43756.78121609372, 43797.78101109474, 43905.0, 7385.409167266714, 7444.776656700307, 7612.08654961386, 7639.656215470206, 7744.0319960005, 8242.29940455068, 11210.607628732956, 11435.656930292105, 11448.656540303471, 11460.713482163013, 9541.952290238505, 9794.951025244829, 9876.506174691092, 9950.751231219278, 10506.844247132962, 9956.751081223027, 9994.600215991279, 10038.749031274276, 10108.595656173964, 10367.896321036693, 9922.503874806374, 10174.949125254327, 10253.641122560675, 10371.0, 10628.574857005633, 7667.194944530744, 7691.192424795539, 7706.190849960898, 7815.648295826588, 7929.008873890763, 9329.673461429089, 10404.635837745642, 10433.9478302608, 10527.473626318806, 10545.789084218119], "value": 7823.510042080357, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1435.2823588205897, 1458.467659304354, 1577.7554479055743, 1702.7786387769588, 1733.575274057856, 6422.486201103912, 7095.254998225189, 7220.819479513008, 7582.620868956544, 7599.582022988733, 7015.228324884259, 7097.964510177455, 7202.423806095513, 7204.531705439143, 7210.206877243499, 2116.883571403572, 2154.429076294783, 2162.502624396382, 2164.2641501889357, 2169.739631244253, 2085.051301657742, 2086.5618220173783, 2145.560160167162, 2161.643328850738, 2169.0, 2114.4713821544615, 2115.428834214761, 2129.3079749081535, 2138.5295235048266, 2207.834412419075, 2162.4593851537115, 2168.1760930846176, 2170.967435488469, 2174.891255437222, 2178.085204214226, 2055.1779288284656, 2096.4863608415885, 2108.335874199622, 2121.777213392587, 2172.7718589548185, 7281.089863767029, 7333.376662983653, 7351.522151060164, 7352.5220860643885, 7376.409887209064, 4568.611668008223, 4715.504871988426, 4732.881677958044, 4764.380630518045, 4766.142094423002, 2856.957145642817, 2949.27742703037, 2978.4192082543914, 3002.609660744089, 3010.9548356774667, 865.2947847504264, 892.2727976698969, 913.6208473483497, 932.3147486597345, 942.8868535775682, 10122.190224782073, 10181.18550515957, 10242.897571024343, 10263.384196948207, 10290.53692583828, 4321.416608757841, 4327.329263964028, 4331.350297455344, 4337.175936572105, 4366.366876802846, 8862.512561809162, 8881.600327985256, 8920.063393343735, 8927.910720892707, 8932.330075244383, 4528.252838281713, 4611.723296602215, 4619.168549661026, 4764.833230836974, 4776.116418462596, 3589.066842620937, 4096.959030409717, 4235.97882010588, 4276.914461710749, 4385.276429389179, 3520.964790352115, 3531.29374125176, 3613.9638603613625, 3627.383344831332, 3640.3993341098953, 1172.5661505242945, 1183.1599564309436, 1192.0, 1197.4132674989194, 1200.0699457920007, 724.8803947348733, 851.8168593752373, 866.9783255418665, 886.9157430044136, 905.0044950554337, 4898.044881248123, 5091.159958606789, 5142.434332223453, 5163.01902638505, 5221.034108689904, 865.6970060478782, 931.9720408387759, 942.3026960049514, 959.0217977662884, 971.0435221307007, 3471.045462497783, 3514.964850351515, 3525.7531972761662, 3589.8743543976357, 3642.1076836174775, 8921.955390223007, 9169.0, 9213.953930230306, 9236.0, 9259.490728009889, 9189.218916392048, 9199.034101419255, 9236.076392360845, 9291.72124836256, 9298.070192980647, 7025.262347453444, 7202.315780000891, 7237.782866514013, 7301.2333704961275, 7332.9266707332245, 5064.848054558369, 5147.073526765218, 5223.190405487156, 5240.816571419982, 5293.047251494614, 8739.781505462413, 8768.693095741619, 8810.986736525125, 8877.556122193993, 8914.643414263357, 8332.375071869512, 8649.437786543855, 8714.25928796034, 8769.166929141722, 8797.164269394398, 5905.291365036223, 6459.450946669585, 6495.285518593046, 6607.636579988147, 6771.762988295386, 7324.194338622854, 7339.889901651586, 7430.7399241026305, 7453.217412171643, 7472.439567032386, 6642.4686025118845, 6818.624975626388, 6878.140232470942, 6915.965420173068, 6947.722091116501, 6487.0593763903025, 6504.1869766279215, 6640.568363056579, 6660.733570657119, 6856.211535673461, 6449.129367535323, 6478.5141114415665, 6481.254655714464, 6526.836829079121, 6534.1178940844275, 4521.321801729767, 4551.203539380661, 4584.9312260315455, 4596.678232523691, 4647.419072615923, 4586.862394128181, 4603.378543896665, 4605.815767369401, 4626.467956185082, 4683.531646835289], "value": 4098.881166588907, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.5471132965578, 298.1398664851902, 301.42728815251024, 303.68720218175287, 303.7372672638167, 4753.8811529711775, 4804.90390192196, 4867.975660121699, 4946.629002824785, 4965.503449655028, 4892.3884514435695, 4897.951020489794, 4902.779374928128, 4905.3132561441425, 4906.558409743131, 3872.825722842472, 3876.186000939806, 3882.9223415531674, 3888.4361767543687, 3902.590228026059, 3644.7084233261276, 3879.8254078566533, 3895.2599006188734, 3905.2189562087556, 3919.941200881989, 3735.6451137141926, 3801.733878628497, 3807.904802379935, 3814.1227517670955, 3838.2899163654674, 3772.924541509168, 3787.6591106800383, 3812.6377994090517, 3818.293615681108, 3820.7707537547835, 3336.249343897628, 3342.0, 3343.849526771301, 3349.346877358916, 3355.1612096975755, 4602.585767280961, 4689.343491911135, 4714.764261786897, 4738.312944623045, 4742.525747425264, 4287.335463003239, 4313.525512193656, 4319.97840010798, 4325.935110973338, 4327.978360108211, 5102.770375333119, 5118.923216151761, 5119.744012799345, 5131.640785145041, 5161.509656582619, 3462.5325581046486, 3597.3165098631175, 3620.131168519563, 3631.2555926035097, 3649.8905032849057, 5304.230886521472, 5311.415744268127, 5373.838784836422, 5378.489043540857, 5384.246205531229, 3664.230511592542, 3667.5232219811255, 3670.0090975436483, 3685.447182922583, 3692.464592634053, 3715.7213209009433, 3720.572134204547, 3756.567994680592, 3757.5490941086696, 3761.153740408386, 4217.810198541073, 4260.233158031522, 4276.1661476012505, 4349.086691794695, 4355.607995280377, 5129.666286765393, 5134.358205224347, 5136.5890728741615, 5139.201279552201, 5156.1492353761205, 1271.6693659648372, 1303.1594621469098, 1358.076507974567, 1360.6462319796924, 1363.3455941148304, 889.0842432294746, 903.5211337990876, 908.0556221529667, 911.5396724654007, 915.4736026784492, 4810.903781924342, 4817.843717507772, 4819.084373968934, 4822.879428014257, 4861.173600487926, 5588.469095435927, 5635.436456354331, 5649.943500564942, 5652.660840349592, 5665.773369065274, 4743.335932969387, 4816.8554943351755, 4820.25286080658, 4838.419389673261, 4846.321514987904, 3010.8408262818534, 3016.4570377332293, 3016.879324826982, 3034.969650303513, 3038.6657467678538, 5261.210818377274, 5276.551493123127, 5290.973545132327, 5298.0, 5324.334458192726, 5642.971785141048, 5786.3056433228285, 5794.275715535558, 5826.883462330815, 5832.591718579659, 5282.683039017671, 5301.973490132602, 5308.814191503356, 5321.201819727072, 5337.199420087018, 5550.500454958911, 5629.577781666473, 5638.661680299195, 5650.406707295675, 5660.688662123458, 5479.6164268500825, 5561.499465048165, 5566.777328906798, 5584.636998595079, 5597.496225339739, 5249.868753281198, 5270.235815806764, 5271.367435907716, 5301.390340110783, 5313.1764576490705, 3532.947005794864, 3871.6902647788675, 3898.5321761388814, 3902.1025164211824, 3903.219356128729, 5036.546710796046, 5338.519533242027, 5342.706151161723, 5367.329083864517, 5371.62398632092, 5026.924596130988, 5097.974510127426, 5178.404483484297, 5208.8437346879655, 5209.4009188943755, 5134.409542902614, 5157.020166168416, 5169.327987361619, 5196.68819870809, 5210.645232239569, 4941.085899108676, 5099.113328068638, 5108.284840122312, 5129.615278854027, 5145.948540514697, 5210.426853046086, 5216.061109000417, 5221.060209162235, 5227.738613069255, 5238.611767881591, 5083.38999320084, 5091.719955402488, 5101.362329708786, 5125.384953805567, 5129.256257842518], "value": 3947.1698629970433, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [658.7463826426824, 665.5640555436189, 702.4275215699201, 720.6720941971405, 723.9285856931741, 12046.698832529191, 12228.144029917898, 12276.32480213588, 12299.954503867182, 13582.0, 13545.119567228123, 13555.0, 13557.59327220185, 13595.388207530661, 13803.37884795184, 628.990565141521, 805.0580820440099, 807.2774866494484, 809.2756982500658, 809.955452450115, 774.0981756253985, 800.2757504458474, 803.2529747334976, 805.114374188394, 806.3629732511309, 835.7952301686065, 836.0761358698642, 840.2647683277132, 843.5318398288947, 843.8354520868434, 827.8923739913803, 829.2081062585277, 831.0401486283353, 832.4797001873828, 832.9791755206138, 607.3713706313988, 612.301975747648, 616.0512810272176, 617.9938200617981, 618.3692633513836, 12647.304398258093, 12653.746925061447, 12654.367281635881, 12665.873341266653, 12734.363281835964, 12032.217905836093, 12269.447874845653, 12342.444589993473, 12375.257484550955, 12568.874311256863, 9787.217022638171, 9873.506324683736, 9953.502324883726, 9976.201903847676, 10016.348937319124, 3247.1443147599825, 3282.638909719929, 3287.671232876717, 3341.465365541502, 3366.663333666638, 43695.56304436947, 44135.0, 44433.0, 44539.554604453864, 44876.0, 9345.532723363805, 9519.571619277149, 9673.564689588986, 9904.356216845881, 9906.405615663083, 16655.750163747554, 16738.4141555045, 16754.664906701797, 16765.32938682439, 16830.91584542094, 6660.167479065117, 6796.4562834973085, 6889.448844092461, 6963.338482844122, 7000.754973576002, 3701.796401197906, 3709.2025214578994, 3735.9626403736156, 3739.139997800521, 3854.9421758673643, 2701.1086341507257, 2812.3531587734938, 2813.521701310782, 2991.805532640415, 3149.3858697554215, 555.8999380111619, 561.2283110722756, 572.5762935427754, 573.0773454737869, 591.6923199936009, 610.8289678889918, 634.1945728924333, 639.8944174211204, 659.2813832922138, 661.163628010567, 7926.643301051467, 8045.557494337868, 8275.379346549033, 8374.874376884352, 8408.075111737704, 518.1860515808175, 602.0187095035064, 607.3895734786511, 629.116091890894, 656.917885264342, 3867.7099217558234, 3887.0, 3912.726109172331, 3952.1700442906736, 3981.960180398217, 56060.439395606336, 58149.4185058144, 59129.0, 59502.404975949685, 59784.0, 51551.0, 51628.0, 52073.7396313016, 52401.0, 52760.0, 46797.53202468, 47061.29408058814, 47809.282860757114, 48318.0, 48375.5162448371, 7527.9247207529415, 7658.540487570764, 7668.386529077772, 7888.0, 7941.0, 30929.69070309358, 31229.0, 31397.0, 31558.0, 31911.361772764878, 40726.0, 42463.0, 42825.357619635106, 43140.78429607832, 43168.35247471228, 9850.458224797705, 10247.795044099226, 10274.12669923035, 10439.791204175723, 10752.516136773707, 10936.289141205796, 11255.493502792231, 11350.94324528372, 11701.2979221247, 12047.75904481923, 10671.306365086244, 10895.56417743313, 11031.117510598971, 11702.239354441934, 11977.64067077989, 10609.840852387066, 11023.393713345842, 11304.943475282571, 11380.772384552429, 11640.417979101181, 11159.442027898735, 11193.888061119611, 11331.603393881174, 11567.652970410902, 11616.186866919235, 9857.260705447263, 9899.1585715215, 10015.499225038864, 10204.13264872494, 10350.120239779702, 9289.256859451363, 9424.623015079595, 9520.904790952001, 9863.802723945624, 9921.851172232567], "value": 6062.633493374421, "unit": "score"}], "name": "dromaeo_css", "value": 6172.739955851369, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 110.0, 115.0, 113.0, 115.0, 126.0, 116.0, 114.0, 115.0, 114.0], "value": 115.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 133.0, 157.0, 190.0, 138.0, 160.0, 157.0, 133.0, 200.0, 135.0], "value": 156.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 169.0, 164.0, 163.0, 163.0, 163.0, 166.0, 163.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 75.0, 183.0, 76.0, 75.0, 75.0, 78.0, 151.0, 75.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 150.0, 95.0, 95.0, 95.0, 145.0, 94.0, 95.0, 152.0], "value": 110.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 119.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 154.0, 148.0, 148.0, 150.0, 147.0, 148.0, 147.0, 147.0, 147.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 66.0, 66.0, 66.0, 65.0, 67.0, 82.0, 66.0, 65.0], "value": 68.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 66.0, 65.0, 65.0, 64.0, 71.0, 66.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 79.0, 78.0, 88.0, 80.0, 79.0, 80.0, 82.0, 80.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 134.0, 149.0, 140.0, 133.0, 143.0, 133.0, 142.0, 169.0, 137.0], "value": 144.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [222.0, 220.0, 219.0, 230.0, 225.0, 217.0, 229.0, 217.0, 222.0, 224.0], "value": 222.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 78.0, 77.0, 81.0, 73.0, 79.0, 77.0, 78.0, 77.0], "value": 77.1, "unit": "score"}], "name": "kraken", "value": 1661.0, "alertThreshold": 2.0}]} 16:12:47 INFO - Return code: 0 16:12:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:12:48 ERROR - # TBPL SUCCESS # 16:12:48 INFO - Running post-action listener: _resource_record_post_action 16:12:48 INFO - Running post-run listener: _resource_record_post_run 16:12:49 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 529018880; Read time: 12; Write time: 499488 16:12:49 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234577920; Read time: 0; Write time: 251448 16:12:49 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294440960; Read time: 12; Write time: 248040 16:12:49 INFO - Running post-run listener: _upload_blobber_files 16:12:49 INFO - Blob upload gear active. 16:12:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:12:49 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 16:12:49 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:12:49 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:12:49 INFO - (blobuploader) - INFO - Open directory for files ... 16:12:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:12:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:12:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:12:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:12:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:12:50 INFO - (blobuploader) - INFO - Done attempting. 16:12:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:12:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:12:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:12:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:12:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:12:51 INFO - (blobuploader) - INFO - Done attempting. 16:12:51 INFO - (blobuploader) - INFO - Iteration through files over. 16:12:51 INFO - Return code: 0 16:12:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:12:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:12:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f5bc00f1a9748cec9749e5af2cb5f32eafa6501d1c533f965f3df4bf123ce8144f2b5f4413c1a6986d31bf12a4fa07195ff6d7085adf69a64c2afb4deea01df9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fb7625c9fc287dbe6d29404521a727667805d86a31616522b975fd194a021cab09095bdd00fbd39e450d487ea1ad499d1ff1b02ef0bed9291cb46523f621b669"} 16:12:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:12:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:12:51 INFO - Contents: 16:12:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f5bc00f1a9748cec9749e5af2cb5f32eafa6501d1c533f965f3df4bf123ce8144f2b5f4413c1a6986d31bf12a4fa07195ff6d7085adf69a64c2afb4deea01df9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fb7625c9fc287dbe6d29404521a727667805d86a31616522b975fd194a021cab09095bdd00fbd39e450d487ea1ad499d1ff1b02ef0bed9291cb46523f621b669"} 16:12:51 INFO - Running post-run listener: copy_logs_to_upload_dir 16:12:51 INFO - Copying logs to upload dir... 16:12:51 INFO - mkdir: /builds/slave/test/build/upload/logs 16:12:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.643385 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-04-26 16:12:50.695857) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 16:12:50.699205) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1461709408.870582-200037354 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-Non-PGO/sha512/f5bc00f1a9748cec9749e5af2cb5f32eafa6501d1c533f965f3df4bf123ce8144f2b5f4413c1a6986d31bf12a4fa07195ff6d7085adf69a64c2afb4deea01df9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fb7625c9fc287dbe6d29404521a727667805d86a31616522b975fd194a021cab09095bdd00fbd39e450d487ea1ad499d1ff1b02ef0bed9291cb46523f621b669"} build_url:https://queue.taskcluster.net/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011227 build_url: 'https://queue.taskcluster.net/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f5bc00f1a9748cec9749e5af2cb5f32eafa6501d1c533f965f3df4bf123ce8144f2b5f4413c1a6986d31bf12a4fa07195ff6d7085adf69a64c2afb4deea01df9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fb7625c9fc287dbe6d29404521a727667805d86a31616522b975fd194a021cab09095bdd00fbd39e450d487ea1ad499d1ff1b02ef0bed9291cb46523f621b669"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 16:12:50.725291) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 16:12:50.725926) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1461709408.870582-200037354 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 16:12:50.812152) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 16:12:50.812490) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 16:12:50.812818) ========= ========= Total master_lag: 0.19 =========