builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-043 starttime: 1461921273.18 results: success (0) buildid: 20160428233030 builduid: 5c3f7d6064db4249871a5d2df27b30b5 revision: 37465cb0c50550fd6f673223942b3c479e39e569 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 02:14:33.176789) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 02:14:33.177272) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 02:14:33.177555) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 02:14:33.196112) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 02:14:33.196393) ========= 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=d2a8c569965ab8367867b893000001a1-1461920608.472091-1451329270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-29 02:14:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2016-04-29 02:14:33 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088838 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 02:14:33.299461) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 02:14:33.299799) ========= 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=d2a8c569965ab8367867b893000001a1-1461920608.472091-1451329270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020964 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 02:14:33.349469) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 02:14:33.349818) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 37465cb0c50550fd6f673223942b3c479e39e569 --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 37465cb0c50550fd6f673223942b3c479e39e569 --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=d2a8c569965ab8367867b893000001a1-1461920608.472091-1451329270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-29 02:14:33,503 truncating revision to first 12 chars 2016-04-29 02:14:33,504 Setting DEBUG logging. 2016-04-29 02:14:33,504 attempt 1/10 2016-04-29 02:14:33,504 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/37465cb0c505?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-29 02:14:33,768 unpacking tar archive at: fx-team-37465cb0c505/testing/mozharness/ program finished with exit code 0 elapsedTime=0.577790 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 02:14:33.940544) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 02:14:33.940855) ========= script_repo_revision: 37465cb0c50550fd6f673223942b3c479e39e569 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 02:14:33.941271) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 02:14:33.941640) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 02:14:33.950385) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-04-29 02:14:33.950673) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=d2a8c569965ab8367867b893000001a1-1461920608.472091-1451329270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:14:34 INFO - MultiFileLogger online at 20160429 02:14:34 in /builds/slave/test 02:14:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:14:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:14:34 INFO - {'append_to_log': False, 02:14:34 INFO - 'base_work_dir': '/builds/slave/test', 02:14:34 INFO - 'blob_upload_branch': 'Fx-Team', 02:14:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:14:34 INFO - 'branch': 'Fx-Team', 02:14:34 INFO - 'buildbot_json_path': 'buildprops.json', 02:14:34 INFO - 'config_files': ('talos/linux_config.py',), 02:14:34 INFO - 'default_actions': ('clobber', 02:14:34 INFO - 'read-buildbot-config', 02:14:34 INFO - 'download-and-extract', 02:14:34 INFO - 'populate-webroot', 02:14:34 INFO - 'create-virtualenv', 02:14:34 INFO - 'install', 02:14:34 INFO - 'run-tests'), 02:14:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:14:34 INFO - 'download_minidump_stackwalk': True, 02:14:34 INFO - 'download_symbols': 'ondemand', 02:14:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:14:34 INFO - 'tooltool.py': '/tools/tooltool.py', 02:14:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:14:34 INFO - '/tools/misc-python/virtualenv.py')}, 02:14:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:14:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:14:34 INFO - 'installer_path': 'installer.exe', 02:14:34 INFO - 'log_level': 'info', 02:14:34 INFO - 'log_name': 'talos', 02:14:34 INFO - 'log_to_console': True, 02:14:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:14:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:14:34 INFO - 'opt_config_files': (), 02:14:34 INFO - 'pip_index': False, 02:14:34 INFO - 'sps_profile': False, 02:14:34 INFO - 'sps_profile_interval': 0, 02:14:34 INFO - 'suite': 'dromaeojs', 02:14:34 INFO - 'system_bits': '32', 02:14:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:14:34 INFO - 'title': 'talos-linux64-ix-043', 02:14:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:14:34 INFO - 'use_talos_json': True, 02:14:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:14:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:14:34 INFO - 'work_dir': 'build'} 02:14:34 INFO - ##### 02:14:34 INFO - ##### Running clobber step. 02:14:34 INFO - ##### 02:14:34 INFO - Running pre-action listener: _resource_record_pre_action 02:14:34 INFO - Running main action method: clobber 02:14:34 INFO - rmtree: /builds/slave/test/build 02:14:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:14:34 INFO - Running post-action listener: _resource_record_post_action 02:14:34 INFO - ##### 02:14:34 INFO - ##### Running read-buildbot-config step. 02:14:34 INFO - ##### 02:14:34 INFO - Running pre-action listener: _resource_record_pre_action 02:14:34 INFO - Running main action method: read_buildbot_config 02:14:34 INFO - Using buildbot properties: 02:14:34 INFO - { 02:14:34 INFO - "project": "", 02:14:34 INFO - "product": "firefox", 02:14:34 INFO - "script_repo_revision": "production", 02:14:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:14:34 INFO - "repository": "", 02:14:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 02:14:34 INFO - "buildid": "20160428233030", 02:14:34 INFO - "pgo_build": "True", 02:14:34 INFO - "basedir": "/builds/slave/test", 02:14:34 INFO - "buildnumber": 622, 02:14:34 INFO - "slavename": "talos-linux64-ix-043", 02:14:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:14:34 INFO - "platform": "ubuntu64_hw", 02:14:34 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:14:34 INFO - "branch": "fx-team", 02:14:34 INFO - "repo_path": "integration/fx-team", 02:14:34 INFO - "revision": "37465cb0c50550fd6f673223942b3c479e39e569", 02:14:34 INFO - "stage_platform": "linux64-pgo", 02:14:34 INFO - "builduid": "5c3f7d6064db4249871a5d2df27b30b5", 02:14:34 INFO - "slavebuilddir": "test" 02:14:34 INFO - } 02:14:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/ADV3nDuxSjqsQL18Yw52mw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 02:14:34 INFO - Running post-action listener: _resource_record_post_action 02:14:34 INFO - ##### 02:14:34 INFO - ##### Running download-and-extract step. 02:14:34 INFO - ##### 02:14:34 INFO - Running pre-action listener: _resource_record_pre_action 02:14:34 INFO - Running main action method: download_and_extract 02:14:34 INFO - mkdir: /builds/slave/test/build/tests 02:14:34 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')]} 02:14:34 INFO - https://queue.taskcluster.net/v1/task/ADV3nDuxSjqsQL18Yw52mw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:14:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADV3nDuxSjqsQL18Yw52mw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:14:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADV3nDuxSjqsQL18Yw52mw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:14:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADV3nDuxSjqsQL18Yw52mw/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 02:14:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADV3nDuxSjqsQL18Yw52mw/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 02:14:39 INFO - Downloaded 1361 bytes. 02:14:39 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:14:39 INFO - Using the following test package requirements: 02:14:39 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:14:39 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:14:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:14:39 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:14:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:14:39 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:14:39 INFO - u'jsshell-linux-x86_64.zip'], 02:14:39 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:14:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:14:39 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:14:39 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:14:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:14:39 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:14:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:14:39 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:14:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:14:39 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:14:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:14:39 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:14:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:39 INFO - https://queue.taskcluster.net/v1/task/ADV3nDuxSjqsQL18Yw52mw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:14:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADV3nDuxSjqsQL18Yw52mw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:14:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADV3nDuxSjqsQL18Yw52mw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:14:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADV3nDuxSjqsQL18Yw52mw/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 02:14:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADV3nDuxSjqsQL18Yw52mw/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 02:14:43 INFO - Downloaded 23873563 bytes. 02:14:43 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'] 02:14:43 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 02:14:45 INFO - Return code: 0 02:14:45 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 02:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:45 INFO - https://queue.taskcluster.net/v1/task/ADV3nDuxSjqsQL18Yw52mw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:14:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADV3nDuxSjqsQL18Yw52mw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:14:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADV3nDuxSjqsQL18Yw52mw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:14:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADV3nDuxSjqsQL18Yw52mw/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 02:14:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADV3nDuxSjqsQL18Yw52mw/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 02:14:56 INFO - Downloaded 23873563 bytes. 02:14:56 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'] 02:14:56 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 02:14:57 INFO - Return code: 0 02:14:57 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')]} 02:14:57 INFO - https://queue.taskcluster.net/v1/task/ADV3nDuxSjqsQL18Yw52mw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:14:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADV3nDuxSjqsQL18Yw52mw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:14:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADV3nDuxSjqsQL18Yw52mw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:14:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADV3nDuxSjqsQL18Yw52mw/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 02:14:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADV3nDuxSjqsQL18Yw52mw/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 02:14:58 INFO - Downloaded 10840145 bytes. 02:14:58 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'] 02:14:58 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 02:14:59 INFO - Return code: 0 02:14:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:59 INFO - https://queue.taskcluster.net/v1/task/ADV3nDuxSjqsQL18Yw52mw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:14:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADV3nDuxSjqsQL18Yw52mw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:14:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADV3nDuxSjqsQL18Yw52mw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:14:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADV3nDuxSjqsQL18Yw52mw/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 02:14:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADV3nDuxSjqsQL18Yw52mw/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 02:15:00 INFO - Downloaded 58401592 bytes. 02:15:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ADV3nDuxSjqsQL18Yw52mw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:15:01 INFO - mkdir: /builds/slave/test/properties 02:15:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:15:01 INFO - Writing to file /builds/slave/test/properties/build_url 02:15:01 INFO - Contents: 02:15:01 INFO - build_url:https://queue.taskcluster.net/v1/task/ADV3nDuxSjqsQL18Yw52mw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:15:01 INFO - Running post-action listener: _resource_record_post_action 02:15:01 INFO - Running post-action listener: set_extra_try_arguments 02:15:01 INFO - ##### 02:15:01 INFO - ##### Running populate-webroot step. 02:15:01 INFO - ##### 02:15:01 INFO - Running pre-action listener: _resource_record_pre_action 02:15:01 INFO - Running main action method: populate_webroot 02:15:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:15:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:15:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:15:01 INFO - '--tppagecycles', 02:15:01 INFO - '7'], 02:15:01 INFO - 'tests': ['tsvgm']}}, 02:15:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:15:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:15:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:15:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:15:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:15:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:15:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:01 INFO - 'talos_options': ['--disable-e10s'], 02:15:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:15:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:15:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:01 INFO - 'talos_options': ['--disable-e10s'], 02:15:01 INFO - 'tests': ['damp', 'tps']}, 02:15:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:01 INFO - 'tests': ['damp', 'tps']}, 02:15:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:15:01 INFO - 'tests': ['dromaeo_dom']}, 02:15:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:15:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:15:01 INFO - 'tests': ['a11yr', 02:15:01 INFO - 'ts_paint', 02:15:01 INFO - 'tpaint', 02:15:01 INFO - 'sessionrestore', 02:15:01 INFO - 'sessionrestore_no_auto_restore', 02:15:01 INFO - 'tabpaint']}, 02:15:01 INFO - 'other-e10s': {'tests': ['a11yr', 02:15:01 INFO - 'ts_paint', 02:15:01 INFO - 'tpaint', 02:15:01 INFO - 'sessionrestore', 02:15:01 INFO - 'sessionrestore_no_auto_restore', 02:15:01 INFO - 'tabpaint']}, 02:15:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:15:01 INFO - 'ts_paint', 02:15:01 INFO - 'tpaint', 02:15:01 INFO - 'sessionrestore', 02:15:01 INFO - 'sessionrestore_no_auto_restore', 02:15:01 INFO - 'tabpaint']}, 02:15:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:15:01 INFO - 'ts_paint', 02:15:01 INFO - 'tpaint', 02:15:01 INFO - 'sessionrestore', 02:15:01 INFO - 'sessionrestore_no_auto_restore', 02:15:01 INFO - 'tabpaint']}, 02:15:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:15:01 INFO - 'tests': ['a11yr', 02:15:01 INFO - 'ts_paint', 02:15:01 INFO - 'tpaint', 02:15:01 INFO - 'sessionrestore', 02:15:01 INFO - 'sessionrestore_no_auto_restore', 02:15:01 INFO - 'tabpaint']}, 02:15:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:15:01 INFO - 'tests': ['a11yr', 02:15:01 INFO - 'ts_paint', 02:15:01 INFO - 'tpaint', 02:15:01 INFO - 'sessionrestore', 02:15:01 INFO - 'sessionrestore_no_auto_restore', 02:15:01 INFO - 'tabpaint']}, 02:15:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:15:01 INFO - 'tests': ['tsvgx', 02:15:01 INFO - 'tsvgr_opacity', 02:15:01 INFO - 'tart', 02:15:01 INFO - 'tscrollx', 02:15:01 INFO - 'cart']}, 02:15:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:15:01 INFO - 'tsvgr_opacity', 02:15:01 INFO - 'tart', 02:15:01 INFO - 'tscrollx', 02:15:01 INFO - 'cart']}, 02:15:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:01 INFO - 'talos_options': ['--disable-e10s'], 02:15:01 INFO - 'tests': ['tp5o']}, 02:15:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:01 INFO - 'tests': ['tp5o']}, 02:15:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:01 INFO - 'talos_options': ['--disable-e10s', 02:15:01 INFO - '--xperf_path', 02:15:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:15:01 INFO - 'tests': ['tp5n']}, 02:15:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:01 INFO - 'talos_options': ['--xperf_path', 02:15:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:15:01 INFO - 'tests': ['tp5n']}}, 02:15:01 INFO - 'talos.zip': {'path': '', 02:15:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:15:01 INFO - Running post-action listener: _resource_record_post_action 02:15:01 INFO - ##### 02:15:01 INFO - ##### Running create-virtualenv step. 02:15:01 INFO - ##### 02:15:01 INFO - Running pre-action listener: _resource_record_pre_action 02:15:01 INFO - Running main action method: create_virtualenv 02:15:01 INFO - Creating virtualenv /builds/slave/test/build/venv 02:15:01 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 02:15:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:15:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:15:01 INFO - Using real prefix '/usr' 02:15:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:15:02 INFO - Installing distribute.............................................................................................................................................................................................done. 02:15:04 INFO - Installing pip.................done. 02:15:04 INFO - Return code: 0 02:15:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:15:04 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')]} 02:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:04 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')]} 02:15:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:04 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 0x7f7e3e2f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15af9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163e810>, '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 0x163f710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x163fba0>, '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': 'd2a8c569965ab8367867b893000001a1-1461920608.472091-1451329270', '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 02:15:04 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 02:15:04 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 02:15:04 INFO - Using env: {'DISPLAY': ':0', 02:15:04 INFO - 'HOME': '/home/cltbld', 02:15:04 INFO - 'LANG': 'en_US.UTF-8', 02:15:04 INFO - 'LANGUAGE': 'en_US:en', 02:15:04 INFO - 'LOGNAME': 'cltbld', 02:15:04 INFO - 'MAIL': '/var/mail/cltbld', 02:15:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:04 INFO - 'MOZ_NO_REMOTE': '1', 02:15:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:15:04 INFO - 'NO_EM_RESTART': '1', 02:15:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:15:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:04 INFO - 'PWD': '/builds/slave/test', 02:15:04 INFO - 'SHELL': '/bin/bash', 02:15:04 INFO - 'SHLVL': '1', 02:15:04 INFO - 'TERM': 'linux', 02:15:04 INFO - 'TMOUT': '86400', 02:15:04 INFO - 'USER': 'cltbld', 02:15:04 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461920608.472091-1451329270', 02:15:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:04 INFO - '_': '/tools/buildbot/bin/python'} 02:15:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:04 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 02:15:04 INFO - Cleaning up... 02:15:04 INFO - Return code: 0 02:15:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:15:04 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')]} 02:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:04 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')]} 02:15:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:04 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 0x7f7e3e2f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15af9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163e810>, '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 0x163f710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x163fba0>, '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': 'd2a8c569965ab8367867b893000001a1-1461920608.472091-1451329270', '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 02:15:04 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 02:15:04 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 02:15:04 INFO - Using env: {'DISPLAY': ':0', 02:15:04 INFO - 'HOME': '/home/cltbld', 02:15:04 INFO - 'LANG': 'en_US.UTF-8', 02:15:04 INFO - 'LANGUAGE': 'en_US:en', 02:15:04 INFO - 'LOGNAME': 'cltbld', 02:15:04 INFO - 'MAIL': '/var/mail/cltbld', 02:15:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:04 INFO - 'MOZ_NO_REMOTE': '1', 02:15:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:15:04 INFO - 'NO_EM_RESTART': '1', 02:15:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:15:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:04 INFO - 'PWD': '/builds/slave/test', 02:15:04 INFO - 'SHELL': '/bin/bash', 02:15:04 INFO - 'SHLVL': '1', 02:15:04 INFO - 'TERM': 'linux', 02:15:04 INFO - 'TMOUT': '86400', 02:15:04 INFO - 'USER': 'cltbld', 02:15:04 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461920608.472091-1451329270', 02:15:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:04 INFO - '_': '/tools/buildbot/bin/python'} 02:15:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:04 INFO - Downloading/unpacking psutil>=0.7.1 02:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:15:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:15:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:15:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:15:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:15:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:15:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:15:06 INFO - Installing collected packages: psutil 02:15:06 INFO - Running setup.py install for psutil 02:15:06 INFO - building 'psutil._psutil_linux' extension 02:15:06 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 02:15:07 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 02:15:07 INFO - building 'psutil._psutil_posix' extension 02:15:07 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 02:15:07 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 02:15:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:15:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:15:07 INFO - Successfully installed psutil 02:15:07 INFO - Cleaning up... 02:15:07 INFO - Return code: 0 02:15:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:15:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:15:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:07 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 0x7f7e3e2f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15af9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163e810>, '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 0x163f710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x163fba0>, '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': 'd2a8c569965ab8367867b893000001a1-1461920608.472091-1451329270', '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 02:15:07 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 02:15:07 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 02:15:07 INFO - Using env: {'DISPLAY': ':0', 02:15:07 INFO - 'HOME': '/home/cltbld', 02:15:07 INFO - 'LANG': 'en_US.UTF-8', 02:15:07 INFO - 'LANGUAGE': 'en_US:en', 02:15:07 INFO - 'LOGNAME': 'cltbld', 02:15:07 INFO - 'MAIL': '/var/mail/cltbld', 02:15:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:07 INFO - 'MOZ_NO_REMOTE': '1', 02:15:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:15:07 INFO - 'NO_EM_RESTART': '1', 02:15:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:15:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:07 INFO - 'PWD': '/builds/slave/test', 02:15:07 INFO - 'SHELL': '/bin/bash', 02:15:07 INFO - 'SHLVL': '1', 02:15:07 INFO - 'TERM': 'linux', 02:15:07 INFO - 'TMOUT': '86400', 02:15:07 INFO - 'USER': 'cltbld', 02:15:07 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461920608.472091-1451329270', 02:15:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:07 INFO - '_': '/tools/buildbot/bin/python'} 02:15:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:15:07 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 02:15:07 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 02:15:07 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 02:15:07 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 02:15:07 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 02:15:07 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 02:15:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:15:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:15:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:15:09 INFO - Installing collected packages: mozsystemmonitor 02:15:09 INFO - Running setup.py install for mozsystemmonitor 02:15:09 INFO - Successfully installed mozsystemmonitor 02:15:09 INFO - Cleaning up... 02:15:09 INFO - Return code: 0 02:15:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:15:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:15:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:09 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 0x7f7e3e2f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15af9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163e810>, '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 0x163f710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x163fba0>, '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': 'd2a8c569965ab8367867b893000001a1-1461920608.472091-1451329270', '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 02:15:09 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 02:15:09 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 02:15:09 INFO - Using env: {'DISPLAY': ':0', 02:15:09 INFO - 'HOME': '/home/cltbld', 02:15:09 INFO - 'LANG': 'en_US.UTF-8', 02:15:09 INFO - 'LANGUAGE': 'en_US:en', 02:15:09 INFO - 'LOGNAME': 'cltbld', 02:15:09 INFO - 'MAIL': '/var/mail/cltbld', 02:15:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:09 INFO - 'MOZ_NO_REMOTE': '1', 02:15:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:15:09 INFO - 'NO_EM_RESTART': '1', 02:15:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:15:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:09 INFO - 'PWD': '/builds/slave/test', 02:15:09 INFO - 'SHELL': '/bin/bash', 02:15:09 INFO - 'SHLVL': '1', 02:15:09 INFO - 'TERM': 'linux', 02:15:09 INFO - 'TMOUT': '86400', 02:15:09 INFO - 'USER': 'cltbld', 02:15:09 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461920608.472091-1451329270', 02:15:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:09 INFO - '_': '/tools/buildbot/bin/python'} 02:15:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:09 INFO - Downloading/unpacking blobuploader==1.2.4 02:15:09 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 02:15:09 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 02:15:09 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 02:15:09 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 02:15:09 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 02:15:09 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 02:15:11 INFO - Downloading blobuploader-1.2.4.tar.gz 02:15:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:15:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:15:11 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 02:15:11 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 02:15:11 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 02:15:11 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 02:15:11 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 02:15:11 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 02:15:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:15:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:15:12 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 02:15:12 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 02:15:12 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 02:15:12 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 02:15:12 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 02:15:12 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 02:15:12 INFO - Downloading docopt-0.6.1.tar.gz 02:15:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:15:12 INFO - Installing collected packages: blobuploader, requests, docopt 02:15:12 INFO - Running setup.py install for blobuploader 02:15:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:15:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:15:12 INFO - Running setup.py install for requests 02:15:12 INFO - Running setup.py install for docopt 02:15:13 INFO - Successfully installed blobuploader requests docopt 02:15:13 INFO - Cleaning up... 02:15:13 INFO - Return code: 0 02:15:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:15:13 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')]} 02:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:13 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')]} 02:15:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:13 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 0x7f7e3e2f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15af9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163e810>, '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 0x163f710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x163fba0>, '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': 'd2a8c569965ab8367867b893000001a1-1461920608.472091-1451329270', '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 02:15:13 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 02:15:13 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 02:15:13 INFO - Using env: {'DISPLAY': ':0', 02:15:13 INFO - 'HOME': '/home/cltbld', 02:15:13 INFO - 'LANG': 'en_US.UTF-8', 02:15:13 INFO - 'LANGUAGE': 'en_US:en', 02:15:13 INFO - 'LOGNAME': 'cltbld', 02:15:13 INFO - 'MAIL': '/var/mail/cltbld', 02:15:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:13 INFO - 'MOZ_NO_REMOTE': '1', 02:15:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:15:13 INFO - 'NO_EM_RESTART': '1', 02:15:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:15:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:13 INFO - 'PWD': '/builds/slave/test', 02:15:13 INFO - 'SHELL': '/bin/bash', 02:15:13 INFO - 'SHLVL': '1', 02:15:13 INFO - 'TERM': 'linux', 02:15:13 INFO - 'TMOUT': '86400', 02:15:13 INFO - 'USER': 'cltbld', 02:15:13 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461920608.472091-1451329270', 02:15:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:13 INFO - '_': '/tools/buildbot/bin/python'} 02:15:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:15:13 INFO - Running setup.py (path:/tmp/pip-dCJhKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:15:13 INFO - Running setup.py (path:/tmp/pip-biCioq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:15:13 INFO - Running setup.py (path:/tmp/pip-Y4n_c0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:15:13 INFO - Running setup.py (path:/tmp/pip-VqAp7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:15:13 INFO - Running setup.py (path:/tmp/pip-7t_9Fx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:15:13 INFO - Running setup.py (path:/tmp/pip-As33xb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:15:13 INFO - Running setup.py (path:/tmp/pip-iM18Cv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:15:13 INFO - Running setup.py (path:/tmp/pip-BDlk2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:15:13 INFO - Running setup.py (path:/tmp/pip-7us74e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:15:13 INFO - Running setup.py (path:/tmp/pip-6BrIbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:15:13 INFO - Running setup.py (path:/tmp/pip-_luT99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:15:14 INFO - Running setup.py (path:/tmp/pip-OrZP11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:15:14 INFO - Running setup.py (path:/tmp/pip-dgmP1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:15:14 INFO - Running setup.py (path:/tmp/pip-dW1r24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:15:14 INFO - Running setup.py (path:/tmp/pip-lZWBff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:15:14 INFO - Running setup.py (path:/tmp/pip-ael45e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:15:14 INFO - Running setup.py (path:/tmp/pip-1tNLRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:15:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:15:14 INFO - Running setup.py install for manifestparser 02:15:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:15:14 INFO - Running setup.py install for mozcrash 02:15:14 INFO - Running setup.py install for mozdebug 02:15:14 INFO - Running setup.py install for mozdevice 02:15:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:15:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:15:14 INFO - Running setup.py install for mozfile 02:15:14 INFO - Running setup.py install for mozhttpd 02:15:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:15:15 INFO - Running setup.py install for mozinfo 02:15:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:15:15 INFO - Running setup.py install for mozInstall 02:15:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:15:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:15:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:15:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:15:15 INFO - Running setup.py install for mozleak 02:15:15 INFO - Running setup.py install for mozlog 02:15:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:15:15 INFO - Running setup.py install for moznetwork 02:15:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:15:15 INFO - Running setup.py install for mozprocess 02:15:15 INFO - Running setup.py install for mozprofile 02:15:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:15:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:15:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:15:15 INFO - Running setup.py install for mozrunner 02:15:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:15:15 INFO - Running setup.py install for mozscreenshot 02:15:16 INFO - Running setup.py install for moztest 02:15:16 INFO - Running setup.py install for mozversion 02:15:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:15:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:15:16 INFO - Cleaning up... 02:15:16 INFO - Return code: 0 02:15:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:15:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:15:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:15:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:16 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 0x7f7e3e2f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15af9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163e810>, '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 0x163f710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x163fba0>, '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': 'd2a8c569965ab8367867b893000001a1-1461920608.472091-1451329270', '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 02:15:16 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 02:15:16 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 02:15:16 INFO - Using env: {'DISPLAY': ':0', 02:15:16 INFO - 'HOME': '/home/cltbld', 02:15:16 INFO - 'LANG': 'en_US.UTF-8', 02:15:16 INFO - 'LANGUAGE': 'en_US:en', 02:15:16 INFO - 'LOGNAME': 'cltbld', 02:15:16 INFO - 'MAIL': '/var/mail/cltbld', 02:15:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:16 INFO - 'MOZ_NO_REMOTE': '1', 02:15:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:15:16 INFO - 'NO_EM_RESTART': '1', 02:15:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:15:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:16 INFO - 'PWD': '/builds/slave/test', 02:15:16 INFO - 'SHELL': '/bin/bash', 02:15:16 INFO - 'SHLVL': '1', 02:15:16 INFO - 'TERM': 'linux', 02:15:16 INFO - 'TMOUT': '86400', 02:15:16 INFO - 'USER': 'cltbld', 02:15:16 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461920608.472091-1451329270', 02:15:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:16 INFO - '_': '/tools/buildbot/bin/python'} 02:15:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:15:16 INFO - Running setup.py (path:/tmp/pip-De8oec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:15:16 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)) 02:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:15:16 INFO - Running setup.py (path:/tmp/pip-U7tJ59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:15:16 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)) 02:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:15:16 INFO - Running setup.py (path:/tmp/pip-r9_wHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:15:16 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)) 02:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:15:16 INFO - Running setup.py (path:/tmp/pip-mryHG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:15:16 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)) 02:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:15:16 INFO - Running setup.py (path:/tmp/pip-Wh5xx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:15:16 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)) 02:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:15:16 INFO - Running setup.py (path:/tmp/pip-RxsO3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:15:16 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)) 02:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:15:16 INFO - Running setup.py (path:/tmp/pip-1ldwHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:15:16 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)) 02:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:15:16 INFO - Running setup.py (path:/tmp/pip-jKLtYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:15:17 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)) 02:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:15:17 INFO - Running setup.py (path:/tmp/pip-SVefKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:15:17 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)) 02:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:15:17 INFO - Running setup.py (path:/tmp/pip-PutAfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:15:17 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)) 02:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:15:17 INFO - Running setup.py (path:/tmp/pip-vCIDko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:15:17 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)) 02:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:15:17 INFO - Running setup.py (path:/tmp/pip-r0wqE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:15:17 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)) 02:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:15:17 INFO - Running setup.py (path:/tmp/pip-ywtJSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:15:17 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)) 02:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:15:17 INFO - Running setup.py (path:/tmp/pip-XzwcWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:15:17 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)) 02:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:15:17 INFO - Running setup.py (path:/tmp/pip-4mDA1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:15:17 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)) 02:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:15:17 INFO - Running setup.py (path:/tmp/pip-qCU1EG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:15:17 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)) 02:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:15:17 INFO - Running setup.py (path:/tmp/pip-WQUpsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:15:17 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)) 02:15:17 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)) 02:15:17 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)) 02:15:17 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)) 02:15:17 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)) 02:15:17 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)) 02:15:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:15: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 02:15: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 02:15: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 02:15: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 02:15: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 02:15: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 02:15:19 INFO - Downloading blessings-1.6.tar.gz 02:15:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:15:19 INFO - Installing collected packages: blessings 02:15:19 INFO - Running setup.py install for blessings 02:15:19 INFO - Successfully installed blessings 02:15:19 INFO - Cleaning up... 02:15:19 INFO - Return code: 0 02:15:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:15:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:15:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:15:20 INFO - Reading from file tmpfile_stdout 02:15:20 INFO - Current package versions: 02:15:20 INFO - argparse == 1.2.1 02:15:20 INFO - blessings == 1.6 02:15:20 INFO - blobuploader == 1.2.4 02:15:20 INFO - docopt == 0.6.1 02:15:20 INFO - manifestparser == 1.1 02:15:20 INFO - mozInstall == 1.12 02:15:20 INFO - mozcrash == 0.17 02:15:20 INFO - mozdebug == 0.1 02:15:20 INFO - mozdevice == 0.48 02:15:20 INFO - mozfile == 1.2 02:15:20 INFO - mozhttpd == 0.7 02:15:20 INFO - mozinfo == 0.9 02:15:20 INFO - mozleak == 0.1 02:15:20 INFO - mozlog == 3.1 02:15:20 INFO - moznetwork == 0.27 02:15:20 INFO - mozprocess == 0.22 02:15:20 INFO - mozprofile == 0.28 02:15:20 INFO - mozrunner == 6.11 02:15:20 INFO - mozscreenshot == 0.1 02:15:20 INFO - mozsystemmonitor == 0.0 02:15:20 INFO - moztest == 0.7 02:15:20 INFO - mozversion == 1.4 02:15:20 INFO - psutil == 3.1.1 02:15:20 INFO - requests == 1.2.3 02:15:20 INFO - wsgiref == 0.1.2 02:15:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:15: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')]} 02:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15: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')]} 02:15:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:20 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 0x7f7e3e2f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15af9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163e810>, '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 0x163f710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x163fba0>, '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': 'd2a8c569965ab8367867b893000001a1-1461920608.472091-1451329270', '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 02:15:20 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 02:15:20 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 02:15:20 INFO - Using env: {'DISPLAY': ':0', 02:15:20 INFO - 'HOME': '/home/cltbld', 02:15:20 INFO - 'LANG': 'en_US.UTF-8', 02:15:20 INFO - 'LANGUAGE': 'en_US:en', 02:15:20 INFO - 'LOGNAME': 'cltbld', 02:15:20 INFO - 'MAIL': '/var/mail/cltbld', 02:15:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:20 INFO - 'MOZ_NO_REMOTE': '1', 02:15:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:15:20 INFO - 'NO_EM_RESTART': '1', 02:15:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:15:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:20 INFO - 'PWD': '/builds/slave/test', 02:15:20 INFO - 'SHELL': '/bin/bash', 02:15:20 INFO - 'SHLVL': '1', 02:15:20 INFO - 'TERM': 'linux', 02:15:20 INFO - 'TMOUT': '86400', 02:15:20 INFO - 'USER': 'cltbld', 02:15:20 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461920608.472091-1451329270', 02:15:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:20 INFO - '_': '/tools/buildbot/bin/python'} 02:15:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:20 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)) 02:15:20 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)) 02:15:20 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)) 02:15:20 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)) 02:15:20 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)) 02:15:20 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)) 02:15:20 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)) 02:15:20 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)) 02:15:20 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)) 02:15:20 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)) 02:15:20 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)) 02:15:20 INFO - Cleaning up... 02:15:20 INFO - Return code: 0 02:15:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:15: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')]} 02:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15: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')]} 02:15:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7e3e2f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15af9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163e810>, '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 0x163f710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x163fba0>, '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': 'd2a8c569965ab8367867b893000001a1-1461920608.472091-1451329270', '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 02:15: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', 'jsonschema'] in /builds/slave/test/build 02:15: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 jsonschema 02:15:20 INFO - Using env: {'DISPLAY': ':0', 02:15:20 INFO - 'HOME': '/home/cltbld', 02:15:20 INFO - 'LANG': 'en_US.UTF-8', 02:15:20 INFO - 'LANGUAGE': 'en_US:en', 02:15:20 INFO - 'LOGNAME': 'cltbld', 02:15:20 INFO - 'MAIL': '/var/mail/cltbld', 02:15:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:20 INFO - 'MOZ_NO_REMOTE': '1', 02:15:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:15:20 INFO - 'NO_EM_RESTART': '1', 02:15:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:15:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:20 INFO - 'PWD': '/builds/slave/test', 02:15:20 INFO - 'SHELL': '/bin/bash', 02:15:20 INFO - 'SHLVL': '1', 02:15:20 INFO - 'TERM': 'linux', 02:15:20 INFO - 'TMOUT': '86400', 02:15:20 INFO - 'USER': 'cltbld', 02:15:20 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461920608.472091-1451329270', 02:15:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:20 INFO - '_': '/tools/buildbot/bin/python'} 02:15:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:20 INFO - Downloading/unpacking jsonschema 02:15: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 02:15: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 02:15: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 02:15: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 02:15: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 02:15: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 02:15:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:15:22 INFO - Downloading/unpacking functools32 (from jsonschema) 02:15: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 02:15: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 02:15: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 02:15: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 02:15: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 02:15: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 02:15:22 INFO - Downloading functools32-3.2.3-2.tar.gz 02:15:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:15:22 INFO - warning: no files found matching '*.txt' 02:15:22 INFO - no previously-included directories found matching 'build' 02:15:22 INFO - no previously-included directories found matching 'dist' 02:15:22 INFO - no previously-included directories found matching '.git*' 02:15:22 INFO - Installing collected packages: jsonschema, functools32 02:15:22 INFO - Running setup.py install for functools32 02:15:22 INFO - warning: no files found matching '*.txt' 02:15:22 INFO - no previously-included directories found matching 'build' 02:15:22 INFO - no previously-included directories found matching 'dist' 02:15:22 INFO - no previously-included directories found matching '.git*' 02:15:22 INFO - Successfully installed jsonschema functools32 02:15:22 INFO - Cleaning up... 02:15:22 INFO - Return code: 0 02:15:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:15: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')]} 02:15:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15: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')]} 02:15:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7e3e2f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15af9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163e810>, '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 0x163f710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x163fba0>, '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': 'd2a8c569965ab8367867b893000001a1-1461920608.472091-1451329270', '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 02:15: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', 'flake8'] in /builds/slave/test/build 02:15: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 flake8 02:15:22 INFO - Using env: {'DISPLAY': ':0', 02:15:22 INFO - 'HOME': '/home/cltbld', 02:15:22 INFO - 'LANG': 'en_US.UTF-8', 02:15:22 INFO - 'LANGUAGE': 'en_US:en', 02:15:22 INFO - 'LOGNAME': 'cltbld', 02:15:22 INFO - 'MAIL': '/var/mail/cltbld', 02:15:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:22 INFO - 'MOZ_NO_REMOTE': '1', 02:15:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:15:22 INFO - 'NO_EM_RESTART': '1', 02:15:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:15:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:22 INFO - 'PWD': '/builds/slave/test', 02:15:22 INFO - 'SHELL': '/bin/bash', 02:15:22 INFO - 'SHLVL': '1', 02:15:22 INFO - 'TERM': 'linux', 02:15:22 INFO - 'TMOUT': '86400', 02:15:22 INFO - 'USER': 'cltbld', 02:15:22 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461920608.472091-1451329270', 02:15:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:22 INFO - '_': '/tools/buildbot/bin/python'} 02:15:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:23 INFO - Downloading/unpacking flake8 02:15:23 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 02:15:23 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 02:15:23 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 02:15:23 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 02:15:23 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 02:15:23 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 02:15:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:15:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:15:24 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 02:15:24 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 02:15:24 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 02:15:24 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 02:15:24 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 02:15:24 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 02:15:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:15:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:15: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 02:15: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 02:15: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 02:15: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 02:15: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 02:15: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 02:15:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:15: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 02:15: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 02:15: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 02:15: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 02:15: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 02:15: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 02:15:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:15:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:15:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:15:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:15:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:15:25 INFO - no previously-included directories found matching 'docs/_build' 02:15:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:15:25 INFO - Running setup.py install for pep8 02:15:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:15:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:15:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:15:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:15:25 INFO - no previously-included directories found matching 'docs/_build' 02:15:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:15:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:15:25 INFO - Cleaning up... 02:15:25 INFO - Return code: 0 02:15:25 INFO - Running post-action listener: _resource_record_post_action 02:15:25 INFO - Running post-action listener: _start_resource_monitoring 02:15:25 INFO - Starting resource monitoring. 02:15:25 INFO - ##### 02:15:25 INFO - ##### Running install step. 02:15:25 INFO - ##### 02:15:25 INFO - Running pre-action listener: _resource_record_pre_action 02:15:25 INFO - Running main action method: install 02:15:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:15:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:15:26 INFO - Reading from file tmpfile_stdout 02:15:26 INFO - Detecting whether we're running mozinstall >=1.0... 02:15:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:15:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:15:26 INFO - Reading from file tmpfile_stdout 02:15:26 INFO - Output received: 02:15:26 INFO - Usage: mozinstall [options] installer 02:15:26 INFO - Options: 02:15:26 INFO - -h, --help show this help message and exit 02:15:26 INFO - -d DEST, --destination=DEST 02:15:26 INFO - Directory to install application into. [default: 02:15:26 INFO - "/builds/slave/test"] 02:15:26 INFO - --app=APP Application being installed. [default: firefox] 02:15:26 INFO - mkdir: /builds/slave/test/build/application 02:15:26 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'] 02:15:26 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 02:15:42 INFO - Reading from file tmpfile_stdout 02:15:42 INFO - Output received: 02:15:42 INFO - /builds/slave/test/build/application/firefox/firefox 02:15:42 INFO - Running post-action listener: _resource_record_post_action 02:15:42 INFO - ##### 02:15:42 INFO - ##### Running run-tests step. 02:15:42 INFO - ##### 02:15:42 INFO - Running pre-action listener: _resource_record_pre_action 02:15:42 INFO - Running main action method: run_tests 02:15:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:15:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:15:42 INFO - Python 2.7.3 02:15:42 INFO - Return code: 0 02:15:42 INFO - grabbing minidump binary from tooltool 02:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:15:42 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 0x163e810>, '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 0x163f710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x163fba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:15:42 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 02:15:42 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 02:15:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:15:42 INFO - Return code: 0 02:15:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:15:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:15:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:15:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:15:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:15:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:15:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:15:43 INFO - Return code: 0 02:15:43 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ADV3nDuxSjqsQL18Yw52mw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:15:43 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ADV3nDuxSjqsQL18Yw52mw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:15:43 INFO - Using env: {'DISPLAY': ':0', 02:15:43 INFO - 'HOME': '/home/cltbld', 02:15:43 INFO - 'LANG': 'en_US.UTF-8', 02:15:43 INFO - 'LANGUAGE': 'en_US:en', 02:15:43 INFO - 'LOGNAME': 'cltbld', 02:15:43 INFO - 'MAIL': '/var/mail/cltbld', 02:15:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:15:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:15:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:43 INFO - 'MOZ_NO_REMOTE': '1', 02:15:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:15:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:15:43 INFO - 'NO_EM_RESTART': '1', 02:15:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:15:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:43 INFO - 'PWD': '/builds/slave/test', 02:15:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:15:43 INFO - 'SHELL': '/bin/bash', 02:15:43 INFO - 'SHLVL': '1', 02:15:43 INFO - 'TERM': 'linux', 02:15:43 INFO - 'TMOUT': '86400', 02:15:43 INFO - 'USER': 'cltbld', 02:15:43 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461920608.472091-1451329270', 02:15:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:43 INFO - '_': '/tools/buildbot/bin/python'} 02:15:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ADV3nDuxSjqsQL18Yw52mw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:15:43 INFO - mozversion application_buildid: 20160428233030 02:15:43 INFO - mozversion application_changeset: 37465cb0c50550fd6f673223942b3c479e39e569 02:15:43 INFO - mozversion application_display_name: Nightly 02:15:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:15:43 INFO - mozversion application_name: Firefox 02:15:43 INFO - mozversion application_remotingname: firefox 02:15:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:15:43 INFO - mozversion application_vendor: Mozilla 02:15:43 INFO - mozversion application_version: 49.0a1 02:15:43 INFO - mozversion platform_buildid: 20160428233030 02:15:43 INFO - mozversion platform_changeset: 37465cb0c50550fd6f673223942b3c479e39e569 02:15:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:15:43 INFO - mozversion platform_version: 49.0a1 02:15:43 INFO - using testdate: 1461921343 02:15:43 INFO - actual date: 1461921343 02:15:43 INFO - starting webserver on 'localhost:36432' 02:15:43 INFO - SUITE-START | Running 2 tests 02:15:43 INFO - TEST-START | dromaeo_css 02:15:43 INFO - operating with platform_type : linux_ 02:15:43 INFO - Initialising browser for dromaeo_css test... 02:15:43 INFO - TEST-INFO | started process 16706 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpesRpQs/profile http://localhost:36432/getInfo.html) 02:15:48 INFO - PROCESS | 16706 | __metrics Screen width/height:1600/1200 02:15:48 INFO - PROCESS | 16706 | colorDepth:24 02:15:48 INFO - PROCESS | 16706 | Browser inner width/height: 1024/697 02:15:48 INFO - PROCESS | 16706 | __metrics 02:15:49 ERROR - PROCESS | 16706 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:15:50 INFO - TEST-INFO | 16706: exit 0 02:15:50 INFO - Browser initialized. 02:15:50 INFO - Running cycle 1/1 for dromaeo_css test... 02:15:50 INFO - TEST-INFO | started process 16789 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpesRpQs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:16:02 INFO - PROCESS | 16789 | RSS: Main: 153927680 02:16:02 INFO - PROCESS | 16789 | 02:16:53 INFO - PROCESS | 16789 | 1461921413118 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] 02:19:00 INFO - PROCESS | 16789 | Cycle 1(1): loaded http://localhost:36432/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36432/tests/dromaeo/cssquery-ext.html) 02:19:01 INFO - PROCESS | 16789 | RSS: Main: 255311872 02:19:01 INFO - PROCESS | 16789 | 02:22:04 INFO - PROCESS | 16789 | Cycle 1(1): loaded http://localhost:36432/tests/dromaeo/cssquery-ext.html (next: http://localhost:36432/tests/dromaeo/cssquery-jquery.html) 02:22:04 INFO - PROCESS | 16789 | RSS: Main: 238710784 02:22:04 INFO - PROCESS | 16789 | 02:25:06 INFO - PROCESS | 16789 | Cycle 1(1): loaded http://localhost:36432/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36432/tests/dromaeo/cssquery-mootools.html) 02:25:07 INFO - PROCESS | 16789 | RSS: Main: 239542272 02:25:07 INFO - PROCESS | 16789 | 02:28:09 INFO - PROCESS | 16789 | Cycle 1(1): loaded http://localhost:36432/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36432/tests/dromaeo/cssquery-prototype.html) 02:28:09 INFO - PROCESS | 16789 | RSS: Main: 230793216 02:28:09 INFO - PROCESS | 16789 | 02:31:12 INFO - PROCESS | 16789 | Cycle 1(1): loaded http://localhost:36432/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36432/tests/dromaeo/cssquery-yui.html) 02:31:13 INFO - PROCESS | 16789 | RSS: Main: 213364736 02:31:13 INFO - PROCESS | 16789 | 02:34:15 INFO - PROCESS | 16789 | Cycle 1(1): loaded http://localhost:36432/tests/dromaeo/cssquery-yui.html (next: http://localhost:36432/tests/dromaeo/cssquery-dojo.html) 02:34:15 INFO - PROCESS | 16789 | RSS: Main: 264785920 02:34:15 INFO - PROCESS | 16789 | 02:34:15 INFO - PROCESS | 16789 | __start_tp_report 02:34:15 INFO - PROCESS | 16789 | _x_x_mozilla_page_load 02:34:15 INFO - PROCESS | 16789 | _x_x_mozilla_page_load_details 02:34:15 INFO - PROCESS | 16789 | |i|pagename|runs| 02:34:15 INFO - PROCESS | 16789 | |0;dojo.html;3072.8309942953138;3135.5923729915107;3164.6835316468355;3170.508571171468;3205.2147223930133;5067.543921047105;5107.744612769356;5162.7160506172195;5172.715500647463;5206.193040078789;5208.322918020652;5215.374155101393;5246.422893481714;5297.894042119165;5311.362636483617;4668.11305851887;4688;4701.48283688794;4749.026449577828;4854.97572512137;4778.259369797687;4786.401699787527;4815.036992601476;4832.565069143777;4873.366462359888;4591.127685739715;4715.056988602276;4718.41019872516;4775.283707443877;4776.665633405663;4709.858704238844;4741.336212930192;4750.168720473903;4758.476567577563;4786.952130478686;4642.048380082075;4725.976370118162;4728;4728.054389122155;4750.073735621555;5061.392632884041;5076.314697515825;5086.287919691246;5129.461406552296;5135.691858488465;5450.127979523258;5470.316210473691;5476.780928762884;5482.533984611313;5526.226328314039;5390.568754499631;5503.9174412383845;5527.115661494142;5553.500184983371;5604.775808967677;5191;5210.036143313499;5215.0873597120735;5216.7230555805;5257.13257312543;5637.520810731052;5638.520725738276;5639.041362968305;5639.943600564024;5654.491095801315;5281.339832520935;5355.277037599952;5443.755031023535;5446.945530544723;5449.945500545023;5410.891782164414;5425.240466334716;5425.674459532441;5451.618386712971;5472;5445.128779395357;5446.2375267462585;5447.53695935842;5449;5498.45015498447;5394.91907621386;5567.137093750475;5596.1605759136455;5633.971830140905;5654.6324488908085;4272.700910936267;4286.935695964563;4288.292431748727;4293.677974151951;4321.027768752068;3652.36083685354;3856.2287542491613;3871.690264778811;3883.922321553553;3911.2764138634443;5303.28405665238;5309.628326017141;5310.628256022042;5317.867053323621;5362.436944120811;5421.078416669176;5478.726063696879;5482.068048431776;5487.314085739283;5548.805791797348;5232.084385232569;5259.894802103937;5288.788448462095;5348.786048558092;5370.543503802142;4722.527747225318;4760.738159401197;4764.904701905943;4780.211265141213;4801.327814106028;5860.941390586039;5863.091220860773;5864;5865.589408741433;5880.117982302603;5364.222187782828;5527.944720552904;5574.358948720868;5580.051391263414;5643.435656434323;5858.47273745365;5871.970640146772;5880.529557635294;5882.205902203148;5922.703864806656;5479.315085614298;5496.615236933376;5506.311711036121;5508.394076651645;5508.9724551376985;5360.0619891518045;5517.337919449692;5570.053090974625;5585.832425027255;5613.017721898733;5487.64330318528;5489.670619762827;5490.121580547093;5494.066008778437;5520.91718624229;5433.891322173614;5464.1257398816;5464.3442786865835;5473.06957817164;5535.7785688572;5166.6125040621355;5318.202269659582;5405;5405.540529055074;5406.702631355313;5451.509364157245;5477.20580515815;5479.342478902558;5481.671099734029;5486.588505861996;5406.378266499403;5465.453454654662;5466.753996070107;5468.3711373191;5488.506034456918 02:34:15 INFO - PROCESS | 16789 | |1;ext.html;605.0953824033071;623.6164758673417;645.7739791073125;660.1154453032935;671.2247354305775;30450.390992180142;38249.23501529971;38983.41524877129;39119.41320880182;39219;40984.59015409845;41604.58395416045;41743.79128104355;41759.956001099985;41872;7239.674214660353;7493.625318734069;8437.28283095936;8709.129087091304;8714;9868.358556693827;10078.34490758102;10087.798244035115;10136.23978201634;10138.797224055514;10168.796624067514;10334.7416314592;10335.844962325571;10343.275970682056;10343.327683700572;7175.60534170623;7447.069116360455;7458;10066.69799906004;10092.444915529642;10052.195824334036;10203.336783109075;10221.488925553693;10227.693169204862;10235.283530152892;37917.24165516702;38618.227635447416;38634;38642.420363694284;38674;3410.1474631342167;3562.71498280137;3573.8927832165077;3633.418653015505;4102.958970410317;30072.84963575168;33120.668793312;33129.3374132516;33191.502127468106;33229.16927076818;4297.376880352363;4326.740395576276;4463.464384273875;4550.453945526525;4553.54464553542;329033;332886;333425.66158861254;334459;335059.99999999756;33778;34400.311993759984;34400.655993439745;62317.442063947856;62386.37613623896;35027.82486087553;35244.823775880956;35249.11877203039;35344.293114137574;35344.46983295253;14565.053271537528;14784.852151478563;14785.408583656748;14788.852111478962;14794.112353258624;12089.335086570323;12131.757364852654;12146;12153.5138594457;12154.635360939186;8777.210051095304;8793.912060879436;8801.07588703177;8841.292696584258;8889.155530224618;3363.293708321231;3398.5072164536004;3429.7599168058496;3450.258194488197;3490.424080026818;1005.1355833982769;1009.4952523738131;1064.297563608015;1097.160672085855;1105.0441368216595;32681.50977735336;32998.3400331992;33219.3356132876;33343.49984750231;33539.161520962174;1058.8623478947688;1098.5056724474018;1105.6019832860163;1107.7064577886867;1225.1301575881225;17007.914960425118;17078;17289;17447.56381090483;17573.03348315855;493594;495781;498109;499943;501707;58254.70872645694;58868.705656471444;58929.41070589325;58951.410485894594;59064.40935590675;1292.386116594629;1309.7315050414643;1314.7567699975534;1334.8197993270785;1434.985650143506;30083.84958075283;31785.13933745974;32236.677633224306;32475.18812029718;32509.187270317485;49693;50433.74783126061;50465;50490.49509504858;50492.24261636005;408085;415786;416076;417644;417788;23368.76631233666;23888.880555597807;23898.641520377558;28463.43073138484;29090;35070.12324691903;43286;43319.78340108405;46101;47387.28919066286;38531.2293754129;38607.6139238604;39359.80320098381;39573.80213098916;39837.40243896402;38314.6168538311;38797.80601096976;39213.647181169224;39292.21415571615;40027.79986100051;39381;40336.1932761349;40361.59638403579;41305;41373;33441.331173376886;34745;35300.82349588236;35435.64564354427;35712.8214358937;27022.594661080493;27173.86413067922;27918.059072994656;27948.40049522751;27972.16083517498 02:34:15 INFO - PROCESS | 16789 | |2;jquery.html;371.74721189591065;390.08719596145016;397.19369679550516;400.6314190944331;401.1815895573029;17144.485665430042;19404.320848770294;19643.803561964378;19696.803031969677;19734.309299174532;18368.17343219555;18805.24779008838;18871.433856984313;19006.239750409968;19159.137838797255;5417.83746487604;5446.264754258164;5613.298337707786;5646.943530564703;5664.971675141618;5629.493345598895;5636.661800291975;5657.20799088128;5676.347220069703;5678.943210567903;5069.2649565812935;5115.283860259567;5388.0570900092525;5628.887422251552;5634.32388113427;5134.486551344873;5315.654482458647;5337.893242135175;5359.5712343012465;5367.785288588452;5306.416294207634;5309.522143007148;5325.440828713007;5332.14685650298;5332.986732520847;13002.804957925639;13088.149270297401;15105.39578416862;21261.36215913525;21431.464213394633;2131.6802479628027;2267.444476103365;2327.7439481657;2383.535210633927;2624.409507860716;8674.175953284428;8990.145936136056;9992.10071093605;11562.884371156264;14175.85824141766;1905.1902941250053;1934.6517626827165;1940.0396803582175;1971.9112639931238;2017.6065667194903;79572;82434.58782706049;82905;83425.58287208524;84693.15306846914;10809.67570972872;10849.24055316136;10892.782144357068;10942.671719848417;11146.219764616399;15281.388744450098;15319.693606127816;15320.616984575252;15334.386624535116;15340.92329538345;7759.68961241544;8113.391495637851;8214.548199849065;8235;8274.420790544604;7792.454528182972;7793.441311737675;7849.686012559434;7989.320907722792;8066.23370779775;4670.813167473331;4686.718796872198;4690.95309046912;4694.652673663169;4789.473157952622;1910.560571068662;1915.4732448576754;1930.197510903546;1941.5825597496605;1975.782663906969;906.8277027364779;1001.0940099210227;1029.3360782295379;1108.83921831334;1115.3308015190983;17678;19106.71339929902;19166.233350665818;19250.80749192518;19332.457814009904;958.5351104714208;979.7501637082498;979.9020097990286;996.8604395384652;999.7600575861741;10498.842517362245;10581.735456613646;10721.410322432184;10738.302010369458;10815.83776243357;499348;500083;503534;503615;507607;89740;92342.53828730814;93950.53024734833;95713;96174;1002.1631937332263;1014.4471263161447;1050.9159267258601;1063.500154927183;1079.4656644960637;16030.839691602934;16265.75601366004;16715.247813848648;17005.65988680244;17323.133843307533;39391.606083938794;39964.800175998935;40287.59712402838;41379.1724165521;42127.789361053;53113.468865312396;55877.16184257158;55915.72042139763;55948.440515594324;55964.16053759278;8547.529885856338;8554.358423118167;8586.797848301369;8875.156860098281;8947.150020748019;10944.78110437771;13406.128601640861;13600.591982240152;13604.795928061285;13766.24285664258;10843.240973131806;10981.542745086159;11149.212696825794;11236.381998990135;11269.718257043312;11308.604198853001;11492.31046137201;11652.766944660889;11656.766864662828;11715.941420292844;10691.732706682395;11020.944895275472;11133.94022105913;11248.606298779503;11402.315861048364;8503.204424301794;8638.17937295956;8735.213830755009;8766.780830479289;8789.604467798836;10577.524011419351;10791.784164316512;10924.726881828017;11176.329420234812;11244.83132752993 02:34:15 INFO - PROCESS | 16789 | |3;mootools.html;1302.863199364066;1451.0930668332292;1488.4343949299266;1596.329541592531;1768.1866341482926;7653.885191722122;7935.047794264697;7956.443048986574;7965.681372745091;7973.12295647479;7800.843983120334;7934.3255823255095;7939.404544659144;7958.0450345958425;7983.12185659577;1961.9019049047563;2021.8079282468143;2023.8380929525676;2334.439734463725;2364.0661938534267;2284.303287497313;2363.52729454109;2368.656544801003;2368.7275963264274;2370.2533701883935;2274.0789980058103;2287.5196208796174;2306.5271619318;2309.983607212821;2332.7550607186254;1938.7285779990812;2007.3676791810533;2309.399556115414;2330.82518811089;2332.7317358503733;1963.0381113254546;2212.1814928476406;2292.7363353214428;2292.7592602776804;2296.552172326397;7577.507462014952;7687.6156192190165;7695.923040769577;7703.268189521987;7710.537367757953;4769;4900.387451568554;4913.533214344631;4957;4958.157113290749;3052.771042171846;3073.800202986799;3120.251139726472;3139.9843000785077;3148.937021259585;991.3853410885225;1017.3793985668736;1018.7809620931536;1035.8446233065101;1037.1435131115295;10665.306755060896;10990.890091099067;11047.72380690489;11104.222704410695;11106.44467776608;4384.934225986613;4397.340398940185;4448.466184057869;4475.888102797456;4499.910001799945;9467;9478.95260523693;9483.620655173716;9483.810323793485;9484.19384352324;4972.453030166679;5043.420006699276;5047.848564543069;5050.419201791841;5053.36832895888;4015.5382131055303;4534.614557762561;4639;4679.953200467951;4684.672072954929;3841.750286231386;3920.862769803043;3926.1951299983434;3936.940945885814;3969.4442778011103;1270.4600544768437;1302.5375991523063;1305.797601371789;1315.375196781521;1317.637649646355;706.3713295167305;789.8617741895146;918.6555041859302;922.2990527199377;931.5668214280392;5232.738363081907;5475.67145971243;5494.615376923577;5501.697406642673;5507.504324610804;393.5258014093011;396.10085106807384;396.3440505962636;396.5142700192299;416.2299745470855;3587.605363410075;3659.5059666945153;3675.448682697563;3679;3708.870189543353;9707.466089365153;10158.13655839262;10170.338927969658;10179.389236645826;10306.48467576633;9916.851247231298;10175.28772985884;10239;10240.385576865412;10257.076863082359;7822.100458447351;7833.921660783433;7865.606719663994;7870.543949369385;7912.762617121495;5484.369297530835;5512.310961129859;5514.751836167302;5645.548356131418;5653.038983372919;9092.181703646704;9427.434353938786;9454.385464944757;9497.952510237405;9519.762005949906;8829.16122968317;9129.360944733804;9221.723348299562;9244.260459163384;9535;6406.839829004312;6805.625690587065;7022.929770702228;7127.180374257026;7278.781636550912;7779.33875620556;7802.843943121219;7847.411444141598;7871.48835325702;7880.763577092696;6834.2140653825445;6973.755918542826;7012.474064445289;7038.788836334918;7151.964240178766;7168.2831716827895;7203.243659415895;7267.30960558746;7334.96332518334;7408.814779630552;6533.738650453929;6634.701438435379;6645.634490102897;6650.235222949229;6659;4691.812327506998;4730.172219861579;4794.544518270759;4800.639952003544;4840.588549973151;4778.737169455713;4780.282957556395;4793.784279707352;4889.217725163957;4913.287573301923 02:34:15 INFO - PROCESS | 16789 | |4;prototype.html;308.79156569315705;319.8776120440874;321.02408677620036;322.18005176824977;324.85219225252513;5033.270175824503;5148.382194136709;5170.9482905170935;5203.869903252421;5224.033553792551;5163.3545806774155;5205.843824685256;5229.300477344859;5229.764660590273;5242.135047717122;4095.344744840826;4108.753474791522;4108.979455102721;4119.917601647965;4136.110736191718;3895.9805200973956;3924.803759811998;4129.855455059073;4139.523954745213;4149.792510374485;4004.379321205218;4032.8790136295956;4061.735987160825;4082.203970225792;4089.407035979781;4014.1570270243283;4059.2896243157625;4072.409500622423;4075.225707115653;4078.5921407859273;3488.1628409181612;3574.338747331726;3608;3609.2420591675777;3615.8192090395637;4988.106897999151;4996.725180115092;4996.975015124937;5025.190931264742;5030.346055012861;4654.813807447698;4658.627309815207;4689.929651055237;4705.12955103307;4706.552877476634;5236.502532259429;5415.702136382497;5418.7807743257845;5421.918671219935;5438.45615438453;3868.226354729037;3919.470871432377;3948.2103579284258;3953.367461206222;3955.8022098895226;5609.551235901118;5633.690147041911;5651;5663.150527420919;5678.3186017678145;4024.557298697141;4031.334829753058;4049.311617025113;4052.3111071117983;4075.0627355708352;3950.4666869972184;4125.876223713293;4126.112885729583;4141.295979683461;4149.543550209474;4626.352310676508;4626.583607475343;4627.490975992638;4635.361241425532;4656.8137274508645;5214.835843125136;5425.321834770653;5444.863878403072;5463.836084917459;5473.2063850741415;1428.3215472650409;1480.4744315767962;1485.4355344968842;1487.7545205041047;1495.827979782339;997.4713401897006;1010.8129995950773;1017.9949100254452;1020.3979652005353;1026.1431704526804;5660.915086273709;5667.744951477193;5671.602987790898;5688.374278829326;5689.431056894277;5887.8233652990475;5891.499222566044;5911.793087242012;5914.645121292736;5936.584439089309;5532.695701736363;5590.580706447033;5637.379888212294;5654.717264136777;5669.801556945487;3139.199504126433;3141.3403185331335;3150.480170771843;3156.542301366335;3161.668024857357;6037.698115094227;6216.129741836146;6216.129741836146;6225.719842607094;6244.968775156186;6005.129256257818;6009.45914867664;6057.636541807506;6063.605865618809;6099.237595300588;6079.483243924316;6173.56785025044;6227.314995350508;6240.65825847445;6252.374762523711;5706.28671416073;5909;5914.526837853047;5919.260092488439;5922.851928701644;5866.41335866427;5879.382664820132;5887.735051922759;5889.852753681193;5892.941070589411;6120.265568131853;6229.96885015572;6237.937620623918;6239.469645080219;6241.96879015602;4214.1150358425075;4234.534201237923;4243.408721729352;4250.192463431938;4276.358546218092;5366.785328586813;5463.31708536433;5902.527797776082;5929.673867937132;5939.198208241832;4970.602351811919;5386.542143917654;5429.724014856427;5456.863578410572;5499.350194941421;5452.372977107525;5461.013460174175;5467;5471.753771080232;5480.725963701879;5391.406945235943;5393.541548968382;5404.43253458397;5421.512063914267;5438.184272359178;5203;5447.836564903059;5495.807646732345;5546.973809845192;5556.16657501378;5376.1398176291605;5381.681488035457;5396.676199428047;5425.9961907045745;5439.700816454974 02:34:15 INFO - PROCESS | 16789 | |5;yui.html;705.6718625838985;724.0840336973729;728.8068661804626;762.4586543554076;768.846230753849;13497.865021349784;13909.165450073002;13943.302834858254;13955.651108722286;13961.720765584681;11460.140489463303;11539;11547.942260288686;11566.363849988247;11567.65297041088;651.4495251512488;777.6966982876683;802.5585927739749;804.2399932064202;804.694216197844;802.5545822068749;806.5241507510567;810.1857633078747;810.8216192437654;813.2314962360572;685.725709716115;851.5103815306193;851.5614458553849;851.6721062390993;854.7948492361851;824.4846970643348;840.0465471689615;844.4384484317922;844.4553263145237;846.0101681033175;615.1111643674892;615.2432508015122;615.7506209984963;616.8951278282702;617.6263360666821;13507.189568625914;13622.93188534051;13638.045336826426;13638.181709097387;13658.453661853513;14165.362558684781;14456.783148252785;14485.203313817736;14503;14597.416103355854;11295.830562541569;11630.592929247521;11779.352135632536;11857.703557411134;12132.332721700302;3714.7028237741188;3719.6466335698337;3746.981265093684;3876.4379165021196;3881.7282790204695;51266.48733512654;51671;52762.47237527652;55522.889542209334;55538.72230638821;11159.218854680257;11406.478475302916;11492.540298388138;11678.591249306233;11823.231489953125;18914;19007.33474328392;19028.80971190298;19433.125509352114;20570.382888513068;7742.7677169685;7933.801654958556;7966.880496792553;8028.277455029075;8140.877886831702;4382.956170438319;4662.883427914329;4671;4682.695624784378;4740.810367585258;3287.917802054968;3362.1930736623035;3363.9495407568907;3364.899053028413;3377.4258376076127;589.8201048680194;613.6931534232883;614.1463365921372;614.6496496996758;617.043582447205;611.8500967263049;633.7718421368304;655.6885479397248;670.2493207607413;679.9626020568916;8281.875771863426;8748.300135989233;8798.428102173339;8871.866921996176;8966.955165224132;618.3136718242837;637.9936200637934;649.302000349626;660.1582981698277;664.6743095882982;3668.63313668631;3990.940135897964;4008.819603117867;4047.2310261050893;4112.177564487115;55557;64185.67907160528;66800.33199668038;66824;66831.3316866825;53406;54024.33060886328;54431.455685443434;56227.71886140543;56332.43667563354;51764.48235517597;52060.73969630127;52166.73916630392;52633;53794.46205537973;8467.280281176169;8573.65705371803;8632.179942905414;8720;8728.78178045554;33112.66887331192;33727;34160.31679366448;34670;34801.82599087089;43078.78460607677;46425;46434.767826160656;46758.298625519965;47078.76460617675;10360.844587331347;10682.57269709203;11182.389560038562;11287.661370158909;11400.087992960709;12143.696407589881;12223.083268755057;12347.13570050088;12362.134650574373;12367.443465044274;10417.322874013165;10875.510602023087;10884;11090.889091108986;11147.554097835995;11752;11769;12052.638420847037;12204.694882628006;12251.08116891219;11383.54465821391;11552.6534203974;11554.133439991867;11577.421128943688;11603.709907252387;9185.127412895765;9426.340156189;9486.762830929281;9520.23838092937;9582.952085239529;9365.859512107187;9461.195798357217;9559.23526117895;9623.759406014906;9628.422294662343 02:34:15 INFO - PROCESS | 16789 | __end_tp_report 02:34:15 INFO - PROCESS | 16789 | __start_cc_report 02:34:15 INFO - PROCESS | 16789 | _x_x_mozilla_cycle_collect,847 02:34:15 INFO - PROCESS | 16789 | __end_cc_report 02:34:15 INFO - PROCESS | 16789 | __startTimestamp1461922455684__endTimestamp 02:34:15 INFO - PROCESS | 16789 | 02:34:15 INFO - PROCESS | 16789 | ------- Summary: start ------- 02:34:15 INFO - PROCESS | 16789 | Number of tests: 6 02:34:15 INFO - PROCESS | 16789 | 02:34:15 INFO - PROCESS | 16789 | [#0] dojo.html Cycles:165 Average:5171.29 Median:5394.92 stddev:566.20 (10.5%) stddev-sans-first:543.48 02:34:15 INFO - PROCESS | 16789 | Values: 3072.8 3135.6 3164.7 3170.5 3205.2 5067.5 5107.7 5162.7 5172.7 5206.2 5208.3 5215.4 5246.4 5297.9 5311.4 4668.1 4688.0 4701.5 4749.0 4855.0 4778.3 4786.4 4815.0 4832.6 4873.4 4591.1 4715.1 4718.4 4775.3 4776.7 4709.9 4741.3 4750.2 4758.5 4787.0 4642.0 4726.0 4728.0 4728.1 4750.1 5061.4 5076.3 5086.3 5129.5 5135.7 5450.1 5470.3 5476.8 5482.5 5526.2 5390.6 5503.9 5527.1 5553.5 5604.8 5191.0 5210.0 5215.1 5216.7 5257.1 5637.5 5638.5 5639.0 5639.9 5654.5 5281.3 5355.3 5443.8 5446.9 5449.9 5410.9 5425.2 5425.7 5451.6 5472.0 5445.1 5446.2 5447.5 5449.0 5498.5 5394.9 5567.1 5596.2 5634.0 5654.6 4272.7 4286.9 4288.3 4293.7 4321.0 3652.4 3856.2 3871.7 3883.9 3911.3 5303.3 5309.6 5310.6 5317.9 5362.4 5421.1 5478.7 5482.1 5487.3 5548.8 5232.1 5259.9 5288.8 5348.8 5370.5 4722.5 4760.7 4764.9 4780.2 4801.3 5860.9 5863.1 5864.0 5865.6 5880.1 5364.2 5527.9 5574.4 5580.1 5643.4 5858.5 5872.0 5880.5 5882.2 5922.7 5479.3 5496.6 5506.3 5508.4 5509.0 5360.1 5517.3 5570.1 5585.8 5613.0 5487.6 5489.7 5490.1 5494.1 5520.9 5433.9 5464.1 5464.3 5473.1 5535.8 5166.6 5318.2 5405.0 5405.5 5406.7 5451.5 5477.2 5479.3 5481.7 5486.6 5406.4 5465.5 5466.8 5468.4 5488.5 02:34:15 INFO - PROCESS | 16789 | 02:34:15 INFO - PROCESS | 16789 | [#1] ext.html Cycles:180 Average:56012.97 Median:35246.97 stddev:111592.54 (316.6%) stddev-sans-first:111828.04 02:34:15 INFO - PROCESS | 16789 | Values: 605.1 623.6 645.8 660.1 671.2 30450.4 38249.2 38983.4 39119.4 39219.0 40984.6 41604.6 41743.8 41760.0 41872.0 7239.7 7493.6 8437.3 8709.1 8714.0 9868.4 10078.3 10087.8 10136.2 10138.8 10168.8 10334.7 10335.8 10343.3 10343.3 7175.6 7447.1 7458.0 10066.7 10092.4 10052.2 10203.3 10221.5 10227.7 10235.3 37917.2 38618.2 38634.0 38642.4 38674.0 3410.1 3562.7 3573.9 3633.4 4103.0 30072.8 33120.7 33129.3 33191.5 33229.2 4297.4 4326.7 4463.5 4550.5 4553.5 329033.0 332886.0 333425.7 334459.0 335060.0 33778.0 34400.3 34400.7 62317.4 62386.4 35027.8 35244.8 35249.1 35344.3 35344.5 14565.1 14784.9 14785.4 14788.9 14794.1 12089.3 12131.8 12146.0 12153.5 12154.6 8777.2 8793.9 8801.1 8841.3 8889.2 3363.3 3398.5 3429.8 3450.3 3490.4 1005.1 1009.5 1064.3 1097.2 1105.0 32681.5 32998.3 33219.3 33343.5 33539.2 1058.9 1098.5 1105.6 1107.7 1225.1 17007.9 17078.0 17289.0 17447.6 17573.0 493594.0 495781.0 498109.0 499943.0 501707.0 58254.7 58868.7 58929.4 58951.4 59064.4 1292.4 1309.7 1314.8 1334.8 1435.0 30083.8 31785.1 32236.7 32475.2 32509.2 49693.0 50433.7 50465.0 50490.5 50492.2 408085.0 415786.0 416076.0 417644.0 417788.0 23368.8 23888.9 23898.6 28463.4 29090.0 35070.1 43286.0 43319.8 46101.0 47387.3 38531.2 38607.6 39359.8 39573.8 39837.4 38314.6 38797.8 39213.6 39292.2 40027.8 39381.0 40336.2 40361.6 41305.0 41373.0 33441.3 34745.0 35300.8 35435.6 35712.8 27022.6 27173.9 27918.1 27948.4 27972.2 02:34:15 INFO - PROCESS | 16789 | 02:34:15 INFO - PROCESS | 16789 | [#2] jquery.html Cycles:180 Average:29047.51 Median:1498.08 stddev:82922.39 (5535.3%) stddev-sans-first:83127.06 02:34:15 INFO - PROCESS | 16789 | Values: 371.7 390.1 397.2 400.6 401.2 17144.5 19404.3 19643.8 19696.8 19734.3 18368.2 18805.2 18871.4 19006.2 19159.1 5417.8 5446.3 5613.3 5646.9 5665.0 5629.5 5636.7 5657.2 5676.3 5678.9 5069.3 5115.3 5388.1 5628.9 5634.3 5134.5 5315.7 5337.9 5359.6 5367.8 5306.4 5309.5 5325.4 5332.1 5333.0 13002.8 13088.1 15105.4 21261.4 21431.5 2131.7 2267.4 2327.7 2383.5 2624.4 8674.2 8990.1 9992.1 11562.9 14175.9 1905.2 1934.7 1940.0 1971.9 2017.6 79572.0 82434.6 82905.0 83425.6 84693.2 10809.7 10849.2 10892.8 10942.7 11146.2 15281.4 15319.7 15320.6 15334.4 15340.9 7759.7 8113.4 8214.5 8235.0 8274.4 7792.5 7793.4 7849.7 7989.3 8066.2 4670.8 4686.7 4691.0 4694.7 4789.5 1910.6 1915.5 1930.2 1941.6 1975.8 906.8 1001.1 1029.3 1108.8 1115.3 17678.0 19106.7 19166.2 19250.8 19332.5 958.5 979.8 979.9 996.9 999.8 10498.8 10581.7 10721.4 10738.3 10815.8 499348.0 500083.0 503534.0 503615.0 507607.0 89740.0 92342.5 93950.5 95713.0 96174.0 1002.2 1014.4 1050.9 1063.5 1079.5 16030.8 16265.8 16715.2 17005.7 17323.1 39391.6 39964.8 40287.6 41379.2 42127.8 53113.5 55877.2 55915.7 55948.4 55964.2 8547.5 8554.4 8586.8 8875.2 8947.2 10944.8 13406.1 13600.6 13604.8 13766.2 10843.2 10981.5 11149.2 11236.4 11269.7 11308.6 11492.3 11652.8 11656.8 11715.9 10691.7 11020.9 11133.9 11248.6 11402.3 8503.2 8638.2 8735.2 8766.8 8789.6 10577.5 10791.8 10924.7 11176.3 11244.8 02:34:15 INFO - PROCESS | 16789 | 02:34:15 INFO - PROCESS | 16789 | [#3] mootools.html Cycles:180 Average:5355.95 Median:4864.90 stddev:3004.53 (61.8%) stddev-sans-first:2997.51 02:34:15 INFO - PROCESS | 16789 | Values: 1302.9 1451.1 1488.4 1596.3 1768.2 7653.9 7935.0 7956.4 7965.7 7973.1 7800.8 7934.3 7939.4 7958.0 7983.1 1961.9 2021.8 2023.8 2334.4 2364.1 2284.3 2363.5 2368.7 2368.7 2370.3 2274.1 2287.5 2306.5 2310.0 2332.8 1938.7 2007.4 2309.4 2330.8 2332.7 1963.0 2212.2 2292.7 2292.8 2296.6 7577.5 7687.6 7695.9 7703.3 7710.5 4769.0 4900.4 4913.5 4957.0 4958.2 3052.8 3073.8 3120.3 3140.0 3148.9 991.4 1017.4 1018.8 1035.8 1037.1 10665.3 10990.9 11047.7 11104.2 11106.4 4384.9 4397.3 4448.5 4475.9 4499.9 9467.0 9479.0 9483.6 9483.8 9484.2 4972.5 5043.4 5047.8 5050.4 5053.4 4015.5 4534.6 4639.0 4680.0 4684.7 3841.8 3920.9 3926.2 3936.9 3969.4 1270.5 1302.5 1305.8 1315.4 1317.6 706.4 789.9 918.7 922.3 931.6 5232.7 5475.7 5494.6 5501.7 5507.5 393.5 396.1 396.3 396.5 416.2 3587.6 3659.5 3675.4 3679.0 3708.9 9707.5 10158.1 10170.3 10179.4 10306.5 9916.9 10175.3 10239.0 10240.4 10257.1 7822.1 7833.9 7865.6 7870.5 7912.8 5484.4 5512.3 5514.8 5645.5 5653.0 9092.2 9427.4 9454.4 9498.0 9519.8 8829.2 9129.4 9221.7 9244.3 9535.0 6406.8 6805.6 7022.9 7127.2 7278.8 7779.3 7802.8 7847.4 7871.5 7880.8 6834.2 6973.8 7012.5 7038.8 7152.0 7168.3 7203.2 7267.3 7335.0 7408.8 6533.7 6634.7 6645.6 6650.2 6659.0 4691.8 4730.2 4794.5 4800.6 4840.6 4778.7 4780.3 4793.8 4889.2 4913.3 02:34:15 INFO - PROCESS | 16789 | 02:34:15 INFO - PROCESS | 16789 | [#4] prototype.html Cycles:180 Average:4712.97 Median:5233.13 stddev:1406.61 (26.9%) stddev-sans-first:1371.16 02:34:15 INFO - PROCESS | 16789 | Values: 308.8 319.9 321.0 322.2 324.9 5033.3 5148.4 5170.9 5203.9 5224.0 5163.4 5205.8 5229.3 5229.8 5242.1 4095.3 4108.8 4109.0 4119.9 4136.1 3896.0 3924.8 4129.9 4139.5 4149.8 4004.4 4032.9 4061.7 4082.2 4089.4 4014.2 4059.3 4072.4 4075.2 4078.6 3488.2 3574.3 3608.0 3609.2 3615.8 4988.1 4996.7 4997.0 5025.2 5030.3 4654.8 4658.6 4689.9 4705.1 4706.6 5236.5 5415.7 5418.8 5421.9 5438.5 3868.2 3919.5 3948.2 3953.4 3955.8 5609.6 5633.7 5651.0 5663.2 5678.3 4024.6 4031.3 4049.3 4052.3 4075.1 3950.5 4125.9 4126.1 4141.3 4149.5 4626.4 4626.6 4627.5 4635.4 4656.8 5214.8 5425.3 5444.9 5463.8 5473.2 1428.3 1480.5 1485.4 1487.8 1495.8 997.5 1010.8 1018.0 1020.4 1026.1 5660.9 5667.7 5671.6 5688.4 5689.4 5887.8 5891.5 5911.8 5914.6 5936.6 5532.7 5590.6 5637.4 5654.7 5669.8 3139.2 3141.3 3150.5 3156.5 3161.7 6037.7 6216.1 6216.1 6225.7 6245.0 6005.1 6009.5 6057.6 6063.6 6099.2 6079.5 6173.6 6227.3 6240.7 6252.4 5706.3 5909.0 5914.5 5919.3 5922.9 5866.4 5879.4 5887.7 5889.9 5892.9 6120.3 6230.0 6237.9 6239.5 6242.0 4214.1 4234.5 4243.4 4250.2 4276.4 5366.8 5463.3 5902.5 5929.7 5939.2 4970.6 5386.5 5429.7 5456.9 5499.4 5452.4 5461.0 5467.0 5471.8 5480.7 5391.4 5393.5 5404.4 5421.5 5438.2 5203.0 5447.8 5495.8 5547.0 5556.2 5376.1 5381.7 5396.7 5426.0 5439.7 02:34:15 INFO - PROCESS | 16789 | 02:34:15 INFO - PROCESS | 16789 | [#5] yui.html Cycles:180 Average:14586.33 Median:51468.74 stddev:17409.85 (33.8%) stddev-sans-first:17427.48 02:34:15 INFO - PROCESS | 16789 | Values: 705.7 724.1 728.8 762.5 768.8 13497.9 13909.2 13943.3 13955.7 13961.7 11460.1 11539.0 11547.9 11566.4 11567.7 651.4 777.7 802.6 804.2 804.7 802.6 806.5 810.2 810.8 813.2 685.7 851.5 851.6 851.7 854.8 824.5 840.0 844.4 844.5 846.0 615.1 615.2 615.8 616.9 617.6 13507.2 13622.9 13638.0 13638.2 13658.5 14165.4 14456.8 14485.2 14503.0 14597.4 11295.8 11630.6 11779.4 11857.7 12132.3 3714.7 3719.6 3747.0 3876.4 3881.7 51266.5 51671.0 52762.5 55522.9 55538.7 11159.2 11406.5 11492.5 11678.6 11823.2 18914.0 19007.3 19028.8 19433.1 20570.4 7742.8 7933.8 7966.9 8028.3 8140.9 4383.0 4662.9 4671.0 4682.7 4740.8 3287.9 3362.2 3363.9 3364.9 3377.4 589.8 613.7 614.1 614.6 617.0 611.9 633.8 655.7 670.2 680.0 8281.9 8748.3 8798.4 8871.9 8967.0 618.3 638.0 649.3 660.2 664.7 3668.6 3990.9 4008.8 4047.2 4112.2 55557.0 64185.7 66800.3 66824.0 66831.3 53406.0 54024.3 54431.5 56227.7 56332.4 51764.5 52060.7 52166.7 52633.0 53794.5 8467.3 8573.7 8632.2 8720.0 8728.8 33112.7 33727.0 34160.3 34670.0 34801.8 43078.8 46425.0 46434.8 46758.3 47078.8 10360.8 10682.6 11182.4 11287.7 11400.1 12143.7 12223.1 12347.1 12362.1 12367.4 10417.3 10875.5 10884.0 11090.9 11147.6 11752.0 11769.0 12052.6 12204.7 12251.1 11383.5 11552.7 11554.1 11577.4 11603.7 9185.1 9426.3 9486.8 9520.2 9583.0 9365.9 9461.2 9559.2 9623.8 9628.4 02:34:15 INFO - PROCESS | 16789 | -------- Summary: end -------- 02:34:15 INFO - PROCESS | 16789 | 02:34:16 INFO - TEST-INFO | 16789: exit 0 02:34:16 INFO - TEST-OK | dromaeo_css | took 1112511ms 02:34:16 INFO - TEST-START | kraken 02:34:16 INFO - operating with platform_type : linux_ 02:34:16 INFO - Initialising browser for kraken test... 02:34:16 INFO - TEST-INFO | started process 16969 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLQZOwW/profile http://localhost:36432/getInfo.html) 02:34:20 INFO - PROCESS | 16969 | __metrics Screen width/height:1600/1200 02:34:20 INFO - PROCESS | 16969 | colorDepth:24 02:34:20 INFO - PROCESS | 16969 | Browser inner width/height: 1024/697 02:34:20 INFO - PROCESS | 16969 | __metrics 02:34:21 ERROR - PROCESS | 16969 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:34:22 INFO - TEST-INFO | 16969: exit 0 02:34:22 INFO - Browser initialized. 02:34:22 INFO - Running cycle 1/1 for kraken test... 02:34:22 INFO - TEST-INFO | started process 17050 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLQZOwW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:34:34 INFO - PROCESS | 17050 | RSS: Main: 153579520 02:34:34 INFO - PROCESS | 17050 | 02:34:37 INFO - PROCESS | 17050 | Cycle 1(1): loaded http://localhost:36432/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36432/tests/kraken/driver.html?testName=audio-beat-detection) 02:34:37 INFO - PROCESS | 17050 | RSS: Main: 208908288 02:34:37 INFO - PROCESS | 17050 | 02:34:40 INFO - PROCESS | 17050 | Cycle 1(1): loaded http://localhost:36432/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36432/tests/kraken/driver.html?testName=audio-dft) 02:34:41 INFO - PROCESS | 17050 | RSS: Main: 195014656 02:34:41 INFO - PROCESS | 17050 | 02:34:44 INFO - PROCESS | 17050 | Cycle 1(1): loaded http://localhost:36432/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36432/tests/kraken/driver.html?testName=audio-fft) 02:34:44 INFO - PROCESS | 17050 | RSS: Main: 265543680 02:34:44 INFO - PROCESS | 17050 | 02:34:46 INFO - PROCESS | 17050 | Cycle 1(1): loaded http://localhost:36432/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36432/tests/kraken/driver.html?testName=audio-oscillator) 02:34:47 INFO - PROCESS | 17050 | RSS: Main: 173699072 02:34:47 INFO - PROCESS | 17050 | 02:34:49 INFO - PROCESS | 17050 | Cycle 1(1): loaded http://localhost:36432/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36432/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:34:50 INFO - PROCESS | 17050 | RSS: Main: 177975296 02:34:50 INFO - PROCESS | 17050 | 02:34:53 INFO - PROCESS | 17050 | Cycle 1(1): loaded http://localhost:36432/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36432/tests/kraken/driver.html?testName=imaging-darkroom) 02:34:53 INFO - PROCESS | 17050 | RSS: Main: 214589440 02:34:53 INFO - PROCESS | 17050 | 02:34:57 INFO - PROCESS | 17050 | Cycle 1(1): loaded http://localhost:36432/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36432/tests/kraken/driver.html?testName=imaging-desaturate) 02:34:57 INFO - PROCESS | 17050 | RSS: Main: 214921216 02:34:57 INFO - PROCESS | 17050 | 02:35:00 INFO - PROCESS | 17050 | Cycle 1(1): loaded http://localhost:36432/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36432/tests/kraken/driver.html?testName=json-parse-financial) 02:35:01 INFO - PROCESS | 17050 | RSS: Main: 214450176 02:35:01 INFO - PROCESS | 17050 | 02:35:02 INFO - PROCESS | 17050 | Cycle 1(1): loaded http://localhost:36432/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36432/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:35:03 INFO - PROCESS | 17050 | RSS: Main: 203223040 02:35:03 INFO - PROCESS | 17050 | 02:35:05 INFO - PROCESS | 17050 | Cycle 1(1): loaded http://localhost:36432/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36432/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:35:05 INFO - PROCESS | 17050 | RSS: Main: 204767232 02:35:05 INFO - PROCESS | 17050 | 02:35:07 INFO - PROCESS | 17050 | Cycle 1(1): loaded http://localhost:36432/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36432/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:35:08 INFO - PROCESS | 17050 | RSS: Main: 215703552 02:35:08 INFO - PROCESS | 17050 | 02:35:10 INFO - PROCESS | 17050 | Cycle 1(1): loaded http://localhost:36432/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36432/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:35:11 INFO - PROCESS | 17050 | RSS: Main: 224145408 02:35:11 INFO - PROCESS | 17050 | 02:35:14 INFO - PROCESS | 17050 | Cycle 1(1): loaded http://localhost:36432/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36432/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:35:14 INFO - PROCESS | 17050 | RSS: Main: 221413376 02:35:14 INFO - PROCESS | 17050 | 02:35:16 INFO - PROCESS | 17050 | Cycle 1(1): loaded http://localhost:36432/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36432/tests/kraken/driver.html?testName=ai-astar) 02:35:16 INFO - PROCESS | 17050 | RSS: Main: 285458432 02:35:16 INFO - PROCESS | 17050 | 02:35:16 INFO - PROCESS | 17050 | __start_tp_report 02:35:16 INFO - PROCESS | 17050 | _x_x_mozilla_page_load 02:35:16 INFO - PROCESS | 17050 | _x_x_mozilla_page_load_details 02:35:16 INFO - PROCESS | 17050 | |i|pagename|runs| 02:35:16 INFO - PROCESS | 17050 | |0;ai-astar;108;111;106;110;110;112;98;110;109;109 02:35:16 INFO - PROCESS | 17050 | |1;audio-beat-detection;159;129;153;177;128;160;159;128;189;127 02:35:16 INFO - PROCESS | 17050 | |2;audio-dft;163;161;163;162;160;161;162;163;163;162 02:35:16 INFO - PROCESS | 17050 | |3;audio-fft;73;76;109;107;73;72;75;118;108;76 02:35:16 INFO - PROCESS | 17050 | |4;audio-oscillator;93;92;153;93;92;92;150;91;91;151 02:35:16 INFO - PROCESS | 17050 | |5;imaging-gaussian-blur;117;116;116;117;116;116;117;117;117;116 02:35:16 INFO - PROCESS | 17050 | |6;imaging-darkroom;146;145;146;145;146;145;145;146;146;146 02:35:16 INFO - PROCESS | 17050 | |7;imaging-desaturate;108;95;95;94;95;94;94;94;95;95 02:35:16 INFO - PROCESS | 17050 | |8;json-parse-financial;58;58;58;56;60;58;60;69;57;55 02:35:16 INFO - PROCESS | 17050 | |9;json-stringify-tinderbox;60;61;61;60;61;60;60;60;62;61 02:35:16 INFO - PROCESS | 17050 | |10;stanford-crypto-aes;77;75;75;76;78;84;76;77;77;77 02:35:16 INFO - PROCESS | 17050 | |11;stanford-crypto-ccm;127;125;137;122;121;120;120;123;161;126 02:35:16 INFO - PROCESS | 17050 | |12;stanford-crypto-pbkdf2;174;163;167;171;169;167;171;167;164;165 02:35:16 INFO - PROCESS | 17050 | |13;stanford-crypto-sha256-iterative;69;69;69;69;69;69;68;66;67;65 02:35:16 INFO - PROCESS | 17050 | __end_tp_report 02:35:16 INFO - PROCESS | 17050 | __start_cc_report 02:35:16 INFO - PROCESS | 17050 | _x_x_mozilla_cycle_collect,1606 02:35:16 INFO - PROCESS | 17050 | __end_cc_report 02:35:16 INFO - PROCESS | 17050 | __startTimestamp1461922516859__endTimestamp 02:35:16 INFO - PROCESS | 17050 | 02:35:16 INFO - PROCESS | 17050 | ------- Summary: start ------- 02:35:16 INFO - PROCESS | 17050 | Number of tests: 14 02:35:16 INFO - PROCESS | 17050 | 02:35:16 INFO - PROCESS | 17050 | [#0] ai-astar Cycles:10 Average:108.30 Median:110.00 stddev:3.97 (3.6%) stddev-sans-first:4.21 02:35:16 INFO - PROCESS | 17050 | Values: 108.0 111.0 106.0 110.0 110.0 112.0 98.0 110.0 109.0 109.0 02:35:16 INFO - PROCESS | 17050 | 02:35:16 INFO - PROCESS | 17050 | [#1] audio-beat-detection Cycles:10 Average:150.90 Median:159.00 stddev:22.24 (14.0%) stddev-sans-first:23.39 02:35:16 INFO - PROCESS | 17050 | Values: 159.0 129.0 153.0 177.0 128.0 160.0 159.0 128.0 189.0 127.0 02:35:16 INFO - PROCESS | 17050 | 02:35:16 INFO - PROCESS | 17050 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.50 stddev:1.05 (0.6%) stddev-sans-first:1.05 02:35:16 INFO - PROCESS | 17050 | Values: 163.0 161.0 163.0 162.0 160.0 161.0 162.0 163.0 163.0 162.0 02:35:16 INFO - PROCESS | 17050 | 02:35:16 INFO - PROCESS | 17050 | [#3] audio-fft Cycles:10 Average:88.70 Median:73.00 stddev:19.03 (26.1%) stddev-sans-first:19.32 02:35:16 INFO - PROCESS | 17050 | Values: 73.0 76.0 109.0 107.0 73.0 72.0 75.0 118.0 108.0 76.0 02:35:16 INFO - PROCESS | 17050 | 02:35:16 INFO - PROCESS | 17050 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:92.00 stddev:28.68 (31.2%) stddev-sans-first:29.77 02:35:16 INFO - PROCESS | 17050 | Values: 93.0 92.0 153.0 93.0 92.0 92.0 150.0 91.0 91.0 151.0 02:35:16 INFO - PROCESS | 17050 | 02:35:16 INFO - PROCESS | 17050 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 02:35:16 INFO - PROCESS | 17050 | Values: 117.0 116.0 116.0 117.0 116.0 116.0 117.0 117.0 117.0 116.0 02:35:16 INFO - PROCESS | 17050 | 02:35:16 INFO - PROCESS | 17050 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 02:35:16 INFO - PROCESS | 17050 | Values: 146.0 145.0 146.0 145.0 146.0 145.0 145.0 146.0 146.0 146.0 02:35:16 INFO - PROCESS | 17050 | 02:35:16 INFO - PROCESS | 17050 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:95.00 stddev:4.28 (4.5%) stddev-sans-first:0.53 02:35:16 INFO - PROCESS | 17050 | Values: 108.0 95.0 95.0 94.0 95.0 94.0 94.0 94.0 95.0 95.0 02:35:16 INFO - PROCESS | 17050 | 02:35:16 INFO - PROCESS | 17050 | [#8] json-parse-financial Cycles:10 Average:58.90 Median:58.00 stddev:3.87 (6.7%) stddev-sans-first:4.09 02:35:16 INFO - PROCESS | 17050 | Values: 58.0 58.0 58.0 56.0 60.0 58.0 60.0 69.0 57.0 55.0 02:35:16 INFO - PROCESS | 17050 | 02:35:16 INFO - PROCESS | 17050 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:61.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 02:35:16 INFO - PROCESS | 17050 | Values: 60.0 61.0 61.0 60.0 61.0 60.0 60.0 60.0 62.0 61.0 02:35:16 INFO - PROCESS | 17050 | 02:35:16 INFO - PROCESS | 17050 | [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:77.00 stddev:2.57 (3.3%) stddev-sans-first:2.73 02:35:16 INFO - PROCESS | 17050 | Values: 77.0 75.0 75.0 76.0 78.0 84.0 76.0 77.0 77.0 77.0 02:35:16 INFO - PROCESS | 17050 | 02:35:16 INFO - PROCESS | 17050 | [#11] stanford-crypto-ccm Cycles:10 Average:128.20 Median:125.50 stddev:12.57 (10.0%) stddev-sans-first:13.32 02:35:16 INFO - PROCESS | 17050 | Values: 127.0 125.0 137.0 122.0 121.0 120.0 120.0 123.0 161.0 126.0 02:35:16 INFO - PROCESS | 17050 | 02:35:16 INFO - PROCESS | 17050 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.80 Median:168.00 stddev:3.46 (2.1%) stddev-sans-first:2.85 02:35:16 INFO - PROCESS | 17050 | Values: 174.0 163.0 167.0 171.0 169.0 167.0 171.0 167.0 164.0 165.0 02:35:16 INFO - PROCESS | 17050 | 02:35:16 INFO - PROCESS | 17050 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:69.00 stddev:1.49 (2.2%) stddev-sans-first:1.54 02:35:16 INFO - PROCESS | 17050 | Values: 69.0 69.0 69.0 69.0 69.0 69.0 68.0 66.0 67.0 65.0 02:35:16 INFO - PROCESS | 17050 | -------- Summary: end -------- 02:35:16 INFO - PROCESS | 17050 | 02:35:17 INFO - TEST-INFO | 17050: exit 0 02:35:17 INFO - TEST-OK | kraken | took 61405ms 02:35:17 INFO - SUITE-END | took 1173s 02:35:18 INFO - Completed test suite (00:19:34) 02:35:18 INFO - javascript benchmark 02:35:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3072.8309942953138, 3135.5923729915107, 3164.6835316468355, 3170.508571171468, 3205.2147223930133, 5067.543921047105, 5107.744612769356, 5162.7160506172195, 5172.715500647463, 5206.193040078789, 5208.322918020652, 5215.374155101393, 5246.422893481714, 5297.894042119165, 5311.362636483617, 4668.11305851887, 4688.0, 4701.48283688794, 4749.026449577828, 4854.97572512137, 4778.259369797687, 4786.401699787527, 4815.036992601476, 4832.565069143777, 4873.366462359888, 4591.127685739715, 4715.056988602276, 4718.41019872516, 4775.283707443877, 4776.665633405663, 4709.858704238844, 4741.336212930192, 4750.168720473903, 4758.476567577563, 4786.952130478686, 4642.048380082075, 4725.976370118162, 4728.0, 4728.054389122155, 4750.073735621555, 5061.392632884041, 5076.314697515825, 5086.287919691246, 5129.461406552296, 5135.691858488465, 5450.127979523258, 5470.316210473691, 5476.780928762884, 5482.533984611313, 5526.226328314039, 5390.568754499631, 5503.9174412383845, 5527.115661494142, 5553.500184983371, 5604.775808967677, 5191.0, 5210.036143313499, 5215.0873597120735, 5216.7230555805, 5257.13257312543, 5637.520810731052, 5638.520725738276, 5639.041362968305, 5639.943600564024, 5654.491095801315, 5281.339832520935, 5355.277037599952, 5443.755031023535, 5446.945530544723, 5449.945500545023, 5410.891782164414, 5425.240466334716, 5425.674459532441, 5451.618386712971, 5472.0, 5445.128779395357, 5446.2375267462585, 5447.53695935842, 5449.0, 5498.45015498447, 5394.91907621386, 5567.137093750475, 5596.1605759136455, 5633.971830140905, 5654.6324488908085, 4272.700910936267, 4286.935695964563, 4288.292431748727, 4293.677974151951, 4321.027768752068, 3652.36083685354, 3856.2287542491613, 3871.690264778811, 3883.922321553553, 3911.2764138634443, 5303.28405665238, 5309.628326017141, 5310.628256022042, 5317.867053323621, 5362.436944120811, 5421.078416669176, 5478.726063696879, 5482.068048431776, 5487.314085739283, 5548.805791797348, 5232.084385232569, 5259.894802103937, 5288.788448462095, 5348.786048558092, 5370.543503802142, 4722.527747225318, 4760.738159401197, 4764.904701905943, 4780.211265141213, 4801.327814106028, 5860.941390586039, 5863.091220860773, 5864.0, 5865.589408741433, 5880.117982302603, 5364.222187782828, 5527.944720552904, 5574.358948720868, 5580.051391263414, 5643.435656434323, 5858.47273745365, 5871.970640146772, 5880.529557635294, 5882.205902203148, 5922.703864806656, 5479.315085614298, 5496.615236933376, 5506.311711036121, 5508.394076651645, 5508.9724551376985, 5360.0619891518045, 5517.337919449692, 5570.053090974625, 5585.832425027255, 5613.017721898733, 5487.64330318528, 5489.670619762827, 5490.121580547093, 5494.066008778437, 5520.91718624229, 5433.891322173614, 5464.1257398816, 5464.3442786865835, 5473.06957817164, 5535.7785688572, 5166.6125040621355, 5318.202269659582, 5405.0, 5405.540529055074, 5406.702631355313, 5451.509364157245, 5477.20580515815, 5479.342478902558, 5481.671099734029, 5486.588505861996, 5406.378266499403, 5465.453454654662, 5466.753996070107, 5468.3711373191, 5488.506034456918], "value": 5135.240957802692, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.0953824033071, 623.6164758673417, 645.7739791073125, 660.1154453032935, 671.2247354305775, 30450.390992180142, 38249.23501529971, 38983.41524877129, 39119.41320880182, 39219.0, 40984.59015409845, 41604.58395416045, 41743.79128104355, 41759.956001099985, 41872.0, 7239.674214660353, 7493.625318734069, 8437.28283095936, 8709.129087091304, 8714.0, 9868.358556693827, 10078.34490758102, 10087.798244035115, 10136.23978201634, 10138.797224055514, 10168.796624067514, 10334.7416314592, 10335.844962325571, 10343.275970682056, 10343.327683700572, 7175.60534170623, 7447.069116360455, 7458.0, 10066.69799906004, 10092.444915529642, 10052.195824334036, 10203.336783109075, 10221.488925553693, 10227.693169204862, 10235.283530152892, 37917.24165516702, 38618.227635447416, 38634.0, 38642.420363694284, 38674.0, 3410.1474631342167, 3562.71498280137, 3573.8927832165077, 3633.418653015505, 4102.958970410317, 30072.84963575168, 33120.668793312, 33129.3374132516, 33191.502127468106, 33229.16927076818, 4297.376880352363, 4326.740395576276, 4463.464384273875, 4550.453945526525, 4553.54464553542, 329033.0, 332886.0, 333425.66158861254, 334459.0, 335059.99999999756, 33778.0, 34400.311993759984, 34400.655993439745, 62317.442063947856, 62386.37613623896, 35027.82486087553, 35244.823775880956, 35249.11877203039, 35344.293114137574, 35344.46983295253, 14565.053271537528, 14784.852151478563, 14785.408583656748, 14788.852111478962, 14794.112353258624, 12089.335086570323, 12131.757364852654, 12146.0, 12153.5138594457, 12154.635360939186, 8777.210051095304, 8793.912060879436, 8801.07588703177, 8841.292696584258, 8889.155530224618, 3363.293708321231, 3398.5072164536004, 3429.7599168058496, 3450.258194488197, 3490.424080026818, 1005.1355833982769, 1009.4952523738131, 1064.297563608015, 1097.160672085855, 1105.0441368216595, 32681.50977735336, 32998.3400331992, 33219.3356132876, 33343.49984750231, 33539.161520962174, 1058.8623478947688, 1098.5056724474018, 1105.6019832860163, 1107.7064577886867, 1225.1301575881225, 17007.914960425118, 17078.0, 17289.0, 17447.56381090483, 17573.03348315855, 493594.0, 495781.0, 498109.0, 499943.0, 501707.0, 58254.70872645694, 58868.705656471444, 58929.41070589325, 58951.410485894594, 59064.40935590675, 1292.386116594629, 1309.7315050414643, 1314.7567699975534, 1334.8197993270785, 1434.985650143506, 30083.84958075283, 31785.13933745974, 32236.677633224306, 32475.18812029718, 32509.187270317485, 49693.0, 50433.74783126061, 50465.0, 50490.49509504858, 50492.24261636005, 408085.0, 415786.0, 416076.0, 417644.0, 417788.0, 23368.76631233666, 23888.880555597807, 23898.641520377558, 28463.43073138484, 29090.0, 35070.12324691903, 43286.0, 43319.78340108405, 46101.0, 47387.28919066286, 38531.2293754129, 38607.6139238604, 39359.80320098381, 39573.80213098916, 39837.40243896402, 38314.6168538311, 38797.80601096976, 39213.647181169224, 39292.21415571615, 40027.79986100051, 39381.0, 40336.1932761349, 40361.59638403579, 41305.0, 41373.0, 33441.331173376886, 34745.0, 35300.82349588236, 35435.64564354427, 35712.8214358937, 27022.594661080493, 27173.86413067922, 27918.059072994656, 27948.40049522751, 27972.16083517498], "value": 18591.227261843604, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.74721189591065, 390.08719596145016, 397.19369679550516, 400.6314190944331, 401.1815895573029, 17144.485665430042, 19404.320848770294, 19643.803561964378, 19696.803031969677, 19734.309299174532, 18368.17343219555, 18805.24779008838, 18871.433856984313, 19006.239750409968, 19159.137838797255, 5417.83746487604, 5446.264754258164, 5613.298337707786, 5646.943530564703, 5664.971675141618, 5629.493345598895, 5636.661800291975, 5657.20799088128, 5676.347220069703, 5678.943210567903, 5069.2649565812935, 5115.283860259567, 5388.0570900092525, 5628.887422251552, 5634.32388113427, 5134.486551344873, 5315.654482458647, 5337.893242135175, 5359.5712343012465, 5367.785288588452, 5306.416294207634, 5309.522143007148, 5325.440828713007, 5332.14685650298, 5332.986732520847, 13002.804957925639, 13088.149270297401, 15105.39578416862, 21261.36215913525, 21431.464213394633, 2131.6802479628027, 2267.444476103365, 2327.7439481657, 2383.535210633927, 2624.409507860716, 8674.175953284428, 8990.145936136056, 9992.10071093605, 11562.884371156264, 14175.85824141766, 1905.1902941250053, 1934.6517626827165, 1940.0396803582175, 1971.9112639931238, 2017.6065667194903, 79572.0, 82434.58782706049, 82905.0, 83425.58287208524, 84693.15306846914, 10809.67570972872, 10849.24055316136, 10892.782144357068, 10942.671719848417, 11146.219764616399, 15281.388744450098, 15319.693606127816, 15320.616984575252, 15334.386624535116, 15340.92329538345, 7759.68961241544, 8113.391495637851, 8214.548199849065, 8235.0, 8274.420790544604, 7792.454528182972, 7793.441311737675, 7849.686012559434, 7989.320907722792, 8066.23370779775, 4670.813167473331, 4686.718796872198, 4690.95309046912, 4694.652673663169, 4789.473157952622, 1910.560571068662, 1915.4732448576754, 1930.197510903546, 1941.5825597496605, 1975.782663906969, 906.8277027364779, 1001.0940099210227, 1029.3360782295379, 1108.83921831334, 1115.3308015190983, 17678.0, 19106.71339929902, 19166.233350665818, 19250.80749192518, 19332.457814009904, 958.5351104714208, 979.7501637082498, 979.9020097990286, 996.8604395384652, 999.7600575861741, 10498.842517362245, 10581.735456613646, 10721.410322432184, 10738.302010369458, 10815.83776243357, 499348.0, 500083.0, 503534.0, 503615.0, 507607.0, 89740.0, 92342.53828730814, 93950.53024734833, 95713.0, 96174.0, 1002.1631937332263, 1014.4471263161447, 1050.9159267258601, 1063.500154927183, 1079.4656644960637, 16030.839691602934, 16265.75601366004, 16715.247813848648, 17005.65988680244, 17323.133843307533, 39391.606083938794, 39964.800175998935, 40287.59712402838, 41379.1724165521, 42127.789361053, 53113.468865312396, 55877.16184257158, 55915.72042139763, 55948.440515594324, 55964.16053759278, 8547.529885856338, 8554.358423118167, 8586.797848301369, 8875.156860098281, 8947.150020748019, 10944.78110437771, 13406.128601640861, 13600.591982240152, 13604.795928061285, 13766.24285664258, 10843.240973131806, 10981.542745086159, 11149.212696825794, 11236.381998990135, 11269.718257043312, 11308.604198853001, 11492.31046137201, 11652.766944660889, 11656.766864662828, 11715.941420292844, 10691.732706682395, 11020.944895275472, 11133.94022105913, 11248.606298779503, 11402.315861048364, 8503.204424301794, 8638.17937295956, 8735.213830755009, 8766.780830479289, 8789.604467798836, 10577.524011419351, 10791.784164316512, 10924.726881828017, 11176.329420234812, 11244.83132752993], "value": 9036.03628624473, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1302.863199364066, 1451.0930668332292, 1488.4343949299266, 1596.329541592531, 1768.1866341482926, 7653.885191722122, 7935.047794264697, 7956.443048986574, 7965.681372745091, 7973.12295647479, 7800.843983120334, 7934.3255823255095, 7939.404544659144, 7958.0450345958425, 7983.12185659577, 1961.9019049047563, 2021.8079282468143, 2023.8380929525676, 2334.439734463725, 2364.0661938534267, 2284.303287497313, 2363.52729454109, 2368.656544801003, 2368.7275963264274, 2370.2533701883935, 2274.0789980058103, 2287.5196208796174, 2306.5271619318, 2309.983607212821, 2332.7550607186254, 1938.7285779990812, 2007.3676791810533, 2309.399556115414, 2330.82518811089, 2332.7317358503733, 1963.0381113254546, 2212.1814928476406, 2292.7363353214428, 2292.7592602776804, 2296.552172326397, 7577.507462014952, 7687.6156192190165, 7695.923040769577, 7703.268189521987, 7710.537367757953, 4769.0, 4900.387451568554, 4913.533214344631, 4957.0, 4958.157113290749, 3052.771042171846, 3073.800202986799, 3120.251139726472, 3139.9843000785077, 3148.937021259585, 991.3853410885225, 1017.3793985668736, 1018.7809620931536, 1035.8446233065101, 1037.1435131115295, 10665.306755060896, 10990.890091099067, 11047.72380690489, 11104.222704410695, 11106.44467776608, 4384.934225986613, 4397.340398940185, 4448.466184057869, 4475.888102797456, 4499.910001799945, 9467.0, 9478.95260523693, 9483.620655173716, 9483.810323793485, 9484.19384352324, 4972.453030166679, 5043.420006699276, 5047.848564543069, 5050.419201791841, 5053.36832895888, 4015.5382131055303, 4534.614557762561, 4639.0, 4679.953200467951, 4684.672072954929, 3841.750286231386, 3920.862769803043, 3926.1951299983434, 3936.940945885814, 3969.4442778011103, 1270.4600544768437, 1302.5375991523063, 1305.797601371789, 1315.375196781521, 1317.637649646355, 706.3713295167305, 789.8617741895146, 918.6555041859302, 922.2990527199377, 931.5668214280392, 5232.738363081907, 5475.67145971243, 5494.615376923577, 5501.697406642673, 5507.504324610804, 393.5258014093011, 396.10085106807384, 396.3440505962636, 396.5142700192299, 416.2299745470855, 3587.605363410075, 3659.5059666945153, 3675.448682697563, 3679.0, 3708.870189543353, 9707.466089365153, 10158.13655839262, 10170.338927969658, 10179.389236645826, 10306.48467576633, 9916.851247231298, 10175.28772985884, 10239.0, 10240.385576865412, 10257.076863082359, 7822.100458447351, 7833.921660783433, 7865.606719663994, 7870.543949369385, 7912.762617121495, 5484.369297530835, 5512.310961129859, 5514.751836167302, 5645.548356131418, 5653.038983372919, 9092.181703646704, 9427.434353938786, 9454.385464944757, 9497.952510237405, 9519.762005949906, 8829.16122968317, 9129.360944733804, 9221.723348299562, 9244.260459163384, 9535.0, 6406.839829004312, 6805.625690587065, 7022.929770702228, 7127.180374257026, 7278.781636550912, 7779.33875620556, 7802.843943121219, 7847.411444141598, 7871.48835325702, 7880.763577092696, 6834.2140653825445, 6973.755918542826, 7012.474064445289, 7038.788836334918, 7151.964240178766, 7168.2831716827895, 7203.243659415895, 7267.30960558746, 7334.96332518334, 7408.814779630552, 6533.738650453929, 6634.701438435379, 6645.634490102897, 6650.235222949229, 6659.0, 4691.812327506998, 4730.172219861579, 4794.544518270759, 4800.639952003544, 4840.588549973151, 4778.737169455713, 4780.282957556395, 4793.784279707352, 4889.217725163957, 4913.287573301923], "value": 4238.826599630829, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.79156569315705, 319.8776120440874, 321.02408677620036, 322.18005176824977, 324.85219225252513, 5033.270175824503, 5148.382194136709, 5170.9482905170935, 5203.869903252421, 5224.033553792551, 5163.3545806774155, 5205.843824685256, 5229.300477344859, 5229.764660590273, 5242.135047717122, 4095.344744840826, 4108.753474791522, 4108.979455102721, 4119.917601647965, 4136.110736191718, 3895.9805200973956, 3924.803759811998, 4129.855455059073, 4139.523954745213, 4149.792510374485, 4004.379321205218, 4032.8790136295956, 4061.735987160825, 4082.203970225792, 4089.407035979781, 4014.1570270243283, 4059.2896243157625, 4072.409500622423, 4075.225707115653, 4078.5921407859273, 3488.1628409181612, 3574.338747331726, 3608.0, 3609.2420591675777, 3615.8192090395637, 4988.106897999151, 4996.725180115092, 4996.975015124937, 5025.190931264742, 5030.346055012861, 4654.813807447698, 4658.627309815207, 4689.929651055237, 4705.12955103307, 4706.552877476634, 5236.502532259429, 5415.702136382497, 5418.7807743257845, 5421.918671219935, 5438.45615438453, 3868.226354729037, 3919.470871432377, 3948.2103579284258, 3953.367461206222, 3955.8022098895226, 5609.551235901118, 5633.690147041911, 5651.0, 5663.150527420919, 5678.3186017678145, 4024.557298697141, 4031.334829753058, 4049.311617025113, 4052.3111071117983, 4075.0627355708352, 3950.4666869972184, 4125.876223713293, 4126.112885729583, 4141.295979683461, 4149.543550209474, 4626.352310676508, 4626.583607475343, 4627.490975992638, 4635.361241425532, 4656.8137274508645, 5214.835843125136, 5425.321834770653, 5444.863878403072, 5463.836084917459, 5473.2063850741415, 1428.3215472650409, 1480.4744315767962, 1485.4355344968842, 1487.7545205041047, 1495.827979782339, 997.4713401897006, 1010.8129995950773, 1017.9949100254452, 1020.3979652005353, 1026.1431704526804, 5660.915086273709, 5667.744951477193, 5671.602987790898, 5688.374278829326, 5689.431056894277, 5887.8233652990475, 5891.499222566044, 5911.793087242012, 5914.645121292736, 5936.584439089309, 5532.695701736363, 5590.580706447033, 5637.379888212294, 5654.717264136777, 5669.801556945487, 3139.199504126433, 3141.3403185331335, 3150.480170771843, 3156.542301366335, 3161.668024857357, 6037.698115094227, 6216.129741836146, 6216.129741836146, 6225.719842607094, 6244.968775156186, 6005.129256257818, 6009.45914867664, 6057.636541807506, 6063.605865618809, 6099.237595300588, 6079.483243924316, 6173.56785025044, 6227.314995350508, 6240.65825847445, 6252.374762523711, 5706.28671416073, 5909.0, 5914.526837853047, 5919.260092488439, 5922.851928701644, 5866.41335866427, 5879.382664820132, 5887.735051922759, 5889.852753681193, 5892.941070589411, 6120.265568131853, 6229.96885015572, 6237.937620623918, 6239.469645080219, 6241.96879015602, 4214.1150358425075, 4234.534201237923, 4243.408721729352, 4250.192463431938, 4276.358546218092, 5366.785328586813, 5463.31708536433, 5902.527797776082, 5929.673867937132, 5939.198208241832, 4970.602351811919, 5386.542143917654, 5429.724014856427, 5456.863578410572, 5499.350194941421, 5452.372977107525, 5461.013460174175, 5467.0, 5471.753771080232, 5480.725963701879, 5391.406945235943, 5393.541548968382, 5404.43253458397, 5421.512063914267, 5438.184272359178, 5203.0, 5447.836564903059, 5495.807646732345, 5546.973809845192, 5556.16657501378, 5376.1398176291605, 5381.681488035457, 5396.676199428047, 5425.9961907045745, 5439.700816454974], "value": 4269.016522395114, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.6718625838985, 724.0840336973729, 728.8068661804626, 762.4586543554076, 768.846230753849, 13497.865021349784, 13909.165450073002, 13943.302834858254, 13955.651108722286, 13961.720765584681, 11460.140489463303, 11539.0, 11547.942260288686, 11566.363849988247, 11567.65297041088, 651.4495251512488, 777.6966982876683, 802.5585927739749, 804.2399932064202, 804.694216197844, 802.5545822068749, 806.5241507510567, 810.1857633078747, 810.8216192437654, 813.2314962360572, 685.725709716115, 851.5103815306193, 851.5614458553849, 851.6721062390993, 854.7948492361851, 824.4846970643348, 840.0465471689615, 844.4384484317922, 844.4553263145237, 846.0101681033175, 615.1111643674892, 615.2432508015122, 615.7506209984963, 616.8951278282702, 617.6263360666821, 13507.189568625914, 13622.93188534051, 13638.045336826426, 13638.181709097387, 13658.453661853513, 14165.362558684781, 14456.783148252785, 14485.203313817736, 14503.0, 14597.416103355854, 11295.830562541569, 11630.592929247521, 11779.352135632536, 11857.703557411134, 12132.332721700302, 3714.7028237741188, 3719.6466335698337, 3746.981265093684, 3876.4379165021196, 3881.7282790204695, 51266.48733512654, 51671.0, 52762.47237527652, 55522.889542209334, 55538.72230638821, 11159.218854680257, 11406.478475302916, 11492.540298388138, 11678.591249306233, 11823.231489953125, 18914.0, 19007.33474328392, 19028.80971190298, 19433.125509352114, 20570.382888513068, 7742.7677169685, 7933.801654958556, 7966.880496792553, 8028.277455029075, 8140.877886831702, 4382.956170438319, 4662.883427914329, 4671.0, 4682.695624784378, 4740.810367585258, 3287.917802054968, 3362.1930736623035, 3363.9495407568907, 3364.899053028413, 3377.4258376076127, 589.8201048680194, 613.6931534232883, 614.1463365921372, 614.6496496996758, 617.043582447205, 611.8500967263049, 633.7718421368304, 655.6885479397248, 670.2493207607413, 679.9626020568916, 8281.875771863426, 8748.300135989233, 8798.428102173339, 8871.866921996176, 8966.955165224132, 618.3136718242837, 637.9936200637934, 649.302000349626, 660.1582981698277, 664.6743095882982, 3668.63313668631, 3990.940135897964, 4008.819603117867, 4047.2310261050893, 4112.177564487115, 55557.0, 64185.67907160528, 66800.33199668038, 66824.0, 66831.3316866825, 53406.0, 54024.33060886328, 54431.455685443434, 56227.71886140543, 56332.43667563354, 51764.48235517597, 52060.73969630127, 52166.73916630392, 52633.0, 53794.46205537973, 8467.280281176169, 8573.65705371803, 8632.179942905414, 8720.0, 8728.78178045554, 33112.66887331192, 33727.0, 34160.31679366448, 34670.0, 34801.82599087089, 43078.78460607677, 46425.0, 46434.767826160656, 46758.298625519965, 47078.76460617675, 10360.844587331347, 10682.57269709203, 11182.389560038562, 11287.661370158909, 11400.087992960709, 12143.696407589881, 12223.083268755057, 12347.13570050088, 12362.134650574373, 12367.443465044274, 10417.322874013165, 10875.510602023087, 10884.0, 11090.889091108986, 11147.554097835995, 11752.0, 11769.0, 12052.638420847037, 12204.694882628006, 12251.08116891219, 11383.54465821391, 11552.6534203974, 11554.133439991867, 11577.421128943688, 11603.709907252387, 9185.127412895765, 9426.340156189, 9486.762830929281, 9520.23838092937, 9582.952085239529, 9365.859512107187, 9461.195798357217, 9559.23526117895, 9623.759406014906, 9628.422294662343], "value": 6478.301938539943, "unit": "score"}], "name": "dromaeo_css", "value": 6825.814738600017, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 106.0, 110.0, 110.0, 112.0, 98.0, 110.0, 109.0, 109.0], "value": 108.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 129.0, 153.0, 177.0, 128.0, 160.0, 159.0, 128.0, 189.0, 127.0], "value": 150.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 163.0, 162.0, 160.0, 161.0, 162.0, 163.0, 163.0, 162.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 109.0, 107.0, 73.0, 72.0, 75.0, 118.0, 108.0, 76.0], "value": 88.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 153.0, 93.0, 92.0, 92.0, 150.0, 91.0, 91.0, 151.0], "value": 109.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 56.0, 60.0, 58.0, 60.0, 69.0, 57.0, 55.0], "value": 58.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 60.0, 61.0, 60.0, 60.0, 60.0, 62.0, 61.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 76.0, 78.0, 84.0, 76.0, 77.0, 77.0, 77.0], "value": 77.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 125.0, 137.0, 122.0, 121.0, 120.0, 120.0, 123.0, 161.0, 126.0], "value": 128.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 163.0, 167.0, 171.0, 169.0, 167.0, 171.0, 167.0, 164.0, 165.0], "value": 167.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 68.0, 66.0, 67.0, 65.0], "value": 68.0, "unit": "score"}], "name": "kraken", "value": 1538.3999999999999, "alertThreshold": 2.0}]} 02:35:18 INFO - Return code: 0 02:35:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:35:18 ERROR - # TBPL SUCCESS # 02:35:18 INFO - Running post-action listener: _resource_record_post_action 02:35:18 INFO - Running post-run listener: _resource_record_post_run 02:35:19 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 339968; Write bytes: 534380544; Read time: 64; Write time: 563540 02:35:19 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244858880; Read time: 0; Write time: 288748 02:35:19 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 339968; Write bytes: 289521664; Read time: 64; Write time: 274792 02:35:19 INFO - Running post-run listener: _upload_blobber_files 02:35:19 INFO - Blob upload gear active. 02:35:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:35:19 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 02:35:19 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'] 02:35:19 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 02:35:19 INFO - (blobuploader) - INFO - Open directory for files ... 02:35:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:35:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:35:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:35:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:35:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:35:20 INFO - (blobuploader) - INFO - Done attempting. 02:35:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:35:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:35:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:35:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:35:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:35:21 INFO - (blobuploader) - INFO - Done attempting. 02:35:21 INFO - (blobuploader) - INFO - Iteration through files over. 02:35:21 INFO - Return code: 0 02:35:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:35:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:35:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5e81f11d951df176353ec859b9a62f45cf4506ced20cd0fbe82b11e059bf5d57e3487050149e772f5cdc56ce8d273743c2361ef5373e04e29da984c2a15d1fed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1b3408b9f437961c69be223308ceb3d031cd6f16888d3c80607496f44513f216689b8137a77a3598ae2ef1e5ecd135896e422ec4a22f4aef600ca92a033b85a5"} 02:35:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:35:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:35:21 INFO - Contents: 02:35:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5e81f11d951df176353ec859b9a62f45cf4506ced20cd0fbe82b11e059bf5d57e3487050149e772f5cdc56ce8d273743c2361ef5373e04e29da984c2a15d1fed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1b3408b9f437961c69be223308ceb3d031cd6f16888d3c80607496f44513f216689b8137a77a3598ae2ef1e5ecd135896e422ec4a22f4aef600ca92a033b85a5"} 02:35:21 INFO - Running post-run listener: copy_logs_to_upload_dir 02:35:21 INFO - Copying logs to upload dir... 02:35:21 INFO - mkdir: /builds/slave/test/build/upload/logs 02:35:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.321817 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-04-29 02:35:21.287018) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 02:35:21.290409) ========= 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=d2a8c569965ab8367867b893000001a1-1461920608.472091-1451329270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5e81f11d951df176353ec859b9a62f45cf4506ced20cd0fbe82b11e059bf5d57e3487050149e772f5cdc56ce8d273743c2361ef5373e04e29da984c2a15d1fed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1b3408b9f437961c69be223308ceb3d031cd6f16888d3c80607496f44513f216689b8137a77a3598ae2ef1e5ecd135896e422ec4a22f4aef600ca92a033b85a5"} build_url:https://queue.taskcluster.net/v1/task/ADV3nDuxSjqsQL18Yw52mw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011295 build_url: 'https://queue.taskcluster.net/v1/task/ADV3nDuxSjqsQL18Yw52mw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5e81f11d951df176353ec859b9a62f45cf4506ced20cd0fbe82b11e059bf5d57e3487050149e772f5cdc56ce8d273743c2361ef5373e04e29da984c2a15d1fed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1b3408b9f437961c69be223308ceb3d031cd6f16888d3c80607496f44513f216689b8137a77a3598ae2ef1e5ecd135896e422ec4a22f4aef600ca92a033b85a5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 02:35:21.315096) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 02:35:21.315449) ========= 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=d2a8c569965ab8367867b893000001a1-1461920608.472091-1451329270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004555 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 02:35:21.398986) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 02:35:21.399302) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 02:35:21.399588) ========= ========= Total master_lag: 0.16 =========