builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-068 starttime: 1462831769.44 results: success (0) buildid: 20160509143357 builduid: a1c0eb9ec2944c97b0654c5bf447e07b revision: 9428c76cb9df77442a54cd68cae5a8426ba334a7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 15:09:29.439886) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 15:09:29.440391) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 15:09:29.440731) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 15:09:29.456983) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 15:09:29.457281) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1462831765.376647-466763386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-09 15:09:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-05-09 15:09:29 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.169968 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 15:09:29.640276) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 15:09:29.640595) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1462831765.376647-466763386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019422 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 15:09:29.689529) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 15:09:29.689889) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9428c76cb9df77442a54cd68cae5a8426ba334a7 --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 9428c76cb9df77442a54cd68cae5a8426ba334a7 --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=97facb8ba2ac28944cc45e6b000001d4-1462831765.376647-466763386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-09 15:09:29,985 truncating revision to first 12 chars 2016-05-09 15:09:29,985 Setting DEBUG logging. 2016-05-09 15:09:29,985 attempt 1/10 2016-05-09 15:09:29,985 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9428c76cb9df?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 15:09:30,823 unpacking tar archive at: fx-team-9428c76cb9df/testing/mozharness/ program finished with exit code 0 elapsedTime=1.097370 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 15:09:30.799855) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 15:09:30.800178) ========= script_repo_revision: 9428c76cb9df77442a54cd68cae5a8426ba334a7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 15:09:30.800570) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 15:09:30.800857) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 15:09:30.808962) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-09 15:09:30.809275) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1462831765.376647-466763386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:09:31 INFO - MultiFileLogger online at 20160509 15:09:31 in /builds/slave/test 15:09:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 15:09:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:09:31 INFO - {'append_to_log': False, 15:09:31 INFO - 'base_work_dir': '/builds/slave/test', 15:09:31 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:09:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:09:31 INFO - 'branch': 'Fx-Team-Non-PGO', 15:09:31 INFO - 'buildbot_json_path': 'buildprops.json', 15:09:31 INFO - 'config_files': ('talos/linux_config.py',), 15:09:31 INFO - 'default_actions': ('clobber', 15:09:31 INFO - 'read-buildbot-config', 15:09:31 INFO - 'download-and-extract', 15:09:31 INFO - 'populate-webroot', 15:09:31 INFO - 'create-virtualenv', 15:09:31 INFO - 'install', 15:09:31 INFO - 'run-tests'), 15:09:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:09:31 INFO - 'download_minidump_stackwalk': True, 15:09:31 INFO - 'download_symbols': 'ondemand', 15:09:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:09:31 INFO - 'tooltool.py': '/tools/tooltool.py', 15:09:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:09:31 INFO - '/tools/misc-python/virtualenv.py')}, 15:09:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:09:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:09:31 INFO - 'installer_path': 'installer.exe', 15:09:31 INFO - 'log_level': 'info', 15:09:31 INFO - 'log_name': 'talos', 15:09:31 INFO - 'log_to_console': True, 15:09:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:09:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:09:31 INFO - 'opt_config_files': (), 15:09:31 INFO - 'pip_index': False, 15:09:31 INFO - 'sps_profile': False, 15:09:31 INFO - 'sps_profile_interval': 0, 15:09:31 INFO - 'suite': 'dromaeojs', 15:09:31 INFO - 'system_bits': '32', 15:09:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:09:31 INFO - 'title': 'talos-linux64-ix-068', 15:09:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:09:31 INFO - 'use_talos_json': True, 15:09:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:09:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:09:31 INFO - 'work_dir': 'build'} 15:09:31 INFO - ##### 15:09:31 INFO - ##### Running clobber step. 15:09:31 INFO - ##### 15:09:31 INFO - Running pre-action listener: _resource_record_pre_action 15:09:31 INFO - Running main action method: clobber 15:09:31 INFO - rmtree: /builds/slave/test/build 15:09:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:09:31 INFO - Running post-action listener: _resource_record_post_action 15:09:31 INFO - ##### 15:09:31 INFO - ##### Finished clobber step (success) 15:09:31 INFO - ##### 15:09:31 INFO - ##### 15:09:31 INFO - ##### Running read-buildbot-config step. 15:09:31 INFO - ##### 15:09:31 INFO - Running pre-action listener: _resource_record_pre_action 15:09:31 INFO - Running main action method: read_buildbot_config 15:09:31 INFO - Using buildbot properties: 15:09:31 INFO - { 15:09:31 INFO - "project": "", 15:09:31 INFO - "product": "firefox", 15:09:31 INFO - "script_repo_revision": "production", 15:09:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:09:31 INFO - "repository": "", 15:09:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 15:09:31 INFO - "buildid": "20160509143357", 15:09:31 INFO - "pgo_build": "False", 15:09:31 INFO - "basedir": "/builds/slave/test", 15:09:31 INFO - "buildnumber": 2942, 15:09:31 INFO - "slavename": "talos-linux64-ix-068", 15:09:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:09:31 INFO - "platform": "ubuntu64_hw", 15:09:31 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:09:31 INFO - "branch": "fx-team", 15:09:31 INFO - "repo_path": "integration/fx-team", 15:09:31 INFO - "revision": "9428c76cb9df77442a54cd68cae5a8426ba334a7", 15:09:31 INFO - "stage_platform": "linux64", 15:09:31 INFO - "builduid": "a1c0eb9ec2944c97b0654c5bf447e07b", 15:09:31 INFO - "slavebuilddir": "test" 15:09:31 INFO - } 15:09:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/QJLTcO3KSSGKSS4195Pvsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 15:09:31 INFO - Running post-action listener: _resource_record_post_action 15:09:31 INFO - ##### 15:09:31 INFO - ##### Finished read-buildbot-config step (success) 15:09:31 INFO - ##### 15:09:31 INFO - ##### 15:09:31 INFO - ##### Running download-and-extract step. 15:09:31 INFO - ##### 15:09:31 INFO - Running pre-action listener: _resource_record_pre_action 15:09:31 INFO - Running main action method: download_and_extract 15:09:31 INFO - mkdir: /builds/slave/test/build/tests 15:09:31 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')]} 15:09:31 INFO - https://queue.taskcluster.net/v1/task/QJLTcO3KSSGKSS4195Pvsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:09:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJLTcO3KSSGKSS4195Pvsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:09:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJLTcO3KSSGKSS4195Pvsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:09:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJLTcO3KSSGKSS4195Pvsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:09:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJLTcO3KSSGKSS4195Pvsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:09:32 INFO - Downloaded 1361 bytes. 15:09:32 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:09:32 INFO - Using the following test package requirements: 15:09:32 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:09:32 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:09:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:09:32 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:09:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:09:32 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:09:32 INFO - u'jsshell-linux-x86_64.zip'], 15:09:32 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:09:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:09:32 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:09:32 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:09:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:09:32 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:09:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:09:32 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:09:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:09:32 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:09:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:09:32 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:09:32 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')]} 15:09:32 INFO - https://queue.taskcluster.net/v1/task/QJLTcO3KSSGKSS4195Pvsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:09:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJLTcO3KSSGKSS4195Pvsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:09:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJLTcO3KSSGKSS4195Pvsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:09:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJLTcO3KSSGKSS4195Pvsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:09:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJLTcO3KSSGKSS4195Pvsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:09:33 INFO - Downloaded 22322863 bytes. 15:09:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:09:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:09:34 INFO - Return code: 0 15:09:34 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:09:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:09:34 INFO - https://queue.taskcluster.net/v1/task/QJLTcO3KSSGKSS4195Pvsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:09:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJLTcO3KSSGKSS4195Pvsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:09:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJLTcO3KSSGKSS4195Pvsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:09:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJLTcO3KSSGKSS4195Pvsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:09:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJLTcO3KSSGKSS4195Pvsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:09:37 INFO - Downloaded 22322863 bytes. 15:09:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:09:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:09:39 INFO - Return code: 0 15:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:09:39 INFO - https://queue.taskcluster.net/v1/task/QJLTcO3KSSGKSS4195Pvsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:09:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJLTcO3KSSGKSS4195Pvsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:09:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJLTcO3KSSGKSS4195Pvsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:09:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJLTcO3KSSGKSS4195Pvsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:09:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJLTcO3KSSGKSS4195Pvsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:09:40 INFO - Downloaded 10840152 bytes. 15:09:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:09:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:09:40 INFO - Return code: 0 15:09:40 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')]} 15:09:40 INFO - https://queue.taskcluster.net/v1/task/QJLTcO3KSSGKSS4195Pvsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:09:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJLTcO3KSSGKSS4195Pvsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:09:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJLTcO3KSSGKSS4195Pvsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:09:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJLTcO3KSSGKSS4195Pvsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:09:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJLTcO3KSSGKSS4195Pvsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:09:41 INFO - Downloaded 54858301 bytes. 15:09:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QJLTcO3KSSGKSS4195Pvsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:09:41 INFO - mkdir: /builds/slave/test/properties 15:09:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:09:41 INFO - Writing to file /builds/slave/test/properties/build_url 15:09:41 INFO - Contents: 15:09:41 INFO - build_url:https://queue.taskcluster.net/v1/task/QJLTcO3KSSGKSS4195Pvsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:09:42 INFO - Running post-action listener: _resource_record_post_action 15:09:42 INFO - Running post-action listener: set_extra_try_arguments 15:09:42 INFO - ##### 15:09:42 INFO - ##### Finished download-and-extract step (success) 15:09:42 INFO - ##### 15:09:42 INFO - ##### 15:09:42 INFO - ##### Running populate-webroot step. 15:09:42 INFO - ##### 15:09:42 INFO - Running pre-action listener: _resource_record_pre_action 15:09:42 INFO - Running main action method: populate_webroot 15:09:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:09:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:09:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:09:42 INFO - '--tppagecycles', 15:09:42 INFO - '7'], 15:09:42 INFO - 'tests': ['tsvgm']}}, 15:09:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:09:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:09:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:09:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:09:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:09:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:09:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:09:42 INFO - 'talos_options': ['--disable-e10s'], 15:09:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:09:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:09:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:09:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:09:42 INFO - 'talos_options': ['--disable-e10s'], 15:09:42 INFO - 'tests': ['damp', 'tps']}, 15:09:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:09:42 INFO - 'tests': ['damp', 'tps']}, 15:09:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:09:42 INFO - 'tests': ['dromaeo_dom']}, 15:09:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:09:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:09:42 INFO - 'tests': ['a11yr', 15:09:42 INFO - 'ts_paint', 15:09:42 INFO - 'tpaint', 15:09:42 INFO - 'sessionrestore', 15:09:42 INFO - 'sessionrestore_no_auto_restore', 15:09:42 INFO - 'tabpaint']}, 15:09:42 INFO - 'other-e10s': {'tests': ['a11yr', 15:09:42 INFO - 'ts_paint', 15:09:42 INFO - 'tpaint', 15:09:42 INFO - 'sessionrestore', 15:09:42 INFO - 'sessionrestore_no_auto_restore', 15:09:42 INFO - 'tabpaint']}, 15:09:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:09:42 INFO - 'ts_paint', 15:09:42 INFO - 'tpaint', 15:09:42 INFO - 'sessionrestore', 15:09:42 INFO - 'sessionrestore_no_auto_restore', 15:09:42 INFO - 'tabpaint']}, 15:09:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:09:42 INFO - 'ts_paint', 15:09:42 INFO - 'tpaint', 15:09:42 INFO - 'sessionrestore', 15:09:42 INFO - 'sessionrestore_no_auto_restore', 15:09:42 INFO - 'tabpaint']}, 15:09:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:09:42 INFO - 'tests': ['a11yr', 15:09:42 INFO - 'ts_paint', 15:09:42 INFO - 'tpaint', 15:09:42 INFO - 'sessionrestore', 15:09:42 INFO - 'sessionrestore_no_auto_restore', 15:09:42 INFO - 'tabpaint']}, 15:09:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:09:42 INFO - 'tests': ['a11yr', 15:09:42 INFO - 'ts_paint', 15:09:42 INFO - 'tpaint', 15:09:42 INFO - 'sessionrestore', 15:09:42 INFO - 'sessionrestore_no_auto_restore', 15:09:42 INFO - 'tabpaint']}, 15:09:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:09:42 INFO - 'tests': ['tsvgx', 15:09:42 INFO - 'tsvgr_opacity', 15:09:42 INFO - 'tart', 15:09:42 INFO - 'tscrollx', 15:09:42 INFO - 'cart']}, 15:09:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:09:42 INFO - 'tsvgr_opacity', 15:09:42 INFO - 'tart', 15:09:42 INFO - 'tscrollx', 15:09:42 INFO - 'cart']}, 15:09:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:09:42 INFO - 'talos_options': ['--disable-e10s'], 15:09:42 INFO - 'tests': ['tp5o']}, 15:09:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:09:42 INFO - 'tests': ['tp5o']}, 15:09:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:09:42 INFO - 'talos_options': ['--disable-e10s', 15:09:42 INFO - '--xperf_path', 15:09:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:09:42 INFO - 'tests': ['tp5n']}, 15:09:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:09:42 INFO - 'talos_options': ['--xperf_path', 15:09:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:09:42 INFO - 'tests': ['tp5n']}}, 15:09:42 INFO - 'talos.zip': {'path': '', 15:09:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:09:42 INFO - Running post-action listener: _resource_record_post_action 15:09:42 INFO - ##### 15:09:42 INFO - ##### Finished populate-webroot step (success) 15:09:42 INFO - ##### 15:09:42 INFO - ##### 15:09:42 INFO - ##### Running create-virtualenv step. 15:09:42 INFO - ##### 15:09:42 INFO - Running pre-action listener: _resource_record_pre_action 15:09:42 INFO - Running main action method: create_virtualenv 15:09:42 INFO - Creating virtualenv /builds/slave/test/build/venv 15:09:42 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 15:09:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:09:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:09:42 INFO - Using real prefix '/usr' 15:09:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:09:43 INFO - Installing distribute.............................................................................................................................................................................................done. 15:09:45 INFO - Installing pip.................done. 15:09:45 INFO - Return code: 0 15:09:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:09:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:09:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:09:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:45 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 0x7f453e0e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22af770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233e9c0>, '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 0x233f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x233fd50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1462831765.376647-466763386', '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 15:09:45 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 15:09:45 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 15:09:45 INFO - Using env: {'DISPLAY': ':0', 15:09:45 INFO - 'HOME': '/home/cltbld', 15:09:45 INFO - 'LANG': 'en_US.UTF-8', 15:09:45 INFO - 'LANGUAGE': 'en_US:en', 15:09:45 INFO - 'LOGNAME': 'cltbld', 15:09:45 INFO - 'MAIL': '/var/mail/cltbld', 15:09:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:09:45 INFO - 'MOZ_NO_REMOTE': '1', 15:09:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:09:45 INFO - 'NO_EM_RESTART': '1', 15:09:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:09:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:09:45 INFO - 'PWD': '/builds/slave/test', 15:09:45 INFO - 'SHELL': '/bin/bash', 15:09:45 INFO - 'SHLVL': '1', 15:09:45 INFO - 'TERM': 'linux', 15:09:45 INFO - 'TMOUT': '86400', 15:09:45 INFO - 'USER': 'cltbld', 15:09:45 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1462831765.376647-466763386', 15:09:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:09:45 INFO - '_': '/tools/buildbot/bin/python'} 15:09:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:09:45 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 15:09:45 INFO - Cleaning up... 15:09:45 INFO - Return code: 0 15:09:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:09:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:09:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:09:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:45 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 0x7f453e0e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22af770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233e9c0>, '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 0x233f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x233fd50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1462831765.376647-466763386', '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 15:09:45 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 15:09:45 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 15:09:45 INFO - Using env: {'DISPLAY': ':0', 15:09:45 INFO - 'HOME': '/home/cltbld', 15:09:45 INFO - 'LANG': 'en_US.UTF-8', 15:09:45 INFO - 'LANGUAGE': 'en_US:en', 15:09:45 INFO - 'LOGNAME': 'cltbld', 15:09:45 INFO - 'MAIL': '/var/mail/cltbld', 15:09:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:09:45 INFO - 'MOZ_NO_REMOTE': '1', 15:09:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:09:45 INFO - 'NO_EM_RESTART': '1', 15:09:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:09:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:09:45 INFO - 'PWD': '/builds/slave/test', 15:09:45 INFO - 'SHELL': '/bin/bash', 15:09:45 INFO - 'SHLVL': '1', 15:09:45 INFO - 'TERM': 'linux', 15:09:45 INFO - 'TMOUT': '86400', 15:09:45 INFO - 'USER': 'cltbld', 15:09:45 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1462831765.376647-466763386', 15:09:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:09:45 INFO - '_': '/tools/buildbot/bin/python'} 15:09:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:09:45 INFO - Downloading/unpacking psutil>=0.7.1 15:09:45 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 15:09:45 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 15:09:45 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 15:09:45 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 15:09:45 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 15:09:45 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 15:09:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:09:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:09:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:09:47 INFO - Installing collected packages: psutil 15:09:47 INFO - Running setup.py install for psutil 15:09:47 INFO - building 'psutil._psutil_linux' extension 15:09:47 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 15:09:47 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 15:09:47 INFO - building 'psutil._psutil_posix' extension 15:09:47 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 15:09:48 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 15:09:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:09:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:09:48 INFO - Successfully installed psutil 15:09:48 INFO - Cleaning up... 15:09:48 INFO - Return code: 0 15:09:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:09:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:09:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:09:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:09:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:48 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 0x7f453e0e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22af770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233e9c0>, '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 0x233f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x233fd50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1462831765.376647-466763386', '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 15:09:48 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 15:09:48 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 15:09:48 INFO - Using env: {'DISPLAY': ':0', 15:09:48 INFO - 'HOME': '/home/cltbld', 15:09:48 INFO - 'LANG': 'en_US.UTF-8', 15:09:48 INFO - 'LANGUAGE': 'en_US:en', 15:09:48 INFO - 'LOGNAME': 'cltbld', 15:09:48 INFO - 'MAIL': '/var/mail/cltbld', 15:09:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:09:48 INFO - 'MOZ_NO_REMOTE': '1', 15:09:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:09:48 INFO - 'NO_EM_RESTART': '1', 15:09:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:09:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:09:48 INFO - 'PWD': '/builds/slave/test', 15:09:48 INFO - 'SHELL': '/bin/bash', 15:09:48 INFO - 'SHLVL': '1', 15:09:48 INFO - 'TERM': 'linux', 15:09:48 INFO - 'TMOUT': '86400', 15:09:48 INFO - 'USER': 'cltbld', 15:09:48 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1462831765.376647-466763386', 15:09:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:09:48 INFO - '_': '/tools/buildbot/bin/python'} 15:09:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:09:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:09:48 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 15:09:48 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 15:09:48 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 15:09:48 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 15:09:48 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 15:09:48 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 15:09:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:09:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:09:50 INFO - Installing collected packages: mozsystemmonitor 15:09:50 INFO - Running setup.py install for mozsystemmonitor 15:09:50 INFO - Successfully installed mozsystemmonitor 15:09:50 INFO - Cleaning up... 15:09:50 INFO - Return code: 0 15:09:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:09:50 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')]} 15:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:09:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:50 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')]} 15:09:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:09:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:50 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 0x7f453e0e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22af770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233e9c0>, '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 0x233f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x233fd50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1462831765.376647-466763386', '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 15:09:50 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 15:09:50 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 15:09:50 INFO - Using env: {'DISPLAY': ':0', 15:09:50 INFO - 'HOME': '/home/cltbld', 15:09:50 INFO - 'LANG': 'en_US.UTF-8', 15:09:50 INFO - 'LANGUAGE': 'en_US:en', 15:09:50 INFO - 'LOGNAME': 'cltbld', 15:09:50 INFO - 'MAIL': '/var/mail/cltbld', 15:09:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:09:50 INFO - 'MOZ_NO_REMOTE': '1', 15:09:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:09:50 INFO - 'NO_EM_RESTART': '1', 15:09:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:09:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:09:50 INFO - 'PWD': '/builds/slave/test', 15:09:50 INFO - 'SHELL': '/bin/bash', 15:09:50 INFO - 'SHLVL': '1', 15:09:50 INFO - 'TERM': 'linux', 15:09:50 INFO - 'TMOUT': '86400', 15:09:50 INFO - 'USER': 'cltbld', 15:09:50 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1462831765.376647-466763386', 15:09:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:09:50 INFO - '_': '/tools/buildbot/bin/python'} 15:09:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:09:50 INFO - Downloading/unpacking blobuploader==1.2.4 15:09:50 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 15:09:50 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 15:09:50 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 15:09:50 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 15:09:50 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 15:09:50 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 15:09:52 INFO - Downloading blobuploader-1.2.4.tar.gz 15:09:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:09:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:09:52 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 15:09:52 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 15:09:52 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 15:09:52 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 15:09:52 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 15:09:52 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 15:09:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:09:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:09:53 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 15:09:53 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 15:09:53 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 15:09:53 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 15:09:53 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 15:09:53 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 15:09:53 INFO - Downloading docopt-0.6.1.tar.gz 15:09:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:09:53 INFO - Installing collected packages: blobuploader, requests, docopt 15:09:53 INFO - Running setup.py install for blobuploader 15:09:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:09:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:09:53 INFO - Running setup.py install for requests 15:09:54 INFO - Running setup.py install for docopt 15:09:54 INFO - Successfully installed blobuploader requests docopt 15:09:54 INFO - Cleaning up... 15:09:54 INFO - Return code: 0 15:09:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:09: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')]} 15:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:09:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09: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')]} 15:09:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:09:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:54 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 0x7f453e0e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22af770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233e9c0>, '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 0x233f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x233fd50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1462831765.376647-466763386', '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 15:09:54 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 15:09:54 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 15:09:54 INFO - Using env: {'DISPLAY': ':0', 15:09:54 INFO - 'HOME': '/home/cltbld', 15:09:54 INFO - 'LANG': 'en_US.UTF-8', 15:09:54 INFO - 'LANGUAGE': 'en_US:en', 15:09:54 INFO - 'LOGNAME': 'cltbld', 15:09:54 INFO - 'MAIL': '/var/mail/cltbld', 15:09:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:09:54 INFO - 'MOZ_NO_REMOTE': '1', 15:09:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:09:54 INFO - 'NO_EM_RESTART': '1', 15:09:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:09:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:09:54 INFO - 'PWD': '/builds/slave/test', 15:09:54 INFO - 'SHELL': '/bin/bash', 15:09:54 INFO - 'SHLVL': '1', 15:09:54 INFO - 'TERM': 'linux', 15:09:54 INFO - 'TMOUT': '86400', 15:09:54 INFO - 'USER': 'cltbld', 15:09:54 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1462831765.376647-466763386', 15:09:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:09:54 INFO - '_': '/tools/buildbot/bin/python'} 15:09:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:09:54 INFO - Running setup.py (path:/tmp/pip-Aaj07E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:09:54 INFO - Running setup.py (path:/tmp/pip-HLBKXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:09:54 INFO - Running setup.py (path:/tmp/pip-PfRb6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:09:54 INFO - Running setup.py (path:/tmp/pip-d0WchS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:09:54 INFO - Running setup.py (path:/tmp/pip-kcnZ_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:09:54 INFO - Running setup.py (path:/tmp/pip-FIVaNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:09:54 INFO - Running setup.py (path:/tmp/pip-uFZTu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:09:55 INFO - Running setup.py (path:/tmp/pip-AQdOmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:09:55 INFO - Running setup.py (path:/tmp/pip-ho2HLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:09:55 INFO - Running setup.py (path:/tmp/pip-J32afb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:09:55 INFO - Running setup.py (path:/tmp/pip-0lU6_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:09:55 INFO - Running setup.py (path:/tmp/pip-VKIEpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:09:55 INFO - Running setup.py (path:/tmp/pip-sAJ7mD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:09:55 INFO - Running setup.py (path:/tmp/pip-98FwwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:09:55 INFO - Running setup.py (path:/tmp/pip-yWvuls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:09:55 INFO - Running setup.py (path:/tmp/pip-LfamHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:09:55 INFO - Running setup.py (path:/tmp/pip-bOmgD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:09:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:09:55 INFO - Running setup.py install for manifestparser 15:09:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:09:55 INFO - Running setup.py install for mozcrash 15:09:55 INFO - Running setup.py install for mozdebug 15:09:56 INFO - Running setup.py install for mozdevice 15:09:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:09:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:09:56 INFO - Running setup.py install for mozfile 15:09:56 INFO - Running setup.py install for mozhttpd 15:09:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:09:56 INFO - Running setup.py install for mozinfo 15:09:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:09:56 INFO - Running setup.py install for mozInstall 15:09:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:09:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:09:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:09:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:09:56 INFO - Running setup.py install for mozleak 15:09:56 INFO - Running setup.py install for mozlog 15:09:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:09:56 INFO - Running setup.py install for moznetwork 15:09:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:09:56 INFO - Running setup.py install for mozprocess 15:09:56 INFO - Running setup.py install for mozprofile 15:09:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:09:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:09:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:09:57 INFO - Running setup.py install for mozrunner 15:09:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:09:57 INFO - Running setup.py install for mozscreenshot 15:09:57 INFO - Running setup.py install for moztest 15:09:57 INFO - Running setup.py install for mozversion 15:09:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:09:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:09:57 INFO - Cleaning up... 15:09:57 INFO - Return code: 0 15:09:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:09:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:09:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:09:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:57 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 0x7f453e0e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22af770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233e9c0>, '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 0x233f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x233fd50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1462831765.376647-466763386', '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 15:09:57 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 15:09:57 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 15:09:57 INFO - Using env: {'DISPLAY': ':0', 15:09:57 INFO - 'HOME': '/home/cltbld', 15:09:57 INFO - 'LANG': 'en_US.UTF-8', 15:09:57 INFO - 'LANGUAGE': 'en_US:en', 15:09:57 INFO - 'LOGNAME': 'cltbld', 15:09:57 INFO - 'MAIL': '/var/mail/cltbld', 15:09:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:09:57 INFO - 'MOZ_NO_REMOTE': '1', 15:09:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:09:57 INFO - 'NO_EM_RESTART': '1', 15:09:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:09:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:09:57 INFO - 'PWD': '/builds/slave/test', 15:09:57 INFO - 'SHELL': '/bin/bash', 15:09:57 INFO - 'SHLVL': '1', 15:09:57 INFO - 'TERM': 'linux', 15:09:57 INFO - 'TMOUT': '86400', 15:09:57 INFO - 'USER': 'cltbld', 15:09:57 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1462831765.376647-466763386', 15:09:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:09:57 INFO - '_': '/tools/buildbot/bin/python'} 15:09:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:09:57 INFO - Running setup.py (path:/tmp/pip-LZCELA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:09:57 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)) 15:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:09:57 INFO - Running setup.py (path:/tmp/pip-W19Hcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:09:57 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)) 15:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:09:57 INFO - Running setup.py (path:/tmp/pip-QldDMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:09:57 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)) 15:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:09:57 INFO - Running setup.py (path:/tmp/pip-4fS2Tc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:09:58 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)) 15:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:09:58 INFO - Running setup.py (path:/tmp/pip-Hzu_Ps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:09:58 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)) 15:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:09:58 INFO - Running setup.py (path:/tmp/pip-QzePjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:09:58 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)) 15:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:09:58 INFO - Running setup.py (path:/tmp/pip-utfV7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:09:58 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)) 15:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:09:58 INFO - Running setup.py (path:/tmp/pip-8b6r7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:09:58 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)) 15:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:09:58 INFO - Running setup.py (path:/tmp/pip-7hpXZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:09:58 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)) 15:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:09:58 INFO - Running setup.py (path:/tmp/pip-yk4UqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:09:58 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)) 15:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:09:58 INFO - Running setup.py (path:/tmp/pip-OJ43Qm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:09:58 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)) 15:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:09:58 INFO - Running setup.py (path:/tmp/pip-CfCMFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:09:58 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)) 15:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:09:58 INFO - Running setup.py (path:/tmp/pip-wHeqhf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:09:58 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)) 15:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:09:58 INFO - Running setup.py (path:/tmp/pip-iLdyIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:09:58 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)) 15:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:09:58 INFO - Running setup.py (path:/tmp/pip-Gfgswo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:09:58 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)) 15:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:09:58 INFO - Running setup.py (path:/tmp/pip-2tIxmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:09:58 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)) 15:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:09:58 INFO - Running setup.py (path:/tmp/pip-WtYaxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:09:58 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)) 15:09:58 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)) 15:09:58 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)) 15:09:58 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)) 15:09:58 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)) 15:09:59 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)) 15:09:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:09:59 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 15:09:59 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 15:09:59 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 15:09:59 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 15:09:59 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 15:09:59 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 15:10:00 INFO - Downloading blessings-1.6.tar.gz 15:10:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:10:01 INFO - Installing collected packages: blessings 15:10:01 INFO - Running setup.py install for blessings 15:10:01 INFO - Successfully installed blessings 15:10:01 INFO - Cleaning up... 15:10:01 INFO - Return code: 0 15:10:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:10:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:10:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:10:01 INFO - Reading from file tmpfile_stdout 15:10:01 INFO - Current package versions: 15:10:01 INFO - argparse == 1.2.1 15:10:01 INFO - blessings == 1.6 15:10:01 INFO - blobuploader == 1.2.4 15:10:01 INFO - docopt == 0.6.1 15:10:01 INFO - manifestparser == 1.1 15:10:01 INFO - mozInstall == 1.12 15:10:01 INFO - mozcrash == 0.17 15:10:01 INFO - mozdebug == 0.1 15:10:01 INFO - mozdevice == 0.48 15:10:01 INFO - mozfile == 1.2 15:10:01 INFO - mozhttpd == 0.7 15:10:01 INFO - mozinfo == 0.9 15:10:01 INFO - mozleak == 0.1 15:10:01 INFO - mozlog == 3.1 15:10:01 INFO - moznetwork == 0.27 15:10:01 INFO - mozprocess == 0.22 15:10:01 INFO - mozprofile == 0.28 15:10:01 INFO - mozrunner == 6.11 15:10:01 INFO - mozscreenshot == 0.1 15:10:01 INFO - mozsystemmonitor == 0.0 15:10:01 INFO - moztest == 0.7 15:10:01 INFO - mozversion == 1.4 15:10:01 INFO - psutil == 3.1.1 15:10:01 INFO - requests == 1.2.3 15:10:01 INFO - wsgiref == 0.1.2 15:10:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:01 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 0x7f453e0e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22af770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233e9c0>, '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 0x233f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x233fd50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1462831765.376647-466763386', '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 15:10:01 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 15:10:01 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 15:10:01 INFO - Using env: {'DISPLAY': ':0', 15:10:01 INFO - 'HOME': '/home/cltbld', 15:10:01 INFO - 'LANG': 'en_US.UTF-8', 15:10:01 INFO - 'LANGUAGE': 'en_US:en', 15:10:01 INFO - 'LOGNAME': 'cltbld', 15:10:01 INFO - 'MAIL': '/var/mail/cltbld', 15:10:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:01 INFO - 'MOZ_NO_REMOTE': '1', 15:10:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:01 INFO - 'NO_EM_RESTART': '1', 15:10:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:01 INFO - 'PWD': '/builds/slave/test', 15:10:01 INFO - 'SHELL': '/bin/bash', 15:10:01 INFO - 'SHLVL': '1', 15:10:01 INFO - 'TERM': 'linux', 15:10:01 INFO - 'TMOUT': '86400', 15:10:01 INFO - 'USER': 'cltbld', 15:10:01 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1462831765.376647-466763386', 15:10:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:01 INFO - '_': '/tools/buildbot/bin/python'} 15:10:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:01 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)) 15:10:01 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)) 15:10:01 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)) 15:10:01 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)) 15:10:01 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)) 15:10:01 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)) 15:10:01 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)) 15:10:01 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)) 15:10:01 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)) 15:10:01 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)) 15:10:01 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)) 15:10:01 INFO - Cleaning up... 15:10:01 INFO - Return code: 0 15:10:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:01 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 0x7f453e0e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22af770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233e9c0>, '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 0x233f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x233fd50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1462831765.376647-466763386', '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 15:10:01 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 15:10:01 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 15:10:01 INFO - Using env: {'DISPLAY': ':0', 15:10:01 INFO - 'HOME': '/home/cltbld', 15:10:01 INFO - 'LANG': 'en_US.UTF-8', 15:10:01 INFO - 'LANGUAGE': 'en_US:en', 15:10:01 INFO - 'LOGNAME': 'cltbld', 15:10:01 INFO - 'MAIL': '/var/mail/cltbld', 15:10:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:01 INFO - 'MOZ_NO_REMOTE': '1', 15:10:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:01 INFO - 'NO_EM_RESTART': '1', 15:10:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:01 INFO - 'PWD': '/builds/slave/test', 15:10:01 INFO - 'SHELL': '/bin/bash', 15:10:01 INFO - 'SHLVL': '1', 15:10:01 INFO - 'TERM': 'linux', 15:10:01 INFO - 'TMOUT': '86400', 15:10:01 INFO - 'USER': 'cltbld', 15:10:01 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1462831765.376647-466763386', 15:10:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:01 INFO - '_': '/tools/buildbot/bin/python'} 15:10:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:01 INFO - Downloading/unpacking jsonschema 15:10:01 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 15:10:01 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 15:10:01 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 15:10:01 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 15:10:01 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 15:10:01 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 15:10:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:10:03 INFO - Downloading/unpacking functools32 (from jsonschema) 15:10:03 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 15:10:03 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 15:10:03 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 15:10:03 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 15:10:03 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 15:10:03 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 15:10:04 INFO - Downloading functools32-3.2.3-2.tar.gz 15:10:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:10:04 INFO - warning: no files found matching '*.txt' 15:10:04 INFO - no previously-included directories found matching 'build' 15:10:04 INFO - no previously-included directories found matching 'dist' 15:10:04 INFO - no previously-included directories found matching '.git*' 15:10:04 INFO - Installing collected packages: jsonschema, functools32 15:10:04 INFO - Running setup.py install for functools32 15:10:04 INFO - warning: no files found matching '*.txt' 15:10:04 INFO - no previously-included directories found matching 'build' 15:10:04 INFO - no previously-included directories found matching 'dist' 15:10:04 INFO - no previously-included directories found matching '.git*' 15:10:04 INFO - Successfully installed jsonschema functools32 15:10:04 INFO - Cleaning up... 15:10:04 INFO - Return code: 0 15:10:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:10: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')]} 15:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10: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')]} 15:10:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f453e0e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22af770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233e9c0>, '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 0x233f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x233fd50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1462831765.376647-466763386', '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 15:10:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 15:10:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:10:04 INFO - Using env: {'DISPLAY': ':0', 15:10:04 INFO - 'HOME': '/home/cltbld', 15:10:04 INFO - 'LANG': 'en_US.UTF-8', 15:10:04 INFO - 'LANGUAGE': 'en_US:en', 15:10:04 INFO - 'LOGNAME': 'cltbld', 15:10:04 INFO - 'MAIL': '/var/mail/cltbld', 15:10:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:04 INFO - 'MOZ_NO_REMOTE': '1', 15:10:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:04 INFO - 'NO_EM_RESTART': '1', 15:10:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:04 INFO - 'PWD': '/builds/slave/test', 15:10:04 INFO - 'SHELL': '/bin/bash', 15:10:04 INFO - 'SHLVL': '1', 15:10:04 INFO - 'TERM': 'linux', 15:10:04 INFO - 'TMOUT': '86400', 15:10:04 INFO - 'USER': 'cltbld', 15:10:04 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1462831765.376647-466763386', 15:10:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:04 INFO - '_': '/tools/buildbot/bin/python'} 15:10:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:04 INFO - Downloading/unpacking flake8 15:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:10:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:10:06 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 15:10:06 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 15:10:06 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 15:10:06 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 15:10:06 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 15:10:06 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 15:10:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:10:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:10:06 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 15:10:06 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 15:10:06 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 15:10:06 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 15:10:06 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 15:10:06 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 15:10:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:10:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:10:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:10:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:10:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:10:07 INFO - no previously-included directories found matching 'docs/_build' 15:10:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:10:07 INFO - Running setup.py install for pep8 15:10:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:10:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:10:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:10:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:10:07 INFO - no previously-included directories found matching 'docs/_build' 15:10:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:10:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:10:07 INFO - Cleaning up... 15:10:07 INFO - Return code: 0 15:10:07 INFO - Running post-action listener: _resource_record_post_action 15:10:07 INFO - Running post-action listener: _start_resource_monitoring 15:10:07 INFO - Starting resource monitoring. 15:10:07 INFO - ##### 15:10:07 INFO - ##### Finished create-virtualenv step (success) 15:10:07 INFO - ##### 15:10:07 INFO - ##### 15:10:07 INFO - ##### Running install step. 15:10:07 INFO - ##### 15:10:07 INFO - Running pre-action listener: _resource_record_pre_action 15:10:07 INFO - Running main action method: install 15:10:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:10:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:10:07 INFO - Reading from file tmpfile_stdout 15:10:07 INFO - Detecting whether we're running mozinstall >=1.0... 15:10:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:10:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:10:07 INFO - Reading from file tmpfile_stdout 15:10:07 INFO - Output received: 15:10:07 INFO - Usage: mozinstall [options] installer 15:10:07 INFO - Options: 15:10:07 INFO - -h, --help show this help message and exit 15:10:07 INFO - -d DEST, --destination=DEST 15:10:07 INFO - Directory to install application into. [default: 15:10:07 INFO - "/builds/slave/test"] 15:10:07 INFO - --app=APP Application being installed. [default: firefox] 15:10:07 INFO - mkdir: /builds/slave/test/build/application 15:10:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:10:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:10:23 INFO - Reading from file tmpfile_stdout 15:10:23 INFO - Output received: 15:10:23 INFO - /builds/slave/test/build/application/firefox/firefox 15:10:23 INFO - Running post-action listener: _resource_record_post_action 15:10:23 INFO - ##### 15:10:23 INFO - ##### Finished install step (success) 15:10:23 INFO - ##### 15:10:23 INFO - ##### 15:10:23 INFO - ##### Running run-tests step. 15:10:23 INFO - ##### 15:10:23 INFO - Running pre-action listener: _resource_record_pre_action 15:10:23 INFO - Running main action method: run_tests 15:10:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:10:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:10:23 INFO - Python 2.7.3 15:10:23 INFO - Return code: 0 15:10:23 INFO - grabbing minidump binary from tooltool 15:10:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:23 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 0x233e9c0>, '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 0x233f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x233fd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:10:23 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 15:10:23 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 15:10:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:10:23 INFO - Return code: 0 15:10:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:10:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:10:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:10:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:10:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:10:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:10:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:10:24 INFO - Return code: 0 15:10:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QJLTcO3KSSGKSS4195Pvsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 15:10:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QJLTcO3KSSGKSS4195Pvsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 15:10:24 INFO - Using env: {'DISPLAY': ':0', 15:10:24 INFO - 'HOME': '/home/cltbld', 15:10:24 INFO - 'LANG': 'en_US.UTF-8', 15:10:24 INFO - 'LANGUAGE': 'en_US:en', 15:10:24 INFO - 'LOGNAME': 'cltbld', 15:10:24 INFO - 'MAIL': '/var/mail/cltbld', 15:10:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:10:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:10:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:24 INFO - 'MOZ_NO_REMOTE': '1', 15:10:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:10:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:24 INFO - 'NO_EM_RESTART': '1', 15:10:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:24 INFO - 'PWD': '/builds/slave/test', 15:10:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:10:24 INFO - 'SHELL': '/bin/bash', 15:10:24 INFO - 'SHLVL': '1', 15:10:24 INFO - 'TERM': 'linux', 15:10:24 INFO - 'TMOUT': '86400', 15:10:24 INFO - 'USER': 'cltbld', 15:10:24 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1462831765.376647-466763386', 15:10:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:24 INFO - '_': '/tools/buildbot/bin/python'} 15:10:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QJLTcO3KSSGKSS4195Pvsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 15:10:24 INFO - mozversion application_buildid: 20160509143357 15:10:24 INFO - mozversion application_changeset: 9428c76cb9df77442a54cd68cae5a8426ba334a7 15:10:24 INFO - mozversion application_display_name: Nightly 15:10:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:10:24 INFO - mozversion application_name: Firefox 15:10:24 INFO - mozversion application_remotingname: firefox 15:10:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:10:24 INFO - mozversion application_vendor: Mozilla 15:10:24 INFO - mozversion application_version: 49.0a1 15:10:24 INFO - mozversion platform_buildid: 20160509143357 15:10:24 INFO - mozversion platform_changeset: 9428c76cb9df77442a54cd68cae5a8426ba334a7 15:10:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:10:24 INFO - mozversion platform_version: 49.0a1 15:10:24 INFO - using testdate: 1462831824 15:10:24 INFO - actual date: 1462831824 15:10:24 INFO - starting webserver on 'localhost:51735' 15:10:24 INFO - SUITE-START | Running 2 tests 15:10:24 INFO - TEST-START | dromaeo_css 15:10:24 INFO - operating with platform_type : linux_ 15:10:24 INFO - Initialising browser for dromaeo_css test... 15:10:24 INFO - TEST-INFO | started process 15752 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEPiLvV/profile http://localhost:51735/getInfo.html) 15:10:29 INFO - PROCESS | 15752 | __metrics Screen width/height:1600/1200 15:10:29 INFO - PROCESS | 15752 | colorDepth:24 15:10:29 INFO - PROCESS | 15752 | Browser inner width/height: 1024/697 15:10:29 INFO - PROCESS | 15752 | __metrics 15:10:30 ERROR - PROCESS | 15752 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:10:31 INFO - TEST-INFO | 15752: exit 0 15:10:31 INFO - Browser initialized. 15:10:31 INFO - Running cycle 1/1 for dromaeo_css test... 15:10:31 INFO - TEST-INFO | started process 15834 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEPiLvV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:10:43 INFO - PROCESS | 15834 | RSS: Main: 154460160 15:10:43 INFO - PROCESS | 15834 | 15:11:34 INFO - PROCESS | 15834 | 1462831894808 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] 15:13:46 INFO - PROCESS | 15834 | Cycle 1(1): loaded http://localhost:51735/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51735/tests/dromaeo/cssquery-ext.html) 15:13:47 INFO - PROCESS | 15834 | RSS: Main: 267837440 15:13:47 INFO - PROCESS | 15834 | 15:16:49 INFO - PROCESS | 15834 | Cycle 1(1): loaded http://localhost:51735/tests/dromaeo/cssquery-ext.html (next: http://localhost:51735/tests/dromaeo/cssquery-jquery.html) 15:16:50 INFO - PROCESS | 15834 | RSS: Main: 243445760 15:16:50 INFO - PROCESS | 15834 | 15:19:52 INFO - PROCESS | 15834 | Cycle 1(1): loaded http://localhost:51735/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51735/tests/dromaeo/cssquery-mootools.html) 15:19:53 INFO - PROCESS | 15834 | RSS: Main: 240451584 15:19:53 INFO - PROCESS | 15834 | 15:22:55 INFO - PROCESS | 15834 | Cycle 1(1): loaded http://localhost:51735/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51735/tests/dromaeo/cssquery-prototype.html) 15:22:56 INFO - PROCESS | 15834 | RSS: Main: 229109760 15:22:56 INFO - PROCESS | 15834 | 15:25:59 INFO - PROCESS | 15834 | Cycle 1(1): loaded http://localhost:51735/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51735/tests/dromaeo/cssquery-yui.html) 15:25:59 INFO - PROCESS | 15834 | RSS: Main: 211861504 15:25:59 INFO - PROCESS | 15834 | 15:29:02 INFO - PROCESS | 15834 | Cycle 1(1): loaded http://localhost:51735/tests/dromaeo/cssquery-yui.html (next: http://localhost:51735/tests/dromaeo/cssquery-dojo.html) 15:29:02 INFO - PROCESS | 15834 | RSS: Main: 270540800 15:29:02 INFO - PROCESS | 15834 | 15:29:02 INFO - PROCESS | 15834 | __start_tp_report 15:29:02 INFO - PROCESS | 15834 | _x_x_mozilla_page_load 15:29:02 INFO - PROCESS | 15834 | _x_x_mozilla_page_load_details 15:29:02 INFO - PROCESS | 15834 | |i|pagename|runs| 15:29:02 INFO - PROCESS | 15834 | |0;dojo.html;2639.973600263997;2661.1484325015977;2683.101161111027;2698.7840972722183;2703.189043287013;4534.750588717619;4586.3579098926175;4660.883477913049;4705.858824235274;4764.666473346867;4761;4764.928526072112;4834.564889159975;4842.878928026801;4905.141600219965;4299.5485474025245;4345.500267469242;4425.7565833879125;4474.932876006863;4524.97737511312;4462.665300102489;4481.0813783174535;4504.279315309551;4504.797284122223;4518.367428559988;4188.28799104153;4235.216484950263;4307.612314891675;4357.716748411343;4407.493138289105;4310.719803212781;4318.179545886272;4327.978360108211;4405.383246345515;4454.354118652777;4339.088791353788;4342.782860856944;4350.195213885409;4356.695031347807;4401.977990110061;4423.601875831158;4603.401557797499;4607.10161518504;4619.538046195387;4680.531946805327;5149.665271757362;5153.149730294497;5170.896582068375;5173;5176.767045482925;5115;5144.43411224765;5149.588032957355;5182.455842136596;5184.170532714786;4566;4772.5227477252;4812.51874812523;4857.878553036202;4860.1008813368935;5257.6845389276;5258.8948221036135;5289.418164001957;5301.761420736076;5311.707856067954;5053.747312634354;5072.416672082684;5075.796968121308;5100.030994111107;5103.744812759347;4856.417229932431;4955.677880937727;5027.1956486962645;5034.89930201394;5068.949310506848;4976.751162441863;4995.9500404996215;4998.375203099613;5003.174476211457;5063.11395505785;4930.901381972412;4931.5561599455505;4932.284818701268;4976.303317535548;4997.600191984632;4130.359794231899;4164.875053748392;4239.40648309237;4322.459692538433;4329.480462344476;3746.7377283589885;3767.773933563995;3779.3008293465246;3786.3563194257044;3809.5238095238096;4315.784210789448;4326.935095973563;4331.436913201263;4380.3210502372185;4381.474223093249;4923.926141107886;4973.42805577356;5007.84976450707;5019.447860735316;5044.1929291313945;4292.678049146327;4298.785060747013;4299.806508707115;4304.720193187432;4323.156984388077;4429.53489883564;4565.474970378383;4565.840195593139;4570.040291538748;4604.848787803049;4750.714957102585;4802.951970480251;4806.519348065165;4825.227963525819;4826.203676393497;5092.312537807348;5128.769205385692;5130;5141.794328226829;5184;4624.16764982293;4750.881227969328;4809.711417314972;4814.350062741625;4867.269909513601;4974.7512624369365;5011.674241174312;5020.673656212481;5082.491750824888;5083;5073.644844860824;5091.949080509147;5112.693238405707;5115;5165.690058596496;4802.327674125695;4932.4081110267;4940.962397896482;4958.76030992252;4958.8760280993265;4925.064237794808;4949.876253093701;4952.257161425815;4965.8013679452415;4997.750112494288;4872.317875497362;4891.241857512091;4941.876453088702;4946.579540739078;4950.801967921243;4813.446453657734;4852.733099679552;4905.190643543775;5009.799608015638;5018.874528136826;4800.66395352336;4817.349657796152;4827.324174615627;4859.149648811514;4865.343178670834 15:29:02 INFO - PROCESS | 15834 | |1;ext.html;557.4147145497227;599.5563283170454;603.7826382502301;607.6141650052218;609.4240942309519;41755.37366939498;42186.15627687444;43088.13823723524;43144;43161.568384316146;41824;42218;42290.57709422905;42325.576744232545;42444;7450.105987281534;7616;7907.999999999985;8049.637766300501;10186.28695991281;9839.311248212627;10145.188384929188;10150.13723833475;10162.339447935861;10165.898341016606;10183.134433573117;10226.795464090714;10227.130693891027;10236.129928956048;10237.539310731036;10071.093601575856;10123;10133.189344852393;10134.54394552247;10138.746531336701;10047.447390393525;10094.89905100947;10126.29115961883;10129.746756331077;10130;38862.61137388618;39015;39303;39324.21351572981;39403.8029809852;3233.708966193054;3426.194844211608;3518.384282750534;3604.5854726706502;3843.3658446356317;32512.67487325144;33252.50121248183;33458.66541334604;33480.330393392236;33490.1627459313;3195.6964088411796;3268.2809781847955;3291.391092647844;3412.283420481702;3414.897553073412;246459;248070;248790;248911;249315;58271;58401.415985840446;58517;58618;58889;61574;61698;61973;62072.68963655153;62080;15095.622609434851;15349.462768803038;15349.846501535065;15354.692906142038;15369.1546964918;11392.43037848121;11442.713932151597;11445.08439324852;11458.369789661481;11478.139139564566;18339.57799250646;19252.518687032654;19354.806451935583;19453.51366215856;19507.317243896396;6765.221999470124;6874.450043996469;6899.586024838526;6940.236573976858;7288.727294520757;871.9389642725075;946.2146418472789;948.83869742144;1008.8587597736323;1020.5101551255439;28058.2985425366;29156.562651560245;29294.853525732236;29506.362746469043;29706.25734356615;990.782027953849;1003.9146672532917;1012.4330374990029;1042.0881728487573;1073.5866691323897;15181.544553663407;15547.30037148331;15680.372785088468;15757.290921908541;15850;393116;394029;394543;399190.012149818;400042;50540.74729626402;51078;51185.744071279405;51241.7437912808;51262.48737512652;1217.8843009914044;1256.1534544219983;1256.7109564800148;1260.848698156227;1262.1543565810928;27663.308417288925;28373.43253134967;28561.322047240137;28774.280642984093;28802.711972880003;44257;44534.331985019606;44588.777056114515;44600.33099503575;44668.77665611651;330563;331421;332501;334119;334215;25748.356291092874;26022.60966085548;26567;26647.86676066607;26656.60015099736;42801.785991069846;43677.78161109174;43869.34195986999;44193;44240.55759442493;37159;37488.25023499569;37537.2492550153;37664.81167594254;38394.23211535698;37428.62571374251;37716;37742;37966.62033379631;38015.429768554044;36001.63998359983;36587.08532286714;37370.43944340783;37603.435948461345;37608.43587346137;31586.842065789522;33378.15210056693;33382.49926251157;33794.49308260427;33819;26027.609585855847;26037.95848166052;26161.869190653924;26227.475450491263;26389.34026649349 15:29:02 INFO - PROCESS | 15834 | |2;jquery.html;348.8674303764569;381.2755764048308;389.79340949296864;390.20203683467315;403.24995508354453;12860.678483037917;13917.582472525828;17880.463586092406;17895.73156402655;17898.73151902721;16566.585835354123;17111.91444042778;17351.91324043378;17616.414522692987;17641.91179044103;5200.141976573861;5262.342207224097;5347.171188465794;5401.162819762943;5404.540614047811;3762.1159027628487;3970.583088775666;5294.841154765344;5459.508644222019;6026.819195424145;6069.57512974092;6103.328633850273;6108.725107370156;6219.9689001554925;6245.406686364788;6048.848778780522;6081.331053584102;6184.876302473948;6228.844278893064;6233.2208473940755;3359.7816141950693;3564.928701425983;5091.592672586185;5423.132298832207;5434.64674796137;21265;21494.677579836316;21653.45866353338;21730.348089557338;21778.34664960054;1823.2069049963309;2084.7289852319254;2097.8741275523516;2129.0100103451814;2228.5320082782637;9444.716658500256;9728.367656102331;9758.170555502791;9967.252456065751;12615.558455454107;1793.9820601793945;1804.0889350877853;1805.5034865412117;1825.9634807303912;1872.6535590915723;65223.3477665222;68828;68927.31072689309;69266.30733692649;71226.28773712249;8362.414630975894;8901.55492225399;9005.819883602291;9484.525773711286;10374;12621.116521843567;12661.810072848915;12693.49226030967;12727.363631818373;12745.681357966125;6985.196702379291;7076.716931322792;7089.291070892869;7149.785506434815;7265.200827908926;6798.252192258848;6836.965815170893;6946.895796563055;6952.617606031616;6967.233604303523;3879.262940041383;3965.147493288957;3972.960270397259;4014.1570270243574;4037.212743515045;1854;1861.678208471973;1863.9440816775518;1897.3643829317057;1913.7799153097571;823.5717426938079;909.8589718593629;940.2994768897215;953.1612181280428;973.9026097390346;16360.181990900408;16957.321707131825;17375.131243437776;17512.91243543774;17869.642607148045;878.2271600991087;912.0378001208655;924.4869097650734;931.6180366049887;991.4794732765212;9112.772180695403;9596.90403095974;9607.13535781769;9663.420194788336;9826.263030272758;285977;291382;389318;393252;402273;78596.60701696569;81448.59275703583;82388;83958;84710.15289847145;946.3564775952281;961.3270710502676;985.8619793228954;993.4089216915924;997.4364484066624;15691.293891775125;15830.548486222204;15955.60110997188;16129;16453.42413015539;35781;36012;36184.81907590445;36351.454728179626;36586.26827463489;48187.277190841465;49589.75205123951;49680.75159624179;50012;50305.24542131798;7797.805054873674;7998.280154786097;8011.919880801117;8073.919260807317;8149.959250203711;8766.386352955233;11445.48495317696;12024.639260822189;12201;12377;9502.762430939005;10265;10473.31923424975;10595.682129536126;10636.09593184557;9676.274279429212;10483.318584291997;10575.788484230427;10621.150307975498;10757.193210509087;10573.89426105729;10770.353778772986;10880.292780969212;11052.613158539412;11132.666020019413;7847.9607601961625;7937.404694647809;7978.880316795136;8023.237792409712;8081.919180808117;8320.16798320163;10194.235432342455;10318.380897146195;10718.464076795974;11034.282771619819 15:29:02 INFO - PROCESS | 15834 | |3;mootools.html;1291.3672300572723;1441.6035590212691;1465.4797546870861;1584.413766906244;1776.2983621469511;6896.4138048265895;7228.530145540542;7262.382697470708;7405.185429602753;7405.962970185142;7254.274572542743;7393.778186654409;7443.478956473035;7460.738874139406;7462.9924960130365;1880.3512788088087;1927.6144771045776;1949.9415017549495;2131.914723411062;2192.8245740340813;2175.282156888231;2254.3237028891267;2257.006916956534;2274.3063365673547;2283.5547068321684;2208.536207396449;2221.544583360407;2237.4965632732587;2239.8656080635214;2244.0574958517464;1851.1947302923272;2167.1439781286463;2195.1000089963118;2232.285668586053;2236.4856083100894;2220.7224096987875;2254.864708117502;2257.932262032142;2258.841881068326;2259.35608351619;7330.083739532559;7390.076240469942;7400.888986665204;7402.888956665654;7408.333250007471;4525.162844873709;4650.162970665279;4650.25595904657;4657.7903994319995;4658.231391820345;2910.359720861407;3034.544818277254;3072.4316001539787;3083.892063777757;3088.8146711197173;955.6273053509137;986.4722373530127;996.227923359395;1001.2140469731225;1006.9144122749575;9847.310688251826;9866.605335786631;9885.110340069428;9900.702978910644;9910.306278560503;4219.9789001055415;4239.830406783694;4318.676099292566;4359.149965756647;4371.650267978554;8599.226069653636;8640.913590864136;8641.567921603895;8647.956760216159;8662.566871656392;4439.223135951195;4483.484399294058;4516.548345165457;4522.3668686383935;4529.38853254813;3608.45873119029;3959.3467077932396;4013;4130.463039804867;4227.0489139943265;3618.2944325856206;3659.652333028358;3735.1782607826235;3739.1586892949413;3759.473673685686;1199.232491205629;1212.6907638552113;1216.4586758892208;1218.415160722858;1223.9510419583296;804.6459557794552;848.5248260973874;885.7874110213502;907.9591418386188;928.8003079337975;4953.653244272867;5074.391073071255;5290.100682883919;5342.8664283392445;5423.566114710814;857.1385757313859;861.4056301152185;870.9477431354139;889.8086911314099;946.8816397950256;3489.3021395720957;3523.788572685647;3562.287542491512;3574.1243395367783;3636.054625797312;8906.064863189402;9110.954445227731;9254.629814807467;9397.859032114524;9401.811963760823;8985.550722463851;9111.589978450986;9142;9210.217131543894;9227.492487913229;6721.361470660279;6725.125733654593;6789.626570538569;6866.931330686729;6993.720251189896;5018.1218286800395;5080.314157588826;5103.3110530077965;5139;5211.791528338824;8370.66517339324;8413.200745929127;8423.831523369621;8571.61427735766;8634.352423568133;8459.492430454193;8670.609822557873;8671.089535598923;8713.433626814236;8849.469031858109;5520.585956053393;5664.915026274527;5811.622244554091;6002.639841609517;6185.257769067741;6992.615406152507;6992.860142797217;7028.472864535078;7038.436925045881;7060.293970603104;6142.201513803177;6238.937610623836;6261.405166509175;6430.485561155003;6440.227172739301;6192.969035154795;6199.938000619936;6243.750249989949;6281.4660753834605;6351.142595749515;5864.06175011996;5920.644761314163;5923.229980102559;5951.880962380815;5957.195778570011;4370.562943705604;4380.737155770664;4455.821767129408;4470.588235294118;4502.302143167814;4375.868723938287;4401.053773438726;4426.82292708301;4467.463904331501;4482 15:29:02 INFO - PROCESS | 15834 | |4;prototype.html;302.65043874325164;315.78053252989173;319.5558174137948;326.1601376455627;326.38802245789145;4645.767711614414;4826.613870890329;4890.413150421946;4909.63177761668;4921.581665558428;4658.928446457317;4730.0303437795255;4757.405324334458;4768.402585133984;4825.372701548802;3849.1724279279947;3853.807309634521;3862.8454861805494;3863.420486926955;3864.671502922241;3664.662398224642;3737.9252414951684;3837.5970523095093;3877.1664092220167;3879.7866117363533;3808.485854409661;3817.866374676887;3822.789746563938;3825.9808700956596;3831.7892515911612;3776.9055773605605;3794.5636251831115;3809.5999920008553;3823.8279277432584;3844.0774214188395;3421.349943510725;3423.4864770284407;3451.913702157441;3455.1362159460136;3457.1529975155995;4549.795259213311;4587.8623641290815;4616.8153273869;4624.606908412789;4658.953410465886;4326.156399502099;4337.414449049401;4345.023014528382;4368.104538569617;4378.255696531597;5015;5037.219231019161;5038.193888977746;5044.54599086084;5056.418511871145;3606.1886075633033;3731.0485826114436;3753.8498460061564;3762.6049264827348;3763.397856342972;5211.661242019257;5243;5253;5271.789128434858;5306.999999999962;3825.464434979105;3834.1948190880225;3845.6346647068485;3886.261610294035;3897.0841852164717;3599.46008098782;3894.6689531389584;3904.06302487401;3908.0069164726197;3911.9804400977814;4241.300185469425;4252.362145678111;4298.161858437637;4302.892427689333;4305.612494875476;5038.2190760432195;5049.081349087323;5054.4692807254705;5062.443131255559;5068.189089745697;1213.883227430748;1238.2756087688804;1252.5240408644838;1260.449646934276;1266.512392728806;860.3246451535515;865.4504389712578;882.8146089321186;884.5709830732089;894.4856707393275;4261.680373971964;4299.1831552005015;4312.870613881589;4323.783810809447;4336.457942757155;5047.16721740916;5060.49395060491;5064.164412871834;5065.772040258197;5067.974660126676;4235.407043013981;4279.443672322641;4290.89272768177;4333.8699839004885;4341.240282950471;2537.0486067724605;2667.1465131157843;2675.5719084946313;2677.3708178578017;2686.1135825177644;4739.95260047402;4778.546038126373;4784.521547845257;4787.40157480315;4824.565789079;5174.508421699932;5175.767090480937;5180.937907728907;5192.338451695497;5196.168613021899;4705.247160454379;5015.648904576645;5020.824271150492;5028.924566131438;5036.949630503721;5136.434992150786;5228.660137091077;5252.632315738015;5254.343207099113;5273.156294992783;4940.407151141886;5177.171652535576;5192.870178245574;5221.43356992893;5230.398504172069;4926.8768280793265;4974.303597496281;4975.328330675457;4979.800807967641;4993.375828021497;3677.7793332400142;3709.2396058808417;3710.666040056408;3755.8309876055096;3761.3417651911354;4914.778834952364;5310.575153987749;5320.920186197288;5325.414204437431;5327.334083239595;4416.447944006999;5081.611642528006;5105.642605017613;5125.180560900826;5128.333316668958;5060.49395060491;5073.7716802743225;5082.2122571001555;5100.132977393778;5114.181730923035;4951.628627852998;4983.177775666974;5005.149124648746;5051.419086805065;5069.2902993581665;4887.242477416006;5152.639315247897;5157.896842063213;5200.6879587224885;5207.973960130175;5033.748312584429;5034.798608055637;5066.138756411346;5094.490550944876;5095.949040509548 15:29:02 INFO - PROCESS | 15834 | |5;yui.html;741.2328240271319;754.1402800807077;797.2386371015681;815.388458656008;825.380964276792;11042.613508527204;11625.128115391348;11647.068234541237;11664.41677916104;11697.766044679101;11085.722856928582;11883.227590206652;11916.702082447942;11965.820512692295;12050.698732531691;860.578316624854;866.2550206822159;870.695256660167;874.0822136756381;874.7288340614398;875.1511034296722;879.5734068976541;880.1110878013221;880.423322723617;880.7445840706188;916.6974898283584;916.9083091690844;918.5774543709902;919.3748251189222;920.6777627830273;901.4230892228978;912.2063804490103;912.543728135932;913.1644545241096;914.5884352041608;672.2504407585556;674.0125715826289;674.5649056358621;674.6862708840364;674.7132468700783;10204.336718113298;10216.438095904723;10225.64210252645;10241.897581024243;10280.94859525705;9828.754281142958;10040.89959100407;10438;10658.946705266502;10846.511906964206;9193.126652967958;9235.076492350778;9339.766505837408;9350.29872759539;9627.3260871739;3179.284660951291;3184.9363012739846;3187.0279564732746;3212.791168574035;3383.5263063171174;33416.16459588506;35109.64890351089;35212.56885453049;36226;41123.588764112275;8475;8536.957315213509;8749.16882896124;9420.293477989178;10205;17092.316307347817;17096.57258568546;17113.657726845395;17134.314627414762;17231.3969011084;5023.49765023502;6078.696065196723;6739.286866330899;6781.050652908597;6786.966065169642;3266.477363621809;3320.9833950830093;3512.8243587820507;3578.8031658258524;3666.5416822897137;2818.3799564095866;2940.955885661674;2943.9852800735857;2944.2344990302677;2946.130891387046;512.2751306900768;522.1593234891822;525.3328273093226;529.8887233680894;535.6973310079793;503.6172508893267;623.8003838771549;624.1168746224133;626.5739297277895;636.4144986612328;7276.56340619554;7292.562446253136;7584.658690358947;7629.694812207561;7721.112072111667;519.5843325339713;578.8581797459649;628.1582679209881;634.1249076274711;634.7587916591666;3401.6035564023355;3529.3294274087843;3609.6029436761937;3616.5840928293583;3628;50064.24903626448;50948.235776463385;53123.73438132785;53186;53574.73212633912;45203.77398112988;46082.76958615185;46350;46920;46971.53028469672;42232.788836055624;42373;42392.99999999938;42466.78766606147;42531.57468425276;6820.283870193558;6914.204866440424;6919.688614012281;7050.153981522045;7070.505064645426;27587.44825103527;28268.43463130767;28286;28576.42847143087;28580.714192857806;34588.481172781925;34980.82509587436;36097;36354;37330;9852.359596626196;10119.848202277119;10314.948425257826;10395.32430392022;10436.37381757097;11378.54485820558;11597.362145082101;11946.223495473114;12019.75960480768;12318.076144289034;10292.125169360688;10364.740881478023;11099.223054386439;11159.442027898735;11293.153013524183;10577.682669519927;10693.839592406275;10711.464426778786;10790;10816.242862999514;10728.356298622108;10739.516721747385;11188.66434006981;11305;11384.032357249394;9196.26429885621;9359.625614975324;9389.436633801994;9474.52627368615;9652.75868103303;9261;9455.920717188734;9472.194863436685;9587.952060239933;9809.215262778818 15:29:02 INFO - PROCESS | 15834 | __end_tp_report 15:29:02 INFO - PROCESS | 15834 | __start_cc_report 15:29:02 INFO - PROCESS | 15834 | _x_x_mozilla_cycle_collect,1119 15:29:02 INFO - PROCESS | 15834 | __end_cc_report 15:29:02 INFO - PROCESS | 15834 | __startTimestamp1462832942856__endTimestamp 15:29:02 INFO - PROCESS | 15834 | 15:29:02 INFO - PROCESS | 15834 | ------- Summary: start ------- 15:29:02 INFO - PROCESS | 15834 | Number of tests: 6 15:29:02 INFO - PROCESS | 15834 | 15:29:02 INFO - PROCESS | 15834 | [#0] dojo.html Cycles:165 Average:4687.57 Median:4826.20 stddev:495.49 (10.3%) stddev-sans-first:470.25 15:29:02 INFO - PROCESS | 15834 | Values: 2640.0 2661.1 2683.1 2698.8 2703.2 4534.8 4586.4 4660.9 4705.9 4764.7 4761.0 4764.9 4834.6 4842.9 4905.1 4299.5 4345.5 4425.8 4474.9 4525.0 4462.7 4481.1 4504.3 4504.8 4518.4 4188.3 4235.2 4307.6 4357.7 4407.5 4310.7 4318.2 4328.0 4405.4 4454.4 4339.1 4342.8 4350.2 4356.7 4402.0 4423.6 4603.4 4607.1 4619.5 4680.5 5149.7 5153.1 5170.9 5173.0 5176.8 5115.0 5144.4 5149.6 5182.5 5184.2 4566.0 4772.5 4812.5 4857.9 4860.1 5257.7 5258.9 5289.4 5301.8 5311.7 5053.7 5072.4 5075.8 5100.0 5103.7 4856.4 4955.7 5027.2 5034.9 5068.9 4976.8 4996.0 4998.4 5003.2 5063.1 4930.9 4931.6 4932.3 4976.3 4997.6 4130.4 4164.9 4239.4 4322.5 4329.5 3746.7 3767.8 3779.3 3786.4 3809.5 4315.8 4326.9 4331.4 4380.3 4381.5 4923.9 4973.4 5007.8 5019.4 5044.2 4292.7 4298.8 4299.8 4304.7 4323.2 4429.5 4565.5 4565.8 4570.0 4604.8 4750.7 4803.0 4806.5 4825.2 4826.2 5092.3 5128.8 5130.0 5141.8 5184.0 4624.2 4750.9 4809.7 4814.4 4867.3 4974.8 5011.7 5020.7 5082.5 5083.0 5073.6 5091.9 5112.7 5115.0 5165.7 4802.3 4932.4 4941.0 4958.8 4958.9 4925.1 4949.9 4952.3 4965.8 4997.8 4872.3 4891.2 4941.9 4946.6 4950.8 4813.4 4852.7 4905.2 5009.8 5018.9 4800.7 4817.3 4827.3 4859.1 4865.3 15:29:02 INFO - PROCESS | 15834 | 15:29:02 INFO - PROCESS | 15834 | [#1] ext.html Cycles:180 Average:49383.26 Median:33469.50 stddev:87057.47 (260.1%) stddev-sans-first:87224.50 15:29:02 INFO - PROCESS | 15834 | Values: 557.4 599.6 603.8 607.6 609.4 41755.4 42186.2 43088.1 43144.0 43161.6 41824.0 42218.0 42290.6 42325.6 42444.0 7450.1 7616.0 7908.0 8049.6 10186.3 9839.3 10145.2 10150.1 10162.3 10165.9 10183.1 10226.8 10227.1 10236.1 10237.5 10071.1 10123.0 10133.2 10134.5 10138.7 10047.4 10094.9 10126.3 10129.7 10130.0 38862.6 39015.0 39303.0 39324.2 39403.8 3233.7 3426.2 3518.4 3604.6 3843.4 32512.7 33252.5 33458.7 33480.3 33490.2 3195.7 3268.3 3291.4 3412.3 3414.9 246459.0 248070.0 248790.0 248911.0 249315.0 58271.0 58401.4 58517.0 58618.0 58889.0 61574.0 61698.0 61973.0 62072.7 62080.0 15095.6 15349.5 15349.8 15354.7 15369.2 11392.4 11442.7 11445.1 11458.4 11478.1 18339.6 19252.5 19354.8 19453.5 19507.3 6765.2 6874.5 6899.6 6940.2 7288.7 871.9 946.2 948.8 1008.9 1020.5 28058.3 29156.6 29294.9 29506.4 29706.3 990.8 1003.9 1012.4 1042.1 1073.6 15181.5 15547.3 15680.4 15757.3 15850.0 393116.0 394029.0 394543.0 399190.0 400042.0 50540.7 51078.0 51185.7 51241.7 51262.5 1217.9 1256.2 1256.7 1260.8 1262.2 27663.3 28373.4 28561.3 28774.3 28802.7 44257.0 44534.3 44588.8 44600.3 44668.8 330563.0 331421.0 332501.0 334119.0 334215.0 25748.4 26022.6 26567.0 26647.9 26656.6 42801.8 43677.8 43869.3 44193.0 44240.6 37159.0 37488.3 37537.2 37664.8 38394.2 37428.6 37716.0 37742.0 37966.6 38015.4 36001.6 36587.1 37370.4 37603.4 37608.4 31586.8 33378.2 33382.5 33794.5 33819.0 26027.6 26038.0 26161.9 26227.5 26389.3 15:29:02 INFO - PROCESS | 15834 | 15:29:02 INFO - PROCESS | 15834 | [#2] jquery.html Cycles:180 Average:23393.43 Median:2220.23 stddev:59207.36 (2666.7%) stddev-sans-first:59348.17 15:29:02 INFO - PROCESS | 15834 | Values: 348.9 381.3 389.8 390.2 403.2 12860.7 13917.6 17880.5 17895.7 17898.7 16566.6 17111.9 17351.9 17616.4 17641.9 5200.1 5262.3 5347.2 5401.2 5404.5 3762.1 3970.6 5294.8 5459.5 6026.8 6069.6 6103.3 6108.7 6220.0 6245.4 6048.8 6081.3 6184.9 6228.8 6233.2 3359.8 3564.9 5091.6 5423.1 5434.6 21265.0 21494.7 21653.5 21730.3 21778.3 1823.2 2084.7 2097.9 2129.0 2228.5 9444.7 9728.4 9758.2 9967.3 12615.6 1794.0 1804.1 1805.5 1826.0 1872.7 65223.3 68828.0 68927.3 69266.3 71226.3 8362.4 8901.6 9005.8 9484.5 10374.0 12621.1 12661.8 12693.5 12727.4 12745.7 6985.2 7076.7 7089.3 7149.8 7265.2 6798.3 6837.0 6946.9 6952.6 6967.2 3879.3 3965.1 3973.0 4014.2 4037.2 1854.0 1861.7 1863.9 1897.4 1913.8 823.6 909.9 940.3 953.2 973.9 16360.2 16957.3 17375.1 17512.9 17869.6 878.2 912.0 924.5 931.6 991.5 9112.8 9596.9 9607.1 9663.4 9826.3 285977.0 291382.0 389318.0 393252.0 402273.0 78596.6 81448.6 82388.0 83958.0 84710.2 946.4 961.3 985.9 993.4 997.4 15691.3 15830.5 15955.6 16129.0 16453.4 35781.0 36012.0 36184.8 36351.5 36586.3 48187.3 49589.8 49680.8 50012.0 50305.2 7797.8 7998.3 8011.9 8073.9 8150.0 8766.4 11445.5 12024.6 12201.0 12377.0 9502.8 10265.0 10473.3 10595.7 10636.1 9676.3 10483.3 10575.8 10621.2 10757.2 10573.9 10770.4 10880.3 11052.6 11132.7 7848.0 7937.4 7978.9 8023.2 8081.9 8320.2 10194.2 10318.4 10718.5 11034.3 15:29:02 INFO - PROCESS | 15834 | 15:29:02 INFO - PROCESS | 15834 | [#3] mootools.html Cycles:180 Average:4929.98 Median:5383.22 stddev:2658.92 (49.4%) stddev-sans-first:2652.32 15:29:02 INFO - PROCESS | 15834 | Values: 1291.4 1441.6 1465.5 1584.4 1776.3 6896.4 7228.5 7262.4 7405.2 7406.0 7254.3 7393.8 7443.5 7460.7 7463.0 1880.4 1927.6 1949.9 2131.9 2192.8 2175.3 2254.3 2257.0 2274.3 2283.6 2208.5 2221.5 2237.5 2239.9 2244.1 1851.2 2167.1 2195.1 2232.3 2236.5 2220.7 2254.9 2257.9 2258.8 2259.4 7330.1 7390.1 7400.9 7402.9 7408.3 4525.2 4650.2 4650.3 4657.8 4658.2 2910.4 3034.5 3072.4 3083.9 3088.8 955.6 986.5 996.2 1001.2 1006.9 9847.3 9866.6 9885.1 9900.7 9910.3 4220.0 4239.8 4318.7 4359.1 4371.7 8599.2 8640.9 8641.6 8648.0 8662.6 4439.2 4483.5 4516.5 4522.4 4529.4 3608.5 3959.3 4013.0 4130.5 4227.0 3618.3 3659.7 3735.2 3739.2 3759.5 1199.2 1212.7 1216.5 1218.4 1224.0 804.6 848.5 885.8 908.0 928.8 4953.7 5074.4 5290.1 5342.9 5423.6 857.1 861.4 870.9 889.8 946.9 3489.3 3523.8 3562.3 3574.1 3636.1 8906.1 9111.0 9254.6 9397.9 9401.8 8985.6 9111.6 9142.0 9210.2 9227.5 6721.4 6725.1 6789.6 6866.9 6993.7 5018.1 5080.3 5103.3 5139.0 5211.8 8370.7 8413.2 8423.8 8571.6 8634.4 8459.5 8670.6 8671.1 8713.4 8849.5 5520.6 5664.9 5811.6 6002.6 6185.3 6992.6 6992.9 7028.5 7038.4 7060.3 6142.2 6238.9 6261.4 6430.5 6440.2 6193.0 6199.9 6243.8 6281.5 6351.1 5864.1 5920.6 5923.2 5951.9 5957.2 4370.6 4380.7 4455.8 4470.6 4502.3 4375.9 4401.1 4426.8 4467.5 4482.0 15:29:02 INFO - PROCESS | 15834 | 15:29:02 INFO - PROCESS | 15834 | [#4] prototype.html Cycles:180 Average:4210.69 Median:4748.68 stddev:1212.90 (25.5%) stddev-sans-first:1180.30 15:29:02 INFO - PROCESS | 15834 | Values: 302.7 315.8 319.6 326.2 326.4 4645.8 4826.6 4890.4 4909.6 4921.6 4658.9 4730.0 4757.4 4768.4 4825.4 3849.2 3853.8 3862.8 3863.4 3864.7 3664.7 3737.9 3837.6 3877.2 3879.8 3808.5 3817.9 3822.8 3826.0 3831.8 3776.9 3794.6 3809.6 3823.8 3844.1 3421.3 3423.5 3451.9 3455.1 3457.2 4549.8 4587.9 4616.8 4624.6 4659.0 4326.2 4337.4 4345.0 4368.1 4378.3 5015.0 5037.2 5038.2 5044.5 5056.4 3606.2 3731.0 3753.8 3762.6 3763.4 5211.7 5243.0 5253.0 5271.8 5307.0 3825.5 3834.2 3845.6 3886.3 3897.1 3599.5 3894.7 3904.1 3908.0 3912.0 4241.3 4252.4 4298.2 4302.9 4305.6 5038.2 5049.1 5054.5 5062.4 5068.2 1213.9 1238.3 1252.5 1260.4 1266.5 860.3 865.5 882.8 884.6 894.5 4261.7 4299.2 4312.9 4323.8 4336.5 5047.2 5060.5 5064.2 5065.8 5068.0 4235.4 4279.4 4290.9 4333.9 4341.2 2537.0 2667.1 2675.6 2677.4 2686.1 4740.0 4778.5 4784.5 4787.4 4824.6 5174.5 5175.8 5180.9 5192.3 5196.2 4705.2 5015.6 5020.8 5028.9 5036.9 5136.4 5228.7 5252.6 5254.3 5273.2 4940.4 5177.2 5192.9 5221.4 5230.4 4926.9 4974.3 4975.3 4979.8 4993.4 3677.8 3709.2 3710.7 3755.8 3761.3 4914.8 5310.6 5320.9 5325.4 5327.3 4416.4 5081.6 5105.6 5125.2 5128.3 5060.5 5073.8 5082.2 5100.1 5114.2 4951.6 4983.2 5005.1 5051.4 5069.3 4887.2 5152.6 5157.9 5200.7 5208.0 5033.7 5034.8 5066.1 5094.5 5095.9 15:29:02 INFO - PROCESS | 15834 | 15:29:02 INFO - PROCESS | 15834 | [#5] yui.html Cycles:180 Average:12083.84 Median:46216.38 stddev:13717.56 (29.7%) stddev-sans-first:13729.59 15:29:02 INFO - PROCESS | 15834 | Values: 741.2 754.1 797.2 815.4 825.4 11042.6 11625.1 11647.1 11664.4 11697.8 11085.7 11883.2 11916.7 11965.8 12050.7 860.6 866.3 870.7 874.1 874.7 875.2 879.6 880.1 880.4 880.7 916.7 916.9 918.6 919.4 920.7 901.4 912.2 912.5 913.2 914.6 672.3 674.0 674.6 674.7 674.7 10204.3 10216.4 10225.6 10241.9 10280.9 9828.8 10040.9 10438.0 10658.9 10846.5 9193.1 9235.1 9339.8 9350.3 9627.3 3179.3 3184.9 3187.0 3212.8 3383.5 33416.2 35109.6 35212.6 36226.0 41123.6 8475.0 8537.0 8749.2 9420.3 10205.0 17092.3 17096.6 17113.7 17134.3 17231.4 5023.5 6078.7 6739.3 6781.1 6787.0 3266.5 3321.0 3512.8 3578.8 3666.5 2818.4 2941.0 2944.0 2944.2 2946.1 512.3 522.2 525.3 529.9 535.7 503.6 623.8 624.1 626.6 636.4 7276.6 7292.6 7584.7 7629.7 7721.1 519.6 578.9 628.2 634.1 634.8 3401.6 3529.3 3609.6 3616.6 3628.0 50064.2 50948.2 53123.7 53186.0 53574.7 45203.8 46082.8 46350.0 46920.0 46971.5 42232.8 42373.0 42393.0 42466.8 42531.6 6820.3 6914.2 6919.7 7050.2 7070.5 27587.4 28268.4 28286.0 28576.4 28580.7 34588.5 34980.8 36097.0 36354.0 37330.0 9852.4 10119.8 10314.9 10395.3 10436.4 11378.5 11597.4 11946.2 12019.8 12318.1 10292.1 10364.7 11099.2 11159.4 11293.2 10577.7 10693.8 10711.5 10790.0 10816.2 10728.4 10739.5 11188.7 11305.0 11384.0 9196.3 9359.6 9389.4 9474.5 9652.8 9261.0 9455.9 9472.2 9588.0 9809.2 15:29:02 INFO - PROCESS | 15834 | -------- Summary: end -------- 15:29:02 INFO - PROCESS | 15834 | 15:29:03 INFO - TEST-INFO | 15834: exit 0 15:29:03 INFO - TEST-OK | dromaeo_css | took 1118762ms 15:29:03 INFO - TEST-START | kraken 15:29:03 INFO - operating with platform_type : linux_ 15:29:03 INFO - Initialising browser for kraken test... 15:29:03 INFO - TEST-INFO | started process 16017 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPaTdES/profile http://localhost:51735/getInfo.html) 15:29:07 INFO - PROCESS | 16017 | __metrics Screen width/height:1600/1200 15:29:07 INFO - PROCESS | 16017 | colorDepth:24 15:29:07 INFO - PROCESS | 16017 | Browser inner width/height: 1024/697 15:29:07 INFO - PROCESS | 16017 | __metrics 15:29:09 ERROR - PROCESS | 16017 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:29:10 INFO - TEST-INFO | 16017: exit 0 15:29:10 INFO - Browser initialized. 15:29:10 INFO - Running cycle 1/1 for kraken test... 15:29:10 INFO - TEST-INFO | started process 16100 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPaTdES/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:29:22 INFO - PROCESS | 16100 | RSS: Main: 154296320 15:29:22 INFO - PROCESS | 16100 | 15:29:24 INFO - PROCESS | 16100 | Cycle 1(1): loaded http://localhost:51735/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51735/tests/kraken/driver.html?testName=audio-beat-detection) 15:29:25 INFO - PROCESS | 16100 | RSS: Main: 209244160 15:29:25 INFO - PROCESS | 16100 | 15:29:28 INFO - PROCESS | 16100 | Cycle 1(1): loaded http://localhost:51735/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51735/tests/kraken/driver.html?testName=audio-dft) 15:29:29 INFO - PROCESS | 16100 | RSS: Main: 197603328 15:29:29 INFO - PROCESS | 16100 | 15:29:32 INFO - PROCESS | 16100 | Cycle 1(1): loaded http://localhost:51735/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51735/tests/kraken/driver.html?testName=audio-fft) 15:29:33 INFO - PROCESS | 16100 | RSS: Main: 266555392 15:29:33 INFO - PROCESS | 16100 | 15:29:35 INFO - PROCESS | 16100 | Cycle 1(1): loaded http://localhost:51735/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51735/tests/kraken/driver.html?testName=audio-oscillator) 15:29:35 INFO - PROCESS | 16100 | RSS: Main: 175423488 15:29:35 INFO - PROCESS | 16100 | 15:29:38 INFO - PROCESS | 16100 | Cycle 1(1): loaded http://localhost:51735/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51735/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:29:38 INFO - PROCESS | 16100 | RSS: Main: 179675136 15:29:38 INFO - PROCESS | 16100 | 15:29:42 INFO - PROCESS | 16100 | Cycle 1(1): loaded http://localhost:51735/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51735/tests/kraken/driver.html?testName=imaging-darkroom) 15:29:42 INFO - PROCESS | 16100 | RSS: Main: 215756800 15:29:42 INFO - PROCESS | 16100 | 15:29:46 INFO - PROCESS | 16100 | Cycle 1(1): loaded http://localhost:51735/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51735/tests/kraken/driver.html?testName=imaging-desaturate) 15:29:47 INFO - PROCESS | 16100 | RSS: Main: 214441984 15:29:47 INFO - PROCESS | 16100 | 15:29:50 INFO - PROCESS | 16100 | Cycle 1(1): loaded http://localhost:51735/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51735/tests/kraken/driver.html?testName=json-parse-financial) 15:29:50 INFO - PROCESS | 16100 | RSS: Main: 214810624 15:29:50 INFO - PROCESS | 16100 | 15:29:52 INFO - PROCESS | 16100 | Cycle 1(1): loaded http://localhost:51735/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51735/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:29:53 INFO - PROCESS | 16100 | RSS: Main: 204292096 15:29:53 INFO - PROCESS | 16100 | 15:29:55 INFO - PROCESS | 16100 | Cycle 1(1): loaded http://localhost:51735/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51735/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:29:55 INFO - PROCESS | 16100 | RSS: Main: 207609856 15:29:55 INFO - PROCESS | 16100 | 15:29:58 INFO - PROCESS | 16100 | Cycle 1(1): loaded http://localhost:51735/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51735/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:29:58 INFO - PROCESS | 16100 | RSS: Main: 215732224 15:29:58 INFO - PROCESS | 16100 | 15:30:01 INFO - PROCESS | 16100 | Cycle 1(1): loaded http://localhost:51735/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51735/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:30:02 INFO - PROCESS | 16100 | RSS: Main: 221200384 15:30:02 INFO - PROCESS | 16100 | 15:30:05 INFO - PROCESS | 16100 | Cycle 1(1): loaded http://localhost:51735/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51735/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:30:06 INFO - PROCESS | 16100 | RSS: Main: 220696576 15:30:06 INFO - PROCESS | 16100 | 15:30:07 INFO - PROCESS | 16100 | Cycle 1(1): loaded http://localhost:51735/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51735/tests/kraken/driver.html?testName=ai-astar) 15:30:08 INFO - PROCESS | 16100 | RSS: Main: 267075584 15:30:08 INFO - PROCESS | 16100 | 15:30:08 INFO - PROCESS | 16100 | __start_tp_report 15:30:08 INFO - PROCESS | 16100 | _x_x_mozilla_page_load 15:30:08 INFO - PROCESS | 16100 | _x_x_mozilla_page_load_details 15:30:08 INFO - PROCESS | 16100 | |i|pagename|runs| 15:30:08 INFO - PROCESS | 16100 | |0;ai-astar;114;111;114;114;113;113;114;114;115;113 15:30:08 INFO - PROCESS | 16100 | |1;audio-beat-detection;154;134;159;218;131;163;164;131;193;131 15:30:08 INFO - PROCESS | 16100 | |2;audio-dft;161;160;161;161;163;162;160;161;163;161 15:30:08 INFO - PROCESS | 16100 | |3;audio-fft;76;76;77;156;79;77;77;76;129;76 15:30:08 INFO - PROCESS | 16100 | |4;audio-oscillator;92;93;144;93;92;93;125;92;92;124 15:30:08 INFO - PROCESS | 16100 | |5;imaging-gaussian-blur;117;117;117;117;116;116;117;116;116;117 15:30:08 INFO - PROCESS | 16100 | |6;imaging-darkroom;148;148;148;149;149;149;148;148;149;146 15:30:08 INFO - PROCESS | 16100 | |7;imaging-desaturate;96;94;95;94;95;95;95;95;96;95 15:30:08 INFO - PROCESS | 16100 | |8;json-parse-financial;64;65;64;64;64;64;67;117;63;63 15:30:08 INFO - PROCESS | 16100 | |9;json-stringify-tinderbox;64;64;65;66;64;64;64;64;64;64 15:30:08 INFO - PROCESS | 16100 | |10;stanford-crypto-aes;88;85;81;81;82;84;88;83;87;89 15:30:08 INFO - PROCESS | 16100 | |11;stanford-crypto-ccm;132;133;143;129;131;139;131;137;242;136 15:30:08 INFO - PROCESS | 16100 | |12;stanford-crypto-pbkdf2;171;178;181;175;180;176;176;172;177;177 15:30:08 INFO - PROCESS | 16100 | |13;stanford-crypto-sha256-iterative;70;70;68;70;69;68;67;68;66;66 15:30:08 INFO - PROCESS | 16100 | __end_tp_report 15:30:08 INFO - PROCESS | 16100 | __start_cc_report 15:30:08 INFO - PROCESS | 16100 | _x_x_mozilla_cycle_collect,2103 15:30:08 INFO - PROCESS | 16100 | __end_cc_report 15:30:08 INFO - PROCESS | 16100 | __startTimestamp1462833008168__endTimestamp 15:30:08 INFO - PROCESS | 16100 | 15:30:08 INFO - PROCESS | 16100 | ------- Summary: start ------- 15:30:08 INFO - PROCESS | 16100 | Number of tests: 14 15:30:08 INFO - PROCESS | 16100 | 15:30:08 INFO - PROCESS | 16100 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.00 stddev:1.08 (0.9%) stddev-sans-first:1.13 15:30:08 INFO - PROCESS | 16100 | Values: 114.0 111.0 114.0 114.0 113.0 113.0 114.0 114.0 115.0 113.0 15:30:08 INFO - PROCESS | 16100 | 15:30:08 INFO - PROCESS | 16100 | [#1] audio-beat-detection Cycles:10 Average:157.80 Median:161.00 stddev:29.18 (18.1%) stddev-sans-first:30.92 15:30:08 INFO - PROCESS | 16100 | Values: 154.0 134.0 159.0 218.0 131.0 163.0 164.0 131.0 193.0 131.0 15:30:08 INFO - PROCESS | 16100 | 15:30:08 INFO - PROCESS | 16100 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 15:30:08 INFO - PROCESS | 16100 | Values: 161.0 160.0 161.0 161.0 163.0 162.0 160.0 161.0 163.0 161.0 15:30:08 INFO - PROCESS | 16100 | 15:30:08 INFO - PROCESS | 16100 | [#3] audio-fft Cycles:10 Average:89.90 Median:76.50 stddev:28.46 (37.2%) stddev-sans-first:29.74 15:30:08 INFO - PROCESS | 16100 | Values: 76.0 76.0 77.0 156.0 79.0 77.0 77.0 76.0 129.0 76.0 15:30:08 INFO - PROCESS | 16100 | 15:30:08 INFO - PROCESS | 16100 | [#4] audio-oscillator Cycles:10 Average:104.00 Median:92.00 stddev:19.38 (21.1%) stddev-sans-first:20.06 15:30:08 INFO - PROCESS | 16100 | Values: 92.0 93.0 144.0 93.0 92.0 93.0 125.0 92.0 92.0 124.0 15:30:08 INFO - PROCESS | 16100 | 15:30:08 INFO - PROCESS | 16100 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 15:30:08 INFO - PROCESS | 16100 | Values: 117.0 117.0 117.0 117.0 116.0 116.0 117.0 116.0 116.0 117.0 15:30:08 INFO - PROCESS | 16100 | 15:30:08 INFO - PROCESS | 16100 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.50 stddev:0.92 (0.6%) stddev-sans-first:0.97 15:30:08 INFO - PROCESS | 16100 | Values: 148.0 148.0 148.0 149.0 149.0 149.0 148.0 148.0 149.0 146.0 15:30:08 INFO - PROCESS | 16100 | 15:30:08 INFO - PROCESS | 16100 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 15:30:08 INFO - PROCESS | 16100 | Values: 96.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 96.0 95.0 15:30:08 INFO - PROCESS | 16100 | 15:30:08 INFO - PROCESS | 16100 | [#8] json-parse-financial Cycles:10 Average:69.50 Median:64.00 stddev:16.73 (26.1%) stddev-sans-first:17.62 15:30:08 INFO - PROCESS | 16100 | Values: 64.0 65.0 64.0 64.0 64.0 64.0 67.0 117.0 63.0 63.0 15:30:08 INFO - PROCESS | 16100 | 15:30:08 INFO - PROCESS | 16100 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 15:30:08 INFO - PROCESS | 16100 | Values: 64.0 64.0 65.0 66.0 64.0 64.0 64.0 64.0 64.0 64.0 15:30:08 INFO - PROCESS | 16100 | 15:30:08 INFO - PROCESS | 16100 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:86.00 stddev:3.05 (3.5%) stddev-sans-first:3.00 15:30:08 INFO - PROCESS | 16100 | Values: 88.0 85.0 81.0 81.0 82.0 84.0 88.0 83.0 87.0 89.0 15:30:08 INFO - PROCESS | 16100 | 15:30:08 INFO - PROCESS | 16100 | [#11] stanford-crypto-ccm Cycles:10 Average:145.30 Median:136.50 stddev:34.24 (25.1%) stddev-sans-first:35.98 15:30:08 INFO - PROCESS | 16100 | Values: 132.0 133.0 143.0 129.0 131.0 139.0 131.0 137.0 242.0 136.0 15:30:08 INFO - PROCESS | 16100 | 15:30:08 INFO - PROCESS | 16100 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.30 Median:177.00 stddev:3.13 (1.8%) stddev-sans-first:2.67 15:30:08 INFO - PROCESS | 16100 | Values: 171.0 178.0 181.0 175.0 180.0 176.0 176.0 172.0 177.0 177.0 15:30:08 INFO - PROCESS | 16100 | 15:30:08 INFO - PROCESS | 16100 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.50 stddev:1.55 (2.3%) stddev-sans-first:1.50 15:30:08 INFO - PROCESS | 16100 | Values: 70.0 70.0 68.0 70.0 69.0 68.0 67.0 68.0 66.0 66.0 15:30:08 INFO - PROCESS | 16100 | -------- Summary: end -------- 15:30:08 INFO - PROCESS | 16100 | 15:30:09 INFO - TEST-INFO | 16100: exit 0 15:30:09 INFO - TEST-OK | kraken | took 65579ms 15:30:09 INFO - SUITE-END | took 1184s 15:30:09 INFO - Completed test suite (00:19:44) 15:30:09 INFO - javascript benchmark 15:30:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2639.973600263997, 2661.1484325015977, 2683.101161111027, 2698.7840972722183, 2703.189043287013, 4534.750588717619, 4586.3579098926175, 4660.883477913049, 4705.858824235274, 4764.666473346867, 4761.0, 4764.928526072112, 4834.564889159975, 4842.878928026801, 4905.141600219965, 4299.5485474025245, 4345.500267469242, 4425.7565833879125, 4474.932876006863, 4524.97737511312, 4462.665300102489, 4481.0813783174535, 4504.279315309551, 4504.797284122223, 4518.367428559988, 4188.28799104153, 4235.216484950263, 4307.612314891675, 4357.716748411343, 4407.493138289105, 4310.719803212781, 4318.179545886272, 4327.978360108211, 4405.383246345515, 4454.354118652777, 4339.088791353788, 4342.782860856944, 4350.195213885409, 4356.695031347807, 4401.977990110061, 4423.601875831158, 4603.401557797499, 4607.10161518504, 4619.538046195387, 4680.531946805327, 5149.665271757362, 5153.149730294497, 5170.896582068375, 5173.0, 5176.767045482925, 5115.0, 5144.43411224765, 5149.588032957355, 5182.455842136596, 5184.170532714786, 4566.0, 4772.5227477252, 4812.51874812523, 4857.878553036202, 4860.1008813368935, 5257.6845389276, 5258.8948221036135, 5289.418164001957, 5301.761420736076, 5311.707856067954, 5053.747312634354, 5072.416672082684, 5075.796968121308, 5100.030994111107, 5103.744812759347, 4856.417229932431, 4955.677880937727, 5027.1956486962645, 5034.89930201394, 5068.949310506848, 4976.751162441863, 4995.9500404996215, 4998.375203099613, 5003.174476211457, 5063.11395505785, 4930.901381972412, 4931.5561599455505, 4932.284818701268, 4976.303317535548, 4997.600191984632, 4130.359794231899, 4164.875053748392, 4239.40648309237, 4322.459692538433, 4329.480462344476, 3746.7377283589885, 3767.773933563995, 3779.3008293465246, 3786.3563194257044, 3809.5238095238096, 4315.784210789448, 4326.935095973563, 4331.436913201263, 4380.3210502372185, 4381.474223093249, 4923.926141107886, 4973.42805577356, 5007.84976450707, 5019.447860735316, 5044.1929291313945, 4292.678049146327, 4298.785060747013, 4299.806508707115, 4304.720193187432, 4323.156984388077, 4429.53489883564, 4565.474970378383, 4565.840195593139, 4570.040291538748, 4604.848787803049, 4750.714957102585, 4802.951970480251, 4806.519348065165, 4825.227963525819, 4826.203676393497, 5092.312537807348, 5128.769205385692, 5130.0, 5141.794328226829, 5184.0, 4624.16764982293, 4750.881227969328, 4809.711417314972, 4814.350062741625, 4867.269909513601, 4974.7512624369365, 5011.674241174312, 5020.673656212481, 5082.491750824888, 5083.0, 5073.644844860824, 5091.949080509147, 5112.693238405707, 5115.0, 5165.690058596496, 4802.327674125695, 4932.4081110267, 4940.962397896482, 4958.76030992252, 4958.8760280993265, 4925.064237794808, 4949.876253093701, 4952.257161425815, 4965.8013679452415, 4997.750112494288, 4872.317875497362, 4891.241857512091, 4941.876453088702, 4946.579540739078, 4950.801967921243, 4813.446453657734, 4852.733099679552, 4905.190643543775, 5009.799608015638, 5018.874528136826, 4800.66395352336, 4817.349657796152, 4827.324174615627, 4859.149648811514, 4865.343178670834], "value": 4656.166202701335, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.4147145497227, 599.5563283170454, 603.7826382502301, 607.6141650052218, 609.4240942309519, 41755.37366939498, 42186.15627687444, 43088.13823723524, 43144.0, 43161.568384316146, 41824.0, 42218.0, 42290.57709422905, 42325.576744232545, 42444.0, 7450.105987281534, 7616.0, 7907.999999999985, 8049.637766300501, 10186.28695991281, 9839.311248212627, 10145.188384929188, 10150.13723833475, 10162.339447935861, 10165.898341016606, 10183.134433573117, 10226.795464090714, 10227.130693891027, 10236.129928956048, 10237.539310731036, 10071.093601575856, 10123.0, 10133.189344852393, 10134.54394552247, 10138.746531336701, 10047.447390393525, 10094.89905100947, 10126.29115961883, 10129.746756331077, 10130.0, 38862.61137388618, 39015.0, 39303.0, 39324.21351572981, 39403.8029809852, 3233.708966193054, 3426.194844211608, 3518.384282750534, 3604.5854726706502, 3843.3658446356317, 32512.67487325144, 33252.50121248183, 33458.66541334604, 33480.330393392236, 33490.1627459313, 3195.6964088411796, 3268.2809781847955, 3291.391092647844, 3412.283420481702, 3414.897553073412, 246459.0, 248070.0, 248790.0, 248911.0, 249315.0, 58271.0, 58401.415985840446, 58517.0, 58618.0, 58889.0, 61574.0, 61698.0, 61973.0, 62072.68963655153, 62080.0, 15095.622609434851, 15349.462768803038, 15349.846501535065, 15354.692906142038, 15369.1546964918, 11392.43037848121, 11442.713932151597, 11445.08439324852, 11458.369789661481, 11478.139139564566, 18339.57799250646, 19252.518687032654, 19354.806451935583, 19453.51366215856, 19507.317243896396, 6765.221999470124, 6874.450043996469, 6899.586024838526, 6940.236573976858, 7288.727294520757, 871.9389642725075, 946.2146418472789, 948.83869742144, 1008.8587597736323, 1020.5101551255439, 28058.2985425366, 29156.562651560245, 29294.853525732236, 29506.362746469043, 29706.25734356615, 990.782027953849, 1003.9146672532917, 1012.4330374990029, 1042.0881728487573, 1073.5866691323897, 15181.544553663407, 15547.30037148331, 15680.372785088468, 15757.290921908541, 15850.0, 393116.0, 394029.0, 394543.0, 399190.012149818, 400042.0, 50540.74729626402, 51078.0, 51185.744071279405, 51241.7437912808, 51262.48737512652, 1217.8843009914044, 1256.1534544219983, 1256.7109564800148, 1260.848698156227, 1262.1543565810928, 27663.308417288925, 28373.43253134967, 28561.322047240137, 28774.280642984093, 28802.711972880003, 44257.0, 44534.331985019606, 44588.777056114515, 44600.33099503575, 44668.77665611651, 330563.0, 331421.0, 332501.0, 334119.0, 334215.0, 25748.356291092874, 26022.60966085548, 26567.0, 26647.86676066607, 26656.60015099736, 42801.785991069846, 43677.78161109174, 43869.34195986999, 44193.0, 44240.55759442493, 37159.0, 37488.25023499569, 37537.2492550153, 37664.81167594254, 38394.23211535698, 37428.62571374251, 37716.0, 37742.0, 37966.62033379631, 38015.429768554044, 36001.63998359983, 36587.08532286714, 37370.43944340783, 37603.435948461345, 37608.43587346137, 31586.842065789522, 33378.15210056693, 33382.49926251157, 33794.49308260427, 33819.0, 26027.609585855847, 26037.95848166052, 26161.869190653924, 26227.475450491263, 26389.34026649349], "value": 18808.211563267992, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.8674303764569, 381.2755764048308, 389.79340949296864, 390.20203683467315, 403.24995508354453, 12860.678483037917, 13917.582472525828, 17880.463586092406, 17895.73156402655, 17898.73151902721, 16566.585835354123, 17111.91444042778, 17351.91324043378, 17616.414522692987, 17641.91179044103, 5200.141976573861, 5262.342207224097, 5347.171188465794, 5401.162819762943, 5404.540614047811, 3762.1159027628487, 3970.583088775666, 5294.841154765344, 5459.508644222019, 6026.819195424145, 6069.57512974092, 6103.328633850273, 6108.725107370156, 6219.9689001554925, 6245.406686364788, 6048.848778780522, 6081.331053584102, 6184.876302473948, 6228.844278893064, 6233.2208473940755, 3359.7816141950693, 3564.928701425983, 5091.592672586185, 5423.132298832207, 5434.64674796137, 21265.0, 21494.677579836316, 21653.45866353338, 21730.348089557338, 21778.34664960054, 1823.2069049963309, 2084.7289852319254, 2097.8741275523516, 2129.0100103451814, 2228.5320082782637, 9444.716658500256, 9728.367656102331, 9758.170555502791, 9967.252456065751, 12615.558455454107, 1793.9820601793945, 1804.0889350877853, 1805.5034865412117, 1825.9634807303912, 1872.6535590915723, 65223.3477665222, 68828.0, 68927.31072689309, 69266.30733692649, 71226.28773712249, 8362.414630975894, 8901.55492225399, 9005.819883602291, 9484.525773711286, 10374.0, 12621.116521843567, 12661.810072848915, 12693.49226030967, 12727.363631818373, 12745.681357966125, 6985.196702379291, 7076.716931322792, 7089.291070892869, 7149.785506434815, 7265.200827908926, 6798.252192258848, 6836.965815170893, 6946.895796563055, 6952.617606031616, 6967.233604303523, 3879.262940041383, 3965.147493288957, 3972.960270397259, 4014.1570270243574, 4037.212743515045, 1854.0, 1861.678208471973, 1863.9440816775518, 1897.3643829317057, 1913.7799153097571, 823.5717426938079, 909.8589718593629, 940.2994768897215, 953.1612181280428, 973.9026097390346, 16360.181990900408, 16957.321707131825, 17375.131243437776, 17512.91243543774, 17869.642607148045, 878.2271600991087, 912.0378001208655, 924.4869097650734, 931.6180366049887, 991.4794732765212, 9112.772180695403, 9596.90403095974, 9607.13535781769, 9663.420194788336, 9826.263030272758, 285977.0, 291382.0, 389318.0, 393252.0, 402273.0, 78596.60701696569, 81448.59275703583, 82388.0, 83958.0, 84710.15289847145, 946.3564775952281, 961.3270710502676, 985.8619793228954, 993.4089216915924, 997.4364484066624, 15691.293891775125, 15830.548486222204, 15955.60110997188, 16129.0, 16453.42413015539, 35781.0, 36012.0, 36184.81907590445, 36351.454728179626, 36586.26827463489, 48187.277190841465, 49589.75205123951, 49680.75159624179, 50012.0, 50305.24542131798, 7797.805054873674, 7998.280154786097, 8011.919880801117, 8073.919260807317, 8149.959250203711, 8766.386352955233, 11445.48495317696, 12024.639260822189, 12201.0, 12377.0, 9502.762430939005, 10265.0, 10473.31923424975, 10595.682129536126, 10636.09593184557, 9676.274279429212, 10483.318584291997, 10575.788484230427, 10621.150307975498, 10757.193210509087, 10573.89426105729, 10770.353778772986, 10880.292780969212, 11052.613158539412, 11132.666020019413, 7847.9607601961625, 7937.404694647809, 7978.880316795136, 8023.237792409712, 8081.919180808117, 8320.16798320163, 10194.235432342455, 10318.380897146195, 10718.464076795974, 11034.282771619819], "value": 8289.821484532293, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1291.3672300572723, 1441.6035590212691, 1465.4797546870861, 1584.413766906244, 1776.2983621469511, 6896.4138048265895, 7228.530145540542, 7262.382697470708, 7405.185429602753, 7405.962970185142, 7254.274572542743, 7393.778186654409, 7443.478956473035, 7460.738874139406, 7462.9924960130365, 1880.3512788088087, 1927.6144771045776, 1949.9415017549495, 2131.914723411062, 2192.8245740340813, 2175.282156888231, 2254.3237028891267, 2257.006916956534, 2274.3063365673547, 2283.5547068321684, 2208.536207396449, 2221.544583360407, 2237.4965632732587, 2239.8656080635214, 2244.0574958517464, 1851.1947302923272, 2167.1439781286463, 2195.1000089963118, 2232.285668586053, 2236.4856083100894, 2220.7224096987875, 2254.864708117502, 2257.932262032142, 2258.841881068326, 2259.35608351619, 7330.083739532559, 7390.076240469942, 7400.888986665204, 7402.888956665654, 7408.333250007471, 4525.162844873709, 4650.162970665279, 4650.25595904657, 4657.7903994319995, 4658.231391820345, 2910.359720861407, 3034.544818277254, 3072.4316001539787, 3083.892063777757, 3088.8146711197173, 955.6273053509137, 986.4722373530127, 996.227923359395, 1001.2140469731225, 1006.9144122749575, 9847.310688251826, 9866.605335786631, 9885.110340069428, 9900.702978910644, 9910.306278560503, 4219.9789001055415, 4239.830406783694, 4318.676099292566, 4359.149965756647, 4371.650267978554, 8599.226069653636, 8640.913590864136, 8641.567921603895, 8647.956760216159, 8662.566871656392, 4439.223135951195, 4483.484399294058, 4516.548345165457, 4522.3668686383935, 4529.38853254813, 3608.45873119029, 3959.3467077932396, 4013.0, 4130.463039804867, 4227.0489139943265, 3618.2944325856206, 3659.652333028358, 3735.1782607826235, 3739.1586892949413, 3759.473673685686, 1199.232491205629, 1212.6907638552113, 1216.4586758892208, 1218.415160722858, 1223.9510419583296, 804.6459557794552, 848.5248260973874, 885.7874110213502, 907.9591418386188, 928.8003079337975, 4953.653244272867, 5074.391073071255, 5290.100682883919, 5342.8664283392445, 5423.566114710814, 857.1385757313859, 861.4056301152185, 870.9477431354139, 889.8086911314099, 946.8816397950256, 3489.3021395720957, 3523.788572685647, 3562.287542491512, 3574.1243395367783, 3636.054625797312, 8906.064863189402, 9110.954445227731, 9254.629814807467, 9397.859032114524, 9401.811963760823, 8985.550722463851, 9111.589978450986, 9142.0, 9210.217131543894, 9227.492487913229, 6721.361470660279, 6725.125733654593, 6789.626570538569, 6866.931330686729, 6993.720251189896, 5018.1218286800395, 5080.314157588826, 5103.3110530077965, 5139.0, 5211.791528338824, 8370.66517339324, 8413.200745929127, 8423.831523369621, 8571.61427735766, 8634.352423568133, 8459.492430454193, 8670.609822557873, 8671.089535598923, 8713.433626814236, 8849.469031858109, 5520.585956053393, 5664.915026274527, 5811.622244554091, 6002.639841609517, 6185.257769067741, 6992.615406152507, 6992.860142797217, 7028.472864535078, 7038.436925045881, 7060.293970603104, 6142.201513803177, 6238.937610623836, 6261.405166509175, 6430.485561155003, 6440.227172739301, 6192.969035154795, 6199.938000619936, 6243.750249989949, 6281.4660753834605, 6351.142595749515, 5864.06175011996, 5920.644761314163, 5923.229980102559, 5951.880962380815, 5957.195778570011, 4370.562943705604, 4380.737155770664, 4455.821767129408, 4470.588235294118, 4502.302143167814, 4375.868723938287, 4401.053773438726, 4426.82292708301, 4467.463904331501, 4482.0], "value": 4044.2278891098463, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.65043874325164, 315.78053252989173, 319.5558174137948, 326.1601376455627, 326.38802245789145, 4645.767711614414, 4826.613870890329, 4890.413150421946, 4909.63177761668, 4921.581665558428, 4658.928446457317, 4730.0303437795255, 4757.405324334458, 4768.402585133984, 4825.372701548802, 3849.1724279279947, 3853.807309634521, 3862.8454861805494, 3863.420486926955, 3864.671502922241, 3664.662398224642, 3737.9252414951684, 3837.5970523095093, 3877.1664092220167, 3879.7866117363533, 3808.485854409661, 3817.866374676887, 3822.789746563938, 3825.9808700956596, 3831.7892515911612, 3776.9055773605605, 3794.5636251831115, 3809.5999920008553, 3823.8279277432584, 3844.0774214188395, 3421.349943510725, 3423.4864770284407, 3451.913702157441, 3455.1362159460136, 3457.1529975155995, 4549.795259213311, 4587.8623641290815, 4616.8153273869, 4624.606908412789, 4658.953410465886, 4326.156399502099, 4337.414449049401, 4345.023014528382, 4368.104538569617, 4378.255696531597, 5015.0, 5037.219231019161, 5038.193888977746, 5044.54599086084, 5056.418511871145, 3606.1886075633033, 3731.0485826114436, 3753.8498460061564, 3762.6049264827348, 3763.397856342972, 5211.661242019257, 5243.0, 5253.0, 5271.789128434858, 5306.999999999962, 3825.464434979105, 3834.1948190880225, 3845.6346647068485, 3886.261610294035, 3897.0841852164717, 3599.46008098782, 3894.6689531389584, 3904.06302487401, 3908.0069164726197, 3911.9804400977814, 4241.300185469425, 4252.362145678111, 4298.161858437637, 4302.892427689333, 4305.612494875476, 5038.2190760432195, 5049.081349087323, 5054.4692807254705, 5062.443131255559, 5068.189089745697, 1213.883227430748, 1238.2756087688804, 1252.5240408644838, 1260.449646934276, 1266.512392728806, 860.3246451535515, 865.4504389712578, 882.8146089321186, 884.5709830732089, 894.4856707393275, 4261.680373971964, 4299.1831552005015, 4312.870613881589, 4323.783810809447, 4336.457942757155, 5047.16721740916, 5060.49395060491, 5064.164412871834, 5065.772040258197, 5067.974660126676, 4235.407043013981, 4279.443672322641, 4290.89272768177, 4333.8699839004885, 4341.240282950471, 2537.0486067724605, 2667.1465131157843, 2675.5719084946313, 2677.3708178578017, 2686.1135825177644, 4739.95260047402, 4778.546038126373, 4784.521547845257, 4787.40157480315, 4824.565789079, 5174.508421699932, 5175.767090480937, 5180.937907728907, 5192.338451695497, 5196.168613021899, 4705.247160454379, 5015.648904576645, 5020.824271150492, 5028.924566131438, 5036.949630503721, 5136.434992150786, 5228.660137091077, 5252.632315738015, 5254.343207099113, 5273.156294992783, 4940.407151141886, 5177.171652535576, 5192.870178245574, 5221.43356992893, 5230.398504172069, 4926.8768280793265, 4974.303597496281, 4975.328330675457, 4979.800807967641, 4993.375828021497, 3677.7793332400142, 3709.2396058808417, 3710.666040056408, 3755.8309876055096, 3761.3417651911354, 4914.778834952364, 5310.575153987749, 5320.920186197288, 5325.414204437431, 5327.334083239595, 4416.447944006999, 5081.611642528006, 5105.642605017613, 5125.180560900826, 5128.333316668958, 5060.49395060491, 5073.7716802743225, 5082.2122571001555, 5100.132977393778, 5114.181730923035, 4951.628627852998, 4983.177775666974, 5005.149124648746, 5051.419086805065, 5069.2902993581665, 4887.242477416006, 5152.639315247897, 5157.896842063213, 5200.6879587224885, 5207.973960130175, 5033.748312584429, 5034.798608055637, 5066.138756411346, 5094.490550944876, 5095.949040509548], "value": 3828.9211011527827, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.2328240271319, 754.1402800807077, 797.2386371015681, 815.388458656008, 825.380964276792, 11042.613508527204, 11625.128115391348, 11647.068234541237, 11664.41677916104, 11697.766044679101, 11085.722856928582, 11883.227590206652, 11916.702082447942, 11965.820512692295, 12050.698732531691, 860.578316624854, 866.2550206822159, 870.695256660167, 874.0822136756381, 874.7288340614398, 875.1511034296722, 879.5734068976541, 880.1110878013221, 880.423322723617, 880.7445840706188, 916.6974898283584, 916.9083091690844, 918.5774543709902, 919.3748251189222, 920.6777627830273, 901.4230892228978, 912.2063804490103, 912.543728135932, 913.1644545241096, 914.5884352041608, 672.2504407585556, 674.0125715826289, 674.5649056358621, 674.6862708840364, 674.7132468700783, 10204.336718113298, 10216.438095904723, 10225.64210252645, 10241.897581024243, 10280.94859525705, 9828.754281142958, 10040.89959100407, 10438.0, 10658.946705266502, 10846.511906964206, 9193.126652967958, 9235.076492350778, 9339.766505837408, 9350.29872759539, 9627.3260871739, 3179.284660951291, 3184.9363012739846, 3187.0279564732746, 3212.791168574035, 3383.5263063171174, 33416.16459588506, 35109.64890351089, 35212.56885453049, 36226.0, 41123.588764112275, 8475.0, 8536.957315213509, 8749.16882896124, 9420.293477989178, 10205.0, 17092.316307347817, 17096.57258568546, 17113.657726845395, 17134.314627414762, 17231.3969011084, 5023.49765023502, 6078.696065196723, 6739.286866330899, 6781.050652908597, 6786.966065169642, 3266.477363621809, 3320.9833950830093, 3512.8243587820507, 3578.8031658258524, 3666.5416822897137, 2818.3799564095866, 2940.955885661674, 2943.9852800735857, 2944.2344990302677, 2946.130891387046, 512.2751306900768, 522.1593234891822, 525.3328273093226, 529.8887233680894, 535.6973310079793, 503.6172508893267, 623.8003838771549, 624.1168746224133, 626.5739297277895, 636.4144986612328, 7276.56340619554, 7292.562446253136, 7584.658690358947, 7629.694812207561, 7721.112072111667, 519.5843325339713, 578.8581797459649, 628.1582679209881, 634.1249076274711, 634.7587916591666, 3401.6035564023355, 3529.3294274087843, 3609.6029436761937, 3616.5840928293583, 3628.0, 50064.24903626448, 50948.235776463385, 53123.73438132785, 53186.0, 53574.73212633912, 45203.77398112988, 46082.76958615185, 46350.0, 46920.0, 46971.53028469672, 42232.788836055624, 42373.0, 42392.99999999938, 42466.78766606147, 42531.57468425276, 6820.283870193558, 6914.204866440424, 6919.688614012281, 7050.153981522045, 7070.505064645426, 27587.44825103527, 28268.43463130767, 28286.0, 28576.42847143087, 28580.714192857806, 34588.481172781925, 34980.82509587436, 36097.0, 36354.0, 37330.0, 9852.359596626196, 10119.848202277119, 10314.948425257826, 10395.32430392022, 10436.37381757097, 11378.54485820558, 11597.362145082101, 11946.223495473114, 12019.75960480768, 12318.076144289034, 10292.125169360688, 10364.740881478023, 11099.223054386439, 11159.442027898735, 11293.153013524183, 10577.682669519927, 10693.839592406275, 10711.464426778786, 10790.0, 10816.242862999514, 10728.356298622108, 10739.516721747385, 11188.66434006981, 11305.0, 11384.032357249394, 9196.26429885621, 9359.625614975324, 9389.436633801994, 9474.52627368615, 9652.75868103303, 9261.0, 9455.920717188734, 9472.194863436685, 9587.952060239933, 9809.215262778818], "value": 5782.064464107076, "unit": "score"}], "name": "dromaeo_css", "value": 6341.056757107382, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 111.0, 114.0, 114.0, 113.0, 113.0, 114.0, 114.0, 115.0, 113.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 134.0, 159.0, 218.0, 131.0, 163.0, 164.0, 131.0, 193.0, 131.0], "value": 157.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 161.0, 163.0, 162.0, 160.0, 161.0, 163.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 156.0, 79.0, 77.0, 77.0, 76.0, 129.0, 76.0], "value": 89.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 144.0, 93.0, 92.0, 93.0, 125.0, 92.0, 92.0, 124.0], "value": 104.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 149.0, 149.0, 149.0, 148.0, 148.0, 149.0, 146.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 64.0, 64.0, 67.0, 117.0, 63.0, 63.0], "value": 69.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 66.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0], "value": 64.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 81.0, 81.0, 82.0, 84.0, 88.0, 83.0, 87.0, 89.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 133.0, 143.0, 129.0, 131.0, 139.0, 131.0, 137.0, 242.0, 136.0], "value": 145.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 178.0, 181.0, 175.0, 180.0, 176.0, 176.0, 172.0, 177.0, 177.0], "value": 176.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 68.0, 70.0, 69.0, 68.0, 67.0, 68.0, 66.0, 66.0], "value": 68.2, "unit": "score"}], "name": "kraken", "value": 1594.6999999999998, "alertThreshold": 2.0}]} 15:30:09 INFO - Return code: 0 15:30:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:30:09 ERROR - # TBPL SUCCESS # 15:30:09 INFO - Running post-action listener: _resource_record_post_action 15:30:09 INFO - ##### 15:30:09 INFO - ##### Finished run-tests step (success) 15:30:09 INFO - ##### 15:30:09 INFO - Running post-run listener: _resource_record_post_run 15:30:10 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 528801792; Read time: 24; Write time: 562832 15:30:10 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 234737664; Read time: 0; Write time: 293508 15:30:10 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293838848; Read time: 24; Write time: 269324 15:30:10 INFO - Running post-run listener: _upload_blobber_files 15:30:10 INFO - Blob upload gear active. 15:30:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:30:10 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 15:30:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:30:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:30:10 INFO - (blobuploader) - INFO - Open directory for files ... 15:30:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:30:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:30:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:30:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:30:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:30:11 INFO - (blobuploader) - INFO - Done attempting. 15:30:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:30:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:30:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:30:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:30:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:30:12 INFO - (blobuploader) - INFO - Done attempting. 15:30:12 INFO - (blobuploader) - INFO - Iteration through files over. 15:30:12 INFO - Return code: 0 15:30:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:30:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:30:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/00ff3e01c3d0b5b84fa9bfe0cf8f84a68faeb1a83c39b63b4145e3fc6cfd345cbe90bf145b838f1da37449f37d1162d73432634a1d3e34ad0fba0f3099b62b64", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a99202d91dbb638ef7b38eef60c5e608efd1350b7a5c979503ea68ebd595ab0861808219cd6e89cbba711210b5e8f8c898eb827513418a6db8d9db03db21cf53"} 15:30:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:30:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:30:12 INFO - Contents: 15:30:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/00ff3e01c3d0b5b84fa9bfe0cf8f84a68faeb1a83c39b63b4145e3fc6cfd345cbe90bf145b838f1da37449f37d1162d73432634a1d3e34ad0fba0f3099b62b64", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a99202d91dbb638ef7b38eef60c5e608efd1350b7a5c979503ea68ebd595ab0861808219cd6e89cbba711210b5e8f8c898eb827513418a6db8d9db03db21cf53"} 15:30:12 INFO - Running post-run listener: copy_logs_to_upload_dir 15:30:12 INFO - Copying logs to upload dir... 15:30:12 INFO - mkdir: /builds/slave/test/build/upload/logs 15:30:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.475363 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-09 15:30:12.281862) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 15:30:12.285132) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1462831765.376647-466763386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/00ff3e01c3d0b5b84fa9bfe0cf8f84a68faeb1a83c39b63b4145e3fc6cfd345cbe90bf145b838f1da37449f37d1162d73432634a1d3e34ad0fba0f3099b62b64", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a99202d91dbb638ef7b38eef60c5e608efd1350b7a5c979503ea68ebd595ab0861808219cd6e89cbba711210b5e8f8c898eb827513418a6db8d9db03db21cf53"} build_url:https://queue.taskcluster.net/v1/task/QJLTcO3KSSGKSS4195Pvsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011329 build_url: 'https://queue.taskcluster.net/v1/task/QJLTcO3KSSGKSS4195Pvsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/00ff3e01c3d0b5b84fa9bfe0cf8f84a68faeb1a83c39b63b4145e3fc6cfd345cbe90bf145b838f1da37449f37d1162d73432634a1d3e34ad0fba0f3099b62b64", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a99202d91dbb638ef7b38eef60c5e608efd1350b7a5c979503ea68ebd595ab0861808219cd6e89cbba711210b5e8f8c898eb827513418a6db8d9db03db21cf53"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 15:30:12.309761) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 15:30:12.310073) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1462831765.376647-466763386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004444 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 15:30:12.393701) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 15:30:12.394019) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 15:30:12.394326) ========= ========= Total master_lag: 0.14 =========