builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-013 starttime: 1461022552.22 results: success (0) buildid: 20160418151628 builduid: 8c315b4aa65a4fcdaad46c949d0ca905 revision: e8ef4670ee16f419b1037b715f0d28978825439e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 16:35:52.221046) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 16:35:52.221542) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 16:35:52.221865) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 16:35:52.238303) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 16:35:52.238607) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1461022551.688912-1266825473 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-18 16:35:52-- 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% 217M=0s 2016-04-18 16:35:52 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.133067 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 16:35:52.385283) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 16:35:52.385634) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1461022551.688912-1266825473 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014345 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 16:35:52.435315) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 16:35:52.435703) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e8ef4670ee16f419b1037b715f0d28978825439e --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 e8ef4670ee16f419b1037b715f0d28978825439e --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=9c3a94c35cc88655b05d2c08000001b2-1461022551.688912-1266825473 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-18 16:35:52,638 truncating revision to first 12 chars 2016-04-18 16:35:52,638 Setting DEBUG logging. 2016-04-18 16:35:52,638 attempt 1/10 2016-04-18 16:35:52,639 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e8ef4670ee16?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-18 16:35:52,895 unpacking tar archive at: fx-team-e8ef4670ee16/testing/mozharness/ program finished with exit code 0 elapsedTime=0.537526 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 16:35:52.990631) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 16:35:52.991448) ========= script_repo_revision: e8ef4670ee16f419b1037b715f0d28978825439e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 16:35:52.992412) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 16:35:52.993217) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 16:35:53.004857) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-04-18 16:35:53.005184) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1461022551.688912-1266825473 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:35:53 INFO - MultiFileLogger online at 20160418 16:35:53 in /builds/slave/test 16:35:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 16:35:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:35:53 INFO - {'append_to_log': False, 16:35:53 INFO - 'base_work_dir': '/builds/slave/test', 16:35:53 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:35:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:35:53 INFO - 'branch': 'Fx-Team-Non-PGO', 16:35:53 INFO - 'buildbot_json_path': 'buildprops.json', 16:35:53 INFO - 'config_files': ('talos/linux_config.py',), 16:35:53 INFO - 'default_actions': ('clobber', 16:35:53 INFO - 'read-buildbot-config', 16:35:53 INFO - 'download-and-extract', 16:35:53 INFO - 'populate-webroot', 16:35:53 INFO - 'create-virtualenv', 16:35:53 INFO - 'install', 16:35:53 INFO - 'run-tests'), 16:35:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:35:53 INFO - 'download_minidump_stackwalk': True, 16:35:53 INFO - 'download_symbols': 'ondemand', 16:35:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:35:53 INFO - 'tooltool.py': '/tools/tooltool.py', 16:35:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:35:53 INFO - '/tools/misc-python/virtualenv.py')}, 16:35:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:35:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:35:53 INFO - 'installer_path': 'installer.exe', 16:35:53 INFO - 'log_level': 'info', 16:35:53 INFO - 'log_name': 'talos', 16:35:53 INFO - 'log_to_console': True, 16:35:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:35:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:35:53 INFO - 'opt_config_files': (), 16:35:53 INFO - 'pip_index': False, 16:35:53 INFO - 'sps_profile': False, 16:35:53 INFO - 'sps_profile_interval': 0, 16:35:53 INFO - 'suite': 'dromaeojs', 16:35:53 INFO - 'system_bits': '32', 16:35:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:35:53 INFO - 'title': 'talos-linux64-ix-013', 16:35:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:35:53 INFO - 'use_talos_json': True, 16:35:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:35:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:35:53 INFO - 'work_dir': 'build'} 16:35:53 INFO - ##### 16:35:53 INFO - ##### Running clobber step. 16:35:53 INFO - ##### 16:35:53 INFO - Running pre-action listener: _resource_record_pre_action 16:35:53 INFO - Running main action method: clobber 16:35:53 INFO - rmtree: /builds/slave/test/build 16:35:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:35:53 INFO - Running post-action listener: _resource_record_post_action 16:35:53 INFO - ##### 16:35:53 INFO - ##### Running read-buildbot-config step. 16:35:53 INFO - ##### 16:35:53 INFO - Running pre-action listener: _resource_record_pre_action 16:35:53 INFO - Running main action method: read_buildbot_config 16:35:53 INFO - Using buildbot properties: 16:35:53 INFO - { 16:35:53 INFO - "project": "", 16:35:53 INFO - "product": "firefox", 16:35:53 INFO - "script_repo_revision": "production", 16:35:53 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:35:53 INFO - "repository": "", 16:35:53 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 16:35:53 INFO - "buildid": "20160418151628", 16:35:53 INFO - "pgo_build": "False", 16:35:53 INFO - "basedir": "/builds/slave/test", 16:35:53 INFO - "buildnumber": 1658, 16:35:53 INFO - "slavename": "talos-linux64-ix-013", 16:35:53 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:35:53 INFO - "platform": "ubuntu64_hw", 16:35:53 INFO - "scheduler": "tests-fx-team-linux64-talos", 16:35:53 INFO - "branch": "fx-team", 16:35:53 INFO - "repo_path": "integration/fx-team", 16:35:53 INFO - "revision": "e8ef4670ee16f419b1037b715f0d28978825439e", 16:35:53 INFO - "stage_platform": "linux64", 16:35:53 INFO - "builduid": "8c315b4aa65a4fcdaad46c949d0ca905", 16:35:53 INFO - "slavebuilddir": "test" 16:35:53 INFO - } 16:35:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 16:35:53 INFO - Running post-action listener: _resource_record_post_action 16:35:53 INFO - ##### 16:35:53 INFO - ##### Running download-and-extract step. 16:35:53 INFO - ##### 16:35:53 INFO - Running pre-action listener: _resource_record_pre_action 16:35:53 INFO - Running main action method: download_and_extract 16:35:53 INFO - mkdir: /builds/slave/test/build/tests 16:35:53 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')]} 16:35:53 INFO - https://queue.taskcluster.net/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:35:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:35:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:35:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7XbNAbVRGqqSCAngJlrZA/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 16:35:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7XbNAbVRGqqSCAngJlrZA/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 16:35:54 INFO - Downloaded 1361 bytes. 16:35:54 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:35:54 INFO - Using the following test package requirements: 16:35:54 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 16:35:54 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:35:54 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:35:54 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:35:54 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:35:54 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:35:54 INFO - u'jsshell-linux-x86_64.zip'], 16:35:54 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:35:54 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:35:54 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 16:35:54 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:35:54 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:35:54 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:35:54 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:35:54 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:35:54 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:35:54 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:35:54 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:35:54 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:35:54 INFO - https://queue.taskcluster.net/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:35:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:35:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:35:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7XbNAbVRGqqSCAngJlrZA/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 16:35:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7XbNAbVRGqqSCAngJlrZA/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 16:35:55 INFO - Downloaded 22209599 bytes. 16:35:55 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'] 16:35:55 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 16:35:56 INFO - Return code: 0 16:35:56 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 16:35:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:35:56 INFO - https://queue.taskcluster.net/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:35:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:35:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:35:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7XbNAbVRGqqSCAngJlrZA/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 16:35:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7XbNAbVRGqqSCAngJlrZA/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 16:35:58 INFO - Downloaded 22209599 bytes. 16:35:58 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'] 16:35:58 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 16:35:59 INFO - Return code: 0 16:35:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:35:59 INFO - https://queue.taskcluster.net/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:35:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 16:35:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 16:35:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7XbNAbVRGqqSCAngJlrZA/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 16:35:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7XbNAbVRGqqSCAngJlrZA/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 16:36:00 INFO - Downloaded 10845952 bytes. 16:36:00 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'] 16:36:00 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 16:36:00 INFO - Return code: 0 16:36:00 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')]} 16:36:00 INFO - https://queue.taskcluster.net/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:36:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:36:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:36:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7XbNAbVRGqqSCAngJlrZA/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 16:36:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7XbNAbVRGqqSCAngJlrZA/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 16:36:02 INFO - Downloaded 54453839 bytes. 16:36:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:36:02 INFO - mkdir: /builds/slave/test/properties 16:36:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:36:02 INFO - Writing to file /builds/slave/test/properties/build_url 16:36:02 INFO - Contents: 16:36:02 INFO - build_url:https://queue.taskcluster.net/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:36:02 INFO - Running post-action listener: _resource_record_post_action 16:36:02 INFO - Running post-action listener: set_extra_try_arguments 16:36:02 INFO - ##### 16:36:02 INFO - ##### Running populate-webroot step. 16:36:02 INFO - ##### 16:36:02 INFO - Running pre-action listener: _resource_record_pre_action 16:36:02 INFO - Running main action method: populate_webroot 16:36:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:36:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:36:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:36:02 INFO - '--tppagecycles', 16:36:02 INFO - '7'], 16:36:02 INFO - 'tests': ['tsvgm']}}, 16:36:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:36:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:36:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:36:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:36:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:36:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:36:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:02 INFO - 'talos_options': ['--disable-e10s'], 16:36:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:36:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:36:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:02 INFO - 'talos_options': ['--disable-e10s'], 16:36:02 INFO - 'tests': ['damp', 'tps']}, 16:36:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:02 INFO - 'tests': ['damp', 'tps']}, 16:36:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:36:02 INFO - 'tests': ['dromaeo_dom']}, 16:36:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:36:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:36:02 INFO - 'tests': ['a11yr', 16:36:02 INFO - 'ts_paint', 16:36:02 INFO - 'tpaint', 16:36:02 INFO - 'sessionrestore', 16:36:02 INFO - 'sessionrestore_no_auto_restore', 16:36:02 INFO - 'tabpaint']}, 16:36:02 INFO - 'other-e10s': {'tests': ['a11yr', 16:36:02 INFO - 'ts_paint', 16:36:02 INFO - 'tpaint', 16:36:02 INFO - 'sessionrestore', 16:36:02 INFO - 'sessionrestore_no_auto_restore', 16:36:02 INFO - 'tabpaint']}, 16:36:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:36:02 INFO - 'ts_paint', 16:36:02 INFO - 'tpaint', 16:36:02 INFO - 'sessionrestore', 16:36:02 INFO - 'sessionrestore_no_auto_restore', 16:36:02 INFO - 'tabpaint']}, 16:36:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:36:02 INFO - 'ts_paint', 16:36:02 INFO - 'tpaint', 16:36:02 INFO - 'sessionrestore', 16:36:02 INFO - 'sessionrestore_no_auto_restore', 16:36:02 INFO - 'tabpaint']}, 16:36:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:36:02 INFO - 'tests': ['a11yr', 16:36:02 INFO - 'ts_paint', 16:36:02 INFO - 'tpaint', 16:36:02 INFO - 'sessionrestore', 16:36:02 INFO - 'sessionrestore_no_auto_restore', 16:36:02 INFO - 'tabpaint']}, 16:36:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:36:02 INFO - 'tests': ['a11yr', 16:36:02 INFO - 'ts_paint', 16:36:02 INFO - 'tpaint', 16:36:02 INFO - 'sessionrestore', 16:36:02 INFO - 'sessionrestore_no_auto_restore', 16:36:02 INFO - 'tabpaint']}, 16:36:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:36:02 INFO - 'tests': ['tsvgx', 16:36:02 INFO - 'tsvgr_opacity', 16:36:02 INFO - 'tart', 16:36:02 INFO - 'tscrollx', 16:36:02 INFO - 'cart']}, 16:36:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:36:02 INFO - 'tsvgr_opacity', 16:36:02 INFO - 'tart', 16:36:02 INFO - 'tscrollx', 16:36:02 INFO - 'cart']}, 16:36:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:02 INFO - 'talos_options': ['--disable-e10s'], 16:36:02 INFO - 'tests': ['tp5o']}, 16:36:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:02 INFO - 'tests': ['tp5o']}, 16:36:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:02 INFO - 'talos_options': ['--disable-e10s', 16:36:02 INFO - '--xperf_path', 16:36:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:36:02 INFO - 'tests': ['tp5n']}, 16:36:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:02 INFO - 'talos_options': ['--xperf_path', 16:36:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:36:02 INFO - 'tests': ['tp5n']}}, 16:36:02 INFO - 'talos.zip': {'path': '', 16:36:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:36:02 INFO - Running post-action listener: _resource_record_post_action 16:36:02 INFO - ##### 16:36:02 INFO - ##### Running create-virtualenv step. 16:36:02 INFO - ##### 16:36:02 INFO - Running pre-action listener: _resource_record_pre_action 16:36:02 INFO - Running main action method: create_virtualenv 16:36:02 INFO - Creating virtualenv /builds/slave/test/build/venv 16:36:02 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 16:36:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:36:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:36:03 INFO - Using real prefix '/usr' 16:36:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:36:03 INFO - Installing distribute.............................................................................................................................................................................................done. 16:36:05 INFO - Installing pip.................done. 16:36:05 INFO - Return code: 0 16:36:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:05 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 0x7f57d474cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfb410>, '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 0x2bfc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfc7a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1461022551.688912-1266825473', '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 16:36:05 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 16:36:05 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 16:36:05 INFO - Using env: {'DISPLAY': ':0', 16:36:05 INFO - 'HOME': '/home/cltbld', 16:36:05 INFO - 'LANG': 'en_US.UTF-8', 16:36:05 INFO - 'LANGUAGE': 'en_US:en', 16:36:05 INFO - 'LOGNAME': 'cltbld', 16:36:05 INFO - 'MAIL': '/var/mail/cltbld', 16:36:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:05 INFO - 'MOZ_NO_REMOTE': '1', 16:36:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:05 INFO - 'NO_EM_RESTART': '1', 16:36:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:05 INFO - 'PWD': '/builds/slave/test', 16:36:05 INFO - 'SHELL': '/bin/bash', 16:36:05 INFO - 'SHLVL': '1', 16:36:05 INFO - 'TERM': 'linux', 16:36:05 INFO - 'TMOUT': '86400', 16:36:05 INFO - 'USER': 'cltbld', 16:36:05 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461022551.688912-1266825473', 16:36:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:05 INFO - '_': '/tools/buildbot/bin/python'} 16:36:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:05 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 16:36:05 INFO - Cleaning up... 16:36:05 INFO - Return code: 0 16:36:05 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:05 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 0x7f57d474cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfb410>, '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 0x2bfc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfc7a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1461022551.688912-1266825473', '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 16:36:05 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 16:36:05 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 16:36:05 INFO - Using env: {'DISPLAY': ':0', 16:36:05 INFO - 'HOME': '/home/cltbld', 16:36:05 INFO - 'LANG': 'en_US.UTF-8', 16:36:05 INFO - 'LANGUAGE': 'en_US:en', 16:36:05 INFO - 'LOGNAME': 'cltbld', 16:36:05 INFO - 'MAIL': '/var/mail/cltbld', 16:36:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:05 INFO - 'MOZ_NO_REMOTE': '1', 16:36:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:05 INFO - 'NO_EM_RESTART': '1', 16:36:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:05 INFO - 'PWD': '/builds/slave/test', 16:36:05 INFO - 'SHELL': '/bin/bash', 16:36:05 INFO - 'SHLVL': '1', 16:36:05 INFO - 'TERM': 'linux', 16:36:05 INFO - 'TMOUT': '86400', 16:36:05 INFO - 'USER': 'cltbld', 16:36:05 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461022551.688912-1266825473', 16:36:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:05 INFO - '_': '/tools/buildbot/bin/python'} 16:36:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:05 INFO - Downloading/unpacking psutil>=0.7.1 16:36:05 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 16:36:05 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 16:36:05 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 16:36:05 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 16:36:05 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 16:36:05 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 16:36:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:36:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:36:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:36:07 INFO - Installing collected packages: psutil 16:36:07 INFO - Running setup.py install for psutil 16:36:08 INFO - building 'psutil._psutil_linux' extension 16:36:08 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 16:36:08 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 16:36:08 INFO - building 'psutil._psutil_posix' extension 16:36:08 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 16:36:08 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 16:36:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:36:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:36:08 INFO - Successfully installed psutil 16:36:08 INFO - Cleaning up... 16:36:08 INFO - Return code: 0 16:36:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:36: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')]} 16:36:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36: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')]} 16:36:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36: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', '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 0x7f57d474cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfb410>, '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 0x2bfc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfc7a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1461022551.688912-1266825473', '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 16:36: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:36: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 mozsystemmonitor==0.0.0 16:36:08 INFO - Using env: {'DISPLAY': ':0', 16:36:08 INFO - 'HOME': '/home/cltbld', 16:36:08 INFO - 'LANG': 'en_US.UTF-8', 16:36:08 INFO - 'LANGUAGE': 'en_US:en', 16:36:08 INFO - 'LOGNAME': 'cltbld', 16:36:08 INFO - 'MAIL': '/var/mail/cltbld', 16:36:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:08 INFO - 'MOZ_NO_REMOTE': '1', 16:36:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:08 INFO - 'NO_EM_RESTART': '1', 16:36:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:08 INFO - 'PWD': '/builds/slave/test', 16:36:08 INFO - 'SHELL': '/bin/bash', 16:36:08 INFO - 'SHLVL': '1', 16:36:08 INFO - 'TERM': 'linux', 16:36:08 INFO - 'TMOUT': '86400', 16:36:08 INFO - 'USER': 'cltbld', 16:36:08 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461022551.688912-1266825473', 16:36:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:08 INFO - '_': '/tools/buildbot/bin/python'} 16:36:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:08 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:36: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 16:36: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 16:36: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 16:36: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 16:36: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 16:36: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 16:36:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:36:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:36:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:36:10 INFO - Installing collected packages: mozsystemmonitor 16:36:10 INFO - Running setup.py install for mozsystemmonitor 16:36:10 INFO - Successfully installed mozsystemmonitor 16:36:10 INFO - Cleaning up... 16:36:10 INFO - Return code: 0 16:36:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:36: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')]} 16:36:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36: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')]} 16:36:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36: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', '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 0x7f57d474cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfb410>, '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 0x2bfc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfc7a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1461022551.688912-1266825473', '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 16:36: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:36: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 blobuploader==1.2.4 16:36:10 INFO - Using env: {'DISPLAY': ':0', 16:36:10 INFO - 'HOME': '/home/cltbld', 16:36:10 INFO - 'LANG': 'en_US.UTF-8', 16:36:10 INFO - 'LANGUAGE': 'en_US:en', 16:36:10 INFO - 'LOGNAME': 'cltbld', 16:36:10 INFO - 'MAIL': '/var/mail/cltbld', 16:36:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:10 INFO - 'MOZ_NO_REMOTE': '1', 16:36:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:10 INFO - 'NO_EM_RESTART': '1', 16:36:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:10 INFO - 'PWD': '/builds/slave/test', 16:36:10 INFO - 'SHELL': '/bin/bash', 16:36:10 INFO - 'SHLVL': '1', 16:36:10 INFO - 'TERM': 'linux', 16:36:10 INFO - 'TMOUT': '86400', 16:36:10 INFO - 'USER': 'cltbld', 16:36:10 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461022551.688912-1266825473', 16:36:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:10 INFO - '_': '/tools/buildbot/bin/python'} 16:36:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:10 INFO - Downloading/unpacking blobuploader==1.2.4 16:36:10 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 16:36:10 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 16:36:10 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 16:36:10 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 16:36:10 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 16:36:10 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 16:36:12 INFO - Downloading blobuploader-1.2.4.tar.gz 16:36:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:36:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:36:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:36:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:36: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 16:36: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 16:36: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 16:36: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 16:36: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 16:36: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 16:36:13 INFO - Downloading docopt-0.6.1.tar.gz 16:36:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:36:13 INFO - Installing collected packages: blobuploader, requests, docopt 16:36:13 INFO - Running setup.py install for blobuploader 16:36:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:36:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:36:13 INFO - Running setup.py install for requests 16:36:14 INFO - Running setup.py install for docopt 16:36:14 INFO - Successfully installed blobuploader requests docopt 16:36:14 INFO - Cleaning up... 16:36:14 INFO - Return code: 0 16:36:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:36:14 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')]} 16:36:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:14 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')]} 16:36:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:14 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 0x7f57d474cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfb410>, '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 0x2bfc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfc7a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1461022551.688912-1266825473', '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 16:36:14 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 16:36:14 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 16:36:14 INFO - Using env: {'DISPLAY': ':0', 16:36:14 INFO - 'HOME': '/home/cltbld', 16:36:14 INFO - 'LANG': 'en_US.UTF-8', 16:36:14 INFO - 'LANGUAGE': 'en_US:en', 16:36:14 INFO - 'LOGNAME': 'cltbld', 16:36:14 INFO - 'MAIL': '/var/mail/cltbld', 16:36:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:14 INFO - 'MOZ_NO_REMOTE': '1', 16:36:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:14 INFO - 'NO_EM_RESTART': '1', 16:36:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:14 INFO - 'PWD': '/builds/slave/test', 16:36:14 INFO - 'SHELL': '/bin/bash', 16:36:14 INFO - 'SHLVL': '1', 16:36:14 INFO - 'TERM': 'linux', 16:36:14 INFO - 'TMOUT': '86400', 16:36:14 INFO - 'USER': 'cltbld', 16:36:14 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461022551.688912-1266825473', 16:36:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:14 INFO - '_': '/tools/buildbot/bin/python'} 16:36:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:36:14 INFO - Running setup.py (path:/tmp/pip-Uq8vJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:36:14 INFO - Running setup.py (path:/tmp/pip-FdTJGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:36:14 INFO - Running setup.py (path:/tmp/pip-UMLGy6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:36:14 INFO - Running setup.py (path:/tmp/pip-B0Gjh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:36:14 INFO - Running setup.py (path:/tmp/pip-MfVJMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:36:14 INFO - Running setup.py (path:/tmp/pip-hZgupL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:36:14 INFO - Running setup.py (path:/tmp/pip-5pSgPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:36:14 INFO - Running setup.py (path:/tmp/pip-UePSKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:36:14 INFO - Running setup.py (path:/tmp/pip-PTZk5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:36:15 INFO - Running setup.py (path:/tmp/pip-6PJ2e2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:36:15 INFO - Running setup.py (path:/tmp/pip-74rvHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:36:15 INFO - Running setup.py (path:/tmp/pip-jplCa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:36:15 INFO - Running setup.py (path:/tmp/pip-n3qmEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:36:15 INFO - Running setup.py (path:/tmp/pip-_tAw9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:36:15 INFO - Running setup.py (path:/tmp/pip-xfvcnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:36:15 INFO - Running setup.py (path:/tmp/pip-6cXm3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:36:15 INFO - Running setup.py (path:/tmp/pip-51X8Gx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:36:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:36:15 INFO - Running setup.py install for manifestparser 16:36:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:36:15 INFO - Running setup.py install for mozcrash 16:36:15 INFO - Running setup.py install for mozdebug 16:36:15 INFO - Running setup.py install for mozdevice 16:36:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:36:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:36:16 INFO - Running setup.py install for mozfile 16:36:16 INFO - Running setup.py install for mozhttpd 16:36:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:36:16 INFO - Running setup.py install for mozinfo 16:36:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:36:16 INFO - Running setup.py install for mozInstall 16:36:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:36:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:36:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:36:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:36:16 INFO - Running setup.py install for mozleak 16:36:16 INFO - Running setup.py install for mozlog 16:36:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:36:16 INFO - Running setup.py install for moznetwork 16:36:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:36:16 INFO - Running setup.py install for mozprocess 16:36:16 INFO - Running setup.py install for mozprofile 16:36:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:36:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:36:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:36:16 INFO - Running setup.py install for mozrunner 16:36:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:36:17 INFO - Running setup.py install for mozscreenshot 16:36:17 INFO - Running setup.py install for moztest 16:36:17 INFO - Running setup.py install for mozversion 16:36:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:36:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:36:17 INFO - Cleaning up... 16:36:17 INFO - Return code: 0 16:36:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:36:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:17 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 0x7f57d474cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfb410>, '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 0x2bfc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfc7a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1461022551.688912-1266825473', '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 16:36:17 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 16:36:17 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 16:36:17 INFO - Using env: {'DISPLAY': ':0', 16:36:17 INFO - 'HOME': '/home/cltbld', 16:36:17 INFO - 'LANG': 'en_US.UTF-8', 16:36:17 INFO - 'LANGUAGE': 'en_US:en', 16:36:17 INFO - 'LOGNAME': 'cltbld', 16:36:17 INFO - 'MAIL': '/var/mail/cltbld', 16:36:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:17 INFO - 'MOZ_NO_REMOTE': '1', 16:36:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:17 INFO - 'NO_EM_RESTART': '1', 16:36:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:17 INFO - 'PWD': '/builds/slave/test', 16:36:17 INFO - 'SHELL': '/bin/bash', 16:36:17 INFO - 'SHLVL': '1', 16:36:17 INFO - 'TERM': 'linux', 16:36:17 INFO - 'TMOUT': '86400', 16:36:17 INFO - 'USER': 'cltbld', 16:36:17 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461022551.688912-1266825473', 16:36:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:17 INFO - '_': '/tools/buildbot/bin/python'} 16:36:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:36:17 INFO - Running setup.py (path:/tmp/pip-rckF2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:36:17 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)) 16:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:36:17 INFO - Running setup.py (path:/tmp/pip-DmO4F4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:36:17 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)) 16:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:36:17 INFO - Running setup.py (path:/tmp/pip-HNedN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:36:17 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)) 16:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:36:17 INFO - Running setup.py (path:/tmp/pip-5cz99R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:36:17 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)) 16:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:36:17 INFO - Running setup.py (path:/tmp/pip-W3h9eN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:36:17 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)) 16:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:36:17 INFO - Running setup.py (path:/tmp/pip-qrZEGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:36:18 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)) 16:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:36:18 INFO - Running setup.py (path:/tmp/pip-f8_lYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:36:18 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)) 16:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:36:18 INFO - Running setup.py (path:/tmp/pip-QUnwlL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:36:18 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)) 16:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:36:18 INFO - Running setup.py (path:/tmp/pip-tcEIc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:36:18 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)) 16:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:36:18 INFO - Running setup.py (path:/tmp/pip-LbHF3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:36:18 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)) 16:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:36:18 INFO - Running setup.py (path:/tmp/pip-wjwPWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:36:18 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)) 16:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:36:18 INFO - Running setup.py (path:/tmp/pip-tL7Rie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:36:18 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)) 16:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:36:18 INFO - Running setup.py (path:/tmp/pip-7rnh3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:36:18 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)) 16:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:36:18 INFO - Running setup.py (path:/tmp/pip-VnBJD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:36:18 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)) 16:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:36:18 INFO - Running setup.py (path:/tmp/pip-7MTHlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:36:18 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)) 16:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:36:18 INFO - Running setup.py (path:/tmp/pip-iOn6Ey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:36:18 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)) 16:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:36:18 INFO - Running setup.py (path:/tmp/pip-Y77oS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:36:18 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)) 16:36:18 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)) 16:36:18 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)) 16:36:18 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)) 16:36:18 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)) 16:36:18 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)) 16:36:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:36:18 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 16:36:18 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 16:36:18 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 16:36:18 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 16:36:18 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 16:36:18 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 16:36:20 INFO - Downloading blessings-1.6.tar.gz 16:36:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:36:20 INFO - Installing collected packages: blessings 16:36:20 INFO - Running setup.py install for blessings 16:36:20 INFO - Successfully installed blessings 16:36:20 INFO - Cleaning up... 16:36:20 INFO - Return code: 0 16:36:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:36:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:36:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:36:21 INFO - Reading from file tmpfile_stdout 16:36:21 INFO - Current package versions: 16:36:21 INFO - argparse == 1.2.1 16:36:21 INFO - blessings == 1.6 16:36:21 INFO - blobuploader == 1.2.4 16:36:21 INFO - docopt == 0.6.1 16:36:21 INFO - manifestparser == 1.1 16:36:21 INFO - mozInstall == 1.12 16:36:21 INFO - mozcrash == 0.17 16:36:21 INFO - mozdebug == 0.1 16:36:21 INFO - mozdevice == 0.48 16:36:21 INFO - mozfile == 1.2 16:36:21 INFO - mozhttpd == 0.7 16:36:21 INFO - mozinfo == 0.9 16:36:21 INFO - mozleak == 0.1 16:36:21 INFO - mozlog == 3.1 16:36:21 INFO - moznetwork == 0.27 16:36:21 INFO - mozprocess == 0.22 16:36:21 INFO - mozprofile == 0.28 16:36:21 INFO - mozrunner == 6.11 16:36:21 INFO - mozscreenshot == 0.1 16:36:21 INFO - mozsystemmonitor == 0.0 16:36:21 INFO - moztest == 0.7 16:36:21 INFO - mozversion == 1.4 16:36:21 INFO - psutil == 3.1.1 16:36:21 INFO - requests == 1.2.3 16:36:21 INFO - wsgiref == 0.1.2 16:36:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:36:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:21 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 0x7f57d474cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfb410>, '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 0x2bfc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfc7a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1461022551.688912-1266825473', '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 16:36:21 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 16:36:21 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 16:36:21 INFO - Using env: {'DISPLAY': ':0', 16:36:21 INFO - 'HOME': '/home/cltbld', 16:36:21 INFO - 'LANG': 'en_US.UTF-8', 16:36:21 INFO - 'LANGUAGE': 'en_US:en', 16:36:21 INFO - 'LOGNAME': 'cltbld', 16:36:21 INFO - 'MAIL': '/var/mail/cltbld', 16:36:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:21 INFO - 'MOZ_NO_REMOTE': '1', 16:36:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:21 INFO - 'NO_EM_RESTART': '1', 16:36:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:21 INFO - 'PWD': '/builds/slave/test', 16:36:21 INFO - 'SHELL': '/bin/bash', 16:36:21 INFO - 'SHLVL': '1', 16:36:21 INFO - 'TERM': 'linux', 16:36:21 INFO - 'TMOUT': '86400', 16:36:21 INFO - 'USER': 'cltbld', 16:36:21 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461022551.688912-1266825473', 16:36:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:21 INFO - '_': '/tools/buildbot/bin/python'} 16:36:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:21 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)) 16:36:21 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)) 16:36:21 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)) 16:36:21 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)) 16:36:21 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)) 16:36:21 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)) 16:36:21 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)) 16:36:21 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)) 16:36:21 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)) 16:36:21 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)) 16:36:21 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)) 16:36:21 INFO - Cleaning up... 16:36:21 INFO - Return code: 0 16:36:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:36:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:21 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 0x7f57d474cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfb410>, '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 0x2bfc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfc7a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1461022551.688912-1266825473', '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 16:36:21 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 16:36:21 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 16:36:21 INFO - Using env: {'DISPLAY': ':0', 16:36:21 INFO - 'HOME': '/home/cltbld', 16:36:21 INFO - 'LANG': 'en_US.UTF-8', 16:36:21 INFO - 'LANGUAGE': 'en_US:en', 16:36:21 INFO - 'LOGNAME': 'cltbld', 16:36:21 INFO - 'MAIL': '/var/mail/cltbld', 16:36:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:21 INFO - 'MOZ_NO_REMOTE': '1', 16:36:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:21 INFO - 'NO_EM_RESTART': '1', 16:36:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:21 INFO - 'PWD': '/builds/slave/test', 16:36:21 INFO - 'SHELL': '/bin/bash', 16:36:21 INFO - 'SHLVL': '1', 16:36:21 INFO - 'TERM': 'linux', 16:36:21 INFO - 'TMOUT': '86400', 16:36:21 INFO - 'USER': 'cltbld', 16:36:21 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461022551.688912-1266825473', 16:36:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:21 INFO - '_': '/tools/buildbot/bin/python'} 16:36:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:21 INFO - Downloading/unpacking jsonschema 16:36: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 16:36: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 16:36: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 16:36: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 16:36: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 16:36: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 16:36:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:36:23 INFO - Downloading/unpacking functools32 (from jsonschema) 16:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:36:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:23 INFO - Downloading functools32-3.2.3-2.tar.gz 16:36:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:36:23 INFO - warning: no files found matching '*.txt' 16:36:23 INFO - no previously-included directories found matching 'build' 16:36:23 INFO - no previously-included directories found matching 'dist' 16:36:23 INFO - no previously-included directories found matching '.git*' 16:36:23 INFO - Installing collected packages: jsonschema, functools32 16:36:23 INFO - Running setup.py install for functools32 16:36:23 INFO - warning: no files found matching '*.txt' 16:36:23 INFO - no previously-included directories found matching 'build' 16:36:23 INFO - no previously-included directories found matching 'dist' 16:36:23 INFO - no previously-included directories found matching '.git*' 16:36:23 INFO - Successfully installed jsonschema functools32 16:36:23 INFO - Cleaning up... 16:36:23 INFO - Return code: 0 16:36:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:36: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')]} 16:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36: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')]} 16:36:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:23 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 0x7f57d474cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfb410>, '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 0x2bfc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfc7a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1461022551.688912-1266825473', '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 16:36:23 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 16:36:23 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 16:36:23 INFO - Using env: {'DISPLAY': ':0', 16:36:23 INFO - 'HOME': '/home/cltbld', 16:36:23 INFO - 'LANG': 'en_US.UTF-8', 16:36:23 INFO - 'LANGUAGE': 'en_US:en', 16:36:23 INFO - 'LOGNAME': 'cltbld', 16:36:23 INFO - 'MAIL': '/var/mail/cltbld', 16:36:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:23 INFO - 'MOZ_NO_REMOTE': '1', 16:36:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:23 INFO - 'NO_EM_RESTART': '1', 16:36:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:23 INFO - 'PWD': '/builds/slave/test', 16:36:23 INFO - 'SHELL': '/bin/bash', 16:36:23 INFO - 'SHLVL': '1', 16:36:23 INFO - 'TERM': 'linux', 16:36:23 INFO - 'TMOUT': '86400', 16:36:23 INFO - 'USER': 'cltbld', 16:36:23 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461022551.688912-1266825473', 16:36:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:23 INFO - '_': '/tools/buildbot/bin/python'} 16:36:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:24 INFO - Downloading/unpacking flake8 16:36: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 16:36: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 16:36: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 16:36: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 16:36: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 16:36: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 16:36:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:36:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:36: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 16:36: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 16:36: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 16:36: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 16:36: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 16:36: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 16:36:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:36:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:36: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 16:36: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 16:36: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 16:36: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 16:36: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 16:36: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 16:36:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:36: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 16:36: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 16:36: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 16:36: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 16:36: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 16:36: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 16:36:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:36:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:36:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:36:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:36:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:36:26 INFO - no previously-included directories found matching 'docs/_build' 16:36:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:36:26 INFO - Running setup.py install for pep8 16:36:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:36:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:36:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:36:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:36:27 INFO - no previously-included directories found matching 'docs/_build' 16:36:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:36:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:36:27 INFO - Cleaning up... 16:36:27 INFO - Return code: 0 16:36:27 INFO - Running post-action listener: _resource_record_post_action 16:36:27 INFO - Running post-action listener: _start_resource_monitoring 16:36:27 INFO - Starting resource monitoring. 16:36:27 INFO - ##### 16:36:27 INFO - ##### Running install step. 16:36:27 INFO - ##### 16:36:27 INFO - Running pre-action listener: _resource_record_pre_action 16:36:27 INFO - Running main action method: install 16:36:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:36:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:36:27 INFO - Reading from file tmpfile_stdout 16:36:27 INFO - Detecting whether we're running mozinstall >=1.0... 16:36:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:36:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:36:27 INFO - Reading from file tmpfile_stdout 16:36:27 INFO - Output received: 16:36:27 INFO - Usage: mozinstall [options] installer 16:36:27 INFO - Options: 16:36:27 INFO - -h, --help show this help message and exit 16:36:27 INFO - -d DEST, --destination=DEST 16:36:27 INFO - Directory to install application into. [default: 16:36:27 INFO - "/builds/slave/test"] 16:36:27 INFO - --app=APP Application being installed. [default: firefox] 16:36:27 INFO - mkdir: /builds/slave/test/build/application 16:36:27 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'] 16:36:27 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 16:36:43 INFO - Reading from file tmpfile_stdout 16:36:43 INFO - Output received: 16:36:43 INFO - /builds/slave/test/build/application/firefox/firefox 16:36:43 INFO - Running post-action listener: _resource_record_post_action 16:36:43 INFO - ##### 16:36:43 INFO - ##### Running run-tests step. 16:36:43 INFO - ##### 16:36:43 INFO - Running pre-action listener: _resource_record_pre_action 16:36:43 INFO - Running main action method: run_tests 16:36:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:36:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:36:43 INFO - Python 2.7.3 16:36:43 INFO - Return code: 0 16:36:43 INFO - grabbing minidump binary from tooltool 16:36:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:43 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 0x2bfb410>, '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 0x2bfc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfc7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:36:43 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 16:36:43 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 16:36:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:36:43 INFO - Return code: 0 16:36:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:36:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:36:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:36:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:36:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:36:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:36:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:36:44 INFO - Return code: 0 16:36:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 16:36:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 16:36:44 INFO - Using env: {'DISPLAY': ':0', 16:36:44 INFO - 'HOME': '/home/cltbld', 16:36:44 INFO - 'LANG': 'en_US.UTF-8', 16:36:44 INFO - 'LANGUAGE': 'en_US:en', 16:36:44 INFO - 'LOGNAME': 'cltbld', 16:36:44 INFO - 'MAIL': '/var/mail/cltbld', 16:36:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:36:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:36:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:44 INFO - 'MOZ_NO_REMOTE': '1', 16:36:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:36:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:44 INFO - 'NO_EM_RESTART': '1', 16:36:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:44 INFO - 'PWD': '/builds/slave/test', 16:36:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:36:44 INFO - 'SHELL': '/bin/bash', 16:36:44 INFO - 'SHLVL': '1', 16:36:44 INFO - 'TERM': 'linux', 16:36:44 INFO - 'TMOUT': '86400', 16:36:44 INFO - 'USER': 'cltbld', 16:36:44 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461022551.688912-1266825473', 16:36:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:44 INFO - '_': '/tools/buildbot/bin/python'} 16:36:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 16:36:44 INFO - mozversion application_buildid: 20160418151628 16:36:44 INFO - mozversion application_changeset: e8ef4670ee16f419b1037b715f0d28978825439e 16:36:44 INFO - mozversion application_display_name: Nightly 16:36:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:36:44 INFO - mozversion application_name: Firefox 16:36:44 INFO - mozversion application_remotingname: firefox 16:36:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:36:44 INFO - mozversion application_vendor: Mozilla 16:36:44 INFO - mozversion application_version: 48.0a1 16:36:44 INFO - mozversion platform_buildid: 20160418151628 16:36:44 INFO - mozversion platform_changeset: e8ef4670ee16f419b1037b715f0d28978825439e 16:36:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:36:44 INFO - mozversion platform_version: 48.0a1 16:36:44 INFO - using testdate: 1461022604 16:36:44 INFO - actual date: 1461022604 16:36:44 INFO - starting webserver on 'localhost:49228' 16:36:44 INFO - SUITE-START | Running 2 tests 16:36:44 INFO - TEST-START | dromaeo_css 16:36:44 INFO - operating with platform_type : linux_ 16:36:44 INFO - Initialising browser for dromaeo_css test... 16:36:44 INFO - TEST-INFO | started process 7733 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkDnlgf/profile http://localhost:49228/getInfo.html) 16:36:48 INFO - PROCESS | 7733 | __metrics Screen width/height:1600/1200 16:36:48 INFO - PROCESS | 7733 | colorDepth:24 16:36:48 INFO - PROCESS | 7733 | Browser inner width/height: 1024/697 16:36:48 INFO - PROCESS | 7733 | __metrics 16:36:49 ERROR - PROCESS | 7733 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:36:50 INFO - TEST-INFO | 7733: exit 0 16:36:50 INFO - Browser initialized. 16:36:50 INFO - Running cycle 1/1 for dromaeo_css test... 16:36:50 INFO - TEST-INFO | started process 7813 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkDnlgf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:37:02 INFO - PROCESS | 7813 | RSS: Main: 154595328 16:37:02 INFO - PROCESS | 7813 | 16:37:54 INFO - PROCESS | 7813 | 1461022674213 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] 16:40:05 INFO - PROCESS | 7813 | Cycle 1(1): loaded http://localhost:49228/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49228/tests/dromaeo/cssquery-ext.html) 16:40:06 INFO - PROCESS | 7813 | RSS: Main: 267165696 16:40:06 INFO - PROCESS | 7813 | 16:43:09 INFO - PROCESS | 7813 | Cycle 1(1): loaded http://localhost:49228/tests/dromaeo/cssquery-ext.html (next: http://localhost:49228/tests/dromaeo/cssquery-jquery.html) 16:43:10 INFO - PROCESS | 7813 | RSS: Main: 233668608 16:43:10 INFO - PROCESS | 7813 | 16:46:12 INFO - PROCESS | 7813 | Cycle 1(1): loaded http://localhost:49228/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49228/tests/dromaeo/cssquery-mootools.html) 16:46:12 INFO - PROCESS | 7813 | RSS: Main: 231575552 16:46:12 INFO - PROCESS | 7813 | 16:49:14 INFO - PROCESS | 7813 | Cycle 1(1): loaded http://localhost:49228/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49228/tests/dromaeo/cssquery-prototype.html) 16:49:15 INFO - PROCESS | 7813 | RSS: Main: 236773376 16:49:15 INFO - PROCESS | 7813 | 16:52:18 INFO - PROCESS | 7813 | Cycle 1(1): loaded http://localhost:49228/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49228/tests/dromaeo/cssquery-yui.html) 16:52:19 INFO - PROCESS | 7813 | RSS: Main: 214130688 16:52:19 INFO - PROCESS | 7813 | 16:55:21 INFO - PROCESS | 7813 | Cycle 1(1): loaded http://localhost:49228/tests/dromaeo/cssquery-yui.html (next: http://localhost:49228/tests/dromaeo/cssquery-dojo.html) 16:55:21 INFO - PROCESS | 7813 | RSS: Main: 296382464 16:55:21 INFO - PROCESS | 7813 | 16:55:21 INFO - PROCESS | 7813 | __start_tp_report 16:55:21 INFO - PROCESS | 7813 | _x_x_mozilla_page_load 16:55:21 INFO - PROCESS | 7813 | _x_x_mozilla_page_load_details 16:55:21 INFO - PROCESS | 7813 | |i|pagename|runs| 16:55:21 INFO - PROCESS | 7813 | |0;dojo.html;2616.764491195792;2681.4503026879493;2696.7572918437336;2708.038646280569;2724.0057379056643;4587.632989360852;4671.159191345557;4675.018246168304;4680.882977925554;4685.695429797065;4708.199606066968;4765.737884416364;4835.951640483594;4837.830675926343;4848.6363522735755;4216.915661686764;4272.060146767706;4282.914341713164;4335.0679603885155;4432.11357728454;4337.067530480946;4379.255526560492;4391.802368893392;4394.055278115205;4429.313456414245;4229.894252643709;4239.173361194568;4308.526062133163;4315.287977483711;4340.262155433568;4293.205756934977;4306.181825453154;4316.115196384765;4317.222899878021;4362.389265502832;4286.164197981395;4286.357046443059;4300.290452075404;4312.22379971605;4341.696081274312;4497.168023915586;4569.177548041352;4601.2637977923705;4664.300354946785;4671.369365135697;4821.638377121695;5072.061668591323;5090.694558326512;5091.0581542414775;5141.280220769096;5086.41506226785;5091.236314552847;5098.745062746885;5103.642745007851;5149.536541711226;4590.678652494326;4678.883027924329;4712.9057418851435;4747.2879068140055;4751.881202969954;5143.254228136899;5151.0470562945975;5161.071007218661;5163;5164.457731938168;4828.2998965150555;4958.107540642719;4961.206207006861;4962.528559786814;5005.849824505271;5019.7239151847;5042.520960508746;5073.365829271341;5111.514406131411;5116.692998420107;4988.152014157529;5020.246962955513;5024.79900803971;5025.924611130836;5073.568746656501;4879.658423910292;4956.90086198274;4989.850304490871;5013.298138260647;5016.372953380827;4262.65898728101;4265.488141422987;4287.164003019381;4291.935620965688;4306.160298741778;3706.981465092711;3718.7396882217986;3722.925541489155;3746.7751934883995;3762.981185094112;4210.473690788652;4266.381374700651;4276.57234276576;4278.63631591312;4284.464441944757;5016.54851063406;5041.899162016739;5048.495150484996;5094.5669618082875;5098.1842905135;4289.463817022872;4322.37325587788;4327.415798867176;4359.956400436018;4374.4531933508315;4351.543087975717;4523.050159466483;4523.84166554169;4539.84110556129;4568.565986231302;4746.786394612251;4777.020710754217;4784.521547845187;4803.423589169252;4828.66199366041;5032.421271553671;5054.974725126351;5074.31496747949;5081.288619593334;5114.590832733298;4623.514530974199;4745.525447455227;4783.7129772213775;4797.952020479751;4798.688085274446;4979.925301120414;4987.12725273083;5003.124453220745;5033.823816166417;5047.1419858623385;5048.823291184791;5067.062593420229;5067.771950262173;5071.264666623245;5118.181091025418;4798.2082956311815;4821.807127714992;4886.413630364379;4909.754512274443;4954.702717836942;4838.806447742051;4854.466008739107;4864.708117512961;4866.416030076413;4912.582430493448;4789.44921334051;4791.257355109963;4792.832250871203;4794.065157294294;4838.661293709407;4771.59441447467;4853.51464853526;4932.28481870134;4938.703677779345;4967.031428871335;4749.453812811571;4763.523647635208;4771.761411929459;4809.398825146856;4823.589994850477 16:55:21 INFO - PROCESS | 7813 | |1;ext.html;579.7593998490627;586.3872253495097;600.1627729317602;605.6305653551335;621.1490258346065;26383.868080659595;34038.48942265865;35038.29923401531;35081.649183508154;35093.64906350939;37582.62417375825;38357;38367.42448863262;38449.03877403066;38478.807605962;7303.963480182618;7465.477416580841;7617.80955476112;7626.122995855492;9479.194268487152;9602.231821454301;9766.853497197548;9767.218622510181;9773.755656108584;9779.951100244489;9698.175655069328;9815.067568580973;9815.705528834147;9817.067378599022;9820.705378838646;7454.291842275003;9690.32167748258;9732.562034708455;10057.145142662883;10060.798784024351;9415.576299066559;9549.570269337826;9556.904430955741;9558.522073896278;9562.56968436422;34546.654533454595;35022.12444688903;35187.648123518695;35207.295854082775;35312.64687353145;3107.3474570340254;3281.1469018055477;3414.607320158189;3535.9469607955903;3696.131409118855;28814;28955.276118097005;29262.122136335944;29392.559111613344;29405.70594294051;3389.118829104426;3416.1118109291515;3533.222691007974;3573.9642603574152;3589.192431702846;228606;230981;231893;232418;232618;32882.34235315328;53358.733206333716;53515.197272040954;54020.72989635027;54042.189367159524;32038.83980580082;32318.676813231566;32343;32345.838270808967;32358.83820580929;13679.110857794212;13793.310334483436;13916.860831391556;13919.443222271198;13927.721445571031;9637.37357071788;11229.157813164045;11483.885161148282;11498.540058397737;11499.770004600028;7995.1605081465605;8006.1993800619475;8038.83922321562;8101.675932962733;8125.187481251945;3178.634457037424;3181.904542863718;3190.3729098159642;3213.775035747475;3229.4671379222636;929.656027269901;936.6066252173968;984.9803003939882;996.5366104761321;1114.5820317380983;28110.71889281122;28285.858570707427;28607.141785746462;28660;28785;996.1283876607968;999.5901680311183;1000.2797985450464;1039.9480025998669;1043.1446214104512;14655.853441465662;15179.848201518063;15229.847701523064;15389.153596552072;15471.14908680011;327962;328968;329673;332571;332683;48872.5112748875;49834.50165498371;49838.252426213636;49860.750696247014;49889.75055124701;1096.714854137914;1208.9939550302192;1246.4266437438698;1288.0339745191106;1288.909776315649;25731.614025790004;27909.302267443476;27976.440471190053;28462.43075138527;28640.57039144373;39329.803350983064;39665.206695865345;39807.2038559233;39863.800680996406;39887.800560997006;223960;225655;225670;226541;226847;22905.19831805879;25310.873445632653;25877;26079.478410432064;26129.778968787865;35923.640763592026;39078;40456.39315410212;40699.389509157976;41333.58666413297;34272;34321.313573727886;34451;34991.65008349884;35157;33545.66454335523;33881.83059084689;34242.82878585591;34414;34499.310013799084;34269.82865085659;34360.14099647529;34688.306233874675;34792.47811282883;34805.825970869984;29927.251818703837;30554.236144095685;30928.53607195849;30974.53538196884;31070.22324441907;23946.28161155168;24340.634890477013;24504.632430513913;24615.384615384042;24636.753632464162 16:55:21 INFO - PROCESS | 7813 | |2;jquery.html;378.7367779393321;382.4817372460318;387.18883938149577;393.21161072050535;397.5706237263755;15725.449609263664;16933.238004289804;16993.83006169938;17105.9736415815;17140.14299285037;15651.608709782262;16035.438759643415;16363.181840907966;16378.918105409486;16401.42595009175;5099.15863882459;5230.973845130769;5265.394479634833;5268.736563171845;5269.789208431658;3657.7988210648405;5584.91622625661;6110.633361998294;6121.66330851803;6131.3562075982045;6040.033594624861;6040.637561746287;6078.088286757;6084.634921904678;6254.499640028809;6543.312952140028;6576.177977752781;6585.670716464181;6594.043863639793;6611.173603299588;3830.8276127574327;6121.540884433641;6516.218053833571;6522.7390904363765;6531.216254049545;21397.78602213989;21815.45461363463;22160.778392216034;23022.73374964376;23109.76890231093;1906.752122224102;1976.802319768026;1987.920483180671;1995.9002049897447;2152.5156839711094;14151.504697335544;14289.356978935974;14577.416903323854;14650.853491465055;15004.324805383783;1821.3261093395529;1889.8439605858111;1917.213942283657;1922.9615407691767;1931.777845547766;78287;80212.59893700494;80671.59664201758;81211.18788812096;84391.15608843956;14433.24245336676;15880.364785408685;15948.840511594968;15987.60030999211;16243.51269461918;29569.55645665317;29616.111516654535;29653;29739.553906691417;29761.25596860096;8583;8638.17937295956;8700.608472618747;8744.02014060979;8854.955725221333;7046.788596342118;7241.565506069547;7368.263173682589;7413;7488.438367122379;8210.137935516685;8338.166183381612;8373.790655233546;8468.745937621881;8548.658053677784;2547;3151.795133316327;3322.2192784695576;3397.5413319202084;3638.272345530904;867.9132086791396;879.445949052093;925.8981512033671;1008.1078245752415;1014.5434554450527;15570.844291557167;15641.530754077396;16895;17095.316187352615;17166;876.5398165962921;900.6847603338779;902.9413088149249;904.6110172625703;911.6672414568767;9278;9355.345125841126;9489.335746497816;9489.762755931157;9668.613255469843;372809;377475;377599;378104.10947945085;379386;76254.23745762583;78426.21573784303;79154.6042269785;79754;80541.59729201316;913.3378300731916;925.7500474871881;939.8261321655516;948.7438391634358;953.1469334945185;14255.358508866919;14775.187364695044;14790.704185916005;15248.542543723706;15765;31147.221319467193;32711.836440817642;33360.99917002494;34794.478082829286;35921.820390897876;42263;43022.569774303105;44376.55623443853;47993.28010079782;50650;7621.885671714817;7646;7695.461317707706;7962.283394494523;7965.4822436541435;7883.448158628841;11061;11118.49966751482;11327.886721133013;11865;9959.950200248952;10013.349132306668;10022.298439109192;10089.545970431494;10272.126869215901;9865.260105491972;9973.102420781874;10009.149222316184;10119.544620491948;10129.341592796445;5280.947190528199;6733.865322693617;10016.694490818158;10528.78942421132;10586.576536938745;6486.513511486752;6874.4844136690945;7038.049863268393;7067.2579379164445;8156.755297341089;8483.236508714246;9883.308168428428;10022.649207277711;10110.595576176871;10135.64525241613 16:55:21 INFO - PROCESS | 7813 | |3;mootools.html;1284.7687416265069;1434.992825035875;1464.5020692964392;1565.1782814022636;1750.6936286149928;7297.233790451999;7573.886391704129;7616.314531692146;7629.427792915526;7629.542227466356;7362.079740032496;7505.399568034558;7510.549367037968;7513.098428188611;7552.055993000875;1935.4774210963033;1991;1997.5205950571903;2069.0689189864547;2103.064136459276;2208.5914105890383;2270.8751018693965;2271.375371772759;2273.1134857405623;2274.55646149001;2178.0525471419905;2218.223621732397;2218.234709025384;2226.4100013496436;2227.877466739337;1895.6113996630795;2168.316980151263;2183.9235626753066;2187.3656639574583;2192.7149470568884;2202.108146200775;2222.533268013719;2227.4431392151964;2229.8104661103825;2230.966535501969;7507.9624601877185;7545;7559.622018899033;7564.810879727996;7569.129550101754;4418.917365245503;4558.658100642465;4569.954300456986;4570.908581828345;4574.428196475441;2790.652761684032;2959.4672958867395;2979.1658335666048;2993.760499160084;3005.008347245404;922.0226559846584;943.9056094390575;954.7613096725819;957.8802649668792;969.7381706939158;10397.480125993745;10416.5833366666;10428.009339112772;10446.68659940203;10451.425171615558;4093.6111069448357;4176.1230141669985;4315.417418648442;4343.718603012119;4348.782560872007;8948.776280593038;8960.1935825776;8967.865482017774;8973.192412682889;9004.279657627374;4711.057788442326;4726.976365118221;4739.644526660514;4740.597049250852;4756.9286460703115;3690.5202323698286;3750.6249375062275;3934.9213015739524;4297.05464797744;4308.4399028126145;3348.5646865907274;3474.6699063588917;3770.45328427382;3776.2258736958856;3778.244351129785;1212.933288669114;1226.45422786859;1229.7601967616229;1234.234774439853;1246.8503779546513;842.149429076637;843.8143608406141;863.2360361080489;882.9293656507464;886.6542048601051;4948.331975183376;5136.897262054813;5150.072986862326;5165.147750621106;5190.870228244324;416.8207670701567;420.2456590420203;420.4912056411715;424.6454210734072;887.0907319997054;3731.850725970931;3876.2247550490015;3876.3022655922205;3878.185581028016;3957.050307926135;8800.559972001502;9140.63437462494;9235.95382023099;9239.122283383067;9263.120003599648;9072.00207977122;9086.318526110568;9108;9155.725328240163;9164.541772911462;6955.1653801544135;7069.151701795818;7082.681279342442;7110.537815042109;7110.857782844314;5172.7155006475;5385.380681221553;5390.730463476889;5476.72616369172;5631.465010823965;8647.56762161902;8816.426932249384;8854.070322616033;8922.107789221025;8938.329625278;8472.406931514735;8575.142485751376;8677.826443471222;8761.211490965843;8778.473291602524;6567.802965911031;6720.428763555153;6728.932710672831;6733.764318248838;6737.157855268091;6473.77341793035;7045.330693584101;7232.276772322725;7274.672639731119;7276.345128938421;6420.454261387835;6528.053432252392;6593.96703016501;6674.43267322283;6878.759243426456;6497.122888410193;6543;6626.801195964129;6715.1941766988275;6752.122224110834;6132.938670613236;6199.628022318675;6200.7519699211525;6209.782657606962;6275.121482992294;4596;4631.444226692818;4656.394668693184;4668.416447944007;4729.621630269639;4710.105080034782;4739.21802902531;4765.237561990065;4830.637702172281;4926.679765815211 16:55:21 INFO - PROCESS | 7813 | |4;prototype.html;312.0560305077141;312.38772006866543;315.9763017773667;321.57873186126193;322.5436008048613;5124.38581846718;5166.844994650157;5184.300119483869;5216;5231.0845602019635;5095.439501654815;5124.923126153101;5132.050570644434;5137.56330711889;5138.9743051284695;3806.638369354907;3867.1878905429894;4020.336644453662;4022.296098182821;4044.211378781124;3999.760014399131;4010.3984402339593;4027.436158937751;4030.6976976726714;4033.6773058155422;3774.4904437900946;3989.341758609826;3995.320795464778;3995.5604883462797;4007.519097708279;3917.216556688674;4015.6307778410733;4021.4973128358956;4026.295398305285;4033.3949907513816;3551.5738111426795;3553.4492153716214;3557.3063252665743;3570.732195085353;3577.4276115821344;4931.0630980113665;4932.383452068491;4940.901181976376;4955.058538877602;4959.677620954626;4494.617957473619;4541.182587134314;4644.9535504644855;4646.605038571725;4652.930206046912;5385.380681221671;5386.78452861885;5397.487238712316;5415.810446634349;5417.241586177938;3885.436611691289;3886.650201481852;3912.158885839558;3912.6478616924614;3912.7652340859354;5479.7509023838675;5667.603267771257;5677;5694.288213973254;5713.029004993271;4006.959930400717;4012.558618551957;4025.1748391579654;4031.4557534732435;4033.7983100845427;4067.654249388835;4069.7354671946227;4077.8368865245056;4092.4066010428323;4100.815463304159;4359.193549193409;4584.40980845821;4601.838935637236;4617.953820461819;4624.745638989821;5371.57027437804;5384.038778671715;5399.83800485986;5402.945970540244;5421.566274698014;1408.0425310788557;1424.444466658004;1428.407211007441;1432.8710416062604;1436.3249272841747;895.6193617712446;949.4350861237552;976.72651657536;986.6941248213077;997.6907158780801;4679.508651591602;4683.344331793552;4691.437027556647;4697.459792123949;4706.7411292378565;5487.341519017744;5505.476979686923;5514.724263786795;5540.695261760642;5540.833774986757;4530.79611417487;4660.114578230193;4667.113248482778;4671.556202160789;4779.641526885497;2997.6103106596;3007.9849600752295;3012.29211135383;3012.29211135383;3019.245188702824;5286.762095705702;5293.12663410533;5304.204369344629;5314.050701860428;5328.866778330573;5540.667559946416;5755.769769209269;5770.124709469355;5775.303805564442;5788.421157884178;5283.365996080495;5299.629025968223;5302.098643230583;5304.761285742151;5305.4164041955355;5372.973135134299;5634.887302254014;5636.520895723909;5640.85897852557;5644.435556444323;5512.834614961557;5524.696141712245;5528.502434780889;5541.667499950016;5545.170093868933;5230.869228269324;5259.184826351921;5278.920816187837;5288.338957630296;5321.627486075938;3702.444633305026;3878.4570160178164;3901.6293452122004;3913.5499417567344;3920.4707364505425;5565.276514053147;5581.218629391969;5598.076317407745;5607.102863541813;5613.943860561342;5386.757595908115;5400.216968539461;5406.918896216481;5409.134538473825;5435.402105768283;5243.868903277448;5391.137418013099;5414.539764120094;5434.673919564681;5437.673739575638;5018.648694591344;5270.920936186037;5309.787608495617;5317.441668624739;5334.599905007062;5290.100682883842;5294.629375943801;5328.626996110235;5345.599080069088;5349.304590403222;5309.177077552986;5329.44040875718;5329.600279978939;5342.919856202082;5364.7049412282695 16:55:21 INFO - PROCESS | 7813 | |5;yui.html;648.4002297874466;702.7540360873695;708.6067232685857;715.5492040014793;722.949393542452;11425.885741142585;12349.567765128222;12385.56650517232;12421.130520863544;12424.875751242496;12306.077044221696;12357;12360.50557977682;12375.50497980082;12384.50461981522;624.7813265357134;767.5548182054423;792.2750683124934;798.8442253760519;800.7797855589702;790.0637744273026;790.7548659915444;794.4002278279919;797.2744802229972;798.5767543202112;843.7004863273542;848.6647774129216;849.3757088539918;849.5794581682076;849.6898631999337;667.0328024364691;803.4175222963363;830.6511265268541;830.8130670599128;831.3681601982477;609.7195290166529;611.3214332091375;612.1980205930201;612.3509080374772;612.37843588757;10727;10747.140228781678;10748.677539673823;10777.83833242502;10797.514111864984;11396.601118960796;11984.580539681156;12141.453634586376;12197.634070977885;12506.81239781404;9936.90063099367;9974.750631234205;10064.798704025952;10066.496675166212;10196.133328667072;3279.360524697685;3289.276359200972;3321.8671253149846;3339.699427051577;3387.915302117442;44624.553754462366;45148;45794.54205457936;45830.31254531185;45838.999999999665;9058;9314.86027709585;9438.811223775623;9518.619255229853;9713.417194968184;16831;16862.24119914607;16887.662246754997;16909.23908424124;16958.321667133423;5993.370696076936;6087.6956152192215;6136.754529818846;6271.623702577769;6430.582012169194;3358.697717205463;3515.898515675062;3586.6413358664445;3652.995426257747;3703.79629120401;2610.7911367090587;2684.9731502685113;2687.865606719656;2696.2989622697846;2697.527932611785;439.06041072105717;464.90934267818125;480.11418932070274;480.5362824874013;523.9607029472804;475.47460056637607;527.6359312074657;571.029250274535;574.2850151561249;577.3447137498969;7783.532988020737;7917.722879699298;8272.751817445485;8361.95819020901;8525.275351595059;530.6895466152345;532.7975369359696;535.2078923193695;584.8098129104201;627.3130921640796;3805.866794662229;3837.827297771551;3843.6348546888003;3902.3366027775346;3971.6822654187595;44729.552704473186;46134.30798538025;56945.715271424204;57215;57265;41612.37581436281;42231.7888410556;42332.57667423348;42941.57058429438;44082.33876491855;39353.60646393557;39419.605803941595;39686;40319.596804031586;41094.38358424626;7971.362291016589;8169.918300816916;8326.426901832852;8403.873941890999;8554.358423118167;28268.85865570659;28320.291992700346;28416.57375139333;28619;28963.275918102216;36188;37940.62059379481;38093.80953095217;38264.2347153061;38761.6123838758;9696.660616878375;10556.577736890438;10572.36565806054;10916.781664366827;10942.124630029737;11586.304821710388;11798.115141364604;11815;12147.210431321935;12157.331346775658;10714.357138571711;10896.182786290901;10919.290246133976;10923.453827308444;11116.888831111586;10104.444255566015;10229.079382855578;10428.791424171626;10571.471426428801;10572.577096916037;10499.895001050198;10551;10609.20430967696;10829.133669306279;10943.726406839893;9196.448213107235;9421.340506164503;9459.952700236454;9461.668841590512;9557.713268601952;8836.602352894264;8846.911530884609;9073.727788166365;9156.725298241063;9367.344285899922 16:55:21 INFO - PROCESS | 7813 | __end_tp_report 16:55:21 INFO - PROCESS | 7813 | __start_cc_report 16:55:21 INFO - PROCESS | 7813 | _x_x_mozilla_cycle_collect,1158 16:55:21 INFO - PROCESS | 7813 | __end_cc_report 16:55:21 INFO - PROCESS | 7813 | __startTimestamp1461023721853__endTimestamp 16:55:21 INFO - PROCESS | 7813 | 16:55:21 INFO - PROCESS | 7813 | ------- Summary: start ------- 16:55:21 INFO - PROCESS | 7813 | Number of tests: 6 16:55:21 INFO - PROCESS | 7813 | 16:55:21 INFO - PROCESS | 7813 | [#0] dojo.html Cycles:165 Average:4650.10 Median:4789.45 stddev:486.53 (10.2%) stddev-sans-first:461.13 16:55:21 INFO - PROCESS | 7813 | Values: 2616.8 2681.5 2696.8 2708.0 2724.0 4587.6 4671.2 4675.0 4680.9 4685.7 4708.2 4765.7 4836.0 4837.8 4848.6 4216.9 4272.1 4282.9 4335.1 4432.1 4337.1 4379.3 4391.8 4394.1 4429.3 4229.9 4239.2 4308.5 4315.3 4340.3 4293.2 4306.2 4316.1 4317.2 4362.4 4286.2 4286.4 4300.3 4312.2 4341.7 4497.2 4569.2 4601.3 4664.3 4671.4 4821.6 5072.1 5090.7 5091.1 5141.3 5086.4 5091.2 5098.7 5103.6 5149.5 4590.7 4678.9 4712.9 4747.3 4751.9 5143.3 5151.0 5161.1 5163.0 5164.5 4828.3 4958.1 4961.2 4962.5 5005.8 5019.7 5042.5 5073.4 5111.5 5116.7 4988.2 5020.2 5024.8 5025.9 5073.6 4879.7 4956.9 4989.9 5013.3 5016.4 4262.7 4265.5 4287.2 4291.9 4306.2 3707.0 3718.7 3722.9 3746.8 3763.0 4210.5 4266.4 4276.6 4278.6 4284.5 5016.5 5041.9 5048.5 5094.6 5098.2 4289.5 4322.4 4327.4 4360.0 4374.5 4351.5 4523.1 4523.8 4539.8 4568.6 4746.8 4777.0 4784.5 4803.4 4828.7 5032.4 5055.0 5074.3 5081.3 5114.6 4623.5 4745.5 4783.7 4798.0 4798.7 4979.9 4987.1 5003.1 5033.8 5047.1 5048.8 5067.1 5067.8 5071.3 5118.2 4798.2 4821.8 4886.4 4909.8 4954.7 4838.8 4854.5 4864.7 4866.4 4912.6 4789.4 4791.3 4792.8 4794.1 4838.7 4771.6 4853.5 4932.3 4938.7 4967.0 4749.5 4763.5 4771.8 4809.4 4823.6 16:55:21 INFO - PROCESS | 7813 | 16:55:21 INFO - PROCESS | 7813 | [#1] ext.html Cycles:180 Average:41169.51 Median:34256.33 stddev:69880.43 (204.0%) stddev-sans-first:70010.01 16:55:21 INFO - PROCESS | 7813 | Values: 579.8 586.4 600.2 605.6 621.1 26383.9 34038.5 35038.3 35081.6 35093.6 37582.6 38357.0 38367.4 38449.0 38478.8 7304.0 7465.5 7617.8 7626.1 9479.2 9602.2 9766.9 9767.2 9773.8 9780.0 9698.2 9815.1 9815.7 9817.1 9820.7 7454.3 9690.3 9732.6 10057.1 10060.8 9415.6 9549.6 9556.9 9558.5 9562.6 34546.7 35022.1 35187.6 35207.3 35312.6 3107.3 3281.1 3414.6 3535.9 3696.1 28814.0 28955.3 29262.1 29392.6 29405.7 3389.1 3416.1 3533.2 3574.0 3589.2 228606.0 230981.0 231893.0 232418.0 232618.0 32882.3 53358.7 53515.2 54020.7 54042.2 32038.8 32318.7 32343.0 32345.8 32358.8 13679.1 13793.3 13916.9 13919.4 13927.7 9637.4 11229.2 11483.9 11498.5 11499.8 7995.2 8006.2 8038.8 8101.7 8125.2 3178.6 3181.9 3190.4 3213.8 3229.5 929.7 936.6 985.0 996.5 1114.6 28110.7 28285.9 28607.1 28660.0 28785.0 996.1 999.6 1000.3 1039.9 1043.1 14655.9 15179.8 15229.8 15389.2 15471.1 327962.0 328968.0 329673.0 332571.0 332683.0 48872.5 49834.5 49838.3 49860.8 49889.8 1096.7 1209.0 1246.4 1288.0 1288.9 25731.6 27909.3 27976.4 28462.4 28640.6 39329.8 39665.2 39807.2 39863.8 39887.8 223960.0 225655.0 225670.0 226541.0 226847.0 22905.2 25310.9 25877.0 26079.5 26129.8 35923.6 39078.0 40456.4 40699.4 41333.6 34272.0 34321.3 34451.0 34991.7 35157.0 33545.7 33881.8 34242.8 34414.0 34499.3 34269.8 34360.1 34688.3 34792.5 34805.8 29927.3 30554.2 30928.5 30974.5 31070.2 23946.3 24340.6 24504.6 24615.4 24636.8 16:55:21 INFO - PROCESS | 7813 | 16:55:21 INFO - PROCESS | 7813 | [#2] jquery.html Cycles:180 Average:25004.52 Median:21330.29 stddev:62455.61 (292.8%) stddev-sans-first:62603.45 16:55:21 INFO - PROCESS | 7813 | Values: 378.7 382.5 387.2 393.2 397.6 15725.4 16933.2 16993.8 17106.0 17140.1 15651.6 16035.4 16363.2 16378.9 16401.4 5099.2 5231.0 5265.4 5268.7 5269.8 3657.8 5584.9 6110.6 6121.7 6131.4 6040.0 6040.6 6078.1 6084.6 6254.5 6543.3 6576.2 6585.7 6594.0 6611.2 3830.8 6121.5 6516.2 6522.7 6531.2 21397.8 21815.5 22160.8 23022.7 23109.8 1906.8 1976.8 1987.9 1995.9 2152.5 14151.5 14289.4 14577.4 14650.9 15004.3 1821.3 1889.8 1917.2 1923.0 1931.8 78287.0 80212.6 80671.6 81211.2 84391.2 14433.2 15880.4 15948.8 15987.6 16243.5 29569.6 29616.1 29653.0 29739.6 29761.3 8583.0 8638.2 8700.6 8744.0 8855.0 7046.8 7241.6 7368.3 7413.0 7488.4 8210.1 8338.2 8373.8 8468.7 8548.7 2547.0 3151.8 3322.2 3397.5 3638.3 867.9 879.4 925.9 1008.1 1014.5 15570.8 15641.5 16895.0 17095.3 17166.0 876.5 900.7 902.9 904.6 911.7 9278.0 9355.3 9489.3 9489.8 9668.6 372809.0 377475.0 377599.0 378104.1 379386.0 76254.2 78426.2 79154.6 79754.0 80541.6 913.3 925.8 939.8 948.7 953.1 14255.4 14775.2 14790.7 15248.5 15765.0 31147.2 32711.8 33361.0 34794.5 35921.8 42263.0 43022.6 44376.6 47993.3 50650.0 7621.9 7646.0 7695.5 7962.3 7965.5 7883.4 11061.0 11118.5 11327.9 11865.0 9960.0 10013.3 10022.3 10089.5 10272.1 9865.3 9973.1 10009.1 10119.5 10129.3 5280.9 6733.9 10016.7 10528.8 10586.6 6486.5 6874.5 7038.0 7067.3 8156.8 8483.2 9883.3 10022.6 10110.6 10135.6 16:55:21 INFO - PROCESS | 7813 | 16:55:21 INFO - PROCESS | 7813 | [#3] mootools.html Cycles:180 Average:5051.24 Median:5143.49 stddev:2770.67 (53.9%) stddev-sans-first:2763.99 16:55:21 INFO - PROCESS | 7813 | Values: 1284.8 1435.0 1464.5 1565.2 1750.7 7297.2 7573.9 7616.3 7629.4 7629.5 7362.1 7505.4 7510.5 7513.1 7552.1 1935.5 1991.0 1997.5 2069.1 2103.1 2208.6 2270.9 2271.4 2273.1 2274.6 2178.1 2218.2 2218.2 2226.4 2227.9 1895.6 2168.3 2183.9 2187.4 2192.7 2202.1 2222.5 2227.4 2229.8 2231.0 7508.0 7545.0 7559.6 7564.8 7569.1 4418.9 4558.7 4570.0 4570.9 4574.4 2790.7 2959.5 2979.2 2993.8 3005.0 922.0 943.9 954.8 957.9 969.7 10397.5 10416.6 10428.0 10446.7 10451.4 4093.6 4176.1 4315.4 4343.7 4348.8 8948.8 8960.2 8967.9 8973.2 9004.3 4711.1 4727.0 4739.6 4740.6 4756.9 3690.5 3750.6 3934.9 4297.1 4308.4 3348.6 3474.7 3770.5 3776.2 3778.2 1212.9 1226.5 1229.8 1234.2 1246.9 842.1 843.8 863.2 882.9 886.7 4948.3 5136.9 5150.1 5165.1 5190.9 416.8 420.2 420.5 424.6 887.1 3731.9 3876.2 3876.3 3878.2 3957.1 8800.6 9140.6 9236.0 9239.1 9263.1 9072.0 9086.3 9108.0 9155.7 9164.5 6955.2 7069.2 7082.7 7110.5 7110.9 5172.7 5385.4 5390.7 5476.7 5631.5 8647.6 8816.4 8854.1 8922.1 8938.3 8472.4 8575.1 8677.8 8761.2 8778.5 6567.8 6720.4 6728.9 6733.8 6737.2 6473.8 7045.3 7232.3 7274.7 7276.3 6420.5 6528.1 6594.0 6674.4 6878.8 6497.1 6543.0 6626.8 6715.2 6752.1 6132.9 6199.6 6200.8 6209.8 6275.1 4596.0 4631.4 4656.4 4668.4 4729.6 4710.1 4739.2 4765.2 4830.6 4926.7 16:55:21 INFO - PROCESS | 7813 | 16:55:21 INFO - PROCESS | 7813 | [#4] prototype.html Cycles:180 Average:4494.72 Median:5138.27 stddev:1298.69 (25.3%) stddev-sans-first:1263.82 16:55:21 INFO - PROCESS | 7813 | Values: 312.1 312.4 316.0 321.6 322.5 5124.4 5166.8 5184.3 5216.0 5231.1 5095.4 5124.9 5132.1 5137.6 5139.0 3806.6 3867.2 4020.3 4022.3 4044.2 3999.8 4010.4 4027.4 4030.7 4033.7 3774.5 3989.3 3995.3 3995.6 4007.5 3917.2 4015.6 4021.5 4026.3 4033.4 3551.6 3553.4 3557.3 3570.7 3577.4 4931.1 4932.4 4940.9 4955.1 4959.7 4494.6 4541.2 4645.0 4646.6 4652.9 5385.4 5386.8 5397.5 5415.8 5417.2 3885.4 3886.7 3912.2 3912.6 3912.8 5479.8 5667.6 5677.0 5694.3 5713.0 4007.0 4012.6 4025.2 4031.5 4033.8 4067.7 4069.7 4077.8 4092.4 4100.8 4359.2 4584.4 4601.8 4618.0 4624.7 5371.6 5384.0 5399.8 5402.9 5421.6 1408.0 1424.4 1428.4 1432.9 1436.3 895.6 949.4 976.7 986.7 997.7 4679.5 4683.3 4691.4 4697.5 4706.7 5487.3 5505.5 5514.7 5540.7 5540.8 4530.8 4660.1 4667.1 4671.6 4779.6 2997.6 3008.0 3012.3 3012.3 3019.2 5286.8 5293.1 5304.2 5314.1 5328.9 5540.7 5755.8 5770.1 5775.3 5788.4 5283.4 5299.6 5302.1 5304.8 5305.4 5373.0 5634.9 5636.5 5640.9 5644.4 5512.8 5524.7 5528.5 5541.7 5545.2 5230.9 5259.2 5278.9 5288.3 5321.6 3702.4 3878.5 3901.6 3913.5 3920.5 5565.3 5581.2 5598.1 5607.1 5613.9 5386.8 5400.2 5406.9 5409.1 5435.4 5243.9 5391.1 5414.5 5434.7 5437.7 5018.6 5270.9 5309.8 5317.4 5334.6 5290.1 5294.6 5328.6 5345.6 5349.3 5309.2 5329.4 5329.6 5342.9 5364.7 16:55:21 INFO - PROCESS | 7813 | 16:55:21 INFO - PROCESS | 7813 | [#5] yui.html Cycles:180 Average:12379.35 Median:21690.32 stddev:14007.24 (64.6%) stddev-sans-first:14018.83 16:55:21 INFO - PROCESS | 7813 | Values: 648.4 702.8 708.6 715.5 722.9 11425.9 12349.6 12385.6 12421.1 12424.9 12306.1 12357.0 12360.5 12375.5 12384.5 624.8 767.6 792.3 798.8 800.8 790.1 790.8 794.4 797.3 798.6 843.7 848.7 849.4 849.6 849.7 667.0 803.4 830.7 830.8 831.4 609.7 611.3 612.2 612.4 612.4 10727.0 10747.1 10748.7 10777.8 10797.5 11396.6 11984.6 12141.5 12197.6 12506.8 9936.9 9974.8 10064.8 10066.5 10196.1 3279.4 3289.3 3321.9 3339.7 3387.9 44624.6 45148.0 45794.5 45830.3 45839.0 9058.0 9314.9 9438.8 9518.6 9713.4 16831.0 16862.2 16887.7 16909.2 16958.3 5993.4 6087.7 6136.8 6271.6 6430.6 3358.7 3515.9 3586.6 3653.0 3703.8 2610.8 2685.0 2687.9 2696.3 2697.5 439.1 464.9 480.1 480.5 524.0 475.5 527.6 571.0 574.3 577.3 7783.5 7917.7 8272.8 8362.0 8525.3 530.7 532.8 535.2 584.8 627.3 3805.9 3837.8 3843.6 3902.3 3971.7 44729.6 46134.3 56945.7 57215.0 57265.0 41612.4 42231.8 42332.6 42941.6 44082.3 39353.6 39419.6 39686.0 40319.6 41094.4 7971.4 8169.9 8326.4 8403.9 8554.4 28268.9 28320.3 28416.6 28619.0 28963.3 36188.0 37940.6 38093.8 38264.2 38761.6 9696.7 10556.6 10572.4 10916.8 10942.1 11586.3 11798.1 11815.0 12147.2 12157.3 10714.4 10896.2 10919.3 10923.5 11116.9 10104.4 10229.1 10428.8 10571.5 10572.6 10499.9 10551.0 10609.2 10829.1 10943.7 9196.4 9421.3 9460.0 9461.7 9557.7 8836.6 8846.9 9073.7 9156.7 9367.3 16:55:21 INFO - PROCESS | 7813 | -------- Summary: end -------- 16:55:21 INFO - PROCESS | 7813 | 16:55:22 INFO - TEST-INFO | 7813: exit 0 16:55:22 INFO - TEST-OK | dromaeo_css | took 1118153ms 16:55:22 INFO - TEST-START | kraken 16:55:22 INFO - operating with platform_type : linux_ 16:55:22 INFO - Initialising browser for kraken test... 16:55:22 INFO - TEST-INFO | started process 7994 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7HacyZ/profile http://localhost:49228/getInfo.html) 16:55:26 INFO - PROCESS | 7994 | __metrics Screen width/height:1600/1200 16:55:26 INFO - PROCESS | 7994 | colorDepth:24 16:55:26 INFO - PROCESS | 7994 | Browser inner width/height: 1024/697 16:55:26 INFO - PROCESS | 7994 | __metrics 16:55:27 ERROR - PROCESS | 7994 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:55:28 INFO - TEST-INFO | 7994: exit 0 16:55:28 INFO - Browser initialized. 16:55:28 INFO - Running cycle 1/1 for kraken test... 16:55:28 INFO - TEST-INFO | started process 8073 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7HacyZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:55:40 INFO - PROCESS | 8073 | RSS: Main: 154128384 16:55:40 INFO - PROCESS | 8073 | 16:55:43 INFO - PROCESS | 8073 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49228/tests/kraken/driver.html?testName=audio-beat-detection) 16:55:44 INFO - PROCESS | 8073 | RSS: Main: 209547264 16:55:44 INFO - PROCESS | 8073 | 16:55:46 INFO - PROCESS | 8073 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49228/tests/kraken/driver.html?testName=audio-dft) 16:55:47 INFO - PROCESS | 8073 | RSS: Main: 195104768 16:55:47 INFO - PROCESS | 8073 | 16:55:50 INFO - PROCESS | 8073 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49228/tests/kraken/driver.html?testName=audio-fft) 16:55:51 INFO - PROCESS | 8073 | RSS: Main: 265814016 16:55:51 INFO - PROCESS | 8073 | 16:55:53 INFO - PROCESS | 8073 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49228/tests/kraken/driver.html?testName=audio-oscillator) 16:55:54 INFO - PROCESS | 8073 | RSS: Main: 173834240 16:55:54 INFO - PROCESS | 8073 | 16:55:56 INFO - PROCESS | 8073 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49228/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:55:56 INFO - PROCESS | 8073 | RSS: Main: 178606080 16:55:56 INFO - PROCESS | 8073 | 16:56:00 INFO - PROCESS | 8073 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49228/tests/kraken/driver.html?testName=imaging-darkroom) 16:56:00 INFO - PROCESS | 8073 | RSS: Main: 213815296 16:56:00 INFO - PROCESS | 8073 | 16:56:04 INFO - PROCESS | 8073 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49228/tests/kraken/driver.html?testName=imaging-desaturate) 16:56:04 INFO - PROCESS | 8073 | RSS: Main: 214831104 16:56:04 INFO - PROCESS | 8073 | 16:56:07 INFO - PROCESS | 8073 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49228/tests/kraken/driver.html?testName=json-parse-financial) 16:56:08 INFO - PROCESS | 8073 | RSS: Main: 215322624 16:56:08 INFO - PROCESS | 8073 | 16:56:09 INFO - PROCESS | 8073 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49228/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:56:10 INFO - PROCESS | 8073 | RSS: Main: 204292096 16:56:10 INFO - PROCESS | 8073 | 16:56:12 INFO - PROCESS | 8073 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49228/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:56:12 INFO - PROCESS | 8073 | RSS: Main: 207216640 16:56:12 INFO - PROCESS | 8073 | 16:56:15 INFO - PROCESS | 8073 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49228/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:56:15 INFO - PROCESS | 8073 | RSS: Main: 221253632 16:56:15 INFO - PROCESS | 8073 | 16:56:18 INFO - PROCESS | 8073 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49228/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:56:19 INFO - PROCESS | 8073 | RSS: Main: 224784384 16:56:19 INFO - PROCESS | 8073 | 16:56:22 INFO - PROCESS | 8073 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49228/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:56:22 INFO - PROCESS | 8073 | RSS: Main: 219607040 16:56:22 INFO - PROCESS | 8073 | 16:56:24 INFO - PROCESS | 8073 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49228/tests/kraken/driver.html?testName=ai-astar) 16:56:24 INFO - PROCESS | 8073 | RSS: Main: 282193920 16:56:24 INFO - PROCESS | 8073 | 16:56:24 INFO - PROCESS | 8073 | __start_tp_report 16:56:24 INFO - PROCESS | 8073 | _x_x_mozilla_page_load 16:56:24 INFO - PROCESS | 8073 | _x_x_mozilla_page_load_details 16:56:24 INFO - PROCESS | 8073 | |i|pagename|runs| 16:56:24 INFO - PROCESS | 8073 | |0;ai-astar;113;114;110;115;113;113;103;112;112;115 16:56:24 INFO - PROCESS | 8073 | |1;audio-beat-detection;161;135;156;192;141;156;155;137;182;133 16:56:24 INFO - PROCESS | 8073 | |2;audio-dft;162;162;162;161;163;161;162;163;163;162 16:56:24 INFO - PROCESS | 8073 | |3;audio-fft;74;73;102;104;74;72;73;119;101;74 16:56:24 INFO - PROCESS | 8073 | |4;audio-oscillator;92;93;151;94;94;93;153;94;93;139 16:56:24 INFO - PROCESS | 8073 | |5;imaging-gaussian-blur;117;117;116;117;117;116;116;117;118;117 16:56:24 INFO - PROCESS | 8073 | |6;imaging-darkroom;148;148;147;148;147;151;148;149;148;146 16:56:24 INFO - PROCESS | 8073 | |7;imaging-desaturate;96;95;94;96;95;95;95;95;94;94 16:56:24 INFO - PROCESS | 8073 | |8;json-parse-financial;63;65;64;64;65;66;64;79;62;63 16:56:24 INFO - PROCESS | 8073 | |9;json-stringify-tinderbox;64;64;65;64;64;65;65;65;64;66 16:56:24 INFO - PROCESS | 8073 | |10;stanford-crypto-aes;78;79;79;88;79;81;80;79;85;83 16:56:24 INFO - PROCESS | 8073 | |11;stanford-crypto-ccm;136;132;132;131;133;132;137;142;165;133 16:56:24 INFO - PROCESS | 8073 | |12;stanford-crypto-pbkdf2;173;175;172;175;180;172;173;175;173;175 16:56:24 INFO - PROCESS | 8073 | |13;stanford-crypto-sha256-iterative;73;73;73;73;73;71;72;73;74;70 16:56:24 INFO - PROCESS | 8073 | __end_tp_report 16:56:24 INFO - PROCESS | 8073 | __start_cc_report 16:56:24 INFO - PROCESS | 8073 | _x_x_mozilla_cycle_collect,1869 16:56:24 INFO - PROCESS | 8073 | __end_cc_report 16:56:24 INFO - PROCESS | 8073 | __startTimestamp1461023784719__endTimestamp 16:56:24 INFO - PROCESS | 8073 | 16:56:24 INFO - PROCESS | 8073 | ------- Summary: start ------- 16:56:24 INFO - PROCESS | 8073 | Number of tests: 14 16:56:24 INFO - PROCESS | 8073 | 16:56:24 INFO - PROCESS | 8073 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:3.50 (3.1%) stddev-sans-first:3.69 16:56:24 INFO - PROCESS | 8073 | Values: 113.0 114.0 110.0 115.0 113.0 113.0 103.0 112.0 112.0 115.0 16:56:24 INFO - PROCESS | 8073 | 16:56:24 INFO - PROCESS | 8073 | [#1] audio-beat-detection Cycles:10 Average:154.80 Median:156.00 stddev:19.83 (12.7%) stddev-sans-first:20.91 16:56:24 INFO - PROCESS | 8073 | Values: 161.0 135.0 156.0 192.0 141.0 156.0 155.0 137.0 182.0 133.0 16:56:24 INFO - PROCESS | 8073 | 16:56:24 INFO - PROCESS | 8073 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 16:56:24 INFO - PROCESS | 8073 | Values: 162.0 162.0 162.0 161.0 163.0 161.0 162.0 163.0 163.0 162.0 16:56:24 INFO - PROCESS | 8073 | 16:56:24 INFO - PROCESS | 8073 | [#3] audio-fft Cycles:10 Average:86.60 Median:73.00 stddev:17.82 (24.4%) stddev-sans-first:18.30 16:56:24 INFO - PROCESS | 8073 | Values: 74.0 73.0 102.0 104.0 74.0 72.0 73.0 119.0 101.0 74.0 16:56:24 INFO - PROCESS | 8073 | 16:56:24 INFO - PROCESS | 8073 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:93.00 stddev:26.52 (28.5%) stddev-sans-first:27.35 16:56:24 INFO - PROCESS | 8073 | Values: 92.0 93.0 151.0 94.0 94.0 93.0 153.0 94.0 93.0 139.0 16:56:24 INFO - PROCESS | 8073 | 16:56:24 INFO - PROCESS | 8073 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 16:56:24 INFO - PROCESS | 8073 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 116.0 117.0 118.0 117.0 16:56:24 INFO - PROCESS | 8073 | 16:56:24 INFO - PROCESS | 8073 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:1.33 (0.9%) stddev-sans-first:1.41 16:56:24 INFO - PROCESS | 8073 | Values: 148.0 148.0 147.0 148.0 147.0 151.0 148.0 149.0 148.0 146.0 16:56:24 INFO - PROCESS | 8073 | 16:56:24 INFO - PROCESS | 8073 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 16:56:24 INFO - PROCESS | 8073 | Values: 96.0 95.0 94.0 96.0 95.0 95.0 95.0 95.0 94.0 94.0 16:56:24 INFO - PROCESS | 8073 | 16:56:24 INFO - PROCESS | 8073 | [#8] json-parse-financial Cycles:10 Average:65.50 Median:64.50 stddev:4.88 (7.6%) stddev-sans-first:5.09 16:56:24 INFO - PROCESS | 8073 | Values: 63.0 65.0 64.0 64.0 65.0 66.0 64.0 79.0 62.0 63.0 16:56:24 INFO - PROCESS | 8073 | 16:56:24 INFO - PROCESS | 8073 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 16:56:24 INFO - PROCESS | 8073 | Values: 64.0 64.0 65.0 64.0 64.0 65.0 65.0 65.0 64.0 66.0 16:56:24 INFO - PROCESS | 8073 | 16:56:24 INFO - PROCESS | 8073 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:80.50 stddev:3.25 (4.0%) stddev-sans-first:3.24 16:56:24 INFO - PROCESS | 8073 | Values: 78.0 79.0 79.0 88.0 79.0 81.0 80.0 79.0 85.0 83.0 16:56:24 INFO - PROCESS | 8073 | 16:56:24 INFO - PROCESS | 8073 | [#11] stanford-crypto-ccm Cycles:10 Average:137.30 Median:134.50 stddev:10.29 (7.6%) stddev-sans-first:10.90 16:56:24 INFO - PROCESS | 8073 | Values: 136.0 132.0 132.0 131.0 133.0 132.0 137.0 142.0 165.0 133.0 16:56:24 INFO - PROCESS | 8073 | 16:56:24 INFO - PROCESS | 8073 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.30 Median:175.00 stddev:2.36 (1.3%) stddev-sans-first:2.46 16:56:24 INFO - PROCESS | 8073 | Values: 173.0 175.0 172.0 175.0 180.0 172.0 173.0 175.0 173.0 175.0 16:56:24 INFO - PROCESS | 8073 | 16:56:24 INFO - PROCESS | 8073 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:73.00 stddev:1.18 (1.6%) stddev-sans-first:1.24 16:56:24 INFO - PROCESS | 8073 | Values: 73.0 73.0 73.0 73.0 73.0 71.0 72.0 73.0 74.0 70.0 16:56:24 INFO - PROCESS | 8073 | -------- Summary: end -------- 16:56:24 INFO - PROCESS | 8073 | 16:56:25 INFO - TEST-INFO | 8073: exit 0 16:56:25 INFO - TEST-OK | kraken | took 63133ms 16:56:25 INFO - SUITE-END | took 1181s 16:56:25 INFO - Completed test suite (00:19:41) 16:56:25 INFO - javascript benchmark 16:56:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2616.764491195792, 2681.4503026879493, 2696.7572918437336, 2708.038646280569, 2724.0057379056643, 4587.632989360852, 4671.159191345557, 4675.018246168304, 4680.882977925554, 4685.695429797065, 4708.199606066968, 4765.737884416364, 4835.951640483594, 4837.830675926343, 4848.6363522735755, 4216.915661686764, 4272.060146767706, 4282.914341713164, 4335.0679603885155, 4432.11357728454, 4337.067530480946, 4379.255526560492, 4391.802368893392, 4394.055278115205, 4429.313456414245, 4229.894252643709, 4239.173361194568, 4308.526062133163, 4315.287977483711, 4340.262155433568, 4293.205756934977, 4306.181825453154, 4316.115196384765, 4317.222899878021, 4362.389265502832, 4286.164197981395, 4286.357046443059, 4300.290452075404, 4312.22379971605, 4341.696081274312, 4497.168023915586, 4569.177548041352, 4601.2637977923705, 4664.300354946785, 4671.369365135697, 4821.638377121695, 5072.061668591323, 5090.694558326512, 5091.0581542414775, 5141.280220769096, 5086.41506226785, 5091.236314552847, 5098.745062746885, 5103.642745007851, 5149.536541711226, 4590.678652494326, 4678.883027924329, 4712.9057418851435, 4747.2879068140055, 4751.881202969954, 5143.254228136899, 5151.0470562945975, 5161.071007218661, 5163.0, 5164.457731938168, 4828.2998965150555, 4958.107540642719, 4961.206207006861, 4962.528559786814, 5005.849824505271, 5019.7239151847, 5042.520960508746, 5073.365829271341, 5111.514406131411, 5116.692998420107, 4988.152014157529, 5020.246962955513, 5024.79900803971, 5025.924611130836, 5073.568746656501, 4879.658423910292, 4956.90086198274, 4989.850304490871, 5013.298138260647, 5016.372953380827, 4262.65898728101, 4265.488141422987, 4287.164003019381, 4291.935620965688, 4306.160298741778, 3706.981465092711, 3718.7396882217986, 3722.925541489155, 3746.7751934883995, 3762.981185094112, 4210.473690788652, 4266.381374700651, 4276.57234276576, 4278.63631591312, 4284.464441944757, 5016.54851063406, 5041.899162016739, 5048.495150484996, 5094.5669618082875, 5098.1842905135, 4289.463817022872, 4322.37325587788, 4327.415798867176, 4359.956400436018, 4374.4531933508315, 4351.543087975717, 4523.050159466483, 4523.84166554169, 4539.84110556129, 4568.565986231302, 4746.786394612251, 4777.020710754217, 4784.521547845187, 4803.423589169252, 4828.66199366041, 5032.421271553671, 5054.974725126351, 5074.31496747949, 5081.288619593334, 5114.590832733298, 4623.514530974199, 4745.525447455227, 4783.7129772213775, 4797.952020479751, 4798.688085274446, 4979.925301120414, 4987.12725273083, 5003.124453220745, 5033.823816166417, 5047.1419858623385, 5048.823291184791, 5067.062593420229, 5067.771950262173, 5071.264666623245, 5118.181091025418, 4798.2082956311815, 4821.807127714992, 4886.413630364379, 4909.754512274443, 4954.702717836942, 4838.806447742051, 4854.466008739107, 4864.708117512961, 4866.416030076413, 4912.582430493448, 4789.44921334051, 4791.257355109963, 4792.832250871203, 4794.065157294294, 4838.661293709407, 4771.59441447467, 4853.51464853526, 4932.28481870134, 4938.703677779345, 4967.031428871335, 4749.453812811571, 4763.523647635208, 4771.761411929459, 4809.398825146856, 4823.589994850477], "value": 4619.647057226772, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.7593998490627, 586.3872253495097, 600.1627729317602, 605.6305653551335, 621.1490258346065, 26383.868080659595, 34038.48942265865, 35038.29923401531, 35081.649183508154, 35093.64906350939, 37582.62417375825, 38357.0, 38367.42448863262, 38449.03877403066, 38478.807605962, 7303.963480182618, 7465.477416580841, 7617.80955476112, 7626.122995855492, 9479.194268487152, 9602.231821454301, 9766.853497197548, 9767.218622510181, 9773.755656108584, 9779.951100244489, 9698.175655069328, 9815.067568580973, 9815.705528834147, 9817.067378599022, 9820.705378838646, 7454.291842275003, 9690.32167748258, 9732.562034708455, 10057.145142662883, 10060.798784024351, 9415.576299066559, 9549.570269337826, 9556.904430955741, 9558.522073896278, 9562.56968436422, 34546.654533454595, 35022.12444688903, 35187.648123518695, 35207.295854082775, 35312.64687353145, 3107.3474570340254, 3281.1469018055477, 3414.607320158189, 3535.9469607955903, 3696.131409118855, 28814.0, 28955.276118097005, 29262.122136335944, 29392.559111613344, 29405.70594294051, 3389.118829104426, 3416.1118109291515, 3533.222691007974, 3573.9642603574152, 3589.192431702846, 228606.0, 230981.0, 231893.0, 232418.0, 232618.0, 32882.34235315328, 53358.733206333716, 53515.197272040954, 54020.72989635027, 54042.189367159524, 32038.83980580082, 32318.676813231566, 32343.0, 32345.838270808967, 32358.83820580929, 13679.110857794212, 13793.310334483436, 13916.860831391556, 13919.443222271198, 13927.721445571031, 9637.37357071788, 11229.157813164045, 11483.885161148282, 11498.540058397737, 11499.770004600028, 7995.1605081465605, 8006.1993800619475, 8038.83922321562, 8101.675932962733, 8125.187481251945, 3178.634457037424, 3181.904542863718, 3190.3729098159642, 3213.775035747475, 3229.4671379222636, 929.656027269901, 936.6066252173968, 984.9803003939882, 996.5366104761321, 1114.5820317380983, 28110.71889281122, 28285.858570707427, 28607.141785746462, 28660.0, 28785.0, 996.1283876607968, 999.5901680311183, 1000.2797985450464, 1039.9480025998669, 1043.1446214104512, 14655.853441465662, 15179.848201518063, 15229.847701523064, 15389.153596552072, 15471.14908680011, 327962.0, 328968.0, 329673.0, 332571.0, 332683.0, 48872.5112748875, 49834.50165498371, 49838.252426213636, 49860.750696247014, 49889.75055124701, 1096.714854137914, 1208.9939550302192, 1246.4266437438698, 1288.0339745191106, 1288.909776315649, 25731.614025790004, 27909.302267443476, 27976.440471190053, 28462.43075138527, 28640.57039144373, 39329.803350983064, 39665.206695865345, 39807.2038559233, 39863.800680996406, 39887.800560997006, 223960.0, 225655.0, 225670.0, 226541.0, 226847.0, 22905.19831805879, 25310.873445632653, 25877.0, 26079.478410432064, 26129.778968787865, 35923.640763592026, 39078.0, 40456.39315410212, 40699.389509157976, 41333.58666413297, 34272.0, 34321.313573727886, 34451.0, 34991.65008349884, 35157.0, 33545.66454335523, 33881.83059084689, 34242.82878585591, 34414.0, 34499.310013799084, 34269.82865085659, 34360.14099647529, 34688.306233874675, 34792.47811282883, 34805.825970869984, 29927.251818703837, 30554.236144095685, 30928.53607195849, 30974.53538196884, 31070.22324441907, 23946.28161155168, 24340.634890477013, 24504.632430513913, 24615.384615384042, 24636.753632464162], "value": 16453.800772835264, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.7367779393321, 382.4817372460318, 387.18883938149577, 393.21161072050535, 397.5706237263755, 15725.449609263664, 16933.238004289804, 16993.83006169938, 17105.9736415815, 17140.14299285037, 15651.608709782262, 16035.438759643415, 16363.181840907966, 16378.918105409486, 16401.42595009175, 5099.15863882459, 5230.973845130769, 5265.394479634833, 5268.736563171845, 5269.789208431658, 3657.7988210648405, 5584.91622625661, 6110.633361998294, 6121.66330851803, 6131.3562075982045, 6040.033594624861, 6040.637561746287, 6078.088286757, 6084.634921904678, 6254.499640028809, 6543.312952140028, 6576.177977752781, 6585.670716464181, 6594.043863639793, 6611.173603299588, 3830.8276127574327, 6121.540884433641, 6516.218053833571, 6522.7390904363765, 6531.216254049545, 21397.78602213989, 21815.45461363463, 22160.778392216034, 23022.73374964376, 23109.76890231093, 1906.752122224102, 1976.802319768026, 1987.920483180671, 1995.9002049897447, 2152.5156839711094, 14151.504697335544, 14289.356978935974, 14577.416903323854, 14650.853491465055, 15004.324805383783, 1821.3261093395529, 1889.8439605858111, 1917.213942283657, 1922.9615407691767, 1931.777845547766, 78287.0, 80212.59893700494, 80671.59664201758, 81211.18788812096, 84391.15608843956, 14433.24245336676, 15880.364785408685, 15948.840511594968, 15987.60030999211, 16243.51269461918, 29569.55645665317, 29616.111516654535, 29653.0, 29739.553906691417, 29761.25596860096, 8583.0, 8638.17937295956, 8700.608472618747, 8744.02014060979, 8854.955725221333, 7046.788596342118, 7241.565506069547, 7368.263173682589, 7413.0, 7488.438367122379, 8210.137935516685, 8338.166183381612, 8373.790655233546, 8468.745937621881, 8548.658053677784, 2547.0, 3151.795133316327, 3322.2192784695576, 3397.5413319202084, 3638.272345530904, 867.9132086791396, 879.445949052093, 925.8981512033671, 1008.1078245752415, 1014.5434554450527, 15570.844291557167, 15641.530754077396, 16895.0, 17095.316187352615, 17166.0, 876.5398165962921, 900.6847603338779, 902.9413088149249, 904.6110172625703, 911.6672414568767, 9278.0, 9355.345125841126, 9489.335746497816, 9489.762755931157, 9668.613255469843, 372809.0, 377475.0, 377599.0, 378104.10947945085, 379386.0, 76254.23745762583, 78426.21573784303, 79154.6042269785, 79754.0, 80541.59729201316, 913.3378300731916, 925.7500474871881, 939.8261321655516, 948.7438391634358, 953.1469334945185, 14255.358508866919, 14775.187364695044, 14790.704185916005, 15248.542543723706, 15765.0, 31147.221319467193, 32711.836440817642, 33360.99917002494, 34794.478082829286, 35921.820390897876, 42263.0, 43022.569774303105, 44376.55623443853, 47993.28010079782, 50650.0, 7621.885671714817, 7646.0, 7695.461317707706, 7962.283394494523, 7965.4822436541435, 7883.448158628841, 11061.0, 11118.49966751482, 11327.886721133013, 11865.0, 9959.950200248952, 10013.349132306668, 10022.298439109192, 10089.545970431494, 10272.126869215901, 9865.260105491972, 9973.102420781874, 10009.149222316184, 10119.544620491948, 10129.341592796445, 5280.947190528199, 6733.865322693617, 10016.694490818158, 10528.78942421132, 10586.576536938745, 6486.513511486752, 6874.4844136690945, 7038.049863268393, 7067.2579379164445, 8156.755297341089, 8483.236508714246, 9883.308168428428, 10022.649207277711, 10110.595576176871, 10135.64525241613], "value": 9018.114127926983, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1284.7687416265069, 1434.992825035875, 1464.5020692964392, 1565.1782814022636, 1750.6936286149928, 7297.233790451999, 7573.886391704129, 7616.314531692146, 7629.427792915526, 7629.542227466356, 7362.079740032496, 7505.399568034558, 7510.549367037968, 7513.098428188611, 7552.055993000875, 1935.4774210963033, 1991.0, 1997.5205950571903, 2069.0689189864547, 2103.064136459276, 2208.5914105890383, 2270.8751018693965, 2271.375371772759, 2273.1134857405623, 2274.55646149001, 2178.0525471419905, 2218.223621732397, 2218.234709025384, 2226.4100013496436, 2227.877466739337, 1895.6113996630795, 2168.316980151263, 2183.9235626753066, 2187.3656639574583, 2192.7149470568884, 2202.108146200775, 2222.533268013719, 2227.4431392151964, 2229.8104661103825, 2230.966535501969, 7507.9624601877185, 7545.0, 7559.622018899033, 7564.810879727996, 7569.129550101754, 4418.917365245503, 4558.658100642465, 4569.954300456986, 4570.908581828345, 4574.428196475441, 2790.652761684032, 2959.4672958867395, 2979.1658335666048, 2993.760499160084, 3005.008347245404, 922.0226559846584, 943.9056094390575, 954.7613096725819, 957.8802649668792, 969.7381706939158, 10397.480125993745, 10416.5833366666, 10428.009339112772, 10446.68659940203, 10451.425171615558, 4093.6111069448357, 4176.1230141669985, 4315.417418648442, 4343.718603012119, 4348.782560872007, 8948.776280593038, 8960.1935825776, 8967.865482017774, 8973.192412682889, 9004.279657627374, 4711.057788442326, 4726.976365118221, 4739.644526660514, 4740.597049250852, 4756.9286460703115, 3690.5202323698286, 3750.6249375062275, 3934.9213015739524, 4297.05464797744, 4308.4399028126145, 3348.5646865907274, 3474.6699063588917, 3770.45328427382, 3776.2258736958856, 3778.244351129785, 1212.933288669114, 1226.45422786859, 1229.7601967616229, 1234.234774439853, 1246.8503779546513, 842.149429076637, 843.8143608406141, 863.2360361080489, 882.9293656507464, 886.6542048601051, 4948.331975183376, 5136.897262054813, 5150.072986862326, 5165.147750621106, 5190.870228244324, 416.8207670701567, 420.2456590420203, 420.4912056411715, 424.6454210734072, 887.0907319997054, 3731.850725970931, 3876.2247550490015, 3876.3022655922205, 3878.185581028016, 3957.050307926135, 8800.559972001502, 9140.63437462494, 9235.95382023099, 9239.122283383067, 9263.120003599648, 9072.00207977122, 9086.318526110568, 9108.0, 9155.725328240163, 9164.541772911462, 6955.1653801544135, 7069.151701795818, 7082.681279342442, 7110.537815042109, 7110.857782844314, 5172.7155006475, 5385.380681221553, 5390.730463476889, 5476.72616369172, 5631.465010823965, 8647.56762161902, 8816.426932249384, 8854.070322616033, 8922.107789221025, 8938.329625278, 8472.406931514735, 8575.142485751376, 8677.826443471222, 8761.211490965843, 8778.473291602524, 6567.802965911031, 6720.428763555153, 6728.932710672831, 6733.764318248838, 6737.157855268091, 6473.77341793035, 7045.330693584101, 7232.276772322725, 7274.672639731119, 7276.345128938421, 6420.454261387835, 6528.053432252392, 6593.96703016501, 6674.43267322283, 6878.759243426456, 6497.122888410193, 6543.0, 6626.801195964129, 6715.1941766988275, 6752.122224110834, 6132.938670613236, 6199.628022318675, 6200.7519699211525, 6209.782657606962, 6275.121482992294, 4596.0, 4631.444226692818, 4656.394668693184, 4668.416447944007, 4729.621630269639, 4710.105080034782, 4739.21802902531, 4765.237561990065, 4830.637702172281, 4926.679765815211], "value": 4059.542118720114, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.0560305077141, 312.38772006866543, 315.9763017773667, 321.57873186126193, 322.5436008048613, 5124.38581846718, 5166.844994650157, 5184.300119483869, 5216.0, 5231.0845602019635, 5095.439501654815, 5124.923126153101, 5132.050570644434, 5137.56330711889, 5138.9743051284695, 3806.638369354907, 3867.1878905429894, 4020.336644453662, 4022.296098182821, 4044.211378781124, 3999.760014399131, 4010.3984402339593, 4027.436158937751, 4030.6976976726714, 4033.6773058155422, 3774.4904437900946, 3989.341758609826, 3995.320795464778, 3995.5604883462797, 4007.519097708279, 3917.216556688674, 4015.6307778410733, 4021.4973128358956, 4026.295398305285, 4033.3949907513816, 3551.5738111426795, 3553.4492153716214, 3557.3063252665743, 3570.732195085353, 3577.4276115821344, 4931.0630980113665, 4932.383452068491, 4940.901181976376, 4955.058538877602, 4959.677620954626, 4494.617957473619, 4541.182587134314, 4644.9535504644855, 4646.605038571725, 4652.930206046912, 5385.380681221671, 5386.78452861885, 5397.487238712316, 5415.810446634349, 5417.241586177938, 3885.436611691289, 3886.650201481852, 3912.158885839558, 3912.6478616924614, 3912.7652340859354, 5479.7509023838675, 5667.603267771257, 5677.0, 5694.288213973254, 5713.029004993271, 4006.959930400717, 4012.558618551957, 4025.1748391579654, 4031.4557534732435, 4033.7983100845427, 4067.654249388835, 4069.7354671946227, 4077.8368865245056, 4092.4066010428323, 4100.815463304159, 4359.193549193409, 4584.40980845821, 4601.838935637236, 4617.953820461819, 4624.745638989821, 5371.57027437804, 5384.038778671715, 5399.83800485986, 5402.945970540244, 5421.566274698014, 1408.0425310788557, 1424.444466658004, 1428.407211007441, 1432.8710416062604, 1436.3249272841747, 895.6193617712446, 949.4350861237552, 976.72651657536, 986.6941248213077, 997.6907158780801, 4679.508651591602, 4683.344331793552, 4691.437027556647, 4697.459792123949, 4706.7411292378565, 5487.341519017744, 5505.476979686923, 5514.724263786795, 5540.695261760642, 5540.833774986757, 4530.79611417487, 4660.114578230193, 4667.113248482778, 4671.556202160789, 4779.641526885497, 2997.6103106596, 3007.9849600752295, 3012.29211135383, 3012.29211135383, 3019.245188702824, 5286.762095705702, 5293.12663410533, 5304.204369344629, 5314.050701860428, 5328.866778330573, 5540.667559946416, 5755.769769209269, 5770.124709469355, 5775.303805564442, 5788.421157884178, 5283.365996080495, 5299.629025968223, 5302.098643230583, 5304.761285742151, 5305.4164041955355, 5372.973135134299, 5634.887302254014, 5636.520895723909, 5640.85897852557, 5644.435556444323, 5512.834614961557, 5524.696141712245, 5528.502434780889, 5541.667499950016, 5545.170093868933, 5230.869228269324, 5259.184826351921, 5278.920816187837, 5288.338957630296, 5321.627486075938, 3702.444633305026, 3878.4570160178164, 3901.6293452122004, 3913.5499417567344, 3920.4707364505425, 5565.276514053147, 5581.218629391969, 5598.076317407745, 5607.102863541813, 5613.943860561342, 5386.757595908115, 5400.216968539461, 5406.918896216481, 5409.134538473825, 5435.402105768283, 5243.868903277448, 5391.137418013099, 5414.539764120094, 5434.673919564681, 5437.673739575638, 5018.648694591344, 5270.920936186037, 5309.787608495617, 5317.441668624739, 5334.599905007062, 5290.100682883842, 5294.629375943801, 5328.626996110235, 5345.599080069088, 5349.304590403222, 5309.177077552986, 5329.44040875718, 5329.600279978939, 5342.919856202082, 5364.7049412282695], "value": 4085.5540298838373, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [648.4002297874466, 702.7540360873695, 708.6067232685857, 715.5492040014793, 722.949393542452, 11425.885741142585, 12349.567765128222, 12385.56650517232, 12421.130520863544, 12424.875751242496, 12306.077044221696, 12357.0, 12360.50557977682, 12375.50497980082, 12384.50461981522, 624.7813265357134, 767.5548182054423, 792.2750683124934, 798.8442253760519, 800.7797855589702, 790.0637744273026, 790.7548659915444, 794.4002278279919, 797.2744802229972, 798.5767543202112, 843.7004863273542, 848.6647774129216, 849.3757088539918, 849.5794581682076, 849.6898631999337, 667.0328024364691, 803.4175222963363, 830.6511265268541, 830.8130670599128, 831.3681601982477, 609.7195290166529, 611.3214332091375, 612.1980205930201, 612.3509080374772, 612.37843588757, 10727.0, 10747.140228781678, 10748.677539673823, 10777.83833242502, 10797.514111864984, 11396.601118960796, 11984.580539681156, 12141.453634586376, 12197.634070977885, 12506.81239781404, 9936.90063099367, 9974.750631234205, 10064.798704025952, 10066.496675166212, 10196.133328667072, 3279.360524697685, 3289.276359200972, 3321.8671253149846, 3339.699427051577, 3387.915302117442, 44624.553754462366, 45148.0, 45794.54205457936, 45830.31254531185, 45838.999999999665, 9058.0, 9314.86027709585, 9438.811223775623, 9518.619255229853, 9713.417194968184, 16831.0, 16862.24119914607, 16887.662246754997, 16909.23908424124, 16958.321667133423, 5993.370696076936, 6087.6956152192215, 6136.754529818846, 6271.623702577769, 6430.582012169194, 3358.697717205463, 3515.898515675062, 3586.6413358664445, 3652.995426257747, 3703.79629120401, 2610.7911367090587, 2684.9731502685113, 2687.865606719656, 2696.2989622697846, 2697.527932611785, 439.06041072105717, 464.90934267818125, 480.11418932070274, 480.5362824874013, 523.9607029472804, 475.47460056637607, 527.6359312074657, 571.029250274535, 574.2850151561249, 577.3447137498969, 7783.532988020737, 7917.722879699298, 8272.751817445485, 8361.95819020901, 8525.275351595059, 530.6895466152345, 532.7975369359696, 535.2078923193695, 584.8098129104201, 627.3130921640796, 3805.866794662229, 3837.827297771551, 3843.6348546888003, 3902.3366027775346, 3971.6822654187595, 44729.552704473186, 46134.30798538025, 56945.715271424204, 57215.0, 57265.0, 41612.37581436281, 42231.7888410556, 42332.57667423348, 42941.57058429438, 44082.33876491855, 39353.60646393557, 39419.605803941595, 39686.0, 40319.596804031586, 41094.38358424626, 7971.362291016589, 8169.918300816916, 8326.426901832852, 8403.873941890999, 8554.358423118167, 28268.85865570659, 28320.291992700346, 28416.57375139333, 28619.0, 28963.275918102216, 36188.0, 37940.62059379481, 38093.80953095217, 38264.2347153061, 38761.6123838758, 9696.660616878375, 10556.577736890438, 10572.36565806054, 10916.781664366827, 10942.124630029737, 11586.304821710388, 11798.115141364604, 11815.0, 12147.210431321935, 12157.331346775658, 10714.357138571711, 10896.182786290901, 10919.290246133976, 10923.453827308444, 11116.888831111586, 10104.444255566015, 10229.079382855578, 10428.791424171626, 10571.471426428801, 10572.577096916037, 10499.895001050198, 10551.0, 10609.20430967696, 10829.133669306279, 10943.726406839893, 9196.448213107235, 9421.340506164503, 9459.952700236454, 9461.668841590512, 9557.713268601952, 8836.602352894264, 8846.911530884609, 9073.727788166365, 9156.725298241063, 9367.344285899922], "value": 5757.122453680518, "unit": "score"}], "name": "dromaeo_css", "value": 6348.364286038646, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 110.0, 115.0, 113.0, 113.0, 103.0, 112.0, 112.0, 115.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 135.0, 156.0, 192.0, 141.0, 156.0, 155.0, 137.0, 182.0, 133.0], "value": 154.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 161.0, 163.0, 161.0, 162.0, 163.0, 163.0, 162.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 102.0, 104.0, 74.0, 72.0, 73.0, 119.0, 101.0, 74.0], "value": 86.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 151.0, 94.0, 94.0, 93.0, 153.0, 94.0, 93.0, 139.0], "value": 109.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 118.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 148.0, 147.0, 151.0, 148.0, 149.0, 148.0, 146.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 94.0, 96.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 64.0, 64.0, 65.0, 66.0, 64.0, 79.0, 62.0, 63.0], "value": 65.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 64.0, 64.0, 65.0, 65.0, 65.0, 64.0, 66.0], "value": 64.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 79.0, 88.0, 79.0, 81.0, 80.0, 79.0, 85.0, 83.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 132.0, 132.0, 131.0, 133.0, 132.0, 137.0, 142.0, 165.0, 133.0], "value": 137.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 175.0, 172.0, 175.0, 180.0, 172.0, 173.0, 175.0, 173.0, 175.0], "value": 174.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 73.0, 73.0, 71.0, 72.0, 73.0, 74.0, 70.0], "value": 72.5, "unit": "score"}], "name": "kraken", "value": 1580.0999999999997, "alertThreshold": 2.0}]} 16:56:25 INFO - Return code: 0 16:56:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:56:26 ERROR - # TBPL SUCCESS # 16:56:26 INFO - Running post-action listener: _resource_record_post_action 16:56:26 INFO - Running post-run listener: _resource_record_post_run 16:56:27 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 518152192; Read time: 8; Write time: 422052 16:56:27 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 240705536; Read time: 0; Write time: 214424 16:56:27 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 277446656; Read time: 8; Write time: 207628 16:56:27 INFO - Running post-run listener: _upload_blobber_files 16:56:27 INFO - Blob upload gear active. 16:56:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:56:27 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:56:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:56:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:56:27 INFO - (blobuploader) - INFO - Open directory for files ... 16:56:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:56:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:56:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:56:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:56:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:56:28 INFO - (blobuploader) - INFO - Done attempting. 16:56:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:56:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:56:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:56:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:56:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:56:29 INFO - (blobuploader) - INFO - Done attempting. 16:56:29 INFO - (blobuploader) - INFO - Iteration through files over. 16:56:29 INFO - Return code: 0 16:56:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:56:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:56:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/578c310bdb37797225854cd2b0c4b498a56fb5bc103e29429b9d5bd85d570009450b2d5d3b6fa44f238956d5a83796f87bc3e91d16e6aa51ad38759f4bb4a9e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/309afbe5dcd8f1cf9cde9091f4f0998233e059ea359f5e1ce8fdffec3b1659e03e4fed3bba5eaefd231db84e5cee2a05f99bda385ee4098a8a709872bd1336dd"} 16:56:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:56:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:56:29 INFO - Contents: 16:56:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/578c310bdb37797225854cd2b0c4b498a56fb5bc103e29429b9d5bd85d570009450b2d5d3b6fa44f238956d5a83796f87bc3e91d16e6aa51ad38759f4bb4a9e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/309afbe5dcd8f1cf9cde9091f4f0998233e059ea359f5e1ce8fdffec3b1659e03e4fed3bba5eaefd231db84e5cee2a05f99bda385ee4098a8a709872bd1336dd"} 16:56:29 INFO - Running post-run listener: copy_logs_to_upload_dir 16:56:29 INFO - Copying logs to upload dir... 16:56:29 INFO - mkdir: /builds/slave/test/build/upload/logs 16:56:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.930249 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-04-18 16:56:28.957827) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 16:56:28.961577) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1461022551.688912-1266825473 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-Non-PGO/sha512/578c310bdb37797225854cd2b0c4b498a56fb5bc103e29429b9d5bd85d570009450b2d5d3b6fa44f238956d5a83796f87bc3e91d16e6aa51ad38759f4bb4a9e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/309afbe5dcd8f1cf9cde9091f4f0998233e059ea359f5e1ce8fdffec3b1659e03e4fed3bba5eaefd231db84e5cee2a05f99bda385ee4098a8a709872bd1336dd"} build_url:https://queue.taskcluster.net/v1/task/e7XbNAbVRGqqSCAngJlrZA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011228 build_url: 'https://queue.taskcluster.net/v1/task/e7XbNAbVRGqqSCAngJlrZA/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-Non-PGO/sha512/578c310bdb37797225854cd2b0c4b498a56fb5bc103e29429b9d5bd85d570009450b2d5d3b6fa44f238956d5a83796f87bc3e91d16e6aa51ad38759f4bb4a9e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/309afbe5dcd8f1cf9cde9091f4f0998233e059ea359f5e1ce8fdffec3b1659e03e4fed3bba5eaefd231db84e5cee2a05f99bda385ee4098a8a709872bd1336dd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 16:56:28.990437) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 16:56:28.990774) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1461022551.688912-1266825473 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004461 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 16:56:29.073565) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 16:56:29.074122) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 16:56:29.074612) ========= ========= Total master_lag: 0.18 =========