builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-029 starttime: 1461488375.79 results: success (0) buildid: 20160423233016 builduid: fa1872bf9c1845eea0555310a8a559fe revision: 8afadb96e97704a98492c2286fb92479deb3365f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-24 01:59:35.791410) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-24 01:59:35.791866) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-24 01:59:35.792156) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-24 01:59:35.807893) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 01:59:35.808182) ========= 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=0274524eba3bdaad075c2247000001d4-1461488375.644406-1856488294 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-24 01:59:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 28.4M=0s 2016-04-24 01:59:36 (28.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087632 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 01:59:35.909069) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 01:59:35.909382) ========= 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=0274524eba3bdaad075c2247000001d4-1461488375.644406-1856488294 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013888 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 01:59:35.958857) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 01:59:35.959213) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8afadb96e97704a98492c2286fb92479deb3365f --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 8afadb96e97704a98492c2286fb92479deb3365f --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=0274524eba3bdaad075c2247000001d4-1461488375.644406-1856488294 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-24 01:59:36,463 truncating revision to first 12 chars 2016-04-24 01:59:36,463 Setting DEBUG logging. 2016-04-24 01:59:36,463 attempt 1/10 2016-04-24 01:59:36,464 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8afadb96e977?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-24 01:59:36,735 unpacking tar archive at: fx-team-8afadb96e977/testing/mozharness/ program finished with exit code 0 elapsedTime=0.568892 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 01:59:36.540941) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-24 01:59:36.541260) ========= script_repo_revision: 8afadb96e97704a98492c2286fb92479deb3365f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-24 01:59:36.541643) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-24 01:59:36.541908) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-24 01:59:36.551478) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-04-24 01:59:36.551754) ========= /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=0274524eba3bdaad075c2247000001d4-1461488375.644406-1856488294 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:59:37 INFO - MultiFileLogger online at 20160424 01:59:37 in /builds/slave/test 01:59:37 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 01:59:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:59:37 INFO - {'append_to_log': False, 01:59:37 INFO - 'base_work_dir': '/builds/slave/test', 01:59:37 INFO - 'blob_upload_branch': 'Fx-Team', 01:59:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:59:37 INFO - 'branch': 'Fx-Team', 01:59:37 INFO - 'buildbot_json_path': 'buildprops.json', 01:59:37 INFO - 'config_files': ('talos/linux_config.py',), 01:59:37 INFO - 'default_actions': ('clobber', 01:59:37 INFO - 'read-buildbot-config', 01:59:37 INFO - 'download-and-extract', 01:59:37 INFO - 'populate-webroot', 01:59:37 INFO - 'create-virtualenv', 01:59:37 INFO - 'install', 01:59:37 INFO - 'run-tests'), 01:59:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:59:37 INFO - 'download_minidump_stackwalk': True, 01:59:37 INFO - 'download_symbols': 'ondemand', 01:59:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:59:37 INFO - 'tooltool.py': '/tools/tooltool.py', 01:59:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:59:37 INFO - '/tools/misc-python/virtualenv.py')}, 01:59:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:59:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:59:37 INFO - 'installer_path': 'installer.exe', 01:59:37 INFO - 'log_level': 'info', 01:59:37 INFO - 'log_name': 'talos', 01:59:37 INFO - 'log_to_console': True, 01:59:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:59:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:59:37 INFO - 'opt_config_files': (), 01:59:37 INFO - 'pip_index': False, 01:59:37 INFO - 'sps_profile': False, 01:59:37 INFO - 'sps_profile_interval': 0, 01:59:37 INFO - 'suite': 'dromaeojs', 01:59:37 INFO - 'system_bits': '32', 01:59:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:59:37 INFO - 'title': 'talos-linux64-ix-029', 01:59:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:59:37 INFO - 'use_talos_json': True, 01:59:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:59:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:59:37 INFO - 'work_dir': 'build'} 01:59:37 INFO - ##### 01:59:37 INFO - ##### Running clobber step. 01:59:37 INFO - ##### 01:59:37 INFO - Running pre-action listener: _resource_record_pre_action 01:59:37 INFO - Running main action method: clobber 01:59:37 INFO - rmtree: /builds/slave/test/build 01:59:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:59:37 INFO - Running post-action listener: _resource_record_post_action 01:59:37 INFO - ##### 01:59:37 INFO - ##### Running read-buildbot-config step. 01:59:37 INFO - ##### 01:59:37 INFO - Running pre-action listener: _resource_record_pre_action 01:59:37 INFO - Running main action method: read_buildbot_config 01:59:37 INFO - Using buildbot properties: 01:59:37 INFO - { 01:59:37 INFO - "project": "", 01:59:37 INFO - "product": "firefox", 01:59:37 INFO - "script_repo_revision": "production", 01:59:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 01:59:37 INFO - "repository": "", 01:59:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 01:59:37 INFO - "buildid": "20160423233016", 01:59:37 INFO - "pgo_build": "True", 01:59:37 INFO - "basedir": "/builds/slave/test", 01:59:37 INFO - "buildnumber": 604, 01:59:37 INFO - "slavename": "talos-linux64-ix-029", 01:59:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:59:37 INFO - "platform": "ubuntu64_hw", 01:59:37 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 01:59:37 INFO - "branch": "fx-team", 01:59:37 INFO - "repo_path": "integration/fx-team", 01:59:37 INFO - "revision": "8afadb96e97704a98492c2286fb92479deb3365f", 01:59:37 INFO - "stage_platform": "linux64-pgo", 01:59:37 INFO - "builduid": "fa1872bf9c1845eea0555310a8a559fe", 01:59:37 INFO - "slavebuilddir": "test" 01:59:37 INFO - } 01:59:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/TqvH3Gv4ScCvbErBXpWI-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 01:59:37 INFO - Running post-action listener: _resource_record_post_action 01:59:37 INFO - ##### 01:59:37 INFO - ##### Running download-and-extract step. 01:59:37 INFO - ##### 01:59:37 INFO - Running pre-action listener: _resource_record_pre_action 01:59:37 INFO - Running main action method: download_and_extract 01:59:37 INFO - mkdir: /builds/slave/test/build/tests 01:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:37 INFO - https://queue.taskcluster.net/v1/task/TqvH3Gv4ScCvbErBXpWI-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:59:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TqvH3Gv4ScCvbErBXpWI-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 01:59:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TqvH3Gv4ScCvbErBXpWI-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 01:59:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TqvH3Gv4ScCvbErBXpWI-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 01:59:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TqvH3Gv4ScCvbErBXpWI-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:59:41 INFO - Downloaded 1361 bytes. 01:59:41 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 01:59:41 INFO - Using the following test package requirements: 01:59:41 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 01:59:41 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:41 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:59:41 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:41 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:59:41 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:41 INFO - u'jsshell-linux-x86_64.zip'], 01:59:41 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:41 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:59:41 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 01:59:41 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:41 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:59:41 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:41 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:59:41 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:41 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:59:41 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:41 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:59:41 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:59:41 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')]} 01:59:41 INFO - https://queue.taskcluster.net/v1/task/TqvH3Gv4ScCvbErBXpWI-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:59:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TqvH3Gv4ScCvbErBXpWI-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:59:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TqvH3Gv4ScCvbErBXpWI-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:59:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TqvH3Gv4ScCvbErBXpWI-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:59:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TqvH3Gv4ScCvbErBXpWI-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:59:46 INFO - Downloaded 23857707 bytes. 01:59:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:59:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:59:48 INFO - Return code: 0 01:59:48 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:48 INFO - https://queue.taskcluster.net/v1/task/TqvH3Gv4ScCvbErBXpWI-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:59:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TqvH3Gv4ScCvbErBXpWI-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:59:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TqvH3Gv4ScCvbErBXpWI-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:59:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TqvH3Gv4ScCvbErBXpWI-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:59:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TqvH3Gv4ScCvbErBXpWI-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:59:59 INFO - Downloaded 23857707 bytes. 01:59:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:59:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:00:01 INFO - Return code: 0 02:00:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:01 INFO - https://queue.taskcluster.net/v1/task/TqvH3Gv4ScCvbErBXpWI-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:00:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TqvH3Gv4ScCvbErBXpWI-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:00:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TqvH3Gv4ScCvbErBXpWI-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:00:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TqvH3Gv4ScCvbErBXpWI-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:00:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TqvH3Gv4ScCvbErBXpWI-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:00:03 INFO - Downloaded 10840145 bytes. 02:00:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:00:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:00:03 INFO - Return code: 0 02:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:03 INFO - https://queue.taskcluster.net/v1/task/TqvH3Gv4ScCvbErBXpWI-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:00:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TqvH3Gv4ScCvbErBXpWI-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:00:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TqvH3Gv4ScCvbErBXpWI-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:00:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TqvH3Gv4ScCvbErBXpWI-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:00:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TqvH3Gv4ScCvbErBXpWI-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:00:04 INFO - Downloaded 58348704 bytes. 02:00:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TqvH3Gv4ScCvbErBXpWI-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:00:04 INFO - mkdir: /builds/slave/test/properties 02:00:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:00:04 INFO - Writing to file /builds/slave/test/properties/build_url 02:00:04 INFO - Contents: 02:00:04 INFO - build_url:https://queue.taskcluster.net/v1/task/TqvH3Gv4ScCvbErBXpWI-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:00:05 INFO - Running post-action listener: _resource_record_post_action 02:00:05 INFO - Running post-action listener: set_extra_try_arguments 02:00:05 INFO - ##### 02:00:05 INFO - ##### Running populate-webroot step. 02:00:05 INFO - ##### 02:00:05 INFO - Running pre-action listener: _resource_record_pre_action 02:00:05 INFO - Running main action method: populate_webroot 02:00:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:00:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:00:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:00:05 INFO - '--tppagecycles', 02:00:05 INFO - '7'], 02:00:05 INFO - 'tests': ['tsvgm']}}, 02:00:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:00:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:00:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:00:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:00:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:00:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:00:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:05 INFO - 'talos_options': ['--disable-e10s'], 02:00:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:00:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:00:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:05 INFO - 'talos_options': ['--disable-e10s'], 02:00:05 INFO - 'tests': ['damp', 'tps']}, 02:00:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:05 INFO - 'tests': ['damp', 'tps']}, 02:00:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:00:05 INFO - 'tests': ['dromaeo_dom']}, 02:00:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:00:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:00:05 INFO - 'tests': ['a11yr', 02:00:05 INFO - 'ts_paint', 02:00:05 INFO - 'tpaint', 02:00:05 INFO - 'sessionrestore', 02:00:05 INFO - 'sessionrestore_no_auto_restore', 02:00:05 INFO - 'tabpaint']}, 02:00:05 INFO - 'other-e10s': {'tests': ['a11yr', 02:00:05 INFO - 'ts_paint', 02:00:05 INFO - 'tpaint', 02:00:05 INFO - 'sessionrestore', 02:00:05 INFO - 'sessionrestore_no_auto_restore', 02:00:05 INFO - 'tabpaint']}, 02:00:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:00:05 INFO - 'ts_paint', 02:00:05 INFO - 'tpaint', 02:00:05 INFO - 'sessionrestore', 02:00:05 INFO - 'sessionrestore_no_auto_restore', 02:00:05 INFO - 'tabpaint']}, 02:00:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:00:05 INFO - 'ts_paint', 02:00:05 INFO - 'tpaint', 02:00:05 INFO - 'sessionrestore', 02:00:05 INFO - 'sessionrestore_no_auto_restore', 02:00:05 INFO - 'tabpaint']}, 02:00:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:00:05 INFO - 'tests': ['a11yr', 02:00:05 INFO - 'ts_paint', 02:00:05 INFO - 'tpaint', 02:00:05 INFO - 'sessionrestore', 02:00:05 INFO - 'sessionrestore_no_auto_restore', 02:00:05 INFO - 'tabpaint']}, 02:00:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:00:05 INFO - 'tests': ['a11yr', 02:00:05 INFO - 'ts_paint', 02:00:05 INFO - 'tpaint', 02:00:05 INFO - 'sessionrestore', 02:00:05 INFO - 'sessionrestore_no_auto_restore', 02:00:05 INFO - 'tabpaint']}, 02:00:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:00:05 INFO - 'tests': ['tsvgx', 02:00:05 INFO - 'tsvgr_opacity', 02:00:05 INFO - 'tart', 02:00:05 INFO - 'tscrollx', 02:00:05 INFO - 'cart']}, 02:00:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:00:05 INFO - 'tsvgr_opacity', 02:00:05 INFO - 'tart', 02:00:05 INFO - 'tscrollx', 02:00:05 INFO - 'cart']}, 02:00:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:05 INFO - 'talos_options': ['--disable-e10s'], 02:00:05 INFO - 'tests': ['tp5o']}, 02:00:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:05 INFO - 'tests': ['tp5o']}, 02:00:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:05 INFO - 'talos_options': ['--disable-e10s', 02:00:05 INFO - '--xperf_path', 02:00:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:00:05 INFO - 'tests': ['tp5n']}, 02:00:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:05 INFO - 'talos_options': ['--xperf_path', 02:00:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:00:05 INFO - 'tests': ['tp5n']}}, 02:00:05 INFO - 'talos.zip': {'path': '', 02:00:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:00:05 INFO - Running post-action listener: _resource_record_post_action 02:00:05 INFO - ##### 02:00:05 INFO - ##### Running create-virtualenv step. 02:00:05 INFO - ##### 02:00:05 INFO - Running pre-action listener: _resource_record_pre_action 02:00:05 INFO - Running main action method: create_virtualenv 02:00:05 INFO - Creating virtualenv /builds/slave/test/build/venv 02:00:05 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:00:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:00:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:00:05 INFO - Using real prefix '/usr' 02:00:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:00:05 INFO - Installing distribute.............................................................................................................................................................................................done. 02:00:07 INFO - Installing pip.................done. 02:00:07 INFO - Return code: 0 02:00:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:00: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:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00: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:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3e8d21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe459a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed4810>, '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 0xed5710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed5ba0>, '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': '0274524eba3bdaad075c2247000001d4-1461488375.644406-1856488294', '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:00: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', 'pip>=1.5'] in /builds/slave/test/build 02:00: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 pip>=1.5 02:00:07 INFO - Using env: {'DISPLAY': ':0', 02:00:07 INFO - 'HOME': '/home/cltbld', 02:00:07 INFO - 'LANG': 'en_US.UTF-8', 02:00:07 INFO - 'LANGUAGE': 'en_US:en', 02:00:07 INFO - 'LOGNAME': 'cltbld', 02:00:07 INFO - 'MAIL': '/var/mail/cltbld', 02:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:07 INFO - 'MOZ_NO_REMOTE': '1', 02:00:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:07 INFO - 'NO_EM_RESTART': '1', 02:00:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:07 INFO - 'PWD': '/builds/slave/test', 02:00:07 INFO - 'SHELL': '/bin/bash', 02:00:07 INFO - 'SHLVL': '1', 02:00:07 INFO - 'TERM': 'linux', 02:00:07 INFO - 'TMOUT': '86400', 02:00:07 INFO - 'USER': 'cltbld', 02:00:07 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1461488375.644406-1856488294', 02:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:07 INFO - '_': '/tools/buildbot/bin/python'} 02:00:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:08 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:00:08 INFO - Cleaning up... 02:00:08 INFO - Return code: 0 02:00:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:00:08 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:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:08 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:00:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:08 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 0x7fd3e8d21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe459a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed4810>, '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 0xed5710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed5ba0>, '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': '0274524eba3bdaad075c2247000001d4-1461488375.644406-1856488294', '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:00:08 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:00:08 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:00:08 INFO - Using env: {'DISPLAY': ':0', 02:00:08 INFO - 'HOME': '/home/cltbld', 02:00:08 INFO - 'LANG': 'en_US.UTF-8', 02:00:08 INFO - 'LANGUAGE': 'en_US:en', 02:00:08 INFO - 'LOGNAME': 'cltbld', 02:00:08 INFO - 'MAIL': '/var/mail/cltbld', 02:00:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:08 INFO - 'MOZ_NO_REMOTE': '1', 02:00:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:08 INFO - 'NO_EM_RESTART': '1', 02:00:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:08 INFO - 'PWD': '/builds/slave/test', 02:00:08 INFO - 'SHELL': '/bin/bash', 02:00:08 INFO - 'SHLVL': '1', 02:00:08 INFO - 'TERM': 'linux', 02:00:08 INFO - 'TMOUT': '86400', 02:00:08 INFO - 'USER': 'cltbld', 02:00:08 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1461488375.644406-1856488294', 02:00:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:08 INFO - '_': '/tools/buildbot/bin/python'} 02:00:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:08 INFO - Downloading/unpacking psutil>=0.7.1 02:00:08 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:00:08 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:00:08 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:00:08 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:00:08 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:00:08 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:00:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:00:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:00:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:00:10 INFO - Installing collected packages: psutil 02:00:10 INFO - Running setup.py install for psutil 02:00:10 INFO - building 'psutil._psutil_linux' extension 02:00:10 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:00:10 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:00:10 INFO - building 'psutil._psutil_posix' extension 02:00:10 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:00:10 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:00:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:00:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:00:10 INFO - Successfully installed psutil 02:00:10 INFO - Cleaning up... 02:00:10 INFO - Return code: 0 02:00:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:10 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 0x7fd3e8d21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe459a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed4810>, '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 0xed5710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed5ba0>, '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': '0274524eba3bdaad075c2247000001d4-1461488375.644406-1856488294', '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:00:10 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:00:10 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:00:10 INFO - Using env: {'DISPLAY': ':0', 02:00:10 INFO - 'HOME': '/home/cltbld', 02:00:10 INFO - 'LANG': 'en_US.UTF-8', 02:00:10 INFO - 'LANGUAGE': 'en_US:en', 02:00:10 INFO - 'LOGNAME': 'cltbld', 02:00:10 INFO - 'MAIL': '/var/mail/cltbld', 02:00:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:10 INFO - 'MOZ_NO_REMOTE': '1', 02:00:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:10 INFO - 'NO_EM_RESTART': '1', 02:00:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:10 INFO - 'PWD': '/builds/slave/test', 02:00:10 INFO - 'SHELL': '/bin/bash', 02:00:10 INFO - 'SHLVL': '1', 02:00:10 INFO - 'TERM': 'linux', 02:00:10 INFO - 'TMOUT': '86400', 02:00:10 INFO - 'USER': 'cltbld', 02:00:10 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1461488375.644406-1856488294', 02:00:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:10 INFO - '_': '/tools/buildbot/bin/python'} 02:00:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:00: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:00: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:00: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:00: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:00: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:00: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:00:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:00:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:00:12 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:00:12 INFO - Installing collected packages: mozsystemmonitor 02:00:12 INFO - Running setup.py install for mozsystemmonitor 02:00:13 INFO - Successfully installed mozsystemmonitor 02:00:13 INFO - Cleaning up... 02:00:13 INFO - Return code: 0 02:00:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:00: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:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00: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:00:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:13 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 0x7fd3e8d21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe459a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed4810>, '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 0xed5710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed5ba0>, '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': '0274524eba3bdaad075c2247000001d4-1461488375.644406-1856488294', '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:00:13 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:00:13 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:00:13 INFO - Using env: {'DISPLAY': ':0', 02:00:13 INFO - 'HOME': '/home/cltbld', 02:00:13 INFO - 'LANG': 'en_US.UTF-8', 02:00:13 INFO - 'LANGUAGE': 'en_US:en', 02:00:13 INFO - 'LOGNAME': 'cltbld', 02:00:13 INFO - 'MAIL': '/var/mail/cltbld', 02:00:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:13 INFO - 'MOZ_NO_REMOTE': '1', 02:00:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:13 INFO - 'NO_EM_RESTART': '1', 02:00:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:13 INFO - 'PWD': '/builds/slave/test', 02:00:13 INFO - 'SHELL': '/bin/bash', 02:00:13 INFO - 'SHLVL': '1', 02:00:13 INFO - 'TERM': 'linux', 02:00:13 INFO - 'TMOUT': '86400', 02:00:13 INFO - 'USER': 'cltbld', 02:00:13 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1461488375.644406-1856488294', 02:00:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:13 INFO - '_': '/tools/buildbot/bin/python'} 02:00:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:13 INFO - Downloading/unpacking blobuploader==1.2.4 02:00:13 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:00:13 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:00:13 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:00:13 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:00:13 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:00:13 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:00:15 INFO - Downloading blobuploader-1.2.4.tar.gz 02:00:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:00:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:00:15 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:00:15 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:00:15 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:00:15 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:00:15 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:00:15 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:00:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:00:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:00:15 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:00:15 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:00:15 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:00:15 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:00:15 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:00:15 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:00:16 INFO - Downloading docopt-0.6.1.tar.gz 02:00:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:00:16 INFO - Installing collected packages: blobuploader, requests, docopt 02:00:16 INFO - Running setup.py install for blobuploader 02:00:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:00:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:00:16 INFO - Running setup.py install for requests 02:00:16 INFO - Running setup.py install for docopt 02:00:16 INFO - Successfully installed blobuploader requests docopt 02:00:16 INFO - Cleaning up... 02:00:16 INFO - Return code: 0 02:00:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:00: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:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00: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:00:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:16 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 0x7fd3e8d21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe459a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed4810>, '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 0xed5710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed5ba0>, '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': '0274524eba3bdaad075c2247000001d4-1461488375.644406-1856488294', '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:00:16 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:00:16 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:00:16 INFO - Using env: {'DISPLAY': ':0', 02:00:16 INFO - 'HOME': '/home/cltbld', 02:00:16 INFO - 'LANG': 'en_US.UTF-8', 02:00:16 INFO - 'LANGUAGE': 'en_US:en', 02:00:16 INFO - 'LOGNAME': 'cltbld', 02:00:16 INFO - 'MAIL': '/var/mail/cltbld', 02:00:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:16 INFO - 'MOZ_NO_REMOTE': '1', 02:00:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:16 INFO - 'NO_EM_RESTART': '1', 02:00:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:16 INFO - 'PWD': '/builds/slave/test', 02:00:16 INFO - 'SHELL': '/bin/bash', 02:00:16 INFO - 'SHLVL': '1', 02:00:16 INFO - 'TERM': 'linux', 02:00:16 INFO - 'TMOUT': '86400', 02:00:16 INFO - 'USER': 'cltbld', 02:00:16 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1461488375.644406-1856488294', 02:00:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:16 INFO - '_': '/tools/buildbot/bin/python'} 02:00:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:00:16 INFO - Running setup.py (path:/tmp/pip-2_mpD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:00:17 INFO - Running setup.py (path:/tmp/pip-8PpsRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:00:17 INFO - Running setup.py (path:/tmp/pip-A_mxrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:00:17 INFO - Running setup.py (path:/tmp/pip-mP5972-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:00:17 INFO - Running setup.py (path:/tmp/pip-vmIf3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:00:17 INFO - Running setup.py (path:/tmp/pip-MOLZw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:00:17 INFO - Running setup.py (path:/tmp/pip-eGODUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:00:17 INFO - Running setup.py (path:/tmp/pip-T5cL_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:00:17 INFO - Running setup.py (path:/tmp/pip-whB6WJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:00:17 INFO - Running setup.py (path:/tmp/pip-A9Inzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:00:17 INFO - Running setup.py (path:/tmp/pip-l27d6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:00:17 INFO - Running setup.py (path:/tmp/pip-Y0rDe6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:00:17 INFO - Running setup.py (path:/tmp/pip-BLwre0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:00:17 INFO - Running setup.py (path:/tmp/pip-jXxhpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:00:17 INFO - Running setup.py (path:/tmp/pip-QncF6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:00:18 INFO - Running setup.py (path:/tmp/pip-8430lx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:00:18 INFO - Running setup.py (path:/tmp/pip-SIR6wq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:00:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:00:18 INFO - Running setup.py install for manifestparser 02:00:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:00:18 INFO - Running setup.py install for mozcrash 02:00:18 INFO - Running setup.py install for mozdebug 02:00:18 INFO - Running setup.py install for mozdevice 02:00:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:00:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:00:18 INFO - Running setup.py install for mozfile 02:00:18 INFO - Running setup.py install for mozhttpd 02:00:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:00:18 INFO - Running setup.py install for mozinfo 02:00:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:00:18 INFO - Running setup.py install for mozInstall 02:00:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:00:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:00:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:00:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:00:18 INFO - Running setup.py install for mozleak 02:00:19 INFO - Running setup.py install for mozlog 02:00:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:00:19 INFO - Running setup.py install for moznetwork 02:00:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:00:19 INFO - Running setup.py install for mozprocess 02:00:19 INFO - Running setup.py install for mozprofile 02:00:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:00:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:00:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:00:19 INFO - Running setup.py install for mozrunner 02:00:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:00:19 INFO - Running setup.py install for mozscreenshot 02:00:19 INFO - Running setup.py install for moztest 02:00:19 INFO - Running setup.py install for mozversion 02:00:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:00:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:00:19 INFO - Cleaning up... 02:00:19 INFO - Return code: 0 02:00:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:00:19 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:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:19 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:00:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:19 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 0x7fd3e8d21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe459a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed4810>, '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 0xed5710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed5ba0>, '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': '0274524eba3bdaad075c2247000001d4-1461488375.644406-1856488294', '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:00:19 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:00:19 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:00:19 INFO - Using env: {'DISPLAY': ':0', 02:00:19 INFO - 'HOME': '/home/cltbld', 02:00:19 INFO - 'LANG': 'en_US.UTF-8', 02:00:19 INFO - 'LANGUAGE': 'en_US:en', 02:00:19 INFO - 'LOGNAME': 'cltbld', 02:00:19 INFO - 'MAIL': '/var/mail/cltbld', 02:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:19 INFO - 'MOZ_NO_REMOTE': '1', 02:00:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:19 INFO - 'NO_EM_RESTART': '1', 02:00:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:19 INFO - 'PWD': '/builds/slave/test', 02:00:19 INFO - 'SHELL': '/bin/bash', 02:00:19 INFO - 'SHLVL': '1', 02:00:19 INFO - 'TERM': 'linux', 02:00:19 INFO - 'TMOUT': '86400', 02:00:19 INFO - 'USER': 'cltbld', 02:00:19 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1461488375.644406-1856488294', 02:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:19 INFO - '_': '/tools/buildbot/bin/python'} 02:00:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:00:20 INFO - Running setup.py (path:/tmp/pip-00g_B1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:00:20 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:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:00:20 INFO - Running setup.py (path:/tmp/pip-2aLTTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:00:20 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:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:00:20 INFO - Running setup.py (path:/tmp/pip-hkDYZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:00:20 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:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:00:20 INFO - Running setup.py (path:/tmp/pip-Nt6Uor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:00:20 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:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:00:20 INFO - Running setup.py (path:/tmp/pip-mk43mu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:00:20 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:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:00:20 INFO - Running setup.py (path:/tmp/pip-nTQNuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:00:20 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:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:00:20 INFO - Running setup.py (path:/tmp/pip-PPPrCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:00:20 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:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:00:20 INFO - Running setup.py (path:/tmp/pip-7333Yr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:00:20 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:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:00:20 INFO - Running setup.py (path:/tmp/pip-jwItcO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:00:20 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:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:00:20 INFO - Running setup.py (path:/tmp/pip-UyB5ye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:00:20 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:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:00:20 INFO - Running setup.py (path:/tmp/pip-WCgyWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:00:20 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:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:00:20 INFO - Running setup.py (path:/tmp/pip-EflZOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:00:21 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:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:00:21 INFO - Running setup.py (path:/tmp/pip-2sqHYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:00:21 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:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:00:21 INFO - Running setup.py (path:/tmp/pip-4dVOKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:00:21 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:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:00:21 INFO - Running setup.py (path:/tmp/pip-W0oNZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:00:21 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:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:00:21 INFO - Running setup.py (path:/tmp/pip-ihpT4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:00:21 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:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:00:21 INFO - Running setup.py (path:/tmp/pip-tGYUwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:00:21 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:00:21 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:00:21 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:00:21 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:00:21 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:00:21 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:00:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:00:21 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:00:21 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:00:21 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:00:21 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:00:21 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:00:21 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:00:23 INFO - Downloading blessings-1.6.tar.gz 02:00:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:00:23 INFO - Installing collected packages: blessings 02:00:23 INFO - Running setup.py install for blessings 02:00:23 INFO - Successfully installed blessings 02:00:23 INFO - Cleaning up... 02:00:23 INFO - Return code: 0 02:00:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:00:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:00:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:00:23 INFO - Reading from file tmpfile_stdout 02:00:23 INFO - Current package versions: 02:00:23 INFO - argparse == 1.2.1 02:00:23 INFO - blessings == 1.6 02:00:23 INFO - blobuploader == 1.2.4 02:00:23 INFO - docopt == 0.6.1 02:00:23 INFO - manifestparser == 1.1 02:00:23 INFO - mozInstall == 1.12 02:00:23 INFO - mozcrash == 0.17 02:00:23 INFO - mozdebug == 0.1 02:00:23 INFO - mozdevice == 0.48 02:00:23 INFO - mozfile == 1.2 02:00:23 INFO - mozhttpd == 0.7 02:00:23 INFO - mozinfo == 0.9 02:00:23 INFO - mozleak == 0.1 02:00:23 INFO - mozlog == 3.1 02:00:23 INFO - moznetwork == 0.27 02:00:23 INFO - mozprocess == 0.22 02:00:23 INFO - mozprofile == 0.28 02:00:23 INFO - mozrunner == 6.11 02:00:23 INFO - mozscreenshot == 0.1 02:00:23 INFO - mozsystemmonitor == 0.0 02:00:23 INFO - moztest == 0.7 02:00:23 INFO - mozversion == 1.4 02:00:23 INFO - psutil == 3.1.1 02:00:23 INFO - requests == 1.2.3 02:00:23 INFO - wsgiref == 0.1.2 02:00:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:00:23 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:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:23 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:00:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:23 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 0x7fd3e8d21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe459a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed4810>, '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 0xed5710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed5ba0>, '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': '0274524eba3bdaad075c2247000001d4-1461488375.644406-1856488294', '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:00:23 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:00:23 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:00:23 INFO - Using env: {'DISPLAY': ':0', 02:00:23 INFO - 'HOME': '/home/cltbld', 02:00:23 INFO - 'LANG': 'en_US.UTF-8', 02:00:23 INFO - 'LANGUAGE': 'en_US:en', 02:00:23 INFO - 'LOGNAME': 'cltbld', 02:00:23 INFO - 'MAIL': '/var/mail/cltbld', 02:00:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:23 INFO - 'MOZ_NO_REMOTE': '1', 02:00:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:23 INFO - 'NO_EM_RESTART': '1', 02:00:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:23 INFO - 'PWD': '/builds/slave/test', 02:00:23 INFO - 'SHELL': '/bin/bash', 02:00:23 INFO - 'SHLVL': '1', 02:00:23 INFO - 'TERM': 'linux', 02:00:23 INFO - 'TMOUT': '86400', 02:00:23 INFO - 'USER': 'cltbld', 02:00:23 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1461488375.644406-1856488294', 02:00:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:23 INFO - '_': '/tools/buildbot/bin/python'} 02:00:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:24 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:00:24 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:00:24 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:00:24 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:00:24 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:00:24 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:00:24 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:00:24 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:00:24 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:00:24 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:00:24 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:00:24 INFO - Cleaning up... 02:00:24 INFO - Return code: 0 02:00:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:00:24 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:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:24 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:00:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:24 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 0x7fd3e8d21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe459a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed4810>, '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 0xed5710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed5ba0>, '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': '0274524eba3bdaad075c2247000001d4-1461488375.644406-1856488294', '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:00:24 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:00:24 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:00:24 INFO - Using env: {'DISPLAY': ':0', 02:00:24 INFO - 'HOME': '/home/cltbld', 02:00:24 INFO - 'LANG': 'en_US.UTF-8', 02:00:24 INFO - 'LANGUAGE': 'en_US:en', 02:00:24 INFO - 'LOGNAME': 'cltbld', 02:00:24 INFO - 'MAIL': '/var/mail/cltbld', 02:00:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:24 INFO - 'MOZ_NO_REMOTE': '1', 02:00:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:24 INFO - 'NO_EM_RESTART': '1', 02:00:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:24 INFO - 'PWD': '/builds/slave/test', 02:00:24 INFO - 'SHELL': '/bin/bash', 02:00:24 INFO - 'SHLVL': '1', 02:00:24 INFO - 'TERM': 'linux', 02:00:24 INFO - 'TMOUT': '86400', 02:00:24 INFO - 'USER': 'cltbld', 02:00:24 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1461488375.644406-1856488294', 02:00:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:24 INFO - '_': '/tools/buildbot/bin/python'} 02:00:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:24 INFO - Downloading/unpacking jsonschema 02:00: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:00: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:00: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:00: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:00: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:00: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:00:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:00:26 INFO - Downloading/unpacking functools32 (from jsonschema) 02:00:26 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:00:26 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:00:26 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:00:26 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:00:26 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:00:26 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:00:26 INFO - Downloading functools32-3.2.3-2.tar.gz 02:00:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:00:26 INFO - warning: no files found matching '*.txt' 02:00:26 INFO - no previously-included directories found matching 'build' 02:00:26 INFO - no previously-included directories found matching 'dist' 02:00:26 INFO - no previously-included directories found matching '.git*' 02:00:26 INFO - Installing collected packages: jsonschema, functools32 02:00:26 INFO - Running setup.py install for functools32 02:00:26 INFO - warning: no files found matching '*.txt' 02:00:26 INFO - no previously-included directories found matching 'build' 02:00:26 INFO - no previously-included directories found matching 'dist' 02:00:26 INFO - no previously-included directories found matching '.git*' 02:00:26 INFO - Successfully installed jsonschema functools32 02:00:26 INFO - Cleaning up... 02:00:26 INFO - Return code: 0 02:00:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:26 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 0x7fd3e8d21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe459a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed4810>, '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 0xed5710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed5ba0>, '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': '0274524eba3bdaad075c2247000001d4-1461488375.644406-1856488294', '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:00:26 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:00:26 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:00:26 INFO - Using env: {'DISPLAY': ':0', 02:00:26 INFO - 'HOME': '/home/cltbld', 02:00:26 INFO - 'LANG': 'en_US.UTF-8', 02:00:26 INFO - 'LANGUAGE': 'en_US:en', 02:00:26 INFO - 'LOGNAME': 'cltbld', 02:00:26 INFO - 'MAIL': '/var/mail/cltbld', 02:00:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:26 INFO - 'MOZ_NO_REMOTE': '1', 02:00:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:26 INFO - 'NO_EM_RESTART': '1', 02:00:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:26 INFO - 'PWD': '/builds/slave/test', 02:00:26 INFO - 'SHELL': '/bin/bash', 02:00:26 INFO - 'SHLVL': '1', 02:00:26 INFO - 'TERM': 'linux', 02:00:26 INFO - 'TMOUT': '86400', 02:00:26 INFO - 'USER': 'cltbld', 02:00:26 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1461488375.644406-1856488294', 02:00:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:26 INFO - '_': '/tools/buildbot/bin/python'} 02:00:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:26 INFO - Downloading/unpacking flake8 02:00:26 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:00:26 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:00:26 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:00:26 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:00:26 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:00:26 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:00:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:00:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:00:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:00:29 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:00:29 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:00:29 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:00:29 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:00:29 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:00:29 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:00:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:00:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:00:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:00:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:00:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:00:29 INFO - no previously-included directories found matching 'docs/_build' 02:00:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:00:29 INFO - Running setup.py install for pep8 02:00:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:00:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:00:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:00:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:00:29 INFO - no previously-included directories found matching 'docs/_build' 02:00:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:00:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:00:29 INFO - Cleaning up... 02:00:29 INFO - Return code: 0 02:00:29 INFO - Running post-action listener: _resource_record_post_action 02:00:29 INFO - Running post-action listener: _start_resource_monitoring 02:00:29 INFO - Starting resource monitoring. 02:00:29 INFO - ##### 02:00:29 INFO - ##### Running install step. 02:00:29 INFO - ##### 02:00:29 INFO - Running pre-action listener: _resource_record_pre_action 02:00:29 INFO - Running main action method: install 02:00:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:00:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:00:29 INFO - Reading from file tmpfile_stdout 02:00:29 INFO - Detecting whether we're running mozinstall >=1.0... 02:00:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:00:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:00:30 INFO - Reading from file tmpfile_stdout 02:00:30 INFO - Output received: 02:00:30 INFO - Usage: mozinstall [options] installer 02:00:30 INFO - Options: 02:00:30 INFO - -h, --help show this help message and exit 02:00:30 INFO - -d DEST, --destination=DEST 02:00:30 INFO - Directory to install application into. [default: 02:00:30 INFO - "/builds/slave/test"] 02:00:30 INFO - --app=APP Application being installed. [default: firefox] 02:00:30 INFO - mkdir: /builds/slave/test/build/application 02:00:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:00:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:00:46 INFO - Reading from file tmpfile_stdout 02:00:46 INFO - Output received: 02:00:46 INFO - /builds/slave/test/build/application/firefox/firefox 02:00:46 INFO - Running post-action listener: _resource_record_post_action 02:00:46 INFO - ##### 02:00:46 INFO - ##### Running run-tests step. 02:00:46 INFO - ##### 02:00:46 INFO - Running pre-action listener: _resource_record_pre_action 02:00:46 INFO - Running main action method: run_tests 02:00:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:00:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:00:46 INFO - Python 2.7.3 02:00:46 INFO - Return code: 0 02:00:46 INFO - grabbing minidump binary from tooltool 02:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:46 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 0xed4810>, '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 0xed5710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed5ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:00:46 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:00:46 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:00:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:00:46 INFO - Return code: 0 02:00:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:00:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:00:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:00:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:00:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:00:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:00:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:00:47 INFO - Return code: 0 02:00:47 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/TqvH3Gv4ScCvbErBXpWI-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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:00:47 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/TqvH3Gv4ScCvbErBXpWI-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --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:00:47 INFO - Using env: {'DISPLAY': ':0', 02:00:47 INFO - 'HOME': '/home/cltbld', 02:00:47 INFO - 'LANG': 'en_US.UTF-8', 02:00:47 INFO - 'LANGUAGE': 'en_US:en', 02:00:47 INFO - 'LOGNAME': 'cltbld', 02:00:47 INFO - 'MAIL': '/var/mail/cltbld', 02:00:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:00:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:00:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:47 INFO - 'MOZ_NO_REMOTE': '1', 02:00:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:00:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:47 INFO - 'NO_EM_RESTART': '1', 02:00:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:47 INFO - 'PWD': '/builds/slave/test', 02:00:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:00:47 INFO - 'SHELL': '/bin/bash', 02:00:47 INFO - 'SHLVL': '1', 02:00:47 INFO - 'TERM': 'linux', 02:00:47 INFO - 'TMOUT': '86400', 02:00:47 INFO - 'USER': 'cltbld', 02:00:47 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1461488375.644406-1856488294', 02:00:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:47 INFO - '_': '/tools/buildbot/bin/python'} 02:00:47 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/TqvH3Gv4ScCvbErBXpWI-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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:00:47 INFO - mozversion application_buildid: 20160423233016 02:00:47 INFO - mozversion application_changeset: 8afadb96e97704a98492c2286fb92479deb3365f 02:00:47 INFO - mozversion application_display_name: Nightly 02:00:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:00:47 INFO - mozversion application_name: Firefox 02:00:47 INFO - mozversion application_remotingname: firefox 02:00:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:00:47 INFO - mozversion application_vendor: Mozilla 02:00:47 INFO - mozversion application_version: 48.0a1 02:00:47 INFO - mozversion platform_buildid: 20160423233016 02:00:47 INFO - mozversion platform_changeset: 8afadb96e97704a98492c2286fb92479deb3365f 02:00:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:00:47 INFO - mozversion platform_version: 48.0a1 02:00:47 INFO - using testdate: 1461488447 02:00:47 INFO - actual date: 1461488447 02:00:47 INFO - starting webserver on 'localhost:42080' 02:00:47 INFO - SUITE-START | Running 2 tests 02:00:47 INFO - TEST-START | dromaeo_css 02:00:47 INFO - operating with platform_type : linux_ 02:00:47 INFO - Initialising browser for dromaeo_css test... 02:00:47 INFO - TEST-INFO | started process 23446 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHXGV5_/profile http://localhost:42080/getInfo.html) 02:00:51 INFO - PROCESS | 23446 | __metrics Screen width/height:1600/1200 02:00:51 INFO - PROCESS | 23446 | colorDepth:24 02:00:51 INFO - PROCESS | 23446 | Browser inner width/height: 1024/697 02:00:51 INFO - PROCESS | 23446 | __metrics 02:00:52 ERROR - PROCESS | 23446 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:00:53 INFO - TEST-INFO | 23446: exit 0 02:00:53 INFO - Browser initialized. 02:00:53 INFO - Running cycle 1/1 for dromaeo_css test... 02:00:53 INFO - TEST-INFO | started process 23526 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHXGV5_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:01:04 INFO - PROCESS | 23526 | RSS: Main: 154218496 02:01:04 INFO - PROCESS | 23526 | 02:01:56 INFO - PROCESS | 23526 | 1461488516027 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:04:03 INFO - PROCESS | 23526 | Cycle 1(1): loaded http://localhost:42080/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42080/tests/dromaeo/cssquery-ext.html) 02:04:04 INFO - PROCESS | 23526 | RSS: Main: 265809920 02:04:04 INFO - PROCESS | 23526 | 02:07:07 INFO - PROCESS | 23526 | Cycle 1(1): loaded http://localhost:42080/tests/dromaeo/cssquery-ext.html (next: http://localhost:42080/tests/dromaeo/cssquery-jquery.html) 02:07:07 INFO - PROCESS | 23526 | RSS: Main: 236552192 02:07:07 INFO - PROCESS | 23526 | 02:10:09 INFO - PROCESS | 23526 | Cycle 1(1): loaded http://localhost:42080/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42080/tests/dromaeo/cssquery-mootools.html) 02:10:10 INFO - PROCESS | 23526 | RSS: Main: 240758784 02:10:10 INFO - PROCESS | 23526 | 02:13:11 INFO - PROCESS | 23526 | Cycle 1(1): loaded http://localhost:42080/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42080/tests/dromaeo/cssquery-prototype.html) 02:13:12 INFO - PROCESS | 23526 | RSS: Main: 228110336 02:13:12 INFO - PROCESS | 23526 | 02:16:15 INFO - PROCESS | 23526 | Cycle 1(1): loaded http://localhost:42080/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42080/tests/dromaeo/cssquery-yui.html) 02:16:15 INFO - PROCESS | 23526 | RSS: Main: 224006144 02:16:15 INFO - PROCESS | 23526 | 02:19:18 INFO - PROCESS | 23526 | Cycle 1(1): loaded http://localhost:42080/tests/dromaeo/cssquery-yui.html (next: http://localhost:42080/tests/dromaeo/cssquery-dojo.html) 02:19:18 INFO - PROCESS | 23526 | RSS: Main: 280637440 02:19:18 INFO - PROCESS | 23526 | 02:19:18 INFO - PROCESS | 23526 | __start_tp_report 02:19:18 INFO - PROCESS | 23526 | _x_x_mozilla_page_load 02:19:18 INFO - PROCESS | 23526 | _x_x_mozilla_page_load_details 02:19:18 INFO - PROCESS | 23526 | |i|pagename|runs| 02:19:18 INFO - PROCESS | 23526 | |0;dojo.html;3173.5081062435324;3197.5363572282035;3235.838208089595;3237.401080800052;3269.7057264846167;5296.205569164617;5441.5102640762325;5451.291332126828;5467.398586155519;5482.251720992367;5338.572914166867;5394.595405344595;5402;5560.2493663355435;5565.888682226353;4826.034793041388;4930.6302027348;5037.622178336621;5070.492950704936;5085.974570127144;4740.620750339965;5024.673396229234;5029.924551131736;5059.16523773577;5094.592432605401;4937.827176048839;4942.481039490855;4974.228994505857;4978;4978.775955081994;4927.852164435073;4953.380827396575;4953.6037117030555;4964.578010869081;5006.123928312531;4790.185668436374;4919.065377578285;4929.975350123226;4959.107360675077;5050.949490505084;5351.2240725095035;5354.651947623431;5357.276767636358;5372.140457526816;5383.892322153574;5753.223314852483;5796.333421656479;5803.88392232153;5805.825825225208;5808.4191580842;5663.207150998864;5767.4520920512905;5802.854928626818;5879.7648094076185;5915.822525324247;5451.890962180773;5457.672539647594;5458.181272809111;5459.153831156177;5468.043092458804;5944.940550594525;5953.910691339634;5972;5976.910346344808;5979.910301345483;5611.2144299798065;5729.398413166641;5771.88456230873;5815.244018277682;5826.679532625746;5587.944120558824;5594.944050559524;5610.382857885629;5613;5642.943570564242;5569.860753481195;5571.916421253684;5576.414476479911;5585.078462053797;5620;5715.8856822864145;5726.828195154152;5740.512056475163;5761.567882408836;5793.391693872167;4248.617624413818;4285.978570107191;4292.248856450109;4306.590873866978;4325.091730736518;3749.8312575934146;3854.9229015420096;3864.072622570563;3883.7475564088245;3908.5895980922164;5438.211459338374;5447.863803404946;5464.699441530674;5466.070767969375;5520.889582208413;5848.678322692208;5860.736266868002;5873.765049398062;5874.148248503943;5878.177055212273;5236.24074509194;5372.785088596491;5378.838634840961;5403.486668766461;5447.4824891635235;4930.235813448921;4943.629227807929;4963.205887058053;4966.503349665005;4973.726445045485;5999.220101386792;6000.879982400327;6003.159557661931;6012.158297838306;6040.244969378828;5554.888902222014;5729.140628905531;5806.82579522615;5811.4479124483105;5816.912746308724;5997.790077347272;6016.398360163948;6020.066889632114;6023.1266466363;6024.277086749618;5732.627379220337;5741.052726300114;5742.109972954198;5744.5117165039765;5750.539956803362;5601.60788744784;5816.127580862735;5848.064309710426;5893.2044174035955;5904.645721256738;5689.345725241485;5708.4862362387585;5711.600187986801;5712.143178523254;5716.342620598684;5517.944820551743;5620.971895140498;5695.0603150481365;5703.686297253691;5705;5556.888862222814;5600.747966341606;5607.243022192115;5620.1569764534015;5651.802186923438;5684.744186511534;5692.971535142297;5694.430556944272;5705.258316419005;5711.057675483665;5441;5589.944100558942;5597.748101335531;5599.1041433370465;5636.4927156556105 02:19:18 INFO - PROCESS | 23526 | |1;ext.html;602.8402473344564;640.9807705768826;644.0468107201339;649.9447546958506;651.8337823854918;28704.28239294016;29371.853140734293;38636.0340991475;39613.405798912965;39693.40459893104;44237.336439953426;44845.551544484544;44875.55124448754;44979.32531012029;45086;8760.824783504342;8987.281017518582;8987.325950553703;8991.460512369245;9001.459912405244;8625.827483450326;8763.912360876406;8765.254953328942;8766.34252431067;8768.430052046628;8871.733847984538;8959.641614335418;8975.102489751038;8983.955080224623;8991.595378207996;8838.33712471564;8891.599878005505;8919.598618062171;8921.955390223007;8930.821383572325;8774.780630484225;8859.424137431046;8882.866756998586;8883.51140687262;8885.2447541959;41559;42066;42164;42183.36724949128;42199.156016879795;3509.6841284284537;3621.5292012038267;3632.691221246197;3842.769433833951;4208.242516347056;30623.451816038465;30932.226694332596;31400.37199256025;31431.52852707211;32522;4072.2669919414493;4090.427340172378;4120.340745480738;4265.808038638269;4272.487301523806;271333;274786;275753.6212318946;275990;278419;57022;58377.70811145917;58426.123608145914;58431.12353314704;58431.403917491305;62314.376856231764;62352.376476235564;62418.375816242165;62569.37430625727;62623.6868815653;18052.909735451238;18349.17428715711;18358.449246522625;18361.632767344578;18362.357317493825;13964.650883727785;14074.929625351808;14091.506797262251;14091.859081409055;14093.436262549383;18349.484368134872;20039.499012524804;20113.798862011485;20335.79664203339;20448.284310049075;5937.584369094208;7145.142582889983;7233.789648748603;7569.772906812805;7582.156691240784;1008.3596915958419;1008.3848852200152;1054.4938429553856;1062.054771253585;1079.4602698650674;31051.60267787955;32434;32447;32684;32782.672173278435;1191.18999080626;1205.7166565857017;1229.6065259116997;1234.5864135514523;1281.9423125959354;17093.914530427515;17369.56576085583;17382.3047078118;17542.73685894687;17595.648087038444;455251;465684;468512;468709;469672;56736.43263567394;57542;57658.7117064412;57660;57891.71054144702;1271.3007845684836;1376.0917794255943;1410.6473381654587;1417.206364435919;1423.4092851466526;30854.382912341178;33114.834425827714;33491.330173396884;33666.49500257547;34102.658973410944;50850.23724644059;51973.480265196864;52356.21465678094;52368;52400;414083;426211;426901;429182;430627;37823.81088094652;43605.78197108994;44691.32963005623;44748.55251447444;45234.77382613066;45361;49308.50691493183;49613;50127;50220.49779502158;41757.37363939483;42364.152716946104;43185.13629727325;43436.78281608572;43567;41147.38278925879;41913.79043104765;42088.57911420969;42132.368014480424;42899.57100428956;42124.368134478624;42285.94285142773;43084.78457607692;43349;43428;36069.63930360663;37411.25177496489;37613.2477350446;37742.24515509729;38303.42544861885;27291.317717056438;27903.746414973604;28155.71844281613;28155.88252909824;28397.432051359272 02:19:18 INFO - PROCESS | 23526 | |2;jquery.html;358.6216541548665;369.9352613292674;386.62497377543775;394.92693851637443;399.9880003599893;17926.282948682052;18851.905740471277;19240.518987025313;19312.613747725038;19327.323543675975;17538.736918946226;18402.907985460086;18922.526936826587;19230.711539326887;19240.51898702533;4915.975420122894;5017.247412888059;5060.443351231362;5064.772085256154;5099.821506247282;5673.971630141844;5695;5719.084946408576;5723.799667011655;5727.484526392624;5244.8688782780355;5589.441055894418;5659.462351076641;5667.036603777347;5677.347105082927;5418.674879507243;5427.83716488506;5428.75570599324;5441.891162176735;5460.372057213432;5177.145770947789;5523.28197334348;5548.611597188198;5548.889022219533;5570.777168913239;11885.702857428634;12022.759544809142;12124.27254364741;18113;22641.886790566106;2337.567550003255;2357.6934998450092;2610.8955641774305;2755.925189176223;2786.878695860629;9073.31950103745;9392.48341341226;9435.198008169315;10606.257561970666;14364.712705745827;1858.721191821224;1939.4472575316108;1976.7726711428227;2016.5563576013253;2054.5069183396026;76990.6150469244;80867.99999999942;81255.18744812535;81619.18380816234;82600.58699706523;10618.73453163677;10749.677509674722;10778.946105269424;11008.834867476995;11074.224804263624;15107.169105699291;15170.772438413433;15216.163111029;15242.618934526503;15271.847281527265;7903.604819758989;8165.918340816515;8181.918180818235;8353.164683531599;8375.246227839523;7948.682052717826;8012.479188852706;8051.114377418479;8120.715774947848;8156.1028286888395;4578.9771051144535;4648.163975229833;4690.64820138491;4771.33201351811;4804.663673542818;1764.1179410294853;1859.4421673498166;1866.2721538599958;1874.0255067364894;1888.5373083594332;1018.5467466977273;1035.440861934547;1059.7668512927144;1120.7366268926796;1163.8661553921409;16936.491905242863;18186.63626727458;18441.446756597325;19186.13662385196;19318.32385866488;1034.4982683398546;1065.5471424644495;1070.5664205996584;1100.6808025672465;1115.983260251097;10318.329308594917;10731.570737170581;10757.515911783988;10785.298955567863;10905.127589792797;482337;488840;488952;489217;511511;60454.69772651108;75840;79700;90371;92240;1039.5529922133403;1064.6752740414092;1083.4961742789483;1085.592902661502;1088.6407485529755;16148.838511615204;16150.838491614933;16166.272517736496;16368.75446868274;16373.099479528264;37225.627743722216;37665;37834;38608;38855.41716874193;51599;53644.46355536551;53875.46124538704;53937.19094213669;54249.45750542602;8036;8324.500529968222;8379.916200837913;8523.74428767138;8551.444156129832;9481.762955926157;12780.808287875503;12872.742545149233;13114.475420983053;13307.733845323233;11396.544138234378;11707.765844682888;11845.289282643069;12068.939655301667;12153.635390938285;11373.374464404536;11424.086073114297;11598.47806848677;11663.825042624538;11777.293362398283;11629.476673549541;11655.358955257543;11750.647480575597;11944.402779861146;12097.334646594521;8230.711925082593;8369.874451883104;8376.748697539084;8407.3694472916;8451.83096338082;8557.61490732906;11495.712607184887;11692.70768230801;11901;11903.345316007702 02:19:18 INFO - PROCESS | 23526 | |3;mootools.html;1341.2489006156559;1523.0861483110136;1551.767234914763;1713.982860171398;1862.4878158506417;7497.850042999136;8295.377846661502;8467.110953349902;8489.151084891508;8494.447860889039;8127.5529845858455;8274.54490003051;8286.088530261666;8293;8307.127751586087;2333.3699901026757;2356.77610626991;2357.976420235793;2363.4682196505732;2363.846349987254;2285.6000199965024;2302.4474126209675;2319.860808351504;2326.0579465316573;2342.4143964009;2260.9660855087186;2286.1884031168943;2303.1593468384085;2312.606856834342;2313.144136669426;2197.494576247472;2230.69885565449;2239.9664005039936;2240.686303917461;2240.977590224093;2256.5599708056934;2262.2082271205113;2272.227442669484;2273.102124660766;2274.3518097342344;8326.25063744266;8417.957910210409;8421.70524031656;8447;8467.70363037297;5111.514406131411;5258.55302299305;5278.709670968095;5288.550473209782;5305.177697456862;3306.669333066674;3345.983270083658;3347.7656564040526;3350.157413422608;3375;991.5934466868549;1001.6494227020557;1004.6182450668699;1008.1027885182194;1018.383877753963;11352.829707554394;11889.881101188965;11926.045916326673;11928.940355298255;11934.701632459171;4266.765327906933;4417.094495628388;4419.337099435111;4518.277075667877;4563.110193512233;9403.34176607631;9405.670801521914;9411.529423528797;9411.623535058658;9422.481763502936;5063.189889617717;5066.442691303953;5068.847934561969;5098.694078355311;5104.081265372269;4159.147374788222;4260.765657888784;4353.869383918487;4778.617710583145;4804.159272127364;3651.379265524867;3735.4396840474146;3756.4553139794575;3763.6800871925643;3777.301199278142;1084.8264277715527;1130.8247221680654;1142.817149256115;1145.8281257811395;1151.9424028798526;998.6953979036318;1006.8791744990501;1011.5245834457793;1015.6496008876926;1044.9320794148357;5983.282006159202;6129.080637904261;6129.816105516842;6130.264368275835;6224.968875155595;453.32228318663806;463.4253525628197;464.9814007439732;469.4460536566884;1038.9792204155874;4128.958710412918;4144.046869220036;4244.236037513216;4248.787560622019;4263.658907287409;10521.421321827373;10929.890701093047;10980.066694330912;11002.449877506093;11023.83464248037;10511.106555942677;10617.787644247072;10851.40317282557;10868.402237876993;10891.727706807393;8022.679092836222;8028.759137225892;8037.919620803717;8156.265936065783;8178.509289442533;5854.4730974212525;5884.176215329943;5981;6034.879302414015;6059.151718759289;9633.470159141314;9700;9879.06148915852;9886.209103271865;9926.801463970825;9851.901480985385;9880.35777674449;9989.60041598328;10164.745881353025;10218.284720069523;6621.106150669598;7363.190049094703;7575.848483030419;7579.583122928292;7595.962020189863;7967.083785364525;8008.599570021592;8068.47554908929;8081.515109093473;8090.150534193825;7314.268573142643;7512.32389084985;7522.887156692764;7591.316781489692;7649.235076492307;7104.325089116525;7245.058142441449;7328.78013659591;7335.816604584928;7420.183779784327;6857.828554285983;6881.071055407456;6923.826904327432;6945.201301850352;6947.861042779217;4995.525425084611;5027.245913113063;5152.948470515247;5223.347081614798;5261.947380526299;5187.144121219956;5189.870253243699;5196.168613021899;5206.114960456807;5280.630355875205 02:19:18 INFO - PROCESS | 23526 | |4;prototype.html;300.53567238616347;306.60294918081087;307.2334525359228;311.59337065129995;326.6390638344629;5318.149096144618;5510.559155267579;5592.504684572143;5630.339049980255;5714.628549144302;5605.411431799664;5613.017721898672;5616.747246373913;5626.578006649497;5665.830025099243;4361.105973275471;4364.323529852878;4375.321825117112;4399.12017596482;4399.142167277382;4185.476815398075;4194.496660400741;4275.572442755715;4368.847090351838;4378.584034516732;4275.294576394891;4304.31131019037;4310.396544483775;4324.724206359116;4343;4317.4603174603335;4323.200207961537;4332.91334173318;4339.06710057336;4348.086901750605;3700.6299370063048;3822.694184465236;3827;3834.2906562286066;3834.961650383488;5390.137577987503;5442.12925931849;5459.826137380483;5459.863503412406;5460.208269800896;4967.50324967504;4972.6270529710055;4975.651704380694;4979.228219625964;4984.501549845023;5703.65778053314;5864.70676466175;5865.296164460249;5879.353271140171;5910.645361278337;4168.228877657612;4170.915561953883;4184.284443378231;4187.20443115807;4189.434426352434;5817.941820581825;6074.453299203093;6168.722407491674;6177;6179.134921111048;4154.91690166195;4161.0845613964875;4170.270202714512;4260.957390426056;4299.527052024275;4345.261305578059;4350.978245108818;4352.978235108804;4362.476502819682;4368.890777730582;4896.804127834918;4983.526564976321;4985.177445721488;4994.101061808837;4996.625253105959;5933.940660593339;5946.910796338058;5960.7019649017375;5968.85077873048;5979.4917432018765;1476.8006319146994;1497.0643347907558;1497.2663394936621;1498.9175595342142;1498.932548035341;996.5166894056376;1020.6529779874878;1029.5933106423072;1032.4785983078498;1038.5638032026568;5601.467860553241;5660.5471562274915;5667.744951477193;5674.404187560329;5674.546036317167;6062;6066.666333351708;6075.33171351151;6076.8784624308155;6081.3614570470345;5445.319335083114;5621.213030175779;5651.604387692904;5712.828615141552;5725.026745453283;3244.5133230015213;3248.740100791931;3265.7387409007224;3271;3275.5086736989642;6068.726907289182;6302.1177035215105;6322.841928951813;6326.652034138075;6435.905895997598;6296.653684047421;6310.242770867433;6314.0844577536;6319.210098737658;6323.43089121972;6254.906176407267;6312.747490100436;6354.809355719336;6381.266154392211;6419.565532440122;6139.539534534839;6157.230346206724;6160.784372546939;6202.069689546604;6202.41077097675;6093.2078829751845;6099.512039036777;6105.419985101408;6126.846828829137;6135.6932153393045;5998.25021872266;6041.697915104315;6333.1766870306565;6336.144620476177;6369.235691716838;4187.078842654611;4221.2190744712325;4228.386883901879;4242.554531774119;4243.533211346811;5942.702864856827;6144;6178.567500274938;6194.4115309045565;6207.131001659862;5952.76188952437;5955.344912059583;5963.194968679346;5963.493103086113;5981.700914954322;5932.584719069624;5942.910856337072;5960.195373624679;5961.317407166879;5994.460498555151;5639.167270636977;5876.382979787061;5882.940970660235;5888.528917686489;5903.409659034234;5962.19510366095;5978.282606087123;5993.790217342372;6012.969935150471;6031.125486804476;5711.400302968129;5844.094165404369;5869.383714709894;5891.23413956183;5900.495373679856 02:19:18 INFO - PROCESS | 23526 | |5;yui.html;729.51122747759;732.7069172331067;803.4135081390581;841.1630427724415;881.53278762256;15043.849561504381;15274.847251527495;15410.768838467431;15481.612959676013;15526.146061966587;14948.701025979473;15163.393464261444;15275.923620381911;15285;15332.540023799276;687.1410736579276;860.8364410761935;866.4498043742205;869.4131461263653;870.4603146049458;829.601791140253;844.025150950653;844.3203221406765;847.9406441549094;850.6639877248483;866.9176428239339;885.844977129003;886.5168483176652;892.0366004714892;892.1970226795871;718.5293632670557;865.7965378136133;875.8554838451648;879.2174964281762;880.3221519430067;645.3965542218041;648.9513286503484;654.9738010479575;655.5247445601948;656.3239862941178;14912.776308355384;14941.103533788008;14949.40202391903;14965.850341496554;15003.249837508081;12268.32524211168;12820.679483012906;13045.34773261333;13170.67073323165;13277.86722132776;11731.120165987584;11786.58746943853;11938.104642151873;12138.757224855453;12174.330411827346;3880.3209438348176;3895.5130608673917;3928.3125453045886;3988.3020471417385;4021.2962731521866;58047.709761450926;58071.70964145195;58112.41887581113;58309;58875.70562147204;10523.26337156407;11240.718982025515;11248.100151987821;11289.153313501356;11396.373199474108;19484.415467535997;19498.220071197276;19506.902465487583;19510.122044508033;19549.706754398412;8176.1006289308125;8194.836103277901;8407.159284071544;8447.746567602982;8469.02606200295;4638.976805115953;4718.669693121517;4741.122892264873;4761.285807128958;4814.711117332971;3333.483310086892;3420.0936751760805;3430.953559164479;3432.811195384228;3437.7077948374667;606.0333767640606;611.2084850119106;617.3147805935408;629.568745409396;633.3697970519363;635.5614625908108;744.115715962674;759.1800855076505;764.9808754781175;773.81428457171;9140.260695785282;9708.320417570701;9813.11681948628;9822.217562568288;9887.703368898945;611.5566214494456;744.7691215723144;751.6241879060469;759.2635143910398;785.3873978296938;4378.918592327728;4621.560951709582;4622.838200662961;4640.350350950869;4710.788014539354;62533.68733156305;63395.6830215846;63786.68106659437;64222.67888660527;64552.35447645558;55994.16008759872;56069;56651.43348566462;57128.14307785386;58008.12987805186;50135.24797128046;51525.48474515282;51529;52169;52661;8766.21104100634;8827.16141966512;8856.734297971072;8885.200331970154;8980.326475514494;32395;33234.501482477295;33321.16697082592;33438.66561334453;33722.83138584292;40778;46850.53149468598;47405;47587.52412475831;47637.20916337654;10685.946570267099;10805.945970270099;10940.452977350942;11155.553777848796;11460.255083419552;12101.455434505293;12292.569760058355;12373.257604543756;12450.501979921064;12512.687182820502;11751.823722643996;12047.397630118634;12226.816597750863;12606.243625382507;12896.871031289942;12355.32045737493;12697.111202215756;12770;13090.214587124803;13172.077954543473;12423.130380873252;12947.611571652866;13005;13340.132891362031;13423.194608323533;10296.21716601934;10677.626283080055;10689.144868410664;10975.396353200651;11145.164112691418;10322.277440579088;10550;10665.9466702666;10732.51703673321;11187 02:19:18 INFO - PROCESS | 23526 | __end_tp_report 02:19:18 INFO - PROCESS | 23526 | __start_cc_report 02:19:18 INFO - PROCESS | 23526 | _x_x_mozilla_cycle_collect,863 02:19:18 INFO - PROCESS | 23526 | __end_cc_report 02:19:18 INFO - PROCESS | 23526 | __startTimestamp1461489558683__endTimestamp 02:19:18 INFO - PROCESS | 23526 | 02:19:18 INFO - PROCESS | 23526 | ------- Summary: start ------- 02:19:18 INFO - PROCESS | 23526 | Number of tests: 6 02:19:18 INFO - PROCESS | 23526 | 02:19:18 INFO - PROCESS | 23526 | [#0] dojo.html Cycles:165 Average:5375.11 Median:5585.08 stddev:611.40 (10.9%) stddev-sans-first:588.37 02:19:18 INFO - PROCESS | 23526 | Values: 3173.5 3197.5 3235.8 3237.4 3269.7 5296.2 5441.5 5451.3 5467.4 5482.3 5338.6 5394.6 5402.0 5560.2 5565.9 4826.0 4930.6 5037.6 5070.5 5086.0 4740.6 5024.7 5029.9 5059.2 5094.6 4937.8 4942.5 4974.2 4978.0 4978.8 4927.9 4953.4 4953.6 4964.6 5006.1 4790.2 4919.1 4930.0 4959.1 5050.9 5351.2 5354.7 5357.3 5372.1 5383.9 5753.2 5796.3 5803.9 5805.8 5808.4 5663.2 5767.5 5802.9 5879.8 5915.8 5451.9 5457.7 5458.2 5459.2 5468.0 5944.9 5953.9 5972.0 5976.9 5979.9 5611.2 5729.4 5771.9 5815.2 5826.7 5587.9 5594.9 5610.4 5613.0 5642.9 5569.9 5571.9 5576.4 5585.1 5620.0 5715.9 5726.8 5740.5 5761.6 5793.4 4248.6 4286.0 4292.2 4306.6 4325.1 3749.8 3854.9 3864.1 3883.7 3908.6 5438.2 5447.9 5464.7 5466.1 5520.9 5848.7 5860.7 5873.8 5874.1 5878.2 5236.2 5372.8 5378.8 5403.5 5447.5 4930.2 4943.6 4963.2 4966.5 4973.7 5999.2 6000.9 6003.2 6012.2 6040.2 5554.9 5729.1 5806.8 5811.4 5816.9 5997.8 6016.4 6020.1 6023.1 6024.3 5732.6 5741.1 5742.1 5744.5 5750.5 5601.6 5816.1 5848.1 5893.2 5904.6 5689.3 5708.5 5711.6 5712.1 5716.3 5517.9 5621.0 5695.1 5703.7 5705.0 5556.9 5600.7 5607.2 5620.2 5651.8 5684.7 5693.0 5694.4 5705.3 5711.1 5441.0 5589.9 5597.7 5599.1 5636.5 02:19:18 INFO - PROCESS | 23526 | 02:19:18 INFO - PROCESS | 23526 | [#1] ext.html Cycles:180 Average:56491.23 Median:42242.55 stddev:104871.21 (248.3%) stddev-sans-first:105081.45 02:19:18 INFO - PROCESS | 23526 | Values: 602.8 641.0 644.0 649.9 651.8 28704.3 29371.9 38636.0 39613.4 39693.4 44237.3 44845.6 44875.6 44979.3 45086.0 8760.8 8987.3 8987.3 8991.5 9001.5 8625.8 8763.9 8765.3 8766.3 8768.4 8871.7 8959.6 8975.1 8984.0 8991.6 8838.3 8891.6 8919.6 8922.0 8930.8 8774.8 8859.4 8882.9 8883.5 8885.2 41559.0 42066.0 42164.0 42183.4 42199.2 3509.7 3621.5 3632.7 3842.8 4208.2 30623.5 30932.2 31400.4 31431.5 32522.0 4072.3 4090.4 4120.3 4265.8 4272.5 271333.0 274786.0 275753.6 275990.0 278419.0 57022.0 58377.7 58426.1 58431.1 58431.4 62314.4 62352.4 62418.4 62569.4 62623.7 18052.9 18349.2 18358.4 18361.6 18362.4 13964.7 14074.9 14091.5 14091.9 14093.4 18349.5 20039.5 20113.8 20335.8 20448.3 5937.6 7145.1 7233.8 7569.8 7582.2 1008.4 1008.4 1054.5 1062.1 1079.5 31051.6 32434.0 32447.0 32684.0 32782.7 1191.2 1205.7 1229.6 1234.6 1281.9 17093.9 17369.6 17382.3 17542.7 17595.6 455251.0 465684.0 468512.0 468709.0 469672.0 56736.4 57542.0 57658.7 57660.0 57891.7 1271.3 1376.1 1410.6 1417.2 1423.4 30854.4 33114.8 33491.3 33666.5 34102.7 50850.2 51973.5 52356.2 52368.0 52400.0 414083.0 426211.0 426901.0 429182.0 430627.0 37823.8 43605.8 44691.3 44748.6 45234.8 45361.0 49308.5 49613.0 50127.0 50220.5 41757.4 42364.2 43185.1 43436.8 43567.0 41147.4 41913.8 42088.6 42132.4 42899.6 42124.4 42285.9 43084.8 43349.0 43428.0 36069.6 37411.3 37613.2 37742.2 38303.4 27291.3 27903.7 28155.7 28155.9 28397.4 02:19:18 INFO - PROCESS | 23526 | 02:19:18 INFO - PROCESS | 23526 | [#2] jquery.html Cycles:180 Average:28125.85 Median:2347.63 stddev:80926.16 (3447.1%) stddev-sans-first:81126.32 02:19:18 INFO - PROCESS | 23526 | Values: 358.6 369.9 386.6 394.9 400.0 17926.3 18851.9 19240.5 19312.6 19327.3 17538.7 18402.9 18922.5 19230.7 19240.5 4916.0 5017.2 5060.4 5064.8 5099.8 5674.0 5695.0 5719.1 5723.8 5727.5 5244.9 5589.4 5659.5 5667.0 5677.3 5418.7 5427.8 5428.8 5441.9 5460.4 5177.1 5523.3 5548.6 5548.9 5570.8 11885.7 12022.8 12124.3 18113.0 22641.9 2337.6 2357.7 2610.9 2755.9 2786.9 9073.3 9392.5 9435.2 10606.3 14364.7 1858.7 1939.4 1976.8 2016.6 2054.5 76990.6 80868.0 81255.2 81619.2 82600.6 10618.7 10749.7 10778.9 11008.8 11074.2 15107.2 15170.8 15216.2 15242.6 15271.8 7903.6 8165.9 8181.9 8353.2 8375.2 7948.7 8012.5 8051.1 8120.7 8156.1 4579.0 4648.2 4690.6 4771.3 4804.7 1764.1 1859.4 1866.3 1874.0 1888.5 1018.5 1035.4 1059.8 1120.7 1163.9 16936.5 18186.6 18441.4 19186.1 19318.3 1034.5 1065.5 1070.6 1100.7 1116.0 10318.3 10731.6 10757.5 10785.3 10905.1 482337.0 488840.0 488952.0 489217.0 511511.0 60454.7 75840.0 79700.0 90371.0 92240.0 1039.6 1064.7 1083.5 1085.6 1088.6 16148.8 16150.8 16166.3 16368.8 16373.1 37225.6 37665.0 37834.0 38608.0 38855.4 51599.0 53644.5 53875.5 53937.2 54249.5 8036.0 8324.5 8379.9 8523.7 8551.4 9481.8 12780.8 12872.7 13114.5 13307.7 11396.5 11707.8 11845.3 12068.9 12153.6 11373.4 11424.1 11598.5 11663.8 11777.3 11629.5 11655.4 11750.6 11944.4 12097.3 8230.7 8369.9 8376.7 8407.4 8451.8 8557.6 11495.7 11692.7 11901.0 11903.3 02:19:18 INFO - PROCESS | 23526 | 02:19:18 INFO - PROCESS | 23526 | [#3] mootools.html Cycles:180 Average:5626.10 Median:5011.39 stddev:3185.17 (63.6%) stddev-sans-first:3177.82 02:19:18 INFO - PROCESS | 23526 | Values: 1341.2 1523.1 1551.8 1714.0 1862.5 7497.9 8295.4 8467.1 8489.2 8494.4 8127.6 8274.5 8286.1 8293.0 8307.1 2333.4 2356.8 2358.0 2363.5 2363.8 2285.6 2302.4 2319.9 2326.1 2342.4 2261.0 2286.2 2303.2 2312.6 2313.1 2197.5 2230.7 2240.0 2240.7 2241.0 2256.6 2262.2 2272.2 2273.1 2274.4 8326.3 8418.0 8421.7 8447.0 8467.7 5111.5 5258.6 5278.7 5288.6 5305.2 3306.7 3346.0 3347.8 3350.2 3375.0 991.6 1001.6 1004.6 1008.1 1018.4 11352.8 11889.9 11926.0 11928.9 11934.7 4266.8 4417.1 4419.3 4518.3 4563.1 9403.3 9405.7 9411.5 9411.6 9422.5 5063.2 5066.4 5068.8 5098.7 5104.1 4159.1 4260.8 4353.9 4778.6 4804.2 3651.4 3735.4 3756.5 3763.7 3777.3 1084.8 1130.8 1142.8 1145.8 1151.9 998.7 1006.9 1011.5 1015.6 1044.9 5983.3 6129.1 6129.8 6130.3 6225.0 453.3 463.4 465.0 469.4 1039.0 4129.0 4144.0 4244.2 4248.8 4263.7 10521.4 10929.9 10980.1 11002.4 11023.8 10511.1 10617.8 10851.4 10868.4 10891.7 8022.7 8028.8 8037.9 8156.3 8178.5 5854.5 5884.2 5981.0 6034.9 6059.2 9633.5 9700.0 9879.1 9886.2 9926.8 9851.9 9880.4 9989.6 10164.7 10218.3 6621.1 7363.2 7575.8 7579.6 7596.0 7967.1 8008.6 8068.5 8081.5 8090.2 7314.3 7512.3 7522.9 7591.3 7649.2 7104.3 7245.1 7328.8 7335.8 7420.2 6857.8 6881.1 6923.8 6945.2 6947.9 4995.5 5027.2 5152.9 5223.3 5261.9 5187.1 5189.9 5196.2 5206.1 5280.6 02:19:18 INFO - PROCESS | 23526 | 02:19:18 INFO - PROCESS | 23526 | [#4] prototype.html Cycles:180 Average:4976.72 Median:5645.39 stddev:1488.41 (26.4%) stddev-sans-first:1450.62 02:19:18 INFO - PROCESS | 23526 | Values: 300.5 306.6 307.2 311.6 326.6 5318.1 5510.6 5592.5 5630.3 5714.6 5605.4 5613.0 5616.7 5626.6 5665.8 4361.1 4364.3 4375.3 4399.1 4399.1 4185.5 4194.5 4275.6 4368.8 4378.6 4275.3 4304.3 4310.4 4324.7 4343.0 4317.5 4323.2 4332.9 4339.1 4348.1 3700.6 3822.7 3827.0 3834.3 3835.0 5390.1 5442.1 5459.8 5459.9 5460.2 4967.5 4972.6 4975.7 4979.2 4984.5 5703.7 5864.7 5865.3 5879.4 5910.6 4168.2 4170.9 4184.3 4187.2 4189.4 5817.9 6074.5 6168.7 6177.0 6179.1 4154.9 4161.1 4170.3 4261.0 4299.5 4345.3 4351.0 4353.0 4362.5 4368.9 4896.8 4983.5 4985.2 4994.1 4996.6 5933.9 5946.9 5960.7 5968.9 5979.5 1476.8 1497.1 1497.3 1498.9 1498.9 996.5 1020.7 1029.6 1032.5 1038.6 5601.5 5660.5 5667.7 5674.4 5674.5 6062.0 6066.7 6075.3 6076.9 6081.4 5445.3 5621.2 5651.6 5712.8 5725.0 3244.5 3248.7 3265.7 3271.0 3275.5 6068.7 6302.1 6322.8 6326.7 6435.9 6296.7 6310.2 6314.1 6319.2 6323.4 6254.9 6312.7 6354.8 6381.3 6419.6 6139.5 6157.2 6160.8 6202.1 6202.4 6093.2 6099.5 6105.4 6126.8 6135.7 5998.3 6041.7 6333.2 6336.1 6369.2 4187.1 4221.2 4228.4 4242.6 4243.5 5942.7 6144.0 6178.6 6194.4 6207.1 5952.8 5955.3 5963.2 5963.5 5981.7 5932.6 5942.9 5960.2 5961.3 5994.5 5639.2 5876.4 5882.9 5888.5 5903.4 5962.2 5978.3 5993.8 6013.0 6031.1 5711.4 5844.1 5869.4 5891.2 5900.5 02:19:18 INFO - PROCESS | 23526 | 02:19:18 INFO - PROCESS | 23526 | [#5] yui.html Cycles:180 Average:15114.04 Median:25745.44 stddev:17658.20 (68.6%) stddev-sans-first:17674.69 02:19:18 INFO - PROCESS | 23526 | Values: 729.5 732.7 803.4 841.2 881.5 15043.8 15274.8 15410.8 15481.6 15526.1 14948.7 15163.4 15275.9 15285.0 15332.5 687.1 860.8 866.4 869.4 870.5 829.6 844.0 844.3 847.9 850.7 866.9 885.8 886.5 892.0 892.2 718.5 865.8 875.9 879.2 880.3 645.4 649.0 655.0 655.5 656.3 14912.8 14941.1 14949.4 14965.9 15003.2 12268.3 12820.7 13045.3 13170.7 13277.9 11731.1 11786.6 11938.1 12138.8 12174.3 3880.3 3895.5 3928.3 3988.3 4021.3 58047.7 58071.7 58112.4 58309.0 58875.7 10523.3 11240.7 11248.1 11289.2 11396.4 19484.4 19498.2 19506.9 19510.1 19549.7 8176.1 8194.8 8407.2 8447.7 8469.0 4639.0 4718.7 4741.1 4761.3 4814.7 3333.5 3420.1 3431.0 3432.8 3437.7 606.0 611.2 617.3 629.6 633.4 635.6 744.1 759.2 765.0 773.8 9140.3 9708.3 9813.1 9822.2 9887.7 611.6 744.8 751.6 759.3 785.4 4378.9 4621.6 4622.8 4640.4 4710.8 62533.7 63395.7 63786.7 64222.7 64552.4 55994.2 56069.0 56651.4 57128.1 58008.1 50135.2 51525.5 51529.0 52169.0 52661.0 8766.2 8827.2 8856.7 8885.2 8980.3 32395.0 33234.5 33321.2 33438.7 33722.8 40778.0 46850.5 47405.0 47587.5 47637.2 10685.9 10805.9 10940.5 11155.6 11460.3 12101.5 12292.6 12373.3 12450.5 12512.7 11751.8 12047.4 12226.8 12606.2 12896.9 12355.3 12697.1 12770.0 13090.2 13172.1 12423.1 12947.6 13005.0 13340.1 13423.2 10296.2 10677.6 10689.1 10975.4 11145.2 10322.3 10550.0 10665.9 10732.5 11187.0 02:19:18 INFO - PROCESS | 23526 | -------- Summary: end -------- 02:19:18 INFO - PROCESS | 23526 | 02:19:19 INFO - TEST-INFO | 23526: exit 0 02:19:19 INFO - TEST-OK | dromaeo_css | took 1111569ms 02:19:19 INFO - TEST-START | kraken 02:19:19 INFO - operating with platform_type : linux_ 02:19:19 INFO - Initialising browser for kraken test... 02:19:19 INFO - TEST-INFO | started process 23709 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo2HP4y/profile http://localhost:42080/getInfo.html) 02:19:22 INFO - PROCESS | 23709 | __metrics Screen width/height:1600/1200 02:19:22 INFO - PROCESS | 23709 | colorDepth:24 02:19:22 INFO - PROCESS | 23709 | Browser inner width/height: 1024/697 02:19:22 INFO - PROCESS | 23709 | __metrics 02:19:23 ERROR - PROCESS | 23709 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:19:24 INFO - TEST-INFO | 23709: exit 0 02:19:24 INFO - Browser initialized. 02:19:24 INFO - Running cycle 1/1 for kraken test... 02:19:24 INFO - TEST-INFO | started process 23793 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo2HP4y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:19:36 INFO - PROCESS | 23793 | RSS: Main: 154206208 02:19:36 INFO - PROCESS | 23793 | 02:19:38 INFO - PROCESS | 23793 | Cycle 1(1): loaded http://localhost:42080/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42080/tests/kraken/driver.html?testName=audio-beat-detection) 02:19:39 INFO - PROCESS | 23793 | RSS: Main: 208515072 02:19:39 INFO - PROCESS | 23793 | 02:19:42 INFO - PROCESS | 23793 | Cycle 1(1): loaded http://localhost:42080/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42080/tests/kraken/driver.html?testName=audio-dft) 02:19:42 INFO - PROCESS | 23793 | RSS: Main: 194691072 02:19:42 INFO - PROCESS | 23793 | 02:19:45 INFO - PROCESS | 23793 | Cycle 1(1): loaded http://localhost:42080/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42080/tests/kraken/driver.html?testName=audio-fft) 02:19:46 INFO - PROCESS | 23793 | RSS: Main: 265183232 02:19:46 INFO - PROCESS | 23793 | 02:19:48 INFO - PROCESS | 23793 | Cycle 1(1): loaded http://localhost:42080/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42080/tests/kraken/driver.html?testName=audio-oscillator) 02:19:49 INFO - PROCESS | 23793 | RSS: Main: 173481984 02:19:49 INFO - PROCESS | 23793 | 02:19:51 INFO - PROCESS | 23793 | Cycle 1(1): loaded http://localhost:42080/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42080/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:19:52 INFO - PROCESS | 23793 | RSS: Main: 177655808 02:19:52 INFO - PROCESS | 23793 | 02:19:54 INFO - PROCESS | 23793 | Cycle 1(1): loaded http://localhost:42080/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42080/tests/kraken/driver.html?testName=imaging-darkroom) 02:19:55 INFO - PROCESS | 23793 | RSS: Main: 214650880 02:19:55 INFO - PROCESS | 23793 | 02:19:58 INFO - PROCESS | 23793 | Cycle 1(1): loaded http://localhost:42080/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42080/tests/kraken/driver.html?testName=imaging-desaturate) 02:19:59 INFO - PROCESS | 23793 | RSS: Main: 215187456 02:19:59 INFO - PROCESS | 23793 | 02:20:02 INFO - PROCESS | 23793 | Cycle 1(1): loaded http://localhost:42080/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42080/tests/kraken/driver.html?testName=json-parse-financial) 02:20:02 INFO - PROCESS | 23793 | RSS: Main: 214310912 02:20:02 INFO - PROCESS | 23793 | 02:20:04 INFO - PROCESS | 23793 | Cycle 1(1): loaded http://localhost:42080/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42080/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:20:04 INFO - PROCESS | 23793 | RSS: Main: 201826304 02:20:04 INFO - PROCESS | 23793 | 02:20:06 INFO - PROCESS | 23793 | Cycle 1(1): loaded http://localhost:42080/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42080/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:20:07 INFO - PROCESS | 23793 | RSS: Main: 206778368 02:20:07 INFO - PROCESS | 23793 | 02:20:09 INFO - PROCESS | 23793 | Cycle 1(1): loaded http://localhost:42080/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42080/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:20:10 INFO - PROCESS | 23793 | RSS: Main: 216367104 02:20:10 INFO - PROCESS | 23793 | 02:20:12 INFO - PROCESS | 23793 | Cycle 1(1): loaded http://localhost:42080/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42080/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:20:13 INFO - PROCESS | 23793 | RSS: Main: 220942336 02:20:13 INFO - PROCESS | 23793 | 02:20:16 INFO - PROCESS | 23793 | Cycle 1(1): loaded http://localhost:42080/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42080/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:20:16 INFO - PROCESS | 23793 | RSS: Main: 221503488 02:20:16 INFO - PROCESS | 23793 | 02:20:18 INFO - PROCESS | 23793 | Cycle 1(1): loaded http://localhost:42080/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42080/tests/kraken/driver.html?testName=ai-astar) 02:20:18 INFO - PROCESS | 23793 | RSS: Main: 284594176 02:20:18 INFO - PROCESS | 23793 | 02:20:18 INFO - PROCESS | 23793 | __start_tp_report 02:20:18 INFO - PROCESS | 23793 | _x_x_mozilla_page_load 02:20:18 INFO - PROCESS | 23793 | _x_x_mozilla_page_load_details 02:20:18 INFO - PROCESS | 23793 | |i|pagename|runs| 02:20:18 INFO - PROCESS | 23793 | |0;ai-astar;112;112;108;112;113;114;102;111;111;111 02:20:18 INFO - PROCESS | 23793 | |1;audio-beat-detection;180;126;157;179;136;166;159;136;180;126 02:20:18 INFO - PROCESS | 23793 | |2;audio-dft;163;161;160;160;159;160;162;161;160;160 02:20:18 INFO - PROCESS | 23793 | |3;audio-fft;76;76;138;108;74;75;75;122;106;72 02:20:18 INFO - PROCESS | 23793 | |4;audio-oscillator;93;93;145;93;94;93;156;93;92;149 02:20:18 INFO - PROCESS | 23793 | |5;imaging-gaussian-blur;117;117;117;116;117;116;117;117;117;117 02:20:18 INFO - PROCESS | 23793 | |6;imaging-darkroom;145;146;146;145;145;145;145;145;145;145 02:20:18 INFO - PROCESS | 23793 | |7;imaging-desaturate;95;94;96;95;94;95;94;94;94;95 02:20:18 INFO - PROCESS | 23793 | |8;json-parse-financial;60;60;59;60;60;59;61;76;58;58 02:20:18 INFO - PROCESS | 23793 | |9;json-stringify-tinderbox;60;61;62;62;61;62;61;62;62;62 02:20:18 INFO - PROCESS | 23793 | |10;stanford-crypto-aes;76;85;76;82;77;78;80;77;78;87 02:20:18 INFO - PROCESS | 23793 | |11;stanford-crypto-ccm;126;127;135;122;125;124;125;126;210;125 02:20:18 INFO - PROCESS | 23793 | |12;stanford-crypto-pbkdf2;168;168;172;166;164;171;166;168;167;166 02:20:18 INFO - PROCESS | 23793 | |13;stanford-crypto-sha256-iterative;68;69;68;69;69;70;69;68;70;67 02:20:18 INFO - PROCESS | 23793 | __end_tp_report 02:20:18 INFO - PROCESS | 23793 | __start_cc_report 02:20:18 INFO - PROCESS | 23793 | _x_x_mozilla_cycle_collect,1623 02:20:18 INFO - PROCESS | 23793 | __end_cc_report 02:20:18 INFO - PROCESS | 23793 | __startTimestamp1461489618564__endTimestamp 02:20:18 INFO - PROCESS | 23793 | 02:20:18 INFO - PROCESS | 23793 | ------- Summary: start ------- 02:20:18 INFO - PROCESS | 23793 | Number of tests: 14 02:20:18 INFO - PROCESS | 23793 | 02:20:18 INFO - PROCESS | 23793 | [#0] ai-astar Cycles:10 Average:110.60 Median:112.00 stddev:3.41 (3.0%) stddev-sans-first:3.57 02:20:18 INFO - PROCESS | 23793 | Values: 112.0 112.0 108.0 112.0 113.0 114.0 102.0 111.0 111.0 111.0 02:20:18 INFO - PROCESS | 23793 | 02:20:18 INFO - PROCESS | 23793 | [#1] audio-beat-detection Cycles:10 Average:154.50 Median:162.50 stddev:22.03 (13.6%) stddev-sans-first:21.35 02:20:18 INFO - PROCESS | 23793 | Values: 180.0 126.0 157.0 179.0 136.0 166.0 159.0 136.0 180.0 126.0 02:20:18 INFO - PROCESS | 23793 | 02:20:18 INFO - PROCESS | 23793 | [#2] audio-dft Cycles:10 Average:160.60 Median:160.50 stddev:1.17 (0.7%) stddev-sans-first:0.87 02:20:18 INFO - PROCESS | 23793 | Values: 163.0 161.0 160.0 160.0 159.0 160.0 162.0 161.0 160.0 160.0 02:20:18 INFO - PROCESS | 23793 | 02:20:18 INFO - PROCESS | 23793 | [#3] audio-fft Cycles:10 Average:92.20 Median:74.50 stddev:24.22 (32.5%) stddev-sans-first:24.97 02:20:18 INFO - PROCESS | 23793 | Values: 76.0 76.0 138.0 108.0 74.0 75.0 75.0 122.0 106.0 72.0 02:20:18 INFO - PROCESS | 23793 | 02:20:18 INFO - PROCESS | 23793 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:93.00 stddev:27.66 (29.7%) stddev-sans-first:28.64 02:20:18 INFO - PROCESS | 23793 | Values: 93.0 93.0 145.0 93.0 94.0 93.0 156.0 93.0 92.0 149.0 02:20:18 INFO - PROCESS | 23793 | 02:20:18 INFO - PROCESS | 23793 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 02:20:18 INFO - PROCESS | 23793 | Values: 117.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 02:20:18 INFO - PROCESS | 23793 | 02:20:18 INFO - PROCESS | 23793 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 02:20:18 INFO - PROCESS | 23793 | Values: 145.0 146.0 146.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 02:20:18 INFO - PROCESS | 23793 | 02:20:18 INFO - PROCESS | 23793 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 02:20:18 INFO - PROCESS | 23793 | Values: 95.0 94.0 96.0 95.0 94.0 95.0 94.0 94.0 94.0 95.0 02:20:18 INFO - PROCESS | 23793 | 02:20:18 INFO - PROCESS | 23793 | [#8] json-parse-financial Cycles:10 Average:61.10 Median:60.00 stddev:5.32 (8.9%) stddev-sans-first:5.63 02:20:18 INFO - PROCESS | 23793 | Values: 60.0 60.0 59.0 60.0 60.0 59.0 61.0 76.0 58.0 58.0 02:20:18 INFO - PROCESS | 23793 | 02:20:18 INFO - PROCESS | 23793 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:62.00 stddev:0.71 (1.1%) stddev-sans-first:0.50 02:20:18 INFO - PROCESS | 23793 | Values: 60.0 61.0 62.0 62.0 61.0 62.0 61.0 62.0 62.0 62.0 02:20:18 INFO - PROCESS | 23793 | 02:20:18 INFO - PROCESS | 23793 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:79.00 stddev:3.86 (4.9%) stddev-sans-first:3.87 02:20:18 INFO - PROCESS | 23793 | Values: 76.0 85.0 76.0 82.0 77.0 78.0 80.0 77.0 78.0 87.0 02:20:18 INFO - PROCESS | 23793 | 02:20:18 INFO - PROCESS | 23793 | [#11] stanford-crypto-ccm Cycles:10 Average:134.50 Median:126.00 stddev:26.75 (21.2%) stddev-sans-first:28.19 02:20:18 INFO - PROCESS | 23793 | Values: 126.0 127.0 135.0 122.0 125.0 124.0 125.0 126.0 210.0 125.0 02:20:18 INFO - PROCESS | 23793 | 02:20:18 INFO - PROCESS | 23793 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.60 Median:168.00 stddev:2.41 (1.4%) stddev-sans-first:2.55 02:20:18 INFO - PROCESS | 23793 | Values: 168.0 168.0 172.0 166.0 164.0 171.0 166.0 168.0 167.0 166.0 02:20:18 INFO - PROCESS | 23793 | 02:20:18 INFO - PROCESS | 23793 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:0.95 (1.4%) stddev-sans-first:0.97 02:20:18 INFO - PROCESS | 23793 | Values: 68.0 69.0 68.0 69.0 69.0 70.0 69.0 68.0 70.0 67.0 02:20:18 INFO - PROCESS | 23793 | -------- Summary: end -------- 02:20:18 INFO - PROCESS | 23793 | 02:20:19 INFO - TEST-INFO | 23793: exit 0 02:20:19 INFO - TEST-OK | kraken | took 60105ms 02:20:19 INFO - SUITE-END | took 1171s 02:20:19 INFO - Completed test suite (00:19:31) 02:20:19 INFO - javascript benchmark 02:20:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3173.5081062435324, 3197.5363572282035, 3235.838208089595, 3237.401080800052, 3269.7057264846167, 5296.205569164617, 5441.5102640762325, 5451.291332126828, 5467.398586155519, 5482.251720992367, 5338.572914166867, 5394.595405344595, 5402.0, 5560.2493663355435, 5565.888682226353, 4826.034793041388, 4930.6302027348, 5037.622178336621, 5070.492950704936, 5085.974570127144, 4740.620750339965, 5024.673396229234, 5029.924551131736, 5059.16523773577, 5094.592432605401, 4937.827176048839, 4942.481039490855, 4974.228994505857, 4978.0, 4978.775955081994, 4927.852164435073, 4953.380827396575, 4953.6037117030555, 4964.578010869081, 5006.123928312531, 4790.185668436374, 4919.065377578285, 4929.975350123226, 4959.107360675077, 5050.949490505084, 5351.2240725095035, 5354.651947623431, 5357.276767636358, 5372.140457526816, 5383.892322153574, 5753.223314852483, 5796.333421656479, 5803.88392232153, 5805.825825225208, 5808.4191580842, 5663.207150998864, 5767.4520920512905, 5802.854928626818, 5879.7648094076185, 5915.822525324247, 5451.890962180773, 5457.672539647594, 5458.181272809111, 5459.153831156177, 5468.043092458804, 5944.940550594525, 5953.910691339634, 5972.0, 5976.910346344808, 5979.910301345483, 5611.2144299798065, 5729.398413166641, 5771.88456230873, 5815.244018277682, 5826.679532625746, 5587.944120558824, 5594.944050559524, 5610.382857885629, 5613.0, 5642.943570564242, 5569.860753481195, 5571.916421253684, 5576.414476479911, 5585.078462053797, 5620.0, 5715.8856822864145, 5726.828195154152, 5740.512056475163, 5761.567882408836, 5793.391693872167, 4248.617624413818, 4285.978570107191, 4292.248856450109, 4306.590873866978, 4325.091730736518, 3749.8312575934146, 3854.9229015420096, 3864.072622570563, 3883.7475564088245, 3908.5895980922164, 5438.211459338374, 5447.863803404946, 5464.699441530674, 5466.070767969375, 5520.889582208413, 5848.678322692208, 5860.736266868002, 5873.765049398062, 5874.148248503943, 5878.177055212273, 5236.24074509194, 5372.785088596491, 5378.838634840961, 5403.486668766461, 5447.4824891635235, 4930.235813448921, 4943.629227807929, 4963.205887058053, 4966.503349665005, 4973.726445045485, 5999.220101386792, 6000.879982400327, 6003.159557661931, 6012.158297838306, 6040.244969378828, 5554.888902222014, 5729.140628905531, 5806.82579522615, 5811.4479124483105, 5816.912746308724, 5997.790077347272, 6016.398360163948, 6020.066889632114, 6023.1266466363, 6024.277086749618, 5732.627379220337, 5741.052726300114, 5742.109972954198, 5744.5117165039765, 5750.539956803362, 5601.60788744784, 5816.127580862735, 5848.064309710426, 5893.2044174035955, 5904.645721256738, 5689.345725241485, 5708.4862362387585, 5711.600187986801, 5712.143178523254, 5716.342620598684, 5517.944820551743, 5620.971895140498, 5695.0603150481365, 5703.686297253691, 5705.0, 5556.888862222814, 5600.747966341606, 5607.243022192115, 5620.1569764534015, 5651.802186923438, 5684.744186511534, 5692.971535142297, 5694.430556944272, 5705.258316419005, 5711.057675483665, 5441.0, 5589.944100558942, 5597.748101335531, 5599.1041433370465, 5636.4927156556105], "value": 5334.191743511484, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.8402473344564, 640.9807705768826, 644.0468107201339, 649.9447546958506, 651.8337823854918, 28704.28239294016, 29371.853140734293, 38636.0340991475, 39613.405798912965, 39693.40459893104, 44237.336439953426, 44845.551544484544, 44875.55124448754, 44979.32531012029, 45086.0, 8760.824783504342, 8987.281017518582, 8987.325950553703, 8991.460512369245, 9001.459912405244, 8625.827483450326, 8763.912360876406, 8765.254953328942, 8766.34252431067, 8768.430052046628, 8871.733847984538, 8959.641614335418, 8975.102489751038, 8983.955080224623, 8991.595378207996, 8838.33712471564, 8891.599878005505, 8919.598618062171, 8921.955390223007, 8930.821383572325, 8774.780630484225, 8859.424137431046, 8882.866756998586, 8883.51140687262, 8885.2447541959, 41559.0, 42066.0, 42164.0, 42183.36724949128, 42199.156016879795, 3509.6841284284537, 3621.5292012038267, 3632.691221246197, 3842.769433833951, 4208.242516347056, 30623.451816038465, 30932.226694332596, 31400.37199256025, 31431.52852707211, 32522.0, 4072.2669919414493, 4090.427340172378, 4120.340745480738, 4265.808038638269, 4272.487301523806, 271333.0, 274786.0, 275753.6212318946, 275990.0, 278419.0, 57022.0, 58377.70811145917, 58426.123608145914, 58431.12353314704, 58431.403917491305, 62314.376856231764, 62352.376476235564, 62418.375816242165, 62569.37430625727, 62623.6868815653, 18052.909735451238, 18349.17428715711, 18358.449246522625, 18361.632767344578, 18362.357317493825, 13964.650883727785, 14074.929625351808, 14091.506797262251, 14091.859081409055, 14093.436262549383, 18349.484368134872, 20039.499012524804, 20113.798862011485, 20335.79664203339, 20448.284310049075, 5937.584369094208, 7145.142582889983, 7233.789648748603, 7569.772906812805, 7582.156691240784, 1008.3596915958419, 1008.3848852200152, 1054.4938429553856, 1062.054771253585, 1079.4602698650674, 31051.60267787955, 32434.0, 32447.0, 32684.0, 32782.672173278435, 1191.18999080626, 1205.7166565857017, 1229.6065259116997, 1234.5864135514523, 1281.9423125959354, 17093.914530427515, 17369.56576085583, 17382.3047078118, 17542.73685894687, 17595.648087038444, 455251.0, 465684.0, 468512.0, 468709.0, 469672.0, 56736.43263567394, 57542.0, 57658.7117064412, 57660.0, 57891.71054144702, 1271.3007845684836, 1376.0917794255943, 1410.6473381654587, 1417.206364435919, 1423.4092851466526, 30854.382912341178, 33114.834425827714, 33491.330173396884, 33666.49500257547, 34102.658973410944, 50850.23724644059, 51973.480265196864, 52356.21465678094, 52368.0, 52400.0, 414083.0, 426211.0, 426901.0, 429182.0, 430627.0, 37823.81088094652, 43605.78197108994, 44691.32963005623, 44748.55251447444, 45234.77382613066, 45361.0, 49308.50691493183, 49613.0, 50127.0, 50220.49779502158, 41757.37363939483, 42364.152716946104, 43185.13629727325, 43436.78281608572, 43567.0, 41147.38278925879, 41913.79043104765, 42088.57911420969, 42132.368014480424, 42899.57100428956, 42124.368134478624, 42285.94285142773, 43084.78457607692, 43349.0, 43428.0, 36069.63930360663, 37411.25177496489, 37613.2477350446, 37742.24515509729, 38303.42544861885, 27291.317717056438, 27903.746414973604, 28155.71844281613, 28155.88252909824, 28397.432051359272], "value": 20393.745486173208, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.6216541548665, 369.9352613292674, 386.62497377543775, 394.92693851637443, 399.9880003599893, 17926.282948682052, 18851.905740471277, 19240.518987025313, 19312.613747725038, 19327.323543675975, 17538.736918946226, 18402.907985460086, 18922.526936826587, 19230.711539326887, 19240.51898702533, 4915.975420122894, 5017.247412888059, 5060.443351231362, 5064.772085256154, 5099.821506247282, 5673.971630141844, 5695.0, 5719.084946408576, 5723.799667011655, 5727.484526392624, 5244.8688782780355, 5589.441055894418, 5659.462351076641, 5667.036603777347, 5677.347105082927, 5418.674879507243, 5427.83716488506, 5428.75570599324, 5441.891162176735, 5460.372057213432, 5177.145770947789, 5523.28197334348, 5548.611597188198, 5548.889022219533, 5570.777168913239, 11885.702857428634, 12022.759544809142, 12124.27254364741, 18113.0, 22641.886790566106, 2337.567550003255, 2357.6934998450092, 2610.8955641774305, 2755.925189176223, 2786.878695860629, 9073.31950103745, 9392.48341341226, 9435.198008169315, 10606.257561970666, 14364.712705745827, 1858.721191821224, 1939.4472575316108, 1976.7726711428227, 2016.5563576013253, 2054.5069183396026, 76990.6150469244, 80867.99999999942, 81255.18744812535, 81619.18380816234, 82600.58699706523, 10618.73453163677, 10749.677509674722, 10778.946105269424, 11008.834867476995, 11074.224804263624, 15107.169105699291, 15170.772438413433, 15216.163111029, 15242.618934526503, 15271.847281527265, 7903.604819758989, 8165.918340816515, 8181.918180818235, 8353.164683531599, 8375.246227839523, 7948.682052717826, 8012.479188852706, 8051.114377418479, 8120.715774947848, 8156.1028286888395, 4578.9771051144535, 4648.163975229833, 4690.64820138491, 4771.33201351811, 4804.663673542818, 1764.1179410294853, 1859.4421673498166, 1866.2721538599958, 1874.0255067364894, 1888.5373083594332, 1018.5467466977273, 1035.440861934547, 1059.7668512927144, 1120.7366268926796, 1163.8661553921409, 16936.491905242863, 18186.63626727458, 18441.446756597325, 19186.13662385196, 19318.32385866488, 1034.4982683398546, 1065.5471424644495, 1070.5664205996584, 1100.6808025672465, 1115.983260251097, 10318.329308594917, 10731.570737170581, 10757.515911783988, 10785.298955567863, 10905.127589792797, 482337.0, 488840.0, 488952.0, 489217.0, 511511.0, 60454.69772651108, 75840.0, 79700.0, 90371.0, 92240.0, 1039.5529922133403, 1064.6752740414092, 1083.4961742789483, 1085.592902661502, 1088.6407485529755, 16148.838511615204, 16150.838491614933, 16166.272517736496, 16368.75446868274, 16373.099479528264, 37225.627743722216, 37665.0, 37834.0, 38608.0, 38855.41716874193, 51599.0, 53644.46355536551, 53875.46124538704, 53937.19094213669, 54249.45750542602, 8036.0, 8324.500529968222, 8379.916200837913, 8523.74428767138, 8551.444156129832, 9481.762955926157, 12780.808287875503, 12872.742545149233, 13114.475420983053, 13307.733845323233, 11396.544138234378, 11707.765844682888, 11845.289282643069, 12068.939655301667, 12153.635390938285, 11373.374464404536, 11424.086073114297, 11598.47806848677, 11663.825042624538, 11777.293362398283, 11629.476673549541, 11655.358955257543, 11750.647480575597, 11944.402779861146, 12097.334646594521, 8230.711925082593, 8369.874451883104, 8376.748697539084, 8407.3694472916, 8451.83096338082, 8557.61490732906, 11495.712607184887, 11692.70768230801, 11901.0, 11903.345316007702], "value": 8970.156431058305, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.2489006156559, 1523.0861483110136, 1551.767234914763, 1713.982860171398, 1862.4878158506417, 7497.850042999136, 8295.377846661502, 8467.110953349902, 8489.151084891508, 8494.447860889039, 8127.5529845858455, 8274.54490003051, 8286.088530261666, 8293.0, 8307.127751586087, 2333.3699901026757, 2356.77610626991, 2357.976420235793, 2363.4682196505732, 2363.846349987254, 2285.6000199965024, 2302.4474126209675, 2319.860808351504, 2326.0579465316573, 2342.4143964009, 2260.9660855087186, 2286.1884031168943, 2303.1593468384085, 2312.606856834342, 2313.144136669426, 2197.494576247472, 2230.69885565449, 2239.9664005039936, 2240.686303917461, 2240.977590224093, 2256.5599708056934, 2262.2082271205113, 2272.227442669484, 2273.102124660766, 2274.3518097342344, 8326.25063744266, 8417.957910210409, 8421.70524031656, 8447.0, 8467.70363037297, 5111.514406131411, 5258.55302299305, 5278.709670968095, 5288.550473209782, 5305.177697456862, 3306.669333066674, 3345.983270083658, 3347.7656564040526, 3350.157413422608, 3375.0, 991.5934466868549, 1001.6494227020557, 1004.6182450668699, 1008.1027885182194, 1018.383877753963, 11352.829707554394, 11889.881101188965, 11926.045916326673, 11928.940355298255, 11934.701632459171, 4266.765327906933, 4417.094495628388, 4419.337099435111, 4518.277075667877, 4563.110193512233, 9403.34176607631, 9405.670801521914, 9411.529423528797, 9411.623535058658, 9422.481763502936, 5063.189889617717, 5066.442691303953, 5068.847934561969, 5098.694078355311, 5104.081265372269, 4159.147374788222, 4260.765657888784, 4353.869383918487, 4778.617710583145, 4804.159272127364, 3651.379265524867, 3735.4396840474146, 3756.4553139794575, 3763.6800871925643, 3777.301199278142, 1084.8264277715527, 1130.8247221680654, 1142.817149256115, 1145.8281257811395, 1151.9424028798526, 998.6953979036318, 1006.8791744990501, 1011.5245834457793, 1015.6496008876926, 1044.9320794148357, 5983.282006159202, 6129.080637904261, 6129.816105516842, 6130.264368275835, 6224.968875155595, 453.32228318663806, 463.4253525628197, 464.9814007439732, 469.4460536566884, 1038.9792204155874, 4128.958710412918, 4144.046869220036, 4244.236037513216, 4248.787560622019, 4263.658907287409, 10521.421321827373, 10929.890701093047, 10980.066694330912, 11002.449877506093, 11023.83464248037, 10511.106555942677, 10617.787644247072, 10851.40317282557, 10868.402237876993, 10891.727706807393, 8022.679092836222, 8028.759137225892, 8037.919620803717, 8156.265936065783, 8178.509289442533, 5854.4730974212525, 5884.176215329943, 5981.0, 6034.879302414015, 6059.151718759289, 9633.470159141314, 9700.0, 9879.06148915852, 9886.209103271865, 9926.801463970825, 9851.901480985385, 9880.35777674449, 9989.60041598328, 10164.745881353025, 10218.284720069523, 6621.106150669598, 7363.190049094703, 7575.848483030419, 7579.583122928292, 7595.962020189863, 7967.083785364525, 8008.599570021592, 8068.47554908929, 8081.515109093473, 8090.150534193825, 7314.268573142643, 7512.32389084985, 7522.887156692764, 7591.316781489692, 7649.235076492307, 7104.325089116525, 7245.058142441449, 7328.78013659591, 7335.816604584928, 7420.183779784327, 6857.828554285983, 6881.071055407456, 6923.826904327432, 6945.201301850352, 6947.861042779217, 4995.525425084611, 5027.245913113063, 5152.948470515247, 5223.347081614798, 5261.947380526299, 5187.144121219956, 5189.870253243699, 5196.168613021899, 5206.114960456807, 5280.630355875205], "value": 4463.072129820415, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.53567238616347, 306.60294918081087, 307.2334525359228, 311.59337065129995, 326.6390638344629, 5318.149096144618, 5510.559155267579, 5592.504684572143, 5630.339049980255, 5714.628549144302, 5605.411431799664, 5613.017721898672, 5616.747246373913, 5626.578006649497, 5665.830025099243, 4361.105973275471, 4364.323529852878, 4375.321825117112, 4399.12017596482, 4399.142167277382, 4185.476815398075, 4194.496660400741, 4275.572442755715, 4368.847090351838, 4378.584034516732, 4275.294576394891, 4304.31131019037, 4310.396544483775, 4324.724206359116, 4343.0, 4317.4603174603335, 4323.200207961537, 4332.91334173318, 4339.06710057336, 4348.086901750605, 3700.6299370063048, 3822.694184465236, 3827.0, 3834.2906562286066, 3834.961650383488, 5390.137577987503, 5442.12925931849, 5459.826137380483, 5459.863503412406, 5460.208269800896, 4967.50324967504, 4972.6270529710055, 4975.651704380694, 4979.228219625964, 4984.501549845023, 5703.65778053314, 5864.70676466175, 5865.296164460249, 5879.353271140171, 5910.645361278337, 4168.228877657612, 4170.915561953883, 4184.284443378231, 4187.20443115807, 4189.434426352434, 5817.941820581825, 6074.453299203093, 6168.722407491674, 6177.0, 6179.134921111048, 4154.91690166195, 4161.0845613964875, 4170.270202714512, 4260.957390426056, 4299.527052024275, 4345.261305578059, 4350.978245108818, 4352.978235108804, 4362.476502819682, 4368.890777730582, 4896.804127834918, 4983.526564976321, 4985.177445721488, 4994.101061808837, 4996.625253105959, 5933.940660593339, 5946.910796338058, 5960.7019649017375, 5968.85077873048, 5979.4917432018765, 1476.8006319146994, 1497.0643347907558, 1497.2663394936621, 1498.9175595342142, 1498.932548035341, 996.5166894056376, 1020.6529779874878, 1029.5933106423072, 1032.4785983078498, 1038.5638032026568, 5601.467860553241, 5660.5471562274915, 5667.744951477193, 5674.404187560329, 5674.546036317167, 6062.0, 6066.666333351708, 6075.33171351151, 6076.8784624308155, 6081.3614570470345, 5445.319335083114, 5621.213030175779, 5651.604387692904, 5712.828615141552, 5725.026745453283, 3244.5133230015213, 3248.740100791931, 3265.7387409007224, 3271.0, 3275.5086736989642, 6068.726907289182, 6302.1177035215105, 6322.841928951813, 6326.652034138075, 6435.905895997598, 6296.653684047421, 6310.242770867433, 6314.0844577536, 6319.210098737658, 6323.43089121972, 6254.906176407267, 6312.747490100436, 6354.809355719336, 6381.266154392211, 6419.565532440122, 6139.539534534839, 6157.230346206724, 6160.784372546939, 6202.069689546604, 6202.41077097675, 6093.2078829751845, 6099.512039036777, 6105.419985101408, 6126.846828829137, 6135.6932153393045, 5998.25021872266, 6041.697915104315, 6333.1766870306565, 6336.144620476177, 6369.235691716838, 4187.078842654611, 4221.2190744712325, 4228.386883901879, 4242.554531774119, 4243.533211346811, 5942.702864856827, 6144.0, 6178.567500274938, 6194.4115309045565, 6207.131001659862, 5952.76188952437, 5955.344912059583, 5963.194968679346, 5963.493103086113, 5981.700914954322, 5932.584719069624, 5942.910856337072, 5960.195373624679, 5961.317407166879, 5994.460498555151, 5639.167270636977, 5876.382979787061, 5882.940970660235, 5888.528917686489, 5903.409659034234, 5962.19510366095, 5978.282606087123, 5993.790217342372, 6012.969935150471, 6031.125486804476, 5711.400302968129, 5844.094165404369, 5869.383714709894, 5891.23413956183, 5900.495373679856], "value": 4490.594352697787, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [729.51122747759, 732.7069172331067, 803.4135081390581, 841.1630427724415, 881.53278762256, 15043.849561504381, 15274.847251527495, 15410.768838467431, 15481.612959676013, 15526.146061966587, 14948.701025979473, 15163.393464261444, 15275.923620381911, 15285.0, 15332.540023799276, 687.1410736579276, 860.8364410761935, 866.4498043742205, 869.4131461263653, 870.4603146049458, 829.601791140253, 844.025150950653, 844.3203221406765, 847.9406441549094, 850.6639877248483, 866.9176428239339, 885.844977129003, 886.5168483176652, 892.0366004714892, 892.1970226795871, 718.5293632670557, 865.7965378136133, 875.8554838451648, 879.2174964281762, 880.3221519430067, 645.3965542218041, 648.9513286503484, 654.9738010479575, 655.5247445601948, 656.3239862941178, 14912.776308355384, 14941.103533788008, 14949.40202391903, 14965.850341496554, 15003.249837508081, 12268.32524211168, 12820.679483012906, 13045.34773261333, 13170.67073323165, 13277.86722132776, 11731.120165987584, 11786.58746943853, 11938.104642151873, 12138.757224855453, 12174.330411827346, 3880.3209438348176, 3895.5130608673917, 3928.3125453045886, 3988.3020471417385, 4021.2962731521866, 58047.709761450926, 58071.70964145195, 58112.41887581113, 58309.0, 58875.70562147204, 10523.26337156407, 11240.718982025515, 11248.100151987821, 11289.153313501356, 11396.373199474108, 19484.415467535997, 19498.220071197276, 19506.902465487583, 19510.122044508033, 19549.706754398412, 8176.1006289308125, 8194.836103277901, 8407.159284071544, 8447.746567602982, 8469.02606200295, 4638.976805115953, 4718.669693121517, 4741.122892264873, 4761.285807128958, 4814.711117332971, 3333.483310086892, 3420.0936751760805, 3430.953559164479, 3432.811195384228, 3437.7077948374667, 606.0333767640606, 611.2084850119106, 617.3147805935408, 629.568745409396, 633.3697970519363, 635.5614625908108, 744.115715962674, 759.1800855076505, 764.9808754781175, 773.81428457171, 9140.260695785282, 9708.320417570701, 9813.11681948628, 9822.217562568288, 9887.703368898945, 611.5566214494456, 744.7691215723144, 751.6241879060469, 759.2635143910398, 785.3873978296938, 4378.918592327728, 4621.560951709582, 4622.838200662961, 4640.350350950869, 4710.788014539354, 62533.68733156305, 63395.6830215846, 63786.68106659437, 64222.67888660527, 64552.35447645558, 55994.16008759872, 56069.0, 56651.43348566462, 57128.14307785386, 58008.12987805186, 50135.24797128046, 51525.48474515282, 51529.0, 52169.0, 52661.0, 8766.21104100634, 8827.16141966512, 8856.734297971072, 8885.200331970154, 8980.326475514494, 32395.0, 33234.501482477295, 33321.16697082592, 33438.66561334453, 33722.83138584292, 40778.0, 46850.53149468598, 47405.0, 47587.52412475831, 47637.20916337654, 10685.946570267099, 10805.945970270099, 10940.452977350942, 11155.553777848796, 11460.255083419552, 12101.455434505293, 12292.569760058355, 12373.257604543756, 12450.501979921064, 12512.687182820502, 11751.823722643996, 12047.397630118634, 12226.816597750863, 12606.243625382507, 12896.871031289942, 12355.32045737493, 12697.111202215756, 12770.0, 13090.214587124803, 13172.077954543473, 12423.130380873252, 12947.611571652866, 13005.0, 13340.132891362031, 13423.194608323533, 10296.21716601934, 10677.626283080055, 10689.144868410664, 10975.396353200651, 11145.164112691418, 10322.277440579088, 10550.0, 10665.9466702666, 10732.51703673321, 11187.0], "value": 6847.023297706203, "unit": "score"}], "name": "dromaeo_css", "value": 7152.78063250728, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 108.0, 112.0, 113.0, 114.0, 102.0, 111.0, 111.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 126.0, 157.0, 179.0, 136.0, 166.0, 159.0, 136.0, 180.0, 126.0], "value": 154.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 160.0, 160.0, 159.0, 160.0, 162.0, 161.0, 160.0, 160.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 138.0, 108.0, 74.0, 75.0, 75.0, 122.0, 106.0, 72.0], "value": 92.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 145.0, 93.0, 94.0, 93.0, 156.0, 93.0, 92.0, 149.0], "value": 110.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 96.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 60.0, 60.0, 59.0, 61.0, 76.0, 58.0, 58.0], "value": 61.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 62.0, 62.0, 61.0, 62.0, 61.0, 62.0, 62.0, 62.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 85.0, 76.0, 82.0, 77.0, 78.0, 80.0, 77.0, 78.0, 87.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 127.0, 135.0, 122.0, 125.0, 124.0, 125.0, 126.0, 210.0, 125.0], "value": 134.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 172.0, 166.0, 164.0, 171.0, 166.0, 168.0, 167.0, 166.0], "value": 167.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 68.0, 69.0, 69.0, 70.0, 69.0, 68.0, 70.0, 67.0], "value": 68.7, "unit": "score"}], "name": "kraken", "value": 1557.6, "alertThreshold": 2.0}]} 02:20:19 INFO - Return code: 0 02:20:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:20:19 ERROR - # TBPL SUCCESS # 02:20:19 INFO - Running post-action listener: _resource_record_post_action 02:20:19 INFO - Running post-run listener: _resource_record_post_run 02:20:20 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 539312128; Read time: 0; Write time: 547144 02:20:20 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244809728; Read time: 0; Write time: 346292 02:20:20 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 294502400; Read time: 0; Write time: 200852 02:20:20 INFO - Running post-run listener: _upload_blobber_files 02:20:20 INFO - Blob upload gear active. 02:20:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:20:20 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:20:20 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:20:20 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:20:21 INFO - (blobuploader) - INFO - Open directory for files ... 02:20:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:20:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:20:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:20:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:20:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:20:22 INFO - (blobuploader) - INFO - Done attempting. 02:20:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:20:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:20:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:20:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:20:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:20:22 INFO - (blobuploader) - INFO - Done attempting. 02:20:22 INFO - (blobuploader) - INFO - Iteration through files over. 02:20:22 INFO - Return code: 0 02:20:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:20:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:20:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/52b53e2fdcaf7d0dd654612a5c10ef77a31abf91cec3f63c92d9a3c65b4c33bcfbe733f43bf8bef878e23969ef239f326d955c4d07d1cb5ededce244322fc180", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b400c32e5c705ad15f51a7f844b01bcfbc4ca7b5edf012b227e7fe021ba2de02c46bbb117961f66a4b963b057e71930e3fc8204eb1358faeddb827b3560d6c72"} 02:20:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:20:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:20:22 INFO - Contents: 02:20:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/52b53e2fdcaf7d0dd654612a5c10ef77a31abf91cec3f63c92d9a3c65b4c33bcfbe733f43bf8bef878e23969ef239f326d955c4d07d1cb5ededce244322fc180", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b400c32e5c705ad15f51a7f844b01bcfbc4ca7b5edf012b227e7fe021ba2de02c46bbb117961f66a4b963b057e71930e3fc8204eb1358faeddb827b3560d6c72"} 02:20:22 INFO - Running post-run listener: copy_logs_to_upload_dir 02:20:22 INFO - Copying logs to upload dir... 02:20:22 INFO - mkdir: /builds/slave/test/build/upload/logs 02:20:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.012112 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-04-24 02:20:22.574591) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-24 02:20:22.578319) ========= 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=0274524eba3bdaad075c2247000001d4-1461488375.644406-1856488294 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/52b53e2fdcaf7d0dd654612a5c10ef77a31abf91cec3f63c92d9a3c65b4c33bcfbe733f43bf8bef878e23969ef239f326d955c4d07d1cb5ededce244322fc180", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b400c32e5c705ad15f51a7f844b01bcfbc4ca7b5edf012b227e7fe021ba2de02c46bbb117961f66a4b963b057e71930e3fc8204eb1358faeddb827b3560d6c72"} build_url:https://queue.taskcluster.net/v1/task/TqvH3Gv4ScCvbErBXpWI-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011293 build_url: 'https://queue.taskcluster.net/v1/task/TqvH3Gv4ScCvbErBXpWI-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/52b53e2fdcaf7d0dd654612a5c10ef77a31abf91cec3f63c92d9a3c65b4c33bcfbe733f43bf8bef878e23969ef239f326d955c4d07d1cb5ededce244322fc180", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b400c32e5c705ad15f51a7f844b01bcfbc4ca7b5edf012b227e7fe021ba2de02c46bbb117961f66a4b963b057e71930e3fc8204eb1358faeddb827b3560d6c72"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-24 02:20:22.602175) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 02:20:22.602448) ========= 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=0274524eba3bdaad075c2247000001d4-1461488375.644406-1856488294 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004357 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 02:20:22.688929) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-24 02:20:22.689240) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-24 02:20:22.689508) ========= ========= Total master_lag: 0.17 =========