builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-039 starttime: 1462628137.83 results: success (0) buildid: 20160507050149 builduid: 7aff6ce9d7944ec0a8359b19e03ec161 revision: bae525a694e2dc0aa433885be8751330d4995a49 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-07 06:35:37.826859) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-07 06:35:37.827413) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-07 06:35:37.827700) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-07 06:35:37.898734) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 06:35:37.899290) ========= 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=5bd038846534b2fdfa68eeae000001e2-1462625871.325808-1176405867 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-07 06:35:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.8M=0s 2016-05-07 06:35:38 (88.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116735 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 06:35:38.032409) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 06:35:38.032733) ========= 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=5bd038846534b2fdfa68eeae000001e2-1462625871.325808-1176405867 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019407 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 06:35:38.083704) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 06:35:38.084097) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bae525a694e2dc0aa433885be8751330d4995a49 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev bae525a694e2dc0aa433885be8751330d4995a49 --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=5bd038846534b2fdfa68eeae000001e2-1462625871.325808-1176405867 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-07 06:35:38,234 truncating revision to first 12 chars 2016-05-07 06:35:38,234 Setting DEBUG logging. 2016-05-07 06:35:38,234 attempt 1/10 2016-05-07 06:35:38,234 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bae525a694e2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-07 06:35:38,522 unpacking tar archive at: mozilla-central-bae525a694e2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.586935 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 06:35:38.685946) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-07 06:35:38.686295) ========= script_repo_revision: bae525a694e2dc0aa433885be8751330d4995a49 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-07 06:35:38.686736) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-07 06:35:38.687012) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-07 06:35:38.697060) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-07 06:35:38.697432) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=5bd038846534b2fdfa68eeae000001e2-1462625871.325808-1176405867 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:35:38 INFO - MultiFileLogger online at 20160507 06:35:38 in /builds/slave/test 06:35:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 06:35:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:35:38 INFO - {'append_to_log': False, 06:35:38 INFO - 'base_work_dir': '/builds/slave/test', 06:35:38 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 06:35:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:35:38 INFO - 'branch': 'Firefox-Non-PGO', 06:35:38 INFO - 'buildbot_json_path': 'buildprops.json', 06:35:38 INFO - 'config_files': ('talos/linux_config.py',), 06:35:38 INFO - 'default_actions': ('clobber', 06:35:38 INFO - 'read-buildbot-config', 06:35:38 INFO - 'download-and-extract', 06:35:38 INFO - 'populate-webroot', 06:35:38 INFO - 'create-virtualenv', 06:35:38 INFO - 'install', 06:35:38 INFO - 'run-tests'), 06:35:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:35:38 INFO - 'download_minidump_stackwalk': True, 06:35:38 INFO - 'download_symbols': 'ondemand', 06:35:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:35:38 INFO - 'tooltool.py': '/tools/tooltool.py', 06:35:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:35:38 INFO - '/tools/misc-python/virtualenv.py')}, 06:35:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:35:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:35:38 INFO - 'installer_path': 'installer.exe', 06:35:38 INFO - 'log_level': 'info', 06:35:38 INFO - 'log_name': 'talos', 06:35:38 INFO - 'log_to_console': True, 06:35:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:35:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:35:38 INFO - 'opt_config_files': (), 06:35:38 INFO - 'pip_index': False, 06:35:38 INFO - 'sps_profile': False, 06:35:38 INFO - 'sps_profile_interval': 0, 06:35:38 INFO - 'suite': 'dromaeojs', 06:35:38 INFO - 'system_bits': '32', 06:35:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:35:38 INFO - 'title': 'talos-linux64-ix-039', 06:35:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:35:38 INFO - 'use_talos_json': True, 06:35:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:35:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:35:38 INFO - 'work_dir': 'build'} 06:35:38 INFO - ##### 06:35:38 INFO - ##### Running clobber step. 06:35:38 INFO - ##### 06:35:38 INFO - Running pre-action listener: _resource_record_pre_action 06:35:38 INFO - Running main action method: clobber 06:35:38 INFO - rmtree: /builds/slave/test/build 06:35:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:35:39 INFO - Running post-action listener: _resource_record_post_action 06:35:39 INFO - ##### 06:35:39 INFO - ##### Finished clobber step (success) 06:35:39 INFO - ##### 06:35:39 INFO - ##### 06:35:39 INFO - ##### Running read-buildbot-config step. 06:35:39 INFO - ##### 06:35:39 INFO - Running pre-action listener: _resource_record_pre_action 06:35:39 INFO - Running main action method: read_buildbot_config 06:35:39 INFO - Using buildbot properties: 06:35:39 INFO - { 06:35:39 INFO - "project": "", 06:35:39 INFO - "product": "firefox", 06:35:39 INFO - "script_repo_revision": "production", 06:35:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:35:39 INFO - "repository": "", 06:35:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 06:35:39 INFO - "buildid": "20160507050149", 06:35:39 INFO - "pgo_build": "False", 06:35:39 INFO - "basedir": "/builds/slave/test", 06:35:39 INFO - "buildnumber": 499, 06:35:39 INFO - "slavename": "talos-linux64-ix-039", 06:35:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:35:39 INFO - "platform": "ubuntu64_hw", 06:35:39 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 06:35:39 INFO - "branch": "mozilla-central", 06:35:39 INFO - "repo_path": "mozilla-central", 06:35:39 INFO - "revision": "bae525a694e2dc0aa433885be8751330d4995a49", 06:35:39 INFO - "stage_platform": "linux64", 06:35:39 INFO - "builduid": "7aff6ce9d7944ec0a8359b19e03ec161", 06:35:39 INFO - "slavebuilddir": "test" 06:35:39 INFO - } 06:35:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/YRbs5HPzQOud-TXFR4Fy7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 06:35:39 INFO - Running post-action listener: _resource_record_post_action 06:35:39 INFO - ##### 06:35:39 INFO - ##### Finished read-buildbot-config step (success) 06:35:39 INFO - ##### 06:35:39 INFO - ##### 06:35:39 INFO - ##### Running download-and-extract step. 06:35:39 INFO - ##### 06:35:39 INFO - Running pre-action listener: _resource_record_pre_action 06:35:39 INFO - Running main action method: download_and_extract 06:35:39 INFO - mkdir: /builds/slave/test/build/tests 06:35:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:39 INFO - https://queue.taskcluster.net/v1/task/YRbs5HPzQOud-TXFR4Fy7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:35:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YRbs5HPzQOud-TXFR4Fy7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:35:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YRbs5HPzQOud-TXFR4Fy7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:35:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YRbs5HPzQOud-TXFR4Fy7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:35:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YRbs5HPzQOud-TXFR4Fy7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:35:40 INFO - Downloaded 1361 bytes. 06:35:40 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:35:40 INFO - Using the following test package requirements: 06:35:40 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:35:40 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:35:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:35:40 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:35:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:35:40 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:35:40 INFO - u'jsshell-linux-x86_64.zip'], 06:35:40 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:35:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:35:40 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:35:40 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:35:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:35:40 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:35:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:35:40 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:35:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:35:40 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:35:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:35:40 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:35: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')]} 06:35:40 INFO - https://queue.taskcluster.net/v1/task/YRbs5HPzQOud-TXFR4Fy7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:35:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YRbs5HPzQOud-TXFR4Fy7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:35:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YRbs5HPzQOud-TXFR4Fy7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:35:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YRbs5HPzQOud-TXFR4Fy7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:35:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YRbs5HPzQOud-TXFR4Fy7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:35:41 INFO - Downloaded 22321119 bytes. 06:35:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:35:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:35:42 INFO - Return code: 0 06:35:42 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:35:42 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')]} 06:35:42 INFO - https://queue.taskcluster.net/v1/task/YRbs5HPzQOud-TXFR4Fy7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:35:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YRbs5HPzQOud-TXFR4Fy7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:35:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YRbs5HPzQOud-TXFR4Fy7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:35:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YRbs5HPzQOud-TXFR4Fy7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:35:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YRbs5HPzQOud-TXFR4Fy7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:35:43 INFO - Downloaded 22321119 bytes. 06:35:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:35:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:35:45 INFO - Return code: 0 06:35: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')]} 06:35:45 INFO - https://queue.taskcluster.net/v1/task/YRbs5HPzQOud-TXFR4Fy7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:35:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YRbs5HPzQOud-TXFR4Fy7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:35:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YRbs5HPzQOud-TXFR4Fy7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:35:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YRbs5HPzQOud-TXFR4Fy7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:35:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YRbs5HPzQOud-TXFR4Fy7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:35:46 INFO - Downloaded 10840152 bytes. 06:35:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:35:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:35:46 INFO - Return code: 0 06:35: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')]} 06:35:46 INFO - https://queue.taskcluster.net/v1/task/YRbs5HPzQOud-TXFR4Fy7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:35:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YRbs5HPzQOud-TXFR4Fy7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:35:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YRbs5HPzQOud-TXFR4Fy7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:35:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YRbs5HPzQOud-TXFR4Fy7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:35:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YRbs5HPzQOud-TXFR4Fy7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:35:48 INFO - Downloaded 54838803 bytes. 06:35:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YRbs5HPzQOud-TXFR4Fy7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:35:48 INFO - mkdir: /builds/slave/test/properties 06:35:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:35:48 INFO - Writing to file /builds/slave/test/properties/build_url 06:35:48 INFO - Contents: 06:35:48 INFO - build_url:https://queue.taskcluster.net/v1/task/YRbs5HPzQOud-TXFR4Fy7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:35:48 INFO - Running post-action listener: _resource_record_post_action 06:35:48 INFO - Running post-action listener: set_extra_try_arguments 06:35:48 INFO - ##### 06:35:48 INFO - ##### Finished download-and-extract step (success) 06:35:48 INFO - ##### 06:35:48 INFO - ##### 06:35:48 INFO - ##### Running populate-webroot step. 06:35:48 INFO - ##### 06:35:48 INFO - Running pre-action listener: _resource_record_pre_action 06:35:48 INFO - Running main action method: populate_webroot 06:35:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:35:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:35:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:35:49 INFO - '--tppagecycles', 06:35:49 INFO - '7'], 06:35:49 INFO - 'tests': ['tsvgm']}}, 06:35:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:35:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:35:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:35:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:35:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:35:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:35:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:49 INFO - 'talos_options': ['--disable-e10s'], 06:35:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:35:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:35:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:49 INFO - 'talos_options': ['--disable-e10s'], 06:35:49 INFO - 'tests': ['damp', 'tps']}, 06:35:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:49 INFO - 'tests': ['damp', 'tps']}, 06:35:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:35:49 INFO - 'tests': ['dromaeo_dom']}, 06:35:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:35:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:35:49 INFO - 'tests': ['a11yr', 06:35:49 INFO - 'ts_paint', 06:35:49 INFO - 'tpaint', 06:35:49 INFO - 'sessionrestore', 06:35:49 INFO - 'sessionrestore_no_auto_restore', 06:35:49 INFO - 'tabpaint']}, 06:35:49 INFO - 'other-e10s': {'tests': ['a11yr', 06:35:49 INFO - 'ts_paint', 06:35:49 INFO - 'tpaint', 06:35:49 INFO - 'sessionrestore', 06:35:49 INFO - 'sessionrestore_no_auto_restore', 06:35:49 INFO - 'tabpaint']}, 06:35:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:35:49 INFO - 'ts_paint', 06:35:49 INFO - 'tpaint', 06:35:49 INFO - 'sessionrestore', 06:35:49 INFO - 'sessionrestore_no_auto_restore', 06:35:49 INFO - 'tabpaint']}, 06:35:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:35:49 INFO - 'ts_paint', 06:35:49 INFO - 'tpaint', 06:35:49 INFO - 'sessionrestore', 06:35:49 INFO - 'sessionrestore_no_auto_restore', 06:35:49 INFO - 'tabpaint']}, 06:35:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:35:49 INFO - 'tests': ['a11yr', 06:35:49 INFO - 'ts_paint', 06:35:49 INFO - 'tpaint', 06:35:49 INFO - 'sessionrestore', 06:35:49 INFO - 'sessionrestore_no_auto_restore', 06:35:49 INFO - 'tabpaint']}, 06:35:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:35:49 INFO - 'tests': ['a11yr', 06:35:49 INFO - 'ts_paint', 06:35:49 INFO - 'tpaint', 06:35:49 INFO - 'sessionrestore', 06:35:49 INFO - 'sessionrestore_no_auto_restore', 06:35:49 INFO - 'tabpaint']}, 06:35:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:35:49 INFO - 'tests': ['tsvgx', 06:35:49 INFO - 'tsvgr_opacity', 06:35:49 INFO - 'tart', 06:35:49 INFO - 'tscrollx', 06:35:49 INFO - 'cart']}, 06:35:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:35:49 INFO - 'tsvgr_opacity', 06:35:49 INFO - 'tart', 06:35:49 INFO - 'tscrollx', 06:35:49 INFO - 'cart']}, 06:35:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:49 INFO - 'talos_options': ['--disable-e10s'], 06:35:49 INFO - 'tests': ['tp5o']}, 06:35:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:49 INFO - 'tests': ['tp5o']}, 06:35:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:49 INFO - 'talos_options': ['--disable-e10s', 06:35:49 INFO - '--xperf_path', 06:35:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:35:49 INFO - 'tests': ['tp5n']}, 06:35:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:49 INFO - 'talos_options': ['--xperf_path', 06:35:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:35:49 INFO - 'tests': ['tp5n']}}, 06:35:49 INFO - 'talos.zip': {'path': '', 06:35:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:35:49 INFO - Running post-action listener: _resource_record_post_action 06:35:49 INFO - ##### 06:35:49 INFO - ##### Finished populate-webroot step (success) 06:35:49 INFO - ##### 06:35:49 INFO - ##### 06:35:49 INFO - ##### Running create-virtualenv step. 06:35:49 INFO - ##### 06:35:49 INFO - Running pre-action listener: _resource_record_pre_action 06:35:49 INFO - Running main action method: create_virtualenv 06:35:49 INFO - Creating virtualenv /builds/slave/test/build/venv 06:35:49 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 06:35:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:35:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:35:49 INFO - Using real prefix '/usr' 06:35:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:35:49 INFO - Installing distribute.............................................................................................................................................................................................done. 06:35:51 INFO - Installing pip.................done. 06:35:51 INFO - Return code: 0 06:35:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:35: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')]} 06:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35: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')]} 06:35:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9edc000f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15639c0>, '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 0x15648c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1564d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1462625871.325808-1176405867', '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 06:35: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', 'pip>=1.5'] in /builds/slave/test/build 06:35: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 pip>=1.5 06:35:51 INFO - Using env: {'DISPLAY': ':0', 06:35:51 INFO - 'HOME': '/home/cltbld', 06:35:51 INFO - 'LANG': 'en_US.UTF-8', 06:35:51 INFO - 'LANGUAGE': 'en_US:en', 06:35:51 INFO - 'LOGNAME': 'cltbld', 06:35:51 INFO - 'MAIL': '/var/mail/cltbld', 06:35:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:51 INFO - 'MOZ_NO_REMOTE': '1', 06:35:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:51 INFO - 'NO_EM_RESTART': '1', 06:35:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:51 INFO - 'PWD': '/builds/slave/test', 06:35:51 INFO - 'SHELL': '/bin/bash', 06:35:51 INFO - 'SHLVL': '1', 06:35:51 INFO - 'TERM': 'linux', 06:35:51 INFO - 'TMOUT': '86400', 06:35:51 INFO - 'USER': 'cltbld', 06:35:51 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1462625871.325808-1176405867', 06:35:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:51 INFO - '_': '/tools/buildbot/bin/python'} 06:35:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:51 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 06:35:51 INFO - Cleaning up... 06:35:51 INFO - Return code: 0 06:35:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:35: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')]} 06:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35: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')]} 06:35:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35: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', '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 0x7f9edc000f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15639c0>, '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 0x15648c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1564d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1462625871.325808-1176405867', '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 06:35: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', 'psutil>=0.7.1'] in /builds/slave/test/build 06:35: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 psutil>=0.7.1 06:35:51 INFO - Using env: {'DISPLAY': ':0', 06:35:51 INFO - 'HOME': '/home/cltbld', 06:35:51 INFO - 'LANG': 'en_US.UTF-8', 06:35:51 INFO - 'LANGUAGE': 'en_US:en', 06:35:51 INFO - 'LOGNAME': 'cltbld', 06:35:51 INFO - 'MAIL': '/var/mail/cltbld', 06:35:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:51 INFO - 'MOZ_NO_REMOTE': '1', 06:35:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:51 INFO - 'NO_EM_RESTART': '1', 06:35:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:51 INFO - 'PWD': '/builds/slave/test', 06:35:51 INFO - 'SHELL': '/bin/bash', 06:35:51 INFO - 'SHLVL': '1', 06:35:51 INFO - 'TERM': 'linux', 06:35:51 INFO - 'TMOUT': '86400', 06:35:51 INFO - 'USER': 'cltbld', 06:35:51 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1462625871.325808-1176405867', 06:35:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:51 INFO - '_': '/tools/buildbot/bin/python'} 06:35:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:52 INFO - Downloading/unpacking psutil>=0.7.1 06:35:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:35:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:35:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:35:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:35:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:35:54 INFO - Installing collected packages: psutil 06:35:54 INFO - Running setup.py install for psutil 06:35:54 INFO - building 'psutil._psutil_linux' extension 06:35:54 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 06:35:54 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 06:35:54 INFO - building 'psutil._psutil_posix' extension 06:35:54 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 06:35:54 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 06:35:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:35:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:35:54 INFO - Successfully installed psutil 06:35:54 INFO - Cleaning up... 06:35:54 INFO - Return code: 0 06:35:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:54 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 0x7f9edc000f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15639c0>, '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 0x15648c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1564d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1462625871.325808-1176405867', '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 06:35:54 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 06:35:54 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 06:35:54 INFO - Using env: {'DISPLAY': ':0', 06:35:54 INFO - 'HOME': '/home/cltbld', 06:35:54 INFO - 'LANG': 'en_US.UTF-8', 06:35:54 INFO - 'LANGUAGE': 'en_US:en', 06:35:54 INFO - 'LOGNAME': 'cltbld', 06:35:54 INFO - 'MAIL': '/var/mail/cltbld', 06:35:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:54 INFO - 'MOZ_NO_REMOTE': '1', 06:35:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:54 INFO - 'NO_EM_RESTART': '1', 06:35:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:54 INFO - 'PWD': '/builds/slave/test', 06:35:54 INFO - 'SHELL': '/bin/bash', 06:35:54 INFO - 'SHLVL': '1', 06:35:54 INFO - 'TERM': 'linux', 06:35:54 INFO - 'TMOUT': '86400', 06:35:54 INFO - 'USER': 'cltbld', 06:35:54 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1462625871.325808-1176405867', 06:35:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:54 INFO - '_': '/tools/buildbot/bin/python'} 06:35:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:35:54 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 06:35:54 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 06:35:54 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 06:35:54 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 06:35:54 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 06:35:54 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 06:35:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:35:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:35:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:35:56 INFO - Installing collected packages: mozsystemmonitor 06:35:56 INFO - Running setup.py install for mozsystemmonitor 06:35:56 INFO - Successfully installed mozsystemmonitor 06:35:56 INFO - Cleaning up... 06:35:56 INFO - Return code: 0 06:35:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:35:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:56 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 0x7f9edc000f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15639c0>, '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 0x15648c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1564d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1462625871.325808-1176405867', '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 06:35:56 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 06:35:56 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 06:35:56 INFO - Using env: {'DISPLAY': ':0', 06:35:56 INFO - 'HOME': '/home/cltbld', 06:35:56 INFO - 'LANG': 'en_US.UTF-8', 06:35:56 INFO - 'LANGUAGE': 'en_US:en', 06:35:56 INFO - 'LOGNAME': 'cltbld', 06:35:56 INFO - 'MAIL': '/var/mail/cltbld', 06:35:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:56 INFO - 'MOZ_NO_REMOTE': '1', 06:35:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:56 INFO - 'NO_EM_RESTART': '1', 06:35:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:56 INFO - 'PWD': '/builds/slave/test', 06:35:56 INFO - 'SHELL': '/bin/bash', 06:35:56 INFO - 'SHLVL': '1', 06:35:56 INFO - 'TERM': 'linux', 06:35:56 INFO - 'TMOUT': '86400', 06:35:56 INFO - 'USER': 'cltbld', 06:35:56 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1462625871.325808-1176405867', 06:35:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:56 INFO - '_': '/tools/buildbot/bin/python'} 06:35:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:57 INFO - Downloading/unpacking blobuploader==1.2.4 06:35:57 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 06:35:57 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 06:35:57 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 06:35:57 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 06:35:57 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 06:35:57 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 06:35:58 INFO - Downloading blobuploader-1.2.4.tar.gz 06:35:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:35:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:35:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:35:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:35:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:59 INFO - Downloading docopt-0.6.1.tar.gz 06:35:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:35:59 INFO - Installing collected packages: blobuploader, requests, docopt 06:35:59 INFO - Running setup.py install for blobuploader 06:35:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:35:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:35:59 INFO - Running setup.py install for requests 06:36:00 INFO - Running setup.py install for docopt 06:36:00 INFO - Successfully installed blobuploader requests docopt 06:36:00 INFO - Cleaning up... 06:36:00 INFO - Return code: 0 06:36:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:00 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 0x7f9edc000f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15639c0>, '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 0x15648c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1564d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1462625871.325808-1176405867', '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 06:36:00 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 06:36:00 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 06:36:00 INFO - Using env: {'DISPLAY': ':0', 06:36:00 INFO - 'HOME': '/home/cltbld', 06:36:00 INFO - 'LANG': 'en_US.UTF-8', 06:36:00 INFO - 'LANGUAGE': 'en_US:en', 06:36:00 INFO - 'LOGNAME': 'cltbld', 06:36:00 INFO - 'MAIL': '/var/mail/cltbld', 06:36:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:00 INFO - 'MOZ_NO_REMOTE': '1', 06:36:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:00 INFO - 'NO_EM_RESTART': '1', 06:36:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:00 INFO - 'PWD': '/builds/slave/test', 06:36:00 INFO - 'SHELL': '/bin/bash', 06:36:00 INFO - 'SHLVL': '1', 06:36:00 INFO - 'TERM': 'linux', 06:36:00 INFO - 'TMOUT': '86400', 06:36:00 INFO - 'USER': 'cltbld', 06:36:00 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1462625871.325808-1176405867', 06:36:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:00 INFO - '_': '/tools/buildbot/bin/python'} 06:36:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:36:00 INFO - Running setup.py (path:/tmp/pip-O_PABn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:36:00 INFO - Running setup.py (path:/tmp/pip-GGVZPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:36:00 INFO - Running setup.py (path:/tmp/pip-Cn3S6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:36:00 INFO - Running setup.py (path:/tmp/pip-1kEceA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:36:00 INFO - Running setup.py (path:/tmp/pip-Sj7YxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:36:00 INFO - Running setup.py (path:/tmp/pip-k2eq8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:36:00 INFO - Running setup.py (path:/tmp/pip-lqppCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:36:01 INFO - Running setup.py (path:/tmp/pip-z750dN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:36:01 INFO - Running setup.py (path:/tmp/pip-hJM1h9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:36:01 INFO - Running setup.py (path:/tmp/pip-5JpM6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:36:01 INFO - Running setup.py (path:/tmp/pip-BZERRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:36:01 INFO - Running setup.py (path:/tmp/pip-J4UEbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:36:01 INFO - Running setup.py (path:/tmp/pip-6RT6hb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:36:01 INFO - Running setup.py (path:/tmp/pip-2fu16v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:36:01 INFO - Running setup.py (path:/tmp/pip-1cAWDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:36:01 INFO - Running setup.py (path:/tmp/pip-jDvyR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:36:01 INFO - Running setup.py (path:/tmp/pip-uAb5pb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:36:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:36:01 INFO - Running setup.py install for manifestparser 06:36:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:36:01 INFO - Running setup.py install for mozcrash 06:36:01 INFO - Running setup.py install for mozdebug 06:36:02 INFO - Running setup.py install for mozdevice 06:36:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:36:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:36:02 INFO - Running setup.py install for mozfile 06:36:02 INFO - Running setup.py install for mozhttpd 06:36:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:36:02 INFO - Running setup.py install for mozinfo 06:36:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:36:02 INFO - Running setup.py install for mozInstall 06:36:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:36:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:36:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:36:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:36:02 INFO - Running setup.py install for mozleak 06:36:02 INFO - Running setup.py install for mozlog 06:36:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:36:02 INFO - Running setup.py install for moznetwork 06:36:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:36:02 INFO - Running setup.py install for mozprocess 06:36:02 INFO - Running setup.py install for mozprofile 06:36:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:36:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:36:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:36:03 INFO - Running setup.py install for mozrunner 06:36:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:36:03 INFO - Running setup.py install for mozscreenshot 06:36:03 INFO - Running setup.py install for moztest 06:36:03 INFO - Running setup.py install for mozversion 06:36:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:36:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:36:03 INFO - Cleaning up... 06:36:03 INFO - Return code: 0 06:36:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:36:03 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')]} 06:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:03 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')]} 06:36:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:03 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 0x7f9edc000f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15639c0>, '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 0x15648c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1564d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1462625871.325808-1176405867', '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 06:36:03 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 06:36:03 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 06:36:03 INFO - Using env: {'DISPLAY': ':0', 06:36:03 INFO - 'HOME': '/home/cltbld', 06:36:03 INFO - 'LANG': 'en_US.UTF-8', 06:36:03 INFO - 'LANGUAGE': 'en_US:en', 06:36:03 INFO - 'LOGNAME': 'cltbld', 06:36:03 INFO - 'MAIL': '/var/mail/cltbld', 06:36:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:03 INFO - 'MOZ_NO_REMOTE': '1', 06:36:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:03 INFO - 'NO_EM_RESTART': '1', 06:36:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:03 INFO - 'PWD': '/builds/slave/test', 06:36:03 INFO - 'SHELL': '/bin/bash', 06:36:03 INFO - 'SHLVL': '1', 06:36:03 INFO - 'TERM': 'linux', 06:36:03 INFO - 'TMOUT': '86400', 06:36:03 INFO - 'USER': 'cltbld', 06:36:03 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1462625871.325808-1176405867', 06:36:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:03 INFO - '_': '/tools/buildbot/bin/python'} 06:36:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:36:03 INFO - Running setup.py (path:/tmp/pip-jd_s8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:36:03 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)) 06:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:36:03 INFO - Running setup.py (path:/tmp/pip-4EOerG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:36:03 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)) 06:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:36:03 INFO - Running setup.py (path:/tmp/pip-cfUyFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:36:03 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)) 06:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:36:03 INFO - Running setup.py (path:/tmp/pip-pgYjj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:36:04 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)) 06:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:36:04 INFO - Running setup.py (path:/tmp/pip-Q9EEhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:36:04 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)) 06:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:36:04 INFO - Running setup.py (path:/tmp/pip-tNwdZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:36:04 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)) 06:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:36:04 INFO - Running setup.py (path:/tmp/pip-yxZUFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:36:04 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)) 06:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:36:04 INFO - Running setup.py (path:/tmp/pip-LOZ4t4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:36:04 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)) 06:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:36:04 INFO - Running setup.py (path:/tmp/pip-hNibzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:36:04 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)) 06:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:36:04 INFO - Running setup.py (path:/tmp/pip-J4vu19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:36:04 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)) 06:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:36:04 INFO - Running setup.py (path:/tmp/pip-dUkMjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:36:04 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)) 06:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:36:04 INFO - Running setup.py (path:/tmp/pip-4tO9Fe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:36:04 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)) 06:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:36:04 INFO - Running setup.py (path:/tmp/pip-GZRJC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:36:04 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)) 06:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:36:04 INFO - Running setup.py (path:/tmp/pip-5qzbZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:36:04 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)) 06:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:36:04 INFO - Running setup.py (path:/tmp/pip-U1eSdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:36:04 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)) 06:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:36:04 INFO - Running setup.py (path:/tmp/pip-FZw57p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:36:04 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)) 06:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:36:04 INFO - Running setup.py (path:/tmp/pip-D4ShJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:36:05 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)) 06:36:05 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)) 06:36:05 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)) 06:36:05 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)) 06:36:05 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)) 06:36:05 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)) 06:36:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:06 INFO - Downloading blessings-1.6.tar.gz 06:36:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:36:07 INFO - Installing collected packages: blessings 06:36:07 INFO - Running setup.py install for blessings 06:36:07 INFO - Successfully installed blessings 06:36:07 INFO - Cleaning up... 06:36:07 INFO - Return code: 0 06:36:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:36:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:36:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:36:07 INFO - Reading from file tmpfile_stdout 06:36:07 INFO - Current package versions: 06:36:07 INFO - argparse == 1.2.1 06:36:07 INFO - blessings == 1.6 06:36:07 INFO - blobuploader == 1.2.4 06:36:07 INFO - docopt == 0.6.1 06:36:07 INFO - manifestparser == 1.1 06:36:07 INFO - mozInstall == 1.12 06:36:07 INFO - mozcrash == 0.17 06:36:07 INFO - mozdebug == 0.1 06:36:07 INFO - mozdevice == 0.48 06:36:07 INFO - mozfile == 1.2 06:36:07 INFO - mozhttpd == 0.7 06:36:07 INFO - mozinfo == 0.9 06:36:07 INFO - mozleak == 0.1 06:36:07 INFO - mozlog == 3.1 06:36:07 INFO - moznetwork == 0.27 06:36:07 INFO - mozprocess == 0.22 06:36:07 INFO - mozprofile == 0.28 06:36:07 INFO - mozrunner == 6.11 06:36:07 INFO - mozscreenshot == 0.1 06:36:07 INFO - mozsystemmonitor == 0.0 06:36:07 INFO - moztest == 0.7 06:36:07 INFO - mozversion == 1.4 06:36:07 INFO - psutil == 3.1.1 06:36:07 INFO - requests == 1.2.3 06:36:07 INFO - wsgiref == 0.1.2 06:36:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:36:07 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')]} 06:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:07 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')]} 06:36:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:07 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 0x7f9edc000f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15639c0>, '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 0x15648c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1564d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1462625871.325808-1176405867', '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 06:36:07 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 06:36:07 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 06:36:07 INFO - Using env: {'DISPLAY': ':0', 06:36:07 INFO - 'HOME': '/home/cltbld', 06:36:07 INFO - 'LANG': 'en_US.UTF-8', 06:36:07 INFO - 'LANGUAGE': 'en_US:en', 06:36:07 INFO - 'LOGNAME': 'cltbld', 06:36:07 INFO - 'MAIL': '/var/mail/cltbld', 06:36:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:07 INFO - 'MOZ_NO_REMOTE': '1', 06:36:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:07 INFO - 'NO_EM_RESTART': '1', 06:36:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:07 INFO - 'PWD': '/builds/slave/test', 06:36:07 INFO - 'SHELL': '/bin/bash', 06:36:07 INFO - 'SHLVL': '1', 06:36:07 INFO - 'TERM': 'linux', 06:36:07 INFO - 'TMOUT': '86400', 06:36:07 INFO - 'USER': 'cltbld', 06:36:07 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1462625871.325808-1176405867', 06:36:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:07 INFO - '_': '/tools/buildbot/bin/python'} 06:36:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:07 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)) 06:36:07 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)) 06:36:07 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)) 06:36:07 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)) 06:36:07 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)) 06:36:07 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)) 06:36:07 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)) 06:36:07 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)) 06:36:07 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)) 06:36:07 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)) 06:36:07 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)) 06:36:07 INFO - Cleaning up... 06:36:07 INFO - Return code: 0 06:36:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:36:07 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')]} 06:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:07 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')]} 06:36:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:07 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 0x7f9edc000f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15639c0>, '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 0x15648c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1564d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1462625871.325808-1176405867', '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 06:36:07 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 06:36:07 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 06:36:07 INFO - Using env: {'DISPLAY': ':0', 06:36:07 INFO - 'HOME': '/home/cltbld', 06:36:07 INFO - 'LANG': 'en_US.UTF-8', 06:36:07 INFO - 'LANGUAGE': 'en_US:en', 06:36:07 INFO - 'LOGNAME': 'cltbld', 06:36:07 INFO - 'MAIL': '/var/mail/cltbld', 06:36:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:07 INFO - 'MOZ_NO_REMOTE': '1', 06:36:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:07 INFO - 'NO_EM_RESTART': '1', 06:36:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:07 INFO - 'PWD': '/builds/slave/test', 06:36:07 INFO - 'SHELL': '/bin/bash', 06:36:07 INFO - 'SHLVL': '1', 06:36:07 INFO - 'TERM': 'linux', 06:36:07 INFO - 'TMOUT': '86400', 06:36:07 INFO - 'USER': 'cltbld', 06:36:07 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1462625871.325808-1176405867', 06:36:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:07 INFO - '_': '/tools/buildbot/bin/python'} 06:36:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:07 INFO - Downloading/unpacking jsonschema 06:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:36:10 INFO - Downloading/unpacking functools32 (from jsonschema) 06:36:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:10 INFO - Downloading functools32-3.2.3-2.tar.gz 06:36:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:36:10 INFO - warning: no files found matching '*.txt' 06:36:10 INFO - no previously-included directories found matching 'build' 06:36:10 INFO - no previously-included directories found matching 'dist' 06:36:10 INFO - no previously-included directories found matching '.git*' 06:36:10 INFO - Installing collected packages: jsonschema, functools32 06:36:10 INFO - Running setup.py install for functools32 06:36:10 INFO - warning: no files found matching '*.txt' 06:36:10 INFO - no previously-included directories found matching 'build' 06:36:10 INFO - no previously-included directories found matching 'dist' 06:36:10 INFO - no previously-included directories found matching '.git*' 06:36:10 INFO - Successfully installed jsonschema functools32 06:36:10 INFO - Cleaning up... 06:36:10 INFO - Return code: 0 06:36:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:36:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9edc000f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15639c0>, '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 0x15648c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1564d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1462625871.325808-1176405867', '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 06:36:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 06:36:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:36:10 INFO - Using env: {'DISPLAY': ':0', 06:36:10 INFO - 'HOME': '/home/cltbld', 06:36:10 INFO - 'LANG': 'en_US.UTF-8', 06:36:10 INFO - 'LANGUAGE': 'en_US:en', 06:36:10 INFO - 'LOGNAME': 'cltbld', 06:36:10 INFO - 'MAIL': '/var/mail/cltbld', 06:36:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:10 INFO - 'MOZ_NO_REMOTE': '1', 06:36:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:10 INFO - 'NO_EM_RESTART': '1', 06:36:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:10 INFO - 'PWD': '/builds/slave/test', 06:36:10 INFO - 'SHELL': '/bin/bash', 06:36:10 INFO - 'SHLVL': '1', 06:36:10 INFO - 'TERM': 'linux', 06:36:10 INFO - 'TMOUT': '86400', 06:36:10 INFO - 'USER': 'cltbld', 06:36:10 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1462625871.325808-1176405867', 06:36:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:10 INFO - '_': '/tools/buildbot/bin/python'} 06:36:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:11 INFO - Downloading/unpacking flake8 06:36:11 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 06:36:11 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 06:36:11 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 06:36:11 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 06:36:11 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 06:36:11 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 06:36:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:36:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:36:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:36:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:36:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:36:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:36:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:36:13 INFO - no previously-included directories found matching 'docs/_build' 06:36:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:36:13 INFO - Running setup.py install for pep8 06:36:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:36:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:36:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:36:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:36:13 INFO - no previously-included directories found matching 'docs/_build' 06:36:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:36:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:36:13 INFO - Cleaning up... 06:36:14 INFO - Return code: 0 06:36:14 INFO - Running post-action listener: _resource_record_post_action 06:36:14 INFO - Running post-action listener: _start_resource_monitoring 06:36:14 INFO - Starting resource monitoring. 06:36:14 INFO - ##### 06:36:14 INFO - ##### Finished create-virtualenv step (success) 06:36:14 INFO - ##### 06:36:14 INFO - ##### 06:36:14 INFO - ##### Running install step. 06:36:14 INFO - ##### 06:36:14 INFO - Running pre-action listener: _resource_record_pre_action 06:36:14 INFO - Running main action method: install 06:36:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:36:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:36:14 INFO - Reading from file tmpfile_stdout 06:36:14 INFO - Detecting whether we're running mozinstall >=1.0... 06:36:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:36:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:36:14 INFO - Reading from file tmpfile_stdout 06:36:14 INFO - Output received: 06:36:14 INFO - Usage: mozinstall [options] installer 06:36:14 INFO - Options: 06:36:14 INFO - -h, --help show this help message and exit 06:36:14 INFO - -d DEST, --destination=DEST 06:36:14 INFO - Directory to install application into. [default: 06:36:14 INFO - "/builds/slave/test"] 06:36:14 INFO - --app=APP Application being installed. [default: firefox] 06:36:14 INFO - mkdir: /builds/slave/test/build/application 06:36:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:36:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:36:30 INFO - Reading from file tmpfile_stdout 06:36:30 INFO - Output received: 06:36:30 INFO - /builds/slave/test/build/application/firefox/firefox 06:36:30 INFO - Running post-action listener: _resource_record_post_action 06:36:30 INFO - ##### 06:36:30 INFO - ##### Finished install step (success) 06:36:30 INFO - ##### 06:36:30 INFO - ##### 06:36:30 INFO - ##### Running run-tests step. 06:36:30 INFO - ##### 06:36:30 INFO - Running pre-action listener: _resource_record_pre_action 06:36:30 INFO - Running main action method: run_tests 06:36:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:36:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:36:30 INFO - Python 2.7.3 06:36:30 INFO - Return code: 0 06:36:30 INFO - grabbing minidump binary from tooltool 06:36:30 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')]} 06:36:30 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 0x15639c0>, '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 0x15648c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1564d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:36:30 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 06:36:30 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 06:36:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:36:30 INFO - Return code: 0 06:36:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:36:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:36:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:36:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:36:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:36:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:36:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:36:31 INFO - Return code: 0 06:36:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YRbs5HPzQOud-TXFR4Fy7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 06:36:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YRbs5HPzQOud-TXFR4Fy7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --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 06:36:31 INFO - Using env: {'DISPLAY': ':0', 06:36:31 INFO - 'HOME': '/home/cltbld', 06:36:31 INFO - 'LANG': 'en_US.UTF-8', 06:36:31 INFO - 'LANGUAGE': 'en_US:en', 06:36:31 INFO - 'LOGNAME': 'cltbld', 06:36:31 INFO - 'MAIL': '/var/mail/cltbld', 06:36:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:36:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:36:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:31 INFO - 'MOZ_NO_REMOTE': '1', 06:36:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:36:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:31 INFO - 'NO_EM_RESTART': '1', 06:36:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:31 INFO - 'PWD': '/builds/slave/test', 06:36:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:36:31 INFO - 'SHELL': '/bin/bash', 06:36:31 INFO - 'SHLVL': '1', 06:36:31 INFO - 'TERM': 'linux', 06:36:31 INFO - 'TMOUT': '86400', 06:36:31 INFO - 'USER': 'cltbld', 06:36:31 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1462625871.325808-1176405867', 06:36:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:31 INFO - '_': '/tools/buildbot/bin/python'} 06:36:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YRbs5HPzQOud-TXFR4Fy7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 06:36:31 INFO - mozversion application_buildid: 20160507050149 06:36:31 INFO - mozversion application_changeset: bae525a694e2dc0aa433885be8751330d4995a49 06:36:31 INFO - mozversion application_display_name: Nightly 06:36:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:36:31 INFO - mozversion application_name: Firefox 06:36:31 INFO - mozversion application_remotingname: firefox 06:36:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:36:31 INFO - mozversion application_vendor: Mozilla 06:36:31 INFO - mozversion application_version: 49.0a1 06:36:31 INFO - mozversion platform_buildid: 20160507050149 06:36:31 INFO - mozversion platform_changeset: bae525a694e2dc0aa433885be8751330d4995a49 06:36:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:36:31 INFO - mozversion platform_version: 49.0a1 06:36:31 INFO - using testdate: 1462628191 06:36:31 INFO - actual date: 1462628191 06:36:31 INFO - starting webserver on 'localhost:43068' 06:36:31 INFO - SUITE-START | Running 2 tests 06:36:31 INFO - TEST-START | dromaeo_css 06:36:31 INFO - operating with platform_type : linux_ 06:36:31 INFO - Initialising browser for dromaeo_css test... 06:36:31 INFO - TEST-INFO | started process 13157 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppUYXVc/profile http://localhost:43068/getInfo.html) 06:36:35 INFO - PROCESS | 13157 | __metrics Screen width/height:1600/1200 06:36:35 INFO - PROCESS | 13157 | colorDepth:24 06:36:35 INFO - PROCESS | 13157 | Browser inner width/height: 1024/697 06:36:35 INFO - PROCESS | 13157 | __metrics 06:36:36 ERROR - PROCESS | 13157 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:36:37 INFO - TEST-INFO | 13157: exit 0 06:36:37 INFO - Browser initialized. 06:36:37 INFO - Running cycle 1/1 for dromaeo_css test... 06:36:37 INFO - TEST-INFO | started process 13236 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppUYXVc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:36:49 INFO - PROCESS | 13236 | RSS: Main: 154021888 06:36:49 INFO - PROCESS | 13236 | 06:37:41 INFO - PROCESS | 13236 | 1462628261182 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] 06:39:52 INFO - PROCESS | 13236 | Cycle 1(1): loaded http://localhost:43068/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43068/tests/dromaeo/cssquery-ext.html) 06:39:53 INFO - PROCESS | 13236 | RSS: Main: 230055936 06:39:53 INFO - PROCESS | 13236 | 06:42:56 INFO - PROCESS | 13236 | Cycle 1(1): loaded http://localhost:43068/tests/dromaeo/cssquery-ext.html (next: http://localhost:43068/tests/dromaeo/cssquery-jquery.html) 06:42:56 INFO - PROCESS | 13236 | RSS: Main: 241299456 06:42:56 INFO - PROCESS | 13236 | 06:45:58 INFO - PROCESS | 13236 | Cycle 1(1): loaded http://localhost:43068/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43068/tests/dromaeo/cssquery-mootools.html) 06:45:59 INFO - PROCESS | 13236 | RSS: Main: 243331072 06:45:59 INFO - PROCESS | 13236 | 06:49:01 INFO - PROCESS | 13236 | Cycle 1(1): loaded http://localhost:43068/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43068/tests/dromaeo/cssquery-prototype.html) 06:49:02 INFO - PROCESS | 13236 | RSS: Main: 232288256 06:49:02 INFO - PROCESS | 13236 | 06:52:05 INFO - PROCESS | 13236 | Cycle 1(1): loaded http://localhost:43068/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43068/tests/dromaeo/cssquery-yui.html) 06:52:05 INFO - PROCESS | 13236 | RSS: Main: 212639744 06:52:05 INFO - PROCESS | 13236 | 06:55:08 INFO - PROCESS | 13236 | Cycle 1(1): loaded http://localhost:43068/tests/dromaeo/cssquery-yui.html (next: http://localhost:43068/tests/dromaeo/cssquery-dojo.html) 06:55:08 INFO - PROCESS | 13236 | RSS: Main: 268058624 06:55:08 INFO - PROCESS | 13236 | 06:55:08 INFO - PROCESS | 13236 | __start_tp_report 06:55:08 INFO - PROCESS | 13236 | _x_x_mozilla_page_load 06:55:08 INFO - PROCESS | 13236 | _x_x_mozilla_page_load_details 06:55:08 INFO - PROCESS | 13236 | |i|pagename|runs| 06:55:08 INFO - PROCESS | 13236 | |0;dojo.html;2591.3003489057955;2597.558415069438;2640.181543721446;2643.550596398612;2645.259327388331;4463.977680111603;4503.347014682869;4560.749158796265;4593.333966574849;4625.791839367228;4525.117602067598;4549.431321084864;4559.088182363533;4577.038821847408;4580.358749775034;4211.957880421187;4223.535411104784;4255.085156691311;4284.850030248942;4339.826406943718;4282.443282373287;4293.355996600504;4310.288802347609;4328.783560821962;4350.56494350564;4163.542010378856;4196.664266858644;4198.202341555126;4208.663306935453;4221.598948099926;4183.226103170923;4195.622393984556;4197;4239.533651298355;4245.044864905402;4233.555476674936;4238.87283381499;4246.936295955563;4274.807633656493;4278.229918614648;4294;4417.646588272931;4444.888877778049;4459.777011149429;4546.727196368229;4822.758862056883;4846.878828029292;4861.440934292531;4911.066897289504;4911.238757992517;4883.34074899891;4897.8285759998225;4899.461059283476;4901.044296362211;4912.435069966964;4452.666050046227;4492.595666390008;4535;4538.909221815546;4597.7241365518175;4942.9258561121615;4954.801807927714;4983.526564976321;4989.875253118701;4996.775145118406;4702.6708130431225;4745.311929770233;4751.524847515221;4799.0641824844515;4800.615950723934;4763.214069678534;4824.807007719652;4855.247436647325;4855.975720121377;4866.635002374836;4811.27830825372;4847.878803029953;4848.418189817245;4857.247126695368;4880.097182021337;4705.223638099676;4769.8569042928075;4813.927791083137;4820.831270905572;4885.828995985124;4111.033907031845;4130.132672138884;4133.318002529609;4165.416841642173;4173.728707633994;3575.481555174485;3613;3615.0239435352833;3641.10792855752;3656.5063716398477;4114.588541145921;4163.646090082317;4200.201961627281;4263.211305908417;4269.0608066226005;4883.121038213156;4900.950990490121;4907.165781817028;4924.729139897268;4966.6771659842;4235.343417009224;4242.703010789277;4253.064325848309;4275.87172384829;4293.957060429356;4288.35674648799;4325.4593175853015;4393.648508119343;4403.471583410012;4424.933625995613;4667.6265898728025;4675.9532404676875;4713.29300604912;4716.174669432767;4765.380500534909;4975.228839529878;4975.378077740283;4978.775955082103;4979.377577802775;5016.54851063406;4515.345274935182;4562.520935301745;4610.077984403066;4706.717596944194;4745.952540474551;4805;4829.27560865873;4831.830885918976;4870.245112007645;4874.683145595525;4884.462709101925;4888.90222195547;4889.486603906538;4900.313956046228;4948.257761335828;4679.532046795293;4712.222483290218;4751.049790041936;4762.547557981986;4802.807887684454;4799.184138696361;4805.495422980537;4811.663183577116;4818.614510839055;4854.975725121493;4746.169420351355;4759.524047595212;4762.095201911626;4804.95195048045;4810.13417584838;4596.2186428306595;4695.9530404695515;4726.976365118152;4732.432108147044;4743.407074115736;4639.0721855628335;4648.1168577970075;4656.8602941911795;4656.906861862812;4699.459562150259 06:55:08 INFO - PROCESS | 13236 | |1;ext.html;587.3275100010488;608.5010291560919;609.3632154398653;611.3092205807437;615.2586133708879;27728.861355693218;28275.29311767204;30887.227819304473;30891.536626950612;30983.535246971314;42458;43266.99999999992;43326.35010474845;48358;48516;8058.5567793771315;8177.264046235838;8184.6726130954985;8190.836183276331;8191.426600137993;8070.192980701912;8154.836903261931;8155.10293867674;8157.061937877161;8160.3471722262075;8142.837143257131;8162.102168761431;8173.591320433984;8174.795630109265;8176;8099.7570072897615;8150.592470376487;8151.959240203821;8152.225538573826;8157.673693052271;8108.189181081844;8138.145494723028;8146.5519396433765;8146.75559733209;8175.386845986574;39964.60035399638;40524.79737601322;40707.185856283;40747.59252407467;40777.38833917493;3352.6479719629333;3359.9328013439595;3403.897883063512;3508.649135086471;3563.750537462379;29989.413045315097;30081.699183008328;30541.847290763628;30619.846900765577;30666;3374.9831250843836;3404.3191361727504;3439.0886415100017;3495.2135769451925;3587.9282414351565;243524;243624;244693;244849;245495;57073.71463142741;57265.713671431375;57688.42311576915;57849.71075144597;57939;61026;61280.38719612836;61488.69255653693;61705.38294617086;61813.690931545054;15616.297266623029;15774.290156942965;15807.446739364066;15832.604184895239;15868.920655396649;12249.632511024683;12329.93835030837;12336.444859981322;12336.444859981322;12341.938290308492;17529.996797830077;18352.724709129372;18643;18691.813081869008;18799.248030078918;5410.565245639478;6236.563440559208;6435.099086127946;6505.349465053551;6578.473722102221;853.8932633420823;948.1608776233084;949.8290307744534;1028.876534815827;1072.1744256922127;28283.575746363822;28975.56536651952;29020.564691529646;29393.412131757672;29581;993.4039576254335;1043.5669197283194;1059.6662051453768;1092.5356723392526;1175.588544009607;15351.23243837826;15357.15535645528;15772.526824195293;15868.603284917739;16076.678466430605;329111;330448;334335;334475;335584;51711;51721.48278517167;51779;52018.21972670413;52258.738706306984;1195.121585634558;1289.4970961325091;1293.204679122333;1326.555603872694;1327.6879933215687;28558;29836.104916852528;29934.401311974074;30160.5475917857;30728;44263;44355.77822110869;44817.327740083274;44957.775211123735;45006.54993450024;273049;274673;275567;275834;276808;33506.329873401904;34671.82664086663;38396.42405363866;40204.3969340466;40501.594984050964;42818.78590607027;42960;43346.566534335514;44805.55194448014;44825.55174448214;36044.63955360413;37730.24539509249;38651;38653.420198697604;38874;37216.88349349524;37482.250354993295;37605.24789504249;37811.243775124894;38135;36623.45064824083;38532;39492.21015579615;39708.205835883695;42250.577494224664;31390.529142063344;34405.31189376248;34543.827280863436;34670;34874.651253488155;26046;26117.415441194596;26257.73742262553;26326;26554.468910621294 06:55:08 INFO - PROCESS | 13236 | |2;jquery.html;373.6226411324563;375.5212104566678;376.0936143893217;379.3134426687697;391.6749098248452;15868.920655396721;17304.913475432604;17486.21312040958;17697.73453398197;17858.107094645264;10588.258821882471;15861.524154275361;16617.584560385996;16633.584160395996;17342.138547139708;4626.907461850769;4737.73942433166;4750.667453278272;4777.04459108178;4786.37777088978;3421.469672200813;5100.693958362492;5377.139657654776;5378.058839703056;5457.645253058538;5421.484958928895;5424.728763561826;5429.56563474921;5444.373897001836;5456.154296084113;5108.361454818148;5398.217258497515;5406.972965135188;5449.455054494559;5458.372287186985;3385.2213990782257;3569.6430356964356;3570.428731402989;3595.3708101082207;4912.287718280829;11273.549058037668;11815.11386646005;11822.763544729143;12385;20273.69589456159;1853.8702290839512;1930.0458086802232;1935;1976.6343226503;2255.5037891663974;8720.345974051972;9024.819503609957;9094.909050909473;9135.54322283883;9582.28132890036;1650.1254335202361;1738.6696527659703;1743.808181100078;1790.6060666653316;1792.9282828686837;66490.33509664939;68338.25316895315;68407;68493.31506684919;68999;9761.902380976242;9766.169875560658;9812.116909478182;9855.063768941938;10486;13024.739505209844;13043.543475978486;13098.869011309955;13166.802497962539;13181.143225690299;7129.857402851914;7369.410447164214;7437.776866694008;7440.441966852508;7481.7755467336065;7221.96389018062;7238.348548630648;7373.866106904544;7390.667419966115;7416.962915185498;4033.5361433435532;4101.138760860253;4143.70994030421;4154.792260387029;4170.04089059518;1573.8268790433044;1668.4483430409834;1694.5340031491191;1709.9316027358766;1731.6536692661518;817.595290331278;929.2194556572512;951.6764300137847;964.2912459342377;984.8719666443317;16427.83572164263;16965.575860603585;17199.57001074983;17571.121443927754;18641.533961650795;874.3398733955822;924.7641851327868;960.3146477931186;967.3277072434731;979.9216062714966;9553.474558899326;10034.347767395097;10143.137833284105;10161.796764064677;10192.847107293397;440554;442057;442689;446326;469232;83843.58078209692;84569.15430845736;85377.57311213529;86105;87524;948.5399581203111;966.7148191283588;977.7995510920244;980.5391466010964;984.1487113646645;15299.770503442234;15485;15652.843471565138;15679.608009799846;15870.68258634844;35025;35226.82386588153;35546.64453355433;35923.46114808332;37380.62619373771;52890.73554632202;52922.470775293295;52974.735126325664;53197.4680253208;53213.4678653224;7454.701811927679;7469.253074692705;7506;7711.187870850234;7732.381409487115;10502.159827213958;11370.772584548096;11436.771264574829;11450.141239406912;11558.422078895854;9244.630214791334;9628.555716642559;9902.207823373968;10136.64521741765;10358.948205258925;10116.747081323027;10203.38779673222;10306.793864122825;10474.423906685206;10623.89376106229;9989;10003.899961000297;10191.94904025475;10438.739031523968;10522.263441559324;7779;7837.333826624573;7838.255365740246;7871.960640196762;7996.3602911768085;9718.173955213886;10394.272400931863;10414.479276036016;10423.895761042595;10468.842967355647 06:55:08 INFO - PROCESS | 13236 | |3;mootools.html;1286.2989670629506;1494.1931357067185;1523.4667866246812;1697.8047524534675;1869.3457289948528;7055.57666540008;7325.41396688265;7368.705251789936;7529.698812047512;7557.92442075579;7311.89032164518;7484.738034168805;7485.0643669541305;7487.213842546522;7496.325330720234;2191.5945550073247;2208.5472478142024;2211.2039665720326;2211.7124773779387;2220.8667479951173;2213.8450308478414;2230.018791731633;2282.1099771089207;2289.519200967799;2291.450051987519;2201.2295696506176;2202.1631779923605;2228.0642130305228;2241.607718649238;2242.7308722953267;2149.000714667671;2164.177612507245;2177.194438057913;2183.825293976478;2187.9015444305046;2127.0322003488377;2133.434639820449;2136.6688163334707;2137.946551336229;2150.086213359332;7383.446241531907;7400.962995184989;7429.108506979197;7452.552846829153;7639.618019099023;4411.625011873963;4549.181147393468;4570.268756998864;4579.404677391951;4585.380973568593;2884.5817356483403;2905.7239562241552;2947.6168098147105;2982.164993801717;2983.030515082607;930.734740598926;949.5062567464879;965.9227261819037;967.709687093869;974.2254907348674;10022.749431264203;10210.591576337012;10221.029002244775;10238.744031399274;10267.38395696253;4166.687498437569;4240.173166232555;4338.631216346583;4346.891327716832;4359.760213188241;8873.600687969058;8902.465852048897;8940.552972351357;8947.955260223658;8979.775505612412;4602.355670206174;4614.054118905617;4623.630109591225;4623.728474669493;4639.072185562901;3641.5448068991377;3977.840886364513;4151.024509240327;4156.106437116035;4238.809253583596;3610.097475631092;3657.670809627093;3746.456763769238;3762.962370376316;3875.186210895687;1208.7461633057158;1212.1938910624513;1214.5263347294563;1218.6648671615199;1220.2739370074792;776.7592046465613;901.4095767272447;916.6113338292492;920.406337912043;935.1630290889616;5148.150555158431;5206.76569554371;5288.471152884681;5295.788168473295;5367.704776237267;425.96592272618113;442.93798868158484;446.73642550894476;448.84290498325976;451.45374097341926;3623.0942264433893;3720.720945929012;3781.4138808484727;3785.962140378561;3794.317022935843;8706.825863482694;9057.36598438103;9093.181613654802;9527.952360238154;9533.856992145124;9209.171174594185;9249.075092490697;9292.72121836346;9337.15965563089;9356.204722598655;6906.240313565504;7007.754728584577;7129.322714342233;7135.322144396274;7144.214136444987;5430.076886929152;5454.845006714986;5460.208269800936;5525.696086715108;5605.411431799603;8366.121557236402;8525.829483410422;8597.484150950962;8692.565371731514;8722.302215822592;8305;8513.787155321166;8641.308695304235;8725.65097396097;8820.117988201386;5831.70841457917;6203.286622038343;6431.774887878902;6525.401276687242;6667.633280169443;7207.423406127392;7240.167380751281;7325.523840950321;7332.560046397233;7345.853082938418;6402.90395644075;6527.934720652733;6595.307492713196;6655.500837437115;6659.4006539411685;6551.148350714377;6598.505112116514;6598.60408375499;6634.867302654016;6656.866862662817;6165.321814600301;6209.534284928558;6223.533235007483;6227.50179985591;6251.812445626639;4553.590176884097;4648.279516674921;4703.412073490814;4722.858314250578;4761.214399624023;4627.282771170474;4628.814847406201;4640.767961601974;4664.370310008106;4760.143174228672 06:55:08 INFO - PROCESS | 13236 | |4;prototype.html;298.9745871600914;305.8088694565896;309.0928125950336;316.38621075114264;317.66327692645797;4523.027549076948;4633.166030114587;4713.057388522292;4762.856914340559;4775.4985726498735;4518.186726389248;4660.510646382132;4675.345451636774;4684.789184486698;4685.2035154023815;3714.1271801126713;3716.7026637868908;3719.5164628598245;3727.2359166370898;3734.7759134451885;3553.520274762913;3579.355715971124;3677.5403074615674;3706.425504046877;3719.479272901796;3673.5591728992426;3688.299223147607;3688.7786732796117;3695.1685870679153;3695.445683147536;3678.668919797231;3684.5394325709285;3687.2625474904994;3689.0961714380014;3709.9072523186865;3306.8677252910097;3307.5358857650963;3307.7353811695007;3316.93366132676;3332.3835090508333;4252.936205956913;4469;4475.820967161309;4493.326001099828;4524.751138687371;4101.938470922939;4117.238310912461;4152.792360381999;4153.854615088458;4173.1862286854075;4864.130163203691;4867.148249056437;4896.290037944478;4902.877428064291;4912.280701754357;3426.417509023472;3473.94789078164;3480.164760457472;3490.8254587270535;3610.700147946737;5079.288899554065;5088.211327244246;5125.6155788315655;5141.460146684619;5155.664881782672;3737.8878633641034;3739.8780365890125;3748.3440397930253;3766.8493260269283;3777.0934975605655;3817.370133927871;3829.3872980323013;3833.271678381099;3839.788811615332;3841.713026136276;4176.707630465899;4239.894002649897;4247.830086796494;4254.255505286563;4254.78738559509;4836.298736683161;4871.2206047032305;4906.435759887588;4908.386451693538;4941.728204948762;1185.4843143232722;1222.6454328244888;1263.7662032524013;1264.759695657822;1265.5507294910358;862.4178679391385;884.6288253207503;903.0021825882436;907.2243232036514;907.5190149220923;4156.521999969982;4192.3082691355585;4218.957810421918;4227.873163805029;4274.572542745701;4894.632902532324;4904.479611320502;4905.779239934212;4930.926036109461;4934.629902757308;4164;4167.791610419466;4196.979015104905;4259.190753756776;4275.893102672458;2449.1060762821444;2533.873306334676;2551.374913146291;2572.7813135883284;2574.5623244048556;4536.661684802991;4550.863474095782;4567.406237189144;4587.655925805578;4599.379083823708;4917.754112294371;4938;4963.528464795839;4971.1549036663855;4978.377702787152;4328.658115984055;4561.908761824745;4580.88547786308;4593.954060459419;4612.838550650711;4806.158922188673;4807.375041244616;4815.855524334275;4872.464028956882;4927.827526036572;4752.239641657318;4758.738269395078;4776.9761151194025;4816.614670826255;4837.419509658864;4385.934210986901;4506.346579745984;4600.677952543289;4609.723416595015;4614.74618895964;3534.4698295255916;3536.4872093546805;3556.804375759358;3567.5005499230647;3570.2859428115003;4764.952350476589;4790.257510085942;4804.231322988305;4843.951560484491;4855.4023597375235;4654.813807447799;4872.244802055687;4879.487653796442;4905.7792399342825;4964.304997300309;4835.178019736723;4835.95164048355;4842.249451335048;4892.633052521146;4897.289892965571;4549.567791059844;4755.191617424977;4796.736179510161;4803.495632958628;4824.614030877451;4886.511348865085;4920.434150072788;4933.679310844784;4944.975275123746;4953.826616068421;4805.639577031667;4810.6632535722165;4818;4830.637702172421;4858.4898585648 06:55:08 INFO - PROCESS | 13236 | |5;yui.html;706.5125063706042;801.9198080191982;809.9190080991901;811.4238890387825;815.2540425510659;11477.426128693563;12756.489740410385;12848.871511284884;12934.48262069516;12948.352582370868;11425.485853136608;11949.044076473883;12025.158238923279;12068.396580170978;12262.080343974216;857.3355649371724;865.8744482050099;870.9738707838775;874.3049275825703;874.3136637739376;861.3841103610916;862.1249431826701;865.7662431143588;866.7269810009858;866.8223014282057;899.6761165980242;903.20969151992;905.2260317428603;905.3617199874105;905.728281515546;894.4990805149072;896.6458248991645;897.0312062972007;897.3404547657467;897.905719899411;662.9270780214173;663.0518358747038;664.5879554676084;664.7341063574561;668.0213487241215;11489.195756297062;11603.07175425964;11663;11685.065194784396;11747;10294.89705102947;10428.374297542172;10584.682459526226;10875.673729788119;10897.564097436092;9172.816543669156;9217.723468295962;9268.860967085498;9319.627214911396;9358.11097945694;3277.4428347181038;3284.720798732111;3332.3835090508333;3337.6829201225846;3389.6440873708398;40118;40238;40276.99999999971;40723;40828.38757418611;8277.172282771675;8353.582320883932;8391.244787969112;8396.580170991427;8602;15679.216039197994;15782;15786.289616967264;15790.289436975363;15882.60293492672;6652.334766523309;6756.223034351113;6832.658367081626;6910.06714093601;6992.545484543489;3745.6628903398823;3802.9239415212096;3824.770513769183;3837.597052309523;3862.2275544891136;2883.7548808351107;2986.925326866802;2988.462076826192;2988.5367767995995;2990.9551356729667;504.6064070025386;507.84510724229466;510.4767613196429;513.9640225184276;517.2680656870562;590.7725525672647;592.528939493104;608.1668114682913;608.5435923057706;632.5287660692813;7846.489978151516;7997.840043199103;8145.837083258301;8161.63272652732;8299.735369311782;520.7370278009581;533.1070456984613;588.4233451217831;614.2322097378277;622.700816055372;3719.460678201646;3792.829322680486;3801.1827457096856;3833.961660383416;3888.669463095612;47189.29216061762;49092.01815963732;49157;49521.50478495241;49594;32666.836665816994;39715;43073.49242776551;43121;43981.12037759227;39197.608023919965;40932.38601420981;41601.167976640296;41856.37215441771;45842.312365314545;8196.959015204886;8242.835143296981;8304.83390332202;8312.41813073079;8318.916810831814;29327.12018639444;30190;30634.540481892345;31537.684623154393;31697.366052679277;35468.645313546534;37368.43947340846;37653;38128.809355953046;38459.42310865395;9091.363604547618;10493.422861742372;10649.574017039231;10922.29005114665;10976.341419514854;10160.847587286344;10178.338408003456;10475.109615682752;10778.514966826355;10880.238383313092;9787.85318220213;9812.55843487059;9929.453880036668;10008.699739007841;10157;9827.164691001059;9934.354266972912;10082.143017843566;10176.643817466353;10287.125594324567;9637.951810240904;9658.90341096608;9748.22014238845;9751.073648003428;9955.950220249142;7730.884036739341;7878.4091193161885;7935.761927142195;8077.434579579608;8206.384521161057;8355.83288334242;8523.318134549345;8534.615942282737;8678.652853885775;8739.778691871767 06:55:08 INFO - PROCESS | 13236 | __end_tp_report 06:55:08 INFO - PROCESS | 13236 | __start_cc_report 06:55:08 INFO - PROCESS | 13236 | _x_x_mozilla_cycle_collect,1034 06:55:08 INFO - PROCESS | 13236 | __end_cc_report 06:55:08 INFO - PROCESS | 13236 | __startTimestamp1462629308642__endTimestamp 06:55:08 INFO - PROCESS | 13236 | 06:55:08 INFO - PROCESS | 13236 | ------- Summary: start ------- 06:55:08 INFO - PROCESS | 13236 | Number of tests: 6 06:55:08 INFO - PROCESS | 13236 | 06:55:08 INFO - PROCESS | 13236 | [#0] dojo.html Cycles:165 Average:4520.65 Median:4656.91 stddev:459.30 (9.9%) stddev-sans-first:435.05 06:55:08 INFO - PROCESS | 13236 | Values: 2591.3 2597.6 2640.2 2643.6 2645.3 4464.0 4503.3 4560.7 4593.3 4625.8 4525.1 4549.4 4559.1 4577.0 4580.4 4212.0 4223.5 4255.1 4284.9 4339.8 4282.4 4293.4 4310.3 4328.8 4350.6 4163.5 4196.7 4198.2 4208.7 4221.6 4183.2 4195.6 4197.0 4239.5 4245.0 4233.6 4238.9 4246.9 4274.8 4278.2 4294.0 4417.6 4444.9 4459.8 4546.7 4822.8 4846.9 4861.4 4911.1 4911.2 4883.3 4897.8 4899.5 4901.0 4912.4 4452.7 4492.6 4535.0 4538.9 4597.7 4942.9 4954.8 4983.5 4989.9 4996.8 4702.7 4745.3 4751.5 4799.1 4800.6 4763.2 4824.8 4855.2 4856.0 4866.6 4811.3 4847.9 4848.4 4857.2 4880.1 4705.2 4769.9 4813.9 4820.8 4885.8 4111.0 4130.1 4133.3 4165.4 4173.7 3575.5 3613.0 3615.0 3641.1 3656.5 4114.6 4163.6 4200.2 4263.2 4269.1 4883.1 4901.0 4907.2 4924.7 4966.7 4235.3 4242.7 4253.1 4275.9 4294.0 4288.4 4325.5 4393.6 4403.5 4424.9 4667.6 4676.0 4713.3 4716.2 4765.4 4975.2 4975.4 4978.8 4979.4 5016.5 4515.3 4562.5 4610.1 4706.7 4746.0 4805.0 4829.3 4831.8 4870.2 4874.7 4884.5 4888.9 4889.5 4900.3 4948.3 4679.5 4712.2 4751.0 4762.5 4802.8 4799.2 4805.5 4811.7 4818.6 4855.0 4746.2 4759.5 4762.1 4805.0 4810.1 4596.2 4696.0 4727.0 4732.4 4743.4 4639.1 4648.1 4656.9 4656.9 4699.5 06:55:08 INFO - PROCESS | 13236 | 06:55:08 INFO - PROCESS | 13236 | [#1] ext.html Cycles:180 Average:45810.76 Median:37349.57 stddev:74869.06 (200.5%) stddev-sans-first:75002.09 06:55:08 INFO - PROCESS | 13236 | Values: 587.3 608.5 609.4 611.3 615.3 27728.9 28275.3 30887.2 30891.5 30983.5 42458.0 43267.0 43326.4 48358.0 48516.0 8058.6 8177.3 8184.7 8190.8 8191.4 8070.2 8154.8 8155.1 8157.1 8160.3 8142.8 8162.1 8173.6 8174.8 8176.0 8099.8 8150.6 8152.0 8152.2 8157.7 8108.2 8138.1 8146.6 8146.8 8175.4 39964.6 40524.8 40707.2 40747.6 40777.4 3352.6 3359.9 3403.9 3508.6 3563.8 29989.4 30081.7 30541.8 30619.8 30666.0 3375.0 3404.3 3439.1 3495.2 3587.9 243524.0 243624.0 244693.0 244849.0 245495.0 57073.7 57265.7 57688.4 57849.7 57939.0 61026.0 61280.4 61488.7 61705.4 61813.7 15616.3 15774.3 15807.4 15832.6 15868.9 12249.6 12329.9 12336.4 12336.4 12341.9 17530.0 18352.7 18643.0 18691.8 18799.2 5410.6 6236.6 6435.1 6505.3 6578.5 853.9 948.2 949.8 1028.9 1072.2 28283.6 28975.6 29020.6 29393.4 29581.0 993.4 1043.6 1059.7 1092.5 1175.6 15351.2 15357.2 15772.5 15868.6 16076.7 329111.0 330448.0 334335.0 334475.0 335584.0 51711.0 51721.5 51779.0 52018.2 52258.7 1195.1 1289.5 1293.2 1326.6 1327.7 28558.0 29836.1 29934.4 30160.5 30728.0 44263.0 44355.8 44817.3 44957.8 45006.5 273049.0 274673.0 275567.0 275834.0 276808.0 33506.3 34671.8 38396.4 40204.4 40501.6 42818.8 42960.0 43346.6 44805.6 44825.6 36044.6 37730.2 38651.0 38653.4 38874.0 37216.9 37482.3 37605.2 37811.2 38135.0 36623.5 38532.0 39492.2 39708.2 42250.6 31390.5 34405.3 34543.8 34670.0 34874.7 26046.0 26117.4 26257.7 26326.0 26554.5 06:55:08 INFO - PROCESS | 13236 | 06:55:08 INFO - PROCESS | 13236 | [#2] jquery.html Cycles:180 Average:25864.16 Median:441305.50 stddev:73915.78 (16.7%) stddev-sans-first:74098.35 06:55:08 INFO - PROCESS | 13236 | Values: 373.6 375.5 376.1 379.3 391.7 15868.9 17304.9 17486.2 17697.7 17858.1 10588.3 15861.5 16617.6 16633.6 17342.1 4626.9 4737.7 4750.7 4777.0 4786.4 3421.5 5100.7 5377.1 5378.1 5457.6 5421.5 5424.7 5429.6 5444.4 5456.2 5108.4 5398.2 5407.0 5449.5 5458.4 3385.2 3569.6 3570.4 3595.4 4912.3 11273.5 11815.1 11822.8 12385.0 20273.7 1853.9 1930.0 1935.0 1976.6 2255.5 8720.3 9024.8 9094.9 9135.5 9582.3 1650.1 1738.7 1743.8 1790.6 1792.9 66490.3 68338.3 68407.0 68493.3 68999.0 9761.9 9766.2 9812.1 9855.1 10486.0 13024.7 13043.5 13098.9 13166.8 13181.1 7129.9 7369.4 7437.8 7440.4 7481.8 7222.0 7238.3 7373.9 7390.7 7417.0 4033.5 4101.1 4143.7 4154.8 4170.0 1573.8 1668.4 1694.5 1709.9 1731.7 817.6 929.2 951.7 964.3 984.9 16427.8 16965.6 17199.6 17571.1 18641.5 874.3 924.8 960.3 967.3 979.9 9553.5 10034.3 10143.1 10161.8 10192.8 440554.0 442057.0 442689.0 446326.0 469232.0 83843.6 84569.2 85377.6 86105.0 87524.0 948.5 966.7 977.8 980.5 984.1 15299.8 15485.0 15652.8 15679.6 15870.7 35025.0 35226.8 35546.6 35923.5 37380.6 52890.7 52922.5 52974.7 53197.5 53213.5 7454.7 7469.3 7506.0 7711.2 7732.4 10502.2 11370.8 11436.8 11450.1 11558.4 9244.6 9628.6 9902.2 10136.6 10358.9 10116.7 10203.4 10306.8 10474.4 10623.9 9989.0 10003.9 10191.9 10438.7 10522.3 7779.0 7837.3 7838.3 7872.0 7996.4 9718.2 10394.3 10414.5 10423.9 10468.8 06:55:08 INFO - PROCESS | 13236 | 06:55:08 INFO - PROCESS | 13236 | [#3] mootools.html Cycles:180 Average:5033.69 Median:5177.46 stddev:2741.10 (52.9%) stddev-sans-first:2734.32 06:55:08 INFO - PROCESS | 13236 | Values: 1286.3 1494.2 1523.5 1697.8 1869.3 7055.6 7325.4 7368.7 7529.7 7557.9 7311.9 7484.7 7485.1 7487.2 7496.3 2191.6 2208.5 2211.2 2211.7 2220.9 2213.8 2230.0 2282.1 2289.5 2291.5 2201.2 2202.2 2228.1 2241.6 2242.7 2149.0 2164.2 2177.2 2183.8 2187.9 2127.0 2133.4 2136.7 2137.9 2150.1 7383.4 7401.0 7429.1 7452.6 7639.6 4411.6 4549.2 4570.3 4579.4 4585.4 2884.6 2905.7 2947.6 2982.2 2983.0 930.7 949.5 965.9 967.7 974.2 10022.7 10210.6 10221.0 10238.7 10267.4 4166.7 4240.2 4338.6 4346.9 4359.8 8873.6 8902.5 8940.6 8948.0 8979.8 4602.4 4614.1 4623.6 4623.7 4639.1 3641.5 3977.8 4151.0 4156.1 4238.8 3610.1 3657.7 3746.5 3763.0 3875.2 1208.7 1212.2 1214.5 1218.7 1220.3 776.8 901.4 916.6 920.4 935.2 5148.2 5206.8 5288.5 5295.8 5367.7 426.0 442.9 446.7 448.8 451.5 3623.1 3720.7 3781.4 3786.0 3794.3 8706.8 9057.4 9093.2 9528.0 9533.9 9209.2 9249.1 9292.7 9337.2 9356.2 6906.2 7007.8 7129.3 7135.3 7144.2 5430.1 5454.8 5460.2 5525.7 5605.4 8366.1 8525.8 8597.5 8692.6 8722.3 8305.0 8513.8 8641.3 8725.7 8820.1 5831.7 6203.3 6431.8 6525.4 6667.6 7207.4 7240.2 7325.5 7332.6 7345.9 6402.9 6527.9 6595.3 6655.5 6659.4 6551.1 6598.5 6598.6 6634.9 6656.9 6165.3 6209.5 6223.5 6227.5 6251.8 4553.6 4648.3 4703.4 4722.9 4761.2 4627.3 4628.8 4640.8 4664.4 4760.1 06:55:08 INFO - PROCESS | 13236 | 06:55:08 INFO - PROCESS | 13236 | [#4] prototype.html Cycles:180 Average:4036.76 Median:4543.11 stddev:1143.04 (25.2%) stddev-sans-first:1111.29 06:55:08 INFO - PROCESS | 13236 | Values: 299.0 305.8 309.1 316.4 317.7 4523.0 4633.2 4713.1 4762.9 4775.5 4518.2 4660.5 4675.3 4684.8 4685.2 3714.1 3716.7 3719.5 3727.2 3734.8 3553.5 3579.4 3677.5 3706.4 3719.5 3673.6 3688.3 3688.8 3695.2 3695.4 3678.7 3684.5 3687.3 3689.1 3709.9 3306.9 3307.5 3307.7 3316.9 3332.4 4252.9 4469.0 4475.8 4493.3 4524.8 4101.9 4117.2 4152.8 4153.9 4173.2 4864.1 4867.1 4896.3 4902.9 4912.3 3426.4 3473.9 3480.2 3490.8 3610.7 5079.3 5088.2 5125.6 5141.5 5155.7 3737.9 3739.9 3748.3 3766.8 3777.1 3817.4 3829.4 3833.3 3839.8 3841.7 4176.7 4239.9 4247.8 4254.3 4254.8 4836.3 4871.2 4906.4 4908.4 4941.7 1185.5 1222.6 1263.8 1264.8 1265.6 862.4 884.6 903.0 907.2 907.5 4156.5 4192.3 4219.0 4227.9 4274.6 4894.6 4904.5 4905.8 4930.9 4934.6 4164.0 4167.8 4197.0 4259.2 4275.9 2449.1 2533.9 2551.4 2572.8 2574.6 4536.7 4550.9 4567.4 4587.7 4599.4 4917.8 4938.0 4963.5 4971.2 4978.4 4328.7 4561.9 4580.9 4594.0 4612.8 4806.2 4807.4 4815.9 4872.5 4927.8 4752.2 4758.7 4777.0 4816.6 4837.4 4385.9 4506.3 4600.7 4609.7 4614.7 3534.5 3536.5 3556.8 3567.5 3570.3 4765.0 4790.3 4804.2 4844.0 4855.4 4654.8 4872.2 4879.5 4905.8 4964.3 4835.2 4836.0 4842.2 4892.6 4897.3 4549.6 4755.2 4796.7 4803.5 4824.6 4886.5 4920.4 4933.7 4945.0 4953.8 4805.6 4810.7 4818.0 4830.6 4858.5 06:55:08 INFO - PROCESS | 13236 | 06:55:08 INFO - PROCESS | 13236 | [#5] yui.html Cycles:180 Average:11974.44 Median:509.16 stddev:13442.20 (2640.1%) stddev-sans-first:13453.27 06:55:08 INFO - PROCESS | 13236 | Values: 706.5 801.9 809.9 811.4 815.3 11477.4 12756.5 12848.9 12934.5 12948.4 11425.5 11949.0 12025.2 12068.4 12262.1 857.3 865.9 871.0 874.3 874.3 861.4 862.1 865.8 866.7 866.8 899.7 903.2 905.2 905.4 905.7 894.5 896.6 897.0 897.3 897.9 662.9 663.1 664.6 664.7 668.0 11489.2 11603.1 11663.0 11685.1 11747.0 10294.9 10428.4 10584.7 10875.7 10897.6 9172.8 9217.7 9268.9 9319.6 9358.1 3277.4 3284.7 3332.4 3337.7 3389.6 40118.0 40238.0 40277.0 40723.0 40828.4 8277.2 8353.6 8391.2 8396.6 8602.0 15679.2 15782.0 15786.3 15790.3 15882.6 6652.3 6756.2 6832.7 6910.1 6992.5 3745.7 3802.9 3824.8 3837.6 3862.2 2883.8 2986.9 2988.5 2988.5 2991.0 504.6 507.8 510.5 514.0 517.3 590.8 592.5 608.2 608.5 632.5 7846.5 7997.8 8145.8 8161.6 8299.7 520.7 533.1 588.4 614.2 622.7 3719.5 3792.8 3801.2 3834.0 3888.7 47189.3 49092.0 49157.0 49521.5 49594.0 32666.8 39715.0 43073.5 43121.0 43981.1 39197.6 40932.4 41601.2 41856.4 45842.3 8197.0 8242.8 8304.8 8312.4 8318.9 29327.1 30190.0 30634.5 31537.7 31697.4 35468.6 37368.4 37653.0 38128.8 38459.4 9091.4 10493.4 10649.6 10922.3 10976.3 10160.8 10178.3 10475.1 10778.5 10880.2 9787.9 9812.6 9929.5 10008.7 10157.0 9827.2 9934.4 10082.1 10176.6 10287.1 9638.0 9658.9 9748.2 9751.1 9956.0 7730.9 7878.4 7935.8 8077.4 8206.4 8355.8 8523.3 8534.6 8678.7 8739.8 06:55:08 INFO - PROCESS | 13236 | -------- Summary: end -------- 06:55:08 INFO - PROCESS | 13236 | 06:55:09 INFO - TEST-INFO | 13236: exit 0 06:55:09 INFO - TEST-OK | dromaeo_css | took 1118168ms 06:55:09 INFO - TEST-START | kraken 06:55:09 INFO - operating with platform_type : linux_ 06:55:09 INFO - Initialising browser for kraken test... 06:55:09 INFO - TEST-INFO | started process 13414 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJe4Abm/profile http://localhost:43068/getInfo.html) 06:55:13 INFO - PROCESS | 13414 | __metrics Screen width/height:1600/1200 06:55:13 INFO - PROCESS | 13414 | colorDepth:24 06:55:13 INFO - PROCESS | 13414 | Browser inner width/height: 1024/697 06:55:13 INFO - PROCESS | 13414 | __metrics 06:55:14 ERROR - PROCESS | 13414 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:55:15 INFO - TEST-INFO | 13414: exit 0 06:55:15 INFO - Browser initialized. 06:55:15 INFO - Running cycle 1/1 for kraken test... 06:55:15 INFO - TEST-INFO | started process 13494 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJe4Abm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:55:27 INFO - PROCESS | 13494 | RSS: Main: 154353664 06:55:27 INFO - PROCESS | 13494 | 06:55:30 INFO - PROCESS | 13494 | Cycle 1(1): loaded http://localhost:43068/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43068/tests/kraken/driver.html?testName=audio-beat-detection) 06:55:31 INFO - PROCESS | 13494 | RSS: Main: 209788928 06:55:31 INFO - PROCESS | 13494 | 06:55:34 INFO - PROCESS | 13494 | Cycle 1(1): loaded http://localhost:43068/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43068/tests/kraken/driver.html?testName=audio-dft) 06:55:34 INFO - PROCESS | 13494 | RSS: Main: 198201344 06:55:34 INFO - PROCESS | 13494 | 06:55:38 INFO - PROCESS | 13494 | Cycle 1(1): loaded http://localhost:43068/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43068/tests/kraken/driver.html?testName=audio-fft) 06:55:38 INFO - PROCESS | 13494 | RSS: Main: 267116544 06:55:38 INFO - PROCESS | 13494 | 06:55:40 INFO - PROCESS | 13494 | Cycle 1(1): loaded http://localhost:43068/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43068/tests/kraken/driver.html?testName=audio-oscillator) 06:55:41 INFO - PROCESS | 13494 | RSS: Main: 175747072 06:55:41 INFO - PROCESS | 13494 | 06:55:43 INFO - PROCESS | 13494 | Cycle 1(1): loaded http://localhost:43068/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43068/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:55:44 INFO - PROCESS | 13494 | RSS: Main: 179720192 06:55:44 INFO - PROCESS | 13494 | 06:55:47 INFO - PROCESS | 13494 | Cycle 1(1): loaded http://localhost:43068/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43068/tests/kraken/driver.html?testName=imaging-darkroom) 06:55:48 INFO - PROCESS | 13494 | RSS: Main: 216039424 06:55:48 INFO - PROCESS | 13494 | 06:55:51 INFO - PROCESS | 13494 | Cycle 1(1): loaded http://localhost:43068/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43068/tests/kraken/driver.html?testName=imaging-desaturate) 06:55:52 INFO - PROCESS | 13494 | RSS: Main: 216866816 06:55:52 INFO - PROCESS | 13494 | 06:55:54 INFO - PROCESS | 13494 | Cycle 1(1): loaded http://localhost:43068/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43068/tests/kraken/driver.html?testName=json-parse-financial) 06:55:55 INFO - PROCESS | 13494 | RSS: Main: 216752128 06:55:55 INFO - PROCESS | 13494 | 06:55:57 INFO - PROCESS | 13494 | Cycle 1(1): loaded http://localhost:43068/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43068/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:55:57 INFO - PROCESS | 13494 | RSS: Main: 203010048 06:55:57 INFO - PROCESS | 13494 | 06:55:59 INFO - PROCESS | 13494 | Cycle 1(1): loaded http://localhost:43068/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43068/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:56:00 INFO - PROCESS | 13494 | RSS: Main: 207421440 06:56:00 INFO - PROCESS | 13494 | 06:56:02 INFO - PROCESS | 13494 | Cycle 1(1): loaded http://localhost:43068/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43068/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:56:03 INFO - PROCESS | 13494 | RSS: Main: 217227264 06:56:03 INFO - PROCESS | 13494 | 06:56:05 INFO - PROCESS | 13494 | Cycle 1(1): loaded http://localhost:43068/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43068/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:56:06 INFO - PROCESS | 13494 | RSS: Main: 224714752 06:56:06 INFO - PROCESS | 13494 | 06:56:09 INFO - PROCESS | 13494 | Cycle 1(1): loaded http://localhost:43068/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43068/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:56:10 INFO - PROCESS | 13494 | RSS: Main: 221446144 06:56:10 INFO - PROCESS | 13494 | 06:56:11 INFO - PROCESS | 13494 | Cycle 1(1): loaded http://localhost:43068/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43068/tests/kraken/driver.html?testName=ai-astar) 06:56:12 INFO - PROCESS | 13494 | RSS: Main: 266735616 06:56:12 INFO - PROCESS | 13494 | 06:56:12 INFO - PROCESS | 13494 | __start_tp_report 06:56:12 INFO - PROCESS | 13494 | _x_x_mozilla_page_load 06:56:12 INFO - PROCESS | 13494 | _x_x_mozilla_page_load_details 06:56:12 INFO - PROCESS | 13494 | |i|pagename|runs| 06:56:12 INFO - PROCESS | 13494 | |0;ai-astar;115;110;115;114;115;112;114;114;114;115 06:56:12 INFO - PROCESS | 13494 | |1;audio-beat-detection;156;136;161;194;140;149;154;136;184;132 06:56:12 INFO - PROCESS | 13494 | |2;audio-dft;160;160;159;159;159;161;162;160;160;162 06:56:12 INFO - PROCESS | 13494 | |3;audio-fft;74;77;75;134;89;75;77;76;137;77 06:56:12 INFO - PROCESS | 13494 | |4;audio-oscillator;94;93;125;92;92;93;135;92;92;122 06:56:12 INFO - PROCESS | 13494 | |5;imaging-gaussian-blur;118;116;116;117;117;117;117;117;117;117 06:56:12 INFO - PROCESS | 13494 | |6;imaging-darkroom;147;153;146;145;145;146;146;145;146;146 06:56:12 INFO - PROCESS | 13494 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;95 06:56:12 INFO - PROCESS | 13494 | |8;json-parse-financial;66;66;67;67;67;67;68;83;66;64 06:56:12 INFO - PROCESS | 13494 | |9;json-stringify-tinderbox;63;65;65;64;65;64;65;65;65;64 06:56:12 INFO - PROCESS | 13494 | |10;stanford-crypto-aes;83;82;88;84;84;83;83;84;82;87 06:56:12 INFO - PROCESS | 13494 | |11;stanford-crypto-ccm;140;142;132;139;130;130;130;131;169;135 06:56:12 INFO - PROCESS | 13494 | |12;stanford-crypto-pbkdf2;175;172;173;183;187;176;179;174;176;173 06:56:12 INFO - PROCESS | 13494 | |13;stanford-crypto-sha256-iterative;69;69;69;69;69;67;68;67;67;67 06:56:12 INFO - PROCESS | 13494 | __end_tp_report 06:56:12 INFO - PROCESS | 13494 | __start_cc_report 06:56:12 INFO - PROCESS | 13494 | _x_x_mozilla_cycle_collect,1820 06:56:12 INFO - PROCESS | 13494 | __end_cc_report 06:56:12 INFO - PROCESS | 13494 | __startTimestamp1462629372126__endTimestamp 06:56:12 INFO - PROCESS | 13494 | 06:56:12 INFO - PROCESS | 13494 | ------- Summary: start ------- 06:56:12 INFO - PROCESS | 13494 | Number of tests: 14 06:56:12 INFO - PROCESS | 13494 | 06:56:12 INFO - PROCESS | 13494 | [#0] ai-astar Cycles:10 Average:113.80 Median:114.50 stddev:1.62 (1.4%) stddev-sans-first:1.66 06:56:12 INFO - PROCESS | 13494 | Values: 115.0 110.0 115.0 114.0 115.0 112.0 114.0 114.0 114.0 115.0 06:56:12 INFO - PROCESS | 13494 | 06:56:12 INFO - PROCESS | 13494 | [#1] audio-beat-detection Cycles:10 Average:154.20 Median:155.00 stddev:20.83 (13.4%) stddev-sans-first:22.09 06:56:12 INFO - PROCESS | 13494 | Values: 156.0 136.0 161.0 194.0 140.0 149.0 154.0 136.0 184.0 132.0 06:56:12 INFO - PROCESS | 13494 | 06:56:12 INFO - PROCESS | 13494 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.00 stddev:1.14 (0.7%) stddev-sans-first:1.20 06:56:12 INFO - PROCESS | 13494 | Values: 160.0 160.0 159.0 159.0 159.0 161.0 162.0 160.0 160.0 162.0 06:56:12 INFO - PROCESS | 13494 | 06:56:12 INFO - PROCESS | 13494 | [#3] audio-fft Cycles:10 Average:89.10 Median:76.50 stddev:24.83 (32.5%) stddev-sans-first:25.72 06:56:12 INFO - PROCESS | 13494 | Values: 74.0 77.0 75.0 134.0 89.0 75.0 77.0 76.0 137.0 77.0 06:56:12 INFO - PROCESS | 13494 | 06:56:12 INFO - PROCESS | 13494 | [#4] audio-oscillator Cycles:10 Average:103.00 Median:92.00 stddev:17.11 (18.6%) stddev-sans-first:17.83 06:56:12 INFO - PROCESS | 13494 | Values: 94.0 93.0 125.0 92.0 92.0 93.0 135.0 92.0 92.0 122.0 06:56:12 INFO - PROCESS | 13494 | 06:56:12 INFO - PROCESS | 13494 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 06:56:12 INFO - PROCESS | 13494 | Values: 118.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 06:56:12 INFO - PROCESS | 13494 | 06:56:12 INFO - PROCESS | 13494 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.00 stddev:2.37 (1.6%) stddev-sans-first:2.51 06:56:12 INFO - PROCESS | 13494 | Values: 147.0 153.0 146.0 145.0 145.0 146.0 146.0 145.0 146.0 146.0 06:56:12 INFO - PROCESS | 13494 | 06:56:12 INFO - PROCESS | 13494 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 06:56:12 INFO - PROCESS | 13494 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 06:56:12 INFO - PROCESS | 13494 | 06:56:12 INFO - PROCESS | 13494 | [#8] json-parse-financial Cycles:10 Average:68.10 Median:67.00 stddev:5.34 (8.0%) stddev-sans-first:5.61 06:56:12 INFO - PROCESS | 13494 | Values: 66.0 66.0 67.0 67.0 67.0 67.0 68.0 83.0 66.0 64.0 06:56:12 INFO - PROCESS | 13494 | 06:56:12 INFO - PROCESS | 13494 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:65.00 stddev:0.71 (1.1%) stddev-sans-first:0.50 06:56:12 INFO - PROCESS | 13494 | Values: 63.0 65.0 65.0 64.0 65.0 64.0 65.0 65.0 65.0 64.0 06:56:12 INFO - PROCESS | 13494 | 06:56:12 INFO - PROCESS | 13494 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:84.00 stddev:2.00 (2.4%) stddev-sans-first:2.09 06:56:12 INFO - PROCESS | 13494 | Values: 83.0 82.0 88.0 84.0 84.0 83.0 83.0 84.0 82.0 87.0 06:56:12 INFO - PROCESS | 13494 | 06:56:12 INFO - PROCESS | 13494 | [#11] stanford-crypto-ccm Cycles:10 Average:137.80 Median:137.00 stddev:11.87 (8.7%) stddev-sans-first:12.56 06:56:12 INFO - PROCESS | 13494 | Values: 140.0 142.0 132.0 139.0 130.0 130.0 130.0 131.0 169.0 135.0 06:56:12 INFO - PROCESS | 13494 | 06:56:12 INFO - PROCESS | 13494 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.80 Median:176.00 stddev:4.85 (2.8%) stddev-sans-first:5.10 06:56:12 INFO - PROCESS | 13494 | Values: 175.0 172.0 173.0 183.0 187.0 176.0 179.0 174.0 176.0 173.0 06:56:12 INFO - PROCESS | 13494 | 06:56:12 INFO - PROCESS | 13494 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:69.00 stddev:0.99 (1.4%) stddev-sans-first:1.00 06:56:12 INFO - PROCESS | 13494 | Values: 69.0 69.0 69.0 69.0 69.0 67.0 68.0 67.0 67.0 67.0 06:56:12 INFO - PROCESS | 13494 | -------- Summary: end -------- 06:56:12 INFO - PROCESS | 13494 | 06:56:13 INFO - TEST-INFO | 13494: exit 0 06:56:13 INFO - TEST-OK | kraken | took 63767ms 06:56:13 INFO - SUITE-END | took 1181s 06:56:13 INFO - Completed test suite (00:19:41) 06:56:13 INFO - javascript benchmark 06:56:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2591.3003489057955, 2597.558415069438, 2640.181543721446, 2643.550596398612, 2645.259327388331, 4463.977680111603, 4503.347014682869, 4560.749158796265, 4593.333966574849, 4625.791839367228, 4525.117602067598, 4549.431321084864, 4559.088182363533, 4577.038821847408, 4580.358749775034, 4211.957880421187, 4223.535411104784, 4255.085156691311, 4284.850030248942, 4339.826406943718, 4282.443282373287, 4293.355996600504, 4310.288802347609, 4328.783560821962, 4350.56494350564, 4163.542010378856, 4196.664266858644, 4198.202341555126, 4208.663306935453, 4221.598948099926, 4183.226103170923, 4195.622393984556, 4197.0, 4239.533651298355, 4245.044864905402, 4233.555476674936, 4238.87283381499, 4246.936295955563, 4274.807633656493, 4278.229918614648, 4294.0, 4417.646588272931, 4444.888877778049, 4459.777011149429, 4546.727196368229, 4822.758862056883, 4846.878828029292, 4861.440934292531, 4911.066897289504, 4911.238757992517, 4883.34074899891, 4897.8285759998225, 4899.461059283476, 4901.044296362211, 4912.435069966964, 4452.666050046227, 4492.595666390008, 4535.0, 4538.909221815546, 4597.7241365518175, 4942.9258561121615, 4954.801807927714, 4983.526564976321, 4989.875253118701, 4996.775145118406, 4702.6708130431225, 4745.311929770233, 4751.524847515221, 4799.0641824844515, 4800.615950723934, 4763.214069678534, 4824.807007719652, 4855.247436647325, 4855.975720121377, 4866.635002374836, 4811.27830825372, 4847.878803029953, 4848.418189817245, 4857.247126695368, 4880.097182021337, 4705.223638099676, 4769.8569042928075, 4813.927791083137, 4820.831270905572, 4885.828995985124, 4111.033907031845, 4130.132672138884, 4133.318002529609, 4165.416841642173, 4173.728707633994, 3575.481555174485, 3613.0, 3615.0239435352833, 3641.10792855752, 3656.5063716398477, 4114.588541145921, 4163.646090082317, 4200.201961627281, 4263.211305908417, 4269.0608066226005, 4883.121038213156, 4900.950990490121, 4907.165781817028, 4924.729139897268, 4966.6771659842, 4235.343417009224, 4242.703010789277, 4253.064325848309, 4275.87172384829, 4293.957060429356, 4288.35674648799, 4325.4593175853015, 4393.648508119343, 4403.471583410012, 4424.933625995613, 4667.6265898728025, 4675.9532404676875, 4713.29300604912, 4716.174669432767, 4765.380500534909, 4975.228839529878, 4975.378077740283, 4978.775955082103, 4979.377577802775, 5016.54851063406, 4515.345274935182, 4562.520935301745, 4610.077984403066, 4706.717596944194, 4745.952540474551, 4805.0, 4829.27560865873, 4831.830885918976, 4870.245112007645, 4874.683145595525, 4884.462709101925, 4888.90222195547, 4889.486603906538, 4900.313956046228, 4948.257761335828, 4679.532046795293, 4712.222483290218, 4751.049790041936, 4762.547557981986, 4802.807887684454, 4799.184138696361, 4805.495422980537, 4811.663183577116, 4818.614510839055, 4854.975725121493, 4746.169420351355, 4759.524047595212, 4762.095201911626, 4804.95195048045, 4810.13417584838, 4596.2186428306595, 4695.9530404695515, 4726.976365118152, 4732.432108147044, 4743.407074115736, 4639.0721855628335, 4648.1168577970075, 4656.8602941911795, 4656.906861862812, 4699.459562150259], "value": 4492.485913495901, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.3275100010488, 608.5010291560919, 609.3632154398653, 611.3092205807437, 615.2586133708879, 27728.861355693218, 28275.29311767204, 30887.227819304473, 30891.536626950612, 30983.535246971314, 42458.0, 43266.99999999992, 43326.35010474845, 48358.0, 48516.0, 8058.5567793771315, 8177.264046235838, 8184.6726130954985, 8190.836183276331, 8191.426600137993, 8070.192980701912, 8154.836903261931, 8155.10293867674, 8157.061937877161, 8160.3471722262075, 8142.837143257131, 8162.102168761431, 8173.591320433984, 8174.795630109265, 8176.0, 8099.7570072897615, 8150.592470376487, 8151.959240203821, 8152.225538573826, 8157.673693052271, 8108.189181081844, 8138.145494723028, 8146.5519396433765, 8146.75559733209, 8175.386845986574, 39964.60035399638, 40524.79737601322, 40707.185856283, 40747.59252407467, 40777.38833917493, 3352.6479719629333, 3359.9328013439595, 3403.897883063512, 3508.649135086471, 3563.750537462379, 29989.413045315097, 30081.699183008328, 30541.847290763628, 30619.846900765577, 30666.0, 3374.9831250843836, 3404.3191361727504, 3439.0886415100017, 3495.2135769451925, 3587.9282414351565, 243524.0, 243624.0, 244693.0, 244849.0, 245495.0, 57073.71463142741, 57265.713671431375, 57688.42311576915, 57849.71075144597, 57939.0, 61026.0, 61280.38719612836, 61488.69255653693, 61705.38294617086, 61813.690931545054, 15616.297266623029, 15774.290156942965, 15807.446739364066, 15832.604184895239, 15868.920655396649, 12249.632511024683, 12329.93835030837, 12336.444859981322, 12336.444859981322, 12341.938290308492, 17529.996797830077, 18352.724709129372, 18643.0, 18691.813081869008, 18799.248030078918, 5410.565245639478, 6236.563440559208, 6435.099086127946, 6505.349465053551, 6578.473722102221, 853.8932633420823, 948.1608776233084, 949.8290307744534, 1028.876534815827, 1072.1744256922127, 28283.575746363822, 28975.56536651952, 29020.564691529646, 29393.412131757672, 29581.0, 993.4039576254335, 1043.5669197283194, 1059.6662051453768, 1092.5356723392526, 1175.588544009607, 15351.23243837826, 15357.15535645528, 15772.526824195293, 15868.603284917739, 16076.678466430605, 329111.0, 330448.0, 334335.0, 334475.0, 335584.0, 51711.0, 51721.48278517167, 51779.0, 52018.21972670413, 52258.738706306984, 1195.121585634558, 1289.4970961325091, 1293.204679122333, 1326.555603872694, 1327.6879933215687, 28558.0, 29836.104916852528, 29934.401311974074, 30160.5475917857, 30728.0, 44263.0, 44355.77822110869, 44817.327740083274, 44957.775211123735, 45006.54993450024, 273049.0, 274673.0, 275567.0, 275834.0, 276808.0, 33506.329873401904, 34671.82664086663, 38396.42405363866, 40204.3969340466, 40501.594984050964, 42818.78590607027, 42960.0, 43346.566534335514, 44805.55194448014, 44825.55174448214, 36044.63955360413, 37730.24539509249, 38651.0, 38653.420198697604, 38874.0, 37216.88349349524, 37482.250354993295, 37605.24789504249, 37811.243775124894, 38135.0, 36623.45064824083, 38532.0, 39492.21015579615, 39708.205835883695, 42250.577494224664, 31390.529142063344, 34405.31189376248, 34543.827280863436, 34670.0, 34874.651253488155, 26046.0, 26117.415441194596, 26257.73742262553, 26326.0, 26554.468910621294], "value": 18270.252139366385, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.6226411324563, 375.5212104566678, 376.0936143893217, 379.3134426687697, 391.6749098248452, 15868.920655396721, 17304.913475432604, 17486.21312040958, 17697.73453398197, 17858.107094645264, 10588.258821882471, 15861.524154275361, 16617.584560385996, 16633.584160395996, 17342.138547139708, 4626.907461850769, 4737.73942433166, 4750.667453278272, 4777.04459108178, 4786.37777088978, 3421.469672200813, 5100.693958362492, 5377.139657654776, 5378.058839703056, 5457.645253058538, 5421.484958928895, 5424.728763561826, 5429.56563474921, 5444.373897001836, 5456.154296084113, 5108.361454818148, 5398.217258497515, 5406.972965135188, 5449.455054494559, 5458.372287186985, 3385.2213990782257, 3569.6430356964356, 3570.428731402989, 3595.3708101082207, 4912.287718280829, 11273.549058037668, 11815.11386646005, 11822.763544729143, 12385.0, 20273.69589456159, 1853.8702290839512, 1930.0458086802232, 1935.0, 1976.6343226503, 2255.5037891663974, 8720.345974051972, 9024.819503609957, 9094.909050909473, 9135.54322283883, 9582.28132890036, 1650.1254335202361, 1738.6696527659703, 1743.808181100078, 1790.6060666653316, 1792.9282828686837, 66490.33509664939, 68338.25316895315, 68407.0, 68493.31506684919, 68999.0, 9761.902380976242, 9766.169875560658, 9812.116909478182, 9855.063768941938, 10486.0, 13024.739505209844, 13043.543475978486, 13098.869011309955, 13166.802497962539, 13181.143225690299, 7129.857402851914, 7369.410447164214, 7437.776866694008, 7440.441966852508, 7481.7755467336065, 7221.96389018062, 7238.348548630648, 7373.866106904544, 7390.667419966115, 7416.962915185498, 4033.5361433435532, 4101.138760860253, 4143.70994030421, 4154.792260387029, 4170.04089059518, 1573.8268790433044, 1668.4483430409834, 1694.5340031491191, 1709.9316027358766, 1731.6536692661518, 817.595290331278, 929.2194556572512, 951.6764300137847, 964.2912459342377, 984.8719666443317, 16427.83572164263, 16965.575860603585, 17199.57001074983, 17571.121443927754, 18641.533961650795, 874.3398733955822, 924.7641851327868, 960.3146477931186, 967.3277072434731, 979.9216062714966, 9553.474558899326, 10034.347767395097, 10143.137833284105, 10161.796764064677, 10192.847107293397, 440554.0, 442057.0, 442689.0, 446326.0, 469232.0, 83843.58078209692, 84569.15430845736, 85377.57311213529, 86105.0, 87524.0, 948.5399581203111, 966.7148191283588, 977.7995510920244, 980.5391466010964, 984.1487113646645, 15299.770503442234, 15485.0, 15652.843471565138, 15679.608009799846, 15870.68258634844, 35025.0, 35226.82386588153, 35546.64453355433, 35923.46114808332, 37380.62619373771, 52890.73554632202, 52922.470775293295, 52974.735126325664, 53197.4680253208, 53213.4678653224, 7454.701811927679, 7469.253074692705, 7506.0, 7711.187870850234, 7732.381409487115, 10502.159827213958, 11370.772584548096, 11436.771264574829, 11450.141239406912, 11558.422078895854, 9244.630214791334, 9628.555716642559, 9902.207823373968, 10136.64521741765, 10358.948205258925, 10116.747081323027, 10203.38779673222, 10306.793864122825, 10474.423906685206, 10623.89376106229, 9989.0, 10003.899961000297, 10191.94904025475, 10438.739031523968, 10522.263441559324, 7779.0, 7837.333826624573, 7838.255365740246, 7871.960640196762, 7996.3602911768085, 9718.173955213886, 10394.272400931863, 10414.479276036016, 10423.895761042595, 10468.842967355647], "value": 8073.039534612063, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1286.2989670629506, 1494.1931357067185, 1523.4667866246812, 1697.8047524534675, 1869.3457289948528, 7055.57666540008, 7325.41396688265, 7368.705251789936, 7529.698812047512, 7557.92442075579, 7311.89032164518, 7484.738034168805, 7485.0643669541305, 7487.213842546522, 7496.325330720234, 2191.5945550073247, 2208.5472478142024, 2211.2039665720326, 2211.7124773779387, 2220.8667479951173, 2213.8450308478414, 2230.018791731633, 2282.1099771089207, 2289.519200967799, 2291.450051987519, 2201.2295696506176, 2202.1631779923605, 2228.0642130305228, 2241.607718649238, 2242.7308722953267, 2149.000714667671, 2164.177612507245, 2177.194438057913, 2183.825293976478, 2187.9015444305046, 2127.0322003488377, 2133.434639820449, 2136.6688163334707, 2137.946551336229, 2150.086213359332, 7383.446241531907, 7400.962995184989, 7429.108506979197, 7452.552846829153, 7639.618019099023, 4411.625011873963, 4549.181147393468, 4570.268756998864, 4579.404677391951, 4585.380973568593, 2884.5817356483403, 2905.7239562241552, 2947.6168098147105, 2982.164993801717, 2983.030515082607, 930.734740598926, 949.5062567464879, 965.9227261819037, 967.709687093869, 974.2254907348674, 10022.749431264203, 10210.591576337012, 10221.029002244775, 10238.744031399274, 10267.38395696253, 4166.687498437569, 4240.173166232555, 4338.631216346583, 4346.891327716832, 4359.760213188241, 8873.600687969058, 8902.465852048897, 8940.552972351357, 8947.955260223658, 8979.775505612412, 4602.355670206174, 4614.054118905617, 4623.630109591225, 4623.728474669493, 4639.072185562901, 3641.5448068991377, 3977.840886364513, 4151.024509240327, 4156.106437116035, 4238.809253583596, 3610.097475631092, 3657.670809627093, 3746.456763769238, 3762.962370376316, 3875.186210895687, 1208.7461633057158, 1212.1938910624513, 1214.5263347294563, 1218.6648671615199, 1220.2739370074792, 776.7592046465613, 901.4095767272447, 916.6113338292492, 920.406337912043, 935.1630290889616, 5148.150555158431, 5206.76569554371, 5288.471152884681, 5295.788168473295, 5367.704776237267, 425.96592272618113, 442.93798868158484, 446.73642550894476, 448.84290498325976, 451.45374097341926, 3623.0942264433893, 3720.720945929012, 3781.4138808484727, 3785.962140378561, 3794.317022935843, 8706.825863482694, 9057.36598438103, 9093.181613654802, 9527.952360238154, 9533.856992145124, 9209.171174594185, 9249.075092490697, 9292.72121836346, 9337.15965563089, 9356.204722598655, 6906.240313565504, 7007.754728584577, 7129.322714342233, 7135.322144396274, 7144.214136444987, 5430.076886929152, 5454.845006714986, 5460.208269800936, 5525.696086715108, 5605.411431799603, 8366.121557236402, 8525.829483410422, 8597.484150950962, 8692.565371731514, 8722.302215822592, 8305.0, 8513.787155321166, 8641.308695304235, 8725.65097396097, 8820.117988201386, 5831.70841457917, 6203.286622038343, 6431.774887878902, 6525.401276687242, 6667.633280169443, 7207.423406127392, 7240.167380751281, 7325.523840950321, 7332.560046397233, 7345.853082938418, 6402.90395644075, 6527.934720652733, 6595.307492713196, 6655.500837437115, 6659.4006539411685, 6551.148350714377, 6598.505112116514, 6598.60408375499, 6634.867302654016, 6656.866862662817, 6165.321814600301, 6209.534284928558, 6223.533235007483, 6227.50179985591, 6251.812445626639, 4553.590176884097, 4648.279516674921, 4703.412073490814, 4722.858314250578, 4761.214399624023, 4627.282771170474, 4628.814847406201, 4640.767961601974, 4664.370310008106, 4760.143174228672], "value": 4047.9859812693244, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.9745871600914, 305.8088694565896, 309.0928125950336, 316.38621075114264, 317.66327692645797, 4523.027549076948, 4633.166030114587, 4713.057388522292, 4762.856914340559, 4775.4985726498735, 4518.186726389248, 4660.510646382132, 4675.345451636774, 4684.789184486698, 4685.2035154023815, 3714.1271801126713, 3716.7026637868908, 3719.5164628598245, 3727.2359166370898, 3734.7759134451885, 3553.520274762913, 3579.355715971124, 3677.5403074615674, 3706.425504046877, 3719.479272901796, 3673.5591728992426, 3688.299223147607, 3688.7786732796117, 3695.1685870679153, 3695.445683147536, 3678.668919797231, 3684.5394325709285, 3687.2625474904994, 3689.0961714380014, 3709.9072523186865, 3306.8677252910097, 3307.5358857650963, 3307.7353811695007, 3316.93366132676, 3332.3835090508333, 4252.936205956913, 4469.0, 4475.820967161309, 4493.326001099828, 4524.751138687371, 4101.938470922939, 4117.238310912461, 4152.792360381999, 4153.854615088458, 4173.1862286854075, 4864.130163203691, 4867.148249056437, 4896.290037944478, 4902.877428064291, 4912.280701754357, 3426.417509023472, 3473.94789078164, 3480.164760457472, 3490.8254587270535, 3610.700147946737, 5079.288899554065, 5088.211327244246, 5125.6155788315655, 5141.460146684619, 5155.664881782672, 3737.8878633641034, 3739.8780365890125, 3748.3440397930253, 3766.8493260269283, 3777.0934975605655, 3817.370133927871, 3829.3872980323013, 3833.271678381099, 3839.788811615332, 3841.713026136276, 4176.707630465899, 4239.894002649897, 4247.830086796494, 4254.255505286563, 4254.78738559509, 4836.298736683161, 4871.2206047032305, 4906.435759887588, 4908.386451693538, 4941.728204948762, 1185.4843143232722, 1222.6454328244888, 1263.7662032524013, 1264.759695657822, 1265.5507294910358, 862.4178679391385, 884.6288253207503, 903.0021825882436, 907.2243232036514, 907.5190149220923, 4156.521999969982, 4192.3082691355585, 4218.957810421918, 4227.873163805029, 4274.572542745701, 4894.632902532324, 4904.479611320502, 4905.779239934212, 4930.926036109461, 4934.629902757308, 4164.0, 4167.791610419466, 4196.979015104905, 4259.190753756776, 4275.893102672458, 2449.1060762821444, 2533.873306334676, 2551.374913146291, 2572.7813135883284, 2574.5623244048556, 4536.661684802991, 4550.863474095782, 4567.406237189144, 4587.655925805578, 4599.379083823708, 4917.754112294371, 4938.0, 4963.528464795839, 4971.1549036663855, 4978.377702787152, 4328.658115984055, 4561.908761824745, 4580.88547786308, 4593.954060459419, 4612.838550650711, 4806.158922188673, 4807.375041244616, 4815.855524334275, 4872.464028956882, 4927.827526036572, 4752.239641657318, 4758.738269395078, 4776.9761151194025, 4816.614670826255, 4837.419509658864, 4385.934210986901, 4506.346579745984, 4600.677952543289, 4609.723416595015, 4614.74618895964, 3534.4698295255916, 3536.4872093546805, 3556.804375759358, 3567.5005499230647, 3570.2859428115003, 4764.952350476589, 4790.257510085942, 4804.231322988305, 4843.951560484491, 4855.4023597375235, 4654.813807447799, 4872.244802055687, 4879.487653796442, 4905.7792399342825, 4964.304997300309, 4835.178019736723, 4835.95164048355, 4842.249451335048, 4892.633052521146, 4897.289892965571, 4549.567791059844, 4755.191617424977, 4796.736179510161, 4803.495632958628, 4824.614030877451, 4886.511348865085, 4920.434150072788, 4933.679310844784, 4944.975275123746, 4953.826616068421, 4805.639577031667, 4810.6632535722165, 4818.0, 4830.637702172421, 4858.4898585648], "value": 3682.078948813399, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.5125063706042, 801.9198080191982, 809.9190080991901, 811.4238890387825, 815.2540425510659, 11477.426128693563, 12756.489740410385, 12848.871511284884, 12934.48262069516, 12948.352582370868, 11425.485853136608, 11949.044076473883, 12025.158238923279, 12068.396580170978, 12262.080343974216, 857.3355649371724, 865.8744482050099, 870.9738707838775, 874.3049275825703, 874.3136637739376, 861.3841103610916, 862.1249431826701, 865.7662431143588, 866.7269810009858, 866.8223014282057, 899.6761165980242, 903.20969151992, 905.2260317428603, 905.3617199874105, 905.728281515546, 894.4990805149072, 896.6458248991645, 897.0312062972007, 897.3404547657467, 897.905719899411, 662.9270780214173, 663.0518358747038, 664.5879554676084, 664.7341063574561, 668.0213487241215, 11489.195756297062, 11603.07175425964, 11663.0, 11685.065194784396, 11747.0, 10294.89705102947, 10428.374297542172, 10584.682459526226, 10875.673729788119, 10897.564097436092, 9172.816543669156, 9217.723468295962, 9268.860967085498, 9319.627214911396, 9358.11097945694, 3277.4428347181038, 3284.720798732111, 3332.3835090508333, 3337.6829201225846, 3389.6440873708398, 40118.0, 40238.0, 40276.99999999971, 40723.0, 40828.38757418611, 8277.172282771675, 8353.582320883932, 8391.244787969112, 8396.580170991427, 8602.0, 15679.216039197994, 15782.0, 15786.289616967264, 15790.289436975363, 15882.60293492672, 6652.334766523309, 6756.223034351113, 6832.658367081626, 6910.06714093601, 6992.545484543489, 3745.6628903398823, 3802.9239415212096, 3824.770513769183, 3837.597052309523, 3862.2275544891136, 2883.7548808351107, 2986.925326866802, 2988.462076826192, 2988.5367767995995, 2990.9551356729667, 504.6064070025386, 507.84510724229466, 510.4767613196429, 513.9640225184276, 517.2680656870562, 590.7725525672647, 592.528939493104, 608.1668114682913, 608.5435923057706, 632.5287660692813, 7846.489978151516, 7997.840043199103, 8145.837083258301, 8161.63272652732, 8299.735369311782, 520.7370278009581, 533.1070456984613, 588.4233451217831, 614.2322097378277, 622.700816055372, 3719.460678201646, 3792.829322680486, 3801.1827457096856, 3833.961660383416, 3888.669463095612, 47189.29216061762, 49092.01815963732, 49157.0, 49521.50478495241, 49594.0, 32666.836665816994, 39715.0, 43073.49242776551, 43121.0, 43981.12037759227, 39197.608023919965, 40932.38601420981, 41601.167976640296, 41856.37215441771, 45842.312365314545, 8196.959015204886, 8242.835143296981, 8304.83390332202, 8312.41813073079, 8318.916810831814, 29327.12018639444, 30190.0, 30634.540481892345, 31537.684623154393, 31697.366052679277, 35468.645313546534, 37368.43947340846, 37653.0, 38128.809355953046, 38459.42310865395, 9091.363604547618, 10493.422861742372, 10649.574017039231, 10922.29005114665, 10976.341419514854, 10160.847587286344, 10178.338408003456, 10475.109615682752, 10778.514966826355, 10880.238383313092, 9787.85318220213, 9812.55843487059, 9929.453880036668, 10008.699739007841, 10157.0, 9827.164691001059, 9934.354266972912, 10082.143017843566, 10176.643817466353, 10287.125594324567, 9637.951810240904, 9658.90341096608, 9748.22014238845, 9751.073648003428, 9955.950220249142, 7730.884036739341, 7878.4091193161885, 7935.761927142195, 8077.434579579608, 8206.384521161057, 8355.83288334242, 8523.318134549345, 8534.615942282737, 8678.652853885775, 8739.778691871767], "value": 5762.703718313011, "unit": "score"}], "name": "dromaeo_css", "value": 6202.216222048979, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 110.0, 115.0, 114.0, 115.0, 112.0, 114.0, 114.0, 114.0, 115.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 136.0, 161.0, 194.0, 140.0, 149.0, 154.0, 136.0, 184.0, 132.0], "value": 154.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 159.0, 159.0, 159.0, 161.0, 162.0, 160.0, 160.0, 162.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 75.0, 134.0, 89.0, 75.0, 77.0, 76.0, 137.0, 77.0], "value": 89.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 125.0, 92.0, 92.0, 93.0, 135.0, 92.0, 92.0, 122.0], "value": 103.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 153.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 67.0, 67.0, 67.0, 68.0, 83.0, 66.0, 64.0], "value": 68.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 65.0, 64.0, 65.0, 64.0, 65.0, 65.0, 65.0, 64.0], "value": 64.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 88.0, 84.0, 84.0, 83.0, 83.0, 84.0, 82.0, 87.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 142.0, 132.0, 139.0, 130.0, 130.0, 130.0, 131.0, 169.0, 135.0], "value": 137.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 172.0, 173.0, 183.0, 187.0, 176.0, 179.0, 174.0, 176.0, 173.0], "value": 176.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 69.0, 69.0, 69.0, 67.0, 68.0, 67.0, 67.0, 67.0], "value": 68.1, "unit": "score"}], "name": "kraken", "value": 1578.0999999999997, "alertThreshold": 2.0}]} 06:56:13 INFO - Return code: 0 06:56:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:56:13 ERROR - # TBPL SUCCESS # 06:56:13 INFO - Running post-action listener: _resource_record_post_action 06:56:13 INFO - ##### 06:56:13 INFO - ##### Finished run-tests step (success) 06:56:13 INFO - ##### 06:56:13 INFO - Running post-run listener: _resource_record_post_run 06:56:14 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 3309568; Write bytes: 277622784; Read time: 328; Write time: 228600 06:56:14 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 192512; Read time: 0; Write time: 48 06:56:14 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 3309568; Write bytes: 276922368; Read time: 328; Write time: 228524 06:56:14 INFO - Running post-run listener: _upload_blobber_files 06:56:14 INFO - Blob upload gear active. 06:56:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:56:14 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 06:56:14 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:56:14 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:56:14 INFO - (blobuploader) - INFO - Open directory for files ... 06:56:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:56:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:56:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:56:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:56:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:56:15 INFO - (blobuploader) - INFO - Done attempting. 06:56:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:56:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:56:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:56:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:56:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:56:16 INFO - (blobuploader) - INFO - Done attempting. 06:56:16 INFO - (blobuploader) - INFO - Iteration through files over. 06:56:16 INFO - Return code: 0 06:56:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:56:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:56:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/801f25c8ec4d34e3a2b08e3de9d622dcb8e444b660634e00ba75e76b6a7cb603cbbe619d542b3b5728054dee635821424cf19fa2af19c00226779a23d54e221a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/084807b274f9f3c2eb54b3a24b9a4917307790c98da1c88cf432169e9d5ae120da37503e7cbab7f752c34bcee9a33b9fecc5baa7ab643edd7dd274451277af63"} 06:56:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:56:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:56:16 INFO - Contents: 06:56:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/801f25c8ec4d34e3a2b08e3de9d622dcb8e444b660634e00ba75e76b6a7cb603cbbe619d542b3b5728054dee635821424cf19fa2af19c00226779a23d54e221a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/084807b274f9f3c2eb54b3a24b9a4917307790c98da1c88cf432169e9d5ae120da37503e7cbab7f752c34bcee9a33b9fecc5baa7ab643edd7dd274451277af63"} 06:56:16 INFO - Running post-run listener: copy_logs_to_upload_dir 06:56:16 INFO - Copying logs to upload dir... 06:56:16 INFO - mkdir: /builds/slave/test/build/upload/logs 06:56:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.657239 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-07 06:56:16.367787) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-07 06:56:16.370901) ========= 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=5bd038846534b2fdfa68eeae000001e2-1462625871.325808-1176405867 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/801f25c8ec4d34e3a2b08e3de9d622dcb8e444b660634e00ba75e76b6a7cb603cbbe619d542b3b5728054dee635821424cf19fa2af19c00226779a23d54e221a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/084807b274f9f3c2eb54b3a24b9a4917307790c98da1c88cf432169e9d5ae120da37503e7cbab7f752c34bcee9a33b9fecc5baa7ab643edd7dd274451277af63"} build_url:https://queue.taskcluster.net/v1/task/YRbs5HPzQOud-TXFR4Fy7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011050 build_url: 'https://queue.taskcluster.net/v1/task/YRbs5HPzQOud-TXFR4Fy7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/801f25c8ec4d34e3a2b08e3de9d622dcb8e444b660634e00ba75e76b6a7cb603cbbe619d542b3b5728054dee635821424cf19fa2af19c00226779a23d54e221a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/084807b274f9f3c2eb54b3a24b9a4917307790c98da1c88cf432169e9d5ae120da37503e7cbab7f752c34bcee9a33b9fecc5baa7ab643edd7dd274451277af63"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-07 06:56:16.395921) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 06:56:16.396295) ========= 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=5bd038846534b2fdfa68eeae000001e2-1462625871.325808-1176405867 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004415 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 06:56:16.478319) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-07 06:56:16.478639) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-07 06:56:16.478933) ========= ========= Total master_lag: 0.17 =========