builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-062 starttime: 1460803095.62 results: success (0) buildid: 20160416022721 builduid: 39a090301730434491ce63017de2658c revision: 19d56ca9e3f5078dba44230ac3ec0718cc029b70 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-16 03:38:15.623254) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-16 03:38:15.623722) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-16 03:38:15.624039) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-16 03:38:15.682867) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 03:38:15.683182) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1460802939.897490-626456260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-16 03:38:15-- 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% 227M=0s 2016-04-16 03:38:15 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.179993 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 03:38:15.885024) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 03:38:15.885347) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1460802939.897490-626456260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.129944 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 03:38:16.026493) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 03:38:16.026996) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 19d56ca9e3f5078dba44230ac3ec0718cc029b70 --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 19d56ca9e3f5078dba44230ac3ec0718cc029b70 --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=a4ce256d2ec601f24a60a71e000001bc-1460802939.897490-626456260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-16 03:38:16,102 truncating revision to first 12 chars 2016-04-16 03:38:16,102 Setting DEBUG logging. 2016-04-16 03:38:16,102 attempt 1/10 2016-04-16 03:38:16,102 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/19d56ca9e3f5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-16 03:38:16,376 unpacking tar archive at: fx-team-19d56ca9e3f5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.548627 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 03:38:16.588017) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-16 03:38:16.588348) ========= script_repo_revision: 19d56ca9e3f5078dba44230ac3ec0718cc029b70 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-16 03:38:16.588734) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-16 03:38:16.589082) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-16 03:38:16.599230) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-04-16 03:38:16.599553) ========= /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=a4ce256d2ec601f24a60a71e000001bc-1460802939.897490-626456260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:38:16 INFO - MultiFileLogger online at 20160416 03:38:16 in /builds/slave/test 03:38:16 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 03:38:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:38:16 INFO - {'append_to_log': False, 03:38:16 INFO - 'base_work_dir': '/builds/slave/test', 03:38:16 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:38:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:38:16 INFO - 'branch': 'Fx-Team-Non-PGO', 03:38:16 INFO - 'buildbot_json_path': 'buildprops.json', 03:38:16 INFO - 'config_files': ('talos/linux_config.py',), 03:38:16 INFO - 'default_actions': ('clobber', 03:38:16 INFO - 'read-buildbot-config', 03:38:16 INFO - 'download-and-extract', 03:38:16 INFO - 'populate-webroot', 03:38:16 INFO - 'create-virtualenv', 03:38:16 INFO - 'install', 03:38:16 INFO - 'run-tests'), 03:38:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:38:16 INFO - 'download_minidump_stackwalk': True, 03:38:16 INFO - 'download_symbols': 'ondemand', 03:38:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:38:16 INFO - 'tooltool.py': '/tools/tooltool.py', 03:38:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:38:16 INFO - '/tools/misc-python/virtualenv.py')}, 03:38:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:38:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:38:16 INFO - 'installer_path': 'installer.exe', 03:38:16 INFO - 'log_level': 'info', 03:38:16 INFO - 'log_name': 'talos', 03:38:16 INFO - 'log_to_console': True, 03:38:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:38:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:38:16 INFO - 'opt_config_files': (), 03:38:16 INFO - 'pip_index': False, 03:38:16 INFO - 'sps_profile': False, 03:38:16 INFO - 'sps_profile_interval': 0, 03:38:16 INFO - 'suite': 'dromaeojs', 03:38:16 INFO - 'system_bits': '32', 03:38:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:38:16 INFO - 'title': 'talos-linux64-ix-062', 03:38:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:38:16 INFO - 'use_talos_json': True, 03:38:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:38:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:38:16 INFO - 'work_dir': 'build'} 03:38:16 INFO - ##### 03:38:16 INFO - ##### Running clobber step. 03:38:16 INFO - ##### 03:38:16 INFO - Running pre-action listener: _resource_record_pre_action 03:38:16 INFO - Running main action method: clobber 03:38:16 INFO - rmtree: /builds/slave/test/build 03:38:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:38:19 INFO - Running post-action listener: _resource_record_post_action 03:38:19 INFO - ##### 03:38:19 INFO - ##### Running read-buildbot-config step. 03:38:19 INFO - ##### 03:38:19 INFO - Running pre-action listener: _resource_record_pre_action 03:38:19 INFO - Running main action method: read_buildbot_config 03:38:19 INFO - Using buildbot properties: 03:38:19 INFO - { 03:38:19 INFO - "project": "", 03:38:19 INFO - "product": "firefox", 03:38:19 INFO - "script_repo_revision": "production", 03:38:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 03:38:19 INFO - "repository": "", 03:38:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 03:38:19 INFO - "buildid": "20160416022721", 03:38:19 INFO - "pgo_build": "False", 03:38:19 INFO - "basedir": "/builds/slave/test", 03:38:19 INFO - "buildnumber": 1570, 03:38:19 INFO - "slavename": "talos-linux64-ix-062", 03:38:19 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:38:19 INFO - "platform": "ubuntu64_hw", 03:38:19 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:38:19 INFO - "branch": "fx-team", 03:38:19 INFO - "repo_path": "integration/fx-team", 03:38:19 INFO - "revision": "19d56ca9e3f5078dba44230ac3ec0718cc029b70", 03:38:19 INFO - "stage_platform": "linux64", 03:38:19 INFO - "builduid": "39a090301730434491ce63017de2658c", 03:38:19 INFO - "slavebuilddir": "test" 03:38:19 INFO - } 03:38:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/K_2XnYfSSUmzZrMz0BELFw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 03:38:19 INFO - Running post-action listener: _resource_record_post_action 03:38:19 INFO - ##### 03:38:19 INFO - ##### Running download-and-extract step. 03:38:19 INFO - ##### 03:38:19 INFO - Running pre-action listener: _resource_record_pre_action 03:38:19 INFO - Running main action method: download_and_extract 03:38:19 INFO - mkdir: /builds/slave/test/build/tests 03:38:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:19 INFO - https://queue.taskcluster.net/v1/task/K_2XnYfSSUmzZrMz0BELFw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:38:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_2XnYfSSUmzZrMz0BELFw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 03:38:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_2XnYfSSUmzZrMz0BELFw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 03:38:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_2XnYfSSUmzZrMz0BELFw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 03:38:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_2XnYfSSUmzZrMz0BELFw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:38:24 INFO - Downloaded 1361 bytes. 03:38:24 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 03:38:24 INFO - Using the following test package requirements: 03:38:24 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 03:38:24 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:38:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:38:24 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:38:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:38:24 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:38:24 INFO - u'jsshell-linux-x86_64.zip'], 03:38:24 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:38:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:38:24 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 03:38:24 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:38:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:38:24 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:38:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:38:24 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:38:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:38:24 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:38:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:38:24 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:38:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:24 INFO - https://queue.taskcluster.net/v1/task/K_2XnYfSSUmzZrMz0BELFw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:38:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_2XnYfSSUmzZrMz0BELFw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:38:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_2XnYfSSUmzZrMz0BELFw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:38:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_2XnYfSSUmzZrMz0BELFw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:38:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_2XnYfSSUmzZrMz0BELFw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:38:30 INFO - Downloaded 22203703 bytes. 03:38:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:38:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:38:32 INFO - Return code: 0 03:38:32 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:38:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:32 INFO - https://queue.taskcluster.net/v1/task/K_2XnYfSSUmzZrMz0BELFw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:38:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_2XnYfSSUmzZrMz0BELFw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:38:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_2XnYfSSUmzZrMz0BELFw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:38:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_2XnYfSSUmzZrMz0BELFw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:38:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_2XnYfSSUmzZrMz0BELFw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:38:37 INFO - Downloaded 22203703 bytes. 03:38:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:38:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:38:38 INFO - Return code: 0 03:38:38 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')]} 03:38:38 INFO - https://queue.taskcluster.net/v1/task/K_2XnYfSSUmzZrMz0BELFw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:38:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_2XnYfSSUmzZrMz0BELFw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 03:38:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_2XnYfSSUmzZrMz0BELFw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 03:38:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_2XnYfSSUmzZrMz0BELFw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 03:38:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_2XnYfSSUmzZrMz0BELFw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:38:39 INFO - Downloaded 10841076 bytes. 03:38:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:38:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:38:40 INFO - Return code: 0 03:38:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:40 INFO - https://queue.taskcluster.net/v1/task/K_2XnYfSSUmzZrMz0BELFw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:38:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_2XnYfSSUmzZrMz0BELFw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:38:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_2XnYfSSUmzZrMz0BELFw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:38:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_2XnYfSSUmzZrMz0BELFw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:38:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_2XnYfSSUmzZrMz0BELFw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:38:41 INFO - Downloaded 54443711 bytes. 03:38:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K_2XnYfSSUmzZrMz0BELFw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:38:41 INFO - mkdir: /builds/slave/test/properties 03:38:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:38:41 INFO - Writing to file /builds/slave/test/properties/build_url 03:38:41 INFO - Contents: 03:38:41 INFO - build_url:https://queue.taskcluster.net/v1/task/K_2XnYfSSUmzZrMz0BELFw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:38:42 INFO - Running post-action listener: _resource_record_post_action 03:38:42 INFO - Running post-action listener: set_extra_try_arguments 03:38:42 INFO - ##### 03:38:42 INFO - ##### Running populate-webroot step. 03:38:42 INFO - ##### 03:38:42 INFO - Running pre-action listener: _resource_record_pre_action 03:38:42 INFO - Running main action method: populate_webroot 03:38:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:38:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:38:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:38:42 INFO - '--tppagecycles', 03:38:42 INFO - '7'], 03:38:42 INFO - 'tests': ['tsvgm']}}, 03:38:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:38:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:38:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:38:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:38:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:38:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:38:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:42 INFO - 'talos_options': ['--disable-e10s'], 03:38:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:38:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:38:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:42 INFO - 'talos_options': ['--disable-e10s'], 03:38:42 INFO - 'tests': ['damp', 'tps']}, 03:38:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:42 INFO - 'tests': ['damp', 'tps']}, 03:38:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:38:42 INFO - 'tests': ['dromaeo_dom']}, 03:38:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:38:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:38:42 INFO - 'tests': ['a11yr', 03:38:42 INFO - 'ts_paint', 03:38:42 INFO - 'tpaint', 03:38:42 INFO - 'sessionrestore', 03:38:42 INFO - 'sessionrestore_no_auto_restore', 03:38:42 INFO - 'tabpaint']}, 03:38:42 INFO - 'other-e10s': {'tests': ['a11yr', 03:38:42 INFO - 'ts_paint', 03:38:42 INFO - 'tpaint', 03:38:42 INFO - 'sessionrestore', 03:38:42 INFO - 'sessionrestore_no_auto_restore', 03:38:42 INFO - 'tabpaint']}, 03:38:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:38:42 INFO - 'ts_paint', 03:38:42 INFO - 'tpaint', 03:38:42 INFO - 'sessionrestore', 03:38:42 INFO - 'sessionrestore_no_auto_restore', 03:38:42 INFO - 'tabpaint']}, 03:38:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:38:42 INFO - 'ts_paint', 03:38:42 INFO - 'tpaint', 03:38:42 INFO - 'sessionrestore', 03:38:42 INFO - 'sessionrestore_no_auto_restore', 03:38:42 INFO - 'tabpaint']}, 03:38:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:38:42 INFO - 'tests': ['a11yr', 03:38:42 INFO - 'ts_paint', 03:38:42 INFO - 'tpaint', 03:38:42 INFO - 'sessionrestore', 03:38:42 INFO - 'sessionrestore_no_auto_restore', 03:38:42 INFO - 'tabpaint']}, 03:38:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:38:42 INFO - 'tests': ['a11yr', 03:38:42 INFO - 'ts_paint', 03:38:42 INFO - 'tpaint', 03:38:42 INFO - 'sessionrestore', 03:38:42 INFO - 'sessionrestore_no_auto_restore', 03:38:42 INFO - 'tabpaint']}, 03:38:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:38:42 INFO - 'tests': ['tsvgx', 03:38:42 INFO - 'tsvgr_opacity', 03:38:42 INFO - 'tart', 03:38:42 INFO - 'tscrollx', 03:38:42 INFO - 'cart']}, 03:38:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:38:42 INFO - 'tsvgr_opacity', 03:38:42 INFO - 'tart', 03:38:42 INFO - 'tscrollx', 03:38:42 INFO - 'cart']}, 03:38:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:42 INFO - 'talos_options': ['--disable-e10s'], 03:38:42 INFO - 'tests': ['tp5o']}, 03:38:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:42 INFO - 'tests': ['tp5o']}, 03:38:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:42 INFO - 'talos_options': ['--disable-e10s', 03:38:42 INFO - '--xperf_path', 03:38:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:38:42 INFO - 'tests': ['tp5n']}, 03:38:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:42 INFO - 'talos_options': ['--xperf_path', 03:38:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:38:42 INFO - 'tests': ['tp5n']}}, 03:38:42 INFO - 'talos.zip': {'path': '', 03:38:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:38:42 INFO - Running post-action listener: _resource_record_post_action 03:38:42 INFO - ##### 03:38:42 INFO - ##### Running create-virtualenv step. 03:38:42 INFO - ##### 03:38:42 INFO - Running pre-action listener: _resource_record_pre_action 03:38:42 INFO - Running main action method: create_virtualenv 03:38:42 INFO - Creating virtualenv /builds/slave/test/build/venv 03:38:42 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:38:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:38:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:38:42 INFO - Using real prefix '/usr' 03:38:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:38:43 INFO - Installing distribute.............................................................................................................................................................................................done. 03:38:45 INFO - Installing pip.................done. 03:38:45 INFO - Return code: 0 03:38:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:38:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9a7af4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272e410>, '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 0x272f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272f7a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1460802939.897490-626456260', '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 03:38:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:38:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:38:45 INFO - Using env: {'DISPLAY': ':0', 03:38:45 INFO - 'HOME': '/home/cltbld', 03:38:45 INFO - 'LANG': 'en_US.UTF-8', 03:38:45 INFO - 'LANGUAGE': 'en_US:en', 03:38:45 INFO - 'LOGNAME': 'cltbld', 03:38:45 INFO - 'MAIL': '/var/mail/cltbld', 03:38:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:45 INFO - 'MOZ_NO_REMOTE': '1', 03:38:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:45 INFO - 'NO_EM_RESTART': '1', 03:38:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:45 INFO - 'PWD': '/builds/slave/test', 03:38:45 INFO - 'SHELL': '/bin/bash', 03:38:45 INFO - 'SHLVL': '1', 03:38:45 INFO - 'TERM': 'linux', 03:38:45 INFO - 'TMOUT': '86400', 03:38:45 INFO - 'USER': 'cltbld', 03:38:45 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1460802939.897490-626456260', 03:38:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:45 INFO - '_': '/tools/buildbot/bin/python'} 03:38:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:46 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 03:38:46 INFO - Cleaning up... 03:38:46 INFO - Return code: 0 03:38:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:38:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:46 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 0x7fd9a7af4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272e410>, '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 0x272f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272f7a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1460802939.897490-626456260', '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 03:38:46 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 03:38:46 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 03:38:46 INFO - Using env: {'DISPLAY': ':0', 03:38:46 INFO - 'HOME': '/home/cltbld', 03:38:46 INFO - 'LANG': 'en_US.UTF-8', 03:38:46 INFO - 'LANGUAGE': 'en_US:en', 03:38:46 INFO - 'LOGNAME': 'cltbld', 03:38:46 INFO - 'MAIL': '/var/mail/cltbld', 03:38:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:46 INFO - 'MOZ_NO_REMOTE': '1', 03:38:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:46 INFO - 'NO_EM_RESTART': '1', 03:38:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:46 INFO - 'PWD': '/builds/slave/test', 03:38:46 INFO - 'SHELL': '/bin/bash', 03:38:46 INFO - 'SHLVL': '1', 03:38:46 INFO - 'TERM': 'linux', 03:38:46 INFO - 'TMOUT': '86400', 03:38:46 INFO - 'USER': 'cltbld', 03:38:46 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1460802939.897490-626456260', 03:38:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:46 INFO - '_': '/tools/buildbot/bin/python'} 03:38:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:46 INFO - Downloading/unpacking psutil>=0.7.1 03:38:46 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 03:38:46 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 03:38:46 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 03:38:46 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 03:38:46 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 03:38:46 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 03:38:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:38:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:38:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:38:48 INFO - Installing collected packages: psutil 03:38:48 INFO - Running setup.py install for psutil 03:38:48 INFO - building 'psutil._psutil_linux' extension 03:38:48 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 03:38:50 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 03:38:50 INFO - building 'psutil._psutil_posix' extension 03:38:50 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 03:38:51 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 03:38:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:38:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:38:51 INFO - Successfully installed psutil 03:38:51 INFO - Cleaning up... 03:38:51 INFO - Return code: 0 03:38:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:38:51 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')]} 03:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:51 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')]} 03:38:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:51 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 0x7fd9a7af4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272e410>, '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 0x272f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272f7a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1460802939.897490-626456260', '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 03:38:51 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 03:38:51 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 03:38:51 INFO - Using env: {'DISPLAY': ':0', 03:38:51 INFO - 'HOME': '/home/cltbld', 03:38:51 INFO - 'LANG': 'en_US.UTF-8', 03:38:51 INFO - 'LANGUAGE': 'en_US:en', 03:38:51 INFO - 'LOGNAME': 'cltbld', 03:38:51 INFO - 'MAIL': '/var/mail/cltbld', 03:38:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:51 INFO - 'MOZ_NO_REMOTE': '1', 03:38:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:51 INFO - 'NO_EM_RESTART': '1', 03:38:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:51 INFO - 'PWD': '/builds/slave/test', 03:38:51 INFO - 'SHELL': '/bin/bash', 03:38:51 INFO - 'SHLVL': '1', 03:38:51 INFO - 'TERM': 'linux', 03:38:51 INFO - 'TMOUT': '86400', 03:38:51 INFO - 'USER': 'cltbld', 03:38:51 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1460802939.897490-626456260', 03:38:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:51 INFO - '_': '/tools/buildbot/bin/python'} 03:38:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:38:51 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 03:38:51 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 03:38:51 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 03:38:51 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 03:38:51 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 03:38:51 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 03:38:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:38:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:38:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:38:53 INFO - Installing collected packages: mozsystemmonitor 03:38:53 INFO - Running setup.py install for mozsystemmonitor 03:38:53 INFO - Successfully installed mozsystemmonitor 03:38:53 INFO - Cleaning up... 03:38:53 INFO - Return code: 0 03:38:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:38: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')]} 03:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38: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')]} 03:38:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:53 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 0x7fd9a7af4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272e410>, '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 0x272f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272f7a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1460802939.897490-626456260', '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 03:38:53 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 03:38:53 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 03:38:53 INFO - Using env: {'DISPLAY': ':0', 03:38:53 INFO - 'HOME': '/home/cltbld', 03:38:53 INFO - 'LANG': 'en_US.UTF-8', 03:38:53 INFO - 'LANGUAGE': 'en_US:en', 03:38:53 INFO - 'LOGNAME': 'cltbld', 03:38:53 INFO - 'MAIL': '/var/mail/cltbld', 03:38:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:53 INFO - 'MOZ_NO_REMOTE': '1', 03:38:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:53 INFO - 'NO_EM_RESTART': '1', 03:38:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:53 INFO - 'PWD': '/builds/slave/test', 03:38:53 INFO - 'SHELL': '/bin/bash', 03:38:53 INFO - 'SHLVL': '1', 03:38:53 INFO - 'TERM': 'linux', 03:38:53 INFO - 'TMOUT': '86400', 03:38:53 INFO - 'USER': 'cltbld', 03:38:53 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1460802939.897490-626456260', 03:38:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:53 INFO - '_': '/tools/buildbot/bin/python'} 03:38:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:53 INFO - Downloading/unpacking blobuploader==1.2.4 03:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:55 INFO - Downloading blobuploader-1.2.4.tar.gz 03:38:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:38:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:38:55 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 03:38:55 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 03:38:55 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 03:38:55 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 03:38:55 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 03:38:55 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 03:38:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:38:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:38:56 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 03:38:56 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 03:38:56 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 03:38:56 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 03:38:56 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 03:38:56 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 03:38:56 INFO - Downloading docopt-0.6.1.tar.gz 03:38:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:38:56 INFO - Installing collected packages: blobuploader, requests, docopt 03:38:56 INFO - Running setup.py install for blobuploader 03:38:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:38:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:38:56 INFO - Running setup.py install for requests 03:38:56 INFO - Running setup.py install for docopt 03:38:56 INFO - Successfully installed blobuploader requests docopt 03:38:56 INFO - Cleaning up... 03:38:57 INFO - Return code: 0 03:38:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:38:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:57 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 0x7fd9a7af4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272e410>, '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 0x272f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272f7a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1460802939.897490-626456260', '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 03:38:57 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 03:38:57 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 03:38:57 INFO - Using env: {'DISPLAY': ':0', 03:38:57 INFO - 'HOME': '/home/cltbld', 03:38:57 INFO - 'LANG': 'en_US.UTF-8', 03:38:57 INFO - 'LANGUAGE': 'en_US:en', 03:38:57 INFO - 'LOGNAME': 'cltbld', 03:38:57 INFO - 'MAIL': '/var/mail/cltbld', 03:38:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:57 INFO - 'MOZ_NO_REMOTE': '1', 03:38:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:57 INFO - 'NO_EM_RESTART': '1', 03:38:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:57 INFO - 'PWD': '/builds/slave/test', 03:38:57 INFO - 'SHELL': '/bin/bash', 03:38:57 INFO - 'SHLVL': '1', 03:38:57 INFO - 'TERM': 'linux', 03:38:57 INFO - 'TMOUT': '86400', 03:38:57 INFO - 'USER': 'cltbld', 03:38:57 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1460802939.897490-626456260', 03:38:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:57 INFO - '_': '/tools/buildbot/bin/python'} 03:38:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:38:57 INFO - Running setup.py (path:/tmp/pip-Hpk7dK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:38:57 INFO - Running setup.py (path:/tmp/pip-BDK6B9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:38:57 INFO - Running setup.py (path:/tmp/pip-JCNIJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:38:57 INFO - Running setup.py (path:/tmp/pip-PIJZcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:38:57 INFO - Running setup.py (path:/tmp/pip-qOWLZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:38:57 INFO - Running setup.py (path:/tmp/pip-lZo3m9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:38:57 INFO - Running setup.py (path:/tmp/pip-p_CBM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:38:57 INFO - Running setup.py (path:/tmp/pip-aIdkOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:38:57 INFO - Running setup.py (path:/tmp/pip-PDpYMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:38:57 INFO - Running setup.py (path:/tmp/pip-92GFn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:38:57 INFO - Running setup.py (path:/tmp/pip-KGqBAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:38:58 INFO - Running setup.py (path:/tmp/pip-Lv8M6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:38:58 INFO - Running setup.py (path:/tmp/pip-X2vNLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:38:58 INFO - Running setup.py (path:/tmp/pip-Y1ZCGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:38:58 INFO - Running setup.py (path:/tmp/pip-mRQrDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:38:58 INFO - Running setup.py (path:/tmp/pip-twjEWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:38:58 INFO - Running setup.py (path:/tmp/pip-a63yBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:38:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:38:58 INFO - Running setup.py install for manifestparser 03:38:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:38:58 INFO - Running setup.py install for mozcrash 03:38:58 INFO - Running setup.py install for mozdebug 03:38:58 INFO - Running setup.py install for mozdevice 03:38:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:38:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:38:58 INFO - Running setup.py install for mozfile 03:38:59 INFO - Running setup.py install for mozhttpd 03:38:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:38:59 INFO - Running setup.py install for mozinfo 03:38:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:38:59 INFO - Running setup.py install for mozInstall 03:38:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:38:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:38:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:38:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:38:59 INFO - Running setup.py install for mozleak 03:38:59 INFO - Running setup.py install for mozlog 03:38:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:38:59 INFO - Running setup.py install for moznetwork 03:38:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:38:59 INFO - Running setup.py install for mozprocess 03:38:59 INFO - Running setup.py install for mozprofile 03:38:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:38:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:38:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:38:59 INFO - Running setup.py install for mozrunner 03:38:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:38:59 INFO - Running setup.py install for mozscreenshot 03:39:00 INFO - Running setup.py install for moztest 03:39:00 INFO - Running setup.py install for mozversion 03:39:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:39:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:39:00 INFO - Cleaning up... 03:39:00 INFO - Return code: 0 03:39:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:39: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')]} 03:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39: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')]} 03:39:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:00 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 0x7fd9a7af4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272e410>, '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 0x272f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272f7a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1460802939.897490-626456260', '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 03:39:00 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 03:39:00 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 03:39:00 INFO - Using env: {'DISPLAY': ':0', 03:39:00 INFO - 'HOME': '/home/cltbld', 03:39:00 INFO - 'LANG': 'en_US.UTF-8', 03:39:00 INFO - 'LANGUAGE': 'en_US:en', 03:39:00 INFO - 'LOGNAME': 'cltbld', 03:39:00 INFO - 'MAIL': '/var/mail/cltbld', 03:39:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:00 INFO - 'MOZ_NO_REMOTE': '1', 03:39:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:39:00 INFO - 'NO_EM_RESTART': '1', 03:39:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:39:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:00 INFO - 'PWD': '/builds/slave/test', 03:39:00 INFO - 'SHELL': '/bin/bash', 03:39:00 INFO - 'SHLVL': '1', 03:39:00 INFO - 'TERM': 'linux', 03:39:00 INFO - 'TMOUT': '86400', 03:39:00 INFO - 'USER': 'cltbld', 03:39:00 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1460802939.897490-626456260', 03:39:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:00 INFO - '_': '/tools/buildbot/bin/python'} 03:39:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:39:00 INFO - Running setup.py (path:/tmp/pip-hqdoof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:39:00 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)) 03:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:39:00 INFO - Running setup.py (path:/tmp/pip-8g0fDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:39:00 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)) 03:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:39:00 INFO - Running setup.py (path:/tmp/pip-rsbiUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:39:00 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)) 03:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:39:00 INFO - Running setup.py (path:/tmp/pip-5dPINP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:39:00 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)) 03:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:39:00 INFO - Running setup.py (path:/tmp/pip-cT3415-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:39:00 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)) 03:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:39:00 INFO - Running setup.py (path:/tmp/pip-9im9Zj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:39:00 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)) 03:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:39:00 INFO - Running setup.py (path:/tmp/pip-c2Bl3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:39:01 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)) 03:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:39:01 INFO - Running setup.py (path:/tmp/pip-61JvkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:39:01 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)) 03:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:39:01 INFO - Running setup.py (path:/tmp/pip-iGBHnX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:39:01 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)) 03:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:39:01 INFO - Running setup.py (path:/tmp/pip-hvm1FN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:39:01 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)) 03:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:39:01 INFO - Running setup.py (path:/tmp/pip-k_0ORt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:39:01 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)) 03:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:39:01 INFO - Running setup.py (path:/tmp/pip-jnugrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:39:01 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)) 03:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:39:01 INFO - Running setup.py (path:/tmp/pip-lLlqES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:39:01 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)) 03:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:39:01 INFO - Running setup.py (path:/tmp/pip-lYy3yQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:39:01 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)) 03:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:39:01 INFO - Running setup.py (path:/tmp/pip-uUFrH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:39:01 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)) 03:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:39:01 INFO - Running setup.py (path:/tmp/pip-vYXwcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:39:01 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)) 03:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:39:01 INFO - Running setup.py (path:/tmp/pip-MuJ6G0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:39:01 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)) 03:39:01 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)) 03:39:01 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)) 03:39:01 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)) 03:39:01 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)) 03:39:01 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)) 03:39:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:03 INFO - Downloading blessings-1.6.tar.gz 03:39:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:39:03 INFO - Installing collected packages: blessings 03:39:03 INFO - Running setup.py install for blessings 03:39:03 INFO - Successfully installed blessings 03:39:03 INFO - Cleaning up... 03:39:03 INFO - Return code: 0 03:39:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:39:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:39:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:39:04 INFO - Reading from file tmpfile_stdout 03:39:04 INFO - Current package versions: 03:39:04 INFO - argparse == 1.2.1 03:39:04 INFO - blessings == 1.6 03:39:04 INFO - blobuploader == 1.2.4 03:39:04 INFO - docopt == 0.6.1 03:39:04 INFO - manifestparser == 1.1 03:39:04 INFO - mozInstall == 1.12 03:39:04 INFO - mozcrash == 0.17 03:39:04 INFO - mozdebug == 0.1 03:39:04 INFO - mozdevice == 0.48 03:39:04 INFO - mozfile == 1.2 03:39:04 INFO - mozhttpd == 0.7 03:39:04 INFO - mozinfo == 0.9 03:39:04 INFO - mozleak == 0.1 03:39:04 INFO - mozlog == 3.1 03:39:04 INFO - moznetwork == 0.27 03:39:04 INFO - mozprocess == 0.22 03:39:04 INFO - mozprofile == 0.28 03:39:04 INFO - mozrunner == 6.11 03:39:04 INFO - mozscreenshot == 0.1 03:39:04 INFO - mozsystemmonitor == 0.0 03:39:04 INFO - moztest == 0.7 03:39:04 INFO - mozversion == 1.4 03:39:04 INFO - psutil == 3.1.1 03:39:04 INFO - requests == 1.2.3 03:39:04 INFO - wsgiref == 0.1.2 03:39:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:39:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:04 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 0x7fd9a7af4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272e410>, '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 0x272f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272f7a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1460802939.897490-626456260', '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 03:39:04 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 03:39:04 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 03:39:04 INFO - Using env: {'DISPLAY': ':0', 03:39:04 INFO - 'HOME': '/home/cltbld', 03:39:04 INFO - 'LANG': 'en_US.UTF-8', 03:39:04 INFO - 'LANGUAGE': 'en_US:en', 03:39:04 INFO - 'LOGNAME': 'cltbld', 03:39:04 INFO - 'MAIL': '/var/mail/cltbld', 03:39:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:04 INFO - 'MOZ_NO_REMOTE': '1', 03:39:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:39:04 INFO - 'NO_EM_RESTART': '1', 03:39:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:39:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:04 INFO - 'PWD': '/builds/slave/test', 03:39:04 INFO - 'SHELL': '/bin/bash', 03:39:04 INFO - 'SHLVL': '1', 03:39:04 INFO - 'TERM': 'linux', 03:39:04 INFO - 'TMOUT': '86400', 03:39:04 INFO - 'USER': 'cltbld', 03:39:04 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1460802939.897490-626456260', 03:39:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:04 INFO - '_': '/tools/buildbot/bin/python'} 03:39:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:04 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)) 03:39:04 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)) 03:39:04 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)) 03:39:04 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)) 03:39:04 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)) 03:39:04 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)) 03:39:04 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)) 03:39:04 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)) 03:39:04 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)) 03:39:04 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)) 03:39:04 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)) 03:39:04 INFO - Cleaning up... 03:39:04 INFO - Return code: 0 03:39:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:39:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9a7af4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272e410>, '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 0x272f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272f7a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1460802939.897490-626456260', '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 03:39:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:39:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:39:04 INFO - Using env: {'DISPLAY': ':0', 03:39:04 INFO - 'HOME': '/home/cltbld', 03:39:04 INFO - 'LANG': 'en_US.UTF-8', 03:39:04 INFO - 'LANGUAGE': 'en_US:en', 03:39:04 INFO - 'LOGNAME': 'cltbld', 03:39:04 INFO - 'MAIL': '/var/mail/cltbld', 03:39:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:04 INFO - 'MOZ_NO_REMOTE': '1', 03:39:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:39:04 INFO - 'NO_EM_RESTART': '1', 03:39:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:39:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:04 INFO - 'PWD': '/builds/slave/test', 03:39:04 INFO - 'SHELL': '/bin/bash', 03:39:04 INFO - 'SHLVL': '1', 03:39:04 INFO - 'TERM': 'linux', 03:39:04 INFO - 'TMOUT': '86400', 03:39:04 INFO - 'USER': 'cltbld', 03:39:04 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1460802939.897490-626456260', 03:39:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:04 INFO - '_': '/tools/buildbot/bin/python'} 03:39:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:04 INFO - Downloading/unpacking jsonschema 03:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:39:06 INFO - Downloading/unpacking functools32 (from jsonschema) 03:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:06 INFO - Downloading functools32-3.2.3-2.tar.gz 03:39:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:39:06 INFO - warning: no files found matching '*.txt' 03:39:06 INFO - no previously-included directories found matching 'build' 03:39:06 INFO - no previously-included directories found matching 'dist' 03:39:06 INFO - no previously-included directories found matching '.git*' 03:39:06 INFO - Installing collected packages: jsonschema, functools32 03:39:06 INFO - Running setup.py install for functools32 03:39:06 INFO - warning: no files found matching '*.txt' 03:39:06 INFO - no previously-included directories found matching 'build' 03:39:06 INFO - no previously-included directories found matching 'dist' 03:39:06 INFO - no previously-included directories found matching '.git*' 03:39:06 INFO - Successfully installed jsonschema functools32 03:39:06 INFO - Cleaning up... 03:39:06 INFO - Return code: 0 03:39:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:39:06 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')]} 03:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:06 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')]} 03:39:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:06 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 0x7fd9a7af4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272e410>, '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 0x272f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272f7a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1460802939.897490-626456260', '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 03:39:06 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 03:39:06 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 03:39:06 INFO - Using env: {'DISPLAY': ':0', 03:39:06 INFO - 'HOME': '/home/cltbld', 03:39:06 INFO - 'LANG': 'en_US.UTF-8', 03:39:06 INFO - 'LANGUAGE': 'en_US:en', 03:39:06 INFO - 'LOGNAME': 'cltbld', 03:39:06 INFO - 'MAIL': '/var/mail/cltbld', 03:39:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:06 INFO - 'MOZ_NO_REMOTE': '1', 03:39:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:39:06 INFO - 'NO_EM_RESTART': '1', 03:39:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:39:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:06 INFO - 'PWD': '/builds/slave/test', 03:39:06 INFO - 'SHELL': '/bin/bash', 03:39:06 INFO - 'SHLVL': '1', 03:39:06 INFO - 'TERM': 'linux', 03:39:06 INFO - 'TMOUT': '86400', 03:39:06 INFO - 'USER': 'cltbld', 03:39:06 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1460802939.897490-626456260', 03:39:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:06 INFO - '_': '/tools/buildbot/bin/python'} 03:39:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:07 INFO - Downloading/unpacking flake8 03:39: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 03:39: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 03:39: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 03:39: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 03:39: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 03:39: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 03:39:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:39:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:39:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:39:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:39:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:39:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:39:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:39:09 INFO - no previously-included directories found matching 'docs/_build' 03:39:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:39:09 INFO - Running setup.py install for pep8 03:39:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:39:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:39:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:39:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:39:09 INFO - no previously-included directories found matching 'docs/_build' 03:39:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:39:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:39:09 INFO - Cleaning up... 03:39:09 INFO - Return code: 0 03:39:09 INFO - Running post-action listener: _resource_record_post_action 03:39:09 INFO - Running post-action listener: _start_resource_monitoring 03:39:09 INFO - Starting resource monitoring. 03:39:09 INFO - ##### 03:39:09 INFO - ##### Running install step. 03:39:09 INFO - ##### 03:39:09 INFO - Running pre-action listener: _resource_record_pre_action 03:39:09 INFO - Running main action method: install 03:39:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:39:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:39:10 INFO - Reading from file tmpfile_stdout 03:39:10 INFO - Detecting whether we're running mozinstall >=1.0... 03:39:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:39:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:39:10 INFO - Reading from file tmpfile_stdout 03:39:10 INFO - Output received: 03:39:10 INFO - Usage: mozinstall [options] installer 03:39:10 INFO - Options: 03:39:10 INFO - -h, --help show this help message and exit 03:39:10 INFO - -d DEST, --destination=DEST 03:39:10 INFO - Directory to install application into. [default: 03:39:10 INFO - "/builds/slave/test"] 03:39:10 INFO - --app=APP Application being installed. [default: firefox] 03:39:10 INFO - mkdir: /builds/slave/test/build/application 03:39:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:39:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:39:25 INFO - Reading from file tmpfile_stdout 03:39:25 INFO - Output received: 03:39:25 INFO - /builds/slave/test/build/application/firefox/firefox 03:39:25 INFO - Running post-action listener: _resource_record_post_action 03:39:25 INFO - ##### 03:39:25 INFO - ##### Running run-tests step. 03:39:25 INFO - ##### 03:39:25 INFO - Running pre-action listener: _resource_record_pre_action 03:39:25 INFO - Running main action method: run_tests 03:39:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:39:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:39:25 INFO - Python 2.7.3 03:39:25 INFO - Return code: 0 03:39:25 INFO - grabbing minidump binary from tooltool 03:39:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:39:25 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 0x272e410>, '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 0x272f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272f7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:39:25 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 03:39:25 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 03:39:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:39:26 INFO - Return code: 0 03:39:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:39:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:39:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:39:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:39:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:39:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:39:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:39:27 INFO - Return code: 0 03:39:27 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/K_2XnYfSSUmzZrMz0BELFw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 03:39:27 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/K_2XnYfSSUmzZrMz0BELFw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 03:39:27 INFO - Using env: {'DISPLAY': ':0', 03:39:27 INFO - 'HOME': '/home/cltbld', 03:39:27 INFO - 'LANG': 'en_US.UTF-8', 03:39:27 INFO - 'LANGUAGE': 'en_US:en', 03:39:27 INFO - 'LOGNAME': 'cltbld', 03:39:27 INFO - 'MAIL': '/var/mail/cltbld', 03:39:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:39:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:39:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:27 INFO - 'MOZ_NO_REMOTE': '1', 03:39:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:39:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:39:27 INFO - 'NO_EM_RESTART': '1', 03:39:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:39:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:27 INFO - 'PWD': '/builds/slave/test', 03:39:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:39:27 INFO - 'SHELL': '/bin/bash', 03:39:27 INFO - 'SHLVL': '1', 03:39:27 INFO - 'TERM': 'linux', 03:39:27 INFO - 'TMOUT': '86400', 03:39:27 INFO - 'USER': 'cltbld', 03:39:27 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1460802939.897490-626456260', 03:39:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:27 INFO - '_': '/tools/buildbot/bin/python'} 03:39:27 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/K_2XnYfSSUmzZrMz0BELFw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 03:39:27 INFO - mozversion application_buildid: 20160416022721 03:39:27 INFO - mozversion application_changeset: 19d56ca9e3f5078dba44230ac3ec0718cc029b70 03:39:27 INFO - mozversion application_display_name: Nightly 03:39:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:39:27 INFO - mozversion application_name: Firefox 03:39:27 INFO - mozversion application_remotingname: firefox 03:39:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:39:27 INFO - mozversion application_vendor: Mozilla 03:39:27 INFO - mozversion application_version: 48.0a1 03:39:27 INFO - mozversion platform_buildid: 20160416022721 03:39:27 INFO - mozversion platform_changeset: 19d56ca9e3f5078dba44230ac3ec0718cc029b70 03:39:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:39:27 INFO - mozversion platform_version: 48.0a1 03:39:27 INFO - using testdate: 1460803167 03:39:27 INFO - actual date: 1460803167 03:39:27 INFO - starting webserver on 'localhost:50254' 03:39:27 INFO - SUITE-START | Running 2 tests 03:39:27 INFO - TEST-START | dromaeo_css 03:39:27 INFO - operating with platform_type : linux_ 03:39:27 INFO - Initialising browser for dromaeo_css test... 03:39:27 INFO - TEST-INFO | started process 3272 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphMz1Dm/profile http://localhost:50254/getInfo.html) 03:39:33 INFO - PROCESS | 3272 | __metrics Screen width/height:1600/1200 03:39:33 INFO - PROCESS | 3272 | colorDepth:24 03:39:33 INFO - PROCESS | 3272 | Browser inner width/height: 1024/697 03:39:33 INFO - PROCESS | 3272 | __metrics 03:39:35 ERROR - PROCESS | 3272 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:39:35 INFO - TEST-INFO | 3272: exit 0 03:39:35 INFO - Browser initialized. 03:39:35 INFO - Running cycle 1/1 for dromaeo_css test... 03:39:35 INFO - TEST-INFO | started process 3358 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphMz1Dm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:39:47 INFO - PROCESS | 3358 | RSS: Main: 154767360 03:39:47 INFO - PROCESS | 3358 | 03:40:39 INFO - PROCESS | 3358 | 1460803239410 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] 03:42:50 INFO - PROCESS | 3358 | Cycle 1(1): loaded http://localhost:50254/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50254/tests/dromaeo/cssquery-ext.html) 03:42:52 INFO - PROCESS | 3358 | RSS: Main: 270004224 03:42:52 INFO - PROCESS | 3358 | 03:45:54 INFO - PROCESS | 3358 | Cycle 1(1): loaded http://localhost:50254/tests/dromaeo/cssquery-ext.html (next: http://localhost:50254/tests/dromaeo/cssquery-jquery.html) 03:45:55 INFO - PROCESS | 3358 | RSS: Main: 238370816 03:45:55 INFO - PROCESS | 3358 | 03:48:57 INFO - PROCESS | 3358 | Cycle 1(1): loaded http://localhost:50254/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50254/tests/dromaeo/cssquery-mootools.html) 03:48:57 INFO - PROCESS | 3358 | RSS: Main: 239132672 03:48:57 INFO - PROCESS | 3358 | 03:51:59 INFO - PROCESS | 3358 | Cycle 1(1): loaded http://localhost:50254/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50254/tests/dromaeo/cssquery-prototype.html) 03:52:00 INFO - PROCESS | 3358 | RSS: Main: 236498944 03:52:00 INFO - PROCESS | 3358 | 03:55:03 INFO - PROCESS | 3358 | Cycle 1(1): loaded http://localhost:50254/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50254/tests/dromaeo/cssquery-yui.html) 03:55:04 INFO - PROCESS | 3358 | RSS: Main: 211570688 03:55:04 INFO - PROCESS | 3358 | 03:58:06 INFO - PROCESS | 3358 | Cycle 1(1): loaded http://localhost:50254/tests/dromaeo/cssquery-yui.html (next: http://localhost:50254/tests/dromaeo/cssquery-dojo.html) 03:58:07 INFO - PROCESS | 3358 | RSS: Main: 268136448 03:58:07 INFO - PROCESS | 3358 | 03:58:07 INFO - PROCESS | 3358 | __start_tp_report 03:58:07 INFO - PROCESS | 3358 | _x_x_mozilla_page_load 03:58:07 INFO - PROCESS | 3358 | _x_x_mozilla_page_load_details 03:58:07 INFO - PROCESS | 3358 | |i|pagename|runs| 03:58:07 INFO - PROCESS | 3358 | |0;dojo.html;2616.1105224223766;2690.300521864317;2694.919152425428;2713.4844379567894;2732.863356832158;4550.908981820362;4666.370040044601;4679.859604211875;4687.906241875165;4717.528247175285;4692.765361731908;4694.201985662437;4756.833510827122;4780.211265141256;4784;4264.744115353089;4326.567343265672;4352.020795321043;4396.1427521633295;4485.551444855521;4407.360932664762;4442.2448183808665;4450.532694067125;4463.866084017484;4467.30756732707;4166.270902592065;4255.085156691295;4255.17024180285;4276.679249056302;4368.912621747579;4305.849295274682;4353.151135528541;4364.8472303469225;4373.934390984138;4405.581469760367;4287.699861009731;4312.892177695551;4313.82744690212;4321.848735294249;4365.847195348148;4420.778961051935;4567.109413664337;4584.977075114603;4617.561331673485;4651.279051746985;4988.87527811804;4992.176290912032;4997.600191984632;5036.647434679574;5043.445221025721;4989.501049895018;5001.799928002875;5012.423571289312;5016.949830501685;5018.749062546858;4600.240960241523;4658.394408726844;4662.696924699883;4677.158111539888;4774.95225047745;5107.540321371094;5122.308488354099;5137.486251374833;5205.193195054772;5240.790368385298;4910.337104490848;4934.654574179773;4939.3084968104495;4943;4983.626228032912;4854.902901942012;5029.446760856303;5042.218456139304;5149.742512874342;5154.716490593053;5008.949910500848;5013.273075404046;5019.82430614934;5024.899502009939;5080.720560369141;5010.098182327143;5024.472430394829;5026.597872170218;5031.723255220998;5032.446430892599;4119.526254480713;4193.6645068394455;4201.180769749931;4201.264778663722;4213.747175169499;3686.5391826021746;3714.795686237283;3721.1627383838963;3731.7014638828828;3736.495573097597;4237.131388065439;4237.300845360543;4238.23711731885;4265.594768496988;4287.892802679958;5016.322796422436;5093.388793344749;5093.668911520739;5121.359830021247;5139.922901156411;4309.978450107729;4321.308590625485;4345.32647439641;4348.826046958086;4364.738115713068;4558.088382323548;4569.451665800058;4574.748388838646;4583.885402864955;4601.815927362935;4588.105319462673;4736.786844592001;4772.5227477252;4825.710457372498;4848.878778030577;4968.975155124202;5030.773615187399;5067.011932673094;5072.797088116434;5116.897662046813;4539.273716205391;4742.905141897074;4785.736784476887;4792.376990991149;4802.135615589227;4942.184539550934;4961.776720047678;4997.875053123701;5025.246213068069;5041.193409054534;5008.6243531734535;5009.749512524432;5043.697378157322;5064.4935506449065;5106.259592359162;4671.8364857229835;4879.292502587176;4889.462159162418;4908.435529914105;4909.828156014522;4921.753912304299;4934.087193869145;4946.134426475424;4950.628702847373;5000.224965130411;4831.758412079312;4853.635977301646;4857.9514204858915;4873.390826146731;4897.583705385082;4705.694129881546;4896.755162241945;4956.355673762388;4959.553640172402;5030.924536131888;4835.540623640749;4847.515248475124;4853.854384368475;4856.757162141949;4895.996320754166 03:58:07 INFO - PROCESS | 3358 | |1;ext.html;557.1392199052464;606.3663471672102;606.8742482694602;614.0788816774838;624.4411251929522;25091.37271568212;32422;33429.16427089324;33520;33595.32809343815;36398.81800591;37235.441468377925;37276.254474910485;37287.440688389695;37315.25369492608;7608.923910760891;7776.339011184028;7778.766637000899;7780.6109694515335;7788.182240864712;7736.690532378726;7875.645595948196;7879.881801772978;7883.526988380687;7884.093329267122;7888.408369372291;7966.123726390121;7969.322607578363;7970.163132871052;7970.242826931432;7879.330256928168;7946.0464744230485;7952.602369881541;7953.522788632643;7963.362930965509;7770.922290777076;7862.606869656494;7870.173631768639;7871.724489642892;7871.881921771178;36814.8159259202;37305;37376.25247495035;37444.251114977546;37473;3010.412969470954;3068.6777888321853;3077.322988942429;3094.2883136878418;3150.84245787712;28387.716122838712;28692.71307286942;28730.569041464394;28973.42053158925;29575.556366654517;3505.4040813061843;3543.7165026797793;3550.982245088758;3585.1933315003917;3675.209829886587;231897;232250;232830;232901;233462.83268583717;52053.7397313011;52125.218121728205;52150.478495214564;52247.73876130671;52746.47253527492;54665.726671367185;55014;55068.724656376464;59309;61528.69235653883;14079.732824045885;14155;14157.646058848406;14180;14193.432262709583;11993.100517461051;12019.158658893793;12054.578089766992;12175.939120304341;12192;18188.362687410518;18194;18289.817101829078;18309;18380.63238735218;6597;6794.932050679528;6958.37374636275;7157.355837974607;7198.172210195789;884.1512148337667;913.9040400757825;947.4410098042188;978.1099199728355;983.2134292565919;27517.587236191473;28177.43645127127;28727.569086463718;29015;29018;887.9556022198993;1014.9847752283722;1029.2897900448665;1039.6413237433073;1072.5173671847544;13808.240546770025;14247;14542.636434089232;14555.92722036383;14661.633459163606;336392;337221;340099;341364;341919;47508.76245618819;47690.76154619205;48038.27942580864;48063.279050814264;48158.75920620444;1043.1602559939322;1173.178774857603;1195.5098409652176;1283.7881749511412;1340.611222745393;25986.87006564955;27748.722512774613;27902.72097279001;28030.579541306488;28084.71915280821;39250.80374598109;40237.39643905402;40515;40632.39051414172;40662.39006414847;298584;310195;310514;311117;311855;32622;38786.4182037264;39591.604083958795;39595.80202098971;40287.194256114126;42050.57949420589;42084.36873446962;42108.15783684248;42960;43010;35098.12254693653;36094.278114438086;36271.274574507835;36917.815410922776;37027;35683.46474802828;36583.634163658025;36755.44866827053;36940.26119477649;37241.44137837989;36111;36167.63832361748;37099.25801483901;37154.44268335923;37218.8139059303;30872.845635772577;32432.83783581067;32814.34371312608;33004.83497582497;33036.834815825765;24892.75107248904;25345.87327063353;25450.363740905887;25552.744472555038;25678.614820778075 03:58:07 INFO - PROCESS | 3358 | |2;jquery.html;376.8994535955011;383.34448093759687;392.2018691961858;401.4199481748874;403.92931237033514;15229.543113706593;16420.753688694665;16466.423675171372;16501.917490412547;16514.33942642293;10370.274080814346;10907.454627268624;10913.126949844012;10914.454277286124;10917.836232456519;4601.332806743028;4722.574968252857;4768.260919557474;4786.760661966905;4788.186008378584;4642.373279607261;4804.855854324358;4822.638302127337;4829.1307564638355;4837.9516204837855;4816.686915350509;4822.469528351879;4824.686395384307;5079.720615366154;5466.34403871536;5331.733413329318;5338.839834804962;5351.518363347279;5353.839384818461;5386.8383948481605;5127.359080114986;5207.9479205207845;5221.321228240305;5403.162509810985;5414.458554144593;12204.755904881942;12547.686307842285;12590;12606.432710527957;12755.872441275562;1840.9539761505935;1849.4913898677971;1865.3844231403605;1889.9149538270674;1937.1476550317816;9327.067293270686;9573.090556397132;9613.807723845553;10920.890791092066;13250.536231231861;1768.6285879965224;1805.8465030472425;1817.690992531273;1851.8425933795509;1880.6332765110808;66047.3395266046;66470.3352966469;66616.66691666559;66619.66690166567;67702.66148669274;9949.303548751517;10059.497025148714;10064.849027264598;10317.123044541147;10348.379097254188;14161.645958851112;14251.714965700628;14284;14353.067050641675;14357.712845743026;7166;7324.121105467378;7474.5888976106835;7564.810879728051;7572.356349710336;6953.687084081229;6969.82575435608;7106.92893071073;7131.465140114408;7148.714051437988;4342.609165175086;4355.607995280377;4431;4451.732896026248;4490;1791.7312403139372;1850.3061351993003;1861.6928206845719;1884.7361369408293;1891.7351570780102;831.3806214370333;859.8862090536282;871.5118337147479;956.6077908057663;973.9123478886934;16119.919400402923;16152.35390584387;16461.094639794926;16844.157792110345;17018.234179461953;901.9729408117767;904.841652710773;909.9044600317004;941.9764505887408;957.3824882950458;9042.367034307536;9066.09339066088;9237.399569027992;9353.766155846159;9540.618375264912;368461;369771;373920;378283;378554;71736.64131679309;77252.61373693096;80001;84274.1008129425;87349.56325218333;984.9261305402124;994.6335586774068;1001.8296889528943;1011.7116621762763;1018.9286749927434;15238.238088095773;15359.07845529227;15440;15534.533963981099;15753.842461575237;33618.831905840314;35199;35242.942711718686;36215.81892090523;36481.45277820888;43520;44569.55430445784;44918.10163796641;45468;50323.24515132349;6422;6623.337666233531;6954.165500140016;6976.720931162697;7191.676374563262;7606.923930760621;7860.84278314442;7898.328642065259;7918.2477664621765;8011.479253848481;6953.721851125898;7324.96337518309;7360.742374017098;7423.814404639711;7433.888491672521;7048.753293634698;7150;7157.463190260647;7467.850642987219;7478.925210748041;7154.892676609751;7179.066721326194;7295.598742069237;7374.483786134919;7381.298776616213;10596.31123976939;10838.566457341618;10861.185411094042;10883.510242038968;10888.128949683847;10277.897221027994;10392.272540922062;10467;10471.528781205016;10600.734981625212 03:58:07 INFO - PROCESS | 3358 | |3;mootools.html;1300.209888175967;1431.1770731829201;1472.8968972171945;1591.2203020519942;1810.1130446081415;7467;7769.922300776991;7770.3783697304225;7802.453828232019;7809.687612495501;7588.27911348421;7739.729109481155;7743.148253692089;7745.031871016123;7753.496022758517;1899.6485650154766;2159.8164156046755;2164.729408823897;2183.602494403583;2254.0195015168374;2246.539459410825;2267.1498188179435;2271.432141964509;2272.397814579138;2275.544891021794;2211.402921211272;2264.7735226477384;2267.2178098555974;2267.3424706835;2268.3761965459466;1906.551960289331;2117.565898990711;2178.215842296772;2189.6715492676067;2196.8352373572047;2103.82117520011;2117.375374264596;2129.2866889592005;2156.9245076422408;2160.8919554022395;7162.570245785218;7238.2761723827725;7267.200607933123;7279.526830755984;7290.526115802456;4469.7541635210055;4614.238650622643;4632.397788287535;4666.626669866402;4735.289706544011;2952.3062080411087;3002.459557279689;3031.227037105546;3085.1670049086847;3103.8758449661987;997.1723469520281;1040.8386700061503;1059.0309866472169;1832.844208242301;1834.8256915592997;10210.9489452553;10345.896541034645;10390.636327728493;10411.167106631452;10439.321444106108;4096.32410652245;4320.43834301545;4395.252807022814;4469.173202957463;4470.418845550058;9043.819123617492;9057.139571740674;9165.31260155491;9169.633214671472;9195.264378849675;4091.4067460218102;4697.389339385858;4699.78850951708;4708.105459962596;4718.834840780556;4267.722598031118;4348.217320882209;4359.869203923888;4391.6486681065435;4395.692301538862;3688.354537955847;3730.3658378075793;3781.962180378216;3808.3716186829415;3860.2665493556133;1203.3622180244483;1211.1340391619858;1228.4656174564093;1231.612042206702;1240.4480006397066;800.1678254615251;867.913208679127;883.2580632268797;886.7561420609255;902.9503377314179;5162.561182299547;5198.92201616976;5220.608454365938;5278.4721527846905;5341.973290133602;411.83320755094235;412.7853516171574;413.99379009314885;422.2673661197819;434.97607631580564;3875.476810630585;3919.6668283195677;3932.9016774580864;3934.11482416454;3953.8616148434667;9266.444013359085;9451.196648284973;9709.417434953926;9822.803543929223;9825.45959972194;9547.856782148274;9632.662856799978;9694.806103877883;9781.364211326241;9792.657256995972;7219.386352160021;7417.443691723142;7494.063242094739;7499.6250187490405;7502.249775022454;5323.866903327448;5324.920126198032;5386.622936394571;5492.450754924475;5511.889762204813;8736.209077139298;8860.911390886009;8864.20222180007;8866.822663546822;8988.775280618036;8869.778255543662;9071.727848164302;9100;9204.631814727336;9282.675106371245;6185.752569897154;6478.805635830932;6701.0953521274005;6906.205786334435;6973.5118541701595;7301.233370496234;7302.160251571137;7344.412447004333;7371.447141464304;7375.704971801282;6515.771947981798;6626.867462650816;6702.698378573074;6736.124303840469;6831.11195544576;6499.415052645285;6546.312637173029;6586.868262634624;6597.736090556516;6609.570377925419;5960.225170727777;5984.640921544721;6008.849778755566;6011.939880601313;6018.36807135262;4542.727436353829;4632.420947381577;4640.883977900579;4675.438947326343;4706.0823139487475;4243.957560424356;4508.030773383738;4512.05246898155;4543.273076307775;4611.031683346535 03:58:07 INFO - PROCESS | 3358 | |4;prototype.html;312.9624445066591;319.0762741862307;320.2010982598417;321.9855106520207;323.9433099207641;4907.509249075095;4919.6310276729255;4949.8367883547335;4953.678010929287;4958.652894297401;4886.340344053552;4904.239842824368;4907.950920490794;4922.1878390065685;4938.407391113063;3692.9261414771754;3793.563740169888;3939.527256729182;3947.8420863165584;3952.43878667926;3900;3921.274564205617;3924.4505769192338;3934.6655534279475;3941.251162279172;3667.889963301105;3879.631435013669;3893.5911729268446;3901.2977664020464;3924.921501569967;3771.41543060826;3849.615038496142;3864.9806750966345;3877.8448862045484;3908.6482216600643;3406.199543107368;3464.2378676691087;3488.9302213955834;3500.2299494111508;3513.91215219619;4783.378160839104;4787.3537072495465;4788.186008378584;4797.40032495938;4820.276958456225;4257.233697934371;4479.686421950465;4492.955070449287;4501.054778496519;4501.504834468205;5099.668521546125;5171.120909445403;5184.429712731634;5185.299984502081;5187.403448603422;3661.835217415223;3797.3354662933875;3807.447920051605;3809.085819403323;3820.178661587744;5355.544778693777;5435.369389183229;5439.728013599344;5440.619156659035;5450.809221677222;3957.2679054375035;3967.0677390813134;3974.4435778990965;3977.3039718049226;3979.263836190314;4028.113814960704;4032.943198968547;4033.8789836304372;4040.3333449980423;4040.7373520721058;4389;4430;4453.354263631755;4456.68803183774;4476.4180656514445;5154.201098829612;5157.200633901752;5169.3796744390165;5169.715665638426;5191.610629202825;1361.3533571553432;1384.1072508232135;1394.4770710983382;1396.043710058613;1399.8670126337981;873.1879352202386;882.5940067568862;964.8793900762405;973.0804389851522;987.5013118375175;4579.084183163381;4579.702319349231;4579.793909274091;4580.312953057068;4596.931046034312;5321.733913304397;5357.892842143136;5364.3830959440165;5368.382635996911;5380.461953804666;4362.389265502832;4530.161920044737;4558.566936141061;4568.218394826021;4573.405457290597;2859.0993836941298;2872.296287409598;2879.452903948243;2884.4952133376996;2886.1197334812664;5014.89970200594;5039.874003149951;5055.811884207208;5093.617978651616;5096.439391666913;5382.542483888835;5442.945570544323;5480.260164877691;5494.2582751328855;5543.501084902378;5045.318881950963;5052.433745538895;5059.3422855030085;5087.135187018216;5091.1854103343285;5295.735213239245;5359.410464848941;5363.410024897336;5380.596455265949;5383;5081;5261.263423120843;5262.236975638588;5294.776193998607;5300.31095957523;5042.243663450512;5048.697078175322;5060.544550990428;5071.974640126776;5081.415637201769;3770.208256266215;3785.242951409784;3788.7158463114824;3789.2421515697524;3806.980965095157;5238.580913526985;5340.305760251143;5351.224072509543;5366.624336296578;5405.918911216257;4967.4287456941465;5051.621128415457;5167.6641018333685;5191.714455704821;5200.583953283804;5180.766865490987;5182.170852663556;5198.194279886624;5198.584113271005;5200.713960732045;5106.617003724809;5127.359080114986;5161.922571161511;5164.922526162186;5165.070287348313;5066.544011039025;5215.739213039409;5216.347956505437;5216.40011398694;5241.659292145999;5097.719625420637;5135.409427915837;5140.074786538309;5142.074426603247;5149.639525233198 03:58:07 INFO - PROCESS | 3358 | |5;yui.html;655.8884989551776;694.5277211496181;720.4308596208994;735.7976556446973;738.47937204271;12052.879471205286;12210.93894530526;12222.755544889107;12422;12433.254004759721;11342.716432089202;11540;11547.826782598268;11547.942260288708;11570;638.097092613953;653.7646447278976;655.4919937048802;807.3258828877879;827.8592639251342;661.7253839656537;783.6277768060154;813.1746277528314;818.5497976113114;818.615250832111;864.5893200729635;865.3682811547574;867.8177582707639;868.0754995929346;868.2316150207049;670.2493207607462;858.5235194467068;861.1990848510883;861.5692153923038;862.2498426369068;599.706143989442;622.3403192615797;623.2209737827716;623.2769986815318;623.5385814497239;12963.222206667535;12999.740005199843;13015.088943773939;13030.934845325808;13093.345332733325;12283.263004219776;12738.363081845871;12792.61622151337;12893.548725794552;12928.418221179976;9391.34260601758;9464.384814987005;9531.428114313094;9651.613935442643;9712.125908668253;3323.6842499962463;3356.63077061523;3369.831508424569;3371.983140084284;3473.8263086845554;46681.53318466806;47081.76459117683;47198.76400617975;47598.52401475976;47610.285845712344;9914.355566888129;10190.184785217165;10198.796024079476;10267.332623379456;10352.689419317432;18287.54281142982;18311.267549298147;18404.35584754527;18417.90791046063;18444.538886527946;6711.798646040626;6753.189617245962;6773.288804675537;6823.249442561314;6995.580265184105;3576.8211589420944;3602.765820221677;3618.493410922473;3681.742278040565;3735.159589092487;2706.648135742341;2809.0730059080456;2813.521701310782;2815.577663350514;2828.2081017315186;465.52748959805825;494.9802007919643;523.17338605004;527.7677821758414;531.4260598553553;588.6350462713145;595.8689088400545;600.0818747316613;670.4636290967304;672.7981605518324;7969.721059762996;7982.281594656509;8057.31512821405;8151.673933042612;8307.875381869277;510.2728611728272;573.6644063222977;629.197772839624;637.3849235487777;649.4512137244021;3669.6789155903853;3827.655511004023;3924.7448915820382;3946.9013274668364;4032.6370626643743;50357.74821125871;51237.74381128071;52037.47962520402;52280;52297.90808367623;42878;43664.3450348245;44708;44733;44834.77582612066;40665.796671016455;40679.18641627151;41075.7946210273;41433.79283103565;41820.581794182275;8134.877976830234;8143;8307.210814972568;8388.832223355621;8660.523671197892;25224.621630675923;25243;25851.353716157246;25940.610890836277;26349.473010540067;35201.47197791984;35765.642343577274;35999.82000090087;36692.266154677294;36978.260434790616;10669.46652667379;10783.6225732099;10807.945960270148;10865.13078953666;11137.10903127764;11702.180847340946;11758.176927614984;12037.157398982337;12257.69355766113;12311.69220769488;11166.497507612014;11555.191136620691;11672.76654466889;12227.0829687772;12235.449404776627;10778.568857245937;10882.836757448804;11082.22424430282;11464.885351146382;11542.480588373375;11209.215354925404;11277.154213433862;11408.087353011573;11992.700182495159;11998.40007999614;9119.270458363182;9455.257975187118;9719.659811906833;9941.801163976825;9952.402855828674;8621.784455388415;8807.295416366547;9475.773193299432;9488.193503552275;9597.23222142241 03:58:07 INFO - PROCESS | 3358 | __end_tp_report 03:58:07 INFO - PROCESS | 3358 | __start_cc_report 03:58:07 INFO - PROCESS | 3358 | _x_x_mozilla_cycle_collect,1145 03:58:07 INFO - PROCESS | 3358 | __end_cc_report 03:58:07 INFO - PROCESS | 3358 | __startTimestamp1460804287087__endTimestamp 03:58:07 INFO - PROCESS | 3358 | 03:58:07 INFO - PROCESS | 3358 | ------- Summary: start ------- 03:58:07 INFO - PROCESS | 3358 | Number of tests: 6 03:58:07 INFO - PROCESS | 3358 | 03:58:07 INFO - PROCESS | 3358 | [#0] dojo.html Cycles:165 Average:4651.33 Median:4785.74 stddev:485.99 (10.2%) stddev-sans-first:460.51 03:58:07 INFO - PROCESS | 3358 | Values: 2616.1 2690.3 2694.9 2713.5 2732.9 4550.9 4666.4 4679.9 4687.9 4717.5 4692.8 4694.2 4756.8 4780.2 4784.0 4264.7 4326.6 4352.0 4396.1 4485.6 4407.4 4442.2 4450.5 4463.9 4467.3 4166.3 4255.1 4255.2 4276.7 4368.9 4305.8 4353.2 4364.8 4373.9 4405.6 4287.7 4312.9 4313.8 4321.8 4365.8 4420.8 4567.1 4585.0 4617.6 4651.3 4988.9 4992.2 4997.6 5036.6 5043.4 4989.5 5001.8 5012.4 5016.9 5018.7 4600.2 4658.4 4662.7 4677.2 4775.0 5107.5 5122.3 5137.5 5205.2 5240.8 4910.3 4934.7 4939.3 4943.0 4983.6 4854.9 5029.4 5042.2 5149.7 5154.7 5008.9 5013.3 5019.8 5024.9 5080.7 5010.1 5024.5 5026.6 5031.7 5032.4 4119.5 4193.7 4201.2 4201.3 4213.7 3686.5 3714.8 3721.2 3731.7 3736.5 4237.1 4237.3 4238.2 4265.6 4287.9 5016.3 5093.4 5093.7 5121.4 5139.9 4310.0 4321.3 4345.3 4348.8 4364.7 4558.1 4569.5 4574.7 4583.9 4601.8 4588.1 4736.8 4772.5 4825.7 4848.9 4969.0 5030.8 5067.0 5072.8 5116.9 4539.3 4742.9 4785.7 4792.4 4802.1 4942.2 4961.8 4997.9 5025.2 5041.2 5008.6 5009.7 5043.7 5064.5 5106.3 4671.8 4879.3 4889.5 4908.4 4909.8 4921.8 4934.1 4946.1 4950.6 5000.2 4831.8 4853.6 4858.0 4873.4 4897.6 4705.7 4896.8 4956.4 4959.6 5030.9 4835.5 4847.5 4853.9 4856.8 4896.0 03:58:07 INFO - PROCESS | 3358 | 03:58:07 INFO - PROCESS | 3358 | [#1] ext.html Cycles:180 Average:45351.14 Median:36491.23 stddev:77819.63 (213.3%) stddev-sans-first:77965.26 03:58:07 INFO - PROCESS | 3358 | Values: 557.1 606.4 606.9 614.1 624.4 25091.4 32422.0 33429.2 33520.0 33595.3 36398.8 37235.4 37276.3 37287.4 37315.3 7608.9 7776.3 7778.8 7780.6 7788.2 7736.7 7875.6 7879.9 7883.5 7884.1 7888.4 7966.1 7969.3 7970.2 7970.2 7879.3 7946.0 7952.6 7953.5 7963.4 7770.9 7862.6 7870.2 7871.7 7871.9 36814.8 37305.0 37376.3 37444.3 37473.0 3010.4 3068.7 3077.3 3094.3 3150.8 28387.7 28692.7 28730.6 28973.4 29575.6 3505.4 3543.7 3551.0 3585.2 3675.2 231897.0 232250.0 232830.0 232901.0 233462.8 52053.7 52125.2 52150.5 52247.7 52746.5 54665.7 55014.0 55068.7 59309.0 61528.7 14079.7 14155.0 14157.6 14180.0 14193.4 11993.1 12019.2 12054.6 12175.9 12192.0 18188.4 18194.0 18289.8 18309.0 18380.6 6597.0 6794.9 6958.4 7157.4 7198.2 884.2 913.9 947.4 978.1 983.2 27517.6 28177.4 28727.6 29015.0 29018.0 888.0 1015.0 1029.3 1039.6 1072.5 13808.2 14247.0 14542.6 14555.9 14661.6 336392.0 337221.0 340099.0 341364.0 341919.0 47508.8 47690.8 48038.3 48063.3 48158.8 1043.2 1173.2 1195.5 1283.8 1340.6 25986.9 27748.7 27902.7 28030.6 28084.7 39250.8 40237.4 40515.0 40632.4 40662.4 298584.0 310195.0 310514.0 311117.0 311855.0 32622.0 38786.4 39591.6 39595.8 40287.2 42050.6 42084.4 42108.2 42960.0 43010.0 35098.1 36094.3 36271.3 36917.8 37027.0 35683.5 36583.6 36755.4 36940.3 37241.4 36111.0 36167.6 37099.3 37154.4 37218.8 30872.8 32432.8 32814.3 33004.8 33036.8 24892.8 25345.9 25450.4 25552.7 25678.6 03:58:07 INFO - PROCESS | 3358 | 03:58:07 INFO - PROCESS | 3358 | [#2] jquery.html Cycles:180 Average:23002.77 Median:4745.42 stddev:61918.79 (1304.8%) stddev-sans-first:62069.19 03:58:07 INFO - PROCESS | 3358 | Values: 376.9 383.3 392.2 401.4 403.9 15229.5 16420.8 16466.4 16501.9 16514.3 10370.3 10907.5 10913.1 10914.5 10917.8 4601.3 4722.6 4768.3 4786.8 4788.2 4642.4 4804.9 4822.6 4829.1 4838.0 4816.7 4822.5 4824.7 5079.7 5466.3 5331.7 5338.8 5351.5 5353.8 5386.8 5127.4 5207.9 5221.3 5403.2 5414.5 12204.8 12547.7 12590.0 12606.4 12755.9 1841.0 1849.5 1865.4 1889.9 1937.1 9327.1 9573.1 9613.8 10920.9 13250.5 1768.6 1805.8 1817.7 1851.8 1880.6 66047.3 66470.3 66616.7 66619.7 67702.7 9949.3 10059.5 10064.8 10317.1 10348.4 14161.6 14251.7 14284.0 14353.1 14357.7 7166.0 7324.1 7474.6 7564.8 7572.4 6953.7 6969.8 7106.9 7131.5 7148.7 4342.6 4355.6 4431.0 4451.7 4490.0 1791.7 1850.3 1861.7 1884.7 1891.7 831.4 859.9 871.5 956.6 973.9 16119.9 16152.4 16461.1 16844.2 17018.2 902.0 904.8 909.9 942.0 957.4 9042.4 9066.1 9237.4 9353.8 9540.6 368461.0 369771.0 373920.0 378283.0 378554.0 71736.6 77252.6 80001.0 84274.1 87349.6 984.9 994.6 1001.8 1011.7 1018.9 15238.2 15359.1 15440.0 15534.5 15753.8 33618.8 35199.0 35242.9 36215.8 36481.5 43520.0 44569.6 44918.1 45468.0 50323.2 6422.0 6623.3 6954.2 6976.7 7191.7 7606.9 7860.8 7898.3 7918.2 8011.5 6953.7 7325.0 7360.7 7423.8 7433.9 7048.8 7150.0 7157.5 7467.9 7478.9 7154.9 7179.1 7295.6 7374.5 7381.3 10596.3 10838.6 10861.2 10883.5 10888.1 10277.9 10392.3 10467.0 10471.5 10600.7 03:58:07 INFO - PROCESS | 3358 | 03:58:07 INFO - PROCESS | 3358 | [#3] mootools.html Cycles:180 Average:5133.65 Median:4707.09 stddev:2830.02 (60.1%) stddev-sans-first:2823.30 03:58:07 INFO - PROCESS | 3358 | Values: 1300.2 1431.2 1472.9 1591.2 1810.1 7467.0 7769.9 7770.4 7802.5 7809.7 7588.3 7739.7 7743.1 7745.0 7753.5 1899.6 2159.8 2164.7 2183.6 2254.0 2246.5 2267.1 2271.4 2272.4 2275.5 2211.4 2264.8 2267.2 2267.3 2268.4 1906.6 2117.6 2178.2 2189.7 2196.8 2103.8 2117.4 2129.3 2156.9 2160.9 7162.6 7238.3 7267.2 7279.5 7290.5 4469.8 4614.2 4632.4 4666.6 4735.3 2952.3 3002.5 3031.2 3085.2 3103.9 997.2 1040.8 1059.0 1832.8 1834.8 10210.9 10345.9 10390.6 10411.2 10439.3 4096.3 4320.4 4395.3 4469.2 4470.4 9043.8 9057.1 9165.3 9169.6 9195.3 4091.4 4697.4 4699.8 4708.1 4718.8 4267.7 4348.2 4359.9 4391.6 4395.7 3688.4 3730.4 3782.0 3808.4 3860.3 1203.4 1211.1 1228.5 1231.6 1240.4 800.2 867.9 883.3 886.8 903.0 5162.6 5198.9 5220.6 5278.5 5342.0 411.8 412.8 414.0 422.3 435.0 3875.5 3919.7 3932.9 3934.1 3953.9 9266.4 9451.2 9709.4 9822.8 9825.5 9547.9 9632.7 9694.8 9781.4 9792.7 7219.4 7417.4 7494.1 7499.6 7502.2 5323.9 5324.9 5386.6 5492.5 5511.9 8736.2 8860.9 8864.2 8866.8 8988.8 8869.8 9071.7 9100.0 9204.6 9282.7 6185.8 6478.8 6701.1 6906.2 6973.5 7301.2 7302.2 7344.4 7371.4 7375.7 6515.8 6626.9 6702.7 6736.1 6831.1 6499.4 6546.3 6586.9 6597.7 6609.6 5960.2 5984.6 6008.8 6011.9 6018.4 4542.7 4632.4 4640.9 4675.4 4706.1 4244.0 4508.0 4512.1 4543.3 4611.0 03:58:07 INFO - PROCESS | 3358 | 03:58:07 INFO - PROCESS | 3358 | [#4] prototype.html Cycles:180 Average:4338.54 Median:4930.30 stddev:1236.74 (25.1%) stddev-sans-first:1202.73 03:58:07 INFO - PROCESS | 3358 | Values: 313.0 319.1 320.2 322.0 323.9 4907.5 4919.6 4949.8 4953.7 4958.7 4886.3 4904.2 4908.0 4922.2 4938.4 3692.9 3793.6 3939.5 3947.8 3952.4 3900.0 3921.3 3924.5 3934.7 3941.3 3667.9 3879.6 3893.6 3901.3 3924.9 3771.4 3849.6 3865.0 3877.8 3908.6 3406.2 3464.2 3488.9 3500.2 3513.9 4783.4 4787.4 4788.2 4797.4 4820.3 4257.2 4479.7 4493.0 4501.1 4501.5 5099.7 5171.1 5184.4 5185.3 5187.4 3661.8 3797.3 3807.4 3809.1 3820.2 5355.5 5435.4 5439.7 5440.6 5450.8 3957.3 3967.1 3974.4 3977.3 3979.3 4028.1 4032.9 4033.9 4040.3 4040.7 4389.0 4430.0 4453.4 4456.7 4476.4 5154.2 5157.2 5169.4 5169.7 5191.6 1361.4 1384.1 1394.5 1396.0 1399.9 873.2 882.6 964.9 973.1 987.5 4579.1 4579.7 4579.8 4580.3 4596.9 5321.7 5357.9 5364.4 5368.4 5380.5 4362.4 4530.2 4558.6 4568.2 4573.4 2859.1 2872.3 2879.5 2884.5 2886.1 5014.9 5039.9 5055.8 5093.6 5096.4 5382.5 5442.9 5480.3 5494.3 5543.5 5045.3 5052.4 5059.3 5087.1 5091.2 5295.7 5359.4 5363.4 5380.6 5383.0 5081.0 5261.3 5262.2 5294.8 5300.3 5042.2 5048.7 5060.5 5072.0 5081.4 3770.2 3785.2 3788.7 3789.2 3807.0 5238.6 5340.3 5351.2 5366.6 5405.9 4967.4 5051.6 5167.7 5191.7 5200.6 5180.8 5182.2 5198.2 5198.6 5200.7 5106.6 5127.4 5161.9 5164.9 5165.1 5066.5 5215.7 5216.3 5216.4 5241.7 5097.7 5135.4 5140.1 5142.1 5149.6 03:58:07 INFO - PROCESS | 3358 | 03:58:07 INFO - PROCESS | 3358 | [#5] yui.html Cycles:180 Average:12584.29 Median:44186.17 stddev:14009.16 (31.7%) stddev-sans-first:14019.81 03:58:07 INFO - PROCESS | 3358 | Values: 655.9 694.5 720.4 735.8 738.5 12052.9 12210.9 12222.8 12422.0 12433.3 11342.7 11540.0 11547.8 11547.9 11570.0 638.1 653.8 655.5 807.3 827.9 661.7 783.6 813.2 818.5 818.6 864.6 865.4 867.8 868.1 868.2 670.2 858.5 861.2 861.6 862.2 599.7 622.3 623.2 623.3 623.5 12963.2 12999.7 13015.1 13030.9 13093.3 12283.3 12738.4 12792.6 12893.5 12928.4 9391.3 9464.4 9531.4 9651.6 9712.1 3323.7 3356.6 3369.8 3372.0 3473.8 46681.5 47081.8 47198.8 47598.5 47610.3 9914.4 10190.2 10198.8 10267.3 10352.7 18287.5 18311.3 18404.4 18417.9 18444.5 6711.8 6753.2 6773.3 6823.2 6995.6 3576.8 3602.8 3618.5 3681.7 3735.2 2706.6 2809.1 2813.5 2815.6 2828.2 465.5 495.0 523.2 527.8 531.4 588.6 595.9 600.1 670.5 672.8 7969.7 7982.3 8057.3 8151.7 8307.9 510.3 573.7 629.2 637.4 649.5 3669.7 3827.7 3924.7 3946.9 4032.6 50357.7 51237.7 52037.5 52280.0 52297.9 42878.0 43664.3 44708.0 44733.0 44834.8 40665.8 40679.2 41075.8 41433.8 41820.6 8134.9 8143.0 8307.2 8388.8 8660.5 25224.6 25243.0 25851.4 25940.6 26349.5 35201.5 35765.6 35999.8 36692.3 36978.3 10669.5 10783.6 10807.9 10865.1 11137.1 11702.2 11758.2 12037.2 12257.7 12311.7 11166.5 11555.2 11672.8 12227.1 12235.4 10778.6 10882.8 11082.2 11464.9 11542.5 11209.2 11277.2 11408.1 11992.7 11998.4 9119.3 9455.3 9719.7 9941.8 9952.4 8621.8 8807.3 9475.8 9488.2 9597.2 03:58:07 INFO - PROCESS | 3358 | -------- Summary: end -------- 03:58:07 INFO - PROCESS | 3358 | 03:58:07 INFO - TEST-INFO | 3358: exit 0 03:58:07 INFO - TEST-OK | dromaeo_css | took 1120444ms 03:58:07 INFO - TEST-START | kraken 03:58:07 INFO - operating with platform_type : linux_ 03:58:07 INFO - Initialising browser for kraken test... 03:58:07 INFO - TEST-INFO | started process 3562 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplkh9dC/profile http://localhost:50254/getInfo.html) 03:58:12 INFO - PROCESS | 3562 | __metrics Screen width/height:1600/1200 03:58:12 INFO - PROCESS | 3562 | colorDepth:24 03:58:12 INFO - PROCESS | 3562 | Browser inner width/height: 1024/697 03:58:12 INFO - PROCESS | 3562 | __metrics 03:58:13 ERROR - PROCESS | 3562 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:58:14 INFO - TEST-INFO | 3562: exit 0 03:58:14 INFO - Browser initialized. 03:58:14 INFO - Running cycle 1/1 for kraken test... 03:58:14 INFO - TEST-INFO | started process 3642 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplkh9dC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:58:26 INFO - PROCESS | 3642 | RSS: Main: 154591232 03:58:26 INFO - PROCESS | 3642 | 03:58:29 INFO - PROCESS | 3642 | Cycle 1(1): loaded http://localhost:50254/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50254/tests/kraken/driver.html?testName=audio-beat-detection) 03:58:30 INFO - PROCESS | 3642 | RSS: Main: 209973248 03:58:30 INFO - PROCESS | 3642 | 03:58:32 INFO - PROCESS | 3642 | Cycle 1(1): loaded http://localhost:50254/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50254/tests/kraken/driver.html?testName=audio-dft) 03:58:33 INFO - PROCESS | 3642 | RSS: Main: 195391488 03:58:33 INFO - PROCESS | 3642 | 03:58:36 INFO - PROCESS | 3642 | Cycle 1(1): loaded http://localhost:50254/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50254/tests/kraken/driver.html?testName=audio-fft) 03:58:37 INFO - PROCESS | 3642 | RSS: Main: 266002432 03:58:37 INFO - PROCESS | 3642 | 03:58:39 INFO - PROCESS | 3642 | Cycle 1(1): loaded http://localhost:50254/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50254/tests/kraken/driver.html?testName=audio-oscillator) 03:58:39 INFO - PROCESS | 3642 | RSS: Main: 173932544 03:58:39 INFO - PROCESS | 3642 | 03:58:42 INFO - PROCESS | 3642 | Cycle 1(1): loaded http://localhost:50254/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50254/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:58:42 INFO - PROCESS | 3642 | RSS: Main: 178184192 03:58:42 INFO - PROCESS | 3642 | 03:58:45 INFO - PROCESS | 3642 | Cycle 1(1): loaded http://localhost:50254/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50254/tests/kraken/driver.html?testName=imaging-darkroom) 03:58:46 INFO - PROCESS | 3642 | RSS: Main: 214278144 03:58:46 INFO - PROCESS | 3642 | 03:58:50 INFO - PROCESS | 3642 | Cycle 1(1): loaded http://localhost:50254/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50254/tests/kraken/driver.html?testName=imaging-desaturate) 03:58:50 INFO - PROCESS | 3642 | RSS: Main: 215388160 03:58:50 INFO - PROCESS | 3642 | 03:58:53 INFO - PROCESS | 3642 | Cycle 1(1): loaded http://localhost:50254/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50254/tests/kraken/driver.html?testName=json-parse-financial) 03:58:54 INFO - PROCESS | 3642 | RSS: Main: 215830528 03:58:54 INFO - PROCESS | 3642 | 03:58:55 INFO - PROCESS | 3642 | Cycle 1(1): loaded http://localhost:50254/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50254/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:58:56 INFO - PROCESS | 3642 | RSS: Main: 201228288 03:58:56 INFO - PROCESS | 3642 | 03:58:58 INFO - PROCESS | 3642 | Cycle 1(1): loaded http://localhost:50254/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50254/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:58:58 INFO - PROCESS | 3642 | RSS: Main: 204451840 03:58:58 INFO - PROCESS | 3642 | 03:59:00 INFO - PROCESS | 3642 | Cycle 1(1): loaded http://localhost:50254/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50254/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:59:01 INFO - PROCESS | 3642 | RSS: Main: 217546752 03:59:01 INFO - PROCESS | 3642 | 03:59:04 INFO - PROCESS | 3642 | Cycle 1(1): loaded http://localhost:50254/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50254/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:59:05 INFO - PROCESS | 3642 | RSS: Main: 224112640 03:59:05 INFO - PROCESS | 3642 | 03:59:08 INFO - PROCESS | 3642 | Cycle 1(1): loaded http://localhost:50254/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50254/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:59:08 INFO - PROCESS | 3642 | RSS: Main: 220299264 03:59:08 INFO - PROCESS | 3642 | 03:59:10 INFO - PROCESS | 3642 | Cycle 1(1): loaded http://localhost:50254/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50254/tests/kraken/driver.html?testName=ai-astar) 03:59:10 INFO - PROCESS | 3642 | RSS: Main: 284073984 03:59:10 INFO - PROCESS | 3642 | 03:59:10 INFO - PROCESS | 3642 | __start_tp_report 03:59:10 INFO - PROCESS | 3642 | _x_x_mozilla_page_load 03:59:10 INFO - PROCESS | 3642 | _x_x_mozilla_page_load_details 03:59:10 INFO - PROCESS | 3642 | |i|pagename|runs| 03:59:10 INFO - PROCESS | 3642 | |0;ai-astar;111;116;108;112;117;116;101;112;112;114 03:59:10 INFO - PROCESS | 3642 | |1;audio-beat-detection;165;133;161;179;130;172;164;134;196;140 03:59:10 INFO - PROCESS | 3642 | |2;audio-dft;161;161;161;162;163;163;164;163;162;162 03:59:10 INFO - PROCESS | 3642 | |3;audio-fft;75;78;111;103;78;74;75;126;103;75 03:59:10 INFO - PROCESS | 3642 | |4;audio-oscillator;94;95;151;95;94;95;147;95;94;144 03:59:10 INFO - PROCESS | 3642 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 03:59:10 INFO - PROCESS | 3642 | |6;imaging-darkroom;147;147;147;146;147;148;146;146;148;146 03:59:10 INFO - PROCESS | 3642 | |7;imaging-desaturate;96;95;96;95;95;95;95;95;95;95 03:59:10 INFO - PROCESS | 3642 | |8;json-parse-financial;64;65;65;66;67;66;65;81;65;63 03:59:10 INFO - PROCESS | 3642 | |9;json-stringify-tinderbox;64;66;65;64;66;64;64;65;65;65 03:59:10 INFO - PROCESS | 3642 | |10;stanford-crypto-aes;79;81;79;79;82;82;81;80;82;80 03:59:10 INFO - PROCESS | 3642 | |11;stanford-crypto-ccm;136;148;134;133;133;133;139;134;168;135 03:59:10 INFO - PROCESS | 3642 | |12;stanford-crypto-pbkdf2;176;175;178;174;174;179;175;179;177;179 03:59:10 INFO - PROCESS | 3642 | |13;stanford-crypto-sha256-iterative;73;74;71;73;73;74;72;72;75;71 03:59:10 INFO - PROCESS | 3642 | __end_tp_report 03:59:10 INFO - PROCESS | 3642 | __start_cc_report 03:59:10 INFO - PROCESS | 3642 | _x_x_mozilla_cycle_collect,1896 03:59:10 INFO - PROCESS | 3642 | __end_cc_report 03:59:10 INFO - PROCESS | 3642 | __startTimestamp1460804350673__endTimestamp 03:59:10 INFO - PROCESS | 3642 | 03:59:10 INFO - PROCESS | 3642 | ------- Summary: start ------- 03:59:10 INFO - PROCESS | 3642 | Number of tests: 14 03:59:10 INFO - PROCESS | 3642 | 03:59:10 INFO - PROCESS | 3642 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:4.70 (4.2%) stddev-sans-first:4.97 03:59:10 INFO - PROCESS | 3642 | Values: 111.0 116.0 108.0 112.0 117.0 116.0 101.0 112.0 112.0 114.0 03:59:10 INFO - PROCESS | 3642 | 03:59:10 INFO - PROCESS | 3642 | [#1] audio-beat-detection Cycles:10 Average:157.40 Median:164.50 stddev:22.31 (13.6%) stddev-sans-first:23.50 03:59:10 INFO - PROCESS | 3642 | Values: 165.0 133.0 161.0 179.0 130.0 172.0 164.0 134.0 196.0 140.0 03:59:10 INFO - PROCESS | 3642 | 03:59:10 INFO - PROCESS | 3642 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.50 stddev:1.03 (0.6%) stddev-sans-first:1.00 03:59:10 INFO - PROCESS | 3642 | Values: 161.0 161.0 161.0 162.0 163.0 163.0 164.0 163.0 162.0 162.0 03:59:10 INFO - PROCESS | 3642 | 03:59:10 INFO - PROCESS | 3642 | [#3] audio-fft Cycles:10 Average:89.80 Median:75.00 stddev:19.13 (25.5%) stddev-sans-first:19.53 03:59:10 INFO - PROCESS | 3642 | Values: 75.0 78.0 111.0 103.0 78.0 74.0 75.0 126.0 103.0 75.0 03:59:10 INFO - PROCESS | 3642 | 03:59:10 INFO - PROCESS | 3642 | [#4] audio-oscillator Cycles:10 Average:110.40 Median:94.50 stddev:25.54 (27.0%) stddev-sans-first:26.39 03:59:10 INFO - PROCESS | 3642 | Values: 94.0 95.0 151.0 95.0 94.0 95.0 147.0 95.0 94.0 144.0 03:59:10 INFO - PROCESS | 3642 | 03:59:10 INFO - PROCESS | 3642 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 03:59:10 INFO - PROCESS | 3642 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 03:59:10 INFO - PROCESS | 3642 | 03:59:10 INFO - PROCESS | 3642 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 03:59:10 INFO - PROCESS | 3642 | Values: 147.0 147.0 147.0 146.0 147.0 148.0 146.0 146.0 148.0 146.0 03:59:10 INFO - PROCESS | 3642 | 03:59:10 INFO - PROCESS | 3642 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 03:59:10 INFO - PROCESS | 3642 | Values: 96.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 03:59:10 INFO - PROCESS | 3642 | 03:59:10 INFO - PROCESS | 3642 | [#8] json-parse-financial Cycles:10 Average:66.70 Median:65.50 stddev:5.14 (7.9%) stddev-sans-first:5.36 03:59:10 INFO - PROCESS | 3642 | Values: 64.0 65.0 65.0 66.0 67.0 66.0 65.0 81.0 65.0 63.0 03:59:10 INFO - PROCESS | 3642 | 03:59:10 INFO - PROCESS | 3642 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 03:59:10 INFO - PROCESS | 3642 | Values: 64.0 66.0 65.0 64.0 66.0 64.0 64.0 65.0 65.0 65.0 03:59:10 INFO - PROCESS | 3642 | 03:59:10 INFO - PROCESS | 3642 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:81.00 stddev:1.27 (1.6%) stddev-sans-first:1.22 03:59:10 INFO - PROCESS | 3642 | Values: 79.0 81.0 79.0 79.0 82.0 82.0 81.0 80.0 82.0 80.0 03:59:10 INFO - PROCESS | 3642 | 03:59:10 INFO - PROCESS | 3642 | [#11] stanford-crypto-ccm Cycles:10 Average:139.30 Median:135.50 stddev:11.08 (8.2%) stddev-sans-first:11.68 03:59:10 INFO - PROCESS | 3642 | Values: 136.0 148.0 134.0 133.0 133.0 133.0 139.0 134.0 168.0 135.0 03:59:10 INFO - PROCESS | 3642 | 03:59:10 INFO - PROCESS | 3642 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.60 Median:177.50 stddev:2.07 (1.2%) stddev-sans-first:2.18 03:59:10 INFO - PROCESS | 3642 | Values: 176.0 175.0 178.0 174.0 174.0 179.0 175.0 179.0 177.0 179.0 03:59:10 INFO - PROCESS | 3642 | 03:59:10 INFO - PROCESS | 3642 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.80 Median:73.00 stddev:1.32 (1.8%) stddev-sans-first:1.39 03:59:10 INFO - PROCESS | 3642 | Values: 73.0 74.0 71.0 73.0 73.0 74.0 72.0 72.0 75.0 71.0 03:59:10 INFO - PROCESS | 3642 | -------- Summary: end -------- 03:59:10 INFO - PROCESS | 3642 | 03:59:11 INFO - TEST-INFO | 3642: exit 0 03:59:11 INFO - TEST-OK | kraken | took 63898ms 03:59:11 INFO - SUITE-END | took 1184s 03:59:11 INFO - Completed test suite (00:19:44) 03:59:11 INFO - javascript benchmark 03:59:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2616.1105224223766, 2690.300521864317, 2694.919152425428, 2713.4844379567894, 2732.863356832158, 4550.908981820362, 4666.370040044601, 4679.859604211875, 4687.906241875165, 4717.528247175285, 4692.765361731908, 4694.201985662437, 4756.833510827122, 4780.211265141256, 4784.0, 4264.744115353089, 4326.567343265672, 4352.020795321043, 4396.1427521633295, 4485.551444855521, 4407.360932664762, 4442.2448183808665, 4450.532694067125, 4463.866084017484, 4467.30756732707, 4166.270902592065, 4255.085156691295, 4255.17024180285, 4276.679249056302, 4368.912621747579, 4305.849295274682, 4353.151135528541, 4364.8472303469225, 4373.934390984138, 4405.581469760367, 4287.699861009731, 4312.892177695551, 4313.82744690212, 4321.848735294249, 4365.847195348148, 4420.778961051935, 4567.109413664337, 4584.977075114603, 4617.561331673485, 4651.279051746985, 4988.87527811804, 4992.176290912032, 4997.600191984632, 5036.647434679574, 5043.445221025721, 4989.501049895018, 5001.799928002875, 5012.423571289312, 5016.949830501685, 5018.749062546858, 4600.240960241523, 4658.394408726844, 4662.696924699883, 4677.158111539888, 4774.95225047745, 5107.540321371094, 5122.308488354099, 5137.486251374833, 5205.193195054772, 5240.790368385298, 4910.337104490848, 4934.654574179773, 4939.3084968104495, 4943.0, 4983.626228032912, 4854.902901942012, 5029.446760856303, 5042.218456139304, 5149.742512874342, 5154.716490593053, 5008.949910500848, 5013.273075404046, 5019.82430614934, 5024.899502009939, 5080.720560369141, 5010.098182327143, 5024.472430394829, 5026.597872170218, 5031.723255220998, 5032.446430892599, 4119.526254480713, 4193.6645068394455, 4201.180769749931, 4201.264778663722, 4213.747175169499, 3686.5391826021746, 3714.795686237283, 3721.1627383838963, 3731.7014638828828, 3736.495573097597, 4237.131388065439, 4237.300845360543, 4238.23711731885, 4265.594768496988, 4287.892802679958, 5016.322796422436, 5093.388793344749, 5093.668911520739, 5121.359830021247, 5139.922901156411, 4309.978450107729, 4321.308590625485, 4345.32647439641, 4348.826046958086, 4364.738115713068, 4558.088382323548, 4569.451665800058, 4574.748388838646, 4583.885402864955, 4601.815927362935, 4588.105319462673, 4736.786844592001, 4772.5227477252, 4825.710457372498, 4848.878778030577, 4968.975155124202, 5030.773615187399, 5067.011932673094, 5072.797088116434, 5116.897662046813, 4539.273716205391, 4742.905141897074, 4785.736784476887, 4792.376990991149, 4802.135615589227, 4942.184539550934, 4961.776720047678, 4997.875053123701, 5025.246213068069, 5041.193409054534, 5008.6243531734535, 5009.749512524432, 5043.697378157322, 5064.4935506449065, 5106.259592359162, 4671.8364857229835, 4879.292502587176, 4889.462159162418, 4908.435529914105, 4909.828156014522, 4921.753912304299, 4934.087193869145, 4946.134426475424, 4950.628702847373, 5000.224965130411, 4831.758412079312, 4853.635977301646, 4857.9514204858915, 4873.390826146731, 4897.583705385082, 4705.694129881546, 4896.755162241945, 4956.355673762388, 4959.553640172402, 5030.924536131888, 4835.540623640749, 4847.515248475124, 4853.854384368475, 4856.757162141949, 4895.996320754166], "value": 4620.992368241784, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.1392199052464, 606.3663471672102, 606.8742482694602, 614.0788816774838, 624.4411251929522, 25091.37271568212, 32422.0, 33429.16427089324, 33520.0, 33595.32809343815, 36398.81800591, 37235.441468377925, 37276.254474910485, 37287.440688389695, 37315.25369492608, 7608.923910760891, 7776.339011184028, 7778.766637000899, 7780.6109694515335, 7788.182240864712, 7736.690532378726, 7875.645595948196, 7879.881801772978, 7883.526988380687, 7884.093329267122, 7888.408369372291, 7966.123726390121, 7969.322607578363, 7970.163132871052, 7970.242826931432, 7879.330256928168, 7946.0464744230485, 7952.602369881541, 7953.522788632643, 7963.362930965509, 7770.922290777076, 7862.606869656494, 7870.173631768639, 7871.724489642892, 7871.881921771178, 36814.8159259202, 37305.0, 37376.25247495035, 37444.251114977546, 37473.0, 3010.412969470954, 3068.6777888321853, 3077.322988942429, 3094.2883136878418, 3150.84245787712, 28387.716122838712, 28692.71307286942, 28730.569041464394, 28973.42053158925, 29575.556366654517, 3505.4040813061843, 3543.7165026797793, 3550.982245088758, 3585.1933315003917, 3675.209829886587, 231897.0, 232250.0, 232830.0, 232901.0, 233462.83268583717, 52053.7397313011, 52125.218121728205, 52150.478495214564, 52247.73876130671, 52746.47253527492, 54665.726671367185, 55014.0, 55068.724656376464, 59309.0, 61528.69235653883, 14079.732824045885, 14155.0, 14157.646058848406, 14180.0, 14193.432262709583, 11993.100517461051, 12019.158658893793, 12054.578089766992, 12175.939120304341, 12192.0, 18188.362687410518, 18194.0, 18289.817101829078, 18309.0, 18380.63238735218, 6597.0, 6794.932050679528, 6958.37374636275, 7157.355837974607, 7198.172210195789, 884.1512148337667, 913.9040400757825, 947.4410098042188, 978.1099199728355, 983.2134292565919, 27517.587236191473, 28177.43645127127, 28727.569086463718, 29015.0, 29018.0, 887.9556022198993, 1014.9847752283722, 1029.2897900448665, 1039.6413237433073, 1072.5173671847544, 13808.240546770025, 14247.0, 14542.636434089232, 14555.92722036383, 14661.633459163606, 336392.0, 337221.0, 340099.0, 341364.0, 341919.0, 47508.76245618819, 47690.76154619205, 48038.27942580864, 48063.279050814264, 48158.75920620444, 1043.1602559939322, 1173.178774857603, 1195.5098409652176, 1283.7881749511412, 1340.611222745393, 25986.87006564955, 27748.722512774613, 27902.72097279001, 28030.579541306488, 28084.71915280821, 39250.80374598109, 40237.39643905402, 40515.0, 40632.39051414172, 40662.39006414847, 298584.0, 310195.0, 310514.0, 311117.0, 311855.0, 32622.0, 38786.4182037264, 39591.604083958795, 39595.80202098971, 40287.194256114126, 42050.57949420589, 42084.36873446962, 42108.15783684248, 42960.0, 43010.0, 35098.12254693653, 36094.278114438086, 36271.274574507835, 36917.815410922776, 37027.0, 35683.46474802828, 36583.634163658025, 36755.44866827053, 36940.26119477649, 37241.44137837989, 36111.0, 36167.63832361748, 37099.25801483901, 37154.44268335923, 37218.8139059303, 30872.845635772577, 32432.83783581067, 32814.34371312608, 33004.83497582497, 33036.834815825765, 24892.75107248904, 25345.87327063353, 25450.363740905887, 25552.744472555038, 25678.614820778075], "value": 17570.35362549029, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.8994535955011, 383.34448093759687, 392.2018691961858, 401.4199481748874, 403.92931237033514, 15229.543113706593, 16420.753688694665, 16466.423675171372, 16501.917490412547, 16514.33942642293, 10370.274080814346, 10907.454627268624, 10913.126949844012, 10914.454277286124, 10917.836232456519, 4601.332806743028, 4722.574968252857, 4768.260919557474, 4786.760661966905, 4788.186008378584, 4642.373279607261, 4804.855854324358, 4822.638302127337, 4829.1307564638355, 4837.9516204837855, 4816.686915350509, 4822.469528351879, 4824.686395384307, 5079.720615366154, 5466.34403871536, 5331.733413329318, 5338.839834804962, 5351.518363347279, 5353.839384818461, 5386.8383948481605, 5127.359080114986, 5207.9479205207845, 5221.321228240305, 5403.162509810985, 5414.458554144593, 12204.755904881942, 12547.686307842285, 12590.0, 12606.432710527957, 12755.872441275562, 1840.9539761505935, 1849.4913898677971, 1865.3844231403605, 1889.9149538270674, 1937.1476550317816, 9327.067293270686, 9573.090556397132, 9613.807723845553, 10920.890791092066, 13250.536231231861, 1768.6285879965224, 1805.8465030472425, 1817.690992531273, 1851.8425933795509, 1880.6332765110808, 66047.3395266046, 66470.3352966469, 66616.66691666559, 66619.66690166567, 67702.66148669274, 9949.303548751517, 10059.497025148714, 10064.849027264598, 10317.123044541147, 10348.379097254188, 14161.645958851112, 14251.714965700628, 14284.0, 14353.067050641675, 14357.712845743026, 7166.0, 7324.121105467378, 7474.5888976106835, 7564.810879728051, 7572.356349710336, 6953.687084081229, 6969.82575435608, 7106.92893071073, 7131.465140114408, 7148.714051437988, 4342.609165175086, 4355.607995280377, 4431.0, 4451.732896026248, 4490.0, 1791.7312403139372, 1850.3061351993003, 1861.6928206845719, 1884.7361369408293, 1891.7351570780102, 831.3806214370333, 859.8862090536282, 871.5118337147479, 956.6077908057663, 973.9123478886934, 16119.919400402923, 16152.35390584387, 16461.094639794926, 16844.157792110345, 17018.234179461953, 901.9729408117767, 904.841652710773, 909.9044600317004, 941.9764505887408, 957.3824882950458, 9042.367034307536, 9066.09339066088, 9237.399569027992, 9353.766155846159, 9540.618375264912, 368461.0, 369771.0, 373920.0, 378283.0, 378554.0, 71736.64131679309, 77252.61373693096, 80001.0, 84274.1008129425, 87349.56325218333, 984.9261305402124, 994.6335586774068, 1001.8296889528943, 1011.7116621762763, 1018.9286749927434, 15238.238088095773, 15359.07845529227, 15440.0, 15534.533963981099, 15753.842461575237, 33618.831905840314, 35199.0, 35242.942711718686, 36215.81892090523, 36481.45277820888, 43520.0, 44569.55430445784, 44918.10163796641, 45468.0, 50323.24515132349, 6422.0, 6623.337666233531, 6954.165500140016, 6976.720931162697, 7191.676374563262, 7606.923930760621, 7860.84278314442, 7898.328642065259, 7918.2477664621765, 8011.479253848481, 6953.721851125898, 7324.96337518309, 7360.742374017098, 7423.814404639711, 7433.888491672521, 7048.753293634698, 7150.0, 7157.463190260647, 7467.850642987219, 7478.925210748041, 7154.892676609751, 7179.066721326194, 7295.598742069237, 7374.483786134919, 7381.298776616213, 10596.31123976939, 10838.566457341618, 10861.185411094042, 10883.510242038968, 10888.128949683847, 10277.897221027994, 10392.272540922062, 10467.0, 10471.528781205016, 10600.734981625212], "value": 7725.654513701823, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1300.209888175967, 1431.1770731829201, 1472.8968972171945, 1591.2203020519942, 1810.1130446081415, 7467.0, 7769.922300776991, 7770.3783697304225, 7802.453828232019, 7809.687612495501, 7588.27911348421, 7739.729109481155, 7743.148253692089, 7745.031871016123, 7753.496022758517, 1899.6485650154766, 2159.8164156046755, 2164.729408823897, 2183.602494403583, 2254.0195015168374, 2246.539459410825, 2267.1498188179435, 2271.432141964509, 2272.397814579138, 2275.544891021794, 2211.402921211272, 2264.7735226477384, 2267.2178098555974, 2267.3424706835, 2268.3761965459466, 1906.551960289331, 2117.565898990711, 2178.215842296772, 2189.6715492676067, 2196.8352373572047, 2103.82117520011, 2117.375374264596, 2129.2866889592005, 2156.9245076422408, 2160.8919554022395, 7162.570245785218, 7238.2761723827725, 7267.200607933123, 7279.526830755984, 7290.526115802456, 4469.7541635210055, 4614.238650622643, 4632.397788287535, 4666.626669866402, 4735.289706544011, 2952.3062080411087, 3002.459557279689, 3031.227037105546, 3085.1670049086847, 3103.8758449661987, 997.1723469520281, 1040.8386700061503, 1059.0309866472169, 1832.844208242301, 1834.8256915592997, 10210.9489452553, 10345.896541034645, 10390.636327728493, 10411.167106631452, 10439.321444106108, 4096.32410652245, 4320.43834301545, 4395.252807022814, 4469.173202957463, 4470.418845550058, 9043.819123617492, 9057.139571740674, 9165.31260155491, 9169.633214671472, 9195.264378849675, 4091.4067460218102, 4697.389339385858, 4699.78850951708, 4708.105459962596, 4718.834840780556, 4267.722598031118, 4348.217320882209, 4359.869203923888, 4391.6486681065435, 4395.692301538862, 3688.354537955847, 3730.3658378075793, 3781.962180378216, 3808.3716186829415, 3860.2665493556133, 1203.3622180244483, 1211.1340391619858, 1228.4656174564093, 1231.612042206702, 1240.4480006397066, 800.1678254615251, 867.913208679127, 883.2580632268797, 886.7561420609255, 902.9503377314179, 5162.561182299547, 5198.92201616976, 5220.608454365938, 5278.4721527846905, 5341.973290133602, 411.83320755094235, 412.7853516171574, 413.99379009314885, 422.2673661197819, 434.97607631580564, 3875.476810630585, 3919.6668283195677, 3932.9016774580864, 3934.11482416454, 3953.8616148434667, 9266.444013359085, 9451.196648284973, 9709.417434953926, 9822.803543929223, 9825.45959972194, 9547.856782148274, 9632.662856799978, 9694.806103877883, 9781.364211326241, 9792.657256995972, 7219.386352160021, 7417.443691723142, 7494.063242094739, 7499.6250187490405, 7502.249775022454, 5323.866903327448, 5324.920126198032, 5386.622936394571, 5492.450754924475, 5511.889762204813, 8736.209077139298, 8860.911390886009, 8864.20222180007, 8866.822663546822, 8988.775280618036, 8869.778255543662, 9071.727848164302, 9100.0, 9204.631814727336, 9282.675106371245, 6185.752569897154, 6478.805635830932, 6701.0953521274005, 6906.205786334435, 6973.5118541701595, 7301.233370496234, 7302.160251571137, 7344.412447004333, 7371.447141464304, 7375.704971801282, 6515.771947981798, 6626.867462650816, 6702.698378573074, 6736.124303840469, 6831.11195544576, 6499.415052645285, 6546.312637173029, 6586.868262634624, 6597.736090556516, 6609.570377925419, 5960.225170727777, 5984.640921544721, 6008.849778755566, 6011.939880601313, 6018.36807135262, 4542.727436353829, 4632.420947381577, 4640.883977900579, 4675.438947326343, 4706.0823139487475, 4243.957560424356, 4508.030773383738, 4512.05246898155, 4543.273076307775, 4611.031683346535], "value": 4123.401733497005, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.9624445066591, 319.0762741862307, 320.2010982598417, 321.9855106520207, 323.9433099207641, 4907.509249075095, 4919.6310276729255, 4949.8367883547335, 4953.678010929287, 4958.652894297401, 4886.340344053552, 4904.239842824368, 4907.950920490794, 4922.1878390065685, 4938.407391113063, 3692.9261414771754, 3793.563740169888, 3939.527256729182, 3947.8420863165584, 3952.43878667926, 3900.0, 3921.274564205617, 3924.4505769192338, 3934.6655534279475, 3941.251162279172, 3667.889963301105, 3879.631435013669, 3893.5911729268446, 3901.2977664020464, 3924.921501569967, 3771.41543060826, 3849.615038496142, 3864.9806750966345, 3877.8448862045484, 3908.6482216600643, 3406.199543107368, 3464.2378676691087, 3488.9302213955834, 3500.2299494111508, 3513.91215219619, 4783.378160839104, 4787.3537072495465, 4788.186008378584, 4797.40032495938, 4820.276958456225, 4257.233697934371, 4479.686421950465, 4492.955070449287, 4501.054778496519, 4501.504834468205, 5099.668521546125, 5171.120909445403, 5184.429712731634, 5185.299984502081, 5187.403448603422, 3661.835217415223, 3797.3354662933875, 3807.447920051605, 3809.085819403323, 3820.178661587744, 5355.544778693777, 5435.369389183229, 5439.728013599344, 5440.619156659035, 5450.809221677222, 3957.2679054375035, 3967.0677390813134, 3974.4435778990965, 3977.3039718049226, 3979.263836190314, 4028.113814960704, 4032.943198968547, 4033.8789836304372, 4040.3333449980423, 4040.7373520721058, 4389.0, 4430.0, 4453.354263631755, 4456.68803183774, 4476.4180656514445, 5154.201098829612, 5157.200633901752, 5169.3796744390165, 5169.715665638426, 5191.610629202825, 1361.3533571553432, 1384.1072508232135, 1394.4770710983382, 1396.043710058613, 1399.8670126337981, 873.1879352202386, 882.5940067568862, 964.8793900762405, 973.0804389851522, 987.5013118375175, 4579.084183163381, 4579.702319349231, 4579.793909274091, 4580.312953057068, 4596.931046034312, 5321.733913304397, 5357.892842143136, 5364.3830959440165, 5368.382635996911, 5380.461953804666, 4362.389265502832, 4530.161920044737, 4558.566936141061, 4568.218394826021, 4573.405457290597, 2859.0993836941298, 2872.296287409598, 2879.452903948243, 2884.4952133376996, 2886.1197334812664, 5014.89970200594, 5039.874003149951, 5055.811884207208, 5093.617978651616, 5096.439391666913, 5382.542483888835, 5442.945570544323, 5480.260164877691, 5494.2582751328855, 5543.501084902378, 5045.318881950963, 5052.433745538895, 5059.3422855030085, 5087.135187018216, 5091.1854103343285, 5295.735213239245, 5359.410464848941, 5363.410024897336, 5380.596455265949, 5383.0, 5081.0, 5261.263423120843, 5262.236975638588, 5294.776193998607, 5300.31095957523, 5042.243663450512, 5048.697078175322, 5060.544550990428, 5071.974640126776, 5081.415637201769, 3770.208256266215, 3785.242951409784, 3788.7158463114824, 3789.2421515697524, 3806.980965095157, 5238.580913526985, 5340.305760251143, 5351.224072509543, 5366.624336296578, 5405.918911216257, 4967.4287456941465, 5051.621128415457, 5167.6641018333685, 5191.714455704821, 5200.583953283804, 5180.766865490987, 5182.170852663556, 5198.194279886624, 5198.584113271005, 5200.713960732045, 5106.617003724809, 5127.359080114986, 5161.922571161511, 5164.922526162186, 5165.070287348313, 5066.544011039025, 5215.739213039409, 5216.347956505437, 5216.40011398694, 5241.659292145999, 5097.719625420637, 5135.409427915837, 5140.074786538309, 5142.074426603247, 5149.639525233198], "value": 3952.626603360489, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.8884989551776, 694.5277211496181, 720.4308596208994, 735.7976556446973, 738.47937204271, 12052.879471205286, 12210.93894530526, 12222.755544889107, 12422.0, 12433.254004759721, 11342.716432089202, 11540.0, 11547.826782598268, 11547.942260288708, 11570.0, 638.097092613953, 653.7646447278976, 655.4919937048802, 807.3258828877879, 827.8592639251342, 661.7253839656537, 783.6277768060154, 813.1746277528314, 818.5497976113114, 818.615250832111, 864.5893200729635, 865.3682811547574, 867.8177582707639, 868.0754995929346, 868.2316150207049, 670.2493207607462, 858.5235194467068, 861.1990848510883, 861.5692153923038, 862.2498426369068, 599.706143989442, 622.3403192615797, 623.2209737827716, 623.2769986815318, 623.5385814497239, 12963.222206667535, 12999.740005199843, 13015.088943773939, 13030.934845325808, 13093.345332733325, 12283.263004219776, 12738.363081845871, 12792.61622151337, 12893.548725794552, 12928.418221179976, 9391.34260601758, 9464.384814987005, 9531.428114313094, 9651.613935442643, 9712.125908668253, 3323.6842499962463, 3356.63077061523, 3369.831508424569, 3371.983140084284, 3473.8263086845554, 46681.53318466806, 47081.76459117683, 47198.76400617975, 47598.52401475976, 47610.285845712344, 9914.355566888129, 10190.184785217165, 10198.796024079476, 10267.332623379456, 10352.689419317432, 18287.54281142982, 18311.267549298147, 18404.35584754527, 18417.90791046063, 18444.538886527946, 6711.798646040626, 6753.189617245962, 6773.288804675537, 6823.249442561314, 6995.580265184105, 3576.8211589420944, 3602.765820221677, 3618.493410922473, 3681.742278040565, 3735.159589092487, 2706.648135742341, 2809.0730059080456, 2813.521701310782, 2815.577663350514, 2828.2081017315186, 465.52748959805825, 494.9802007919643, 523.17338605004, 527.7677821758414, 531.4260598553553, 588.6350462713145, 595.8689088400545, 600.0818747316613, 670.4636290967304, 672.7981605518324, 7969.721059762996, 7982.281594656509, 8057.31512821405, 8151.673933042612, 8307.875381869277, 510.2728611728272, 573.6644063222977, 629.197772839624, 637.3849235487777, 649.4512137244021, 3669.6789155903853, 3827.655511004023, 3924.7448915820382, 3946.9013274668364, 4032.6370626643743, 50357.74821125871, 51237.74381128071, 52037.47962520402, 52280.0, 52297.90808367623, 42878.0, 43664.3450348245, 44708.0, 44733.0, 44834.77582612066, 40665.796671016455, 40679.18641627151, 41075.7946210273, 41433.79283103565, 41820.581794182275, 8134.877976830234, 8143.0, 8307.210814972568, 8388.832223355621, 8660.523671197892, 25224.621630675923, 25243.0, 25851.353716157246, 25940.610890836277, 26349.473010540067, 35201.47197791984, 35765.642343577274, 35999.82000090087, 36692.266154677294, 36978.260434790616, 10669.46652667379, 10783.6225732099, 10807.945960270148, 10865.13078953666, 11137.10903127764, 11702.180847340946, 11758.176927614984, 12037.157398982337, 12257.69355766113, 12311.69220769488, 11166.497507612014, 11555.191136620691, 11672.76654466889, 12227.0829687772, 12235.449404776627, 10778.568857245937, 10882.836757448804, 11082.22424430282, 11464.885351146382, 11542.480588373375, 11209.215354925404, 11277.154213433862, 11408.087353011573, 11992.700182495159, 11998.40007999614, 9119.270458363182, 9455.257975187118, 9719.659811906833, 9941.801163976825, 9952.402855828674, 8621.784455388415, 8807.295416366547, 9475.773193299432, 9488.193503552275, 9597.23222142241], "value": 5916.795181740855, "unit": "score"}], "name": "dromaeo_css", "value": 6265.481275542844, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 116.0, 108.0, 112.0, 117.0, 116.0, 101.0, 112.0, 112.0, 114.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 133.0, 161.0, 179.0, 130.0, 172.0, 164.0, 134.0, 196.0, 140.0], "value": 157.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 162.0, 163.0, 163.0, 164.0, 163.0, 162.0, 162.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 111.0, 103.0, 78.0, 74.0, 75.0, 126.0, 103.0, 75.0], "value": 89.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 151.0, 95.0, 94.0, 95.0, 147.0, 95.0, 94.0, 144.0], "value": 110.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 148.0, 146.0, 146.0, 148.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 66.0, 67.0, 66.0, 65.0, 81.0, 65.0, 63.0], "value": 66.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 64.0, 66.0, 64.0, 64.0, 65.0, 65.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 79.0, 79.0, 82.0, 82.0, 81.0, 80.0, 82.0, 80.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 148.0, 134.0, 133.0, 133.0, 133.0, 139.0, 134.0, 168.0, 135.0], "value": 139.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 175.0, 178.0, 174.0, 174.0, 179.0, 175.0, 179.0, 177.0, 179.0], "value": 176.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 71.0, 73.0, 73.0, 74.0, 72.0, 72.0, 75.0, 71.0], "value": 72.8, "unit": "score"}], "name": "kraken", "value": 1591.3999999999999, "alertThreshold": 2.0}]} 03:59:11 INFO - Return code: 0 03:59:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:59:11 ERROR - # TBPL SUCCESS # 03:59:11 INFO - Running post-action listener: _resource_record_post_action 03:59:11 INFO - Running post-run listener: _resource_record_post_run 03:59:13 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 10334208; Write bytes: 450195456; Read time: 2616; Write time: 499884 03:59:13 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 99520512; Read time: 196; Write time: 122612 03:59:13 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 10330112; Write bytes: 350674944; Read time: 2420; Write time: 377272 03:59:13 INFO - Running post-run listener: _upload_blobber_files 03:59:13 INFO - Blob upload gear active. 03:59:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:59:13 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 03:59:13 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'] 03:59:13 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 03:59:13 INFO - (blobuploader) - INFO - Open directory for files ... 03:59:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:59:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:59:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:59:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:59:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:59:14 INFO - (blobuploader) - INFO - Done attempting. 03:59:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:59:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:59:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:59:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:59:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:59:14 INFO - (blobuploader) - INFO - Done attempting. 03:59:14 INFO - (blobuploader) - INFO - Iteration through files over. 03:59:14 INFO - Return code: 0 03:59:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:59:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:59:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eed3c88a4e341bb401bb9e460c871e59c02954d6b8812af492f8cbe72cccfecaed0d498bdfa1989567eb3aca2e02a36dd8bea09df264c666f692be5fd7698c34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d3c8c6f74528568fcab00af7d122f4b76b4803dfce687b0f595edf6e8a9273a665c786f79d640bcd0e827259d962d3ecbd3dca871f825e7e788ed825b47499e4"} 03:59:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:59:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:59:14 INFO - Contents: 03:59:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eed3c88a4e341bb401bb9e460c871e59c02954d6b8812af492f8cbe72cccfecaed0d498bdfa1989567eb3aca2e02a36dd8bea09df264c666f692be5fd7698c34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d3c8c6f74528568fcab00af7d122f4b76b4803dfce687b0f595edf6e8a9273a665c786f79d640bcd0e827259d962d3ecbd3dca871f825e7e788ed825b47499e4"} 03:59:14 INFO - Running post-run listener: copy_logs_to_upload_dir 03:59:14 INFO - Copying logs to upload dir... 03:59:14 INFO - mkdir: /builds/slave/test/build/upload/logs 03:59:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.303136 ========= master_lag: -0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-04-16 03:59:14.878679) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-16 03:59:14.882336) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1460802939.897490-626456260 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/eed3c88a4e341bb401bb9e460c871e59c02954d6b8812af492f8cbe72cccfecaed0d498bdfa1989567eb3aca2e02a36dd8bea09df264c666f692be5fd7698c34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d3c8c6f74528568fcab00af7d122f4b76b4803dfce687b0f595edf6e8a9273a665c786f79d640bcd0e827259d962d3ecbd3dca871f825e7e788ed825b47499e4"} build_url:https://queue.taskcluster.net/v1/task/K_2XnYfSSUmzZrMz0BELFw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011121 build_url: 'https://queue.taskcluster.net/v1/task/K_2XnYfSSUmzZrMz0BELFw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eed3c88a4e341bb401bb9e460c871e59c02954d6b8812af492f8cbe72cccfecaed0d498bdfa1989567eb3aca2e02a36dd8bea09df264c666f692be5fd7698c34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d3c8c6f74528568fcab00af7d122f4b76b4803dfce687b0f595edf6e8a9273a665c786f79d640bcd0e827259d962d3ecbd3dca871f825e7e788ed825b47499e4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-16 03:59:14.906315) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 03:59:14.906596) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1460802939.897490-626456260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004420 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 03:59:14.991416) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-16 03:59:14.991705) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-16 03:59:14.991977) ========= ========= Total master_lag: 0.11 =========