builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-048 starttime: 1461672360.31 results: success (0) buildid: 20160426023013 builduid: 51be04eee5d9459fbe353738424cfa95 revision: 99fbe8621fa73724446ea9f828a0d30642faa6f9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 05:06:00.315276) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 05:06:00.316032) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 05:06:00.316539) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 05:06:00.335542) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 05:06:00.336131) ========= 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=fa44defc139c4ba8574fe040000001db-1461665383.224155-1094879320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-26 05:06:00-- 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% 220M=0s 2016-04-26 05:06:01 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.089327 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 05:06:00.440181) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 05:06:00.440960) ========= 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=fa44defc139c4ba8574fe040000001db-1461665383.224155-1094879320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016223 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 05:06:00.491767) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 05:06:00.492165) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 99fbe8621fa73724446ea9f828a0d30642faa6f9 --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 99fbe8621fa73724446ea9f828a0d30642faa6f9 --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=fa44defc139c4ba8574fe040000001db-1461665383.224155-1094879320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-26 05:06:01,169 truncating revision to first 12 chars 2016-04-26 05:06:01,169 Setting DEBUG logging. 2016-04-26 05:06:01,169 attempt 1/10 2016-04-26 05:06:01,169 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/99fbe8621fa7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-26 05:06:01,570 unpacking tar archive at: fx-team-99fbe8621fa7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.677707 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 05:06:01.183421) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 05:06:01.183737) ========= script_repo_revision: 99fbe8621fa73724446ea9f828a0d30642faa6f9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 05:06:01.184138) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 05:06:01.184398) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 05:06:01.193723) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-04-26 05:06:01.194042) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1461665383.224155-1094879320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:06:01 INFO - MultiFileLogger online at 20160426 05:06:01 in /builds/slave/test 05:06:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:06:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:06:01 INFO - {'append_to_log': False, 05:06:01 INFO - 'base_work_dir': '/builds/slave/test', 05:06:01 INFO - 'blob_upload_branch': 'Fx-Team', 05:06:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:06:01 INFO - 'branch': 'Fx-Team', 05:06:01 INFO - 'buildbot_json_path': 'buildprops.json', 05:06:01 INFO - 'config_files': ('talos/linux_config.py',), 05:06:01 INFO - 'default_actions': ('clobber', 05:06:01 INFO - 'read-buildbot-config', 05:06:01 INFO - 'download-and-extract', 05:06:01 INFO - 'populate-webroot', 05:06:01 INFO - 'create-virtualenv', 05:06:01 INFO - 'install', 05:06:01 INFO - 'run-tests'), 05:06:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:06:01 INFO - 'download_minidump_stackwalk': True, 05:06:01 INFO - 'download_symbols': 'ondemand', 05:06:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:06:01 INFO - 'tooltool.py': '/tools/tooltool.py', 05:06:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:06:01 INFO - '/tools/misc-python/virtualenv.py')}, 05:06:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:06:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:06:01 INFO - 'installer_path': 'installer.exe', 05:06:01 INFO - 'log_level': 'info', 05:06:01 INFO - 'log_name': 'talos', 05:06:01 INFO - 'log_to_console': True, 05:06:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:06:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:06:01 INFO - 'opt_config_files': (), 05:06:01 INFO - 'pip_index': False, 05:06:01 INFO - 'sps_profile': False, 05:06:01 INFO - 'sps_profile_interval': 0, 05:06:01 INFO - 'suite': 'dromaeojs-e10s', 05:06:01 INFO - 'system_bits': '32', 05:06:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:06:01 INFO - 'title': 'talos-linux64-ix-048', 05:06:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:06:01 INFO - 'use_talos_json': True, 05:06:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:06:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:06:01 INFO - 'work_dir': 'build'} 05:06:01 INFO - ##### 05:06:01 INFO - ##### Running clobber step. 05:06:01 INFO - ##### 05:06:01 INFO - Running pre-action listener: _resource_record_pre_action 05:06:01 INFO - Running main action method: clobber 05:06:01 INFO - rmtree: /builds/slave/test/build 05:06:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:06:02 INFO - Running post-action listener: _resource_record_post_action 05:06:02 INFO - ##### 05:06:02 INFO - ##### Running read-buildbot-config step. 05:06:02 INFO - ##### 05:06:02 INFO - Running pre-action listener: _resource_record_pre_action 05:06:02 INFO - Running main action method: read_buildbot_config 05:06:02 INFO - Using buildbot properties: 05:06:02 INFO - { 05:06:02 INFO - "project": "", 05:06:02 INFO - "product": "firefox", 05:06:02 INFO - "script_repo_revision": "production", 05:06:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:06:02 INFO - "repository": "", 05:06:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 05:06:02 INFO - "buildid": "20160426023013", 05:06:02 INFO - "pgo_build": "True", 05:06:02 INFO - "basedir": "/builds/slave/test", 05:06:02 INFO - "buildnumber": 693, 05:06:02 INFO - "slavename": "talos-linux64-ix-048", 05:06:02 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:06:02 INFO - "platform": "ubuntu64_hw", 05:06:02 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:06:02 INFO - "branch": "fx-team", 05:06:02 INFO - "repo_path": "integration/fx-team", 05:06:02 INFO - "revision": "99fbe8621fa73724446ea9f828a0d30642faa6f9", 05:06:02 INFO - "stage_platform": "linux64-pgo", 05:06:02 INFO - "builduid": "51be04eee5d9459fbe353738424cfa95", 05:06:02 INFO - "slavebuilddir": "test" 05:06:02 INFO - } 05:06:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/XAIGQlNqRcKKaL707shW6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:06:02 INFO - Running post-action listener: _resource_record_post_action 05:06:02 INFO - ##### 05:06:02 INFO - ##### Running download-and-extract step. 05:06:02 INFO - ##### 05:06:02 INFO - Running pre-action listener: _resource_record_pre_action 05:06:02 INFO - Running main action method: download_and_extract 05:06:02 INFO - mkdir: /builds/slave/test/build/tests 05:06:02 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')]} 05:06:02 INFO - https://queue.taskcluster.net/v1/task/XAIGQlNqRcKKaL707shW6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:06:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAIGQlNqRcKKaL707shW6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:06:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAIGQlNqRcKKaL707shW6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:06:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAIGQlNqRcKKaL707shW6A/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 05:06:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAIGQlNqRcKKaL707shW6A/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 05:06:03 INFO - Downloaded 1361 bytes. 05:06:03 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:06:03 INFO - Using the following test package requirements: 05:06:03 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:06:03 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:03 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:06:03 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:03 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:06:03 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:03 INFO - u'jsshell-linux-x86_64.zip'], 05:06:03 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:03 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:06:03 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:06:03 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:03 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:06:03 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:03 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:06:03 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:03 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:06:03 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:03 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:06:03 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:06:03 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')]} 05:06:03 INFO - https://queue.taskcluster.net/v1/task/XAIGQlNqRcKKaL707shW6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:06:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAIGQlNqRcKKaL707shW6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:06:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAIGQlNqRcKKaL707shW6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:06:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAIGQlNqRcKKaL707shW6A/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 05:06:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAIGQlNqRcKKaL707shW6A/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 05:06:05 INFO - Downloaded 23862905 bytes. 05:06:05 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'] 05:06:05 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 05:06:06 INFO - Return code: 0 05:06:06 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 05:06:06 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')]} 05:06:06 INFO - https://queue.taskcluster.net/v1/task/XAIGQlNqRcKKaL707shW6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:06:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAIGQlNqRcKKaL707shW6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:06:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAIGQlNqRcKKaL707shW6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:06:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAIGQlNqRcKKaL707shW6A/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 05:06:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAIGQlNqRcKKaL707shW6A/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 05:06:08 INFO - Downloaded 23862905 bytes. 05:06:08 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'] 05:06:08 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 05:06:10 INFO - Return code: 0 05:06: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')]} 05:06:10 INFO - https://queue.taskcluster.net/v1/task/XAIGQlNqRcKKaL707shW6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:06:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAIGQlNqRcKKaL707shW6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:06:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAIGQlNqRcKKaL707shW6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:06:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAIGQlNqRcKKaL707shW6A/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 05:06:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAIGQlNqRcKKaL707shW6A/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 05:06:12 INFO - Downloaded 10840145 bytes. 05:06:12 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'] 05:06:12 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 05:06:12 INFO - Return code: 0 05:06:12 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')]} 05:06:12 INFO - https://queue.taskcluster.net/v1/task/XAIGQlNqRcKKaL707shW6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:06:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAIGQlNqRcKKaL707shW6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:06:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAIGQlNqRcKKaL707shW6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:06:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAIGQlNqRcKKaL707shW6A/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 05:06:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAIGQlNqRcKKaL707shW6A/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 05:06:13 INFO - Downloaded 58311588 bytes. 05:06:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XAIGQlNqRcKKaL707shW6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:06:13 INFO - mkdir: /builds/slave/test/properties 05:06:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:06:13 INFO - Writing to file /builds/slave/test/properties/build_url 05:06:13 INFO - Contents: 05:06:13 INFO - build_url:https://queue.taskcluster.net/v1/task/XAIGQlNqRcKKaL707shW6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:06:14 INFO - Running post-action listener: _resource_record_post_action 05:06:14 INFO - Running post-action listener: set_extra_try_arguments 05:06:14 INFO - ##### 05:06:14 INFO - ##### Running populate-webroot step. 05:06:14 INFO - ##### 05:06:14 INFO - Running pre-action listener: _resource_record_pre_action 05:06:14 INFO - Running main action method: populate_webroot 05:06:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:06:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:06:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:06:14 INFO - '--tppagecycles', 05:06:14 INFO - '7'], 05:06:14 INFO - 'tests': ['tsvgm']}}, 05:06:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:06:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:06:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:06:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:06:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:06:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:06:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:14 INFO - 'talos_options': ['--disable-e10s'], 05:06:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:06:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:06:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:14 INFO - 'talos_options': ['--disable-e10s'], 05:06:14 INFO - 'tests': ['damp', 'tps']}, 05:06:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:14 INFO - 'tests': ['damp', 'tps']}, 05:06:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:06:14 INFO - 'tests': ['dromaeo_dom']}, 05:06:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:06:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:06:14 INFO - 'tests': ['a11yr', 05:06:14 INFO - 'ts_paint', 05:06:14 INFO - 'tpaint', 05:06:14 INFO - 'sessionrestore', 05:06:14 INFO - 'sessionrestore_no_auto_restore', 05:06:14 INFO - 'tabpaint']}, 05:06:14 INFO - 'other-e10s': {'tests': ['a11yr', 05:06:14 INFO - 'ts_paint', 05:06:14 INFO - 'tpaint', 05:06:14 INFO - 'sessionrestore', 05:06:14 INFO - 'sessionrestore_no_auto_restore', 05:06:14 INFO - 'tabpaint']}, 05:06:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:06:14 INFO - 'ts_paint', 05:06:14 INFO - 'tpaint', 05:06:14 INFO - 'sessionrestore', 05:06:14 INFO - 'sessionrestore_no_auto_restore', 05:06:14 INFO - 'tabpaint']}, 05:06:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:06:14 INFO - 'ts_paint', 05:06:14 INFO - 'tpaint', 05:06:14 INFO - 'sessionrestore', 05:06:14 INFO - 'sessionrestore_no_auto_restore', 05:06:14 INFO - 'tabpaint']}, 05:06:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:06:14 INFO - 'tests': ['a11yr', 05:06:14 INFO - 'ts_paint', 05:06:14 INFO - 'tpaint', 05:06:14 INFO - 'sessionrestore', 05:06:14 INFO - 'sessionrestore_no_auto_restore', 05:06:14 INFO - 'tabpaint']}, 05:06:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:06:14 INFO - 'tests': ['a11yr', 05:06:14 INFO - 'ts_paint', 05:06:14 INFO - 'tpaint', 05:06:14 INFO - 'sessionrestore', 05:06:14 INFO - 'sessionrestore_no_auto_restore', 05:06:14 INFO - 'tabpaint']}, 05:06:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:06:14 INFO - 'tests': ['tsvgx', 05:06:14 INFO - 'tsvgr_opacity', 05:06:14 INFO - 'tart', 05:06:14 INFO - 'tscrollx', 05:06:14 INFO - 'cart']}, 05:06:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:06:14 INFO - 'tsvgr_opacity', 05:06:14 INFO - 'tart', 05:06:14 INFO - 'tscrollx', 05:06:14 INFO - 'cart']}, 05:06:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:14 INFO - 'talos_options': ['--disable-e10s'], 05:06:14 INFO - 'tests': ['tp5o']}, 05:06:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:14 INFO - 'tests': ['tp5o']}, 05:06:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:14 INFO - 'talos_options': ['--disable-e10s', 05:06:14 INFO - '--xperf_path', 05:06:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:06:14 INFO - 'tests': ['tp5n']}, 05:06:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:14 INFO - 'talos_options': ['--xperf_path', 05:06:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:06:14 INFO - 'tests': ['tp5n']}}, 05:06:14 INFO - 'talos.zip': {'path': '', 05:06:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:06:14 INFO - Running post-action listener: _resource_record_post_action 05:06:14 INFO - ##### 05:06:14 INFO - ##### Running create-virtualenv step. 05:06:14 INFO - ##### 05:06:14 INFO - Running pre-action listener: _resource_record_pre_action 05:06:14 INFO - Running main action method: create_virtualenv 05:06:14 INFO - Creating virtualenv /builds/slave/test/build/venv 05:06:14 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 05:06:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:06:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:06:14 INFO - Using real prefix '/usr' 05:06:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:06:15 INFO - Installing distribute.............................................................................................................................................................................................done. 05:06:17 INFO - Installing pip.................done. 05:06:17 INFO - Return code: 0 05:06:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:06:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:17 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 0x7f2f724c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdac410>, '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 0xdad310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdad7a0>, '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': 'fa44defc139c4ba8574fe040000001db-1461665383.224155-1094879320', '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 05:06:17 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 05:06:17 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 05:06:17 INFO - Using env: {'DISPLAY': ':0', 05:06:17 INFO - 'HOME': '/home/cltbld', 05:06:17 INFO - 'LANG': 'en_US.UTF-8', 05:06:17 INFO - 'LANGUAGE': 'en_US:en', 05:06:17 INFO - 'LOGNAME': 'cltbld', 05:06:17 INFO - 'MAIL': '/var/mail/cltbld', 05:06:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:17 INFO - 'MOZ_NO_REMOTE': '1', 05:06:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:17 INFO - 'NO_EM_RESTART': '1', 05:06:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:17 INFO - 'PWD': '/builds/slave/test', 05:06:17 INFO - 'SHELL': '/bin/bash', 05:06:17 INFO - 'SHLVL': '1', 05:06:17 INFO - 'TERM': 'linux', 05:06:17 INFO - 'TMOUT': '86400', 05:06:17 INFO - 'USER': 'cltbld', 05:06:17 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1461665383.224155-1094879320', 05:06:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:17 INFO - '_': '/tools/buildbot/bin/python'} 05:06:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:17 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 05:06:17 INFO - Cleaning up... 05:06:17 INFO - Return code: 0 05:06:17 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:06:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:17 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 0x7f2f724c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdac410>, '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 0xdad310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdad7a0>, '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': 'fa44defc139c4ba8574fe040000001db-1461665383.224155-1094879320', '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 05:06:17 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 05:06:17 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 05:06:17 INFO - Using env: {'DISPLAY': ':0', 05:06:17 INFO - 'HOME': '/home/cltbld', 05:06:17 INFO - 'LANG': 'en_US.UTF-8', 05:06:17 INFO - 'LANGUAGE': 'en_US:en', 05:06:17 INFO - 'LOGNAME': 'cltbld', 05:06:17 INFO - 'MAIL': '/var/mail/cltbld', 05:06:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:17 INFO - 'MOZ_NO_REMOTE': '1', 05:06:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:17 INFO - 'NO_EM_RESTART': '1', 05:06:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:17 INFO - 'PWD': '/builds/slave/test', 05:06:17 INFO - 'SHELL': '/bin/bash', 05:06:17 INFO - 'SHLVL': '1', 05:06:17 INFO - 'TERM': 'linux', 05:06:17 INFO - 'TMOUT': '86400', 05:06:17 INFO - 'USER': 'cltbld', 05:06:17 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1461665383.224155-1094879320', 05:06:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:17 INFO - '_': '/tools/buildbot/bin/python'} 05:06:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:17 INFO - Downloading/unpacking psutil>=0.7.1 05:06:17 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 05:06:17 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 05:06:17 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 05:06:17 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 05:06:17 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 05:06:17 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 05:06:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:06:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:06:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:06:19 INFO - Installing collected packages: psutil 05:06:19 INFO - Running setup.py install for psutil 05:06:19 INFO - building 'psutil._psutil_linux' extension 05:06:19 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 05:06:19 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 05:06:20 INFO - building 'psutil._psutil_posix' extension 05:06:20 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 05:06:20 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 05:06:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:06:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:06:20 INFO - Successfully installed psutil 05:06:20 INFO - Cleaning up... 05:06:20 INFO - Return code: 0 05:06:20 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:06: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')]} 05:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06: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')]} 05:06:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:20 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 0x7f2f724c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdac410>, '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 0xdad310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdad7a0>, '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': 'fa44defc139c4ba8574fe040000001db-1461665383.224155-1094879320', '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 05:06:20 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 05:06:20 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 05:06:20 INFO - Using env: {'DISPLAY': ':0', 05:06:20 INFO - 'HOME': '/home/cltbld', 05:06:20 INFO - 'LANG': 'en_US.UTF-8', 05:06:20 INFO - 'LANGUAGE': 'en_US:en', 05:06:20 INFO - 'LOGNAME': 'cltbld', 05:06:20 INFO - 'MAIL': '/var/mail/cltbld', 05:06:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:20 INFO - 'MOZ_NO_REMOTE': '1', 05:06:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:20 INFO - 'NO_EM_RESTART': '1', 05:06:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:20 INFO - 'PWD': '/builds/slave/test', 05:06:20 INFO - 'SHELL': '/bin/bash', 05:06:20 INFO - 'SHLVL': '1', 05:06:20 INFO - 'TERM': 'linux', 05:06:20 INFO - 'TMOUT': '86400', 05:06:20 INFO - 'USER': 'cltbld', 05:06:20 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1461665383.224155-1094879320', 05:06:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:20 INFO - '_': '/tools/buildbot/bin/python'} 05:06:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:20 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:06:20 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 05:06:20 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 05:06:20 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 05:06:20 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 05:06:20 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 05:06:20 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 05:06:22 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:06:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:06:22 INFO - Installing collected packages: mozsystemmonitor 05:06:22 INFO - Running setup.py install for mozsystemmonitor 05:06:22 INFO - Successfully installed mozsystemmonitor 05:06:22 INFO - Cleaning up... 05:06:22 INFO - Return code: 0 05:06:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:06: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')]} 05:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06: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')]} 05:06:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:22 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 0x7f2f724c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdac410>, '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 0xdad310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdad7a0>, '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': 'fa44defc139c4ba8574fe040000001db-1461665383.224155-1094879320', '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 05:06:22 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 05:06:22 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 05:06:22 INFO - Using env: {'DISPLAY': ':0', 05:06:22 INFO - 'HOME': '/home/cltbld', 05:06:22 INFO - 'LANG': 'en_US.UTF-8', 05:06:22 INFO - 'LANGUAGE': 'en_US:en', 05:06:22 INFO - 'LOGNAME': 'cltbld', 05:06:22 INFO - 'MAIL': '/var/mail/cltbld', 05:06:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:22 INFO - 'MOZ_NO_REMOTE': '1', 05:06:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:22 INFO - 'NO_EM_RESTART': '1', 05:06:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:22 INFO - 'PWD': '/builds/slave/test', 05:06:22 INFO - 'SHELL': '/bin/bash', 05:06:22 INFO - 'SHLVL': '1', 05:06:22 INFO - 'TERM': 'linux', 05:06:22 INFO - 'TMOUT': '86400', 05:06:22 INFO - 'USER': 'cltbld', 05:06:22 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1461665383.224155-1094879320', 05:06:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:22 INFO - '_': '/tools/buildbot/bin/python'} 05:06:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:22 INFO - Downloading/unpacking blobuploader==1.2.4 05:06:22 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 05:06:22 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 05:06:22 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 05:06:22 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 05:06:22 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 05:06:22 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 05:06:25 INFO - Downloading blobuploader-1.2.4.tar.gz 05:06:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:06:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:06:25 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 05:06:25 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 05:06:25 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 05:06:25 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 05:06:25 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 05:06:25 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 05:06:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:06:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:06:25 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 05:06:25 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 05:06:25 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 05:06:25 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 05:06:25 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 05:06:25 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 05:06:25 INFO - Downloading docopt-0.6.1.tar.gz 05:06:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:06:25 INFO - Installing collected packages: blobuploader, requests, docopt 05:06:25 INFO - Running setup.py install for blobuploader 05:06:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:06:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:06:26 INFO - Running setup.py install for requests 05:06:26 INFO - Running setup.py install for docopt 05:06:26 INFO - Successfully installed blobuploader requests docopt 05:06:26 INFO - Cleaning up... 05:06:26 INFO - Return code: 0 05:06:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:26 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 0x7f2f724c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdac410>, '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 0xdad310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdad7a0>, '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': 'fa44defc139c4ba8574fe040000001db-1461665383.224155-1094879320', '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 05:06:26 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 05:06:26 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 05:06:26 INFO - Using env: {'DISPLAY': ':0', 05:06:26 INFO - 'HOME': '/home/cltbld', 05:06:26 INFO - 'LANG': 'en_US.UTF-8', 05:06:26 INFO - 'LANGUAGE': 'en_US:en', 05:06:26 INFO - 'LOGNAME': 'cltbld', 05:06:26 INFO - 'MAIL': '/var/mail/cltbld', 05:06:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:26 INFO - 'MOZ_NO_REMOTE': '1', 05:06:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:26 INFO - 'NO_EM_RESTART': '1', 05:06:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:26 INFO - 'PWD': '/builds/slave/test', 05:06:26 INFO - 'SHELL': '/bin/bash', 05:06:26 INFO - 'SHLVL': '1', 05:06:26 INFO - 'TERM': 'linux', 05:06:26 INFO - 'TMOUT': '86400', 05:06:26 INFO - 'USER': 'cltbld', 05:06:26 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1461665383.224155-1094879320', 05:06:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:26 INFO - '_': '/tools/buildbot/bin/python'} 05:06:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:06:26 INFO - Running setup.py (path:/tmp/pip-j6IR39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:06:26 INFO - Running setup.py (path:/tmp/pip-RNDYyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:06:26 INFO - Running setup.py (path:/tmp/pip-U4DCQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:06:27 INFO - Running setup.py (path:/tmp/pip-aOPfTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:06:27 INFO - Running setup.py (path:/tmp/pip-IVuHFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:06:27 INFO - Running setup.py (path:/tmp/pip-bW2Hic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:06:27 INFO - Running setup.py (path:/tmp/pip-A8uQTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:06:27 INFO - Running setup.py (path:/tmp/pip-GHEUpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:06:27 INFO - Running setup.py (path:/tmp/pip-36d1nh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:06:27 INFO - Running setup.py (path:/tmp/pip-dXgsgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:06:27 INFO - Running setup.py (path:/tmp/pip-gD0Keo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:06:27 INFO - Running setup.py (path:/tmp/pip-1AQ38h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:06:27 INFO - Running setup.py (path:/tmp/pip-LDk8x1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:06:27 INFO - Running setup.py (path:/tmp/pip-8d5gU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:27 INFO - Running setup.py (path:/tmp/pip-_CwdhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:06:27 INFO - Running setup.py (path:/tmp/pip-2AXGc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:06:27 INFO - Running setup.py (path:/tmp/pip-EYDBaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:06:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:06:28 INFO - Running setup.py install for manifestparser 05:06:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:06:28 INFO - Running setup.py install for mozcrash 05:06:28 INFO - Running setup.py install for mozdebug 05:06:28 INFO - Running setup.py install for mozdevice 05:06:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:06:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:06:28 INFO - Running setup.py install for mozfile 05:06:28 INFO - Running setup.py install for mozhttpd 05:06:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:06:28 INFO - Running setup.py install for mozinfo 05:06:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:06:28 INFO - Running setup.py install for mozInstall 05:06:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:06:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:06:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:06:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:06:28 INFO - Running setup.py install for mozleak 05:06:28 INFO - Running setup.py install for mozlog 05:06:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:06:29 INFO - Running setup.py install for moznetwork 05:06:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:06:29 INFO - Running setup.py install for mozprocess 05:06:29 INFO - Running setup.py install for mozprofile 05:06:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:06:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:06:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:06:29 INFO - Running setup.py install for mozrunner 05:06:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:06:29 INFO - Running setup.py install for mozscreenshot 05:06:29 INFO - Running setup.py install for moztest 05:06:29 INFO - Running setup.py install for mozversion 05:06:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:06:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:06:29 INFO - Cleaning up... 05:06:29 INFO - Return code: 0 05:06:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:06:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:29 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 0x7f2f724c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdac410>, '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 0xdad310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdad7a0>, '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': 'fa44defc139c4ba8574fe040000001db-1461665383.224155-1094879320', '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 05:06:29 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 05:06:29 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 05:06:29 INFO - Using env: {'DISPLAY': ':0', 05:06:29 INFO - 'HOME': '/home/cltbld', 05:06:29 INFO - 'LANG': 'en_US.UTF-8', 05:06:29 INFO - 'LANGUAGE': 'en_US:en', 05:06:29 INFO - 'LOGNAME': 'cltbld', 05:06:29 INFO - 'MAIL': '/var/mail/cltbld', 05:06:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:29 INFO - 'MOZ_NO_REMOTE': '1', 05:06:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:29 INFO - 'NO_EM_RESTART': '1', 05:06:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:29 INFO - 'PWD': '/builds/slave/test', 05:06:29 INFO - 'SHELL': '/bin/bash', 05:06:29 INFO - 'SHLVL': '1', 05:06:29 INFO - 'TERM': 'linux', 05:06:29 INFO - 'TMOUT': '86400', 05:06:29 INFO - 'USER': 'cltbld', 05:06:29 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1461665383.224155-1094879320', 05:06:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:29 INFO - '_': '/tools/buildbot/bin/python'} 05:06:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:06:30 INFO - Running setup.py (path:/tmp/pip-ONjcIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:06:30 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)) 05:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:06:30 INFO - Running setup.py (path:/tmp/pip-1RFdyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:06:30 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)) 05:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:06:30 INFO - Running setup.py (path:/tmp/pip-zQwrGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:06:30 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)) 05:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:06:30 INFO - Running setup.py (path:/tmp/pip-wuVDWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:06:30 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)) 05:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:06:30 INFO - Running setup.py (path:/tmp/pip-6PMtKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:06:30 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)) 05:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:06:30 INFO - Running setup.py (path:/tmp/pip-0tDCYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:06:30 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)) 05:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:06:30 INFO - Running setup.py (path:/tmp/pip-dW4rCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:06:30 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)) 05:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:06:30 INFO - Running setup.py (path:/tmp/pip-G0nerQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:06:30 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)) 05:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:06:30 INFO - Running setup.py (path:/tmp/pip-7upLSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:06:30 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)) 05:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:06:30 INFO - Running setup.py (path:/tmp/pip-QlieJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:06:30 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)) 05:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:06:30 INFO - Running setup.py (path:/tmp/pip-2wSVRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:06:30 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)) 05:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:06:30 INFO - Running setup.py (path:/tmp/pip-gVGyQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:06:30 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)) 05:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:06:30 INFO - Running setup.py (path:/tmp/pip-fj5WE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:06:30 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)) 05:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:06:30 INFO - Running setup.py (path:/tmp/pip-MUsJ0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:06:31 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)) 05:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:31 INFO - Running setup.py (path:/tmp/pip-dBVmA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:31 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)) 05:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:06:31 INFO - Running setup.py (path:/tmp/pip-og62vt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:06:31 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)) 05:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:06:31 INFO - Running setup.py (path:/tmp/pip-0oHcq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:06:31 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)) 05:06:31 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)) 05:06:31 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)) 05:06:31 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)) 05:06:31 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)) 05:06:31 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)) 05:06:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:06: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 05:06: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 05:06: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 05:06: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 05:06: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 05:06: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 05:06:33 INFO - Downloading blessings-1.6.tar.gz 05:06:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:06:33 INFO - Installing collected packages: blessings 05:06:33 INFO - Running setup.py install for blessings 05:06:33 INFO - Successfully installed blessings 05:06:33 INFO - Cleaning up... 05:06:33 INFO - Return code: 0 05:06:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:06:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:06:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:06:33 INFO - Reading from file tmpfile_stdout 05:06:33 INFO - Current package versions: 05:06:33 INFO - argparse == 1.2.1 05:06:33 INFO - blessings == 1.6 05:06:33 INFO - blobuploader == 1.2.4 05:06:33 INFO - docopt == 0.6.1 05:06:33 INFO - manifestparser == 1.1 05:06:33 INFO - mozInstall == 1.12 05:06:33 INFO - mozcrash == 0.17 05:06:33 INFO - mozdebug == 0.1 05:06:33 INFO - mozdevice == 0.48 05:06:33 INFO - mozfile == 1.2 05:06:33 INFO - mozhttpd == 0.7 05:06:33 INFO - mozinfo == 0.9 05:06:33 INFO - mozleak == 0.1 05:06:33 INFO - mozlog == 3.1 05:06:33 INFO - moznetwork == 0.27 05:06:33 INFO - mozprocess == 0.22 05:06:33 INFO - mozprofile == 0.28 05:06:33 INFO - mozrunner == 6.11 05:06:33 INFO - mozscreenshot == 0.1 05:06:33 INFO - mozsystemmonitor == 0.0 05:06:33 INFO - moztest == 0.7 05:06:33 INFO - mozversion == 1.4 05:06:33 INFO - psutil == 3.1.1 05:06:33 INFO - requests == 1.2.3 05:06:33 INFO - wsgiref == 0.1.2 05:06:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:06: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')]} 05:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06: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')]} 05:06:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:33 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 0x7f2f724c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdac410>, '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 0xdad310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdad7a0>, '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': 'fa44defc139c4ba8574fe040000001db-1461665383.224155-1094879320', '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 05:06:33 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 05:06:33 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 05:06:33 INFO - Using env: {'DISPLAY': ':0', 05:06:33 INFO - 'HOME': '/home/cltbld', 05:06:33 INFO - 'LANG': 'en_US.UTF-8', 05:06:33 INFO - 'LANGUAGE': 'en_US:en', 05:06:33 INFO - 'LOGNAME': 'cltbld', 05:06:33 INFO - 'MAIL': '/var/mail/cltbld', 05:06:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:33 INFO - 'MOZ_NO_REMOTE': '1', 05:06:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:33 INFO - 'NO_EM_RESTART': '1', 05:06:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:33 INFO - 'PWD': '/builds/slave/test', 05:06:33 INFO - 'SHELL': '/bin/bash', 05:06:33 INFO - 'SHLVL': '1', 05:06:33 INFO - 'TERM': 'linux', 05:06:33 INFO - 'TMOUT': '86400', 05:06:33 INFO - 'USER': 'cltbld', 05:06:33 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1461665383.224155-1094879320', 05:06:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:33 INFO - '_': '/tools/buildbot/bin/python'} 05:06:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:33 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)) 05:06:33 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)) 05:06:33 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)) 05:06:33 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)) 05:06:33 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)) 05:06:33 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)) 05:06:33 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)) 05:06:33 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)) 05:06:33 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)) 05:06:33 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)) 05:06:33 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)) 05:06:33 INFO - Cleaning up... 05:06:33 INFO - Return code: 0 05:06:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:06: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')]} 05:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06: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')]} 05:06:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2f724c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdac410>, '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 0xdad310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdad7a0>, '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': 'fa44defc139c4ba8574fe040000001db-1461665383.224155-1094879320', '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 05:06: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', 'jsonschema'] in /builds/slave/test/build 05:06: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 jsonschema 05:06:33 INFO - Using env: {'DISPLAY': ':0', 05:06:33 INFO - 'HOME': '/home/cltbld', 05:06:33 INFO - 'LANG': 'en_US.UTF-8', 05:06:33 INFO - 'LANGUAGE': 'en_US:en', 05:06:33 INFO - 'LOGNAME': 'cltbld', 05:06:33 INFO - 'MAIL': '/var/mail/cltbld', 05:06:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:33 INFO - 'MOZ_NO_REMOTE': '1', 05:06:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:33 INFO - 'NO_EM_RESTART': '1', 05:06:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:33 INFO - 'PWD': '/builds/slave/test', 05:06:33 INFO - 'SHELL': '/bin/bash', 05:06:33 INFO - 'SHLVL': '1', 05:06:33 INFO - 'TERM': 'linux', 05:06:33 INFO - 'TMOUT': '86400', 05:06:33 INFO - 'USER': 'cltbld', 05:06:33 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1461665383.224155-1094879320', 05:06:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:33 INFO - '_': '/tools/buildbot/bin/python'} 05:06:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:34 INFO - Downloading/unpacking jsonschema 05:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:06:35 INFO - Downloading/unpacking functools32 (from jsonschema) 05:06: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 05:06: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 05:06: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 05:06: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 05:06: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 05:06: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 05:06:36 INFO - Downloading functools32-3.2.3-2.tar.gz 05:06:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:06:36 INFO - warning: no files found matching '*.txt' 05:06:36 INFO - no previously-included directories found matching 'build' 05:06:36 INFO - no previously-included directories found matching 'dist' 05:06:36 INFO - no previously-included directories found matching '.git*' 05:06:36 INFO - Installing collected packages: jsonschema, functools32 05:06:36 INFO - Running setup.py install for functools32 05:06:36 INFO - warning: no files found matching '*.txt' 05:06:36 INFO - no previously-included directories found matching 'build' 05:06:36 INFO - no previously-included directories found matching 'dist' 05:06:36 INFO - no previously-included directories found matching '.git*' 05:06:36 INFO - Successfully installed jsonschema functools32 05:06:36 INFO - Cleaning up... 05:06:36 INFO - Return code: 0 05:06:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:06: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')]} 05:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06: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')]} 05:06:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:36 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 0x7f2f724c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdac410>, '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 0xdad310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdad7a0>, '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': 'fa44defc139c4ba8574fe040000001db-1461665383.224155-1094879320', '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 05:06:36 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 05:06:36 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 05:06:36 INFO - Using env: {'DISPLAY': ':0', 05:06:36 INFO - 'HOME': '/home/cltbld', 05:06:36 INFO - 'LANG': 'en_US.UTF-8', 05:06:36 INFO - 'LANGUAGE': 'en_US:en', 05:06:36 INFO - 'LOGNAME': 'cltbld', 05:06:36 INFO - 'MAIL': '/var/mail/cltbld', 05:06:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:36 INFO - 'MOZ_NO_REMOTE': '1', 05:06:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:36 INFO - 'NO_EM_RESTART': '1', 05:06:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:36 INFO - 'PWD': '/builds/slave/test', 05:06:36 INFO - 'SHELL': '/bin/bash', 05:06:36 INFO - 'SHLVL': '1', 05:06:36 INFO - 'TERM': 'linux', 05:06:36 INFO - 'TMOUT': '86400', 05:06:36 INFO - 'USER': 'cltbld', 05:06:36 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1461665383.224155-1094879320', 05:06:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:36 INFO - '_': '/tools/buildbot/bin/python'} 05:06:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:36 INFO - Downloading/unpacking flake8 05:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:06:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:06:38 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 05:06:38 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 05:06:38 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 05:06:38 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 05:06:38 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 05:06:38 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 05:06:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:06:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:06:38 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 05:06:38 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 05:06:38 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 05:06:38 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 05:06:38 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 05:06:38 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 05:06:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:06:38 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 05:06:38 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 05:06:38 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 05:06:38 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 05:06:38 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 05:06:38 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 05:06:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:06:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:06:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:06:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:06:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:06:39 INFO - no previously-included directories found matching 'docs/_build' 05:06:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:06:39 INFO - Running setup.py install for pep8 05:06:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:06:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:06:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:06:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:06:39 INFO - no previously-included directories found matching 'docs/_build' 05:06:39 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:06:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:06:39 INFO - Cleaning up... 05:06:39 INFO - Return code: 0 05:06:39 INFO - Running post-action listener: _resource_record_post_action 05:06:39 INFO - Running post-action listener: _start_resource_monitoring 05:06:39 INFO - Starting resource monitoring. 05:06:39 INFO - ##### 05:06:39 INFO - ##### Running install step. 05:06:39 INFO - ##### 05:06:39 INFO - Running pre-action listener: _resource_record_pre_action 05:06:39 INFO - Running main action method: install 05:06:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:06:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:06:39 INFO - Reading from file tmpfile_stdout 05:06:39 INFO - Detecting whether we're running mozinstall >=1.0... 05:06:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:06:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:06:39 INFO - Reading from file tmpfile_stdout 05:06:39 INFO - Output received: 05:06:39 INFO - Usage: mozinstall [options] installer 05:06:39 INFO - Options: 05:06:39 INFO - -h, --help show this help message and exit 05:06:39 INFO - -d DEST, --destination=DEST 05:06:39 INFO - Directory to install application into. [default: 05:06:39 INFO - "/builds/slave/test"] 05:06:39 INFO - --app=APP Application being installed. [default: firefox] 05:06:39 INFO - mkdir: /builds/slave/test/build/application 05:06:39 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'] 05:06:39 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 05:06:56 INFO - Reading from file tmpfile_stdout 05:06:56 INFO - Output received: 05:06:56 INFO - /builds/slave/test/build/application/firefox/firefox 05:06:56 INFO - Running post-action listener: _resource_record_post_action 05:06:56 INFO - ##### 05:06:56 INFO - ##### Running run-tests step. 05:06:56 INFO - ##### 05:06:56 INFO - Running pre-action listener: _resource_record_pre_action 05:06:56 INFO - Running main action method: run_tests 05:06:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:06:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:06:56 INFO - Python 2.7.3 05:06:56 INFO - Return code: 0 05:06:56 INFO - grabbing minidump binary from tooltool 05:06:56 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')]} 05:06:56 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 0xdac410>, '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 0xdad310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdad7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:06:56 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 05:06:56 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 05:06:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:06:56 INFO - Return code: 0 05:06:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:06:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:06:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:06:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:06:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:06:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:06:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:06:57 INFO - Return code: 0 05:06:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XAIGQlNqRcKKaL707shW6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 05:06:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XAIGQlNqRcKKaL707shW6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 05:06:57 INFO - Using env: {'DISPLAY': ':0', 05:06:57 INFO - 'HOME': '/home/cltbld', 05:06:57 INFO - 'LANG': 'en_US.UTF-8', 05:06:57 INFO - 'LANGUAGE': 'en_US:en', 05:06:57 INFO - 'LOGNAME': 'cltbld', 05:06:57 INFO - 'MAIL': '/var/mail/cltbld', 05:06:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:06:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:06:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:57 INFO - 'MOZ_NO_REMOTE': '1', 05:06:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:06:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:57 INFO - 'NO_EM_RESTART': '1', 05:06:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:57 INFO - 'PWD': '/builds/slave/test', 05:06:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:06:57 INFO - 'SHELL': '/bin/bash', 05:06:57 INFO - 'SHLVL': '1', 05:06:57 INFO - 'TERM': 'linux', 05:06:57 INFO - 'TMOUT': '86400', 05:06:57 INFO - 'USER': 'cltbld', 05:06:57 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1461665383.224155-1094879320', 05:06:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:57 INFO - '_': '/tools/buildbot/bin/python'} 05:06:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XAIGQlNqRcKKaL707shW6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 05:06:57 INFO - mozversion application_buildid: 20160426023013 05:06:57 INFO - mozversion application_changeset: 99fbe8621fa73724446ea9f828a0d30642faa6f9 05:06:57 INFO - mozversion application_display_name: Nightly 05:06:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:06:57 INFO - mozversion application_name: Firefox 05:06:57 INFO - mozversion application_remotingname: firefox 05:06:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:06:57 INFO - mozversion application_vendor: Mozilla 05:06:57 INFO - mozversion application_version: 49.0a1 05:06:57 INFO - mozversion platform_buildid: 20160426023013 05:06:57 INFO - mozversion platform_changeset: 99fbe8621fa73724446ea9f828a0d30642faa6f9 05:06:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:06:57 INFO - mozversion platform_version: 49.0a1 05:06:57 INFO - using testdate: 1461672417 05:06:57 INFO - actual date: 1461672417 05:06:57 INFO - starting webserver on 'localhost:33907' 05:06:57 INFO - SUITE-START | Running 2 tests 05:06:57 INFO - TEST-START | dromaeo_css 05:06:57 INFO - operating with platform_type : linux_ 05:06:57 INFO - Initialising browser for dromaeo_css test... 05:06:57 INFO - TEST-INFO | started process 8675 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5GxX0h/profile http://localhost:33907/getInfo.html) 05:07:01 INFO - PROCESS | 8675 | 05:07:01 INFO - PROCESS | 8675 | (process:8745): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:07:02 INFO - PROCESS | 8675 | __metrics Screen width/height:1600/1200 05:07:02 INFO - PROCESS | 8675 | colorDepth:24 05:07:02 INFO - PROCESS | 8675 | Browser inner width/height: 1024/697 05:07:02 INFO - PROCESS | 8675 | __metrics 05:07:02 ERROR - PROCESS | 8675 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:07:03 INFO - TEST-INFO | 8675: exit 0 05:07:03 INFO - Browser initialized. 05:07:03 INFO - Running cycle 1/1 for dromaeo_css test... 05:07:03 INFO - TEST-INFO | started process 8796 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5GxX0h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:07:05 INFO - PROCESS | 8796 | 05:07:05 INFO - PROCESS | 8796 | (process:8857): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:07:15 INFO - PROCESS | 8796 | RSS: Main: 164581376 05:07:15 INFO - PROCESS | 8796 | 05:08:05 INFO - PROCESS | 8796 | 1461672485063 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] 05:10:12 INFO - PROCESS | 8796 | Cycle 1(1): loaded http://localhost:33907/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33907/tests/dromaeo/cssquery-ext.html) 05:10:13 INFO - PROCESS | 8796 | RSS: Main: 170156032 05:10:13 INFO - PROCESS | 8796 | 05:13:15 INFO - PROCESS | 8796 | Cycle 1(1): loaded http://localhost:33907/tests/dromaeo/cssquery-ext.html (next: http://localhost:33907/tests/dromaeo/cssquery-jquery.html) 05:13:16 INFO - PROCESS | 8796 | RSS: Main: 167337984 05:13:16 INFO - PROCESS | 8796 | 05:16:18 INFO - PROCESS | 8796 | Cycle 1(1): loaded http://localhost:33907/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33907/tests/dromaeo/cssquery-mootools.html) 05:16:18 INFO - PROCESS | 8796 | RSS: Main: 168058880 05:16:18 INFO - PROCESS | 8796 | 05:19:20 INFO - PROCESS | 8796 | Cycle 1(1): loaded http://localhost:33907/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33907/tests/dromaeo/cssquery-prototype.html) 05:19:20 INFO - PROCESS | 8796 | RSS: Main: 165855232 05:19:20 INFO - PROCESS | 8796 | 05:22:23 INFO - PROCESS | 8796 | Cycle 1(1): loaded http://localhost:33907/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33907/tests/dromaeo/cssquery-yui.html) 05:22:23 INFO - PROCESS | 8796 | RSS: Main: 167403520 05:22:23 INFO - PROCESS | 8796 | 05:25:26 INFO - PROCESS | 8796 | Cycle 1(1): loaded http://localhost:33907/tests/dromaeo/cssquery-yui.html (next: http://localhost:33907/tests/dromaeo/cssquery-dojo.html) 05:25:26 INFO - PROCESS | 8796 | RSS: Main: 169324544 05:25:26 INFO - PROCESS | 8796 | 05:25:26 INFO - PROCESS | 8796 | __start_tp_report 05:25:26 INFO - PROCESS | 8796 | _x_x_mozilla_page_load 05:25:26 INFO - PROCESS | 8796 | _x_x_mozilla_page_load_details 05:25:26 INFO - PROCESS | 8796 | |i|pagename|runs| 05:25:26 INFO - PROCESS | 8796 | |0;dojo.html;3089.8300593467357;3126.3434678717467;3138.9843050784743;3212.2611799286165;3213.983930080349;5341.572674186065;5347.11772557528;5359.866003349918;5384.2731231283815;5415.702136382497;5270.8418747437545;5413.052715774734;5425.538829199523;5460.290162278899;5529.170624406341;4824.6863953842885;4851.805927762885;4900.901981960359;4922.778474968617;4977.303177555127;800.5615000341515;4830.372051633282;4949.406071271453;4980.27785971034;4988.176950803131;4904.117258893398;4906.950930490685;4914.213725803872;4925.556699897026;4951.084049450845;4805.711657300538;4925.975370123127;4967.82612608557;5010.248462730619;5055.74721263939;4786.976065119687;4814.831480898151;4857.319975203474;4902.950970490285;4907.214845624683;5237.895242095175;5256.894862102737;5267.3679158500845;5282.313299271109;5324.174752913266;5724.456176663252;5733.31200255972;5740.138979153118;5828.300603927513;5895.911561326584;5687.573431992576;5708.71456427177;5743.10981797822;5757.539396848242;5785.88428231433;5355.7857685692525;5356.143017117242;5364.275822763955;5364.383095943977;5366.892662146735;5749.540036797046;5831.037878750044;5856.121581762684;5858.062709966385;5877.52979761618;5647.407022262603;5655.095184770417;5665.801696940587;5684.687342196136;5685.687287199244;5729.914051289234;5732.34078081026;5739.397363276796;5740.856478588069;5753.280839895013;5485.670859748428;5554.583406244547;5720.170575266563;5805.88388232233;5814.098814683646;5589.441055894378;5636;5678;5705.5435565154685;5766.394528574523;4301.268784306675;4305.07440900208;4329.6969212154845;4330.437043184366;4340.47914250292;3854.9036274093373;3879.941800872989;3881.9611803882162;3929.587393323717;3930.5479869814767;5504.972475137599;5529.944700553024;5532.612717109844;5548.361938377057;5552.41699621542;5751.051076572318;5795.072788353843;5804.2744656917885;5815;5865.35481097079;5338.3593968724;5536.529395001389;5565.137403702352;5580.525655319262;5597.076482380443;4898.706077635354;4927.236278376858;4948.109340318705;4963.379577552806;4965.155923493015;5754.769809207585;5947.881042379215;5952;5953;5954.583179177416;5731.914021289684;5782.190493331022;5825.271841019872;5844.795432159854;5875.3243377010485;5980.3421623622235;6026.517878569616;6030.216071910623;6039.335673075871;6040.879182416415;5496.395396506301;5749.655020698771;5754.964106460877;5755.683437410982;5756.481916627524;5868.09044598088;5905.084711869667;5906.763729450774;5942.346341902474;5964;5552.583556233218;5560.054790685674;5560.304961879765;5563.05428077236;5572.972135139298;5470;5510.256115424527;5558.194061860927;5573.414791446839;5611.551075913835;5447.428020057995;5532.5020748132865;5543.501084902378;5602.635828671123;5619.915701264403;5558.194061860927;5608.327000759935;5635.830925072254;5642.351129620146;5655.632383895034;5398.946010539844;5534.557235421237;5538.8061417851795;5559.805406810742;5569.33168019824 05:25:26 INFO - PROCESS | 8796 | |1;ext.html;605.7213681706414;648.2156590525465;655.6197405504807;665.5075244319203;673.4343151752527;31335.373292534136;38688.419673704884;39554.406683899695;39595.20809583807;39709.007274818105;42415;42566.787166064205;42729.57270427295;43020.354694679605;43030;8533.487990720545;8631.223189912907;8717.520536370497;8784.51685157316;8836.955815220916;8586.699465518708;8658.696945606906;8679.826403471958;8683;8891.955540222321;8936.374453788238;8971.237444817165;8999.460032398078;9008.639654413815;9063.093690630918;8882.511461869595;8929.06244844295;8941.418807777507;8961.238294744955;8998.100189980982;8641;8842;8844.159804818531;8849.911500884973;8850.468971861708;41888.79055604733;42283.36574951378;42411.15177696429;42437;42444.363334550006;3341.465365541526;3357.17749151457;3559;3805.1058001369934;3900.278448487039;31946.840265798754;32237.194070148198;32812.343753124806;32869;32882.50676239858;3946.960530394688;3988.142549351903;4059.3707975263883;4118.19695159444;4139.937900931488;320755;323299;324251;329121;329612;31823.84088079591;32595;32604.184895377806;59092;59402.40597594055;33438;33527.49708754371;33527.49708754371;33534.99395018153;33636.1590960228;14096.365663545164;14187.716245675028;14201.715965680629;14212.786808197885;14241.287935603179;12929.54746583884;12975.935120324339;13008.349582520836;13042.869571304354;13051.28217948022;7943.880841787378;7945.841083178304;7976.481528700616;8020.759377218693;8075.475094118863;3084.259777653347;3098.5352197170605;3111.5643809866638;3112.486439737463;3125.9056432190487;992.3648864726581;1042.9634962776267;1063.4948399510326;1075.7687097274124;1076.7039064257235;30994.69005309918;31325.373492530023;31386.52920206199;31763.84118079395;31820.727170913367;1139.7834411461795;1191.2614179208947;1237.1772771107294;1252.4051075739133;1303.1855090568395;16859.578510537336;16864.32542698303;16942.152892355334;17286.654266914844;17433.47699569015;490217;493817;497674;499709;501831;57547;57770.4222957765;58418;58426.7078664604;58636;1358.2325985817981;1418.5673369622364;1425.1306702911215;1432.0262221689559;1518.7038527487255;30573.388532228786;31417.8429107853;31440.213994649403;31545.684543154275;32221.355572887944;49390.25914611212;50653.74673126611;51069;51128.48871511237;51305.7434712824;332781;455814;456117;460199;461709;43083;43939;44096.55903441053;44218;45180.322295164944;48630.75684621554;48992.5100748988;49166.262506063154;50075.499245007086;50258.748706256236;40382.596174037884;41367.37948930829;41537.792311038254;41753;42370;36545.817270913474;36866.44700329444;37808.43287350747;40144.59855401408;41958;39677.80161099176;39975.99099166184;40446.393304099875;40626.390604141554;40859.59140408558;34924;35227;36160.27679446449;36509.26981460303;36961.44557831688;27821.30446738767;28163.591820409307;28179.154625361272;28231.57652635253;28264.717352827032 05:25:26 INFO - PROCESS | 8796 | |2;jquery.html;388.9455476233327;389.3692218605858;396.91069509360415;399.56447472255235;401.9658329042031;13731.93134034331;18079.81920180798;18619.627607447845;18688.252469901203;18718.53203669909;17343.219555120017;17354.392596259135;17552.297908083663;17833.73249401257;17856.464306070808;5514.448555144483;5584.329880414356;5588.720563971806;5707.172459993299;5717.199592057094;5226.503482169188;5559.138333558285;5559.972200138994;5599.216109744619;5599.440055994409;5511.035568775468;5524.58565607579;5533.418991005947;5561.277033985576;5564.638298510604;5427.810026649068;5790.536757059446;5837.357890632027;5837.737301821428;5853.619514731528;5453.263809385722;5579.414161513023;5618.831435056954;5646.632968857011;5672.971635141839;13234.536791212262;13275.269860157687;13464.124831885896;13541.59375218745;15402.922985385001;2167.5881582499273;2252.222983070838;2351.753065928087;2433.707955045406;2652.4429869727383;9834.262430317754;10129.442880641562;10147.949260253725;10246.948765256126;14025.158490490603;1896.8387687046618;1902.1630482587618;1937.7480927479478;1976.4367155360796;2014.738084049079;82596;82969.58515207446;84570;85212.57393712991;85505;10255.794884102275;10744.623938162284;10877.564897404174;11154.386508742096;11485.368304743319;12778.936105319413;14057.156570605797;14742.557723268319;14953.102813831205;14979.400823967137;7709.38324934004;7775.533467991939;7913.287804097544;8025.117237103914;8292.419530632798;7822.061352637606;7852.254035866584;7953.6023198840985;8046.356291496666;8121.512709237465;4524.773761311922;4616.30755386688;4661.836835710734;4662.743549104764;4708.4349878014855;1891.5176629959271;1944.7374604428503;1963.7250784890127;1980.6731889238401;2045.5499790046167;896.6996056321075;951.6716732727198;1029.4132344563677;1072.8015317166348;1074.8495210670512;18008.909955450137;18080.367187148386;18412.447626570956;18540.629187416445;18635;996.5415908681942;998.7802683409639;1028.1466382902174;1036.683811437519;1072.120860894075;10089.899101008896;10351.792964140826;10352.275340726228;10482.161427085815;10582.312149710244;488300;505932;512372;513538;515445.4960427635;92907;95672;95678;95897;96423.51788241154;1036.362636978253;1047.2512153810214;1077.7305673581604;1098.9780204395868;1108.7948729485072;16284.43004494837;16719.74920376171;16723.581910452336;16859.74710379321;17006.404775832787;31974.52038219475;39054.6094539051;40565.79717101395;41027;42809.14381712286;53480.73259633677;55426.18070480772;56376.43623563712;56606.716966414904;56805.147922780365;8090;8163.469374490639;8222.424430289822;8448.112948140357;8488.40581159313;12098.334591597546;12953.805692914426;13260.602181934557;13301.46794128224;13336.333183340988;10528.947355263175;10607.893921060999;10778.568857245937;10802.351858888493;11173.832392513956;10778.461076946278;10789.40658263803;10986.230963832775;11142.220044596801;11431.771364572496;10733.302335348177;10767.89232107669;10830.67507974762;10861.945690271497;11101.278416902875;8299.460535065202;8358.749237522885;8400.28597569189;8527.74416767498;8631.050584435581;10669.786604268027;10732.248742588255;10771.29986550903;10905.34567925927;10979.286346387778 05:25:26 INFO - PROCESS | 8796 | |3;mootools.html;1492.2837038221653;1519.149276405213;1660.8671306295498;1770.1680210301154;1775.5383600263945;6885.20820105688;7415.147258065324;7547.09434867816;7840.921590784091;7846.882296765553;7558.168601453835;7563.810904727371;7639.885401718965;7658.38732901368;7658.5021973571675;2175.0647221694703;2200.8129309008755;2202.537467131904;2208.8122509586706;2209.9005544750526;2154.881481518516;2154.9440774020773;2204.79054489824;2205.106931692659;2206.8455208135438;2191.233068426054;2193.287181665965;2199.604071267171;2201.086549082129;2230.264012875747;2154.2137119951103;2156.536344685884;2162.9026693798737;2169.3600387885613;2176.9564608707815;2159.557290755407;2162;2174.239016344283;2196.2203417786777;2198.791114844103;7470.103587569526;7564.281393267631;7577.43169262302;7614.657340419639;7625.542467451915;4575.885602859922;4723.858284251478;4738.928916066262;4754.310624959396;4783.641226907996;3072.9231769205726;3145.1979745165067;3182.5385319128827;3189.0751682012187;3223.871045158191;1064.669952314785;1075.7902209069234;1083.5232497700986;1092.6667366453228;1096.2107282756483;10466.895331046668;10475.371477711285;10489.475526223734;10524.631637892637;10565.101966332872;4286.057067445157;4298.333758267474;4383.254846676073;4408.823647054146;4415.139047885631;9024.503652299187;9052.547372631474;9059.864102038475;9091;9095.863562046574;4760.428748550196;4783.95216047842;4795.232762757942;4797.328374027639;4797.328374027639;3991.1419044904906;4324.156789426094;4377.080813029236;4453.4433195850515;4623.214053610895;3680.4479328100997;3720.9627903721157;3781.9243615127543;3804.8097595120685;3874.4188371744463;1159.7622487390065;1185.3362117214388;1187.9049676025897;1201.39329638532;1207.589419597341;974.697843668465;976.1507488484922;977.2475194100502;1008.4806324742764;1015.7816069545083;5216.347956505437;5355.598330125256;5371.248025276464;5513.448655134454;5749.338826034976;429.15242396267746;432.79009680305654;444.27361264333047;450.0526391944909;461.98614041578804;3794.5446546414605;3814.9618503815163;3840.807959602009;3890.299746045739;3893.4159876018257;9684.56419461126;9744.269179811543;10014.29899907014;10134.341267817568;10151.543180556893;9598;9618.807623847484;9786.461744603972;9931;9966.451845148442;7707.691692332356;7721.498102623312;7754.185810489817;7770.184130666312;7841.490303130278;5407.83776486706;5458.972705136449;5468.7539060741565;5498.45015498463;5586.13414920688;8847.601857916537;9033.367664263438;9033.95483022607;9101.908980910372;9171.174594286545;8705.91294087051;9175.357724959189;9250.121238482334;9266.305027122859;9379.671711490066;6311.400416960381;6754.2570317266045;6781.932180678327;6950;7011.368976792113;7407.296306850841;7411.777646670608;7432.777016689508;7489.737859174903;7506.774796755888;6377.1390862233;6411.781761465307;6492.188476440445;6563.0811686362995;6597.406233439014;6372;6385.265694445198;6424.38968298011;6536.901946470712;6553.04980777775;5964.701764911651;6202.255729312511;6213.409726076015;6263.874722505433;6265.060240963892;4681.695689780154;4737.644676649196;4820.39745031871;4886.682365646222;4934.111859865258;4753.83361582343;4786.593139583175;4922.753862306942;4948.678335908155;4981.800727970841 05:25:26 INFO - PROCESS | 8796 | |4;prototype.html;319.8209002958342;321.758680989258;323.409777156689;326.70759670095265;329.2279604327853;5470.261514695515;5587.413321601224;5600.215969764231;5604.99110160171;5665.631733937291;5505.807296744605;5518.862028449291;5519.199716041182;5555.666660000403;5606.691631960251;4069.409935559342;4095.385692146187;4244.639205667522;4256.702030857841;4258.510271318792;4246.660267178634;4257.5742425757335;4258.680598955075;4270.295401258789;4295.613394794468;4240.469941257343;4241.639460645849;4248.408470832789;4262.7655478948645;4268.914621707564;4022.718409711336;4260.637845783112;4272.380504826782;4276.935845962297;4284.892877678052;3692.981535092334;3701.1117331840433;3704.148045949447;3708.647678470541;3725.124595720031;5282.735863206863;5333.173358129496;5360.088784906575;5388.137897936312;5389.865253368658;4603.332516785047;4837.685550439211;4893.7063776173545;4894.632902532324;4920.532549407836;5809.925163844702;5852.268466441695;5853.76584936602;5855.912161317541;5859.589828711992;4072.5927407259333;4083.1629515949458;4092.570280120604;4095.85664501744;4104.979475102636;5960.195373624549;6057.546693589104;6129.264488261392;6142.815715528542;6151.292601350812;4126.66986641068;4170.457840480718;4180.122174343361;4182.330827067654;4189.141226048653;4217.198732240864;4232.328230348995;4232.894177645522;4233.682473814476;4241.597048280409;4687.148576312337;4859.2954021666665;4868.659193856396;4884.731339776346;4934.5312195341385;5832.970835145882;5857.648541087548;5874.73563689635;5876.353601103875;5961.314448838352;1522.5660686704236;1528.0678785940568;1531.1425601662881;1534.907905525672;1535.5470136309816;902.4134312696668;929.2287401456774;994.22450488619;1006.2453160129902;1020.9336393134571;5919.200907877467;5926.762929482858;5934.762609495659;5960.910586341209;5985.970070149621;6252.74989000444;6257.5932564383165;6274.560780745304;6286.396968772933;6302.684865756693;5801.216835727208;5899.646021238739;5901.554119240814;5948.791792287336;5956.7319470623925;3363.344147891187;3381.526586277923;3387.3394688035596;3389.3560223557447;3401.4727717203873;6007.759689612367;6256.6871656417;6289.937100628935;6505.316941721146;6543.411093001558;6084.482818960438;6130.141780150782;6148.954677704712;6165.136880836686;6172.197614310111;6181.412765787243;6201.255849298113;6270.2789179244055;6303.7793677222;6321.273053598895;5998.280206375263;6059.515238780798;6084.239470066242;6086.239220097488;6126.877462450815;5983.012802887475;5999.430054145024;6000.339962604023;6010.819675409744;6046.606970546901;6111.358307377662;6112.530437906621;6222.844428889314;6238;6278.874422511615;4122.1961717466;4152.8338866445;4170.520390155171;4187.476565429321;4195.1819395217635;5879.059910229528;6051.304100028553;6057.697115144313;6071.939280607137;6093.2078829751845;5849;5878.265216847894;5923.378045305353;5925.377835327401;5939.168516407793;5813.273340832396;5837.211976383303;5855.853603659943;5882.970480166039;5884.323302820059;5566.4990150886615;5716.170825336019;5724.570657200643;5827.5629327801435;5837.532997360286;5923.940760592339;5924.585279030426;5935.821925342247;5980;5981.192539007178;5597.552195824405;5794.681292528951;5802.20131759156;5822.912656310074;5835.482774478582 05:25:26 INFO - PROCESS | 8796 | |5;yui.html;649.896016637338;736.296836521122;737.4874462248736;740.2671355358191;752.9698812047517;13274;13800.309984500773;13899.513517026906;14100.717985640295;14298.213598252092;13974.93012534936;14095.224762638076;14141.36363863626;14176.149431034119;14222.928885355584;644.2494493914584;780.5394817057935;806.4919100966383;807.9757607271777;816.6896579299887;807.9596020198996;809.2756982500658;811.6956141446957;814.071957967917;815.0871024452622;830.9584520773938;836.7908022994252;838.4801423117675;843.8734189871507;844.4848642328175;827.2430725885807;835.8077642142281;836.45630340279;836.6235194162651;838.287455662688;610.3408319015452;611.5107913669092;612.2561088277764;612.6018088242633;612.9785457508966;13633.386497607631;13661.726765464635;13695.109817861807;13744;13764.518241861486;12566.748665026647;12759.553415630407;12816.615501534969;12851.293178875158;12957.740845183043;10127;10228.181745460346;10316.948415257875;10442.947785261102;10575.947120264349;3497.702695270905;3547.5033495310677;3587.246678197582;3594.6944509716704;3605.873794417209;53128.46871531312;54059.18911216335;55066.898662026935;55146.44853551453;55406.722966385314;9529.714108576754;9624.711258662252;9639.558716247406;9777.560009799576;9849.458279794537;16591.917040414963;16621.252043657823;16653.666926661397;16721.832781672027;16732.832671673128;7758.107817600935;7810.062792464941;7839.294463498312;7865.095514015847;7954.960225198837;4417.955820441819;4492.168948744427;4558.954410455919;4590.403247577793;4642.675012749142;2976.776741744378;3081.352915887644;3085.182426656938;3091.5671805947186;3093.0566177315686;564.8531381840669;577.971101444926;584.4914924016133;587.1105275507609;587.9382664820217;625.5527297981873;646.3762469217228;698.183125742882;713.6146480900255;753.0210726056105;8141.389395795339;8447.45091569046;8549.529775862387;8719.91280087191;8852.24755895756;637.3276193615687;646.7897933171644;664.5414663881907;751.8721817291074;762.561527121896;4101.85643502476;4173.9582604174175;4192.24539582878;4283.593058659422;4292.871213863589;66858.66570667115;67503.3249667497;68680;69136.65431672809;69286.65356673184;59896;60284;60321.396786032456;60897.69551152216;62503;54440.45559544433;54493.182602261;54525.45474545283;54727;55185.172222416695;8214.83570328602;8525.74422767318;8559.700410485602;8632.827343453222;8759.16787905148;36271.818640906626;36389.27221455609;36718.082047949014;36742.44886326654;37540.43689344607;45253.547464524934;47428.52571474379;47556.28665570088;47817.5218247827;49126;11121.88878111241;11193.440327983406;11249;11437.485313161094;11491.770164596828;12128.272303661808;12270.141090123605;12309.199902006341;12385.876141238472;12694;11340.716482088013;11505.309681419141;11534.480948357512;11650.184487085822;11718.472668729757;11289.887101128883;11367.317960922372;11376.374299413612;11580.305181689126;12122.090843186972;11560.183463493244;11677.591284305008;11802.114841387101;11816.763664726486;11931;9996.700098997042;10063.446510441996;10360.637377691744;10676.679699609023;10753.354798712102;9443.244540436886;10084.949575252076;10122.949385253027;10127.392356458342;10220.284580079324 05:25:26 INFO - PROCESS | 8796 | __end_tp_report 05:25:26 INFO - PROCESS | 8796 | __start_cc_report 05:25:26 INFO - PROCESS | 8796 | _x_x_mozilla_cycle_collect,332 05:25:26 INFO - PROCESS | 8796 | __end_cc_report 05:25:26 INFO - PROCESS | 8796 | __startTimestamp1461673526486__endTimestamp 05:25:26 INFO - PROCESS | 8796 | 05:25:26 INFO - PROCESS | 8796 | ------- Summary: start ------- 05:25:26 INFO - PROCESS | 8796 | Number of tests: 6 05:25:26 INFO - PROCESS | 8796 | 05:25:26 INFO - PROCESS | 8796 | [#0] dojo.html Cycles:165 Average:5321.56 Median:5554.58 stddev:704.37 (12.7%) stddev-sans-first:684.43 05:25:26 INFO - PROCESS | 8796 | Values: 3089.8 3126.3 3139.0 3212.3 3214.0 5341.6 5347.1 5359.9 5384.3 5415.7 5270.8 5413.1 5425.5 5460.3 5529.2 4824.7 4851.8 4900.9 4922.8 4977.3 800.6 4830.4 4949.4 4980.3 4988.2 4904.1 4907.0 4914.2 4925.6 4951.1 4805.7 4926.0 4967.8 5010.2 5055.7 4787.0 4814.8 4857.3 4903.0 4907.2 5237.9 5256.9 5267.4 5282.3 5324.2 5724.5 5733.3 5740.1 5828.3 5895.9 5687.6 5708.7 5743.1 5757.5 5785.9 5355.8 5356.1 5364.3 5364.4 5366.9 5749.5 5831.0 5856.1 5858.1 5877.5 5647.4 5655.1 5665.8 5684.7 5685.7 5729.9 5732.3 5739.4 5740.9 5753.3 5485.7 5554.6 5720.2 5805.9 5814.1 5589.4 5636.0 5678.0 5705.5 5766.4 4301.3 4305.1 4329.7 4330.4 4340.5 3854.9 3879.9 3882.0 3929.6 3930.5 5505.0 5529.9 5532.6 5548.4 5552.4 5751.1 5795.1 5804.3 5815.0 5865.4 5338.4 5536.5 5565.1 5580.5 5597.1 4898.7 4927.2 4948.1 4963.4 4965.2 5754.8 5947.9 5952.0 5953.0 5954.6 5731.9 5782.2 5825.3 5844.8 5875.3 5980.3 6026.5 6030.2 6039.3 6040.9 5496.4 5749.7 5755.0 5755.7 5756.5 5868.1 5905.1 5906.8 5942.3 5964.0 5552.6 5560.1 5560.3 5563.1 5573.0 5470.0 5510.3 5558.2 5573.4 5611.6 5447.4 5532.5 5543.5 5602.6 5619.9 5558.2 5608.3 5635.8 5642.4 5655.6 5398.9 5534.6 5538.8 5559.8 5569.3 05:25:26 INFO - PROCESS | 8796 | 05:25:26 INFO - PROCESS | 8796 | [#1] ext.html Cycles:180 Average:56909.59 Median:40263.60 stddev:112856.71 (280.3%) stddev-sans-first:113094.13 05:25:26 INFO - PROCESS | 8796 | Values: 605.7 648.2 655.6 665.5 673.4 31335.4 38688.4 39554.4 39595.2 39709.0 42415.0 42566.8 42729.6 43020.4 43030.0 8533.5 8631.2 8717.5 8784.5 8837.0 8586.7 8658.7 8679.8 8683.0 8892.0 8936.4 8971.2 8999.5 9008.6 9063.1 8882.5 8929.1 8941.4 8961.2 8998.1 8641.0 8842.0 8844.2 8849.9 8850.5 41888.8 42283.4 42411.2 42437.0 42444.4 3341.5 3357.2 3559.0 3805.1 3900.3 31946.8 32237.2 32812.3 32869.0 32882.5 3947.0 3988.1 4059.4 4118.2 4139.9 320755.0 323299.0 324251.0 329121.0 329612.0 31823.8 32595.0 32604.2 59092.0 59402.4 33438.0 33527.5 33527.5 33535.0 33636.2 14096.4 14187.7 14201.7 14212.8 14241.3 12929.5 12975.9 13008.3 13042.9 13051.3 7943.9 7945.8 7976.5 8020.8 8075.5 3084.3 3098.5 3111.6 3112.5 3125.9 992.4 1043.0 1063.5 1075.8 1076.7 30994.7 31325.4 31386.5 31763.8 31820.7 1139.8 1191.3 1237.2 1252.4 1303.2 16859.6 16864.3 16942.2 17286.7 17433.5 490217.0 493817.0 497674.0 499709.0 501831.0 57547.0 57770.4 58418.0 58426.7 58636.0 1358.2 1418.6 1425.1 1432.0 1518.7 30573.4 31417.8 31440.2 31545.7 32221.4 49390.3 50653.7 51069.0 51128.5 51305.7 332781.0 455814.0 456117.0 460199.0 461709.0 43083.0 43939.0 44096.6 44218.0 45180.3 48630.8 48992.5 49166.3 50075.5 50258.7 40382.6 41367.4 41537.8 41753.0 42370.0 36545.8 36866.4 37808.4 40144.6 41958.0 39677.8 39976.0 40446.4 40626.4 40859.6 34924.0 35227.0 36160.3 36509.3 36961.4 27821.3 28163.6 28179.2 28231.6 28264.7 05:25:26 INFO - PROCESS | 8796 | 05:25:26 INFO - PROCESS | 8796 | [#2] jquery.html Cycles:180 Average:28983.37 Median:2209.91 stddev:83721.51 (3788.5%) stddev-sans-first:83928.84 05:25:26 INFO - PROCESS | 8796 | Values: 388.9 389.4 396.9 399.6 402.0 13731.9 18079.8 18619.6 18688.3 18718.5 17343.2 17354.4 17552.3 17833.7 17856.5 5514.4 5584.3 5588.7 5707.2 5717.2 5226.5 5559.1 5560.0 5599.2 5599.4 5511.0 5524.6 5533.4 5561.3 5564.6 5427.8 5790.5 5837.4 5837.7 5853.6 5453.3 5579.4 5618.8 5646.6 5673.0 13234.5 13275.3 13464.1 13541.6 15402.9 2167.6 2252.2 2351.8 2433.7 2652.4 9834.3 10129.4 10147.9 10246.9 14025.2 1896.8 1902.2 1937.7 1976.4 2014.7 82596.0 82969.6 84570.0 85212.6 85505.0 10255.8 10744.6 10877.6 11154.4 11485.4 12778.9 14057.2 14742.6 14953.1 14979.4 7709.4 7775.5 7913.3 8025.1 8292.4 7822.1 7852.3 7953.6 8046.4 8121.5 4524.8 4616.3 4661.8 4662.7 4708.4 1891.5 1944.7 1963.7 1980.7 2045.5 896.7 951.7 1029.4 1072.8 1074.8 18008.9 18080.4 18412.4 18540.6 18635.0 996.5 998.8 1028.1 1036.7 1072.1 10089.9 10351.8 10352.3 10482.2 10582.3 488300.0 505932.0 512372.0 513538.0 515445.5 92907.0 95672.0 95678.0 95897.0 96423.5 1036.4 1047.3 1077.7 1099.0 1108.8 16284.4 16719.7 16723.6 16859.7 17006.4 31974.5 39054.6 40565.8 41027.0 42809.1 53480.7 55426.2 56376.4 56606.7 56805.1 8090.0 8163.5 8222.4 8448.1 8488.4 12098.3 12953.8 13260.6 13301.5 13336.3 10528.9 10607.9 10778.6 10802.4 11173.8 10778.5 10789.4 10986.2 11142.2 11431.8 10733.3 10767.9 10830.7 10861.9 11101.3 8299.5 8358.7 8400.3 8527.7 8631.1 10669.8 10732.2 10771.3 10905.3 10979.3 05:25:26 INFO - PROCESS | 8796 | 05:25:26 INFO - PROCESS | 8796 | [#3] mootools.html Cycles:180 Average:5199.09 Median:4790.91 stddev:2866.43 (59.8%) stddev-sans-first:2860.94 05:25:26 INFO - PROCESS | 8796 | Values: 1492.3 1519.1 1660.9 1770.2 1775.5 6885.2 7415.1 7547.1 7840.9 7846.9 7558.2 7563.8 7639.9 7658.4 7658.5 2175.1 2200.8 2202.5 2208.8 2209.9 2154.9 2154.9 2204.8 2205.1 2206.8 2191.2 2193.3 2199.6 2201.1 2230.3 2154.2 2156.5 2162.9 2169.4 2177.0 2159.6 2162.0 2174.2 2196.2 2198.8 7470.1 7564.3 7577.4 7614.7 7625.5 4575.9 4723.9 4738.9 4754.3 4783.6 3072.9 3145.2 3182.5 3189.1 3223.9 1064.7 1075.8 1083.5 1092.7 1096.2 10466.9 10475.4 10489.5 10524.6 10565.1 4286.1 4298.3 4383.3 4408.8 4415.1 9024.5 9052.5 9059.9 9091.0 9095.9 4760.4 4784.0 4795.2 4797.3 4797.3 3991.1 4324.2 4377.1 4453.4 4623.2 3680.4 3721.0 3781.9 3804.8 3874.4 1159.8 1185.3 1187.9 1201.4 1207.6 974.7 976.2 977.2 1008.5 1015.8 5216.3 5355.6 5371.2 5513.4 5749.3 429.2 432.8 444.3 450.1 462.0 3794.5 3815.0 3840.8 3890.3 3893.4 9684.6 9744.3 10014.3 10134.3 10151.5 9598.0 9618.8 9786.5 9931.0 9966.5 7707.7 7721.5 7754.2 7770.2 7841.5 5407.8 5459.0 5468.8 5498.5 5586.1 8847.6 9033.4 9034.0 9101.9 9171.2 8705.9 9175.4 9250.1 9266.3 9379.7 6311.4 6754.3 6781.9 6950.0 7011.4 7407.3 7411.8 7432.8 7489.7 7506.8 6377.1 6411.8 6492.2 6563.1 6597.4 6372.0 6385.3 6424.4 6536.9 6553.0 5964.7 6202.3 6213.4 6263.9 6265.1 4681.7 4737.6 4820.4 4886.7 4934.1 4753.8 4786.6 4922.8 4948.7 4981.8 05:25:26 INFO - PROCESS | 8796 | 05:25:26 INFO - PROCESS | 8796 | [#4] prototype.html Cycles:180 Average:4939.50 Median:5759.63 stddev:1487.94 (25.8%) stddev-sans-first:1451.15 05:25:26 INFO - PROCESS | 8796 | Values: 319.8 321.8 323.4 326.7 329.2 5470.3 5587.4 5600.2 5605.0 5665.6 5505.8 5518.9 5519.2 5555.7 5606.7 4069.4 4095.4 4244.6 4256.7 4258.5 4246.7 4257.6 4258.7 4270.3 4295.6 4240.5 4241.6 4248.4 4262.8 4268.9 4022.7 4260.6 4272.4 4276.9 4284.9 3693.0 3701.1 3704.1 3708.6 3725.1 5282.7 5333.2 5360.1 5388.1 5389.9 4603.3 4837.7 4893.7 4894.6 4920.5 5809.9 5852.3 5853.8 5855.9 5859.6 4072.6 4083.2 4092.6 4095.9 4105.0 5960.2 6057.5 6129.3 6142.8 6151.3 4126.7 4170.5 4180.1 4182.3 4189.1 4217.2 4232.3 4232.9 4233.7 4241.6 4687.1 4859.3 4868.7 4884.7 4934.5 5833.0 5857.6 5874.7 5876.4 5961.3 1522.6 1528.1 1531.1 1534.9 1535.5 902.4 929.2 994.2 1006.2 1020.9 5919.2 5926.8 5934.8 5960.9 5986.0 6252.7 6257.6 6274.6 6286.4 6302.7 5801.2 5899.6 5901.6 5948.8 5956.7 3363.3 3381.5 3387.3 3389.4 3401.5 6007.8 6256.7 6289.9 6505.3 6543.4 6084.5 6130.1 6149.0 6165.1 6172.2 6181.4 6201.3 6270.3 6303.8 6321.3 5998.3 6059.5 6084.2 6086.2 6126.9 5983.0 5999.4 6000.3 6010.8 6046.6 6111.4 6112.5 6222.8 6238.0 6278.9 4122.2 4152.8 4170.5 4187.5 4195.2 5879.1 6051.3 6057.7 6071.9 6093.2 5849.0 5878.3 5923.4 5925.4 5939.2 5813.3 5837.2 5855.9 5883.0 5884.3 5566.5 5716.2 5724.6 5827.6 5837.5 5923.9 5924.6 5935.8 5980.0 5981.2 5597.6 5794.7 5802.2 5822.9 5835.5 05:25:26 INFO - PROCESS | 8796 | 05:25:26 INFO - PROCESS | 8796 | [#5] yui.html Cycles:180 Average:14983.12 Median:47686.90 stddev:18486.20 (38.8%) stddev-sans-first:18506.72 05:25:26 INFO - PROCESS | 8796 | Values: 649.9 736.3 737.5 740.3 753.0 13274.0 13800.3 13899.5 14100.7 14298.2 13974.9 14095.2 14141.4 14176.1 14222.9 644.2 780.5 806.5 808.0 816.7 808.0 809.3 811.7 814.1 815.1 831.0 836.8 838.5 843.9 844.5 827.2 835.8 836.5 836.6 838.3 610.3 611.5 612.3 612.6 613.0 13633.4 13661.7 13695.1 13744.0 13764.5 12566.7 12759.6 12816.6 12851.3 12957.7 10127.0 10228.2 10316.9 10442.9 10575.9 3497.7 3547.5 3587.2 3594.7 3605.9 53128.5 54059.2 55066.9 55146.4 55406.7 9529.7 9624.7 9639.6 9777.6 9849.5 16591.9 16621.3 16653.7 16721.8 16732.8 7758.1 7810.1 7839.3 7865.1 7955.0 4418.0 4492.2 4559.0 4590.4 4642.7 2976.8 3081.4 3085.2 3091.6 3093.1 564.9 578.0 584.5 587.1 587.9 625.6 646.4 698.2 713.6 753.0 8141.4 8447.5 8549.5 8719.9 8852.2 637.3 646.8 664.5 751.9 762.6 4101.9 4174.0 4192.2 4283.6 4292.9 66858.7 67503.3 68680.0 69136.7 69286.7 59896.0 60284.0 60321.4 60897.7 62503.0 54440.5 54493.2 54525.5 54727.0 55185.2 8214.8 8525.7 8559.7 8632.8 8759.2 36271.8 36389.3 36718.1 36742.4 37540.4 45253.5 47428.5 47556.3 47817.5 49126.0 11121.9 11193.4 11249.0 11437.5 11491.8 12128.3 12270.1 12309.2 12385.9 12694.0 11340.7 11505.3 11534.5 11650.2 11718.5 11289.9 11367.3 11376.4 11580.3 12122.1 11560.2 11677.6 11802.1 11816.8 11931.0 9996.7 10063.4 10360.6 10676.7 10753.4 9443.2 10084.9 10122.9 10127.4 10220.3 05:25:26 INFO - PROCESS | 8796 | -------- Summary: end -------- 05:25:26 INFO - PROCESS | 8796 | 05:25:27 INFO - TEST-INFO | 8796: exit 0 05:25:27 INFO - TEST-OK | dromaeo_css | took 1109717ms 05:25:27 INFO - TEST-START | kraken 05:25:27 INFO - operating with platform_type : linux_ 05:25:27 INFO - Initialising browser for kraken test... 05:25:27 INFO - TEST-INFO | started process 9033 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl4eejC/profile http://localhost:33907/getInfo.html) 05:25:30 INFO - PROCESS | 9033 | 05:25:30 INFO - PROCESS | 9033 | (process:9101): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:25:31 INFO - PROCESS | 9033 | __metrics Screen width/height:1600/1200 05:25:31 INFO - PROCESS | 9033 | colorDepth:24 05:25:31 INFO - PROCESS | 9033 | Browser inner width/height: 1024/697 05:25:31 INFO - PROCESS | 9033 | __metrics 05:25:32 ERROR - PROCESS | 9033 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:25:33 INFO - TEST-INFO | 9033: exit 0 05:25:33 INFO - Browser initialized. 05:25:33 INFO - Running cycle 1/1 for kraken test... 05:25:33 INFO - TEST-INFO | started process 9152 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl4eejC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:25:35 INFO - PROCESS | 9152 | 05:25:35 INFO - PROCESS | 9152 | (process:9214): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:25:45 INFO - PROCESS | 9152 | RSS: Main: 164634624 05:25:45 INFO - PROCESS | 9152 | 05:25:47 INFO - PROCESS | 9152 | Cycle 1(1): loaded http://localhost:33907/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33907/tests/kraken/driver.html?testName=audio-beat-detection) 05:25:48 INFO - PROCESS | 9152 | RSS: Main: 169226240 05:25:48 INFO - PROCESS | 9152 | 05:25:51 INFO - PROCESS | 9152 | Cycle 1(1): loaded http://localhost:33907/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33907/tests/kraken/driver.html?testName=audio-dft) 05:25:51 INFO - PROCESS | 9152 | RSS: Main: 173015040 05:25:51 INFO - PROCESS | 9152 | 05:25:54 INFO - PROCESS | 9152 | Cycle 1(1): loaded http://localhost:33907/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33907/tests/kraken/driver.html?testName=audio-fft) 05:25:55 INFO - PROCESS | 9152 | RSS: Main: 164241408 05:25:55 INFO - PROCESS | 9152 | 05:25:57 INFO - PROCESS | 9152 | Cycle 1(1): loaded http://localhost:33907/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33907/tests/kraken/driver.html?testName=audio-oscillator) 05:25:58 INFO - PROCESS | 9152 | RSS: Main: 164765696 05:25:58 INFO - PROCESS | 9152 | 05:26:00 INFO - PROCESS | 9152 | Cycle 1(1): loaded http://localhost:33907/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33907/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:26:01 INFO - PROCESS | 9152 | RSS: Main: 165085184 05:26:01 INFO - PROCESS | 9152 | 05:26:04 INFO - PROCESS | 9152 | Cycle 1(1): loaded http://localhost:33907/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33907/tests/kraken/driver.html?testName=imaging-darkroom) 05:26:04 INFO - PROCESS | 9152 | RSS: Main: 165412864 05:26:04 INFO - PROCESS | 9152 | 05:26:08 INFO - PROCESS | 9152 | Cycle 1(1): loaded http://localhost:33907/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33907/tests/kraken/driver.html?testName=imaging-desaturate) 05:26:08 INFO - PROCESS | 9152 | RSS: Main: 167669760 05:26:08 INFO - PROCESS | 9152 | 05:26:11 INFO - PROCESS | 9152 | Cycle 1(1): loaded http://localhost:33907/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33907/tests/kraken/driver.html?testName=json-parse-financial) 05:26:12 INFO - PROCESS | 9152 | RSS: Main: 168488960 05:26:12 INFO - PROCESS | 9152 | 05:26:13 INFO - PROCESS | 9152 | Cycle 1(1): loaded http://localhost:33907/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33907/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:26:14 INFO - PROCESS | 9152 | RSS: Main: 167845888 05:26:14 INFO - PROCESS | 9152 | 05:26:16 INFO - PROCESS | 9152 | Cycle 1(1): loaded http://localhost:33907/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33907/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:26:16 INFO - PROCESS | 9152 | RSS: Main: 167968768 05:26:16 INFO - PROCESS | 9152 | 05:26:18 INFO - PROCESS | 9152 | Cycle 1(1): loaded http://localhost:33907/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33907/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:26:19 INFO - PROCESS | 9152 | RSS: Main: 168665088 05:26:19 INFO - PROCESS | 9152 | 05:26:22 INFO - PROCESS | 9152 | Cycle 1(1): loaded http://localhost:33907/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33907/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:26:22 INFO - PROCESS | 9152 | RSS: Main: 168763392 05:26:22 INFO - PROCESS | 9152 | 05:26:25 INFO - PROCESS | 9152 | Cycle 1(1): loaded http://localhost:33907/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33907/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:26:26 INFO - PROCESS | 9152 | RSS: Main: 168173568 05:26:26 INFO - PROCESS | 9152 | 05:26:27 INFO - PROCESS | 9152 | Cycle 1(1): loaded http://localhost:33907/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33907/tests/kraken/driver.html?testName=ai-astar) 05:26:28 INFO - PROCESS | 9152 | RSS: Main: 169664512 05:26:28 INFO - PROCESS | 9152 | 05:26:28 INFO - PROCESS | 9152 | __start_tp_report 05:26:28 INFO - PROCESS | 9152 | _x_x_mozilla_page_load 05:26:28 INFO - PROCESS | 9152 | _x_x_mozilla_page_load_details 05:26:28 INFO - PROCESS | 9152 | |i|pagename|runs| 05:26:28 INFO - PROCESS | 9152 | |0;ai-astar;112;108;116;112;111;125;113;111;111;111 05:26:28 INFO - PROCESS | 9152 | |1;audio-beat-detection;153;127;156;186;130;158;163;130;179;136 05:26:28 INFO - PROCESS | 9152 | |2;audio-dft;163;164;160;163;163;166;169;163;164;163 05:26:28 INFO - PROCESS | 9152 | |3;audio-fft;80;76;77;159;73;76;77;76;164;77 05:26:28 INFO - PROCESS | 9152 | |4;audio-oscillator;93;92;156;93;94;93;146;93;92;140 05:26:28 INFO - PROCESS | 9152 | |5;imaging-gaussian-blur;118;117;117;117;119;118;117;117;118;118 05:26:28 INFO - PROCESS | 9152 | |6;imaging-darkroom;146;147;146;147;149;149;146;146;147;148 05:26:28 INFO - PROCESS | 9152 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;96 05:26:28 INFO - PROCESS | 9152 | |8;json-parse-financial;58;60;62;58;58;58;60;85;58;57 05:26:28 INFO - PROCESS | 9152 | |9;json-stringify-tinderbox;61;61;61;61;61;62;61;61;61;61 05:26:28 INFO - PROCESS | 9152 | |10;stanford-crypto-aes;78;78;79;77;86;78;77;79;79;79 05:26:28 INFO - PROCESS | 9152 | |11;stanford-crypto-ccm;126;132;128;127;142;126;122;126;169;125 05:26:28 INFO - PROCESS | 9152 | |12;stanford-crypto-pbkdf2;176;170;175;179;175;171;171;168;177;172 05:26:28 INFO - PROCESS | 9152 | |13;stanford-crypto-sha256-iterative;72;69;69;70;69;67;70;69;70;68 05:26:28 INFO - PROCESS | 9152 | __end_tp_report 05:26:28 INFO - PROCESS | 9152 | __start_cc_report 05:26:28 INFO - PROCESS | 9152 | _x_x_mozilla_cycle_collect,858 05:26:28 INFO - PROCESS | 9152 | __end_cc_report 05:26:28 INFO - PROCESS | 9152 | __startTimestamp1461673588121__endTimestamp 05:26:28 INFO - PROCESS | 9152 | 05:26:28 INFO - PROCESS | 9152 | ------- Summary: start ------- 05:26:28 INFO - PROCESS | 9152 | Number of tests: 14 05:26:28 INFO - PROCESS | 9152 | 05:26:28 INFO - PROCESS | 9152 | [#0] ai-astar Cycles:10 Average:113.00 Median:112.00 stddev:4.67 (4.2%) stddev-sans-first:4.94 05:26:28 INFO - PROCESS | 9152 | Values: 112.0 108.0 116.0 112.0 111.0 125.0 113.0 111.0 111.0 111.0 05:26:28 INFO - PROCESS | 9152 | 05:26:28 INFO - PROCESS | 9152 | [#1] audio-beat-detection Cycles:10 Average:151.80 Median:157.00 stddev:20.84 (13.3%) stddev-sans-first:22.10 05:26:28 INFO - PROCESS | 9152 | Values: 153.0 127.0 156.0 186.0 130.0 158.0 163.0 130.0 179.0 136.0 05:26:28 INFO - PROCESS | 9152 | 05:26:28 INFO - PROCESS | 9152 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.50 stddev:2.35 (1.4%) stddev-sans-first:2.47 05:26:28 INFO - PROCESS | 9152 | Values: 163.0 164.0 160.0 163.0 163.0 166.0 169.0 163.0 164.0 163.0 05:26:28 INFO - PROCESS | 9152 | 05:26:28 INFO - PROCESS | 9152 | [#3] audio-fft Cycles:10 Average:93.50 Median:76.50 stddev:35.90 (46.9%) stddev-sans-first:37.74 05:26:28 INFO - PROCESS | 9152 | Values: 80.0 76.0 77.0 159.0 73.0 76.0 77.0 76.0 164.0 77.0 05:26:28 INFO - PROCESS | 9152 | 05:26:28 INFO - PROCESS | 9152 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:93.00 stddev:26.59 (28.6%) stddev-sans-first:27.55 05:26:28 INFO - PROCESS | 9152 | Values: 93.0 92.0 156.0 93.0 94.0 93.0 146.0 93.0 92.0 140.0 05:26:28 INFO - PROCESS | 9152 | 05:26:28 INFO - PROCESS | 9152 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 05:26:28 INFO - PROCESS | 9152 | Values: 118.0 117.0 117.0 117.0 119.0 118.0 117.0 117.0 118.0 118.0 05:26:28 INFO - PROCESS | 9152 | 05:26:28 INFO - PROCESS | 9152 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:1.20 (0.8%) stddev-sans-first:1.20 05:26:28 INFO - PROCESS | 9152 | Values: 146.0 147.0 146.0 147.0 149.0 149.0 146.0 146.0 147.0 148.0 05:26:28 INFO - PROCESS | 9152 | 05:26:28 INFO - PROCESS | 9152 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 05:26:28 INFO - PROCESS | 9152 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 05:26:28 INFO - PROCESS | 9152 | 05:26:28 INFO - PROCESS | 9152 | [#8] json-parse-financial Cycles:10 Average:61.40 Median:59.00 stddev:8.42 (14.3%) stddev-sans-first:8.84 05:26:28 INFO - PROCESS | 9152 | Values: 58.0 60.0 62.0 58.0 58.0 58.0 60.0 85.0 58.0 57.0 05:26:28 INFO - PROCESS | 9152 | 05:26:28 INFO - PROCESS | 9152 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 05:26:28 INFO - PROCESS | 9152 | Values: 61.0 61.0 61.0 61.0 61.0 62.0 61.0 61.0 61.0 61.0 05:26:28 INFO - PROCESS | 9152 | 05:26:28 INFO - PROCESS | 9152 | [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:79.00 stddev:2.58 (3.3%) stddev-sans-first:2.71 05:26:28 INFO - PROCESS | 9152 | Values: 78.0 78.0 79.0 77.0 86.0 78.0 77.0 79.0 79.0 79.0 05:26:28 INFO - PROCESS | 9152 | 05:26:28 INFO - PROCESS | 9152 | [#11] stanford-crypto-ccm Cycles:10 Average:132.30 Median:127.50 stddev:14.01 (11.0%) stddev-sans-first:14.67 05:26:28 INFO - PROCESS | 9152 | Values: 126.0 132.0 128.0 127.0 142.0 126.0 122.0 126.0 169.0 125.0 05:26:28 INFO - PROCESS | 9152 | 05:26:28 INFO - PROCESS | 9152 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.40 Median:175.00 stddev:3.50 (2.0%) stddev-sans-first:3.59 05:26:28 INFO - PROCESS | 9152 | Values: 176.0 170.0 175.0 179.0 175.0 171.0 171.0 168.0 177.0 172.0 05:26:28 INFO - PROCESS | 9152 | 05:26:28 INFO - PROCESS | 9152 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.50 stddev:1.34 (1.9%) stddev-sans-first:1.00 05:26:28 INFO - PROCESS | 9152 | Values: 72.0 69.0 69.0 70.0 69.0 67.0 70.0 69.0 70.0 68.0 05:26:28 INFO - PROCESS | 9152 | -------- Summary: end -------- 05:26:28 INFO - PROCESS | 9152 | 05:26:29 INFO - TEST-INFO | 9152: exit 0 05:26:29 INFO - TEST-OK | kraken | took 61859ms 05:26:29 INFO - SUITE-END | took 1171s 05:26:29 INFO - Completed test suite (00:19:31) 05:26:29 INFO - javascript benchmark 05:26:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3089.8300593467357, 3126.3434678717467, 3138.9843050784743, 3212.2611799286165, 3213.983930080349, 5341.572674186065, 5347.11772557528, 5359.866003349918, 5384.2731231283815, 5415.702136382497, 5270.8418747437545, 5413.052715774734, 5425.538829199523, 5460.290162278899, 5529.170624406341, 4824.6863953842885, 4851.805927762885, 4900.901981960359, 4922.778474968617, 4977.303177555127, 800.5615000341515, 4830.372051633282, 4949.406071271453, 4980.27785971034, 4988.176950803131, 4904.117258893398, 4906.950930490685, 4914.213725803872, 4925.556699897026, 4951.084049450845, 4805.711657300538, 4925.975370123127, 4967.82612608557, 5010.248462730619, 5055.74721263939, 4786.976065119687, 4814.831480898151, 4857.319975203474, 4902.950970490285, 4907.214845624683, 5237.895242095175, 5256.894862102737, 5267.3679158500845, 5282.313299271109, 5324.174752913266, 5724.456176663252, 5733.31200255972, 5740.138979153118, 5828.300603927513, 5895.911561326584, 5687.573431992576, 5708.71456427177, 5743.10981797822, 5757.539396848242, 5785.88428231433, 5355.7857685692525, 5356.143017117242, 5364.275822763955, 5364.383095943977, 5366.892662146735, 5749.540036797046, 5831.037878750044, 5856.121581762684, 5858.062709966385, 5877.52979761618, 5647.407022262603, 5655.095184770417, 5665.801696940587, 5684.687342196136, 5685.687287199244, 5729.914051289234, 5732.34078081026, 5739.397363276796, 5740.856478588069, 5753.280839895013, 5485.670859748428, 5554.583406244547, 5720.170575266563, 5805.88388232233, 5814.098814683646, 5589.441055894378, 5636.0, 5678.0, 5705.5435565154685, 5766.394528574523, 4301.268784306675, 4305.07440900208, 4329.6969212154845, 4330.437043184366, 4340.47914250292, 3854.9036274093373, 3879.941800872989, 3881.9611803882162, 3929.587393323717, 3930.5479869814767, 5504.972475137599, 5529.944700553024, 5532.612717109844, 5548.361938377057, 5552.41699621542, 5751.051076572318, 5795.072788353843, 5804.2744656917885, 5815.0, 5865.35481097079, 5338.3593968724, 5536.529395001389, 5565.137403702352, 5580.525655319262, 5597.076482380443, 4898.706077635354, 4927.236278376858, 4948.109340318705, 4963.379577552806, 4965.155923493015, 5754.769809207585, 5947.881042379215, 5952.0, 5953.0, 5954.583179177416, 5731.914021289684, 5782.190493331022, 5825.271841019872, 5844.795432159854, 5875.3243377010485, 5980.3421623622235, 6026.517878569616, 6030.216071910623, 6039.335673075871, 6040.879182416415, 5496.395396506301, 5749.655020698771, 5754.964106460877, 5755.683437410982, 5756.481916627524, 5868.09044598088, 5905.084711869667, 5906.763729450774, 5942.346341902474, 5964.0, 5552.583556233218, 5560.054790685674, 5560.304961879765, 5563.05428077236, 5572.972135139298, 5470.0, 5510.256115424527, 5558.194061860927, 5573.414791446839, 5611.551075913835, 5447.428020057995, 5532.5020748132865, 5543.501084902378, 5602.635828671123, 5619.915701264403, 5558.194061860927, 5608.327000759935, 5635.830925072254, 5642.351129620146, 5655.632383895034, 5398.946010539844, 5534.557235421237, 5538.8061417851795, 5559.805406810742, 5569.33168019824], "value": 5276.17127772893, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.7213681706414, 648.2156590525465, 655.6197405504807, 665.5075244319203, 673.4343151752527, 31335.373292534136, 38688.419673704884, 39554.406683899695, 39595.20809583807, 39709.007274818105, 42415.0, 42566.787166064205, 42729.57270427295, 43020.354694679605, 43030.0, 8533.487990720545, 8631.223189912907, 8717.520536370497, 8784.51685157316, 8836.955815220916, 8586.699465518708, 8658.696945606906, 8679.826403471958, 8683.0, 8891.955540222321, 8936.374453788238, 8971.237444817165, 8999.460032398078, 9008.639654413815, 9063.093690630918, 8882.511461869595, 8929.06244844295, 8941.418807777507, 8961.238294744955, 8998.100189980982, 8641.0, 8842.0, 8844.159804818531, 8849.911500884973, 8850.468971861708, 41888.79055604733, 42283.36574951378, 42411.15177696429, 42437.0, 42444.363334550006, 3341.465365541526, 3357.17749151457, 3559.0, 3805.1058001369934, 3900.278448487039, 31946.840265798754, 32237.194070148198, 32812.343753124806, 32869.0, 32882.50676239858, 3946.960530394688, 3988.142549351903, 4059.3707975263883, 4118.19695159444, 4139.937900931488, 320755.0, 323299.0, 324251.0, 329121.0, 329612.0, 31823.84088079591, 32595.0, 32604.184895377806, 59092.0, 59402.40597594055, 33438.0, 33527.49708754371, 33527.49708754371, 33534.99395018153, 33636.1590960228, 14096.365663545164, 14187.716245675028, 14201.715965680629, 14212.786808197885, 14241.287935603179, 12929.54746583884, 12975.935120324339, 13008.349582520836, 13042.869571304354, 13051.28217948022, 7943.880841787378, 7945.841083178304, 7976.481528700616, 8020.759377218693, 8075.475094118863, 3084.259777653347, 3098.5352197170605, 3111.5643809866638, 3112.486439737463, 3125.9056432190487, 992.3648864726581, 1042.9634962776267, 1063.4948399510326, 1075.7687097274124, 1076.7039064257235, 30994.69005309918, 31325.373492530023, 31386.52920206199, 31763.84118079395, 31820.727170913367, 1139.7834411461795, 1191.2614179208947, 1237.1772771107294, 1252.4051075739133, 1303.1855090568395, 16859.578510537336, 16864.32542698303, 16942.152892355334, 17286.654266914844, 17433.47699569015, 490217.0, 493817.0, 497674.0, 499709.0, 501831.0, 57547.0, 57770.4222957765, 58418.0, 58426.7078664604, 58636.0, 1358.2325985817981, 1418.5673369622364, 1425.1306702911215, 1432.0262221689559, 1518.7038527487255, 30573.388532228786, 31417.8429107853, 31440.213994649403, 31545.684543154275, 32221.355572887944, 49390.25914611212, 50653.74673126611, 51069.0, 51128.48871511237, 51305.7434712824, 332781.0, 455814.0, 456117.0, 460199.0, 461709.0, 43083.0, 43939.0, 44096.55903441053, 44218.0, 45180.322295164944, 48630.75684621554, 48992.5100748988, 49166.262506063154, 50075.499245007086, 50258.748706256236, 40382.596174037884, 41367.37948930829, 41537.792311038254, 41753.0, 42370.0, 36545.817270913474, 36866.44700329444, 37808.43287350747, 40144.59855401408, 41958.0, 39677.80161099176, 39975.99099166184, 40446.393304099875, 40626.390604141554, 40859.59140408558, 34924.0, 35227.0, 36160.27679446449, 36509.26981460303, 36961.44557831688, 27821.30446738767, 28163.591820409307, 28179.154625361272, 28231.57652635253, 28264.717352827032], "value": 18759.793170495133, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.9455476233327, 389.3692218605858, 396.91069509360415, 399.56447472255235, 401.9658329042031, 13731.93134034331, 18079.81920180798, 18619.627607447845, 18688.252469901203, 18718.53203669909, 17343.219555120017, 17354.392596259135, 17552.297908083663, 17833.73249401257, 17856.464306070808, 5514.448555144483, 5584.329880414356, 5588.720563971806, 5707.172459993299, 5717.199592057094, 5226.503482169188, 5559.138333558285, 5559.972200138994, 5599.216109744619, 5599.440055994409, 5511.035568775468, 5524.58565607579, 5533.418991005947, 5561.277033985576, 5564.638298510604, 5427.810026649068, 5790.536757059446, 5837.357890632027, 5837.737301821428, 5853.619514731528, 5453.263809385722, 5579.414161513023, 5618.831435056954, 5646.632968857011, 5672.971635141839, 13234.536791212262, 13275.269860157687, 13464.124831885896, 13541.59375218745, 15402.922985385001, 2167.5881582499273, 2252.222983070838, 2351.753065928087, 2433.707955045406, 2652.4429869727383, 9834.262430317754, 10129.442880641562, 10147.949260253725, 10246.948765256126, 14025.158490490603, 1896.8387687046618, 1902.1630482587618, 1937.7480927479478, 1976.4367155360796, 2014.738084049079, 82596.0, 82969.58515207446, 84570.0, 85212.57393712991, 85505.0, 10255.794884102275, 10744.623938162284, 10877.564897404174, 11154.386508742096, 11485.368304743319, 12778.936105319413, 14057.156570605797, 14742.557723268319, 14953.102813831205, 14979.400823967137, 7709.38324934004, 7775.533467991939, 7913.287804097544, 8025.117237103914, 8292.419530632798, 7822.061352637606, 7852.254035866584, 7953.6023198840985, 8046.356291496666, 8121.512709237465, 4524.773761311922, 4616.30755386688, 4661.836835710734, 4662.743549104764, 4708.4349878014855, 1891.5176629959271, 1944.7374604428503, 1963.7250784890127, 1980.6731889238401, 2045.5499790046167, 896.6996056321075, 951.6716732727198, 1029.4132344563677, 1072.8015317166348, 1074.8495210670512, 18008.909955450137, 18080.367187148386, 18412.447626570956, 18540.629187416445, 18635.0, 996.5415908681942, 998.7802683409639, 1028.1466382902174, 1036.683811437519, 1072.120860894075, 10089.899101008896, 10351.792964140826, 10352.275340726228, 10482.161427085815, 10582.312149710244, 488300.0, 505932.0, 512372.0, 513538.0, 515445.4960427635, 92907.0, 95672.0, 95678.0, 95897.0, 96423.51788241154, 1036.362636978253, 1047.2512153810214, 1077.7305673581604, 1098.9780204395868, 1108.7948729485072, 16284.43004494837, 16719.74920376171, 16723.581910452336, 16859.74710379321, 17006.404775832787, 31974.52038219475, 39054.6094539051, 40565.79717101395, 41027.0, 42809.14381712286, 53480.73259633677, 55426.18070480772, 56376.43623563712, 56606.716966414904, 56805.147922780365, 8090.0, 8163.469374490639, 8222.424430289822, 8448.112948140357, 8488.40581159313, 12098.334591597546, 12953.805692914426, 13260.602181934557, 13301.46794128224, 13336.333183340988, 10528.947355263175, 10607.893921060999, 10778.568857245937, 10802.351858888493, 11173.832392513956, 10778.461076946278, 10789.40658263803, 10986.230963832775, 11142.220044596801, 11431.771364572496, 10733.302335348177, 10767.89232107669, 10830.67507974762, 10861.945690271497, 11101.278416902875, 8299.460535065202, 8358.749237522885, 8400.28597569189, 8527.74416767498, 8631.050584435581, 10669.786604268027, 10732.248742588255, 10771.29986550903, 10905.34567925927, 10979.286346387778], "value": 8924.894702981066, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1492.2837038221653, 1519.149276405213, 1660.8671306295498, 1770.1680210301154, 1775.5383600263945, 6885.20820105688, 7415.147258065324, 7547.09434867816, 7840.921590784091, 7846.882296765553, 7558.168601453835, 7563.810904727371, 7639.885401718965, 7658.38732901368, 7658.5021973571675, 2175.0647221694703, 2200.8129309008755, 2202.537467131904, 2208.8122509586706, 2209.9005544750526, 2154.881481518516, 2154.9440774020773, 2204.79054489824, 2205.106931692659, 2206.8455208135438, 2191.233068426054, 2193.287181665965, 2199.604071267171, 2201.086549082129, 2230.264012875747, 2154.2137119951103, 2156.536344685884, 2162.9026693798737, 2169.3600387885613, 2176.9564608707815, 2159.557290755407, 2162.0, 2174.239016344283, 2196.2203417786777, 2198.791114844103, 7470.103587569526, 7564.281393267631, 7577.43169262302, 7614.657340419639, 7625.542467451915, 4575.885602859922, 4723.858284251478, 4738.928916066262, 4754.310624959396, 4783.641226907996, 3072.9231769205726, 3145.1979745165067, 3182.5385319128827, 3189.0751682012187, 3223.871045158191, 1064.669952314785, 1075.7902209069234, 1083.5232497700986, 1092.6667366453228, 1096.2107282756483, 10466.895331046668, 10475.371477711285, 10489.475526223734, 10524.631637892637, 10565.101966332872, 4286.057067445157, 4298.333758267474, 4383.254846676073, 4408.823647054146, 4415.139047885631, 9024.503652299187, 9052.547372631474, 9059.864102038475, 9091.0, 9095.863562046574, 4760.428748550196, 4783.95216047842, 4795.232762757942, 4797.328374027639, 4797.328374027639, 3991.1419044904906, 4324.156789426094, 4377.080813029236, 4453.4433195850515, 4623.214053610895, 3680.4479328100997, 3720.9627903721157, 3781.9243615127543, 3804.8097595120685, 3874.4188371744463, 1159.7622487390065, 1185.3362117214388, 1187.9049676025897, 1201.39329638532, 1207.589419597341, 974.697843668465, 976.1507488484922, 977.2475194100502, 1008.4806324742764, 1015.7816069545083, 5216.347956505437, 5355.598330125256, 5371.248025276464, 5513.448655134454, 5749.338826034976, 429.15242396267746, 432.79009680305654, 444.27361264333047, 450.0526391944909, 461.98614041578804, 3794.5446546414605, 3814.9618503815163, 3840.807959602009, 3890.299746045739, 3893.4159876018257, 9684.56419461126, 9744.269179811543, 10014.29899907014, 10134.341267817568, 10151.543180556893, 9598.0, 9618.807623847484, 9786.461744603972, 9931.0, 9966.451845148442, 7707.691692332356, 7721.498102623312, 7754.185810489817, 7770.184130666312, 7841.490303130278, 5407.83776486706, 5458.972705136449, 5468.7539060741565, 5498.45015498463, 5586.13414920688, 8847.601857916537, 9033.367664263438, 9033.95483022607, 9101.908980910372, 9171.174594286545, 8705.91294087051, 9175.357724959189, 9250.121238482334, 9266.305027122859, 9379.671711490066, 6311.400416960381, 6754.2570317266045, 6781.932180678327, 6950.0, 7011.368976792113, 7407.296306850841, 7411.777646670608, 7432.777016689508, 7489.737859174903, 7506.774796755888, 6377.1390862233, 6411.781761465307, 6492.188476440445, 6563.0811686362995, 6597.406233439014, 6372.0, 6385.265694445198, 6424.38968298011, 6536.901946470712, 6553.04980777775, 5964.701764911651, 6202.255729312511, 6213.409726076015, 6263.874722505433, 6265.060240963892, 4681.695689780154, 4737.644676649196, 4820.39745031871, 4886.682365646222, 4934.111859865258, 4753.83361582343, 4786.593139583175, 4922.753862306942, 4948.678335908155, 4981.800727970841], "value": 4172.0911562076335, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.8209002958342, 321.758680989258, 323.409777156689, 326.70759670095265, 329.2279604327853, 5470.261514695515, 5587.413321601224, 5600.215969764231, 5604.99110160171, 5665.631733937291, 5505.807296744605, 5518.862028449291, 5519.199716041182, 5555.666660000403, 5606.691631960251, 4069.409935559342, 4095.385692146187, 4244.639205667522, 4256.702030857841, 4258.510271318792, 4246.660267178634, 4257.5742425757335, 4258.680598955075, 4270.295401258789, 4295.613394794468, 4240.469941257343, 4241.639460645849, 4248.408470832789, 4262.7655478948645, 4268.914621707564, 4022.718409711336, 4260.637845783112, 4272.380504826782, 4276.935845962297, 4284.892877678052, 3692.981535092334, 3701.1117331840433, 3704.148045949447, 3708.647678470541, 3725.124595720031, 5282.735863206863, 5333.173358129496, 5360.088784906575, 5388.137897936312, 5389.865253368658, 4603.332516785047, 4837.685550439211, 4893.7063776173545, 4894.632902532324, 4920.532549407836, 5809.925163844702, 5852.268466441695, 5853.76584936602, 5855.912161317541, 5859.589828711992, 4072.5927407259333, 4083.1629515949458, 4092.570280120604, 4095.85664501744, 4104.979475102636, 5960.195373624549, 6057.546693589104, 6129.264488261392, 6142.815715528542, 6151.292601350812, 4126.66986641068, 4170.457840480718, 4180.122174343361, 4182.330827067654, 4189.141226048653, 4217.198732240864, 4232.328230348995, 4232.894177645522, 4233.682473814476, 4241.597048280409, 4687.148576312337, 4859.2954021666665, 4868.659193856396, 4884.731339776346, 4934.5312195341385, 5832.970835145882, 5857.648541087548, 5874.73563689635, 5876.353601103875, 5961.314448838352, 1522.5660686704236, 1528.0678785940568, 1531.1425601662881, 1534.907905525672, 1535.5470136309816, 902.4134312696668, 929.2287401456774, 994.22450488619, 1006.2453160129902, 1020.9336393134571, 5919.200907877467, 5926.762929482858, 5934.762609495659, 5960.910586341209, 5985.970070149621, 6252.74989000444, 6257.5932564383165, 6274.560780745304, 6286.396968772933, 6302.684865756693, 5801.216835727208, 5899.646021238739, 5901.554119240814, 5948.791792287336, 5956.7319470623925, 3363.344147891187, 3381.526586277923, 3387.3394688035596, 3389.3560223557447, 3401.4727717203873, 6007.759689612367, 6256.6871656417, 6289.937100628935, 6505.316941721146, 6543.411093001558, 6084.482818960438, 6130.141780150782, 6148.954677704712, 6165.136880836686, 6172.197614310111, 6181.412765787243, 6201.255849298113, 6270.2789179244055, 6303.7793677222, 6321.273053598895, 5998.280206375263, 6059.515238780798, 6084.239470066242, 6086.239220097488, 6126.877462450815, 5983.012802887475, 5999.430054145024, 6000.339962604023, 6010.819675409744, 6046.606970546901, 6111.358307377662, 6112.530437906621, 6222.844428889314, 6238.0, 6278.874422511615, 4122.1961717466, 4152.8338866445, 4170.520390155171, 4187.476565429321, 4195.1819395217635, 5879.059910229528, 6051.304100028553, 6057.697115144313, 6071.939280607137, 6093.2078829751845, 5849.0, 5878.265216847894, 5923.378045305353, 5925.377835327401, 5939.168516407793, 5813.273340832396, 5837.211976383303, 5855.853603659943, 5882.970480166039, 5884.323302820059, 5566.4990150886615, 5716.170825336019, 5724.570657200643, 5827.5629327801435, 5837.532997360286, 5923.940760592339, 5924.585279030426, 5935.821925342247, 5980.0, 5981.192539007178, 5597.552195824405, 5794.681292528951, 5802.20131759156, 5822.912656310074, 5835.482774478582], "value": 4458.478670688279, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.896016637338, 736.296836521122, 737.4874462248736, 740.2671355358191, 752.9698812047517, 13274.0, 13800.309984500773, 13899.513517026906, 14100.717985640295, 14298.213598252092, 13974.93012534936, 14095.224762638076, 14141.36363863626, 14176.149431034119, 14222.928885355584, 644.2494493914584, 780.5394817057935, 806.4919100966383, 807.9757607271777, 816.6896579299887, 807.9596020198996, 809.2756982500658, 811.6956141446957, 814.071957967917, 815.0871024452622, 830.9584520773938, 836.7908022994252, 838.4801423117675, 843.8734189871507, 844.4848642328175, 827.2430725885807, 835.8077642142281, 836.45630340279, 836.6235194162651, 838.287455662688, 610.3408319015452, 611.5107913669092, 612.2561088277764, 612.6018088242633, 612.9785457508966, 13633.386497607631, 13661.726765464635, 13695.109817861807, 13744.0, 13764.518241861486, 12566.748665026647, 12759.553415630407, 12816.615501534969, 12851.293178875158, 12957.740845183043, 10127.0, 10228.181745460346, 10316.948415257875, 10442.947785261102, 10575.947120264349, 3497.702695270905, 3547.5033495310677, 3587.246678197582, 3594.6944509716704, 3605.873794417209, 53128.46871531312, 54059.18911216335, 55066.898662026935, 55146.44853551453, 55406.722966385314, 9529.714108576754, 9624.711258662252, 9639.558716247406, 9777.560009799576, 9849.458279794537, 16591.917040414963, 16621.252043657823, 16653.666926661397, 16721.832781672027, 16732.832671673128, 7758.107817600935, 7810.062792464941, 7839.294463498312, 7865.095514015847, 7954.960225198837, 4417.955820441819, 4492.168948744427, 4558.954410455919, 4590.403247577793, 4642.675012749142, 2976.776741744378, 3081.352915887644, 3085.182426656938, 3091.5671805947186, 3093.0566177315686, 564.8531381840669, 577.971101444926, 584.4914924016133, 587.1105275507609, 587.9382664820217, 625.5527297981873, 646.3762469217228, 698.183125742882, 713.6146480900255, 753.0210726056105, 8141.389395795339, 8447.45091569046, 8549.529775862387, 8719.91280087191, 8852.24755895756, 637.3276193615687, 646.7897933171644, 664.5414663881907, 751.8721817291074, 762.561527121896, 4101.85643502476, 4173.9582604174175, 4192.24539582878, 4283.593058659422, 4292.871213863589, 66858.66570667115, 67503.3249667497, 68680.0, 69136.65431672809, 69286.65356673184, 59896.0, 60284.0, 60321.396786032456, 60897.69551152216, 62503.0, 54440.45559544433, 54493.182602261, 54525.45474545283, 54727.0, 55185.172222416695, 8214.83570328602, 8525.74422767318, 8559.700410485602, 8632.827343453222, 8759.16787905148, 36271.818640906626, 36389.27221455609, 36718.082047949014, 36742.44886326654, 37540.43689344607, 45253.547464524934, 47428.52571474379, 47556.28665570088, 47817.5218247827, 49126.0, 11121.88878111241, 11193.440327983406, 11249.0, 11437.485313161094, 11491.770164596828, 12128.272303661808, 12270.141090123605, 12309.199902006341, 12385.876141238472, 12694.0, 11340.716482088013, 11505.309681419141, 11534.480948357512, 11650.184487085822, 11718.472668729757, 11289.887101128883, 11367.317960922372, 11376.374299413612, 11580.305181689126, 12122.090843186972, 11560.183463493244, 11677.591284305008, 11802.114841387101, 11816.763664726486, 11931.0, 9996.700098997042, 10063.446510441996, 10360.637377691744, 10676.679699609023, 10753.354798712102, 9443.244540436886, 10084.949575252076, 10122.949385253027, 10127.392356458342, 10220.284580079324], "value": 6497.679037705473, "unit": "score"}], "name": "dromaeo_css", "value": 6887.825744752021, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 108.0, 116.0, 112.0, 111.0, 125.0, 113.0, 111.0, 111.0, 111.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 127.0, 156.0, 186.0, 130.0, 158.0, 163.0, 130.0, 179.0, 136.0], "value": 151.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 160.0, 163.0, 163.0, 166.0, 169.0, 163.0, 164.0, 163.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 76.0, 77.0, 159.0, 73.0, 76.0, 77.0, 76.0, 164.0, 77.0], "value": 93.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 156.0, 93.0, 94.0, 93.0, 146.0, 93.0, 92.0, 140.0], "value": 109.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 119.0, 118.0, 117.0, 117.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 149.0, 149.0, 146.0, 146.0, 147.0, 148.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 62.0, 58.0, 58.0, 58.0, 60.0, 85.0, 58.0, 57.0], "value": 61.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 61.0, 62.0, 61.0, 61.0, 61.0, 61.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 79.0, 77.0, 86.0, 78.0, 77.0, 79.0, 79.0, 79.0], "value": 79.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 132.0, 128.0, 127.0, 142.0, 126.0, 122.0, 126.0, 169.0, 125.0], "value": 132.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 170.0, 175.0, 179.0, 175.0, 171.0, 171.0, 168.0, 177.0, 172.0], "value": 173.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 69.0, 69.0, 70.0, 69.0, 67.0, 70.0, 69.0, 70.0, 68.0], "value": 69.3, "unit": "score"}], "name": "kraken", "value": 1567.6000000000001, "alertThreshold": 2.0}]} 05:26:29 INFO - Return code: 0 05:26:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:26:29 ERROR - # TBPL SUCCESS # 05:26:29 INFO - Running post-action listener: _resource_record_post_action 05:26:29 INFO - Running post-run listener: _resource_record_post_run 05:26:30 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 541638656; Read time: 0; Write time: 677396 05:26:30 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 251830272; Read time: 0; Write time: 367820 05:26:30 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 289808384; Read time: 0; Write time: 309576 05:26:30 INFO - Running post-run listener: _upload_blobber_files 05:26:30 INFO - Blob upload gear active. 05:26:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:26:30 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 05:26:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:26:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:26:30 INFO - (blobuploader) - INFO - Open directory for files ... 05:26:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:26:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:26:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:26:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:26:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:26:31 INFO - (blobuploader) - INFO - Done attempting. 05:26:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:26:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:26:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:26:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:26:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:26:32 INFO - (blobuploader) - INFO - Done attempting. 05:26:32 INFO - (blobuploader) - INFO - Iteration through files over. 05:26:32 INFO - Return code: 0 05:26:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:26:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:26:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6006c87ea3be039e3492c9160571176e90681e22f53b553c51ca24c62498ef3ea2adb53bd7e66f51adfed83c1e2cd8757518ed2d284ec8f4610054d0805f0651", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9bc125eb1d151af2e1262ce77efbd694f2a02443b891c6adba8b9566cef3091bc4d33b97cfc3b438771b8ab28adee070be041ce84756f1c98a5429e591cbd4e2"} 05:26:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:26:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:26:32 INFO - Contents: 05:26:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6006c87ea3be039e3492c9160571176e90681e22f53b553c51ca24c62498ef3ea2adb53bd7e66f51adfed83c1e2cd8757518ed2d284ec8f4610054d0805f0651", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9bc125eb1d151af2e1262ce77efbd694f2a02443b891c6adba8b9566cef3091bc4d33b97cfc3b438771b8ab28adee070be041ce84756f1c98a5429e591cbd4e2"} 05:26:32 INFO - Running post-run listener: copy_logs_to_upload_dir 05:26:32 INFO - Copying logs to upload dir... 05:26:32 INFO - mkdir: /builds/slave/test/build/upload/logs 05:26:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.618180 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-04-26 05:26:31.817911) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 05:26:31.821220) ========= 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=fa44defc139c4ba8574fe040000001db-1461665383.224155-1094879320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6006c87ea3be039e3492c9160571176e90681e22f53b553c51ca24c62498ef3ea2adb53bd7e66f51adfed83c1e2cd8757518ed2d284ec8f4610054d0805f0651", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9bc125eb1d151af2e1262ce77efbd694f2a02443b891c6adba8b9566cef3091bc4d33b97cfc3b438771b8ab28adee070be041ce84756f1c98a5429e591cbd4e2"} build_url:https://queue.taskcluster.net/v1/task/XAIGQlNqRcKKaL707shW6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011292 build_url: 'https://queue.taskcluster.net/v1/task/XAIGQlNqRcKKaL707shW6A/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/sha512/6006c87ea3be039e3492c9160571176e90681e22f53b553c51ca24c62498ef3ea2adb53bd7e66f51adfed83c1e2cd8757518ed2d284ec8f4610054d0805f0651", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9bc125eb1d151af2e1262ce77efbd694f2a02443b891c6adba8b9566cef3091bc4d33b97cfc3b438771b8ab28adee070be041ce84756f1c98a5429e591cbd4e2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 05:26:31.845238) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 05:26:31.845529) ========= 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=fa44defc139c4ba8574fe040000001db-1461665383.224155-1094879320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004513 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 05:26:31.930148) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 05:26:31.930473) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 05:26:31.930798) ========= ========= Total master_lag: 0.16 =========