builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-034 starttime: 1461521433.02 results: success (0) buildid: 20160424083228 builduid: c77c932593e14b929f7acef597cd9748 revision: 463fc6d36ff561f17a34f1688bd8c38833de8966 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-24 11:10:33.025067) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-24 11:10:33.025510) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-24 11:10:33.025785) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-24 11:10:33.063284) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 11:10:33.063533) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1461518772.493648-1610201244 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-24 11:10:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-04-24 11:10:35 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110285 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 11:10:33.188267) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 11:10:33.188560) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1461518772.493648-1610201244 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022795 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 11:10:33.238355) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 11:10:33.238693) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 463fc6d36ff561f17a34f1688bd8c38833de8966 --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 463fc6d36ff561f17a34f1688bd8c38833de8966 --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=d6bbd613908ccac0c6c9cb47000001f7-1461518772.493648-1610201244 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-24 11:10:35,806 truncating revision to first 12 chars 2016-04-24 11:10:35,806 Setting DEBUG logging. 2016-04-24 11:10:35,806 attempt 1/10 2016-04-24 11:10:35,806 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/463fc6d36ff5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-24 11:10:36,097 unpacking tar archive at: fx-team-463fc6d36ff5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.599923 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 11:10:33.852567) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-24 11:10:33.852830) ========= script_repo_revision: 463fc6d36ff561f17a34f1688bd8c38833de8966 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-24 11:10:33.853184) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-24 11:10:33.853436) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-24 11:10:33.861458) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-04-24 11:10:33.861738) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1461518772.493648-1610201244 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:10:36 INFO - MultiFileLogger online at 20160424 11:10:36 in /builds/slave/test 11:10:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:10:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:10:36 INFO - {'append_to_log': False, 11:10:36 INFO - 'base_work_dir': '/builds/slave/test', 11:10:36 INFO - 'blob_upload_branch': 'Fx-Team', 11:10:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:10:36 INFO - 'branch': 'Fx-Team', 11:10:36 INFO - 'buildbot_json_path': 'buildprops.json', 11:10:36 INFO - 'config_files': ('talos/linux_config.py',), 11:10:36 INFO - 'default_actions': ('clobber', 11:10:36 INFO - 'read-buildbot-config', 11:10:36 INFO - 'download-and-extract', 11:10:36 INFO - 'populate-webroot', 11:10:36 INFO - 'create-virtualenv', 11:10:36 INFO - 'install', 11:10:36 INFO - 'run-tests'), 11:10:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:10:36 INFO - 'download_minidump_stackwalk': True, 11:10:36 INFO - 'download_symbols': 'ondemand', 11:10:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:10:36 INFO - 'tooltool.py': '/tools/tooltool.py', 11:10:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:10:36 INFO - '/tools/misc-python/virtualenv.py')}, 11:10:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:10:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:10:36 INFO - 'installer_path': 'installer.exe', 11:10:36 INFO - 'log_level': 'info', 11:10:36 INFO - 'log_name': 'talos', 11:10:36 INFO - 'log_to_console': True, 11:10:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:10:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:10:36 INFO - 'opt_config_files': (), 11:10:36 INFO - 'pip_index': False, 11:10:36 INFO - 'sps_profile': False, 11:10:36 INFO - 'sps_profile_interval': 0, 11:10:36 INFO - 'suite': 'dromaeojs', 11:10:36 INFO - 'system_bits': '32', 11:10:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:10:36 INFO - 'title': 'talos-linux64-ix-034', 11:10:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:10:36 INFO - 'use_talos_json': True, 11:10:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:10:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:10:36 INFO - 'work_dir': 'build'} 11:10:36 INFO - ##### 11:10:36 INFO - ##### Running clobber step. 11:10:36 INFO - ##### 11:10:36 INFO - Running pre-action listener: _resource_record_pre_action 11:10:36 INFO - Running main action method: clobber 11:10:36 INFO - rmtree: /builds/slave/test/build 11:10:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:10:37 INFO - Running post-action listener: _resource_record_post_action 11:10:37 INFO - ##### 11:10:37 INFO - ##### Running read-buildbot-config step. 11:10:37 INFO - ##### 11:10:37 INFO - Running pre-action listener: _resource_record_pre_action 11:10:37 INFO - Running main action method: read_buildbot_config 11:10:37 INFO - Using buildbot properties: 11:10:37 INFO - { 11:10:37 INFO - "project": "", 11:10:37 INFO - "product": "firefox", 11:10:37 INFO - "script_repo_revision": "production", 11:10:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:10:37 INFO - "repository": "", 11:10:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:10:37 INFO - "buildid": "20160424083228", 11:10:37 INFO - "pgo_build": "True", 11:10:37 INFO - "basedir": "/builds/slave/test", 11:10:37 INFO - "buildnumber": 606, 11:10:37 INFO - "slavename": "talos-linux64-ix-034", 11:10:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:10:37 INFO - "platform": "ubuntu64_hw", 11:10:37 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:10:37 INFO - "branch": "fx-team", 11:10:37 INFO - "repo_path": "integration/fx-team", 11:10:37 INFO - "revision": "463fc6d36ff561f17a34f1688bd8c38833de8966", 11:10:37 INFO - "stage_platform": "linux64-pgo", 11:10:37 INFO - "builduid": "c77c932593e14b929f7acef597cd9748", 11:10:37 INFO - "slavebuilddir": "test" 11:10:37 INFO - } 11:10:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/cvwhUmIMSvuOEabPF5qGzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 11:10:37 INFO - Running post-action listener: _resource_record_post_action 11:10:37 INFO - ##### 11:10:37 INFO - ##### Running download-and-extract step. 11:10:37 INFO - ##### 11:10:37 INFO - Running pre-action listener: _resource_record_pre_action 11:10:37 INFO - Running main action method: download_and_extract 11:10:37 INFO - mkdir: /builds/slave/test/build/tests 11:10:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:10:37 INFO - https://queue.taskcluster.net/v1/task/cvwhUmIMSvuOEabPF5qGzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:10:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cvwhUmIMSvuOEabPF5qGzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:10:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cvwhUmIMSvuOEabPF5qGzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:10:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cvwhUmIMSvuOEabPF5qGzw/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 11:10:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cvwhUmIMSvuOEabPF5qGzw/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 11:10:43 INFO - Downloaded 1361 bytes. 11:10:43 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:10:43 INFO - Using the following test package requirements: 11:10:43 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:10:43 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:10:43 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:10:43 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:10:43 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:10:43 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:10:43 INFO - u'jsshell-linux-x86_64.zip'], 11:10:43 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:10:43 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:10:43 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:10:43 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:10:43 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:10:43 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:10:43 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:10:43 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:10:43 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:10:43 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:10:43 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:10:43 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:10: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')]} 11:10:43 INFO - https://queue.taskcluster.net/v1/task/cvwhUmIMSvuOEabPF5qGzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:10:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cvwhUmIMSvuOEabPF5qGzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:10:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cvwhUmIMSvuOEabPF5qGzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:10:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cvwhUmIMSvuOEabPF5qGzw/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 11:10:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cvwhUmIMSvuOEabPF5qGzw/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 11:10:53 INFO - Downloaded 23857749 bytes. 11:10:53 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'] 11:10:53 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 11:10:54 INFO - Return code: 0 11:10:54 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 11:10: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')]} 11:10:54 INFO - https://queue.taskcluster.net/v1/task/cvwhUmIMSvuOEabPF5qGzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:10:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cvwhUmIMSvuOEabPF5qGzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:10:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cvwhUmIMSvuOEabPF5qGzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:10:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cvwhUmIMSvuOEabPF5qGzw/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 11:10:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cvwhUmIMSvuOEabPF5qGzw/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 11:11:01 INFO - Downloaded 23857749 bytes. 11:11:01 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'] 11:11:01 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 11:11:02 INFO - Return code: 0 11:11:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:02 INFO - https://queue.taskcluster.net/v1/task/cvwhUmIMSvuOEabPF5qGzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:11:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cvwhUmIMSvuOEabPF5qGzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:11:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cvwhUmIMSvuOEabPF5qGzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:11:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cvwhUmIMSvuOEabPF5qGzw/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 11:11:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cvwhUmIMSvuOEabPF5qGzw/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 11:11:03 INFO - Downloaded 10840145 bytes. 11:11:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:11:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:11:04 INFO - Return code: 0 11:11:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:04 INFO - https://queue.taskcluster.net/v1/task/cvwhUmIMSvuOEabPF5qGzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:11:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cvwhUmIMSvuOEabPF5qGzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:11:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cvwhUmIMSvuOEabPF5qGzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:11:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cvwhUmIMSvuOEabPF5qGzw/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 11:11:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cvwhUmIMSvuOEabPF5qGzw/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 11:11:05 INFO - Downloaded 58367566 bytes. 11:11:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cvwhUmIMSvuOEabPF5qGzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:11:05 INFO - mkdir: /builds/slave/test/properties 11:11:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:11:05 INFO - Writing to file /builds/slave/test/properties/build_url 11:11:05 INFO - Contents: 11:11:05 INFO - build_url:https://queue.taskcluster.net/v1/task/cvwhUmIMSvuOEabPF5qGzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:11:06 INFO - Running post-action listener: _resource_record_post_action 11:11:06 INFO - Running post-action listener: set_extra_try_arguments 11:11:06 INFO - ##### 11:11:06 INFO - ##### Running populate-webroot step. 11:11:06 INFO - ##### 11:11:06 INFO - Running pre-action listener: _resource_record_pre_action 11:11:06 INFO - Running main action method: populate_webroot 11:11:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:11:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:11:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:11:06 INFO - '--tppagecycles', 11:11:06 INFO - '7'], 11:11:06 INFO - 'tests': ['tsvgm']}}, 11:11:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:11:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:11:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:11:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:11:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:11:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:11:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:06 INFO - 'talos_options': ['--disable-e10s'], 11:11:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:11:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:11:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:06 INFO - 'talos_options': ['--disable-e10s'], 11:11:06 INFO - 'tests': ['damp', 'tps']}, 11:11:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:06 INFO - 'tests': ['damp', 'tps']}, 11:11:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:11:06 INFO - 'tests': ['dromaeo_dom']}, 11:11:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:11:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:11:06 INFO - 'tests': ['a11yr', 11:11:06 INFO - 'ts_paint', 11:11:06 INFO - 'tpaint', 11:11:06 INFO - 'sessionrestore', 11:11:06 INFO - 'sessionrestore_no_auto_restore', 11:11:06 INFO - 'tabpaint']}, 11:11:06 INFO - 'other-e10s': {'tests': ['a11yr', 11:11:06 INFO - 'ts_paint', 11:11:06 INFO - 'tpaint', 11:11:06 INFO - 'sessionrestore', 11:11:06 INFO - 'sessionrestore_no_auto_restore', 11:11:06 INFO - 'tabpaint']}, 11:11:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:11:06 INFO - 'ts_paint', 11:11:06 INFO - 'tpaint', 11:11:06 INFO - 'sessionrestore', 11:11:06 INFO - 'sessionrestore_no_auto_restore', 11:11:06 INFO - 'tabpaint']}, 11:11:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:11:06 INFO - 'ts_paint', 11:11:06 INFO - 'tpaint', 11:11:06 INFO - 'sessionrestore', 11:11:06 INFO - 'sessionrestore_no_auto_restore', 11:11:06 INFO - 'tabpaint']}, 11:11:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:11:06 INFO - 'tests': ['a11yr', 11:11:06 INFO - 'ts_paint', 11:11:06 INFO - 'tpaint', 11:11:06 INFO - 'sessionrestore', 11:11:06 INFO - 'sessionrestore_no_auto_restore', 11:11:06 INFO - 'tabpaint']}, 11:11:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:11:06 INFO - 'tests': ['a11yr', 11:11:06 INFO - 'ts_paint', 11:11:06 INFO - 'tpaint', 11:11:06 INFO - 'sessionrestore', 11:11:06 INFO - 'sessionrestore_no_auto_restore', 11:11:06 INFO - 'tabpaint']}, 11:11:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:11:06 INFO - 'tests': ['tsvgx', 11:11:06 INFO - 'tsvgr_opacity', 11:11:06 INFO - 'tart', 11:11:06 INFO - 'tscrollx', 11:11:06 INFO - 'cart']}, 11:11:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:11:06 INFO - 'tsvgr_opacity', 11:11:06 INFO - 'tart', 11:11:06 INFO - 'tscrollx', 11:11:06 INFO - 'cart']}, 11:11:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:06 INFO - 'talos_options': ['--disable-e10s'], 11:11:06 INFO - 'tests': ['tp5o']}, 11:11:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:06 INFO - 'tests': ['tp5o']}, 11:11:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:06 INFO - 'talos_options': ['--disable-e10s', 11:11:06 INFO - '--xperf_path', 11:11:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:11:06 INFO - 'tests': ['tp5n']}, 11:11:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:06 INFO - 'talos_options': ['--xperf_path', 11:11:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:11:06 INFO - 'tests': ['tp5n']}}, 11:11:06 INFO - 'talos.zip': {'path': '', 11:11:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:11:06 INFO - Running post-action listener: _resource_record_post_action 11:11:06 INFO - ##### 11:11:06 INFO - ##### Running create-virtualenv step. 11:11:06 INFO - ##### 11:11:06 INFO - Running pre-action listener: _resource_record_pre_action 11:11:06 INFO - Running main action method: create_virtualenv 11:11:06 INFO - Creating virtualenv /builds/slave/test/build/venv 11:11:06 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 11:11:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:11:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:11:06 INFO - Using real prefix '/usr' 11:11:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:11:07 INFO - Installing distribute.............................................................................................................................................................................................done. 11:11:09 INFO - Installing pip.................done. 11:11:09 INFO - Return code: 0 11:11:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:11:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96bb1d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19019a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1990810>, '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 0x1991710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1991ba0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1461518772.493648-1610201244', '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 11:11:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:11:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:11:09 INFO - Using env: {'DISPLAY': ':0', 11:11:09 INFO - 'HOME': '/home/cltbld', 11:11:09 INFO - 'LANG': 'en_US.UTF-8', 11:11:09 INFO - 'LANGUAGE': 'en_US:en', 11:11:09 INFO - 'LOGNAME': 'cltbld', 11:11:09 INFO - 'MAIL': '/var/mail/cltbld', 11:11:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:09 INFO - 'MOZ_NO_REMOTE': '1', 11:11:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:09 INFO - 'NO_EM_RESTART': '1', 11:11:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:09 INFO - 'PWD': '/builds/slave/test', 11:11:09 INFO - 'SHELL': '/bin/bash', 11:11:09 INFO - 'SHLVL': '1', 11:11:09 INFO - 'TERM': 'linux', 11:11:09 INFO - 'TMOUT': '86400', 11:11:09 INFO - 'USER': 'cltbld', 11:11:09 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1461518772.493648-1610201244', 11:11:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:09 INFO - '_': '/tools/buildbot/bin/python'} 11:11:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:09 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 11:11:09 INFO - Cleaning up... 11:11:09 INFO - Return code: 0 11:11:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:11:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f96bb1d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19019a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1990810>, '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 0x1991710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1991ba0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1461518772.493648-1610201244', '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 11:11:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 11:11:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 11:11:09 INFO - Using env: {'DISPLAY': ':0', 11:11:09 INFO - 'HOME': '/home/cltbld', 11:11:09 INFO - 'LANG': 'en_US.UTF-8', 11:11:09 INFO - 'LANGUAGE': 'en_US:en', 11:11:09 INFO - 'LOGNAME': 'cltbld', 11:11:09 INFO - 'MAIL': '/var/mail/cltbld', 11:11:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:09 INFO - 'MOZ_NO_REMOTE': '1', 11:11:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:09 INFO - 'NO_EM_RESTART': '1', 11:11:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:09 INFO - 'PWD': '/builds/slave/test', 11:11:09 INFO - 'SHELL': '/bin/bash', 11:11:09 INFO - 'SHLVL': '1', 11:11:09 INFO - 'TERM': 'linux', 11:11:09 INFO - 'TMOUT': '86400', 11:11:09 INFO - 'USER': 'cltbld', 11:11:09 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1461518772.493648-1610201244', 11:11:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:09 INFO - '_': '/tools/buildbot/bin/python'} 11:11:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:09 INFO - Downloading/unpacking psutil>=0.7.1 11:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:11:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:11:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:11:11 INFO - Installing collected packages: psutil 11:11:11 INFO - Running setup.py install for psutil 11:11:11 INFO - building 'psutil._psutil_linux' extension 11:11:11 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 11:11:11 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 11:11:11 INFO - building 'psutil._psutil_posix' extension 11:11:11 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 11:11:12 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 11:11:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:11:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:11:12 INFO - Successfully installed psutil 11:11:12 INFO - Cleaning up... 11:11:12 INFO - Return code: 0 11:11:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:11:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:12 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 0x7f96bb1d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19019a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1990810>, '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 0x1991710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1991ba0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1461518772.493648-1610201244', '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 11:11:12 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 11:11:12 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 11:11:12 INFO - Using env: {'DISPLAY': ':0', 11:11:12 INFO - 'HOME': '/home/cltbld', 11:11:12 INFO - 'LANG': 'en_US.UTF-8', 11:11:12 INFO - 'LANGUAGE': 'en_US:en', 11:11:12 INFO - 'LOGNAME': 'cltbld', 11:11:12 INFO - 'MAIL': '/var/mail/cltbld', 11:11:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:12 INFO - 'MOZ_NO_REMOTE': '1', 11:11:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:12 INFO - 'NO_EM_RESTART': '1', 11:11:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:12 INFO - 'PWD': '/builds/slave/test', 11:11:12 INFO - 'SHELL': '/bin/bash', 11:11:12 INFO - 'SHLVL': '1', 11:11:12 INFO - 'TERM': 'linux', 11:11:12 INFO - 'TMOUT': '86400', 11:11:12 INFO - 'USER': 'cltbld', 11:11:12 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1461518772.493648-1610201244', 11:11:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:12 INFO - '_': '/tools/buildbot/bin/python'} 11:11:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:11: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 11:11: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 11:11: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 11:11: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 11:11: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 11:11: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 11:11:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:11:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:11:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:11:14 INFO - Installing collected packages: mozsystemmonitor 11:11:14 INFO - Running setup.py install for mozsystemmonitor 11:11:14 INFO - Successfully installed mozsystemmonitor 11:11:14 INFO - Cleaning up... 11:11:14 INFO - Return code: 0 11:11:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:11: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')]} 11:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11: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')]} 11:11:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:14 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 0x7f96bb1d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19019a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1990810>, '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 0x1991710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1991ba0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1461518772.493648-1610201244', '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 11:11:14 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 11:11:14 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 11:11:14 INFO - Using env: {'DISPLAY': ':0', 11:11:14 INFO - 'HOME': '/home/cltbld', 11:11:14 INFO - 'LANG': 'en_US.UTF-8', 11:11:14 INFO - 'LANGUAGE': 'en_US:en', 11:11:14 INFO - 'LOGNAME': 'cltbld', 11:11:14 INFO - 'MAIL': '/var/mail/cltbld', 11:11:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:14 INFO - 'MOZ_NO_REMOTE': '1', 11:11:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:14 INFO - 'NO_EM_RESTART': '1', 11:11:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:14 INFO - 'PWD': '/builds/slave/test', 11:11:14 INFO - 'SHELL': '/bin/bash', 11:11:14 INFO - 'SHLVL': '1', 11:11:14 INFO - 'TERM': 'linux', 11:11:14 INFO - 'TMOUT': '86400', 11:11:14 INFO - 'USER': 'cltbld', 11:11:14 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1461518772.493648-1610201244', 11:11:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:14 INFO - '_': '/tools/buildbot/bin/python'} 11:11:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:14 INFO - Downloading/unpacking blobuploader==1.2.4 11:11:14 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 11:11:14 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 11:11:14 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 11:11:14 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 11:11:14 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 11:11:14 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 11:11:16 INFO - Downloading blobuploader-1.2.4.tar.gz 11:11:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:11:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:11:16 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 11:11:16 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 11:11:16 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 11:11:16 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 11:11:16 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 11:11:16 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 11:11:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:11:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:11:16 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 11:11:16 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 11:11:16 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 11:11:16 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 11:11:16 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 11:11:16 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 11:11:17 INFO - Downloading docopt-0.6.1.tar.gz 11:11:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:11:17 INFO - Installing collected packages: blobuploader, requests, docopt 11:11:17 INFO - Running setup.py install for blobuploader 11:11:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:11:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:11:17 INFO - Running setup.py install for requests 11:11:17 INFO - Running setup.py install for docopt 11:11:17 INFO - Successfully installed blobuploader requests docopt 11:11:17 INFO - Cleaning up... 11:11:17 INFO - Return code: 0 11:11:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:11: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')]} 11:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11: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')]} 11:11:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:17 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 0x7f96bb1d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19019a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1990810>, '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 0x1991710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1991ba0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1461518772.493648-1610201244', '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 11:11:17 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 11:11:17 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 11:11:17 INFO - Using env: {'DISPLAY': ':0', 11:11:17 INFO - 'HOME': '/home/cltbld', 11:11:17 INFO - 'LANG': 'en_US.UTF-8', 11:11:17 INFO - 'LANGUAGE': 'en_US:en', 11:11:17 INFO - 'LOGNAME': 'cltbld', 11:11:17 INFO - 'MAIL': '/var/mail/cltbld', 11:11:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:17 INFO - 'MOZ_NO_REMOTE': '1', 11:11:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:17 INFO - 'NO_EM_RESTART': '1', 11:11:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:17 INFO - 'PWD': '/builds/slave/test', 11:11:17 INFO - 'SHELL': '/bin/bash', 11:11:17 INFO - 'SHLVL': '1', 11:11:17 INFO - 'TERM': 'linux', 11:11:17 INFO - 'TMOUT': '86400', 11:11:17 INFO - 'USER': 'cltbld', 11:11:17 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1461518772.493648-1610201244', 11:11:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:17 INFO - '_': '/tools/buildbot/bin/python'} 11:11:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:11:18 INFO - Running setup.py (path:/tmp/pip-VuJlI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:11:18 INFO - Running setup.py (path:/tmp/pip-29ovLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:11:18 INFO - Running setup.py (path:/tmp/pip-ftYpAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:11:18 INFO - Running setup.py (path:/tmp/pip-qCC2hT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:11:18 INFO - Running setup.py (path:/tmp/pip-590iAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:11:18 INFO - Running setup.py (path:/tmp/pip-fPEGQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:11:18 INFO - Running setup.py (path:/tmp/pip-W9q7FE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:11:18 INFO - Running setup.py (path:/tmp/pip-M3XpFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:11:18 INFO - Running setup.py (path:/tmp/pip-JOxT1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:11:18 INFO - Running setup.py (path:/tmp/pip-OrxZdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:11:18 INFO - Running setup.py (path:/tmp/pip-63jsnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:11:18 INFO - Running setup.py (path:/tmp/pip-kor6Dq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:11:18 INFO - Running setup.py (path:/tmp/pip-7Yy1vm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:11:19 INFO - Running setup.py (path:/tmp/pip-20ElK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:11:19 INFO - Running setup.py (path:/tmp/pip-rF16Q3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:11:19 INFO - Running setup.py (path:/tmp/pip-BGynAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:11:19 INFO - Running setup.py (path:/tmp/pip-51Z5rz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:11:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:11:19 INFO - Running setup.py install for manifestparser 11:11:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:11:19 INFO - Running setup.py install for mozcrash 11:11:19 INFO - Running setup.py install for mozdebug 11:11:19 INFO - Running setup.py install for mozdevice 11:11:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:11:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:11:19 INFO - Running setup.py install for mozfile 11:11:19 INFO - Running setup.py install for mozhttpd 11:11:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:11:19 INFO - Running setup.py install for mozinfo 11:11:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:11:20 INFO - Running setup.py install for mozInstall 11:11:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:11:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:11:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:11:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:11:20 INFO - Running setup.py install for mozleak 11:11:20 INFO - Running setup.py install for mozlog 11:11:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:11:20 INFO - Running setup.py install for moznetwork 11:11:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:11:20 INFO - Running setup.py install for mozprocess 11:11:20 INFO - Running setup.py install for mozprofile 11:11:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:11:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:11:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:11:20 INFO - Running setup.py install for mozrunner 11:11:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:11:20 INFO - Running setup.py install for mozscreenshot 11:11:20 INFO - Running setup.py install for moztest 11:11:20 INFO - Running setup.py install for mozversion 11:11:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:11:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:11:21 INFO - Cleaning up... 11:11:21 INFO - Return code: 0 11:11:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:11: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')]} 11:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11: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')]} 11:11:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:21 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 0x7f96bb1d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19019a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1990810>, '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 0x1991710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1991ba0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1461518772.493648-1610201244', '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 11:11:21 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 11:11:21 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 11:11:21 INFO - Using env: {'DISPLAY': ':0', 11:11:21 INFO - 'HOME': '/home/cltbld', 11:11:21 INFO - 'LANG': 'en_US.UTF-8', 11:11:21 INFO - 'LANGUAGE': 'en_US:en', 11:11:21 INFO - 'LOGNAME': 'cltbld', 11:11:21 INFO - 'MAIL': '/var/mail/cltbld', 11:11:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:21 INFO - 'MOZ_NO_REMOTE': '1', 11:11:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:21 INFO - 'NO_EM_RESTART': '1', 11:11:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:21 INFO - 'PWD': '/builds/slave/test', 11:11:21 INFO - 'SHELL': '/bin/bash', 11:11:21 INFO - 'SHLVL': '1', 11:11:21 INFO - 'TERM': 'linux', 11:11:21 INFO - 'TMOUT': '86400', 11:11:21 INFO - 'USER': 'cltbld', 11:11:21 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1461518772.493648-1610201244', 11:11:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:21 INFO - '_': '/tools/buildbot/bin/python'} 11:11:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:11:21 INFO - Running setup.py (path:/tmp/pip-9m6Lrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:11:21 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)) 11:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:11:21 INFO - Running setup.py (path:/tmp/pip-YS8Mzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:11:21 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)) 11:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:11:21 INFO - Running setup.py (path:/tmp/pip-Bwnt3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:11:21 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)) 11:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:11:21 INFO - Running setup.py (path:/tmp/pip-8XKEQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:11:21 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)) 11:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:11:21 INFO - Running setup.py (path:/tmp/pip-jFUDh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:11:21 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)) 11:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:11:21 INFO - Running setup.py (path:/tmp/pip-10xeth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:11:21 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)) 11:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:11:21 INFO - Running setup.py (path:/tmp/pip-NheqMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:11:21 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)) 11:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:11:21 INFO - Running setup.py (path:/tmp/pip-nXpGWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:11:21 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)) 11:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:11:21 INFO - Running setup.py (path:/tmp/pip-xWlkmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:11:21 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)) 11:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:11:21 INFO - Running setup.py (path:/tmp/pip-wzQGwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:11:22 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)) 11:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:11:22 INFO - Running setup.py (path:/tmp/pip-dT3_RD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:11:22 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)) 11:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:11:22 INFO - Running setup.py (path:/tmp/pip-Wbjl01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:11:22 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)) 11:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:11:22 INFO - Running setup.py (path:/tmp/pip-ualQQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:11:22 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)) 11:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:11:22 INFO - Running setup.py (path:/tmp/pip-5n0qYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:11:22 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)) 11:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:11:22 INFO - Running setup.py (path:/tmp/pip-Mht20l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:11:22 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)) 11:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:11:22 INFO - Running setup.py (path:/tmp/pip-_T1q2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:11:22 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)) 11:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:11:22 INFO - Running setup.py (path:/tmp/pip-ULxOIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:11:22 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)) 11:11:22 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)) 11:11:22 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)) 11:11:22 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)) 11:11:22 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)) 11:11:22 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)) 11:11:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:24 INFO - Downloading blessings-1.6.tar.gz 11:11:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:11:24 INFO - Installing collected packages: blessings 11:11:24 INFO - Running setup.py install for blessings 11:11:24 INFO - Successfully installed blessings 11:11:24 INFO - Cleaning up... 11:11:24 INFO - Return code: 0 11:11:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:11:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:11:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:11:24 INFO - Reading from file tmpfile_stdout 11:11:24 INFO - Current package versions: 11:11:24 INFO - argparse == 1.2.1 11:11:24 INFO - blessings == 1.6 11:11:24 INFO - blobuploader == 1.2.4 11:11:24 INFO - docopt == 0.6.1 11:11:24 INFO - manifestparser == 1.1 11:11:24 INFO - mozInstall == 1.12 11:11:24 INFO - mozcrash == 0.17 11:11:24 INFO - mozdebug == 0.1 11:11:24 INFO - mozdevice == 0.48 11:11:24 INFO - mozfile == 1.2 11:11:24 INFO - mozhttpd == 0.7 11:11:24 INFO - mozinfo == 0.9 11:11:24 INFO - mozleak == 0.1 11:11:24 INFO - mozlog == 3.1 11:11:24 INFO - moznetwork == 0.27 11:11:24 INFO - mozprocess == 0.22 11:11:24 INFO - mozprofile == 0.28 11:11:24 INFO - mozrunner == 6.11 11:11:24 INFO - mozscreenshot == 0.1 11:11:24 INFO - mozsystemmonitor == 0.0 11:11:24 INFO - moztest == 0.7 11:11:24 INFO - mozversion == 1.4 11:11:24 INFO - psutil == 3.1.1 11:11:24 INFO - requests == 1.2.3 11:11:24 INFO - wsgiref == 0.1.2 11:11:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:11:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:24 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 0x7f96bb1d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19019a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1990810>, '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 0x1991710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1991ba0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1461518772.493648-1610201244', '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 11:11:24 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 11:11:24 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 11:11:24 INFO - Using env: {'DISPLAY': ':0', 11:11:24 INFO - 'HOME': '/home/cltbld', 11:11:24 INFO - 'LANG': 'en_US.UTF-8', 11:11:24 INFO - 'LANGUAGE': 'en_US:en', 11:11:24 INFO - 'LOGNAME': 'cltbld', 11:11:24 INFO - 'MAIL': '/var/mail/cltbld', 11:11:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:24 INFO - 'MOZ_NO_REMOTE': '1', 11:11:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:24 INFO - 'NO_EM_RESTART': '1', 11:11:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:24 INFO - 'PWD': '/builds/slave/test', 11:11:24 INFO - 'SHELL': '/bin/bash', 11:11:24 INFO - 'SHLVL': '1', 11:11:24 INFO - 'TERM': 'linux', 11:11:24 INFO - 'TMOUT': '86400', 11:11:24 INFO - 'USER': 'cltbld', 11:11:24 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1461518772.493648-1610201244', 11:11:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:24 INFO - '_': '/tools/buildbot/bin/python'} 11:11:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:25 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)) 11:11:25 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)) 11:11:25 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)) 11:11:25 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)) 11:11:25 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)) 11:11:25 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)) 11:11:25 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)) 11:11:25 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)) 11:11:25 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)) 11:11:25 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)) 11:11:25 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)) 11:11:25 INFO - Cleaning up... 11:11:25 INFO - Return code: 0 11:11:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:11:25 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')]} 11:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:25 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')]} 11:11:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:25 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 0x7f96bb1d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19019a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1990810>, '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 0x1991710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1991ba0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1461518772.493648-1610201244', '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 11:11:25 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 11:11:25 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 11:11:25 INFO - Using env: {'DISPLAY': ':0', 11:11:25 INFO - 'HOME': '/home/cltbld', 11:11:25 INFO - 'LANG': 'en_US.UTF-8', 11:11:25 INFO - 'LANGUAGE': 'en_US:en', 11:11:25 INFO - 'LOGNAME': 'cltbld', 11:11:25 INFO - 'MAIL': '/var/mail/cltbld', 11:11:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:25 INFO - 'MOZ_NO_REMOTE': '1', 11:11:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:25 INFO - 'NO_EM_RESTART': '1', 11:11:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:25 INFO - 'PWD': '/builds/slave/test', 11:11:25 INFO - 'SHELL': '/bin/bash', 11:11:25 INFO - 'SHLVL': '1', 11:11:25 INFO - 'TERM': 'linux', 11:11:25 INFO - 'TMOUT': '86400', 11:11:25 INFO - 'USER': 'cltbld', 11:11:25 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1461518772.493648-1610201244', 11:11:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:25 INFO - '_': '/tools/buildbot/bin/python'} 11:11:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:25 INFO - Downloading/unpacking jsonschema 11:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:11:27 INFO - Downloading/unpacking functools32 (from jsonschema) 11:11:27 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 11:11:27 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 11:11:27 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 11:11:27 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 11:11:27 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 11:11:27 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 11:11:27 INFO - Downloading functools32-3.2.3-2.tar.gz 11:11:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:11:27 INFO - warning: no files found matching '*.txt' 11:11:27 INFO - no previously-included directories found matching 'build' 11:11:27 INFO - no previously-included directories found matching 'dist' 11:11:27 INFO - no previously-included directories found matching '.git*' 11:11:27 INFO - Installing collected packages: jsonschema, functools32 11:11:27 INFO - Running setup.py install for functools32 11:11:27 INFO - warning: no files found matching '*.txt' 11:11:27 INFO - no previously-included directories found matching 'build' 11:11:27 INFO - no previously-included directories found matching 'dist' 11:11:27 INFO - no previously-included directories found matching '.git*' 11:11:27 INFO - Successfully installed jsonschema functools32 11:11:27 INFO - Cleaning up... 11:11:27 INFO - Return code: 0 11:11:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96bb1d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19019a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1990810>, '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 0x1991710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1991ba0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1461518772.493648-1610201244', '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 11:11:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:11:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:11:27 INFO - Using env: {'DISPLAY': ':0', 11:11:27 INFO - 'HOME': '/home/cltbld', 11:11:27 INFO - 'LANG': 'en_US.UTF-8', 11:11:27 INFO - 'LANGUAGE': 'en_US:en', 11:11:27 INFO - 'LOGNAME': 'cltbld', 11:11:27 INFO - 'MAIL': '/var/mail/cltbld', 11:11:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:27 INFO - 'MOZ_NO_REMOTE': '1', 11:11:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:27 INFO - 'NO_EM_RESTART': '1', 11:11:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:27 INFO - 'PWD': '/builds/slave/test', 11:11:27 INFO - 'SHELL': '/bin/bash', 11:11:27 INFO - 'SHLVL': '1', 11:11:27 INFO - 'TERM': 'linux', 11:11:27 INFO - 'TMOUT': '86400', 11:11:27 INFO - 'USER': 'cltbld', 11:11:27 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1461518772.493648-1610201244', 11:11:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:27 INFO - '_': '/tools/buildbot/bin/python'} 11:11:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:27 INFO - Downloading/unpacking flake8 11:11:27 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 11:11:27 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 11:11:27 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 11:11:27 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 11:11:27 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 11:11:27 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 11:11:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:11:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:11:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:11:30 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 11:11:30 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 11:11:30 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 11:11:30 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 11:11:30 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 11:11:30 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 11:11:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:11:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:11:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:11:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:11:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:11:30 INFO - no previously-included directories found matching 'docs/_build' 11:11:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:11:30 INFO - Running setup.py install for pep8 11:11:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:11:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:11:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:11:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:11:30 INFO - no previously-included directories found matching 'docs/_build' 11:11:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:11:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:11:30 INFO - Cleaning up... 11:11:30 INFO - Return code: 0 11:11:30 INFO - Running post-action listener: _resource_record_post_action 11:11:30 INFO - Running post-action listener: _start_resource_monitoring 11:11:30 INFO - Starting resource monitoring. 11:11:30 INFO - ##### 11:11:30 INFO - ##### Running install step. 11:11:30 INFO - ##### 11:11:30 INFO - Running pre-action listener: _resource_record_pre_action 11:11:30 INFO - Running main action method: install 11:11:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:11:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:11:30 INFO - Reading from file tmpfile_stdout 11:11:30 INFO - Detecting whether we're running mozinstall >=1.0... 11:11:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:11:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:11:30 INFO - Reading from file tmpfile_stdout 11:11:30 INFO - Output received: 11:11:30 INFO - Usage: mozinstall [options] installer 11:11:30 INFO - Options: 11:11:30 INFO - -h, --help show this help message and exit 11:11:30 INFO - -d DEST, --destination=DEST 11:11:30 INFO - Directory to install application into. [default: 11:11:30 INFO - "/builds/slave/test"] 11:11:30 INFO - --app=APP Application being installed. [default: firefox] 11:11:30 INFO - mkdir: /builds/slave/test/build/application 11:11:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:11:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:11:47 INFO - Reading from file tmpfile_stdout 11:11:47 INFO - Output received: 11:11:47 INFO - /builds/slave/test/build/application/firefox/firefox 11:11:47 INFO - Running post-action listener: _resource_record_post_action 11:11:47 INFO - ##### 11:11:47 INFO - ##### Running run-tests step. 11:11:47 INFO - ##### 11:11:47 INFO - Running pre-action listener: _resource_record_pre_action 11:11:47 INFO - Running main action method: run_tests 11:11:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:11:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:11:47 INFO - Python 2.7.3 11:11:47 INFO - Return code: 0 11:11:47 INFO - grabbing minidump binary from tooltool 11:11:47 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')]} 11:11:47 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 0x1990810>, '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 0x1991710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1991ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:11:47 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 11:11:47 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 11:11:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:11:47 INFO - Return code: 0 11:11:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:11:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:11:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:11:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:11:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:11:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:11:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:11:48 INFO - Return code: 0 11:11:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cvwhUmIMSvuOEabPF5qGzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 11:11:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cvwhUmIMSvuOEabPF5qGzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --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 11:11:48 INFO - Using env: {'DISPLAY': ':0', 11:11:48 INFO - 'HOME': '/home/cltbld', 11:11:48 INFO - 'LANG': 'en_US.UTF-8', 11:11:48 INFO - 'LANGUAGE': 'en_US:en', 11:11:48 INFO - 'LOGNAME': 'cltbld', 11:11:48 INFO - 'MAIL': '/var/mail/cltbld', 11:11:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:11:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:11:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:48 INFO - 'MOZ_NO_REMOTE': '1', 11:11:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:11:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:48 INFO - 'NO_EM_RESTART': '1', 11:11:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:48 INFO - 'PWD': '/builds/slave/test', 11:11:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:11:48 INFO - 'SHELL': '/bin/bash', 11:11:48 INFO - 'SHLVL': '1', 11:11:48 INFO - 'TERM': 'linux', 11:11:48 INFO - 'TMOUT': '86400', 11:11:48 INFO - 'USER': 'cltbld', 11:11:48 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1461518772.493648-1610201244', 11:11:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:48 INFO - '_': '/tools/buildbot/bin/python'} 11:11:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cvwhUmIMSvuOEabPF5qGzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 11:11:48 INFO - mozversion application_buildid: 20160424083228 11:11:48 INFO - mozversion application_changeset: 463fc6d36ff561f17a34f1688bd8c38833de8966 11:11:48 INFO - mozversion application_display_name: Nightly 11:11:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:11:48 INFO - mozversion application_name: Firefox 11:11:48 INFO - mozversion application_remotingname: firefox 11:11:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:11:48 INFO - mozversion application_vendor: Mozilla 11:11:48 INFO - mozversion application_version: 48.0a1 11:11:48 INFO - mozversion platform_buildid: 20160424083228 11:11:48 INFO - mozversion platform_changeset: 463fc6d36ff561f17a34f1688bd8c38833de8966 11:11:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:11:48 INFO - mozversion platform_version: 48.0a1 11:11:48 INFO - using testdate: 1461521508 11:11:48 INFO - actual date: 1461521508 11:11:48 INFO - starting webserver on 'localhost:59763' 11:11:48 INFO - SUITE-START | Running 2 tests 11:11:48 INFO - TEST-START | dromaeo_css 11:11:48 INFO - operating with platform_type : linux_ 11:11:48 INFO - Initialising browser for dromaeo_css test... 11:11:48 INFO - TEST-INFO | started process 16440 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxGh_cl/profile http://localhost:59763/getInfo.html) 11:11:52 INFO - PROCESS | 16440 | __metrics Screen width/height:1600/1200 11:11:52 INFO - PROCESS | 16440 | colorDepth:24 11:11:52 INFO - PROCESS | 16440 | Browser inner width/height: 1024/697 11:11:52 INFO - PROCESS | 16440 | __metrics 11:11:53 ERROR - PROCESS | 16440 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:11:54 INFO - TEST-INFO | 16440: exit 0 11:11:54 INFO - Browser initialized. 11:11:54 INFO - Running cycle 1/1 for dromaeo_css test... 11:11:54 INFO - TEST-INFO | started process 16523 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxGh_cl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:12:06 INFO - PROCESS | 16523 | RSS: Main: 154378240 11:12:06 INFO - PROCESS | 16523 | 11:12:56 INFO - PROCESS | 16523 | 1461521576984 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] 11:15:04 INFO - PROCESS | 16523 | Cycle 1(1): loaded http://localhost:59763/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59763/tests/dromaeo/cssquery-ext.html) 11:15:05 INFO - PROCESS | 16523 | RSS: Main: 259252224 11:15:05 INFO - PROCESS | 16523 | 11:18:07 INFO - PROCESS | 16523 | Cycle 1(1): loaded http://localhost:59763/tests/dromaeo/cssquery-ext.html (next: http://localhost:59763/tests/dromaeo/cssquery-jquery.html) 11:18:08 INFO - PROCESS | 16523 | RSS: Main: 238137344 11:18:08 INFO - PROCESS | 16523 | 11:21:10 INFO - PROCESS | 16523 | Cycle 1(1): loaded http://localhost:59763/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59763/tests/dromaeo/cssquery-mootools.html) 11:21:10 INFO - PROCESS | 16523 | RSS: Main: 234725376 11:21:10 INFO - PROCESS | 16523 | 11:24:12 INFO - PROCESS | 16523 | Cycle 1(1): loaded http://localhost:59763/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59763/tests/dromaeo/cssquery-prototype.html) 11:24:13 INFO - PROCESS | 16523 | RSS: Main: 232374272 11:24:13 INFO - PROCESS | 16523 | 11:27:15 INFO - PROCESS | 16523 | Cycle 1(1): loaded http://localhost:59763/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59763/tests/dromaeo/cssquery-yui.html) 11:27:16 INFO - PROCESS | 16523 | RSS: Main: 225558528 11:27:16 INFO - PROCESS | 16523 | 11:30:18 INFO - PROCESS | 16523 | Cycle 1(1): loaded http://localhost:59763/tests/dromaeo/cssquery-yui.html (next: http://localhost:59763/tests/dromaeo/cssquery-dojo.html) 11:30:18 INFO - PROCESS | 16523 | RSS: Main: 267862016 11:30:18 INFO - PROCESS | 16523 | 11:30:18 INFO - PROCESS | 16523 | __start_tp_report 11:30:18 INFO - PROCESS | 16523 | _x_x_mozilla_page_load 11:30:18 INFO - PROCESS | 16523 | _x_x_mozilla_page_load_details 11:30:18 INFO - PROCESS | 16523 | |i|pagename|runs| 11:30:18 INFO - PROCESS | 16523 | |0;dojo.html;3072.800267982581;3145.8427078646064;3180.348028654126;3182.1567284669554;3213.4697774867154;5179.896402071956;5257.605679574028;5264.184051472023;5302.072137375963;5339.332583427076;5316.388615309241;5336.8132115375965;5345.732713364326;5348.866278343034;5388.78444862205;4695.131400690866;4736.8578942631775;4869.732164730938;4912.091263116317;4926.827561035365;4822.975885120587;4849.951500485003;4885.706857588539;4891.853244402656;4895;4677.812887484497;4741.525847415248;4770.2844573314105;4773.71357718538;4776.522347765231;4757.119932812441;4767.284907263904;4769.236922092448;4779.856604301876;4800.711957282574;4645.535446455361;4731.905361892743;4737.763111844394;4754.049190161947;4799.928001079987;5144.254083157921;5163.328767260232;5169.508896654812;5215.191645294985;5218.399884013349;5541.501264886139;5563.610547261694;5570.248016517799;5571.944280557183;5581.441855814427;5536.446355364472;5639.915401268943;5657.462541058593;5708.286464191976;5768.307803063659;5295.338082739658;5302.443243459458;5307.442718514578;5308.628396012281;5316.3620365556;5780.71096445176;5800.738966746507;5801.564882633819;5802.129680547867;5805.042168042226;5312.7343632818975;5564.165375193753;5569.693666848281;5662.037453632893;5665.631733937364;5656.547476201894;5680.233168522279;5682.971585142048;5682.971585142131;5684;5590.049691552445;5613.354464236665;5633.859153521113;5637.379888212294;5640.435956404327;5484.314460692413;5608.130739735348;5645.661260324394;5664.6034777566;5692.288463942007;4179.811908464127;4179.895502612459;4190.308599081179;4203.915921681611;4221.2190744712325;3761.4921985531605;3777.565579958285;3782.9432558511644;3809.6190380962234;3839.9424008639894;5304.761285742151;5323.441038690959;5331.920021199685;5363.704996225167;5368.355797304349;5613.635113717595;5621.4659607337235;5621.718914054362;5627.268455100892;5630.831075067755;5229.137192363218;5241.030409374278;5258.684478931276;5264.710440925709;5271.20931860224;4894.241392584155;4907.116718990616;4916.70499770015;4916.852494425173;4948.975255123702;5881.558883083786;5893.057110862242;5896.10673883407;5897.705114744245;5898.203742494794;5556.749946252347;5718.857028574319;5738.799142030009;5768.653880767083;5801.94198058014;5857.531397488276;5862.882742345215;5865.94134058671;5882.705864706833;5918.23063001807;5632.042552766122;5642.60501764889;5642.88714225705;5643.520300774316;5644.435556444323;5497.945020549743;5640.125780504029;5719;5730.570207234391;5731.8567035824435;5512.586556008396;5522.558195344443;5530.695811730233;5536.390996990247;5569.387367389503;5539.9169012464035;5557.944420555743;5560.304961879765;5563.638363506359;5611.130274807411;5283.418823929442;5410.1343784994215;5470.753816078206;5474.178873168898;5513.062779327604;5549.944500554942;5553.222548843246;5579;5579.860503487283;5587.580931430078;5181.06740786647;5409.377921539073;5436.7553460093595;5453.072977593898;5454.618176727749 11:30:18 INFO - PROCESS | 16523 | |1;ext.html;596.335086378688;641.2913730327987;644.1014784375795;659.6306068601581;663.8738639658465;31256.84371578142;36683.231179946604;37731.24537509248;37749.24501509972;37751.43372849409;39223.803880980624;39972.600273997254;40013.59986400135;40052.799736001354;40064.39903401451;8542.103079176706;8731.825363492726;8745.825083498326;8746.825063498727;8746.956265218665;8530.957345213295;8611;8638.611262493203;8655.307575393985;8655.523946182957;8693;9005.729828105168;9007.369484136114;9009.729708108767;9009.77475563113;8895;8955.641774329019;8958.37291389603;8964.551772411385;8971.820563588757;8757.124287571256;8896.466212027299;8900.243479304267;8900.287976961827;8907.688230911886;40867.7956610218;41365.37951930724;41467.37798933018;41531.1693766126;41578.37632435516;3368.208471009311;3557.8932632020824;3573.9642603573893;3644.5079914211774;3860.247251785903;29925.920001599665;30528;30621.387572248652;30878.536821947688;30951.690483095106;3873.32216862048;3879.4568760373572;3881.7670939743425;3925.0972276376306;3956.980215098935;270616;273580;274029;274175;274822;53894.73052634712;57371.13943290854;58015;58038.709806451545;58085.70957145187;65016.34983650198;66637.66942140489;66868;66871.66564167148;66980.66509667518;14875.553733388017;14950.327235274439;14983.625409364853;15033.548993530212;15056.32246548908;10989.890101099047;11255.099592032619;11320.433978301216;11367.772644547229;11420.31478111316;17399.82600173982;18789;19417.206336307714;20044.899775501028;20140.496487587927;6875;6942.444604431634;7033.577985320897;7139.32176443237;7235.493515453868;1013.9543720532446;1021.6015753856002;1061.6284300494765;1103.8951299626522;1146.3981409759942;31645.20886977844;32236.35527289488;32248;32311.51532727011;33156.6896303479;1147.73602071524;1163.959261425846;1180.055955235808;1185.875483074282;1200.3098218524208;16486.917565412095;17081.316747330216;17345.3061877526;17395.260473952756;17588.648227035388;525499;535855;537770;539290;539353;56376.15435768467;56961.71519142378;57175.42824571784;57183;57193.71403143041;1335.8196643453205;1377.0842389810864;1412.2091628687967;1417.964550886236;1500.7748837674217;30297.091087267418;31158;31576.842115789274;32081.58739830263;32273.35453290968;51487.742561286956;52006;52122.47877521176;52183.478165217864;52264;412167;420423;422897;425783;425973;25520.361990950376;28208.576871347355;28566.71433285724;29001.85499072491;29032.274193145342;46906;48542.27186592275;49102.5089749098;49575.256371155185;53259.46740532545;38061.619383806916;39248.80375598104;39433.605663942995;39681.80159099186;39854.80072599618;38025.429618555194;39221.41167882541;39541.2091758169;39935;40069.79965100156;39616.40575391314;40096.79951600223;40597.39103913384;40624.390634141106;40631;33682.81061731077;35157.47263791096;35453;35759;35805.46291805573;26929.461410771284;27045.2698694401;27277.86361068182;27295.45409091847;27307.453850923266 11:30:18 INFO - PROCESS | 16523 | |2;jquery.html;382.41299605106167;399.5984036043777;401.7208040411915;403.7637981780658;411.22894572676233;14276.928615356908;16544.338226470925;17829.643407131865;18304.26782928683;18386.356477523288;17676.558086047855;18247.178876950537;18778.061096945134;18889;19910.90044549775;6233.407826256498;6432.42108210261;6458.870822583545;6487.41613254807;6491.221053473566;4538.29656403258;6332.936670633304;6402.903956440658;6743.49423793215;7129.108861392326;7036.82407939803;7037.683304251295;7128.251533588977;7139.89290160648;7144.142702875636;7101.396381307595;7252.057232559733;7283.635818209068;7289.817754556152;7291.41668666508;6805.489588280899;6989.615571143636;7068.505204635678;7083.433325333961;7091.609961452118;24341.878290608434;25380.11169609055;25658.615120773204;25770.742292577022;25800.87099564509;2131.4564785979633;2260.49138943738;2397.30478161333;2422.91519796808;2900.550414685727;14200.431982720678;14698.265086745727;14726.852731472762;15429.459968901147;15494;1839.4757494114112;1849.8335149836444;1849.8982555959417;1860.5999710062267;1974.0919177178514;84532;86866;88227.55886220527;89891.55054224753;90780.54609726975;16545;16870.662586748196;16912.408065717642;17208.65582688339;17260.309587616353;29691.85154074259;29839;30092.398152036836;30121.69878301189;30154.547681784792;8865.68970086044;9179.996901688595;9265;9325.393849399903;9433.198178154797;7582.203868593829;7653.119891212582;7693.384529237647;7762.844743105106;7833.960830195812;8654.87017694735;8770.12298770118;8784.912150878537;8790.384673072824;8889.377743557889;3278.0988824890146;3385.72914166871;3405.9148521287166;3441.346144232588;3463.5670541182353;931.5714771205186;984.7685793838442;1009.8030883977701;1021.3259248895841;1026.6765968719828;18168.818311816714;18498.35255766042;18577.25690972346;18813.529661758566;19255.711164332548;1018.6638409324905;1030.2324768047702;1042.259995403257;1061.8991195836384;1082.9945850270856;10339.586416543405;10713;10766;10814.134869210444;10823.512941917632;427653;432366;447125;477068;488938;65323.67338163279;73770.631146845;74820.62589687017;84753.57623211844;85476.14523854807;1020.4081632653043;1023.7952409518275;1050.333038520545;1077;1080.8865069167625;15756.842431575538;15988.840111598734;15995.920020399824;16045.358185672443;16058.598535036717;26142;26165.345866353495;29986;33363.499547507294;34711.13222169466;51180;51403.74298128635;52275.47724522858;52462.737686311324;52585;8107.716229931924;8198.467099638505;8277.344531093684;8387.370947179108;8469.02606200295;9350.859737104085;13043.413046412745;13077.803832942323;13499.730005400033;13592.86407135916;8479.36404769657;11629;11862.22895511789;11870.228435151688;12031.63905082849;11316.717082072684;11369.090472762324;11720.413979301171;11787.587434439753;11823.408829558315;11929.28424294545;12025.63923082309;12028.458719357475;12028.518859245882;12085.637430877088;7455;8189.877151842847;8350.248477637042;8385.161483851565;8650.740477785677;8943.032532842764;10397.896021039693;10421.635242766466;10521.526531305957;10630.415327157081 11:30:18 INFO - PROCESS | 16523 | |3;mootools.html;1334.032826201005;1503.9774403383947;1537.8539038791314;1703.6166862455948;1839.494139111745;8000.2799748022735;8311.335093192545;8343.08226095129;8344.207300306462;8356.874646880302;8124.065732440771;8262.42163048587;8282.958585207081;8290.58547072647;8293;2010.3868320162344;2235.508188198594;2281.555096756133;2308.2152068296778;2308.2382813671534;2369.5024044950583;2390.127603424755;2391.4977854650456;2394.1022116706235;2394.2936833634035;2304.4699719064624;2342.8360014798973;2343.5078633486987;2343.589871772433;2346.4603141277516;2021.2622392826586;2259.265738634942;2322.512272422793;2324.848884822481;2325.4186453386656;2250.4598896264943;2255.131774266919;2262.321303608911;2266.7506574276817;2297.9655305170436;7964.800879977989;7984.201579842027;8028.438009339348;8042.638081286356;8043.316318112968;4867.488913664085;5013.197888337849;5023.673461225008;5037.5718063964605;5093.465186155475;3373.6963673269524;3380.3746306933294;3448.5689288838894;3484.4947482615135;3488.4244099723514;1133.7675776465805;1139.595443617512;1160.8490896183441;1182.5920057580122;1183.1895151820945;11179.049780768644;11179.776404471946;11185.72035699106;11189.384583847885;11197.60808371703;4446.755428451402;4502.212112880298;4644.047970166108;4697.201475749131;4700.153972285021;9492.288078394009;9508.85736713936;9521.23830093591;9522.476263805556;9523.714288571355;4581.725096494221;5044.8234311798915;5048.697078175322;5066.873328166826;5102.515261050195;4579.95420045802;4678.1813182692895;4691.882702932454;4717.551832575899;4726.7636618169645;3818.2363527294096;3867.941980870289;3916.784576848244;3924.117073658404;3994.820233089518;1280.9167404118703;1304.8499422566526;1307.7253776706807;1310.8099325597734;1331.1148086522549;920.5489310237936;953.3136141977765;958.4632605740808;958.4680502321279;997.6807421625156;5466.453354664502;5564.527015203672;5673.659580425187;5736;5837.88324233513;893.2139717048956;969.4958621516772;977.1059480575336;992.503748125937;998.3909815012836;3884.126071633916;3985.9003524911527;4023.2355852387955;4074;4092.2633925893624;9896.10935015852;10548.367097974146;10669.306495077795;10687;10687.89312106869;10425.218108641731;10425.218108641882;10479.266451348332;10481.737956550995;10493.527791249413;7555.471117021865;7818.960905195438;7898;8027.959860200662;8036.316913062338;5513.807016754395;5524.475174858382;5525.668459892419;5539.612227144223;5575.303087114111;9068.319876009458;9112.95443522778;9159.267258619162;9179.036201198778;9257.814843703223;8964.3276754245;9541.188998935168;9545.809083818423;9684.128428441474;9690.660826871308;6522;7090.787276381717;7305.561666300039;7322.670479828527;7458.216887226763;8085.797855053671;8088.555129467701;8150.959245203736;8154.429189956646;8160.877586836321;7053.753118640823;7203.387712044325;7251.673674684546;7269.854602908018;7522.210167932289;7244.130704315305;7267.091613548307;7270.127584689871;7350.7427240046345;7371.668274927534;6791.185057793096;6857.794266172023;6881.827954301182;6883.311668833277;6884.690188941409;4990.72551009698;5088.821891233789;5089.262057001788;5102.1326374515675;5107.055194788827;5024.924626130684;5057.190849464068;5087.23691446286;5096.898062038813;5210.947890521046 11:30:18 INFO - PROCESS | 16523 | |4;prototype.html;330.49929357024126;337.6589644459096;340.4297801183018;342.7241070937895;344.2821716720637;5492.121260598305;5588.133839254911;5649.887002259958;5683.175939488771;5692.260006199193;5581.107022876341;5648.576356773238;5658.179563963233;5675.574331925101;5692.260006199188;4393.626541743947;4396.406485124499;4398.8900277493;4401.735895846259;4401.823927042915;4157.251694694954;4328.329108988112;4336.891577710567;4399.5160532341415;4428.586420400873;4271.829126834923;4276.3799249109015;4283.635890949273;4308.482982042159;4308.80610372534;4258.701890867656;4272.46594175728;4296.63478604319;4301.182775272689;4319;3576.3204991051616;3760.736748427611;3767.7362584619086;3773.2642984227286;3776.4146557283666;5415.458454154593;5427.538659213971;5439.592030597721;5444.754986025639;5453.291072160633;4934.580560652313;4959.82640607577;4961.3798275215595;4966.528179822947;4967.900641987176;5542.501174894279;5870.530357571384;5889.5288376930175;5898.262717160355;5904.822855314347;4094.7133700640966;4132.752034877917;4136.276151673445;4136.710430269883;4138.751674899486;6028.39716028398;6055.848603784896;6059.757609695607;6080.331163571959;6085.300190478108;4102.179564087194;4197.601227883407;4198.181354635817;4199.664026877843;4238.491381034296;4265.850695225714;4276.32729544035;4276.978615106967;4280.21785839207;4285.421468101828;4899.730514821647;4909.214525675875;4912.410510738734;4915.852524424273;4926.458089610212;5499.7250137492965;5715.971420142872;5878.706064696748;5883.0293001654245;5931.970340148272;1467.6330917270682;1475.6605980624302;1480.5854360778999;1481.7851411545266;1484.3097959448908;936.180841763457;960.1071003966239;974.2206235011962;975.7463059604554;985.0986347492108;5608.69152196625;5611.2144299798065;5629.296337957755;5630.436956304418;5643.097104463348;6016.819495415057;6071.210742603522;6083.832574686354;6084.5132389408745;6087.817365479043;5440.102383106743;5606.803761868397;5607.551395888319;5608.551315894719;5613.691246981373;3213.614366276062;3259.6088469383826;3265.2979609384097;3269.2644155065395;3281.7210537104615;6077.301110372276;6297.118403423525;6299.716512756937;6310.1481300024825;6331.9366806331345;6205.22434695663;6216.471599913967;6224.346443623445;6225.439710425992;6250.406211409909;6239.719212635442;6263.906041409383;6296.087067375296;6297.338779428185;6301.653409062454;5852.332085355653;6095;6095.878082438415;6104.17593624855;6107.450329470369;5888.411158884077;5951.345352011189;5966.105084237399;5976.820695379146;5983.880322393441;5992;6241.251049874044;6250.781222657185;6266.624002559861;6287;4194.077302993336;4212.810423530887;4243.575642435731;4244.1723863846255;4245.150969805989;5836.416358364129;5978.3423823378525;6031.879362412815;6082.939170608414;6093.573449858467;5953.374895636069;5973.193618861398;5974.462298393166;5979.551533635082;5983.192269043798;5900.232969713909;5915.881682366415;5920.319163296276;5931.906984180901;5938.6436813791315;5655.943440565542;5877.617954832922;5885.234919460443;5901.734421950937;5905.970470147622;5997.670128142994;6026.939730602813;6032.607880487754;6038.939610604013;6050.818475445743;5714.828555143353;5849.824505264849;5885.793997210077;5887.4406931341455;5913.793017244376 11:30:18 INFO - PROCESS | 16523 | |5;yui.html;737.2774680812805;795.3160282157344;808.3815880851146;837.5560952695074;851.9616617252223;14037.859621403783;14445.27773611318;14463.276836158202;14464;14482;12563.811542826843;13306.534271300507;13307.135036222662;13350.532731354404;13370.398332075056;802.1577343789028;812.2324403438753;813.2030610002201;813.7965508622844;817.81190326225;811.375241064383;813.3777660090036;816.6692489541745;817.4073796497521;817.5054092274178;859.8495263328924;863.1282404771164;863.7451951674271;863.8661007543809;864.8140649760301;849.9672897429652;850.1413572291967;850.2093053460279;852.9701460448886;853.3471894001094;623.2863371439721;623.9032949892774;623.9937600623981;624.2290770897937;624.6408315218767;12658.367081645973;12735.554255601102;12743;12743.617691469271;12753.426095825618;11154.219204655677;11240;11339.773204535863;11378.544858205662;11722.12084093688;9541.570629321628;9977.90022099777;9984.151347135503;10145.746356341077;10275.845862312071;3417.743669224818;3482.320947415255;3487.5291835602125;3493.1092571394133;3538.6461353864665;46491;46853;51010;51729.48270517284;51877.221841672406;10214.131798797185;10303.587856485807;10361.63734269297;10432.895671043345;10534.20993425496;18437.63124737498;18564.071796410124;18565.81434185668;18576.814231857777;18983.24067037303;7977.162397948248;7986.121526632066;8011.359091272684;8086.9191308086165;8133.389995750343;4123.958760412417;4220.177065472265;4231.597998190167;4266.893327666833;4336.956630433719;3291.4240007998505;3364.5626068611414;3365.3101114271517;3379.7803142795638;3511.227529943408;630.8139098965817;632.6710110742388;633.8954072577973;638.3775818576851;650.3951325267452;746.2127455534463;772.1467778105225;788.8698364769864;789.3961119743401;824.1634740738156;8549.487030778173;8585.18440748128;8686.91313086861;8836.91163088361;8977.46135231875;616.722474886294;627.1032423634247;724.0912654618526;765.12775436003;792.4215322814377;4284.635805956466;4404.471463424409;4430.800613972379;4520.886977825515;4526.366308716782;66993.66503167551;67402;67620.6618966902;69034;69078;44873.55126448759;58308;58636;58969;59879.40120598825;45918.770406148426;45978;46442;46908;47713.52286477091;8921.553922303729;8955.955220223857;8968.596413161293;9010.234130099016;9035.593398297224;34279.31441371208;34386.63847188278;34412;34569.48145777866;34621.826890865384;41845;43536;45753.54246457493;46380.07239855252;46708.766456167505;11409.543618255177;11623.941880290544;11680.824787628362;11709.707257318636;12081.523287726171;12349.753004939672;12381.195222310522;12426.130170887951;12432.286834465454;12731.61805145847;11471.942640286745;11875.703107422383;12131.696707582381;12200.81698774537;12485.812712809497;12080.275183489019;12336.444859981142;12517.874821251671;12577.182483138567;12657.430415631134;11389.715257118307;11556.42217889119;11670.766584668429;11679;11807.23252988553;10426.530806113591;10691.625793097204;10747.677569672922;10801.783964320826;10990.725231868948;9960.950195248977;10139.290249682452;10148.289619726844;10192.28653994243;10264.281500294908 11:30:18 INFO - PROCESS | 16523 | __end_tp_report 11:30:18 INFO - PROCESS | 16523 | __start_cc_report 11:30:18 INFO - PROCESS | 16523 | _x_x_mozilla_cycle_collect,800 11:30:18 INFO - PROCESS | 16523 | __end_cc_report 11:30:18 INFO - PROCESS | 16523 | __startTimestamp1461522618792__endTimestamp 11:30:18 INFO - PROCESS | 16523 | 11:30:18 INFO - PROCESS | 16523 | ------- Summary: start ------- 11:30:18 INFO - PROCESS | 16523 | Number of tests: 6 11:30:18 INFO - PROCESS | 16523 | 11:30:18 INFO - PROCESS | 16523 | [#0] dojo.html Cycles:165 Average:5246.01 Median:5454.62 stddev:600.75 (11.0%) stddev-sans-first:577.90 11:30:18 INFO - PROCESS | 16523 | Values: 3072.8 3145.8 3180.3 3182.2 3213.5 5179.9 5257.6 5264.2 5302.1 5339.3 5316.4 5336.8 5345.7 5348.9 5388.8 4695.1 4736.9 4869.7 4912.1 4926.8 4823.0 4850.0 4885.7 4891.9 4895.0 4677.8 4741.5 4770.3 4773.7 4776.5 4757.1 4767.3 4769.2 4779.9 4800.7 4645.5 4731.9 4737.8 4754.0 4799.9 5144.3 5163.3 5169.5 5215.2 5218.4 5541.5 5563.6 5570.2 5571.9 5581.4 5536.4 5639.9 5657.5 5708.3 5768.3 5295.3 5302.4 5307.4 5308.6 5316.4 5780.7 5800.7 5801.6 5802.1 5805.0 5312.7 5564.2 5569.7 5662.0 5665.6 5656.5 5680.2 5683.0 5683.0 5684.0 5590.0 5613.4 5633.9 5637.4 5640.4 5484.3 5608.1 5645.7 5664.6 5692.3 4179.8 4179.9 4190.3 4203.9 4221.2 3761.5 3777.6 3782.9 3809.6 3839.9 5304.8 5323.4 5331.9 5363.7 5368.4 5613.6 5621.5 5621.7 5627.3 5630.8 5229.1 5241.0 5258.7 5264.7 5271.2 4894.2 4907.1 4916.7 4916.9 4949.0 5881.6 5893.1 5896.1 5897.7 5898.2 5556.7 5718.9 5738.8 5768.7 5801.9 5857.5 5862.9 5865.9 5882.7 5918.2 5632.0 5642.6 5642.9 5643.5 5644.4 5497.9 5640.1 5719.0 5730.6 5731.9 5512.6 5522.6 5530.7 5536.4 5569.4 5539.9 5557.9 5560.3 5563.6 5611.1 5283.4 5410.1 5470.8 5474.2 5513.1 5549.9 5553.2 5579.0 5579.9 5587.6 5181.1 5409.4 5436.8 5453.1 5454.6 11:30:18 INFO - PROCESS | 16523 | 11:30:18 INFO - PROCESS | 16523 | [#1] ext.html Cycles:180 Average:57199.08 Median:21749.09 stddev:112627.88 (517.9%) stddev-sans-first:112863.65 11:30:18 INFO - PROCESS | 16523 | Values: 596.3 641.3 644.1 659.6 663.9 31256.8 36683.2 37731.2 37749.2 37751.4 39223.8 39972.6 40013.6 40052.8 40064.4 8542.1 8731.8 8745.8 8746.8 8747.0 8531.0 8611.0 8638.6 8655.3 8655.5 8693.0 9005.7 9007.4 9009.7 9009.8 8895.0 8955.6 8958.4 8964.6 8971.8 8757.1 8896.5 8900.2 8900.3 8907.7 40867.8 41365.4 41467.4 41531.2 41578.4 3368.2 3557.9 3574.0 3644.5 3860.2 29925.9 30528.0 30621.4 30878.5 30951.7 3873.3 3879.5 3881.8 3925.1 3957.0 270616.0 273580.0 274029.0 274175.0 274822.0 53894.7 57371.1 58015.0 58038.7 58085.7 65016.3 66637.7 66868.0 66871.7 66980.7 14875.6 14950.3 14983.6 15033.5 15056.3 10989.9 11255.1 11320.4 11367.8 11420.3 17399.8 18789.0 19417.2 20044.9 20140.5 6875.0 6942.4 7033.6 7139.3 7235.5 1014.0 1021.6 1061.6 1103.9 1146.4 31645.2 32236.4 32248.0 32311.5 33156.7 1147.7 1164.0 1180.1 1185.9 1200.3 16486.9 17081.3 17345.3 17395.3 17588.6 525499.0 535855.0 537770.0 539290.0 539353.0 56376.2 56961.7 57175.4 57183.0 57193.7 1335.8 1377.1 1412.2 1418.0 1500.8 30297.1 31158.0 31576.8 32081.6 32273.4 51487.7 52006.0 52122.5 52183.5 52264.0 412167.0 420423.0 422897.0 425783.0 425973.0 25520.4 28208.6 28566.7 29001.9 29032.3 46906.0 48542.3 49102.5 49575.3 53259.5 38061.6 39248.8 39433.6 39681.8 39854.8 38025.4 39221.4 39541.2 39935.0 40069.8 39616.4 40096.8 40597.4 40624.4 40631.0 33682.8 35157.5 35453.0 35759.0 35805.5 26929.5 27045.3 27277.9 27295.5 27307.5 11:30:18 INFO - PROCESS | 16523 | 11:30:18 INFO - PROCESS | 16523 | [#2] jquery.html Cycles:180 Average:28188.12 Median:30107.05 stddev:74876.76 (248.7%) stddev-sans-first:75057.70 11:30:18 INFO - PROCESS | 16523 | Values: 382.4 399.6 401.7 403.8 411.2 14276.9 16544.3 17829.6 18304.3 18386.4 17676.6 18247.2 18778.1 18889.0 19910.9 6233.4 6432.4 6458.9 6487.4 6491.2 4538.3 6332.9 6402.9 6743.5 7129.1 7036.8 7037.7 7128.3 7139.9 7144.1 7101.4 7252.1 7283.6 7289.8 7291.4 6805.5 6989.6 7068.5 7083.4 7091.6 24341.9 25380.1 25658.6 25770.7 25800.9 2131.5 2260.5 2397.3 2422.9 2900.6 14200.4 14698.3 14726.9 15429.5 15494.0 1839.5 1849.8 1849.9 1860.6 1974.1 84532.0 86866.0 88227.6 89891.6 90780.5 16545.0 16870.7 16912.4 17208.7 17260.3 29691.9 29839.0 30092.4 30121.7 30154.5 8865.7 9180.0 9265.0 9325.4 9433.2 7582.2 7653.1 7693.4 7762.8 7834.0 8654.9 8770.1 8784.9 8790.4 8889.4 3278.1 3385.7 3405.9 3441.3 3463.6 931.6 984.8 1009.8 1021.3 1026.7 18168.8 18498.4 18577.3 18813.5 19255.7 1018.7 1030.2 1042.3 1061.9 1083.0 10339.6 10713.0 10766.0 10814.1 10823.5 427653.0 432366.0 447125.0 477068.0 488938.0 65323.7 73770.6 74820.6 84753.6 85476.1 1020.4 1023.8 1050.3 1077.0 1080.9 15756.8 15988.8 15995.9 16045.4 16058.6 26142.0 26165.3 29986.0 33363.5 34711.1 51180.0 51403.7 52275.5 52462.7 52585.0 8107.7 8198.5 8277.3 8387.4 8469.0 9350.9 13043.4 13077.8 13499.7 13592.9 8479.4 11629.0 11862.2 11870.2 12031.6 11316.7 11369.1 11720.4 11787.6 11823.4 11929.3 12025.6 12028.5 12028.5 12085.6 7455.0 8189.9 8350.2 8385.2 8650.7 8943.0 10397.9 10421.6 10521.5 10630.4 11:30:18 INFO - PROCESS | 16523 | 11:30:18 INFO - PROCESS | 16523 | [#3] mootools.html Cycles:180 Average:5522.26 Median:5088.03 stddev:3029.09 (59.5%) stddev-sans-first:3021.23 11:30:18 INFO - PROCESS | 16523 | Values: 1334.0 1504.0 1537.9 1703.6 1839.5 8000.3 8311.3 8343.1 8344.2 8356.9 8124.1 8262.4 8283.0 8290.6 8293.0 2010.4 2235.5 2281.6 2308.2 2308.2 2369.5 2390.1 2391.5 2394.1 2394.3 2304.5 2342.8 2343.5 2343.6 2346.5 2021.3 2259.3 2322.5 2324.8 2325.4 2250.5 2255.1 2262.3 2266.8 2298.0 7964.8 7984.2 8028.4 8042.6 8043.3 4867.5 5013.2 5023.7 5037.6 5093.5 3373.7 3380.4 3448.6 3484.5 3488.4 1133.8 1139.6 1160.8 1182.6 1183.2 11179.0 11179.8 11185.7 11189.4 11197.6 4446.8 4502.2 4644.0 4697.2 4700.2 9492.3 9508.9 9521.2 9522.5 9523.7 4581.7 5044.8 5048.7 5066.9 5102.5 4580.0 4678.2 4691.9 4717.6 4726.8 3818.2 3867.9 3916.8 3924.1 3994.8 1280.9 1304.8 1307.7 1310.8 1331.1 920.5 953.3 958.5 958.5 997.7 5466.5 5564.5 5673.7 5736.0 5837.9 893.2 969.5 977.1 992.5 998.4 3884.1 3985.9 4023.2 4074.0 4092.3 9896.1 10548.4 10669.3 10687.0 10687.9 10425.2 10425.2 10479.3 10481.7 10493.5 7555.5 7819.0 7898.0 8028.0 8036.3 5513.8 5524.5 5525.7 5539.6 5575.3 9068.3 9113.0 9159.3 9179.0 9257.8 8964.3 9541.2 9545.8 9684.1 9690.7 6522.0 7090.8 7305.6 7322.7 7458.2 8085.8 8088.6 8151.0 8154.4 8160.9 7053.8 7203.4 7251.7 7269.9 7522.2 7244.1 7267.1 7270.1 7350.7 7371.7 6791.2 6857.8 6881.8 6883.3 6884.7 4990.7 5088.8 5089.3 5102.1 5107.1 5024.9 5057.2 5087.2 5096.9 5210.9 11:30:18 INFO - PROCESS | 16523 | 11:30:18 INFO - PROCESS | 16523 | [#4] prototype.html Cycles:180 Average:4944.89 Median:5649.23 stddev:1478.15 (26.2%) stddev-sans-first:1441.15 11:30:18 INFO - PROCESS | 16523 | Values: 330.5 337.7 340.4 342.7 344.3 5492.1 5588.1 5649.9 5683.2 5692.3 5581.1 5648.6 5658.2 5675.6 5692.3 4393.6 4396.4 4398.9 4401.7 4401.8 4157.3 4328.3 4336.9 4399.5 4428.6 4271.8 4276.4 4283.6 4308.5 4308.8 4258.7 4272.5 4296.6 4301.2 4319.0 3576.3 3760.7 3767.7 3773.3 3776.4 5415.5 5427.5 5439.6 5444.8 5453.3 4934.6 4959.8 4961.4 4966.5 4967.9 5542.5 5870.5 5889.5 5898.3 5904.8 4094.7 4132.8 4136.3 4136.7 4138.8 6028.4 6055.8 6059.8 6080.3 6085.3 4102.2 4197.6 4198.2 4199.7 4238.5 4265.9 4276.3 4277.0 4280.2 4285.4 4899.7 4909.2 4912.4 4915.9 4926.5 5499.7 5716.0 5878.7 5883.0 5932.0 1467.6 1475.7 1480.6 1481.8 1484.3 936.2 960.1 974.2 975.7 985.1 5608.7 5611.2 5629.3 5630.4 5643.1 6016.8 6071.2 6083.8 6084.5 6087.8 5440.1 5606.8 5607.6 5608.6 5613.7 3213.6 3259.6 3265.3 3269.3 3281.7 6077.3 6297.1 6299.7 6310.1 6331.9 6205.2 6216.5 6224.3 6225.4 6250.4 6239.7 6263.9 6296.1 6297.3 6301.7 5852.3 6095.0 6095.9 6104.2 6107.5 5888.4 5951.3 5966.1 5976.8 5983.9 5992.0 6241.3 6250.8 6266.6 6287.0 4194.1 4212.8 4243.6 4244.2 4245.2 5836.4 5978.3 6031.9 6082.9 6093.6 5953.4 5973.2 5974.5 5979.6 5983.2 5900.2 5915.9 5920.3 5931.9 5938.6 5655.9 5877.6 5885.2 5901.7 5906.0 5997.7 6026.9 6032.6 6038.9 6050.8 5714.8 5849.8 5885.8 5887.4 5913.8 11:30:18 INFO - PROCESS | 16523 | 11:30:18 INFO - PROCESS | 16523 | [#5] yui.html Cycles:180 Average:14432.70 Median:24652.18 stddev:17214.78 (69.8%) stddev-sans-first:17232.36 11:30:18 INFO - PROCESS | 16523 | Values: 737.3 795.3 808.4 837.6 852.0 14037.9 14445.3 14463.3 14464.0 14482.0 12563.8 13306.5 13307.1 13350.5 13370.4 802.2 812.2 813.2 813.8 817.8 811.4 813.4 816.7 817.4 817.5 859.8 863.1 863.7 863.9 864.8 850.0 850.1 850.2 853.0 853.3 623.3 623.9 624.0 624.2 624.6 12658.4 12735.6 12743.0 12743.6 12753.4 11154.2 11240.0 11339.8 11378.5 11722.1 9541.6 9977.9 9984.2 10145.7 10275.8 3417.7 3482.3 3487.5 3493.1 3538.6 46491.0 46853.0 51010.0 51729.5 51877.2 10214.1 10303.6 10361.6 10432.9 10534.2 18437.6 18564.1 18565.8 18576.8 18983.2 7977.2 7986.1 8011.4 8086.9 8133.4 4124.0 4220.2 4231.6 4266.9 4337.0 3291.4 3364.6 3365.3 3379.8 3511.2 630.8 632.7 633.9 638.4 650.4 746.2 772.1 788.9 789.4 824.2 8549.5 8585.2 8686.9 8836.9 8977.5 616.7 627.1 724.1 765.1 792.4 4284.6 4404.5 4430.8 4520.9 4526.4 66993.7 67402.0 67620.7 69034.0 69078.0 44873.6 58308.0 58636.0 58969.0 59879.4 45918.8 45978.0 46442.0 46908.0 47713.5 8921.6 8956.0 8968.6 9010.2 9035.6 34279.3 34386.6 34412.0 34569.5 34621.8 41845.0 43536.0 45753.5 46380.1 46708.8 11409.5 11623.9 11680.8 11709.7 12081.5 12349.8 12381.2 12426.1 12432.3 12731.6 11471.9 11875.7 12131.7 12200.8 12485.8 12080.3 12336.4 12517.9 12577.2 12657.4 11389.7 11556.4 11670.8 11679.0 11807.2 10426.5 10691.6 10747.7 10801.8 10990.7 9961.0 10139.3 10148.3 10192.3 10264.3 11:30:18 INFO - PROCESS | 16523 | -------- Summary: end -------- 11:30:18 INFO - PROCESS | 16523 | 11:30:19 INFO - TEST-INFO | 16523: exit 0 11:30:19 INFO - TEST-OK | dromaeo_css | took 1110726ms 11:30:19 INFO - TEST-START | kraken 11:30:19 INFO - operating with platform_type : linux_ 11:30:19 INFO - Initialising browser for kraken test... 11:30:19 INFO - TEST-INFO | started process 16704 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp94W7DC/profile http://localhost:59763/getInfo.html) 11:30:23 INFO - PROCESS | 16704 | __metrics Screen width/height:1600/1200 11:30:23 INFO - PROCESS | 16704 | colorDepth:24 11:30:23 INFO - PROCESS | 16704 | Browser inner width/height: 1024/697 11:30:23 INFO - PROCESS | 16704 | __metrics 11:30:24 ERROR - PROCESS | 16704 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:30:25 INFO - TEST-INFO | 16704: exit 0 11:30:25 INFO - Browser initialized. 11:30:25 INFO - Running cycle 1/1 for kraken test... 11:30:25 INFO - TEST-INFO | started process 16786 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp94W7DC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:30:36 INFO - PROCESS | 16786 | RSS: Main: 153620480 11:30:36 INFO - PROCESS | 16786 | 11:30:39 INFO - PROCESS | 16786 | Cycle 1(1): loaded http://localhost:59763/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59763/tests/kraken/driver.html?testName=audio-beat-detection) 11:30:40 INFO - PROCESS | 16786 | RSS: Main: 209072128 11:30:40 INFO - PROCESS | 16786 | 11:30:43 INFO - PROCESS | 16786 | Cycle 1(1): loaded http://localhost:59763/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59763/tests/kraken/driver.html?testName=audio-dft) 11:30:43 INFO - PROCESS | 16786 | RSS: Main: 194359296 11:30:43 INFO - PROCESS | 16786 | 11:30:46 INFO - PROCESS | 16786 | Cycle 1(1): loaded http://localhost:59763/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59763/tests/kraken/driver.html?testName=audio-fft) 11:30:47 INFO - PROCESS | 16786 | RSS: Main: 265351168 11:30:47 INFO - PROCESS | 16786 | 11:30:49 INFO - PROCESS | 16786 | Cycle 1(1): loaded http://localhost:59763/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59763/tests/kraken/driver.html?testName=audio-oscillator) 11:30:49 INFO - PROCESS | 16786 | RSS: Main: 173404160 11:30:49 INFO - PROCESS | 16786 | 11:30:52 INFO - PROCESS | 16786 | Cycle 1(1): loaded http://localhost:59763/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59763/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:30:52 INFO - PROCESS | 16786 | RSS: Main: 178049024 11:30:52 INFO - PROCESS | 16786 | 11:30:55 INFO - PROCESS | 16786 | Cycle 1(1): loaded http://localhost:59763/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59763/tests/kraken/driver.html?testName=imaging-darkroom) 11:30:56 INFO - PROCESS | 16786 | RSS: Main: 214540288 11:30:56 INFO - PROCESS | 16786 | 11:30:59 INFO - PROCESS | 16786 | Cycle 1(1): loaded http://localhost:59763/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59763/tests/kraken/driver.html?testName=imaging-desaturate) 11:31:00 INFO - PROCESS | 16786 | RSS: Main: 214982656 11:31:00 INFO - PROCESS | 16786 | 11:31:03 INFO - PROCESS | 16786 | Cycle 1(1): loaded http://localhost:59763/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59763/tests/kraken/driver.html?testName=json-parse-financial) 11:31:03 INFO - PROCESS | 16786 | RSS: Main: 214720512 11:31:03 INFO - PROCESS | 16786 | 11:31:05 INFO - PROCESS | 16786 | Cycle 1(1): loaded http://localhost:59763/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59763/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:31:05 INFO - PROCESS | 16786 | RSS: Main: 202547200 11:31:05 INFO - PROCESS | 16786 | 11:31:07 INFO - PROCESS | 16786 | Cycle 1(1): loaded http://localhost:59763/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59763/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:31:08 INFO - PROCESS | 16786 | RSS: Main: 205287424 11:31:08 INFO - PROCESS | 16786 | 11:31:10 INFO - PROCESS | 16786 | Cycle 1(1): loaded http://localhost:59763/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59763/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:31:10 INFO - PROCESS | 16786 | RSS: Main: 213872640 11:31:10 INFO - PROCESS | 16786 | 11:31:13 INFO - PROCESS | 16786 | Cycle 1(1): loaded http://localhost:59763/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59763/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:31:14 INFO - PROCESS | 16786 | RSS: Main: 222253056 11:31:14 INFO - PROCESS | 16786 | 11:31:16 INFO - PROCESS | 16786 | Cycle 1(1): loaded http://localhost:59763/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59763/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:31:17 INFO - PROCESS | 16786 | RSS: Main: 220532736 11:31:17 INFO - PROCESS | 16786 | 11:31:19 INFO - PROCESS | 16786 | Cycle 1(1): loaded http://localhost:59763/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59763/tests/kraken/driver.html?testName=ai-astar) 11:31:19 INFO - PROCESS | 16786 | RSS: Main: 283701248 11:31:19 INFO - PROCESS | 16786 | 11:31:19 INFO - PROCESS | 16786 | __start_tp_report 11:31:19 INFO - PROCESS | 16786 | _x_x_mozilla_page_load 11:31:19 INFO - PROCESS | 16786 | _x_x_mozilla_page_load_details 11:31:19 INFO - PROCESS | 16786 | |i|pagename|runs| 11:31:19 INFO - PROCESS | 16786 | |0;ai-astar;111;111;105;111;111;112;101;113;113;110 11:31:19 INFO - PROCESS | 16786 | |1;audio-beat-detection;165;128;159;188;130;156;152;143;203;134 11:31:19 INFO - PROCESS | 16786 | |2;audio-dft;162;161;161;160;159;161;162;161;161;161 11:31:19 INFO - PROCESS | 16786 | |3;audio-fft;76;73;103;105;74;77;76;119;103;73 11:31:19 INFO - PROCESS | 16786 | |4;audio-oscillator;91;93;147;92;93;93;157;92;92;155 11:31:19 INFO - PROCESS | 16786 | |5;imaging-gaussian-blur;117;117;116;117;116;116;117;116;117;117 11:31:19 INFO - PROCESS | 16786 | |6;imaging-darkroom;146;145;144;146;145;145;145;145;145;144 11:31:19 INFO - PROCESS | 16786 | |7;imaging-desaturate;94;95;94;94;95;94;95;94;95;95 11:31:19 INFO - PROCESS | 16786 | |8;json-parse-financial;62;70;61;62;61;66;61;83;61;59 11:31:19 INFO - PROCESS | 16786 | |9;json-stringify-tinderbox;60;61;61;61;61;60;62;61;61;62 11:31:19 INFO - PROCESS | 16786 | |10;stanford-crypto-aes;77;78;76;76;79;79;78;78;77;78 11:31:19 INFO - PROCESS | 16786 | |11;stanford-crypto-ccm;125;129;125;124;123;122;131;124;157;127 11:31:19 INFO - PROCESS | 16786 | |12;stanford-crypto-pbkdf2;167;172;174;172;173;174;168;173;167;166 11:31:19 INFO - PROCESS | 16786 | |13;stanford-crypto-sha256-iterative;69;69;69;69;73;68;72;68;66;68 11:31:19 INFO - PROCESS | 16786 | __end_tp_report 11:31:19 INFO - PROCESS | 16786 | __start_cc_report 11:31:19 INFO - PROCESS | 16786 | _x_x_mozilla_cycle_collect,1643 11:31:19 INFO - PROCESS | 16786 | __end_cc_report 11:31:19 INFO - PROCESS | 16786 | __startTimestamp1461522679493__endTimestamp 11:31:19 INFO - PROCESS | 16786 | 11:31:19 INFO - PROCESS | 16786 | ------- Summary: start ------- 11:31:19 INFO - PROCESS | 16786 | Number of tests: 14 11:31:19 INFO - PROCESS | 16786 | 11:31:19 INFO - PROCESS | 16786 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:3.82 (3.4%) stddev-sans-first:4.03 11:31:19 INFO - PROCESS | 16786 | Values: 111.0 111.0 105.0 111.0 111.0 112.0 101.0 113.0 113.0 110.0 11:31:19 INFO - PROCESS | 16786 | 11:31:19 INFO - PROCESS | 16786 | [#1] audio-beat-detection Cycles:10 Average:155.80 Median:157.50 stddev:24.61 (15.6%) stddev-sans-first:25.88 11:31:19 INFO - PROCESS | 16786 | Values: 165.0 128.0 159.0 188.0 130.0 156.0 152.0 143.0 203.0 134.0 11:31:19 INFO - PROCESS | 16786 | 11:31:19 INFO - PROCESS | 16786 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.83 11:31:19 INFO - PROCESS | 16786 | Values: 162.0 161.0 161.0 160.0 159.0 161.0 162.0 161.0 161.0 161.0 11:31:19 INFO - PROCESS | 16786 | 11:31:19 INFO - PROCESS | 16786 | [#3] audio-fft Cycles:10 Average:87.90 Median:73.50 stddev:17.50 (23.8%) stddev-sans-first:18.02 11:31:19 INFO - PROCESS | 16786 | Values: 76.0 73.0 103.0 105.0 74.0 77.0 76.0 119.0 103.0 73.0 11:31:19 INFO - PROCESS | 16786 | 11:31:19 INFO - PROCESS | 16786 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:92.00 stddev:29.44 (32.0%) stddev-sans-first:30.37 11:31:19 INFO - PROCESS | 16786 | Values: 91.0 93.0 147.0 92.0 93.0 93.0 157.0 92.0 92.0 155.0 11:31:19 INFO - PROCESS | 16786 | 11:31:19 INFO - PROCESS | 16786 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 11:31:19 INFO - PROCESS | 16786 | Values: 117.0 117.0 116.0 117.0 116.0 116.0 117.0 116.0 117.0 117.0 11:31:19 INFO - PROCESS | 16786 | 11:31:19 INFO - PROCESS | 16786 | [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 11:31:19 INFO - PROCESS | 16786 | Values: 146.0 145.0 144.0 146.0 145.0 145.0 145.0 145.0 145.0 144.0 11:31:19 INFO - PROCESS | 16786 | 11:31:19 INFO - PROCESS | 16786 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 11:31:19 INFO - PROCESS | 16786 | Values: 94.0 95.0 94.0 94.0 95.0 94.0 95.0 94.0 95.0 95.0 11:31:19 INFO - PROCESS | 16786 | 11:31:19 INFO - PROCESS | 16786 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:62.00 stddev:7.20 (11.6%) stddev-sans-first:7.57 11:31:19 INFO - PROCESS | 16786 | Values: 62.0 70.0 61.0 62.0 61.0 66.0 61.0 83.0 61.0 59.0 11:31:19 INFO - PROCESS | 16786 | 11:31:19 INFO - PROCESS | 16786 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.67 (1.1%) stddev-sans-first:0.60 11:31:19 INFO - PROCESS | 16786 | Values: 60.0 61.0 61.0 61.0 61.0 60.0 62.0 61.0 61.0 62.0 11:31:19 INFO - PROCESS | 16786 | 11:31:19 INFO - PROCESS | 16786 | [#10] stanford-crypto-aes Cycles:10 Average:77.60 Median:78.00 stddev:1.07 (1.4%) stddev-sans-first:1.12 11:31:19 INFO - PROCESS | 16786 | Values: 77.0 78.0 76.0 76.0 79.0 79.0 78.0 78.0 77.0 78.0 11:31:19 INFO - PROCESS | 16786 | 11:31:19 INFO - PROCESS | 16786 | [#11] stanford-crypto-ccm Cycles:10 Average:128.70 Median:126.00 stddev:10.32 (8.2%) stddev-sans-first:10.86 11:31:19 INFO - PROCESS | 16786 | Values: 125.0 129.0 125.0 124.0 123.0 122.0 131.0 124.0 157.0 127.0 11:31:19 INFO - PROCESS | 16786 | 11:31:19 INFO - PROCESS | 16786 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.60 Median:172.50 stddev:3.20 (1.9%) stddev-sans-first:3.12 11:31:19 INFO - PROCESS | 16786 | Values: 167.0 172.0 174.0 172.0 173.0 174.0 168.0 173.0 167.0 166.0 11:31:19 INFO - PROCESS | 16786 | 11:31:19 INFO - PROCESS | 16786 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.00 stddev:2.02 (2.9%) stddev-sans-first:2.15 11:31:19 INFO - PROCESS | 16786 | Values: 69.0 69.0 69.0 69.0 73.0 68.0 72.0 68.0 66.0 68.0 11:31:19 INFO - PROCESS | 16786 | -------- Summary: end -------- 11:31:19 INFO - PROCESS | 16786 | 11:31:20 INFO - TEST-INFO | 16786: exit 0 11:31:20 INFO - TEST-OK | kraken | took 61009ms 11:31:20 INFO - SUITE-END | took 1171s 11:31:20 INFO - Completed test suite (00:19:31) 11:31:20 INFO - javascript benchmark 11:31:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3072.800267982581, 3145.8427078646064, 3180.348028654126, 3182.1567284669554, 3213.4697774867154, 5179.896402071956, 5257.605679574028, 5264.184051472023, 5302.072137375963, 5339.332583427076, 5316.388615309241, 5336.8132115375965, 5345.732713364326, 5348.866278343034, 5388.78444862205, 4695.131400690866, 4736.8578942631775, 4869.732164730938, 4912.091263116317, 4926.827561035365, 4822.975885120587, 4849.951500485003, 4885.706857588539, 4891.853244402656, 4895.0, 4677.812887484497, 4741.525847415248, 4770.2844573314105, 4773.71357718538, 4776.522347765231, 4757.119932812441, 4767.284907263904, 4769.236922092448, 4779.856604301876, 4800.711957282574, 4645.535446455361, 4731.905361892743, 4737.763111844394, 4754.049190161947, 4799.928001079987, 5144.254083157921, 5163.328767260232, 5169.508896654812, 5215.191645294985, 5218.399884013349, 5541.501264886139, 5563.610547261694, 5570.248016517799, 5571.944280557183, 5581.441855814427, 5536.446355364472, 5639.915401268943, 5657.462541058593, 5708.286464191976, 5768.307803063659, 5295.338082739658, 5302.443243459458, 5307.442718514578, 5308.628396012281, 5316.3620365556, 5780.71096445176, 5800.738966746507, 5801.564882633819, 5802.129680547867, 5805.042168042226, 5312.7343632818975, 5564.165375193753, 5569.693666848281, 5662.037453632893, 5665.631733937364, 5656.547476201894, 5680.233168522279, 5682.971585142048, 5682.971585142131, 5684.0, 5590.049691552445, 5613.354464236665, 5633.859153521113, 5637.379888212294, 5640.435956404327, 5484.314460692413, 5608.130739735348, 5645.661260324394, 5664.6034777566, 5692.288463942007, 4179.811908464127, 4179.895502612459, 4190.308599081179, 4203.915921681611, 4221.2190744712325, 3761.4921985531605, 3777.565579958285, 3782.9432558511644, 3809.6190380962234, 3839.9424008639894, 5304.761285742151, 5323.441038690959, 5331.920021199685, 5363.704996225167, 5368.355797304349, 5613.635113717595, 5621.4659607337235, 5621.718914054362, 5627.268455100892, 5630.831075067755, 5229.137192363218, 5241.030409374278, 5258.684478931276, 5264.710440925709, 5271.20931860224, 4894.241392584155, 4907.116718990616, 4916.70499770015, 4916.852494425173, 4948.975255123702, 5881.558883083786, 5893.057110862242, 5896.10673883407, 5897.705114744245, 5898.203742494794, 5556.749946252347, 5718.857028574319, 5738.799142030009, 5768.653880767083, 5801.94198058014, 5857.531397488276, 5862.882742345215, 5865.94134058671, 5882.705864706833, 5918.23063001807, 5632.042552766122, 5642.60501764889, 5642.88714225705, 5643.520300774316, 5644.435556444323, 5497.945020549743, 5640.125780504029, 5719.0, 5730.570207234391, 5731.8567035824435, 5512.586556008396, 5522.558195344443, 5530.695811730233, 5536.390996990247, 5569.387367389503, 5539.9169012464035, 5557.944420555743, 5560.304961879765, 5563.638363506359, 5611.130274807411, 5283.418823929442, 5410.1343784994215, 5470.753816078206, 5474.178873168898, 5513.062779327604, 5549.944500554942, 5553.222548843246, 5579.0, 5579.860503487283, 5587.580931430078, 5181.06740786647, 5409.377921539073, 5436.7553460093595, 5453.072977593898, 5454.618176727749], "value": 5205.773954226467, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.335086378688, 641.2913730327987, 644.1014784375795, 659.6306068601581, 663.8738639658465, 31256.84371578142, 36683.231179946604, 37731.24537509248, 37749.24501509972, 37751.43372849409, 39223.803880980624, 39972.600273997254, 40013.59986400135, 40052.799736001354, 40064.39903401451, 8542.103079176706, 8731.825363492726, 8745.825083498326, 8746.825063498727, 8746.956265218665, 8530.957345213295, 8611.0, 8638.611262493203, 8655.307575393985, 8655.523946182957, 8693.0, 9005.729828105168, 9007.369484136114, 9009.729708108767, 9009.77475563113, 8895.0, 8955.641774329019, 8958.37291389603, 8964.551772411385, 8971.820563588757, 8757.124287571256, 8896.466212027299, 8900.243479304267, 8900.287976961827, 8907.688230911886, 40867.7956610218, 41365.37951930724, 41467.37798933018, 41531.1693766126, 41578.37632435516, 3368.208471009311, 3557.8932632020824, 3573.9642603573893, 3644.5079914211774, 3860.247251785903, 29925.920001599665, 30528.0, 30621.387572248652, 30878.536821947688, 30951.690483095106, 3873.32216862048, 3879.4568760373572, 3881.7670939743425, 3925.0972276376306, 3956.980215098935, 270616.0, 273580.0, 274029.0, 274175.0, 274822.0, 53894.73052634712, 57371.13943290854, 58015.0, 58038.709806451545, 58085.70957145187, 65016.34983650198, 66637.66942140489, 66868.0, 66871.66564167148, 66980.66509667518, 14875.553733388017, 14950.327235274439, 14983.625409364853, 15033.548993530212, 15056.32246548908, 10989.890101099047, 11255.099592032619, 11320.433978301216, 11367.772644547229, 11420.31478111316, 17399.82600173982, 18789.0, 19417.206336307714, 20044.899775501028, 20140.496487587927, 6875.0, 6942.444604431634, 7033.577985320897, 7139.32176443237, 7235.493515453868, 1013.9543720532446, 1021.6015753856002, 1061.6284300494765, 1103.8951299626522, 1146.3981409759942, 31645.20886977844, 32236.35527289488, 32248.0, 32311.51532727011, 33156.6896303479, 1147.73602071524, 1163.959261425846, 1180.055955235808, 1185.875483074282, 1200.3098218524208, 16486.917565412095, 17081.316747330216, 17345.3061877526, 17395.260473952756, 17588.648227035388, 525499.0, 535855.0, 537770.0, 539290.0, 539353.0, 56376.15435768467, 56961.71519142378, 57175.42824571784, 57183.0, 57193.71403143041, 1335.8196643453205, 1377.0842389810864, 1412.2091628687967, 1417.964550886236, 1500.7748837674217, 30297.091087267418, 31158.0, 31576.842115789274, 32081.58739830263, 32273.35453290968, 51487.742561286956, 52006.0, 52122.47877521176, 52183.478165217864, 52264.0, 412167.0, 420423.0, 422897.0, 425783.0, 425973.0, 25520.361990950376, 28208.576871347355, 28566.71433285724, 29001.85499072491, 29032.274193145342, 46906.0, 48542.27186592275, 49102.5089749098, 49575.256371155185, 53259.46740532545, 38061.619383806916, 39248.80375598104, 39433.605663942995, 39681.80159099186, 39854.80072599618, 38025.429618555194, 39221.41167882541, 39541.2091758169, 39935.0, 40069.79965100156, 39616.40575391314, 40096.79951600223, 40597.39103913384, 40624.390634141106, 40631.0, 33682.81061731077, 35157.47263791096, 35453.0, 35759.0, 35805.46291805573, 26929.461410771284, 27045.2698694401, 27277.86361068182, 27295.45409091847, 27307.453850923266], "value": 19638.52933794637, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.41299605106167, 399.5984036043777, 401.7208040411915, 403.7637981780658, 411.22894572676233, 14276.928615356908, 16544.338226470925, 17829.643407131865, 18304.26782928683, 18386.356477523288, 17676.558086047855, 18247.178876950537, 18778.061096945134, 18889.0, 19910.90044549775, 6233.407826256498, 6432.42108210261, 6458.870822583545, 6487.41613254807, 6491.221053473566, 4538.29656403258, 6332.936670633304, 6402.903956440658, 6743.49423793215, 7129.108861392326, 7036.82407939803, 7037.683304251295, 7128.251533588977, 7139.89290160648, 7144.142702875636, 7101.396381307595, 7252.057232559733, 7283.635818209068, 7289.817754556152, 7291.41668666508, 6805.489588280899, 6989.615571143636, 7068.505204635678, 7083.433325333961, 7091.609961452118, 24341.878290608434, 25380.11169609055, 25658.615120773204, 25770.742292577022, 25800.87099564509, 2131.4564785979633, 2260.49138943738, 2397.30478161333, 2422.91519796808, 2900.550414685727, 14200.431982720678, 14698.265086745727, 14726.852731472762, 15429.459968901147, 15494.0, 1839.4757494114112, 1849.8335149836444, 1849.8982555959417, 1860.5999710062267, 1974.0919177178514, 84532.0, 86866.0, 88227.55886220527, 89891.55054224753, 90780.54609726975, 16545.0, 16870.662586748196, 16912.408065717642, 17208.65582688339, 17260.309587616353, 29691.85154074259, 29839.0, 30092.398152036836, 30121.69878301189, 30154.547681784792, 8865.68970086044, 9179.996901688595, 9265.0, 9325.393849399903, 9433.198178154797, 7582.203868593829, 7653.119891212582, 7693.384529237647, 7762.844743105106, 7833.960830195812, 8654.87017694735, 8770.12298770118, 8784.912150878537, 8790.384673072824, 8889.377743557889, 3278.0988824890146, 3385.72914166871, 3405.9148521287166, 3441.346144232588, 3463.5670541182353, 931.5714771205186, 984.7685793838442, 1009.8030883977701, 1021.3259248895841, 1026.6765968719828, 18168.818311816714, 18498.35255766042, 18577.25690972346, 18813.529661758566, 19255.711164332548, 1018.6638409324905, 1030.2324768047702, 1042.259995403257, 1061.8991195836384, 1082.9945850270856, 10339.586416543405, 10713.0, 10766.0, 10814.134869210444, 10823.512941917632, 427653.0, 432366.0, 447125.0, 477068.0, 488938.0, 65323.67338163279, 73770.631146845, 74820.62589687017, 84753.57623211844, 85476.14523854807, 1020.4081632653043, 1023.7952409518275, 1050.333038520545, 1077.0, 1080.8865069167625, 15756.842431575538, 15988.840111598734, 15995.920020399824, 16045.358185672443, 16058.598535036717, 26142.0, 26165.345866353495, 29986.0, 33363.499547507294, 34711.13222169466, 51180.0, 51403.74298128635, 52275.47724522858, 52462.737686311324, 52585.0, 8107.716229931924, 8198.467099638505, 8277.344531093684, 8387.370947179108, 8469.02606200295, 9350.859737104085, 13043.413046412745, 13077.803832942323, 13499.730005400033, 13592.86407135916, 8479.36404769657, 11629.0, 11862.22895511789, 11870.228435151688, 12031.63905082849, 11316.717082072684, 11369.090472762324, 11720.413979301171, 11787.587434439753, 11823.408829558315, 11929.28424294545, 12025.63923082309, 12028.458719357475, 12028.518859245882, 12085.637430877088, 7455.0, 8189.877151842847, 8350.248477637042, 8385.161483851565, 8650.740477785677, 8943.032532842764, 10397.896021039693, 10421.635242766466, 10521.526531305957, 10630.415327157081], "value": 9929.153931514289, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1334.032826201005, 1503.9774403383947, 1537.8539038791314, 1703.6166862455948, 1839.494139111745, 8000.2799748022735, 8311.335093192545, 8343.08226095129, 8344.207300306462, 8356.874646880302, 8124.065732440771, 8262.42163048587, 8282.958585207081, 8290.58547072647, 8293.0, 2010.3868320162344, 2235.508188198594, 2281.555096756133, 2308.2152068296778, 2308.2382813671534, 2369.5024044950583, 2390.127603424755, 2391.4977854650456, 2394.1022116706235, 2394.2936833634035, 2304.4699719064624, 2342.8360014798973, 2343.5078633486987, 2343.589871772433, 2346.4603141277516, 2021.2622392826586, 2259.265738634942, 2322.512272422793, 2324.848884822481, 2325.4186453386656, 2250.4598896264943, 2255.131774266919, 2262.321303608911, 2266.7506574276817, 2297.9655305170436, 7964.800879977989, 7984.201579842027, 8028.438009339348, 8042.638081286356, 8043.316318112968, 4867.488913664085, 5013.197888337849, 5023.673461225008, 5037.5718063964605, 5093.465186155475, 3373.6963673269524, 3380.3746306933294, 3448.5689288838894, 3484.4947482615135, 3488.4244099723514, 1133.7675776465805, 1139.595443617512, 1160.8490896183441, 1182.5920057580122, 1183.1895151820945, 11179.049780768644, 11179.776404471946, 11185.72035699106, 11189.384583847885, 11197.60808371703, 4446.755428451402, 4502.212112880298, 4644.047970166108, 4697.201475749131, 4700.153972285021, 9492.288078394009, 9508.85736713936, 9521.23830093591, 9522.476263805556, 9523.714288571355, 4581.725096494221, 5044.8234311798915, 5048.697078175322, 5066.873328166826, 5102.515261050195, 4579.95420045802, 4678.1813182692895, 4691.882702932454, 4717.551832575899, 4726.7636618169645, 3818.2363527294096, 3867.941980870289, 3916.784576848244, 3924.117073658404, 3994.820233089518, 1280.9167404118703, 1304.8499422566526, 1307.7253776706807, 1310.8099325597734, 1331.1148086522549, 920.5489310237936, 953.3136141977765, 958.4632605740808, 958.4680502321279, 997.6807421625156, 5466.453354664502, 5564.527015203672, 5673.659580425187, 5736.0, 5837.88324233513, 893.2139717048956, 969.4958621516772, 977.1059480575336, 992.503748125937, 998.3909815012836, 3884.126071633916, 3985.9003524911527, 4023.2355852387955, 4074.0, 4092.2633925893624, 9896.10935015852, 10548.367097974146, 10669.306495077795, 10687.0, 10687.89312106869, 10425.218108641731, 10425.218108641882, 10479.266451348332, 10481.737956550995, 10493.527791249413, 7555.471117021865, 7818.960905195438, 7898.0, 8027.959860200662, 8036.316913062338, 5513.807016754395, 5524.475174858382, 5525.668459892419, 5539.612227144223, 5575.303087114111, 9068.319876009458, 9112.95443522778, 9159.267258619162, 9179.036201198778, 9257.814843703223, 8964.3276754245, 9541.188998935168, 9545.809083818423, 9684.128428441474, 9690.660826871308, 6522.0, 7090.787276381717, 7305.561666300039, 7322.670479828527, 7458.216887226763, 8085.797855053671, 8088.555129467701, 8150.959245203736, 8154.429189956646, 8160.877586836321, 7053.753118640823, 7203.387712044325, 7251.673674684546, 7269.854602908018, 7522.210167932289, 7244.130704315305, 7267.091613548307, 7270.127584689871, 7350.7427240046345, 7371.668274927534, 6791.185057793096, 6857.794266172023, 6881.827954301182, 6883.311668833277, 6884.690188941409, 4990.72551009698, 5088.821891233789, 5089.262057001788, 5102.1326374515675, 5107.055194788827, 5024.924626130684, 5057.190849464068, 5087.23691446286, 5096.898062038813, 5210.947890521046], "value": 4490.404925599431, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.49929357024126, 337.6589644459096, 340.4297801183018, 342.7241070937895, 344.2821716720637, 5492.121260598305, 5588.133839254911, 5649.887002259958, 5683.175939488771, 5692.260006199193, 5581.107022876341, 5648.576356773238, 5658.179563963233, 5675.574331925101, 5692.260006199188, 4393.626541743947, 4396.406485124499, 4398.8900277493, 4401.735895846259, 4401.823927042915, 4157.251694694954, 4328.329108988112, 4336.891577710567, 4399.5160532341415, 4428.586420400873, 4271.829126834923, 4276.3799249109015, 4283.635890949273, 4308.482982042159, 4308.80610372534, 4258.701890867656, 4272.46594175728, 4296.63478604319, 4301.182775272689, 4319.0, 3576.3204991051616, 3760.736748427611, 3767.7362584619086, 3773.2642984227286, 3776.4146557283666, 5415.458454154593, 5427.538659213971, 5439.592030597721, 5444.754986025639, 5453.291072160633, 4934.580560652313, 4959.82640607577, 4961.3798275215595, 4966.528179822947, 4967.900641987176, 5542.501174894279, 5870.530357571384, 5889.5288376930175, 5898.262717160355, 5904.822855314347, 4094.7133700640966, 4132.752034877917, 4136.276151673445, 4136.710430269883, 4138.751674899486, 6028.39716028398, 6055.848603784896, 6059.757609695607, 6080.331163571959, 6085.300190478108, 4102.179564087194, 4197.601227883407, 4198.181354635817, 4199.664026877843, 4238.491381034296, 4265.850695225714, 4276.32729544035, 4276.978615106967, 4280.21785839207, 4285.421468101828, 4899.730514821647, 4909.214525675875, 4912.410510738734, 4915.852524424273, 4926.458089610212, 5499.7250137492965, 5715.971420142872, 5878.706064696748, 5883.0293001654245, 5931.970340148272, 1467.6330917270682, 1475.6605980624302, 1480.5854360778999, 1481.7851411545266, 1484.3097959448908, 936.180841763457, 960.1071003966239, 974.2206235011962, 975.7463059604554, 985.0986347492108, 5608.69152196625, 5611.2144299798065, 5629.296337957755, 5630.436956304418, 5643.097104463348, 6016.819495415057, 6071.210742603522, 6083.832574686354, 6084.5132389408745, 6087.817365479043, 5440.102383106743, 5606.803761868397, 5607.551395888319, 5608.551315894719, 5613.691246981373, 3213.614366276062, 3259.6088469383826, 3265.2979609384097, 3269.2644155065395, 3281.7210537104615, 6077.301110372276, 6297.118403423525, 6299.716512756937, 6310.1481300024825, 6331.9366806331345, 6205.22434695663, 6216.471599913967, 6224.346443623445, 6225.439710425992, 6250.406211409909, 6239.719212635442, 6263.906041409383, 6296.087067375296, 6297.338779428185, 6301.653409062454, 5852.332085355653, 6095.0, 6095.878082438415, 6104.17593624855, 6107.450329470369, 5888.411158884077, 5951.345352011189, 5966.105084237399, 5976.820695379146, 5983.880322393441, 5992.0, 6241.251049874044, 6250.781222657185, 6266.624002559861, 6287.0, 4194.077302993336, 4212.810423530887, 4243.575642435731, 4244.1723863846255, 4245.150969805989, 5836.416358364129, 5978.3423823378525, 6031.879362412815, 6082.939170608414, 6093.573449858467, 5953.374895636069, 5973.193618861398, 5974.462298393166, 5979.551533635082, 5983.192269043798, 5900.232969713909, 5915.881682366415, 5920.319163296276, 5931.906984180901, 5938.6436813791315, 5655.943440565542, 5877.617954832922, 5885.234919460443, 5901.734421950937, 5905.970470147622, 5997.670128142994, 6026.939730602813, 6032.607880487754, 6038.939610604013, 6050.818475445743, 5714.828555143353, 5849.824505264849, 5885.793997210077, 5887.4406931341455, 5913.793017244376], "value": 4467.828909998694, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.2774680812805, 795.3160282157344, 808.3815880851146, 837.5560952695074, 851.9616617252223, 14037.859621403783, 14445.27773611318, 14463.276836158202, 14464.0, 14482.0, 12563.811542826843, 13306.534271300507, 13307.135036222662, 13350.532731354404, 13370.398332075056, 802.1577343789028, 812.2324403438753, 813.2030610002201, 813.7965508622844, 817.81190326225, 811.375241064383, 813.3777660090036, 816.6692489541745, 817.4073796497521, 817.5054092274178, 859.8495263328924, 863.1282404771164, 863.7451951674271, 863.8661007543809, 864.8140649760301, 849.9672897429652, 850.1413572291967, 850.2093053460279, 852.9701460448886, 853.3471894001094, 623.2863371439721, 623.9032949892774, 623.9937600623981, 624.2290770897937, 624.6408315218767, 12658.367081645973, 12735.554255601102, 12743.0, 12743.617691469271, 12753.426095825618, 11154.219204655677, 11240.0, 11339.773204535863, 11378.544858205662, 11722.12084093688, 9541.570629321628, 9977.90022099777, 9984.151347135503, 10145.746356341077, 10275.845862312071, 3417.743669224818, 3482.320947415255, 3487.5291835602125, 3493.1092571394133, 3538.6461353864665, 46491.0, 46853.0, 51010.0, 51729.48270517284, 51877.221841672406, 10214.131798797185, 10303.587856485807, 10361.63734269297, 10432.895671043345, 10534.20993425496, 18437.63124737498, 18564.071796410124, 18565.81434185668, 18576.814231857777, 18983.24067037303, 7977.162397948248, 7986.121526632066, 8011.359091272684, 8086.9191308086165, 8133.389995750343, 4123.958760412417, 4220.177065472265, 4231.597998190167, 4266.893327666833, 4336.956630433719, 3291.4240007998505, 3364.5626068611414, 3365.3101114271517, 3379.7803142795638, 3511.227529943408, 630.8139098965817, 632.6710110742388, 633.8954072577973, 638.3775818576851, 650.3951325267452, 746.2127455534463, 772.1467778105225, 788.8698364769864, 789.3961119743401, 824.1634740738156, 8549.487030778173, 8585.18440748128, 8686.91313086861, 8836.91163088361, 8977.46135231875, 616.722474886294, 627.1032423634247, 724.0912654618526, 765.12775436003, 792.4215322814377, 4284.635805956466, 4404.471463424409, 4430.800613972379, 4520.886977825515, 4526.366308716782, 66993.66503167551, 67402.0, 67620.6618966902, 69034.0, 69078.0, 44873.55126448759, 58308.0, 58636.0, 58969.0, 59879.40120598825, 45918.770406148426, 45978.0, 46442.0, 46908.0, 47713.52286477091, 8921.553922303729, 8955.955220223857, 8968.596413161293, 9010.234130099016, 9035.593398297224, 34279.31441371208, 34386.63847188278, 34412.0, 34569.48145777866, 34621.826890865384, 41845.0, 43536.0, 45753.54246457493, 46380.07239855252, 46708.766456167505, 11409.543618255177, 11623.941880290544, 11680.824787628362, 11709.707257318636, 12081.523287726171, 12349.753004939672, 12381.195222310522, 12426.130170887951, 12432.286834465454, 12731.61805145847, 11471.942640286745, 11875.703107422383, 12131.696707582381, 12200.81698774537, 12485.812712809497, 12080.275183489019, 12336.444859981142, 12517.874821251671, 12577.182483138567, 12657.430415631134, 11389.715257118307, 11556.42217889119, 11670.766584668429, 11679.0, 11807.23252988553, 10426.530806113591, 10691.625793097204, 10747.677569672922, 10801.783964320826, 10990.725231868948, 9960.950195248977, 10139.290249682452, 10148.289619726844, 10192.28653994243, 10264.281500294908], "value": 6548.981504933357, "unit": "score"}], "name": "dromaeo_css", "value": 7148.000028231681, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 105.0, 111.0, 111.0, 112.0, 101.0, 113.0, 113.0, 110.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 128.0, 159.0, 188.0, 130.0, 156.0, 152.0, 143.0, 203.0, 134.0], "value": 155.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 160.0, 159.0, 161.0, 162.0, 161.0, 161.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 103.0, 105.0, 74.0, 77.0, 76.0, 119.0, 103.0, 73.0], "value": 87.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 93.0, 147.0, 92.0, 93.0, 93.0, 157.0, 92.0, 92.0, 155.0], "value": 110.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 144.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 144.0], "value": 145.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 70.0, 61.0, 62.0, 61.0, 66.0, 61.0, 83.0, 61.0, 59.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 61.0, 61.0, 60.0, 62.0, 61.0, 61.0, 62.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 76.0, 76.0, 79.0, 79.0, 78.0, 78.0, 77.0, 78.0], "value": 77.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 129.0, 125.0, 124.0, 123.0, 122.0, 131.0, 124.0, 157.0, 127.0], "value": 128.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 172.0, 174.0, 172.0, 173.0, 174.0, 168.0, 173.0, 167.0, 166.0], "value": 170.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 69.0, 69.0, 73.0, 68.0, 72.0, 68.0, 66.0, 68.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1552.5999999999997, "alertThreshold": 2.0}]} 11:31:20 INFO - Return code: 0 11:31:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:31:20 ERROR - # TBPL SUCCESS # 11:31:20 INFO - Running post-action listener: _resource_record_post_action 11:31:20 INFO - Running post-run listener: _resource_record_post_run 11:31:21 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8192; Write bytes: 536428544; Read time: 156; Write time: 781520 11:31:21 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 244756480; Read time: 0; Write time: 499928 11:31:21 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 8192; Write bytes: 291672064; Read time: 156; Write time: 281592 11:31:21 INFO - Running post-run listener: _upload_blobber_files 11:31:21 INFO - Blob upload gear active. 11:31:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:31:21 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 11:31:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:31:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:31:22 INFO - (blobuploader) - INFO - Open directory for files ... 11:31:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:31:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:31:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:31:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:31:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:31:23 INFO - (blobuploader) - INFO - Done attempting. 11:31:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:31:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:31:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:31:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:31:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:31:23 INFO - (blobuploader) - INFO - Done attempting. 11:31:23 INFO - (blobuploader) - INFO - Iteration through files over. 11:31:23 INFO - Return code: 0 11:31:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:31:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:31:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ab41575f0e90e7495fa942eeebbe2548a514a4ecf12f2fafa31b7a5f6f504e8f58e1b77dd6a5c095a3c61b8731cfd685f8919b3c95ddc4df3d204a4a1b40fac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cb9a5340cf97fe63ddd2b18c7e702608eb82dfada9c6aaf5d6067d2d9e342fdbf5a472f2c94fee07235a9c730b75680a7dc0cad41c746c47d10d3837ebbf8756"} 11:31:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:31:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:31:23 INFO - Contents: 11:31:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ab41575f0e90e7495fa942eeebbe2548a514a4ecf12f2fafa31b7a5f6f504e8f58e1b77dd6a5c095a3c61b8731cfd685f8919b3c95ddc4df3d204a4a1b40fac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cb9a5340cf97fe63ddd2b18c7e702608eb82dfada9c6aaf5d6067d2d9e342fdbf5a472f2c94fee07235a9c730b75680a7dc0cad41c746c47d10d3837ebbf8756"} 11:31:23 INFO - Running post-run listener: copy_logs_to_upload_dir 11:31:23 INFO - Copying logs to upload dir... 11:31:23 INFO - mkdir: /builds/slave/test/build/upload/logs 11:31:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.497462 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-04-24 11:31:21.367462) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-24 11:31:21.371289) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1461518772.493648-1610201244 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ab41575f0e90e7495fa942eeebbe2548a514a4ecf12f2fafa31b7a5f6f504e8f58e1b77dd6a5c095a3c61b8731cfd685f8919b3c95ddc4df3d204a4a1b40fac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cb9a5340cf97fe63ddd2b18c7e702608eb82dfada9c6aaf5d6067d2d9e342fdbf5a472f2c94fee07235a9c730b75680a7dc0cad41c746c47d10d3837ebbf8756"} build_url:https://queue.taskcluster.net/v1/task/cvwhUmIMSvuOEabPF5qGzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011369 build_url: 'https://queue.taskcluster.net/v1/task/cvwhUmIMSvuOEabPF5qGzw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ab41575f0e90e7495fa942eeebbe2548a514a4ecf12f2fafa31b7a5f6f504e8f58e1b77dd6a5c095a3c61b8731cfd685f8919b3c95ddc4df3d204a4a1b40fac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cb9a5340cf97fe63ddd2b18c7e702608eb82dfada9c6aaf5d6067d2d9e342fdbf5a472f2c94fee07235a9c730b75680a7dc0cad41c746c47d10d3837ebbf8756"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-24 11:31:21.398356) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 11:31:21.398670) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1461518772.493648-1610201244 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004529 ========= master_lag: 0.27 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 11:31:21.671199) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-24 11:31:21.671492) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-24 11:31:21.671771) ========= ========= Total master_lag: 0.35 =========