builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-025 starttime: 1462476939.52 results: success (0) buildid: 20160505113838 builduid: 713a8300805c4987a4d32ce6c53ae583 revision: 7189e5f1105bb41782187b9876bbcc625f4208d8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 12:35:39.518374) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 12:35:39.518841) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 12:35:39.519122) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 12:35:39.550861) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 12:35:39.551225) ========= 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=232498196343f89f466a4a9a000001c8-1462474417.984151-1032471659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-05 12:35:40-- 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% 42.9M=0s 2016-05-05 12:35:40 (42.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.176984 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 12:35:39.745482) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 12:35:39.748887) ========= 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=232498196343f89f466a4a9a000001c8-1462474417.984151-1032471659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019737 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 12:35:39.798027) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 12:35:39.798362) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7189e5f1105bb41782187b9876bbcc625f4208d8 --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 7189e5f1105bb41782187b9876bbcc625f4208d8 --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=232498196343f89f466a4a9a000001c8-1462474417.984151-1032471659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-05 12:35:40,648 truncating revision to first 12 chars 2016-05-05 12:35:40,648 Setting DEBUG logging. 2016-05-05 12:35:40,648 attempt 1/10 2016-05-05 12:35:40,649 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7189e5f1105b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-05 12:35:40,991 unpacking tar archive at: fx-team-7189e5f1105b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.628952 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 12:35:40.440002) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 12:35:40.440304) ========= script_repo_revision: 7189e5f1105bb41782187b9876bbcc625f4208d8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 12:35:40.440746) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 12:35:40.441006) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 12:35:40.450662) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-05 12:35:40.451056) ========= /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=232498196343f89f466a4a9a000001c8-1462474417.984151-1032471659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:35:41 INFO - MultiFileLogger online at 20160505 12:35:41 in /builds/slave/test 12:35:41 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 12:35:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:35:41 INFO - {'append_to_log': False, 12:35:41 INFO - 'base_work_dir': '/builds/slave/test', 12:35:41 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:35:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:35:41 INFO - 'branch': 'Fx-Team-Non-PGO', 12:35:41 INFO - 'buildbot_json_path': 'buildprops.json', 12:35:41 INFO - 'config_files': ('talos/linux_config.py',), 12:35:41 INFO - 'default_actions': ('clobber', 12:35:41 INFO - 'read-buildbot-config', 12:35:41 INFO - 'download-and-extract', 12:35:41 INFO - 'populate-webroot', 12:35:41 INFO - 'create-virtualenv', 12:35:41 INFO - 'install', 12:35:41 INFO - 'run-tests'), 12:35:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:35:41 INFO - 'download_minidump_stackwalk': True, 12:35:41 INFO - 'download_symbols': 'ondemand', 12:35:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:35:41 INFO - 'tooltool.py': '/tools/tooltool.py', 12:35:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:35:41 INFO - '/tools/misc-python/virtualenv.py')}, 12:35:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:35:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:35:41 INFO - 'installer_path': 'installer.exe', 12:35:41 INFO - 'log_level': 'info', 12:35:41 INFO - 'log_name': 'talos', 12:35:41 INFO - 'log_to_console': True, 12:35:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:35:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:35:41 INFO - 'opt_config_files': (), 12:35:41 INFO - 'pip_index': False, 12:35:41 INFO - 'sps_profile': False, 12:35:41 INFO - 'sps_profile_interval': 0, 12:35:41 INFO - 'suite': 'dromaeojs', 12:35:41 INFO - 'system_bits': '32', 12:35:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:35:41 INFO - 'title': 'talos-linux64-ix-025', 12:35:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:35:41 INFO - 'use_talos_json': True, 12:35:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:35:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:35:41 INFO - 'work_dir': 'build'} 12:35:41 INFO - ##### 12:35:41 INFO - ##### Running clobber step. 12:35:41 INFO - ##### 12:35:41 INFO - Running pre-action listener: _resource_record_pre_action 12:35:41 INFO - Running main action method: clobber 12:35:41 INFO - rmtree: /builds/slave/test/build 12:35:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:35:41 INFO - Running post-action listener: _resource_record_post_action 12:35:41 INFO - ##### 12:35:41 INFO - ##### Running read-buildbot-config step. 12:35:41 INFO - ##### 12:35:41 INFO - Running pre-action listener: _resource_record_pre_action 12:35:41 INFO - Running main action method: read_buildbot_config 12:35:41 INFO - Using buildbot properties: 12:35:41 INFO - { 12:35:41 INFO - "project": "", 12:35:41 INFO - "product": "firefox", 12:35:41 INFO - "script_repo_revision": "production", 12:35:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:35:41 INFO - "repository": "", 12:35:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 12:35:41 INFO - "buildid": "20160505113838", 12:35:41 INFO - "pgo_build": "False", 12:35:41 INFO - "basedir": "/builds/slave/test", 12:35:41 INFO - "buildnumber": 1728, 12:35:41 INFO - "slavename": "talos-linux64-ix-025", 12:35:41 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:35:41 INFO - "platform": "ubuntu64_hw", 12:35:41 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:35:41 INFO - "branch": "fx-team", 12:35:41 INFO - "repo_path": "integration/fx-team", 12:35:41 INFO - "revision": "7189e5f1105bb41782187b9876bbcc625f4208d8", 12:35:41 INFO - "stage_platform": "linux64", 12:35:41 INFO - "builduid": "713a8300805c4987a4d32ce6c53ae583", 12:35:41 INFO - "slavebuilddir": "test" 12:35:41 INFO - } 12:35:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZZwjP165TSSgEJAQDqUmNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 12:35:41 INFO - Running post-action listener: _resource_record_post_action 12:35:41 INFO - ##### 12:35:41 INFO - ##### Running download-and-extract step. 12:35:41 INFO - ##### 12:35:41 INFO - Running pre-action listener: _resource_record_pre_action 12:35:41 INFO - Running main action method: download_and_extract 12:35:41 INFO - mkdir: /builds/slave/test/build/tests 12:35:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:41 INFO - https://queue.taskcluster.net/v1/task/ZZwjP165TSSgEJAQDqUmNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:35:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZwjP165TSSgEJAQDqUmNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:35:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZwjP165TSSgEJAQDqUmNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:35:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZwjP165TSSgEJAQDqUmNA/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 12:35:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZwjP165TSSgEJAQDqUmNA/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 12:35:44 INFO - Downloaded 1361 bytes. 12:35:44 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:35:44 INFO - Using the following test package requirements: 12:35:44 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 12:35:44 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:35:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:35:44 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:35:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:35:44 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:35:44 INFO - u'jsshell-linux-x86_64.zip'], 12:35:44 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:35:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:35:44 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 12:35:44 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:35:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:35:44 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:35:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:35:44 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:35:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:35:44 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:35:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:35:44 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:35:44 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')]} 12:35:44 INFO - https://queue.taskcluster.net/v1/task/ZZwjP165TSSgEJAQDqUmNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:35:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZwjP165TSSgEJAQDqUmNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:35:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZwjP165TSSgEJAQDqUmNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:35:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZwjP165TSSgEJAQDqUmNA/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 12:35:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZwjP165TSSgEJAQDqUmNA/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 12:35:46 INFO - Downloaded 22307347 bytes. 12:35:46 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'] 12:35:46 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 12:35:47 INFO - Return code: 0 12:35:47 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 12:35:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:47 INFO - https://queue.taskcluster.net/v1/task/ZZwjP165TSSgEJAQDqUmNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:35:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZwjP165TSSgEJAQDqUmNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:35:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZwjP165TSSgEJAQDqUmNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:35:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZwjP165TSSgEJAQDqUmNA/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 12:35:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZwjP165TSSgEJAQDqUmNA/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 12:35:51 INFO - Downloaded 22307347 bytes. 12:35:51 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'] 12:35:51 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 12:35:53 INFO - Return code: 0 12:35:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:53 INFO - https://queue.taskcluster.net/v1/task/ZZwjP165TSSgEJAQDqUmNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:35:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZwjP165TSSgEJAQDqUmNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 12:35:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZwjP165TSSgEJAQDqUmNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 12:35:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZwjP165TSSgEJAQDqUmNA/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 12:35:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZwjP165TSSgEJAQDqUmNA/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 12:35:54 INFO - Downloaded 10840152 bytes. 12:35:54 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'] 12:35:54 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 12:35:54 INFO - Return code: 0 12:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:54 INFO - https://queue.taskcluster.net/v1/task/ZZwjP165TSSgEJAQDqUmNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:35:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZwjP165TSSgEJAQDqUmNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:35:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZwjP165TSSgEJAQDqUmNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:35:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZwjP165TSSgEJAQDqUmNA/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 12:35:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZwjP165TSSgEJAQDqUmNA/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 12:35:56 INFO - Downloaded 54885297 bytes. 12:35:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZZwjP165TSSgEJAQDqUmNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:35:56 INFO - mkdir: /builds/slave/test/properties 12:35:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:35:56 INFO - Writing to file /builds/slave/test/properties/build_url 12:35:56 INFO - Contents: 12:35:56 INFO - build_url:https://queue.taskcluster.net/v1/task/ZZwjP165TSSgEJAQDqUmNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:35:57 INFO - Running post-action listener: _resource_record_post_action 12:35:57 INFO - Running post-action listener: set_extra_try_arguments 12:35:57 INFO - ##### 12:35:57 INFO - ##### Running populate-webroot step. 12:35:57 INFO - ##### 12:35:57 INFO - Running pre-action listener: _resource_record_pre_action 12:35:57 INFO - Running main action method: populate_webroot 12:35:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:35:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:35:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:35:57 INFO - '--tppagecycles', 12:35:57 INFO - '7'], 12:35:57 INFO - 'tests': ['tsvgm']}}, 12:35:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:35:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:35:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:35:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:35:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:35:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:35:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:35:57 INFO - 'talos_options': ['--disable-e10s'], 12:35:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:35:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:35:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:35:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:35:57 INFO - 'talos_options': ['--disable-e10s'], 12:35:57 INFO - 'tests': ['damp', 'tps']}, 12:35:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:35:57 INFO - 'tests': ['damp', 'tps']}, 12:35:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:35:57 INFO - 'tests': ['dromaeo_dom']}, 12:35:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:35:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:35:57 INFO - 'tests': ['a11yr', 12:35:57 INFO - 'ts_paint', 12:35:57 INFO - 'tpaint', 12:35:57 INFO - 'sessionrestore', 12:35:57 INFO - 'sessionrestore_no_auto_restore', 12:35:57 INFO - 'tabpaint']}, 12:35:57 INFO - 'other-e10s': {'tests': ['a11yr', 12:35:57 INFO - 'ts_paint', 12:35:57 INFO - 'tpaint', 12:35:57 INFO - 'sessionrestore', 12:35:57 INFO - 'sessionrestore_no_auto_restore', 12:35:57 INFO - 'tabpaint']}, 12:35:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:35:57 INFO - 'ts_paint', 12:35:57 INFO - 'tpaint', 12:35:57 INFO - 'sessionrestore', 12:35:57 INFO - 'sessionrestore_no_auto_restore', 12:35:57 INFO - 'tabpaint']}, 12:35:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:35:57 INFO - 'ts_paint', 12:35:57 INFO - 'tpaint', 12:35:57 INFO - 'sessionrestore', 12:35:57 INFO - 'sessionrestore_no_auto_restore', 12:35:57 INFO - 'tabpaint']}, 12:35:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:35:57 INFO - 'tests': ['a11yr', 12:35:57 INFO - 'ts_paint', 12:35:57 INFO - 'tpaint', 12:35:57 INFO - 'sessionrestore', 12:35:57 INFO - 'sessionrestore_no_auto_restore', 12:35:57 INFO - 'tabpaint']}, 12:35:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:35:57 INFO - 'tests': ['a11yr', 12:35:57 INFO - 'ts_paint', 12:35:57 INFO - 'tpaint', 12:35:57 INFO - 'sessionrestore', 12:35:57 INFO - 'sessionrestore_no_auto_restore', 12:35:57 INFO - 'tabpaint']}, 12:35:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:35:57 INFO - 'tests': ['tsvgx', 12:35:57 INFO - 'tsvgr_opacity', 12:35:57 INFO - 'tart', 12:35:57 INFO - 'tscrollx', 12:35:57 INFO - 'cart']}, 12:35:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:35:57 INFO - 'tsvgr_opacity', 12:35:57 INFO - 'tart', 12:35:57 INFO - 'tscrollx', 12:35:57 INFO - 'cart']}, 12:35:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:35:57 INFO - 'talos_options': ['--disable-e10s'], 12:35:57 INFO - 'tests': ['tp5o']}, 12:35:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:35:57 INFO - 'tests': ['tp5o']}, 12:35:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:35:57 INFO - 'talos_options': ['--disable-e10s', 12:35:57 INFO - '--xperf_path', 12:35:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:35:57 INFO - 'tests': ['tp5n']}, 12:35:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:35:57 INFO - 'talos_options': ['--xperf_path', 12:35:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:35:57 INFO - 'tests': ['tp5n']}}, 12:35:57 INFO - 'talos.zip': {'path': '', 12:35:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:35:57 INFO - Running post-action listener: _resource_record_post_action 12:35:57 INFO - ##### 12:35:57 INFO - ##### Running create-virtualenv step. 12:35:57 INFO - ##### 12:35:57 INFO - Running pre-action listener: _resource_record_pre_action 12:35:57 INFO - Running main action method: create_virtualenv 12:35:57 INFO - Creating virtualenv /builds/slave/test/build/venv 12:35:57 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 12:35:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:35:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:35:57 INFO - Using real prefix '/usr' 12:35:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:35:57 INFO - Installing distribute.............................................................................................................................................................................................done. 12:35:59 INFO - Installing pip.................done. 12:35:59 INFO - Return code: 0 12:35:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:35:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:59 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 0x7fd9412a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136f410>, '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 0x1370310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13707a0>, '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': '232498196343f89f466a4a9a000001c8-1462474417.984151-1032471659', '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 12:35:59 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 12:35:59 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 12:35:59 INFO - Using env: {'DISPLAY': ':0', 12:35:59 INFO - 'HOME': '/home/cltbld', 12:35:59 INFO - 'LANG': 'en_US.UTF-8', 12:35:59 INFO - 'LANGUAGE': 'en_US:en', 12:35:59 INFO - 'LOGNAME': 'cltbld', 12:35:59 INFO - 'MAIL': '/var/mail/cltbld', 12:35:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:59 INFO - 'MOZ_NO_REMOTE': '1', 12:35:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:59 INFO - 'NO_EM_RESTART': '1', 12:35:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:59 INFO - 'PWD': '/builds/slave/test', 12:35:59 INFO - 'SHELL': '/bin/bash', 12:35:59 INFO - 'SHLVL': '1', 12:35:59 INFO - 'TERM': 'linux', 12:35:59 INFO - 'TMOUT': '86400', 12:35:59 INFO - 'USER': 'cltbld', 12:35:59 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462474417.984151-1032471659', 12:35:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:59 INFO - '_': '/tools/buildbot/bin/python'} 12:36:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:36:00 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 12:36:00 INFO - Cleaning up... 12:36:00 INFO - Return code: 0 12:36:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:36:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:36:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:36:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:00 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 0x7fd9412a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136f410>, '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 0x1370310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13707a0>, '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': '232498196343f89f466a4a9a000001c8-1462474417.984151-1032471659', '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 12:36:00 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 12:36:00 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 12:36:00 INFO - Using env: {'DISPLAY': ':0', 12:36:00 INFO - 'HOME': '/home/cltbld', 12:36:00 INFO - 'LANG': 'en_US.UTF-8', 12:36:00 INFO - 'LANGUAGE': 'en_US:en', 12:36:00 INFO - 'LOGNAME': 'cltbld', 12:36:00 INFO - 'MAIL': '/var/mail/cltbld', 12:36:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:36:00 INFO - 'MOZ_NO_REMOTE': '1', 12:36:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:36:00 INFO - 'NO_EM_RESTART': '1', 12:36:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:36:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:36:00 INFO - 'PWD': '/builds/slave/test', 12:36:00 INFO - 'SHELL': '/bin/bash', 12:36:00 INFO - 'SHLVL': '1', 12:36:00 INFO - 'TERM': 'linux', 12:36:00 INFO - 'TMOUT': '86400', 12:36:00 INFO - 'USER': 'cltbld', 12:36:00 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462474417.984151-1032471659', 12:36:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:36:00 INFO - '_': '/tools/buildbot/bin/python'} 12:36:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:36:00 INFO - Downloading/unpacking psutil>=0.7.1 12:36:00 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 12:36:00 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 12:36:00 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 12:36:00 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 12:36:00 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 12:36:00 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 12:36:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:36:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:36:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:36:02 INFO - Installing collected packages: psutil 12:36:02 INFO - Running setup.py install for psutil 12:36:02 INFO - building 'psutil._psutil_linux' extension 12:36:02 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 12:36:02 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 12:36:02 INFO - building 'psutil._psutil_posix' extension 12:36:02 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 12:36:02 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 12:36:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:36:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:36:02 INFO - Successfully installed psutil 12:36:02 INFO - Cleaning up... 12:36:02 INFO - Return code: 0 12:36:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:36:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:36:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:36:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:36:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:02 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 0x7fd9412a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136f410>, '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 0x1370310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13707a0>, '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': '232498196343f89f466a4a9a000001c8-1462474417.984151-1032471659', '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 12:36:02 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 12:36:02 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 12:36:02 INFO - Using env: {'DISPLAY': ':0', 12:36:02 INFO - 'HOME': '/home/cltbld', 12:36:02 INFO - 'LANG': 'en_US.UTF-8', 12:36:02 INFO - 'LANGUAGE': 'en_US:en', 12:36:02 INFO - 'LOGNAME': 'cltbld', 12:36:02 INFO - 'MAIL': '/var/mail/cltbld', 12:36:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:36:02 INFO - 'MOZ_NO_REMOTE': '1', 12:36:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:36:02 INFO - 'NO_EM_RESTART': '1', 12:36:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:36:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:36:02 INFO - 'PWD': '/builds/slave/test', 12:36:02 INFO - 'SHELL': '/bin/bash', 12:36:02 INFO - 'SHLVL': '1', 12:36:02 INFO - 'TERM': 'linux', 12:36:02 INFO - 'TMOUT': '86400', 12:36:02 INFO - 'USER': 'cltbld', 12:36:02 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462474417.984151-1032471659', 12:36:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:36:02 INFO - '_': '/tools/buildbot/bin/python'} 12:36:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:36:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:36: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 12:36: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 12:36: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 12:36: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 12:36: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 12:36: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 12:36:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:36:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:36:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:36:04 INFO - Installing collected packages: mozsystemmonitor 12:36:04 INFO - Running setup.py install for mozsystemmonitor 12:36:05 INFO - Successfully installed mozsystemmonitor 12:36:05 INFO - Cleaning up... 12:36:05 INFO - Return code: 0 12:36:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:36:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:36:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:36:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd9412a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136f410>, '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 0x1370310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13707a0>, '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': '232498196343f89f466a4a9a000001c8-1462474417.984151-1032471659', '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 12:36:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:36:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:36:05 INFO - Using env: {'DISPLAY': ':0', 12:36:05 INFO - 'HOME': '/home/cltbld', 12:36:05 INFO - 'LANG': 'en_US.UTF-8', 12:36:05 INFO - 'LANGUAGE': 'en_US:en', 12:36:05 INFO - 'LOGNAME': 'cltbld', 12:36:05 INFO - 'MAIL': '/var/mail/cltbld', 12:36:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:36:05 INFO - 'MOZ_NO_REMOTE': '1', 12:36:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:36:05 INFO - 'NO_EM_RESTART': '1', 12:36:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:36:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:36:05 INFO - 'PWD': '/builds/slave/test', 12:36:05 INFO - 'SHELL': '/bin/bash', 12:36:05 INFO - 'SHLVL': '1', 12:36:05 INFO - 'TERM': 'linux', 12:36:05 INFO - 'TMOUT': '86400', 12:36:05 INFO - 'USER': 'cltbld', 12:36:05 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462474417.984151-1032471659', 12:36:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:36:05 INFO - '_': '/tools/buildbot/bin/python'} 12:36:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:36:05 INFO - Downloading/unpacking blobuploader==1.2.4 12:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:36:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:36:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:36:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:36:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:36:07 INFO - Downloading blobuploader-1.2.4.tar.gz 12:36:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:36:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:36: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 12:36: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 12:36: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 12:36: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 12:36: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 12:36: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 12:36:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:36:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:36: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 12:36: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 12:36: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 12:36: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 12:36: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 12:36: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 12:36:07 INFO - Downloading docopt-0.6.1.tar.gz 12:36:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:36:07 INFO - Installing collected packages: blobuploader, requests, docopt 12:36:07 INFO - Running setup.py install for blobuploader 12:36:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:36:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:36:08 INFO - Running setup.py install for requests 12:36:08 INFO - Running setup.py install for docopt 12:36:08 INFO - Successfully installed blobuploader requests docopt 12:36:08 INFO - Cleaning up... 12:36:08 INFO - Return code: 0 12:36:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:36:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:36:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:36:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:36:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:36:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:08 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 0x7fd9412a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136f410>, '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 0x1370310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13707a0>, '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': '232498196343f89f466a4a9a000001c8-1462474417.984151-1032471659', '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 12:36:08 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 12:36:08 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 12:36:08 INFO - Using env: {'DISPLAY': ':0', 12:36:08 INFO - 'HOME': '/home/cltbld', 12:36:08 INFO - 'LANG': 'en_US.UTF-8', 12:36:08 INFO - 'LANGUAGE': 'en_US:en', 12:36:08 INFO - 'LOGNAME': 'cltbld', 12:36:08 INFO - 'MAIL': '/var/mail/cltbld', 12:36:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:36:08 INFO - 'MOZ_NO_REMOTE': '1', 12:36:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:36:08 INFO - 'NO_EM_RESTART': '1', 12:36:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:36:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:36:08 INFO - 'PWD': '/builds/slave/test', 12:36:08 INFO - 'SHELL': '/bin/bash', 12:36:08 INFO - 'SHLVL': '1', 12:36:08 INFO - 'TERM': 'linux', 12:36:08 INFO - 'TMOUT': '86400', 12:36:08 INFO - 'USER': 'cltbld', 12:36:08 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462474417.984151-1032471659', 12:36:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:36:08 INFO - '_': '/tools/buildbot/bin/python'} 12:36:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:36:08 INFO - Running setup.py (path:/tmp/pip-_ctU6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:36:08 INFO - Running setup.py (path:/tmp/pip-rLsFao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:36:08 INFO - Running setup.py (path:/tmp/pip-DWe3Ak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:36:08 INFO - Running setup.py (path:/tmp/pip-M1b6Te-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:36:09 INFO - Running setup.py (path:/tmp/pip-Ck7pxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:36:09 INFO - Running setup.py (path:/tmp/pip-barKyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:36:09 INFO - Running setup.py (path:/tmp/pip-kSRs_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:36:09 INFO - Running setup.py (path:/tmp/pip-pv4Znc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:36:09 INFO - Running setup.py (path:/tmp/pip-Ymz4Hn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:36:09 INFO - Running setup.py (path:/tmp/pip-WuhasZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:36:09 INFO - Running setup.py (path:/tmp/pip-vgVZ9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:36:09 INFO - Running setup.py (path:/tmp/pip-epHS_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:36:09 INFO - Running setup.py (path:/tmp/pip-OYMLJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:36:09 INFO - Running setup.py (path:/tmp/pip-HTU7Hf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:36:09 INFO - Running setup.py (path:/tmp/pip-wmqQJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:36:09 INFO - Running setup.py (path:/tmp/pip-69EY0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:36:09 INFO - Running setup.py (path:/tmp/pip-Auikl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:36:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:36:09 INFO - Running setup.py install for manifestparser 12:36:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:36:10 INFO - Running setup.py install for mozcrash 12:36:10 INFO - Running setup.py install for mozdebug 12:36:10 INFO - Running setup.py install for mozdevice 12:36:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:36:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:36:10 INFO - Running setup.py install for mozfile 12:36:10 INFO - Running setup.py install for mozhttpd 12:36:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:36:10 INFO - Running setup.py install for mozinfo 12:36:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:36:10 INFO - Running setup.py install for mozInstall 12:36:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:36:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:36:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:36:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:36:10 INFO - Running setup.py install for mozleak 12:36:10 INFO - Running setup.py install for mozlog 12:36:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:36:10 INFO - Running setup.py install for moznetwork 12:36:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:36:11 INFO - Running setup.py install for mozprocess 12:36:11 INFO - Running setup.py install for mozprofile 12:36:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:36:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:36:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:36:11 INFO - Running setup.py install for mozrunner 12:36:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:36:11 INFO - Running setup.py install for mozscreenshot 12:36:11 INFO - Running setup.py install for moztest 12:36:11 INFO - Running setup.py install for mozversion 12:36:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:36:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:36:11 INFO - Cleaning up... 12:36:11 INFO - Return code: 0 12:36:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:36:11 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')]} 12:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:36:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:11 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')]} 12:36:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:36:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:11 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 0x7fd9412a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136f410>, '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 0x1370310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13707a0>, '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': '232498196343f89f466a4a9a000001c8-1462474417.984151-1032471659', '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 12:36:11 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 12:36:11 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 12:36:11 INFO - Using env: {'DISPLAY': ':0', 12:36:11 INFO - 'HOME': '/home/cltbld', 12:36:11 INFO - 'LANG': 'en_US.UTF-8', 12:36:11 INFO - 'LANGUAGE': 'en_US:en', 12:36:11 INFO - 'LOGNAME': 'cltbld', 12:36:11 INFO - 'MAIL': '/var/mail/cltbld', 12:36:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:36:11 INFO - 'MOZ_NO_REMOTE': '1', 12:36:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:36:11 INFO - 'NO_EM_RESTART': '1', 12:36:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:36:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:36:11 INFO - 'PWD': '/builds/slave/test', 12:36:11 INFO - 'SHELL': '/bin/bash', 12:36:11 INFO - 'SHLVL': '1', 12:36:11 INFO - 'TERM': 'linux', 12:36:11 INFO - 'TMOUT': '86400', 12:36:11 INFO - 'USER': 'cltbld', 12:36:11 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462474417.984151-1032471659', 12:36:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:36:11 INFO - '_': '/tools/buildbot/bin/python'} 12:36:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:36:11 INFO - Running setup.py (path:/tmp/pip-XipHJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:36:12 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)) 12:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:36:12 INFO - Running setup.py (path:/tmp/pip-PPC1fC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:36:12 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)) 12:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:36:12 INFO - Running setup.py (path:/tmp/pip-ln793e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:36:12 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)) 12:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:36:12 INFO - Running setup.py (path:/tmp/pip-zK2fAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:36:12 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)) 12:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:36:12 INFO - Running setup.py (path:/tmp/pip-oWo4zV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:36:12 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)) 12:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:36:12 INFO - Running setup.py (path:/tmp/pip-IGkJ4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:36:12 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)) 12:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:36:12 INFO - Running setup.py (path:/tmp/pip-m6DXBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:36:12 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)) 12:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:36:12 INFO - Running setup.py (path:/tmp/pip-PUbYMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:36:12 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)) 12:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:36:12 INFO - Running setup.py (path:/tmp/pip-tqidj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:36:12 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)) 12:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:36:12 INFO - Running setup.py (path:/tmp/pip-gTEiIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:36:12 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)) 12:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:36:12 INFO - Running setup.py (path:/tmp/pip-kPK7Ye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:36:12 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)) 12:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:36:12 INFO - Running setup.py (path:/tmp/pip-esHq3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:36:12 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)) 12:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:36:12 INFO - Running setup.py (path:/tmp/pip-TsF_h5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:36:12 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)) 12:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:36:12 INFO - Running setup.py (path:/tmp/pip-LkGFXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:36:12 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)) 12:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:36:12 INFO - Running setup.py (path:/tmp/pip-ptq16L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:36:13 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)) 12:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:36:13 INFO - Running setup.py (path:/tmp/pip-WHhHrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:36:13 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)) 12:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:36:13 INFO - Running setup.py (path:/tmp/pip-8aPxES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:36:13 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)) 12:36:13 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)) 12:36:13 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)) 12:36:13 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)) 12:36:13 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)) 12:36:13 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)) 12:36:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:36:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:36:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:36:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:36:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:36:15 INFO - Downloading blessings-1.6.tar.gz 12:36:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:36:15 INFO - Installing collected packages: blessings 12:36:15 INFO - Running setup.py install for blessings 12:36:15 INFO - Successfully installed blessings 12:36:15 INFO - Cleaning up... 12:36:15 INFO - Return code: 0 12:36:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:36:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:36:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:36:15 INFO - Reading from file tmpfile_stdout 12:36:15 INFO - Current package versions: 12:36:15 INFO - argparse == 1.2.1 12:36:15 INFO - blessings == 1.6 12:36:15 INFO - blobuploader == 1.2.4 12:36:15 INFO - docopt == 0.6.1 12:36:15 INFO - manifestparser == 1.1 12:36:15 INFO - mozInstall == 1.12 12:36:15 INFO - mozcrash == 0.17 12:36:15 INFO - mozdebug == 0.1 12:36:15 INFO - mozdevice == 0.48 12:36:15 INFO - mozfile == 1.2 12:36:15 INFO - mozhttpd == 0.7 12:36:15 INFO - mozinfo == 0.9 12:36:15 INFO - mozleak == 0.1 12:36:15 INFO - mozlog == 3.1 12:36:15 INFO - moznetwork == 0.27 12:36:15 INFO - mozprocess == 0.22 12:36:15 INFO - mozprofile == 0.28 12:36:15 INFO - mozrunner == 6.11 12:36:15 INFO - mozscreenshot == 0.1 12:36:15 INFO - mozsystemmonitor == 0.0 12:36:15 INFO - moztest == 0.7 12:36:15 INFO - mozversion == 1.4 12:36:15 INFO - psutil == 3.1.1 12:36:15 INFO - requests == 1.2.3 12:36:15 INFO - wsgiref == 0.1.2 12:36:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:36:15 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')]} 12:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:36:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:15 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')]} 12:36:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:36:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:15 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 0x7fd9412a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136f410>, '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 0x1370310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13707a0>, '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': '232498196343f89f466a4a9a000001c8-1462474417.984151-1032471659', '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 12:36:15 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 12:36:15 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 12:36:15 INFO - Using env: {'DISPLAY': ':0', 12:36:15 INFO - 'HOME': '/home/cltbld', 12:36:15 INFO - 'LANG': 'en_US.UTF-8', 12:36:15 INFO - 'LANGUAGE': 'en_US:en', 12:36:15 INFO - 'LOGNAME': 'cltbld', 12:36:15 INFO - 'MAIL': '/var/mail/cltbld', 12:36:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:36:15 INFO - 'MOZ_NO_REMOTE': '1', 12:36:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:36:15 INFO - 'NO_EM_RESTART': '1', 12:36:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:36:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:36:15 INFO - 'PWD': '/builds/slave/test', 12:36:15 INFO - 'SHELL': '/bin/bash', 12:36:15 INFO - 'SHLVL': '1', 12:36:15 INFO - 'TERM': 'linux', 12:36:15 INFO - 'TMOUT': '86400', 12:36:15 INFO - 'USER': 'cltbld', 12:36:15 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462474417.984151-1032471659', 12:36:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:36:15 INFO - '_': '/tools/buildbot/bin/python'} 12:36:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:36:15 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)) 12:36:15 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)) 12:36:15 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)) 12:36:15 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)) 12:36:15 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)) 12:36:15 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)) 12:36:15 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)) 12:36:15 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)) 12:36:15 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)) 12:36:15 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)) 12:36:15 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)) 12:36:15 INFO - Cleaning up... 12:36:15 INFO - Return code: 0 12:36:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:36:15 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')]} 12:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:36:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:15 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')]} 12:36:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:36:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:15 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 0x7fd9412a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136f410>, '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 0x1370310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13707a0>, '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': '232498196343f89f466a4a9a000001c8-1462474417.984151-1032471659', '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 12:36:15 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 12:36:15 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 12:36:15 INFO - Using env: {'DISPLAY': ':0', 12:36:15 INFO - 'HOME': '/home/cltbld', 12:36:15 INFO - 'LANG': 'en_US.UTF-8', 12:36:15 INFO - 'LANGUAGE': 'en_US:en', 12:36:15 INFO - 'LOGNAME': 'cltbld', 12:36:15 INFO - 'MAIL': '/var/mail/cltbld', 12:36:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:36:15 INFO - 'MOZ_NO_REMOTE': '1', 12:36:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:36:15 INFO - 'NO_EM_RESTART': '1', 12:36:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:36:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:36:15 INFO - 'PWD': '/builds/slave/test', 12:36:15 INFO - 'SHELL': '/bin/bash', 12:36:15 INFO - 'SHLVL': '1', 12:36:15 INFO - 'TERM': 'linux', 12:36:15 INFO - 'TMOUT': '86400', 12:36:15 INFO - 'USER': 'cltbld', 12:36:15 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462474417.984151-1032471659', 12:36:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:36:15 INFO - '_': '/tools/buildbot/bin/python'} 12:36:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:36:15 INFO - Downloading/unpacking jsonschema 12:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:36:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:36:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:36:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:36:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:36:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:36:17 INFO - Downloading/unpacking functools32 (from jsonschema) 12:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:36:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:36:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:36:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:36:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:36:18 INFO - Downloading functools32-3.2.3-2.tar.gz 12:36:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:36:18 INFO - warning: no files found matching '*.txt' 12:36:18 INFO - no previously-included directories found matching 'build' 12:36:18 INFO - no previously-included directories found matching 'dist' 12:36:18 INFO - no previously-included directories found matching '.git*' 12:36:18 INFO - Installing collected packages: jsonschema, functools32 12:36:18 INFO - Running setup.py install for functools32 12:36:18 INFO - warning: no files found matching '*.txt' 12:36:18 INFO - no previously-included directories found matching 'build' 12:36:18 INFO - no previously-included directories found matching 'dist' 12:36:18 INFO - no previously-included directories found matching '.git*' 12:36:18 INFO - Successfully installed jsonschema functools32 12:36:18 INFO - Cleaning up... 12:36:18 INFO - Return code: 0 12:36:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:36:18 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')]} 12:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:36:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:18 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')]} 12:36:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:36:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:18 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 0x7fd9412a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136f410>, '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 0x1370310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13707a0>, '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': '232498196343f89f466a4a9a000001c8-1462474417.984151-1032471659', '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 12:36:18 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 12:36:18 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 12:36:18 INFO - Using env: {'DISPLAY': ':0', 12:36:18 INFO - 'HOME': '/home/cltbld', 12:36:18 INFO - 'LANG': 'en_US.UTF-8', 12:36:18 INFO - 'LANGUAGE': 'en_US:en', 12:36:18 INFO - 'LOGNAME': 'cltbld', 12:36:18 INFO - 'MAIL': '/var/mail/cltbld', 12:36:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:36:18 INFO - 'MOZ_NO_REMOTE': '1', 12:36:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:36:18 INFO - 'NO_EM_RESTART': '1', 12:36:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:36:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:36:18 INFO - 'PWD': '/builds/slave/test', 12:36:18 INFO - 'SHELL': '/bin/bash', 12:36:18 INFO - 'SHLVL': '1', 12:36:18 INFO - 'TERM': 'linux', 12:36:18 INFO - 'TMOUT': '86400', 12:36:18 INFO - 'USER': 'cltbld', 12:36:18 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462474417.984151-1032471659', 12:36:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:36:18 INFO - '_': '/tools/buildbot/bin/python'} 12:36:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:36:18 INFO - Downloading/unpacking flake8 12:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:36:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:36:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:36:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:36:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:36:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:36:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:36:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:36:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:36:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:36:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:36:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:36:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:36:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:36:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:36:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:36:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:36:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:36:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:36:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:36:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:36:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:36:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:36:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:36:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:36:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:36:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:36:21 INFO - no previously-included directories found matching 'docs/_build' 12:36:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:36:21 INFO - Running setup.py install for pep8 12:36:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:36:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:36:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:36:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:36:21 INFO - no previously-included directories found matching 'docs/_build' 12:36:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:36:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:36:21 INFO - Cleaning up... 12:36:21 INFO - Return code: 0 12:36:21 INFO - Running post-action listener: _resource_record_post_action 12:36:21 INFO - Running post-action listener: _start_resource_monitoring 12:36:21 INFO - Starting resource monitoring. 12:36:21 INFO - ##### 12:36:21 INFO - ##### Running install step. 12:36:21 INFO - ##### 12:36:21 INFO - Running pre-action listener: _resource_record_pre_action 12:36:21 INFO - Running main action method: install 12:36:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:36:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:36:21 INFO - Reading from file tmpfile_stdout 12:36:21 INFO - Detecting whether we're running mozinstall >=1.0... 12:36:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:36:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:36:21 INFO - Reading from file tmpfile_stdout 12:36:21 INFO - Output received: 12:36:21 INFO - Usage: mozinstall [options] installer 12:36:21 INFO - Options: 12:36:21 INFO - -h, --help show this help message and exit 12:36:21 INFO - -d DEST, --destination=DEST 12:36:21 INFO - Directory to install application into. [default: 12:36:21 INFO - "/builds/slave/test"] 12:36:21 INFO - --app=APP Application being installed. [default: firefox] 12:36:21 INFO - mkdir: /builds/slave/test/build/application 12:36:21 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'] 12:36:21 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 12:36:37 INFO - Reading from file tmpfile_stdout 12:36:37 INFO - Output received: 12:36:37 INFO - /builds/slave/test/build/application/firefox/firefox 12:36:37 INFO - Running post-action listener: _resource_record_post_action 12:36:37 INFO - ##### 12:36:37 INFO - ##### Running run-tests step. 12:36:37 INFO - ##### 12:36:37 INFO - Running pre-action listener: _resource_record_pre_action 12:36:37 INFO - Running main action method: run_tests 12:36:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:36:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:36:37 INFO - Python 2.7.3 12:36:37 INFO - Return code: 0 12:36:37 INFO - grabbing minidump binary from tooltool 12:36:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:36:37 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 0x136f410>, '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 0x1370310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13707a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:36:37 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 12:36:37 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 12:36:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:36:37 INFO - Return code: 0 12:36:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:36:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:36:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:36:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:36:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:36:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:36:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:36:38 INFO - Return code: 0 12:36:38 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/ZZwjP165TSSgEJAQDqUmNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 12:36:38 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/ZZwjP165TSSgEJAQDqUmNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 12:36:38 INFO - Using env: {'DISPLAY': ':0', 12:36:38 INFO - 'HOME': '/home/cltbld', 12:36:38 INFO - 'LANG': 'en_US.UTF-8', 12:36:38 INFO - 'LANGUAGE': 'en_US:en', 12:36:38 INFO - 'LOGNAME': 'cltbld', 12:36:38 INFO - 'MAIL': '/var/mail/cltbld', 12:36:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:36:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:36:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:36:38 INFO - 'MOZ_NO_REMOTE': '1', 12:36:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:36:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:36:38 INFO - 'NO_EM_RESTART': '1', 12:36:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:36:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:36:38 INFO - 'PWD': '/builds/slave/test', 12:36:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:36:38 INFO - 'SHELL': '/bin/bash', 12:36:38 INFO - 'SHLVL': '1', 12:36:38 INFO - 'TERM': 'linux', 12:36:38 INFO - 'TMOUT': '86400', 12:36:38 INFO - 'USER': 'cltbld', 12:36:38 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462474417.984151-1032471659', 12:36:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:36:38 INFO - '_': '/tools/buildbot/bin/python'} 12:36:38 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/ZZwjP165TSSgEJAQDqUmNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 12:36:38 INFO - mozversion application_buildid: 20160505113838 12:36:38 INFO - mozversion application_changeset: 7189e5f1105bb41782187b9876bbcc625f4208d8 12:36:38 INFO - mozversion application_display_name: Nightly 12:36:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:36:38 INFO - mozversion application_name: Firefox 12:36:38 INFO - mozversion application_remotingname: firefox 12:36:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:36:38 INFO - mozversion application_vendor: Mozilla 12:36:38 INFO - mozversion application_version: 49.0a1 12:36:38 INFO - mozversion platform_buildid: 20160505113838 12:36:38 INFO - mozversion platform_changeset: 7189e5f1105bb41782187b9876bbcc625f4208d8 12:36:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:36:38 INFO - mozversion platform_version: 49.0a1 12:36:38 INFO - using testdate: 1462476998 12:36:38 INFO - actual date: 1462476998 12:36:38 INFO - starting webserver on 'localhost:38936' 12:36:38 INFO - SUITE-START | Running 2 tests 12:36:38 INFO - TEST-START | dromaeo_css 12:36:38 INFO - operating with platform_type : linux_ 12:36:38 INFO - Initialising browser for dromaeo_css test... 12:36:38 INFO - TEST-INFO | started process 3232 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTxQeXB/profile http://localhost:38936/getInfo.html) 12:36:42 INFO - PROCESS | 3232 | __metrics Screen width/height:1600/1200 12:36:42 INFO - PROCESS | 3232 | colorDepth:24 12:36:42 INFO - PROCESS | 3232 | Browser inner width/height: 1024/697 12:36:42 INFO - PROCESS | 3232 | __metrics 12:36:43 ERROR - PROCESS | 3232 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:36:44 INFO - TEST-INFO | 3232: exit 0 12:36:44 INFO - Browser initialized. 12:36:44 INFO - Running cycle 1/1 for dromaeo_css test... 12:36:44 INFO - TEST-INFO | started process 3313 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTxQeXB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:36:56 INFO - PROCESS | 3313 | RSS: Main: 156561408 12:36:56 INFO - PROCESS | 3313 | 12:37:48 INFO - PROCESS | 3313 | 1462477068064 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] 12:39:59 INFO - PROCESS | 3313 | Cycle 1(1): loaded http://localhost:38936/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38936/tests/dromaeo/cssquery-ext.html) 12:40:00 INFO - PROCESS | 3313 | RSS: Main: 274554880 12:40:00 INFO - PROCESS | 3313 | 12:43:02 INFO - PROCESS | 3313 | Cycle 1(1): loaded http://localhost:38936/tests/dromaeo/cssquery-ext.html (next: http://localhost:38936/tests/dromaeo/cssquery-jquery.html) 12:43:03 INFO - PROCESS | 3313 | RSS: Main: 238260224 12:43:03 INFO - PROCESS | 3313 | 12:46:05 INFO - PROCESS | 3313 | Cycle 1(1): loaded http://localhost:38936/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38936/tests/dromaeo/cssquery-mootools.html) 12:46:06 INFO - PROCESS | 3313 | RSS: Main: 241418240 12:46:06 INFO - PROCESS | 3313 | 12:49:08 INFO - PROCESS | 3313 | Cycle 1(1): loaded http://localhost:38936/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38936/tests/dromaeo/cssquery-prototype.html) 12:49:08 INFO - PROCESS | 3313 | RSS: Main: 233750528 12:49:08 INFO - PROCESS | 3313 | 12:52:11 INFO - PROCESS | 3313 | Cycle 1(1): loaded http://localhost:38936/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38936/tests/dromaeo/cssquery-yui.html) 12:52:12 INFO - PROCESS | 3313 | RSS: Main: 204242944 12:52:12 INFO - PROCESS | 3313 | 12:55:14 INFO - PROCESS | 3313 | Cycle 1(1): loaded http://localhost:38936/tests/dromaeo/cssquery-yui.html (next: http://localhost:38936/tests/dromaeo/cssquery-dojo.html) 12:55:15 INFO - PROCESS | 3313 | RSS: Main: 293900288 12:55:15 INFO - PROCESS | 3313 | 12:55:15 INFO - PROCESS | 3313 | __start_tp_report 12:55:15 INFO - PROCESS | 3313 | _x_x_mozilla_page_load 12:55:15 INFO - PROCESS | 3313 | _x_x_mozilla_page_load_details 12:55:15 INFO - PROCESS | 3313 | |i|pagename|runs| 12:55:15 INFO - PROCESS | 3313 | |0;dojo.html;2553.348896031512;2557.143356975412;2564.0769323043687;2579.4325248445334;2591.8444893306396;4540.7956641951105;4564.817407303708;4617.769111544418;4626.5373462653715;4662.020975595125;4662.137504561659;4694.718316900989;4719.150552900476;4739.976300118495;4755.286706993953;4237.470316210473;4274.807633656485;4286.03564198056;4312.2453570625175;4417.249067658489;4329.19909816685;4361.738295702252;4373.1909596724545;4384.495782984965;4417;4238.406623072757;4324.17840610283;4329.9567004329865;4388.034632380871;4399.934000989988;4253.744775313491;4298.032942587924;4307.870763877088;4346.630536404409;4388.363687265361;4296.5059018213;4330;4331.285337919239;4343.2182207202695;4375.890602734957;4437.889052773707;4498.820047198108;4504.774761261957;4595.724256544618;4647.256438969783;5005.824796132118;5017.147084995559;5028.1200789862;5054.21659642756;5075.670081444694;5035.320231768701;5046.924296135561;5052.040112378636;5056.317397151374;5062.240663900445;4532.138893610204;4646.907061858744;4697.037107392942;4703;4725.905481890343;5078.619103567247;5100.56645185156;5101.362329708786;5111.693298402108;5143.5113664201845;4884.413870335511;4885.5847252983185;4887.413510378778;4890.095332363524;4921.581665558468;4921;4963.503649635008;4969;5046.899062018739;5051.419086804991;4873.658843880965;4903.362562866876;4906.484819094015;4910.926336104962;4963.6277279204205;4896.167651499253;4900.8774780630765;4904.435989861212;4917.950820491821;4953.603711703127;4098.897527561775;4212.515560710557;4259.254630439661;4285.142971405731;4299.914001719948;3699.2971335446177;3717.386631205875;3719.1817800083936;3720.069982504374;3756.7558108722847;4210.59999300066;4319.67602429819;4347.739135651807;4350.1734670412525;4389.1660584488845;4939.431965323962;4968.90062198754;4976.402831660224;5020.523050310215;5027.472115427828;4236.2586547354085;4272.038791272001;4285.678574106954;4319.222539942778;4321.935170972438;4458.665600080007;4514.367988481616;4523;4538.931916021263;4543.886402839956;4706.435227772689;4706.458757242824;4707.882302942454;4726.669133160645;4761.714297142183;4998.850034498971;5002.424721156968;5003.649744517848;5003.799848006184;5013.849584512471;4625.421822272216;4701.5298470154075;4733.763311834464;4741.431028276629;4823.589994850477;4884.682495637772;4891.280093223854;4903.068417000758;4917.877053073702;4944.901101977868;4964.67729597575;4965.801367945386;4966.801327946986;4971.279164521196;5002.52476014778;4629.722216667011;4726.598239149711;4814.783334750015;4828.806847726051;4858.465568787501;4824.589909857701;4831.613470922248;4846.103470857903;4853.708777473363;4909.5090490950615;4758.619310455225;4778.331033655221;4780.498047704941;4781.7609119543185;4817.349657796152;4720.952790472052;4741.952580474152;4776.355192049029;4803.3995750531185;4849.102915960559;4732.361131247238;4755.262934245197;4773.522647735199;4777.8327758528285;4778.211595086772 12:55:15 INFO - PROCESS | 3313 | |1;ext.html;569.5102212097597;571.2443904495077;594.5422025040718;608.969551522424;616.1404840247851;34783.47824782627;36334.818325908396;36337.0915727107;36373.81813090938;36412;38212;38897.61102388975;38950.22099558007;38967;38984.22031559374;7547.0566179227735;7746.961265193694;7748.1864404237585;7755.302022817945;7757.418193635472;7762.45662803604;7853.410994175431;7867;7891.8421631567335;8053.476524025919;8012.63943122558;8085.757427277191;8087.878681819748;8088.919110808904;8091.150429204937;7997;8039.598020098972;8051.718189863327;8055.63749631268;8059.959700201462;7901.446898717092;7991.640376183086;7997.840043199161;8003.1996800320085;8006.159353267882;38822.22355552902;39026.609733902864;39302.410463843065;39398.80300598507;39416;3148.386064717381;3305.0910999475336;3765.152840610868;3910.5502867170353;3952.1107750756137;29784.40431191386;30023.699763002307;30122.24694382636;30545.08364749061;30997.690023099705;3101;3118.984405077983;3173.5715678383585;3224.4196044711944;3291.127851119455;247743;248802.75598622073;249755;249902;250586;31351.372972540423;31902.840485797424;32093.839530802197;32127.036188913902;49749.50250497521;32536.18659533483;32637.347253054806;32739.345213095603;32768;32773.50839737406;13775.724485510234;13967.930160349337;13970.580882573538;13970.580882573538;13971.301434928213;11627.709307267216;11659.708507287216;11686.532538698528;11687.766244675058;11705.531778728755;8183.79540511492;8195;8223.383246256555;8307.875381869277;8321.292690121287;3226.3547290541987;3260.576125103769;3261.9836900815817;3270.2968861694376;3340.7828491148;927.2674587076269;937.6999360204805;964.1370972979145;1008.5864795433837;1046.4663021858755;28511.287217819307;28724;29157.854210728812;29358.853205734264;29386.265343366587;1014.573878970834;1042.9061384475433;1052.9631462898762;1065.5151905882806;1072.986028203356;15256.847431525543;15438.768418473732;15500.689986200212;15633.257482239549;15709.607259818597;336886;340305;344043;344363;344671;51277.48722512727;51877.481225187264;51895.48104518982;52142.739286303324;52212.73893630583;1178.4343515112794;1269.57469247803;1273.045216087934;1278.213898452445;1287.594407761552;25095;26798.330041748333;27208.591871121553;27230.5915411265;27327.726722733314;36303;36577.45133823048;36906.44640330344;36952;36967.630323696416;226314;229503;230331;230718;231072;21143;23814.404639884142;24116.758832412153;24171.637425438985;25750.227493175236;36997;37212.44181337336;37356.439653404675;37675.43486847645;38242.808785955895;32115.03654890357;32417.51373729443;32455.675443245265;35526.111847204025;35662.28675426529;33668.83165584254;34816.47775283423;35155.29689406147;35367.11582210465;35503;36734.8163259182;36750.44874326941;36820.447693284084;37139.8143009294;37162.44256336103;35703.82148089243;37799.81100094592;39979.40030899481;40594.59405406026;40948.18103637851;29912.25219369446;30806.691933080383;31287.687123129388;31299.822188480284;31347.529787053667 12:55:15 INFO - PROCESS | 3313 | |2;jquery.html;383.22779599107787;390.6796426929917;390.93275358271933;392.67211878081804;406.15722376069647;15975.440859569917;16547.58631034225;16570.91714541427;16587.336506539723;16593.83406165938;16993.150342482888;17118.486445406626;17694.203760830762;17869;17884.195211215494;5062.822801201949;5250.9474905250845;5259.684418934857;5281.788728450857;5284.63007589467;5066.79732810689;5101.209312556541;5222.791088356461;5229.267902493654;5230.7646155922885;5168.974155129219;5174.353205849269;5179.352580927384;5181.248718935752;5208.5572726318305;5168.948310516903;5242.659227150242;5528.778848846041;5540.667559946396;5540.944590554083;5333.333333333333;5334.839954801362;5335.706536140511;5339.679619222859;5371;19118;19684.80315196844;20425;20639.69040464394;20832.062557184963;1787.4101546489758;1986.513304240456;2172.5220451500645;2302.481941563152;2494.538510375586;8816.779580510474;9077.63689452421;9119.772005699844;9737.902620973771;9749.268804839594;1633.7222672145763;1707.1720215695502;1723.3968111161118;1726.533835864322;1735.334079283889;67928.98106528357;71568;71852.64073679598;72294.63852680755;74331.25668743298;10272.9181245626;10311.742206444898;10376.835065305004;10382.948085259526;10385.948070259601;14350.928245358706;14381.92809035948;14442.855571444361;14451.78322325166;14457.1325720455;7272.56364618114;7740.187280335596;7747.922520774833;7862;7866.803329916684;7326.267373262738;7452.813679658052;7491.513051651626;7548.5470871747875;7552.376239108618;4334.393184954109;4481.4174157359985;4523.231050721385;4572.634189264851;4611.123886461562;1841.9723704144449;1851.6759567075708;1895.2324308655018;1904.5146084359767;1918.6930091185343;798.0861913109458;851.5997481183833;967.8983706710835;968.4383057826444;986.9605215791288;16595.926138955474;16720.318310872975;17931.551711207325;18364.63270734578;18562.44312670622;889.5241046040337;948.7817801905462;949.857521371786;954.9665761698308;956.6269155029544;6899.724011039502;9647.517624118766;9790.75523111928;9803.460809655395;9858.831057167412;395961;408045;413161;413892;417059;77708.61145694235;81748.18251817406;81761;82458.58770706109;82905;1015.3856916565519;1076.2466273608504;1088.6298658456162;1097.4512743628186;1106.7122548137543;15032.473863414729;15279.61800954985;15329.77005344943;15497;15560.688786223986;34340.313193735485;34621.65378346285;34681.13297167591;35016.299674006885;35724.28551429009;45283.773581131885;47473.52526474691;50782.49217507778;50924.23613645724;50925.745371272904;7063.081799366049;7341.853162936604;7344.559326440431;7363.852722945404;7492.850142997218;10237;11510.769784604428;11593.594224202112;11731.296122232694;11779;10064.094231519199;10173.28786984904;10286.434246116536;10395.740106497398;10399.064084232456;9903.900960990299;9995.800083998134;10207.234457415576;10227.795444090927;10601.46992650349;10067.69796906094;10595;10637.361758294526;10672.359658420519;10737.409442480739;7768.495047821873;7904.170062143392;7935.682572697258;7998.160193179632;8064.112947575644;7740.7677769667;9463.290253231173;9530.428174309287;9591.9040809591;9718.951405242928 12:55:15 INFO - PROCESS | 3313 | |3;mootools.html;1332.4803326702581;1472.5655931500203;1510.9546713598588;1615.8868879178463;1806.087925597573;6538.215414150302;7514.3237108660205;7731.806704832382;7739.303462688357;7747.845043099134;7458;7659.387249020079;7662.808429789244;7665.846683066349;7669.079710434742;2194.44041769349;2210.049678638185;2223.5330580578016;2223.766504517019;2225.310153852311;2156.8382371322214;2180.9890950545223;2186.147402513021;2195;2200.8129309008755;2210.756816750164;2225.4770129019666;2231.3529076567775;2235.2400183937457;2241.204372447782;2146.0879126371306;2155.892205389724;2161.9783802161933;2162.0378931375544;2163.707899433572;2126.202673997251;2163.8377121715776;2168.327818376308;2172.934811955644;2181.6727490876337;7547.773566793005;7664.73173438927;7739.264769846855;7742.070951485802;7749.186335434754;4483.574060464251;4644.558766917137;4661.254199328091;4662.347271382009;4665.6967297125575;2827.2790438438064;2835.2203144135324;2863.0551917867056;2907.113330434238;2925.420273052549;915.4461550761827;929.7861491856843;934.9439033657934;946.186279799372;960.6109525642056;10337.276390652658;10413;10448.425336606484;10448.68653940383;10459.267851250415;3997.9000524986527;4018.598140185958;4092.386142078712;4116.300228961024;4138.606832350982;8240.13478584752;8280.58597070144;8293.83412331762;8297;8297.709580164787;4485.842995495207;4563.726176429424;4572.1770081385;4572.839950601713;4578.954210457853;3608.657177568127;4014.397840323975;4181.623653871166;4192.538820729717;4263.5736426357735;3655.2689462107683;3738.5513738351574;3741.3452645787424;3743.7005039596766;3840.327942610032;1200.8739082396398;1212.2120621596034;1219.2928101700993;1222.6209874938797;1223.7552489502136;806.8789681547814;836.3476488339105;853.6628031927478;868.6568805321863;871.8648609465542;4913.508649135058;5086.389633243961;5095;5220.1908704150155;5222.3472065991755;956.1824639932896;960.6637676813059;988.9456079915674;1000.7448100734266;1027.2039169643585;3401.5407919930494;3410.6589341065696;3497.283056973314;3511.1924257420937;3582.62382449839;9158.129977652112;9423.764405889908;9462.29032822541;9555.856662150074;9558.713238602853;9229.53852307382;9428.245740340757;9441.952790236142;9456.14894659484;9575.569099390405;7224.819379515449;7331.78004659861;7362.079740032496;7427.7771666850085;7437.293457121565;5063.265826455217;5121.590272778094;5137.126688462896;5203.73981300941;5256.9211461827335;8751.69369072105;8769.956150219208;8824.98512671051;8946.463212207289;9072.455652660861;8838.823223535623;8975.820483590422;8992.100789920956;9129.45223286605;9169.816603668023;5540.833774986757;5723.399043100415;5733.655980641175;6200.3179650239335;6314.179156709598;6721.932780672326;7157.141143062658;7350.19147893742;7361.411087113125;7403.8149046274275;6553.311902250195;6776.15298087739;6806.693698783665;6878.931210687829;6893.276205998499;6573.9810329399015;6575.27671956094;6577.6053436793945;6616.603003819786;6642.667866606747;6036.698165091816;6118.326984031664;6119.051547010221;6124.112003759519;6204.13142160107;4399.934000989923;4426.579474950004;4628.907421851612;4672.299155126622;4687.2031754602485;4548.47692515365;4601.976990115028;4646.070785842778;4690.085433340466;4734.692245004201 12:55:15 INFO - PROCESS | 3313 | |4;prototype.html;309.2793790468209;313.4107877190881;319.1797081500543;319.18289179699957;321.6927833918608;4598.931016034762;4657.091867085919;4708.246680531116;4708.835190768324;4710.152172608929;4576.427946506687;4624.421947256593;4631.745254011028;4634.58288754012;4641.675082744209;3515.156362473014;3605.7115430765607;3650.142216579115;3666;3668.7798732076026;3584.4802503636956;3674.50394196784;3746.756460830051;3763.008408315382;3767.717421193408;3636.2545678136053;3703.925921481582;3718.5537735471644;3722.1066943933397;3737.663610275075;3583.8387272572795;3691.6123807000417;3710.3692372296505;3718.3307004739136;3740.7942563159017;3322.4684050551796;3329.8002119872885;3331.766776325658;3337.8664853405835;3348.4809854472596;4465.24090904547;4466.3523789050405;4471.6646251531265;4480.820767169309;4510.413646226002;3994.6404823566018;4139.81370838313;4182.581741825824;4188.685848561339;4230;4848.127337079324;4867.9269810952865;4875.195592727196;4882.828121250875;4888.584470319992;3540.522029526007;3545.929081418383;3546.545916174356;3548.1307079765365;3549.236914063463;5008.449070602231;5050.166722490784;5070.822521211777;5106.15748401517;5143.730703516073;3606.8376923038527;3608.909777255537;3612.259486805199;3616.855325786939;3618.203995121069;3662.1393972416463;3665;3668.174660701321;3668.486411902336;3670.8164591770305;4163.437935878617;4178.916421671611;4196.866845951637;4198.64311533517;4206.317473010759;4626.057056036473;4913.557779799835;4917.729524876095;4925.21196608541;4992.650514464025;1301.8478646398005;1305.928173950423;1308.1104848702973;1310.7902735562263;1321.2666969831644;868.4789126524036;878.1569693094573;890.25663570919;893.0756666849909;915.1214833759665;4148.896277593024;4255.723377980421;4262.595053469915;4284.850030248988;4292.356146577976;4852.490488498727;5003.574696150795;5063.544281014726;5114.462981386975;5137.614678899097;4347.130573885235;4383.211022016004;4405.713628614129;4410.095930334273;4416.1830061438095;2718.7417195366406;2861.4420188063127;2866.269101379135;2874.7782192568075;2874.9712502874704;5061.240813877874;5079.111155547765;5095.363079615048;5122.282880396748;5127.230915362651;5365.678059316453;5550.361708403585;5555.388907220203;5563.777448902079;5578.135389014709;5091.974540127276;5108.872278193001;5115.7953681852305;5121.385433747974;5136.897262054738;5401.864953376197;5414.566834653139;5421.728913554228;5456.290682211287;5470.589705772003;5188.481151884932;5359.62482626228;5364.38309594386;5369.973150134224;5385.515303622693;5086.440491546001;5099.980003999289;5100.903305789125;5115.437301896863;5117.822900732778;3837.3668344723924;3891.902702432462;3923.7645741255615;3938.8818335449982;3939.113699417608;5196.72606258055;5322.973385133049;5323.680579165262;5333;5334.599905007062;5133.563647090039;5149.279100925798;5152.175651895679;5155.819546315861;5159.122949098737;5125.564327032244;5136.948630513647;5142.76857541404;5146.639735218499;5167.61242906791;4859.878503037452;5048.167052436307;5051.318072060371;5101.6173786966865;5105.366282789471;4644.863362853125;4676.883077923079;4919.139150648693;5135.537801597874;5157.277981082727;4822.638302127425;4825.396825396825;4859.3682821233015;4864.659473836798;4873.6832105913 12:55:15 INFO - PROCESS | 3313 | |5;yui.html;771.22106672261;776.115228639351;785.4305628419397;811.7645882694019;822.5270469480049;11059.2258541902;11584.18910676253;11606.36165010924;11608.651740447778;11672.007879330256;11570.421478926062;11775.470103845326;11842.11184161187;11862.703432414193;12519.874801251985;860.7718954477053;864.7621903976425;866.8483015472299;872.1932212703224;873.3013589128703;836.4270474724802;844.4511067805914;848.3552500099937;849.5539841583156;850.4344610833788;906.8957069936976;907.6006557114848;908.8409528332548;909.4088842252522;909.8316811389881;904.0326850270213;904.9185573298369;905.2531661379355;905.3391024552081;905.9184673379394;658.2002866517157;658.8945768676989;659.024643527577;659.9670016499156;660.3198705333514;11349.375784331858;11383.772324553462;11387;11409.315441073479;11444.71388215293;10734.141268698486;10888.564457421693;10894;10928.836067458995;10966.342019478778;9269.935385028648;9379.531023448868;9453.33826632136;9559.761005974837;9605.135537801561;3039.6808335124715;3120.1731541141617;3128.937421251585;3142.073088438916;3145.874165033396;32012.519812202834;35260;36439.27121457583;40563.59436405598;43193.784031079646;10231.43727095002;10394;10394.948025259977;10404.271700980858;10593.57625694979;17617.38339158149;17661.470155895342;17664.293428262983;17667.38164164248;17675.11624418774;5885.588008839341;6114;6116.908246376308;6895.724171033203;6908.861822763517;3777.225668737902;3885.6502914737807;3914.72596918213;3916.412538119305;4019.618136277049;2878.784091193169;2949.601803756508;2957.497225471675;2971.390864872696;2979.3892252088704;495.9851204463872;508.8244555628302;513.1456125550916;515.2245869965677;527.0065925730026;558.3969313141797;562.5049956038741;578.12702818744;579.9217105690763;590.645612632417;7409.147947985943;7552.207018263113;7564.621768911533;7598.582077985764;7612.352949999312;490.5633985752683;558.0039629261748;601.1583782704162;604.9818505444756;610.789277699202;3391.423458012144;3430;3442.4836274559016;3461.3250416168607;3571.4107172316794;41452.1709565813;43236.56763432388;49666;49706.254406183936;49920.50079499231;43582.34626480605;45448.318275225894;45782.31326530105;46632;46913.29630055552;42483.57516424858;42649;42668.78665606652;42991.35512967308;43331.13337733291;6516.348365163446;6531.836704082246;6532;6641.933580664325;6745.055692203194;28828.42343153167;29119.126426207247;29620.407591848474;29744.256393590334;30268.519120301447;35435.29129417449;35499.64500354963;37787.24425511529;38019.61980380161;38620.80689596534;9463.337566370288;9594.18449431806;9653.131218190396;9656.130948214695;9740.488813144966;9495.857562136436;9698.709038728568;9975.700728978143;9983.800323993624;10360.326578772356;9110.635574576943;9152.450852948845;9170.312226582899;9461.33770636049;9726.124648781644;9191.126842949909;9248.537573121452;9317.208037316634;9434.695524797477;10026.64906728261;8629.56852157377;8653.264472519906;8656.91343086561;8996.460212387277;9621.711348659552;7831.84336313282;8119.83760324802;8170.264676178935;8364.916350836656;8426.536540490331;7747.055300459264;8144.511329320259;8210.261076503144;8301.46040507365;8427.452215605967 12:55:15 INFO - PROCESS | 3313 | __end_tp_report 12:55:15 INFO - PROCESS | 3313 | __start_cc_report 12:55:15 INFO - PROCESS | 3313 | _x_x_mozilla_cycle_collect,1167 12:55:15 INFO - PROCESS | 3313 | __end_cc_report 12:55:15 INFO - PROCESS | 3313 | __startTimestamp1462478114997__endTimestamp 12:55:15 INFO - PROCESS | 3313 | 12:55:15 INFO - PROCESS | 3313 | ------- Summary: start ------- 12:55:15 INFO - PROCESS | 3313 | Number of tests: 6 12:55:15 INFO - PROCESS | 3313 | 12:55:15 INFO - PROCESS | 3313 | [#0] dojo.html Cycles:165 Average:4606.29 Median:4732.36 stddev:478.03 (10.1%) stddev-sans-first:451.55 12:55:15 INFO - PROCESS | 3313 | Values: 2553.3 2557.1 2564.1 2579.4 2591.8 4540.8 4564.8 4617.8 4626.5 4662.0 4662.1 4694.7 4719.2 4740.0 4755.3 4237.5 4274.8 4286.0 4312.2 4417.2 4329.2 4361.7 4373.2 4384.5 4417.0 4238.4 4324.2 4330.0 4388.0 4399.9 4253.7 4298.0 4307.9 4346.6 4388.4 4296.5 4330.0 4331.3 4343.2 4375.9 4437.9 4498.8 4504.8 4595.7 4647.3 5005.8 5017.1 5028.1 5054.2 5075.7 5035.3 5046.9 5052.0 5056.3 5062.2 4532.1 4646.9 4697.0 4703.0 4725.9 5078.6 5100.6 5101.4 5111.7 5143.5 4884.4 4885.6 4887.4 4890.1 4921.6 4921.0 4963.5 4969.0 5046.9 5051.4 4873.7 4903.4 4906.5 4910.9 4963.6 4896.2 4900.9 4904.4 4918.0 4953.6 4098.9 4212.5 4259.3 4285.1 4299.9 3699.3 3717.4 3719.2 3720.1 3756.8 4210.6 4319.7 4347.7 4350.2 4389.2 4939.4 4968.9 4976.4 5020.5 5027.5 4236.3 4272.0 4285.7 4319.2 4321.9 4458.7 4514.4 4523.0 4538.9 4543.9 4706.4 4706.5 4707.9 4726.7 4761.7 4998.9 5002.4 5003.6 5003.8 5013.8 4625.4 4701.5 4733.8 4741.4 4823.6 4884.7 4891.3 4903.1 4917.9 4944.9 4964.7 4965.8 4966.8 4971.3 5002.5 4629.7 4726.6 4814.8 4828.8 4858.5 4824.6 4831.6 4846.1 4853.7 4909.5 4758.6 4778.3 4780.5 4781.8 4817.3 4721.0 4742.0 4776.4 4803.4 4849.1 4732.4 4755.3 4773.5 4777.8 4778.2 12:55:15 INFO - PROCESS | 3313 | 12:55:15 INFO - PROCESS | 3313 | [#1] ext.html Cycles:180 Average:42153.94 Median:344517.00 stddev:72914.94 (21.2%) stddev-sans-first:73052.64 12:55:15 INFO - PROCESS | 3313 | Values: 569.5 571.2 594.5 609.0 616.1 34783.5 36334.8 36337.1 36373.8 36412.0 38212.0 38897.6 38950.2 38967.0 38984.2 7547.1 7747.0 7748.2 7755.3 7757.4 7762.5 7853.4 7867.0 7891.8 8053.5 8012.6 8085.8 8087.9 8088.9 8091.2 7997.0 8039.6 8051.7 8055.6 8060.0 7901.4 7991.6 7997.8 8003.2 8006.2 38822.2 39026.6 39302.4 39398.8 39416.0 3148.4 3305.1 3765.2 3910.6 3952.1 29784.4 30023.7 30122.2 30545.1 30997.7 3101.0 3119.0 3173.6 3224.4 3291.1 247743.0 248802.8 249755.0 249902.0 250586.0 31351.4 31902.8 32093.8 32127.0 49749.5 32536.2 32637.3 32739.3 32768.0 32773.5 13775.7 13967.9 13970.6 13970.6 13971.3 11627.7 11659.7 11686.5 11687.8 11705.5 8183.8 8195.0 8223.4 8307.9 8321.3 3226.4 3260.6 3262.0 3270.3 3340.8 927.3 937.7 964.1 1008.6 1046.5 28511.3 28724.0 29157.9 29358.9 29386.3 1014.6 1042.9 1053.0 1065.5 1073.0 15256.8 15438.8 15500.7 15633.3 15709.6 336886.0 340305.0 344043.0 344363.0 344671.0 51277.5 51877.5 51895.5 52142.7 52212.7 1178.4 1269.6 1273.0 1278.2 1287.6 25095.0 26798.3 27208.6 27230.6 27327.7 36303.0 36577.5 36906.4 36952.0 36967.6 226314.0 229503.0 230331.0 230718.0 231072.0 21143.0 23814.4 24116.8 24171.6 25750.2 36997.0 37212.4 37356.4 37675.4 38242.8 32115.0 32417.5 32455.7 35526.1 35662.3 33668.8 34816.5 35155.3 35367.1 35503.0 36734.8 36750.4 36820.4 37139.8 37162.4 35703.8 37799.8 39979.4 40594.6 40948.2 29912.3 30806.7 31287.7 31299.8 31347.5 12:55:15 INFO - PROCESS | 3313 | 12:55:15 INFO - PROCESS | 3313 | [#2] jquery.html Cycles:180 Average:24964.65 Median:24903.50 stddev:67630.51 (271.6%) stddev-sans-first:67795.05 12:55:15 INFO - PROCESS | 3313 | Values: 383.2 390.7 390.9 392.7 406.2 15975.4 16547.6 16570.9 16587.3 16593.8 16993.2 17118.5 17694.2 17869.0 17884.2 5062.8 5250.9 5259.7 5281.8 5284.6 5066.8 5101.2 5222.8 5229.3 5230.8 5169.0 5174.4 5179.4 5181.2 5208.6 5168.9 5242.7 5528.8 5540.7 5540.9 5333.3 5334.8 5335.7 5339.7 5371.0 19118.0 19684.8 20425.0 20639.7 20832.1 1787.4 1986.5 2172.5 2302.5 2494.5 8816.8 9077.6 9119.8 9737.9 9749.3 1633.7 1707.2 1723.4 1726.5 1735.3 67929.0 71568.0 71852.6 72294.6 74331.3 10272.9 10311.7 10376.8 10382.9 10385.9 14350.9 14381.9 14442.9 14451.8 14457.1 7272.6 7740.2 7747.9 7862.0 7866.8 7326.3 7452.8 7491.5 7548.5 7552.4 4334.4 4481.4 4523.2 4572.6 4611.1 1842.0 1851.7 1895.2 1904.5 1918.7 798.1 851.6 967.9 968.4 987.0 16595.9 16720.3 17931.6 18364.6 18562.4 889.5 948.8 949.9 955.0 956.6 6899.7 9647.5 9790.8 9803.5 9858.8 395961.0 408045.0 413161.0 413892.0 417059.0 77708.6 81748.2 81761.0 82458.6 82905.0 1015.4 1076.2 1088.6 1097.5 1106.7 15032.5 15279.6 15329.8 15497.0 15560.7 34340.3 34621.7 34681.1 35016.3 35724.3 45283.8 47473.5 50782.5 50924.2 50925.7 7063.1 7341.9 7344.6 7363.9 7492.9 10237.0 11510.8 11593.6 11731.3 11779.0 10064.1 10173.3 10286.4 10395.7 10399.1 9903.9 9995.8 10207.2 10227.8 10601.5 10067.7 10595.0 10637.4 10672.4 10737.4 7768.5 7904.2 7935.7 7998.2 8064.1 7740.8 9463.3 9530.4 9591.9 9719.0 12:55:15 INFO - PROCESS | 3313 | 12:55:15 INFO - PROCESS | 3313 | [#3] mootools.html Cycles:180 Average:5042.59 Median:5108.30 stddev:2776.01 (54.3%) stddev-sans-first:2769.80 12:55:15 INFO - PROCESS | 3313 | Values: 1332.5 1472.6 1511.0 1615.9 1806.1 6538.2 7514.3 7731.8 7739.3 7747.8 7458.0 7659.4 7662.8 7665.8 7669.1 2194.4 2210.0 2223.5 2223.8 2225.3 2156.8 2181.0 2186.1 2195.0 2200.8 2210.8 2225.5 2231.4 2235.2 2241.2 2146.1 2155.9 2162.0 2162.0 2163.7 2126.2 2163.8 2168.3 2172.9 2181.7 7547.8 7664.7 7739.3 7742.1 7749.2 4483.6 4644.6 4661.3 4662.3 4665.7 2827.3 2835.2 2863.1 2907.1 2925.4 915.4 929.8 934.9 946.2 960.6 10337.3 10413.0 10448.4 10448.7 10459.3 3997.9 4018.6 4092.4 4116.3 4138.6 8240.1 8280.6 8293.8 8297.0 8297.7 4485.8 4563.7 4572.2 4572.8 4579.0 3608.7 4014.4 4181.6 4192.5 4263.6 3655.3 3738.6 3741.3 3743.7 3840.3 1200.9 1212.2 1219.3 1222.6 1223.8 806.9 836.3 853.7 868.7 871.9 4913.5 5086.4 5095.0 5220.2 5222.3 956.2 960.7 988.9 1000.7 1027.2 3401.5 3410.7 3497.3 3511.2 3582.6 9158.1 9423.8 9462.3 9555.9 9558.7 9229.5 9428.2 9442.0 9456.1 9575.6 7224.8 7331.8 7362.1 7427.8 7437.3 5063.3 5121.6 5137.1 5203.7 5256.9 8751.7 8770.0 8825.0 8946.5 9072.5 8838.8 8975.8 8992.1 9129.5 9169.8 5540.8 5723.4 5733.7 6200.3 6314.2 6721.9 7157.1 7350.2 7361.4 7403.8 6553.3 6776.2 6806.7 6878.9 6893.3 6574.0 6575.3 6577.6 6616.6 6642.7 6036.7 6118.3 6119.1 6124.1 6204.1 4399.9 4426.6 4628.9 4672.3 4687.2 4548.5 4602.0 4646.1 4690.1 4734.7 12:55:15 INFO - PROCESS | 3313 | 12:55:15 INFO - PROCESS | 3313 | [#4] prototype.html Cycles:180 Average:4187.35 Median:4638.13 stddev:1226.89 (26.5%) stddev-sans-first:1195.31 12:55:15 INFO - PROCESS | 3313 | Values: 309.3 313.4 319.2 319.2 321.7 4598.9 4657.1 4708.2 4708.8 4710.2 4576.4 4624.4 4631.7 4634.6 4641.7 3515.2 3605.7 3650.1 3666.0 3668.8 3584.5 3674.5 3746.8 3763.0 3767.7 3636.3 3703.9 3718.6 3722.1 3737.7 3583.8 3691.6 3710.4 3718.3 3740.8 3322.5 3329.8 3331.8 3337.9 3348.5 4465.2 4466.4 4471.7 4480.8 4510.4 3994.6 4139.8 4182.6 4188.7 4230.0 4848.1 4867.9 4875.2 4882.8 4888.6 3540.5 3545.9 3546.5 3548.1 3549.2 5008.4 5050.2 5070.8 5106.2 5143.7 3606.8 3608.9 3612.3 3616.9 3618.2 3662.1 3665.0 3668.2 3668.5 3670.8 4163.4 4178.9 4196.9 4198.6 4206.3 4626.1 4913.6 4917.7 4925.2 4992.7 1301.8 1305.9 1308.1 1310.8 1321.3 868.5 878.2 890.3 893.1 915.1 4148.9 4255.7 4262.6 4284.9 4292.4 4852.5 5003.6 5063.5 5114.5 5137.6 4347.1 4383.2 4405.7 4410.1 4416.2 2718.7 2861.4 2866.3 2874.8 2875.0 5061.2 5079.1 5095.4 5122.3 5127.2 5365.7 5550.4 5555.4 5563.8 5578.1 5092.0 5108.9 5115.8 5121.4 5136.9 5401.9 5414.6 5421.7 5456.3 5470.6 5188.5 5359.6 5364.4 5370.0 5385.5 5086.4 5100.0 5100.9 5115.4 5117.8 3837.4 3891.9 3923.8 3938.9 3939.1 5196.7 5323.0 5323.7 5333.0 5334.6 5133.6 5149.3 5152.2 5155.8 5159.1 5125.6 5136.9 5142.8 5146.6 5167.6 4859.9 5048.2 5051.3 5101.6 5105.4 4644.9 4676.9 4919.1 5135.5 5157.3 4822.6 4825.4 4859.4 4864.7 4873.7 12:55:15 INFO - PROCESS | 3313 | 12:55:15 INFO - PROCESS | 3313 | [#5] yui.html Cycles:180 Average:11853.56 Median:570.32 stddev:13516.09 (2369.9%) stddev-sans-first:13528.38 12:55:15 INFO - PROCESS | 3313 | Values: 771.2 776.1 785.4 811.8 822.5 11059.2 11584.2 11606.4 11608.7 11672.0 11570.4 11775.5 11842.1 11862.7 12519.9 860.8 864.8 866.8 872.2 873.3 836.4 844.5 848.4 849.6 850.4 906.9 907.6 908.8 909.4 909.8 904.0 904.9 905.3 905.3 905.9 658.2 658.9 659.0 660.0 660.3 11349.4 11383.8 11387.0 11409.3 11444.7 10734.1 10888.6 10894.0 10928.8 10966.3 9269.9 9379.5 9453.3 9559.8 9605.1 3039.7 3120.2 3128.9 3142.1 3145.9 32012.5 35260.0 36439.3 40563.6 43193.8 10231.4 10394.0 10394.9 10404.3 10593.6 17617.4 17661.5 17664.3 17667.4 17675.1 5885.6 6114.0 6116.9 6895.7 6908.9 3777.2 3885.7 3914.7 3916.4 4019.6 2878.8 2949.6 2957.5 2971.4 2979.4 496.0 508.8 513.1 515.2 527.0 558.4 562.5 578.1 579.9 590.6 7409.1 7552.2 7564.6 7598.6 7612.4 490.6 558.0 601.2 605.0 610.8 3391.4 3430.0 3442.5 3461.3 3571.4 41452.2 43236.6 49666.0 49706.3 49920.5 43582.3 45448.3 45782.3 46632.0 46913.3 42483.6 42649.0 42668.8 42991.4 43331.1 6516.3 6531.8 6532.0 6641.9 6745.1 28828.4 29119.1 29620.4 29744.3 30268.5 35435.3 35499.6 37787.2 38019.6 38620.8 9463.3 9594.2 9653.1 9656.1 9740.5 9495.9 9698.7 9975.7 9983.8 10360.3 9110.6 9152.5 9170.3 9461.3 9726.1 9191.1 9248.5 9317.2 9434.7 10026.6 8629.6 8653.3 8656.9 8996.5 9621.7 7831.8 8119.8 8170.3 8364.9 8426.5 7747.1 8144.5 8210.3 8301.5 8427.5 12:55:15 INFO - PROCESS | 3313 | -------- Summary: end -------- 12:55:15 INFO - PROCESS | 3313 | 12:55:15 INFO - TEST-INFO | 3313: exit 0 12:55:15 INFO - TEST-OK | dromaeo_css | took 1117041ms 12:55:15 INFO - TEST-START | kraken 12:55:15 INFO - operating with platform_type : linux_ 12:55:15 INFO - Initialising browser for kraken test... 12:55:15 INFO - TEST-INFO | started process 3495 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNu802p/profile http://localhost:38936/getInfo.html) 12:55:19 INFO - PROCESS | 3495 | __metrics Screen width/height:1600/1200 12:55:19 INFO - PROCESS | 3495 | colorDepth:24 12:55:19 INFO - PROCESS | 3495 | Browser inner width/height: 1024/697 12:55:19 INFO - PROCESS | 3495 | __metrics 12:55:20 ERROR - PROCESS | 3495 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:55:21 INFO - TEST-INFO | 3495: exit 0 12:55:21 INFO - Browser initialized. 12:55:21 INFO - Running cycle 1/1 for kraken test... 12:55:21 INFO - TEST-INFO | started process 3576 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNu802p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:55:33 INFO - PROCESS | 3576 | RSS: Main: 157011968 12:55:33 INFO - PROCESS | 3576 | 12:55:36 INFO - PROCESS | 3576 | Cycle 1(1): loaded http://localhost:38936/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38936/tests/kraken/driver.html?testName=audio-beat-detection) 12:55:37 INFO - PROCESS | 3576 | RSS: Main: 211800064 12:55:37 INFO - PROCESS | 3576 | 12:55:39 INFO - PROCESS | 3576 | Cycle 1(1): loaded http://localhost:38936/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38936/tests/kraken/driver.html?testName=audio-dft) 12:55:40 INFO - PROCESS | 3576 | RSS: Main: 197701632 12:55:40 INFO - PROCESS | 3576 | 12:55:43 INFO - PROCESS | 3576 | Cycle 1(1): loaded http://localhost:38936/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38936/tests/kraken/driver.html?testName=audio-fft) 12:55:44 INFO - PROCESS | 3576 | RSS: Main: 267771904 12:55:44 INFO - PROCESS | 3576 | 12:55:46 INFO - PROCESS | 3576 | Cycle 1(1): loaded http://localhost:38936/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38936/tests/kraken/driver.html?testName=audio-oscillator) 12:55:47 INFO - PROCESS | 3576 | RSS: Main: 175607808 12:55:47 INFO - PROCESS | 3576 | 12:55:49 INFO - PROCESS | 3576 | Cycle 1(1): loaded http://localhost:38936/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38936/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:55:49 INFO - PROCESS | 3576 | RSS: Main: 179908608 12:55:49 INFO - PROCESS | 3576 | 12:55:53 INFO - PROCESS | 3576 | Cycle 1(1): loaded http://localhost:38936/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38936/tests/kraken/driver.html?testName=imaging-darkroom) 12:55:53 INFO - PROCESS | 3576 | RSS: Main: 215965696 12:55:53 INFO - PROCESS | 3576 | 12:55:57 INFO - PROCESS | 3576 | Cycle 1(1): loaded http://localhost:38936/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38936/tests/kraken/driver.html?testName=imaging-desaturate) 12:55:57 INFO - PROCESS | 3576 | RSS: Main: 216760320 12:55:57 INFO - PROCESS | 3576 | 12:56:00 INFO - PROCESS | 3576 | Cycle 1(1): loaded http://localhost:38936/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38936/tests/kraken/driver.html?testName=json-parse-financial) 12:56:01 INFO - PROCESS | 3576 | RSS: Main: 217292800 12:56:01 INFO - PROCESS | 3576 | 12:56:02 INFO - PROCESS | 3576 | Cycle 1(1): loaded http://localhost:38936/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38936/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:56:03 INFO - PROCESS | 3576 | RSS: Main: 205623296 12:56:03 INFO - PROCESS | 3576 | 12:56:05 INFO - PROCESS | 3576 | Cycle 1(1): loaded http://localhost:38936/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38936/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:56:06 INFO - PROCESS | 3576 | RSS: Main: 207450112 12:56:06 INFO - PROCESS | 3576 | 12:56:08 INFO - PROCESS | 3576 | Cycle 1(1): loaded http://localhost:38936/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38936/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:56:08 INFO - PROCESS | 3576 | RSS: Main: 217665536 12:56:08 INFO - PROCESS | 3576 | 12:56:11 INFO - PROCESS | 3576 | Cycle 1(1): loaded http://localhost:38936/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38936/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:56:12 INFO - PROCESS | 3576 | RSS: Main: 226414592 12:56:12 INFO - PROCESS | 3576 | 12:56:15 INFO - PROCESS | 3576 | Cycle 1(1): loaded http://localhost:38936/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38936/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:56:15 INFO - PROCESS | 3576 | RSS: Main: 223428608 12:56:15 INFO - PROCESS | 3576 | 12:56:17 INFO - PROCESS | 3576 | Cycle 1(1): loaded http://localhost:38936/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38936/tests/kraken/driver.html?testName=ai-astar) 12:56:17 INFO - PROCESS | 3576 | RSS: Main: 285372416 12:56:17 INFO - PROCESS | 3576 | 12:56:17 INFO - PROCESS | 3576 | __start_tp_report 12:56:17 INFO - PROCESS | 3576 | _x_x_mozilla_page_load 12:56:17 INFO - PROCESS | 3576 | _x_x_mozilla_page_load_details 12:56:17 INFO - PROCESS | 3576 | |i|pagename|runs| 12:56:17 INFO - PROCESS | 3576 | |0;ai-astar;112;114;107;112;113;113;104;114;113;114 12:56:17 INFO - PROCESS | 3576 | |1;audio-beat-detection;163;132;159;179;136;159;157;134;199;140 12:56:17 INFO - PROCESS | 3576 | |2;audio-dft;161;161;161;161;162;161;161;161;164;160 12:56:17 INFO - PROCESS | 3576 | |3;audio-fft;74;74;115;115;73;74;74;109;111;74 12:56:17 INFO - PROCESS | 3576 | |4;audio-oscillator;94;95;149;94;94;94;146;93;94;146 12:56:17 INFO - PROCESS | 3576 | |5;imaging-gaussian-blur;117;117;117;116;116;117;117;117;116;117 12:56:17 INFO - PROCESS | 3576 | |6;imaging-darkroom;146;147;147;146;146;146;146;147;146;146 12:56:17 INFO - PROCESS | 3576 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 12:56:17 INFO - PROCESS | 3576 | |8;json-parse-financial;67;66;66;67;67;67;68;83;65;63 12:56:17 INFO - PROCESS | 3576 | |9;json-stringify-tinderbox;65;65;64;65;65;64;65;65;65;65 12:56:17 INFO - PROCESS | 3576 | |10;stanford-crypto-aes;80;81;80;87;82;82;82;84;86;82 12:56:17 INFO - PROCESS | 3576 | |11;stanford-crypto-ccm;144;140;135;140;140;129;131;130;162;133 12:56:17 INFO - PROCESS | 3576 | |12;stanford-crypto-pbkdf2;186;179;181;179;185;179;175;178;182;180 12:56:17 INFO - PROCESS | 3576 | |13;stanford-crypto-sha256-iterative;75;76;75;74;73;73;73;73;74;72 12:56:17 INFO - PROCESS | 3576 | __end_tp_report 12:56:17 INFO - PROCESS | 3576 | __start_cc_report 12:56:17 INFO - PROCESS | 3576 | _x_x_mozilla_cycle_collect,1895 12:56:17 INFO - PROCESS | 3576 | __end_cc_report 12:56:17 INFO - PROCESS | 3576 | __startTimestamp1462478177960__endTimestamp 12:56:17 INFO - PROCESS | 3576 | 12:56:17 INFO - PROCESS | 3576 | ------- Summary: start ------- 12:56:17 INFO - PROCESS | 3576 | Number of tests: 14 12:56:17 INFO - PROCESS | 3576 | 12:56:17 INFO - PROCESS | 3576 | [#0] ai-astar Cycles:10 Average:111.60 Median:113.00 stddev:3.37 (3.0%) stddev-sans-first:3.57 12:56:17 INFO - PROCESS | 3576 | Values: 112.0 114.0 107.0 112.0 113.0 113.0 104.0 114.0 113.0 114.0 12:56:17 INFO - PROCESS | 3576 | 12:56:17 INFO - PROCESS | 3576 | [#1] audio-beat-detection Cycles:10 Average:155.80 Median:159.00 stddev:21.50 (13.5%) stddev-sans-first:22.65 12:56:17 INFO - PROCESS | 3576 | Values: 163.0 132.0 159.0 179.0 136.0 159.0 157.0 134.0 199.0 140.0 12:56:17 INFO - PROCESS | 3576 | 12:56:17 INFO - PROCESS | 3576 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 12:56:17 INFO - PROCESS | 3576 | Values: 161.0 161.0 161.0 161.0 162.0 161.0 161.0 161.0 164.0 160.0 12:56:17 INFO - PROCESS | 3576 | 12:56:17 INFO - PROCESS | 3576 | [#3] audio-fft Cycles:10 Average:89.30 Median:74.00 stddev:20.04 (27.1%) stddev-sans-first:20.48 12:56:17 INFO - PROCESS | 3576 | Values: 74.0 74.0 115.0 115.0 73.0 74.0 74.0 109.0 111.0 74.0 12:56:17 INFO - PROCESS | 3576 | 12:56:17 INFO - PROCESS | 3576 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:94.00 stddev:25.62 (27.3%) stddev-sans-first:26.52 12:56:17 INFO - PROCESS | 3576 | Values: 94.0 95.0 149.0 94.0 94.0 94.0 146.0 93.0 94.0 146.0 12:56:17 INFO - PROCESS | 3576 | 12:56:17 INFO - PROCESS | 3576 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 12:56:17 INFO - PROCESS | 3576 | Values: 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 116.0 117.0 12:56:17 INFO - PROCESS | 3576 | 12:56:17 INFO - PROCESS | 3576 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 12:56:17 INFO - PROCESS | 3576 | Values: 146.0 147.0 147.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 12:56:17 INFO - PROCESS | 3576 | 12:56:17 INFO - PROCESS | 3576 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 12:56:17 INFO - PROCESS | 3576 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 12:56:17 INFO - PROCESS | 3576 | 12:56:17 INFO - PROCESS | 3576 | [#8] json-parse-financial Cycles:10 Average:67.90 Median:67.00 stddev:5.49 (8.2%) stddev-sans-first:5.81 12:56:17 INFO - PROCESS | 3576 | Values: 67.0 66.0 66.0 67.0 67.0 67.0 68.0 83.0 65.0 63.0 12:56:17 INFO - PROCESS | 3576 | 12:56:17 INFO - PROCESS | 3576 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 12:56:17 INFO - PROCESS | 3576 | Values: 65.0 65.0 64.0 65.0 65.0 64.0 65.0 65.0 65.0 65.0 12:56:17 INFO - PROCESS | 3576 | 12:56:17 INFO - PROCESS | 3576 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:82.00 stddev:2.37 (2.9%) stddev-sans-first:2.32 12:56:17 INFO - PROCESS | 3576 | Values: 80.0 81.0 80.0 87.0 82.0 82.0 82.0 84.0 86.0 82.0 12:56:17 INFO - PROCESS | 3576 | 12:56:17 INFO - PROCESS | 3576 | [#11] stanford-crypto-ccm Cycles:10 Average:138.40 Median:140.00 stddev:9.72 (6.9%) stddev-sans-first:10.10 12:56:17 INFO - PROCESS | 3576 | Values: 144.0 140.0 135.0 140.0 140.0 129.0 131.0 130.0 162.0 133.0 12:56:17 INFO - PROCESS | 3576 | 12:56:17 INFO - PROCESS | 3576 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.40 Median:180.50 stddev:3.27 (1.8%) stddev-sans-first:2.77 12:56:17 INFO - PROCESS | 3576 | Values: 186.0 179.0 181.0 179.0 185.0 179.0 175.0 178.0 182.0 180.0 12:56:17 INFO - PROCESS | 3576 | 12:56:17 INFO - PROCESS | 3576 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.80 Median:74.00 stddev:1.23 (1.7%) stddev-sans-first:1.22 12:56:17 INFO - PROCESS | 3576 | Values: 75.0 76.0 75.0 74.0 73.0 73.0 73.0 73.0 74.0 72.0 12:56:17 INFO - PROCESS | 3576 | -------- Summary: end -------- 12:56:17 INFO - PROCESS | 3576 | 12:56:19 INFO - TEST-INFO | 3576: exit 0 12:56:19 INFO - TEST-OK | kraken | took 63330ms 12:56:19 INFO - SUITE-END | took 1180s 12:56:19 INFO - Completed test suite (00:19:40) 12:56:19 INFO - javascript benchmark 12:56:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2553.348896031512, 2557.143356975412, 2564.0769323043687, 2579.4325248445334, 2591.8444893306396, 4540.7956641951105, 4564.817407303708, 4617.769111544418, 4626.5373462653715, 4662.020975595125, 4662.137504561659, 4694.718316900989, 4719.150552900476, 4739.976300118495, 4755.286706993953, 4237.470316210473, 4274.807633656485, 4286.03564198056, 4312.2453570625175, 4417.249067658489, 4329.19909816685, 4361.738295702252, 4373.1909596724545, 4384.495782984965, 4417.0, 4238.406623072757, 4324.17840610283, 4329.9567004329865, 4388.034632380871, 4399.934000989988, 4253.744775313491, 4298.032942587924, 4307.870763877088, 4346.630536404409, 4388.363687265361, 4296.5059018213, 4330.0, 4331.285337919239, 4343.2182207202695, 4375.890602734957, 4437.889052773707, 4498.820047198108, 4504.774761261957, 4595.724256544618, 4647.256438969783, 5005.824796132118, 5017.147084995559, 5028.1200789862, 5054.21659642756, 5075.670081444694, 5035.320231768701, 5046.924296135561, 5052.040112378636, 5056.317397151374, 5062.240663900445, 4532.138893610204, 4646.907061858744, 4697.037107392942, 4703.0, 4725.905481890343, 5078.619103567247, 5100.56645185156, 5101.362329708786, 5111.693298402108, 5143.5113664201845, 4884.413870335511, 4885.5847252983185, 4887.413510378778, 4890.095332363524, 4921.581665558468, 4921.0, 4963.503649635008, 4969.0, 5046.899062018739, 5051.419086804991, 4873.658843880965, 4903.362562866876, 4906.484819094015, 4910.926336104962, 4963.6277279204205, 4896.167651499253, 4900.8774780630765, 4904.435989861212, 4917.950820491821, 4953.603711703127, 4098.897527561775, 4212.515560710557, 4259.254630439661, 4285.142971405731, 4299.914001719948, 3699.2971335446177, 3717.386631205875, 3719.1817800083936, 3720.069982504374, 3756.7558108722847, 4210.59999300066, 4319.67602429819, 4347.739135651807, 4350.1734670412525, 4389.1660584488845, 4939.431965323962, 4968.90062198754, 4976.402831660224, 5020.523050310215, 5027.472115427828, 4236.2586547354085, 4272.038791272001, 4285.678574106954, 4319.222539942778, 4321.935170972438, 4458.665600080007, 4514.367988481616, 4523.0, 4538.931916021263, 4543.886402839956, 4706.435227772689, 4706.458757242824, 4707.882302942454, 4726.669133160645, 4761.714297142183, 4998.850034498971, 5002.424721156968, 5003.649744517848, 5003.799848006184, 5013.849584512471, 4625.421822272216, 4701.5298470154075, 4733.763311834464, 4741.431028276629, 4823.589994850477, 4884.682495637772, 4891.280093223854, 4903.068417000758, 4917.877053073702, 4944.901101977868, 4964.67729597575, 4965.801367945386, 4966.801327946986, 4971.279164521196, 5002.52476014778, 4629.722216667011, 4726.598239149711, 4814.783334750015, 4828.806847726051, 4858.465568787501, 4824.589909857701, 4831.613470922248, 4846.103470857903, 4853.708777473363, 4909.5090490950615, 4758.619310455225, 4778.331033655221, 4780.498047704941, 4781.7609119543185, 4817.349657796152, 4720.952790472052, 4741.952580474152, 4776.355192049029, 4803.3995750531185, 4849.102915960559, 4732.361131247238, 4755.262934245197, 4773.522647735199, 4777.8327758528285, 4778.211595086772], "value": 4575.629155791053, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.5102212097597, 571.2443904495077, 594.5422025040718, 608.969551522424, 616.1404840247851, 34783.47824782627, 36334.818325908396, 36337.0915727107, 36373.81813090938, 36412.0, 38212.0, 38897.61102388975, 38950.22099558007, 38967.0, 38984.22031559374, 7547.0566179227735, 7746.961265193694, 7748.1864404237585, 7755.302022817945, 7757.418193635472, 7762.45662803604, 7853.410994175431, 7867.0, 7891.8421631567335, 8053.476524025919, 8012.63943122558, 8085.757427277191, 8087.878681819748, 8088.919110808904, 8091.150429204937, 7997.0, 8039.598020098972, 8051.718189863327, 8055.63749631268, 8059.959700201462, 7901.446898717092, 7991.640376183086, 7997.840043199161, 8003.1996800320085, 8006.159353267882, 38822.22355552902, 39026.609733902864, 39302.410463843065, 39398.80300598507, 39416.0, 3148.386064717381, 3305.0910999475336, 3765.152840610868, 3910.5502867170353, 3952.1107750756137, 29784.40431191386, 30023.699763002307, 30122.24694382636, 30545.08364749061, 30997.690023099705, 3101.0, 3118.984405077983, 3173.5715678383585, 3224.4196044711944, 3291.127851119455, 247743.0, 248802.75598622073, 249755.0, 249902.0, 250586.0, 31351.372972540423, 31902.840485797424, 32093.839530802197, 32127.036188913902, 49749.50250497521, 32536.18659533483, 32637.347253054806, 32739.345213095603, 32768.0, 32773.50839737406, 13775.724485510234, 13967.930160349337, 13970.580882573538, 13970.580882573538, 13971.301434928213, 11627.709307267216, 11659.708507287216, 11686.532538698528, 11687.766244675058, 11705.531778728755, 8183.79540511492, 8195.0, 8223.383246256555, 8307.875381869277, 8321.292690121287, 3226.3547290541987, 3260.576125103769, 3261.9836900815817, 3270.2968861694376, 3340.7828491148, 927.2674587076269, 937.6999360204805, 964.1370972979145, 1008.5864795433837, 1046.4663021858755, 28511.287217819307, 28724.0, 29157.854210728812, 29358.853205734264, 29386.265343366587, 1014.573878970834, 1042.9061384475433, 1052.9631462898762, 1065.5151905882806, 1072.986028203356, 15256.847431525543, 15438.768418473732, 15500.689986200212, 15633.257482239549, 15709.607259818597, 336886.0, 340305.0, 344043.0, 344363.0, 344671.0, 51277.48722512727, 51877.481225187264, 51895.48104518982, 52142.739286303324, 52212.73893630583, 1178.4343515112794, 1269.57469247803, 1273.045216087934, 1278.213898452445, 1287.594407761552, 25095.0, 26798.330041748333, 27208.591871121553, 27230.5915411265, 27327.726722733314, 36303.0, 36577.45133823048, 36906.44640330344, 36952.0, 36967.630323696416, 226314.0, 229503.0, 230331.0, 230718.0, 231072.0, 21143.0, 23814.404639884142, 24116.758832412153, 24171.637425438985, 25750.227493175236, 36997.0, 37212.44181337336, 37356.439653404675, 37675.43486847645, 38242.808785955895, 32115.03654890357, 32417.51373729443, 32455.675443245265, 35526.111847204025, 35662.28675426529, 33668.83165584254, 34816.47775283423, 35155.29689406147, 35367.11582210465, 35503.0, 36734.8163259182, 36750.44874326941, 36820.447693284084, 37139.8143009294, 37162.44256336103, 35703.82148089243, 37799.81100094592, 39979.40030899481, 40594.59405406026, 40948.18103637851, 29912.25219369446, 30806.691933080383, 31287.687123129388, 31299.822188480284, 31347.529787053667], "value": 16355.604237767513, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.22779599107787, 390.6796426929917, 390.93275358271933, 392.67211878081804, 406.15722376069647, 15975.440859569917, 16547.58631034225, 16570.91714541427, 16587.336506539723, 16593.83406165938, 16993.150342482888, 17118.486445406626, 17694.203760830762, 17869.0, 17884.195211215494, 5062.822801201949, 5250.9474905250845, 5259.684418934857, 5281.788728450857, 5284.63007589467, 5066.79732810689, 5101.209312556541, 5222.791088356461, 5229.267902493654, 5230.7646155922885, 5168.974155129219, 5174.353205849269, 5179.352580927384, 5181.248718935752, 5208.5572726318305, 5168.948310516903, 5242.659227150242, 5528.778848846041, 5540.667559946396, 5540.944590554083, 5333.333333333333, 5334.839954801362, 5335.706536140511, 5339.679619222859, 5371.0, 19118.0, 19684.80315196844, 20425.0, 20639.69040464394, 20832.062557184963, 1787.4101546489758, 1986.513304240456, 2172.5220451500645, 2302.481941563152, 2494.538510375586, 8816.779580510474, 9077.63689452421, 9119.772005699844, 9737.902620973771, 9749.268804839594, 1633.7222672145763, 1707.1720215695502, 1723.3968111161118, 1726.533835864322, 1735.334079283889, 67928.98106528357, 71568.0, 71852.64073679598, 72294.63852680755, 74331.25668743298, 10272.9181245626, 10311.742206444898, 10376.835065305004, 10382.948085259526, 10385.948070259601, 14350.928245358706, 14381.92809035948, 14442.855571444361, 14451.78322325166, 14457.1325720455, 7272.56364618114, 7740.187280335596, 7747.922520774833, 7862.0, 7866.803329916684, 7326.267373262738, 7452.813679658052, 7491.513051651626, 7548.5470871747875, 7552.376239108618, 4334.393184954109, 4481.4174157359985, 4523.231050721385, 4572.634189264851, 4611.123886461562, 1841.9723704144449, 1851.6759567075708, 1895.2324308655018, 1904.5146084359767, 1918.6930091185343, 798.0861913109458, 851.5997481183833, 967.8983706710835, 968.4383057826444, 986.9605215791288, 16595.926138955474, 16720.318310872975, 17931.551711207325, 18364.63270734578, 18562.44312670622, 889.5241046040337, 948.7817801905462, 949.857521371786, 954.9665761698308, 956.6269155029544, 6899.724011039502, 9647.517624118766, 9790.75523111928, 9803.460809655395, 9858.831057167412, 395961.0, 408045.0, 413161.0, 413892.0, 417059.0, 77708.61145694235, 81748.18251817406, 81761.0, 82458.58770706109, 82905.0, 1015.3856916565519, 1076.2466273608504, 1088.6298658456162, 1097.4512743628186, 1106.7122548137543, 15032.473863414729, 15279.61800954985, 15329.77005344943, 15497.0, 15560.688786223986, 34340.313193735485, 34621.65378346285, 34681.13297167591, 35016.299674006885, 35724.28551429009, 45283.773581131885, 47473.52526474691, 50782.49217507778, 50924.23613645724, 50925.745371272904, 7063.081799366049, 7341.853162936604, 7344.559326440431, 7363.852722945404, 7492.850142997218, 10237.0, 11510.769784604428, 11593.594224202112, 11731.296122232694, 11779.0, 10064.094231519199, 10173.28786984904, 10286.434246116536, 10395.740106497398, 10399.064084232456, 9903.900960990299, 9995.800083998134, 10207.234457415576, 10227.795444090927, 10601.46992650349, 10067.69796906094, 10595.0, 10637.361758294526, 10672.359658420519, 10737.409442480739, 7768.495047821873, 7904.170062143392, 7935.682572697258, 7998.160193179632, 8064.112947575644, 7740.7677769667, 9463.290253231173, 9530.428174309287, 9591.9040809591, 9718.951405242928], "value": 8339.664106758615, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1332.4803326702581, 1472.5655931500203, 1510.9546713598588, 1615.8868879178463, 1806.087925597573, 6538.215414150302, 7514.3237108660205, 7731.806704832382, 7739.303462688357, 7747.845043099134, 7458.0, 7659.387249020079, 7662.808429789244, 7665.846683066349, 7669.079710434742, 2194.44041769349, 2210.049678638185, 2223.5330580578016, 2223.766504517019, 2225.310153852311, 2156.8382371322214, 2180.9890950545223, 2186.147402513021, 2195.0, 2200.8129309008755, 2210.756816750164, 2225.4770129019666, 2231.3529076567775, 2235.2400183937457, 2241.204372447782, 2146.0879126371306, 2155.892205389724, 2161.9783802161933, 2162.0378931375544, 2163.707899433572, 2126.202673997251, 2163.8377121715776, 2168.327818376308, 2172.934811955644, 2181.6727490876337, 7547.773566793005, 7664.73173438927, 7739.264769846855, 7742.070951485802, 7749.186335434754, 4483.574060464251, 4644.558766917137, 4661.254199328091, 4662.347271382009, 4665.6967297125575, 2827.2790438438064, 2835.2203144135324, 2863.0551917867056, 2907.113330434238, 2925.420273052549, 915.4461550761827, 929.7861491856843, 934.9439033657934, 946.186279799372, 960.6109525642056, 10337.276390652658, 10413.0, 10448.425336606484, 10448.68653940383, 10459.267851250415, 3997.9000524986527, 4018.598140185958, 4092.386142078712, 4116.300228961024, 4138.606832350982, 8240.13478584752, 8280.58597070144, 8293.83412331762, 8297.0, 8297.709580164787, 4485.842995495207, 4563.726176429424, 4572.1770081385, 4572.839950601713, 4578.954210457853, 3608.657177568127, 4014.397840323975, 4181.623653871166, 4192.538820729717, 4263.5736426357735, 3655.2689462107683, 3738.5513738351574, 3741.3452645787424, 3743.7005039596766, 3840.327942610032, 1200.8739082396398, 1212.2120621596034, 1219.2928101700993, 1222.6209874938797, 1223.7552489502136, 806.8789681547814, 836.3476488339105, 853.6628031927478, 868.6568805321863, 871.8648609465542, 4913.508649135058, 5086.389633243961, 5095.0, 5220.1908704150155, 5222.3472065991755, 956.1824639932896, 960.6637676813059, 988.9456079915674, 1000.7448100734266, 1027.2039169643585, 3401.5407919930494, 3410.6589341065696, 3497.283056973314, 3511.1924257420937, 3582.62382449839, 9158.129977652112, 9423.764405889908, 9462.29032822541, 9555.856662150074, 9558.713238602853, 9229.53852307382, 9428.245740340757, 9441.952790236142, 9456.14894659484, 9575.569099390405, 7224.819379515449, 7331.78004659861, 7362.079740032496, 7427.7771666850085, 7437.293457121565, 5063.265826455217, 5121.590272778094, 5137.126688462896, 5203.73981300941, 5256.9211461827335, 8751.69369072105, 8769.956150219208, 8824.98512671051, 8946.463212207289, 9072.455652660861, 8838.823223535623, 8975.820483590422, 8992.100789920956, 9129.45223286605, 9169.816603668023, 5540.833774986757, 5723.399043100415, 5733.655980641175, 6200.3179650239335, 6314.179156709598, 6721.932780672326, 7157.141143062658, 7350.19147893742, 7361.411087113125, 7403.8149046274275, 6553.311902250195, 6776.15298087739, 6806.693698783665, 6878.931210687829, 6893.276205998499, 6573.9810329399015, 6575.27671956094, 6577.6053436793945, 6616.603003819786, 6642.667866606747, 6036.698165091816, 6118.326984031664, 6119.051547010221, 6124.112003759519, 6204.13142160107, 4399.934000989923, 4426.579474950004, 4628.907421851612, 4672.299155126622, 4687.2031754602485, 4548.47692515365, 4601.976990115028, 4646.070785842778, 4690.085433340466, 4734.692245004201], "value": 4108.817236217347, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.2793790468209, 313.4107877190881, 319.1797081500543, 319.18289179699957, 321.6927833918608, 4598.931016034762, 4657.091867085919, 4708.246680531116, 4708.835190768324, 4710.152172608929, 4576.427946506687, 4624.421947256593, 4631.745254011028, 4634.58288754012, 4641.675082744209, 3515.156362473014, 3605.7115430765607, 3650.142216579115, 3666.0, 3668.7798732076026, 3584.4802503636956, 3674.50394196784, 3746.756460830051, 3763.008408315382, 3767.717421193408, 3636.2545678136053, 3703.925921481582, 3718.5537735471644, 3722.1066943933397, 3737.663610275075, 3583.8387272572795, 3691.6123807000417, 3710.3692372296505, 3718.3307004739136, 3740.7942563159017, 3322.4684050551796, 3329.8002119872885, 3331.766776325658, 3337.8664853405835, 3348.4809854472596, 4465.24090904547, 4466.3523789050405, 4471.6646251531265, 4480.820767169309, 4510.413646226002, 3994.6404823566018, 4139.81370838313, 4182.581741825824, 4188.685848561339, 4230.0, 4848.127337079324, 4867.9269810952865, 4875.195592727196, 4882.828121250875, 4888.584470319992, 3540.522029526007, 3545.929081418383, 3546.545916174356, 3548.1307079765365, 3549.236914063463, 5008.449070602231, 5050.166722490784, 5070.822521211777, 5106.15748401517, 5143.730703516073, 3606.8376923038527, 3608.909777255537, 3612.259486805199, 3616.855325786939, 3618.203995121069, 3662.1393972416463, 3665.0, 3668.174660701321, 3668.486411902336, 3670.8164591770305, 4163.437935878617, 4178.916421671611, 4196.866845951637, 4198.64311533517, 4206.317473010759, 4626.057056036473, 4913.557779799835, 4917.729524876095, 4925.21196608541, 4992.650514464025, 1301.8478646398005, 1305.928173950423, 1308.1104848702973, 1310.7902735562263, 1321.2666969831644, 868.4789126524036, 878.1569693094573, 890.25663570919, 893.0756666849909, 915.1214833759665, 4148.896277593024, 4255.723377980421, 4262.595053469915, 4284.850030248988, 4292.356146577976, 4852.490488498727, 5003.574696150795, 5063.544281014726, 5114.462981386975, 5137.614678899097, 4347.130573885235, 4383.211022016004, 4405.713628614129, 4410.095930334273, 4416.1830061438095, 2718.7417195366406, 2861.4420188063127, 2866.269101379135, 2874.7782192568075, 2874.9712502874704, 5061.240813877874, 5079.111155547765, 5095.363079615048, 5122.282880396748, 5127.230915362651, 5365.678059316453, 5550.361708403585, 5555.388907220203, 5563.777448902079, 5578.135389014709, 5091.974540127276, 5108.872278193001, 5115.7953681852305, 5121.385433747974, 5136.897262054738, 5401.864953376197, 5414.566834653139, 5421.728913554228, 5456.290682211287, 5470.589705772003, 5188.481151884932, 5359.62482626228, 5364.38309594386, 5369.973150134224, 5385.515303622693, 5086.440491546001, 5099.980003999289, 5100.903305789125, 5115.437301896863, 5117.822900732778, 3837.3668344723924, 3891.902702432462, 3923.7645741255615, 3938.8818335449982, 3939.113699417608, 5196.72606258055, 5322.973385133049, 5323.680579165262, 5333.0, 5334.599905007062, 5133.563647090039, 5149.279100925798, 5152.175651895679, 5155.819546315861, 5159.122949098737, 5125.564327032244, 5136.948630513647, 5142.76857541404, 5146.639735218499, 5167.61242906791, 4859.878503037452, 5048.167052436307, 5051.318072060371, 5101.6173786966865, 5105.366282789471, 4644.863362853125, 4676.883077923079, 4919.139150648693, 5135.537801597874, 5157.277981082727, 4822.638302127425, 4825.396825396825, 4859.3682821233015, 4864.659473836798, 4873.6832105913], "value": 3808.023505360914, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [771.22106672261, 776.115228639351, 785.4305628419397, 811.7645882694019, 822.5270469480049, 11059.2258541902, 11584.18910676253, 11606.36165010924, 11608.651740447778, 11672.007879330256, 11570.421478926062, 11775.470103845326, 11842.11184161187, 11862.703432414193, 12519.874801251985, 860.7718954477053, 864.7621903976425, 866.8483015472299, 872.1932212703224, 873.3013589128703, 836.4270474724802, 844.4511067805914, 848.3552500099937, 849.5539841583156, 850.4344610833788, 906.8957069936976, 907.6006557114848, 908.8409528332548, 909.4088842252522, 909.8316811389881, 904.0326850270213, 904.9185573298369, 905.2531661379355, 905.3391024552081, 905.9184673379394, 658.2002866517157, 658.8945768676989, 659.024643527577, 659.9670016499156, 660.3198705333514, 11349.375784331858, 11383.772324553462, 11387.0, 11409.315441073479, 11444.71388215293, 10734.141268698486, 10888.564457421693, 10894.0, 10928.836067458995, 10966.342019478778, 9269.935385028648, 9379.531023448868, 9453.33826632136, 9559.761005974837, 9605.135537801561, 3039.6808335124715, 3120.1731541141617, 3128.937421251585, 3142.073088438916, 3145.874165033396, 32012.519812202834, 35260.0, 36439.27121457583, 40563.59436405598, 43193.784031079646, 10231.43727095002, 10394.0, 10394.948025259977, 10404.271700980858, 10593.57625694979, 17617.38339158149, 17661.470155895342, 17664.293428262983, 17667.38164164248, 17675.11624418774, 5885.588008839341, 6114.0, 6116.908246376308, 6895.724171033203, 6908.861822763517, 3777.225668737902, 3885.6502914737807, 3914.72596918213, 3916.412538119305, 4019.618136277049, 2878.784091193169, 2949.601803756508, 2957.497225471675, 2971.390864872696, 2979.3892252088704, 495.9851204463872, 508.8244555628302, 513.1456125550916, 515.2245869965677, 527.0065925730026, 558.3969313141797, 562.5049956038741, 578.12702818744, 579.9217105690763, 590.645612632417, 7409.147947985943, 7552.207018263113, 7564.621768911533, 7598.582077985764, 7612.352949999312, 490.5633985752683, 558.0039629261748, 601.1583782704162, 604.9818505444756, 610.789277699202, 3391.423458012144, 3430.0, 3442.4836274559016, 3461.3250416168607, 3571.4107172316794, 41452.1709565813, 43236.56763432388, 49666.0, 49706.254406183936, 49920.50079499231, 43582.34626480605, 45448.318275225894, 45782.31326530105, 46632.0, 46913.29630055552, 42483.57516424858, 42649.0, 42668.78665606652, 42991.35512967308, 43331.13337733291, 6516.348365163446, 6531.836704082246, 6532.0, 6641.933580664325, 6745.055692203194, 28828.42343153167, 29119.126426207247, 29620.407591848474, 29744.256393590334, 30268.519120301447, 35435.29129417449, 35499.64500354963, 37787.24425511529, 38019.61980380161, 38620.80689596534, 9463.337566370288, 9594.18449431806, 9653.131218190396, 9656.130948214695, 9740.488813144966, 9495.857562136436, 9698.709038728568, 9975.700728978143, 9983.800323993624, 10360.326578772356, 9110.635574576943, 9152.450852948845, 9170.312226582899, 9461.33770636049, 9726.124648781644, 9191.126842949909, 9248.537573121452, 9317.208037316634, 9434.695524797477, 10026.64906728261, 8629.56852157377, 8653.264472519906, 8656.91343086561, 8996.460212387277, 9621.711348659552, 7831.84336313282, 8119.83760324802, 8170.264676178935, 8364.916350836656, 8426.536540490331, 7747.055300459264, 8144.511329320259, 8210.261076503144, 8301.46040507365, 8427.452215605967], "value": 5648.070403240696, "unit": "score"}], "name": "dromaeo_css", "value": 6169.809056881584, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 107.0, 112.0, 113.0, 113.0, 104.0, 114.0, 113.0, 114.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 132.0, 159.0, 179.0, 136.0, 159.0, 157.0, 134.0, 199.0, 140.0], "value": 155.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 162.0, 161.0, 161.0, 161.0, 164.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 115.0, 115.0, 73.0, 74.0, 74.0, 109.0, 111.0, 74.0], "value": 89.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 149.0, 94.0, 94.0, 94.0, 146.0, 93.0, 94.0, 146.0], "value": 109.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 67.0, 67.0, 67.0, 68.0, 83.0, 65.0, 63.0], "value": 67.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 80.0, 87.0, 82.0, 82.0, 82.0, 84.0, 86.0, 82.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 140.0, 135.0, 140.0, 140.0, 129.0, 131.0, 130.0, 162.0, 133.0], "value": 138.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 179.0, 181.0, 179.0, 185.0, 179.0, 175.0, 178.0, 182.0, 180.0], "value": 180.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 74.0, 73.0, 73.0, 73.0, 73.0, 74.0, 72.0], "value": 73.8, "unit": "score"}], "name": "kraken", "value": 1593.8000000000002, "alertThreshold": 2.0}]} 12:56:19 INFO - Return code: 0 12:56:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:56:19 ERROR - # TBPL SUCCESS # 12:56:19 INFO - Running post-action listener: _resource_record_post_action 12:56:19 INFO - Running post-run listener: _resource_record_post_run 12:56:20 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 518709248; Read time: 12; Write time: 462424 12:56:20 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234876928; Read time: 0; Write time: 271952 12:56:20 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283832320; Read time: 12; Write time: 190472 12:56:20 INFO - Running post-run listener: _upload_blobber_files 12:56:20 INFO - Blob upload gear active. 12:56:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:56:20 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:56:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:56:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:56:20 INFO - (blobuploader) - INFO - Open directory for files ... 12:56:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:56:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:56:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:56:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:56:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:56:21 INFO - (blobuploader) - INFO - Done attempting. 12:56:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:56:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:56:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:56:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:56:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:56:22 INFO - (blobuploader) - INFO - Done attempting. 12:56:22 INFO - (blobuploader) - INFO - Iteration through files over. 12:56:22 INFO - Return code: 0 12:56:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:56:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:56:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0583c77d024fc03dc9666dd550f3b04bd9ea4200bfe86366b05eb250d9a3d957971bf64735289c56a1ad005bead86c2bfa3388ce617ace37e339335ce5748d60", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/66fa02a25f598093587f514d5cdcb5bbc7ac574529c9976d1dd6ac4538e203822a30ca6a2475ff99c1118c881c7358ae5351fb1ac9cf76ede9af073167fc667c"} 12:56:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:56:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:56:22 INFO - Contents: 12:56:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0583c77d024fc03dc9666dd550f3b04bd9ea4200bfe86366b05eb250d9a3d957971bf64735289c56a1ad005bead86c2bfa3388ce617ace37e339335ce5748d60", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/66fa02a25f598093587f514d5cdcb5bbc7ac574529c9976d1dd6ac4538e203822a30ca6a2475ff99c1118c881c7358ae5351fb1ac9cf76ede9af073167fc667c"} 12:56:22 INFO - Running post-run listener: copy_logs_to_upload_dir 12:56:22 INFO - Copying logs to upload dir... 12:56:22 INFO - mkdir: /builds/slave/test/build/upload/logs 12:56:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.078374 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-05 12:56:21.537893) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 12:56:21.541956) ========= 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=232498196343f89f466a4a9a000001c8-1462474417.984151-1032471659 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/0583c77d024fc03dc9666dd550f3b04bd9ea4200bfe86366b05eb250d9a3d957971bf64735289c56a1ad005bead86c2bfa3388ce617ace37e339335ce5748d60", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/66fa02a25f598093587f514d5cdcb5bbc7ac574529c9976d1dd6ac4538e203822a30ca6a2475ff99c1118c881c7358ae5351fb1ac9cf76ede9af073167fc667c"} build_url:https://queue.taskcluster.net/v1/task/ZZwjP165TSSgEJAQDqUmNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011207 build_url: 'https://queue.taskcluster.net/v1/task/ZZwjP165TSSgEJAQDqUmNA/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/0583c77d024fc03dc9666dd550f3b04bd9ea4200bfe86366b05eb250d9a3d957971bf64735289c56a1ad005bead86c2bfa3388ce617ace37e339335ce5748d60", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/66fa02a25f598093587f514d5cdcb5bbc7ac574529c9976d1dd6ac4538e203822a30ca6a2475ff99c1118c881c7358ae5351fb1ac9cf76ede9af073167fc667c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 12:56:21.567382) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 12:56:21.567745) ========= 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=232498196343f89f466a4a9a000001c8-1462474417.984151-1032471659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004327 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 12:56:21.653813) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 12:56:21.654276) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 12:56:21.654814) ========= ========= Total master_lag: 0.16 =========