builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-004 starttime: 1464648648.51 results: success (0) buildid: 20160530120549 builduid: 7997d47d310b490c9d491deb39fe4327 revision: 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.512468) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.512970) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.513392) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.594242) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.594846) ========= 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=c6927cf182745ad25b1d38b9000001fe-1464648596.87734-1303288114 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 15:50:48-- 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% 43.1M=0s 2016-05-30 15:50:48 (43.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127830 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.753309) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.753596) ========= 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=c6927cf182745ad25b1d38b9000001fe-1464648596.87734-1303288114 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015814 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.813014) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.813319) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 --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=c6927cf182745ad25b1d38b9000001fe-1464648596.87734-1303288114 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 15:50:49,135 truncating revision to first 12 chars 2016-05-30 15:50:49,135 Setting DEBUG logging. 2016-05-30 15:50:49,135 attempt 1/10 2016-05-30 15:50:49,135 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3c7a33fe0b64?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 15:50:49,446 unpacking tar archive at: mozilla-aurora-3c7a33fe0b64/testing/mozharness/ program finished with exit code 0 elapsedTime=0.621815 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:49.449685) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:49.449957) ========= script_repo_revision: 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:49.450364) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:49.450655) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:49.477800) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-05-30 15:50:49.478072) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=c6927cf182745ad25b1d38b9000001fe-1464648596.87734-1303288114 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:50:49 INFO - MultiFileLogger online at 20160530 15:50:49 in /builds/slave/test 15:50:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 15:50:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:50:49 INFO - {'append_to_log': False, 15:50:49 INFO - 'base_work_dir': '/builds/slave/test', 15:50:49 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:50:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:50:49 INFO - 'branch': 'Mozilla-Aurora', 15:50:49 INFO - 'buildbot_json_path': 'buildprops.json', 15:50:49 INFO - 'config_files': ('talos/linux_config.py',), 15:50:49 INFO - 'default_actions': ('clobber', 15:50:49 INFO - 'read-buildbot-config', 15:50:49 INFO - 'download-and-extract', 15:50:49 INFO - 'populate-webroot', 15:50:49 INFO - 'create-virtualenv', 15:50:49 INFO - 'install', 15:50:49 INFO - 'run-tests'), 15:50:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:50:49 INFO - 'download_minidump_stackwalk': True, 15:50:49 INFO - 'download_symbols': 'ondemand', 15:50:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:50:49 INFO - 'tooltool.py': '/tools/tooltool.py', 15:50:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:50:49 INFO - '/tools/misc-python/virtualenv.py')}, 15:50:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:50:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:50:49 INFO - 'installer_path': 'installer.exe', 15:50:49 INFO - 'log_level': 'info', 15:50:49 INFO - 'log_name': 'talos', 15:50:49 INFO - 'log_to_console': True, 15:50:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:50:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:50:49 INFO - 'opt_config_files': (), 15:50:49 INFO - 'pip_index': False, 15:50:49 INFO - 'sps_profile': False, 15:50:49 INFO - 'sps_profile_interval': 0, 15:50:49 INFO - 'suite': 'dromaeojs', 15:50:49 INFO - 'system_bits': '32', 15:50:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:50:49 INFO - 'title': 'talos-linux64-ix-004', 15:50:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:50:49 INFO - 'use_talos_json': True, 15:50:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:50:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:50:49 INFO - 'work_dir': 'build'} 15:50:49 INFO - ##### 15:50:49 INFO - ##### Running clobber step. 15:50:49 INFO - ##### 15:50:49 INFO - Running pre-action listener: _resource_record_pre_action 15:50:49 INFO - Running main action method: clobber 15:50:49 INFO - rmtree: /builds/slave/test/build 15:50:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:50:50 INFO - Running post-action listener: _resource_record_post_action 15:50:50 INFO - ##### 15:50:50 INFO - ##### Running read-buildbot-config step. 15:50:50 INFO - ##### 15:50:50 INFO - Running pre-action listener: _resource_record_pre_action 15:50:50 INFO - Running main action method: read_buildbot_config 15:50:50 INFO - Using buildbot properties: 15:50:50 INFO - { 15:50:50 INFO - "project": "", 15:50:50 INFO - "product": "firefox", 15:50:50 INFO - "script_repo_revision": "production", 15:50:50 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 15:50:50 INFO - "repository": "", 15:50:50 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 15:50:50 INFO - "buildid": "20160530120549", 15:50:50 INFO - "pgo_build": "True", 15:50:50 INFO - "basedir": "/builds/slave/test", 15:50:50 INFO - "buildnumber": 350, 15:50:50 INFO - "slavename": "talos-linux64-ix-004", 15:50:50 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:50:50 INFO - "platform": "ubuntu64_hw", 15:50:50 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 15:50:50 INFO - "branch": "mozilla-aurora", 15:50:50 INFO - "repo_path": "releases/mozilla-aurora", 15:50:50 INFO - "revision": "3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4", 15:50:50 INFO - "stage_platform": "linux64-pgo", 15:50:50 INFO - "builduid": "7997d47d310b490c9d491deb39fe4327", 15:50:50 INFO - "slavebuilddir": "test" 15:50:50 INFO - } 15:50:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 15:50:50 INFO - Running post-action listener: _resource_record_post_action 15:50:50 INFO - ##### 15:50:50 INFO - ##### Running download-and-extract step. 15:50:50 INFO - ##### 15:50:50 INFO - Running pre-action listener: _resource_record_pre_action 15:50:50 INFO - Running main action method: download_and_extract 15:50:50 INFO - mkdir: /builds/slave/test/build/tests 15:50:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:50:50 INFO - https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:50:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 15:50:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 15:50:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 15:50:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:50:51 INFO - Downloaded 1361 bytes. 15:50:51 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 15:50:51 INFO - Using the following test package requirements: 15:50:51 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 15:50:51 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:50:51 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 15:50:51 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:50:51 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 15:50:51 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:50:51 INFO - u'jsshell-linux-x86_64.zip'], 15:50:51 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:50:51 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 15:50:51 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 15:50:51 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:50:51 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 15:50:51 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:50:51 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 15:50:51 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:50:51 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 15:50:51 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:50:51 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 15:50:51 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:50: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')]} 15:50:51 INFO - https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:50:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 15:50:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 15:50:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 15:50:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:50:52 INFO - Downloaded 24173994 bytes. 15:50:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:50:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:50:53 INFO - Return code: 0 15:50:53 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:50:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:50:53 INFO - https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:50:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 15:50:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 15:50:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 15:50:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:50:55 INFO - Downloaded 24173994 bytes. 15:50:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:50:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:50:56 INFO - Return code: 0 15:50: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')]} 15:50:56 INFO - https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:50:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 15:50:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 15:50:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 15:50:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:50:57 INFO - Downloaded 10840145 bytes. 15:50:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:50:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:50:58 INFO - Return code: 0 15:50:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:50:58 INFO - https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:50:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 15:50:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 15:50:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 15:50:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:51:00 INFO - Downloaded 62800628 bytes. 15:51:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 15:51:00 INFO - mkdir: /builds/slave/test/properties 15:51:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:51:00 INFO - Writing to file /builds/slave/test/properties/build_url 15:51:00 INFO - Contents: 15:51:00 INFO - build_url:https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 15:51:00 INFO - Running post-action listener: _resource_record_post_action 15:51:00 INFO - Running post-action listener: set_extra_try_arguments 15:51:00 INFO - ##### 15:51:00 INFO - ##### Running populate-webroot step. 15:51:00 INFO - ##### 15:51:00 INFO - Running pre-action listener: _resource_record_pre_action 15:51:00 INFO - Running main action method: populate_webroot 15:51:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:51:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:51:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:51:00 INFO - '--tppagecycles', 15:51:00 INFO - '7'], 15:51:00 INFO - 'tests': ['tsvgm']}}, 15:51:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:51:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:51:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:51:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:51:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:51:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:51:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:00 INFO - 'talos_options': ['--disable-e10s'], 15:51:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:51:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:51:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:00 INFO - 'talos_options': ['--disable-e10s'], 15:51:00 INFO - 'tests': ['damp', 'tps']}, 15:51:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:00 INFO - 'tests': ['damp', 'tps']}, 15:51:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:51:00 INFO - 'tests': ['dromaeo_dom']}, 15:51:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:51:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:51:00 INFO - 'tests': ['a11yr', 15:51:00 INFO - 'ts_paint', 15:51:00 INFO - 'tpaint', 15:51:00 INFO - 'sessionrestore', 15:51:00 INFO - 'sessionrestore_no_auto_restore', 15:51:00 INFO - 'tabpaint']}, 15:51:00 INFO - 'other-e10s': {'tests': ['a11yr', 15:51:00 INFO - 'ts_paint', 15:51:00 INFO - 'tpaint', 15:51:00 INFO - 'sessionrestore', 15:51:00 INFO - 'sessionrestore_no_auto_restore', 15:51:00 INFO - 'tabpaint']}, 15:51:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:51:00 INFO - 'ts_paint', 15:51:00 INFO - 'tpaint', 15:51:00 INFO - 'sessionrestore', 15:51:00 INFO - 'sessionrestore_no_auto_restore', 15:51:00 INFO - 'tabpaint']}, 15:51:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:51:00 INFO - 'ts_paint', 15:51:00 INFO - 'tpaint', 15:51:00 INFO - 'sessionrestore', 15:51:00 INFO - 'sessionrestore_no_auto_restore', 15:51:00 INFO - 'tabpaint']}, 15:51:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:51:00 INFO - 'tests': ['a11yr', 15:51:00 INFO - 'ts_paint', 15:51:00 INFO - 'tpaint', 15:51:00 INFO - 'sessionrestore', 15:51:00 INFO - 'sessionrestore_no_auto_restore', 15:51:00 INFO - 'tabpaint']}, 15:51:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:51:00 INFO - 'tests': ['a11yr', 15:51:00 INFO - 'ts_paint', 15:51:00 INFO - 'tpaint', 15:51:00 INFO - 'sessionrestore', 15:51:00 INFO - 'sessionrestore_no_auto_restore', 15:51:00 INFO - 'tabpaint']}, 15:51:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:51:00 INFO - 'tests': ['tsvgx', 15:51:00 INFO - 'tsvgr_opacity', 15:51:00 INFO - 'tart', 15:51:00 INFO - 'tscrollx', 15:51:00 INFO - 'cart']}, 15:51:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:51:00 INFO - 'tsvgr_opacity', 15:51:00 INFO - 'tart', 15:51:00 INFO - 'tscrollx', 15:51:00 INFO - 'cart']}, 15:51:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:00 INFO - 'talos_options': ['--disable-e10s'], 15:51:00 INFO - 'tests': ['tp5o']}, 15:51:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:00 INFO - 'tests': ['tp5o']}, 15:51:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:00 INFO - 'talos_options': ['--disable-e10s', 15:51:00 INFO - '--xperf_path', 15:51:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:51:00 INFO - 'tests': ['tp5n']}, 15:51:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:00 INFO - 'talos_options': ['--xperf_path', 15:51:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:51:00 INFO - 'tests': ['tp5n']}}, 15:51:00 INFO - 'talos.zip': {'path': '', 15:51:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:51:00 INFO - Running post-action listener: _resource_record_post_action 15:51:00 INFO - ##### 15:51:00 INFO - ##### Running create-virtualenv step. 15:51:00 INFO - ##### 15:51:00 INFO - Running pre-action listener: _resource_record_pre_action 15:51:00 INFO - Running main action method: create_virtualenv 15:51:00 INFO - Creating virtualenv /builds/slave/test/build/venv 15:51:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:51:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:51:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:51:01 INFO - Using real prefix '/usr' 15:51:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:51:01 INFO - Installing distribute.............................................................................................................................................................................................done. 15:51:03 INFO - Installing pip.................done. 15:51:03 INFO - Return code: 0 15:51:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:51: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')]} 15:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51: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')]} 15:51:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:03 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 0x7ffe23c22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf445a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd3410>, '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 0xfd4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd47a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1464648596.87734-1303288114', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:51:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:51:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:51:03 INFO - Using env: {'DISPLAY': ':0', 15:51:03 INFO - 'HOME': '/home/cltbld', 15:51:03 INFO - 'LANG': 'en_US.UTF-8', 15:51:03 INFO - 'LANGUAGE': 'en_US:en', 15:51:03 INFO - 'LOGNAME': 'cltbld', 15:51:03 INFO - 'MAIL': '/var/mail/cltbld', 15:51:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:03 INFO - 'MOZ_NO_REMOTE': '1', 15:51:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:03 INFO - 'NO_EM_RESTART': '1', 15:51:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:03 INFO - 'PWD': '/builds/slave/test', 15:51:03 INFO - 'SHELL': '/bin/bash', 15:51:03 INFO - 'SHLVL': '1', 15:51:03 INFO - 'TERM': 'linux', 15:51:03 INFO - 'TMOUT': '86400', 15:51:03 INFO - 'USER': 'cltbld', 15:51:03 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1464648596.87734-1303288114', 15:51:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:03 INFO - '_': '/tools/buildbot/bin/python'} 15:51:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:03 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:51:03 INFO - Cleaning up... 15:51:03 INFO - Return code: 0 15:51:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:51: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')]} 15:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51: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')]} 15:51:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:03 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 0x7ffe23c22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf445a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd3410>, '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 0xfd4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd47a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1464648596.87734-1303288114', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:51:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 15:51:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:51:03 INFO - Using env: {'DISPLAY': ':0', 15:51:03 INFO - 'HOME': '/home/cltbld', 15:51:03 INFO - 'LANG': 'en_US.UTF-8', 15:51:03 INFO - 'LANGUAGE': 'en_US:en', 15:51:03 INFO - 'LOGNAME': 'cltbld', 15:51:03 INFO - 'MAIL': '/var/mail/cltbld', 15:51:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:03 INFO - 'MOZ_NO_REMOTE': '1', 15:51:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:03 INFO - 'NO_EM_RESTART': '1', 15:51:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:03 INFO - 'PWD': '/builds/slave/test', 15:51:03 INFO - 'SHELL': '/bin/bash', 15:51:03 INFO - 'SHLVL': '1', 15:51:03 INFO - 'TERM': 'linux', 15:51:03 INFO - 'TMOUT': '86400', 15:51:03 INFO - 'USER': 'cltbld', 15:51:03 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1464648596.87734-1303288114', 15:51:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:03 INFO - '_': '/tools/buildbot/bin/python'} 15:51:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:03 INFO - Downloading/unpacking psutil>=0.7.1 15:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:51:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:51:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:51:05 INFO - Installing collected packages: psutil 15:51:05 INFO - Running setup.py install for psutil 15:51:06 INFO - building 'psutil._psutil_linux' extension 15:51:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:51:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:51:06 INFO - building 'psutil._psutil_posix' extension 15:51:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:51:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:51:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:51:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:51:06 INFO - Successfully installed psutil 15:51:06 INFO - Cleaning up... 15:51:06 INFO - Return code: 0 15:51:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:51:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffe23c22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf445a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd3410>, '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 0xfd4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd47a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1464648596.87734-1303288114', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:51:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 15:51:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:51:06 INFO - Using env: {'DISPLAY': ':0', 15:51:06 INFO - 'HOME': '/home/cltbld', 15:51:06 INFO - 'LANG': 'en_US.UTF-8', 15:51:06 INFO - 'LANGUAGE': 'en_US:en', 15:51:06 INFO - 'LOGNAME': 'cltbld', 15:51:06 INFO - 'MAIL': '/var/mail/cltbld', 15:51:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:06 INFO - 'MOZ_NO_REMOTE': '1', 15:51:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:06 INFO - 'NO_EM_RESTART': '1', 15:51:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:06 INFO - 'PWD': '/builds/slave/test', 15:51:06 INFO - 'SHELL': '/bin/bash', 15:51:06 INFO - 'SHLVL': '1', 15:51:06 INFO - 'TERM': 'linux', 15:51:06 INFO - 'TMOUT': '86400', 15:51:06 INFO - 'USER': 'cltbld', 15:51:06 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1464648596.87734-1303288114', 15:51:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:06 INFO - '_': '/tools/buildbot/bin/python'} 15:51:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:51:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:51:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:51:08 INFO - Installing collected packages: mozsystemmonitor 15:51:08 INFO - Running setup.py install for mozsystemmonitor 15:51:08 INFO - Successfully installed mozsystemmonitor 15:51:08 INFO - Cleaning up... 15:51:08 INFO - Return code: 0 15:51:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:51:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:08 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 0x7ffe23c22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf445a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd3410>, '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 0xfd4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd47a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1464648596.87734-1303288114', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:51:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:51:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:51:08 INFO - Using env: {'DISPLAY': ':0', 15:51:08 INFO - 'HOME': '/home/cltbld', 15:51:08 INFO - 'LANG': 'en_US.UTF-8', 15:51:08 INFO - 'LANGUAGE': 'en_US:en', 15:51:08 INFO - 'LOGNAME': 'cltbld', 15:51:08 INFO - 'MAIL': '/var/mail/cltbld', 15:51:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:08 INFO - 'MOZ_NO_REMOTE': '1', 15:51:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:08 INFO - 'NO_EM_RESTART': '1', 15:51:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:08 INFO - 'PWD': '/builds/slave/test', 15:51:08 INFO - 'SHELL': '/bin/bash', 15:51:08 INFO - 'SHLVL': '1', 15:51:08 INFO - 'TERM': 'linux', 15:51:08 INFO - 'TMOUT': '86400', 15:51:08 INFO - 'USER': 'cltbld', 15:51:08 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1464648596.87734-1303288114', 15:51:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:08 INFO - '_': '/tools/buildbot/bin/python'} 15:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:09 INFO - Downloading/unpacking blobuploader==1.2.4 15:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:10 INFO - Downloading blobuploader-1.2.4.tar.gz 15:51:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:51:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:51:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51:11 INFO - Downloading docopt-0.6.1.tar.gz 15:51:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:51:11 INFO - Installing collected packages: blobuploader, requests, docopt 15:51:11 INFO - Running setup.py install for blobuploader 15:51:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:51:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:51:11 INFO - Running setup.py install for requests 15:51:12 INFO - Running setup.py install for docopt 15:51:12 INFO - Successfully installed blobuploader requests docopt 15:51:12 INFO - Cleaning up... 15:51:12 INFO - Return code: 0 15:51:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:12 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 0x7ffe23c22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf445a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd3410>, '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 0xfd4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd47a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1464648596.87734-1303288114', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:51:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:51:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:51:12 INFO - Using env: {'DISPLAY': ':0', 15:51:12 INFO - 'HOME': '/home/cltbld', 15:51:12 INFO - 'LANG': 'en_US.UTF-8', 15:51:12 INFO - 'LANGUAGE': 'en_US:en', 15:51:12 INFO - 'LOGNAME': 'cltbld', 15:51:12 INFO - 'MAIL': '/var/mail/cltbld', 15:51:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:12 INFO - 'MOZ_NO_REMOTE': '1', 15:51:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:12 INFO - 'NO_EM_RESTART': '1', 15:51:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:12 INFO - 'PWD': '/builds/slave/test', 15:51:12 INFO - 'SHELL': '/bin/bash', 15:51:12 INFO - 'SHLVL': '1', 15:51:12 INFO - 'TERM': 'linux', 15:51:12 INFO - 'TMOUT': '86400', 15:51:12 INFO - 'USER': 'cltbld', 15:51:12 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1464648596.87734-1303288114', 15:51:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:12 INFO - '_': '/tools/buildbot/bin/python'} 15:51:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:51:12 INFO - Running setup.py (path:/tmp/pip-vMC2Nj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:51:12 INFO - Running setup.py (path:/tmp/pip-g7qNNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:51:12 INFO - Running setup.py (path:/tmp/pip-mE4oZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:51:12 INFO - Running setup.py (path:/tmp/pip-DUnKvu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:51:12 INFO - Running setup.py (path:/tmp/pip-cmpeC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:51:12 INFO - Running setup.py (path:/tmp/pip-99qvvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:51:12 INFO - Running setup.py (path:/tmp/pip-4t19ET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:51:13 INFO - Running setup.py (path:/tmp/pip-5ksYR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:51:13 INFO - Running setup.py (path:/tmp/pip-lxYbYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:51:13 INFO - Running setup.py (path:/tmp/pip-I8XjYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:51:13 INFO - Running setup.py (path:/tmp/pip-aUuP7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:51:13 INFO - Running setup.py (path:/tmp/pip-fbj2Pj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:51:13 INFO - Running setup.py (path:/tmp/pip-2xwRZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:51:13 INFO - Running setup.py (path:/tmp/pip-OPq_mq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:13 INFO - Running setup.py (path:/tmp/pip-F28PkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:51:13 INFO - Running setup.py (path:/tmp/pip-BSvkfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:51:13 INFO - Running setup.py (path:/tmp/pip-ECY8Gk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:51:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:51:13 INFO - Running setup.py install for manifestparser 15:51:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:51:13 INFO - Running setup.py install for mozcrash 15:51:13 INFO - Running setup.py install for mozdebug 15:51:14 INFO - Running setup.py install for mozdevice 15:51:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:51:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:51:14 INFO - Running setup.py install for mozfile 15:51:14 INFO - Running setup.py install for mozhttpd 15:51:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:51:14 INFO - Running setup.py install for mozinfo 15:51:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:51:14 INFO - Running setup.py install for mozInstall 15:51:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:51:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:51:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:51:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:51:14 INFO - Running setup.py install for mozleak 15:51:14 INFO - Running setup.py install for mozlog 15:51:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:51:14 INFO - Running setup.py install for moznetwork 15:51:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:51:14 INFO - Running setup.py install for mozprocess 15:51:14 INFO - Running setup.py install for mozprofile 15:51:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:51:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:51:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:51:15 INFO - Running setup.py install for mozrunner 15:51:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:51:15 INFO - Running setup.py install for mozscreenshot 15:51:15 INFO - Running setup.py install for moztest 15:51:15 INFO - Running setup.py install for mozversion 15:51:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:51:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:51:15 INFO - Cleaning up... 15:51:15 INFO - Return code: 0 15:51:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:15 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 0x7ffe23c22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf445a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd3410>, '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 0xfd4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd47a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1464648596.87734-1303288114', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:51:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:51:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:51:15 INFO - Using env: {'DISPLAY': ':0', 15:51:15 INFO - 'HOME': '/home/cltbld', 15:51:15 INFO - 'LANG': 'en_US.UTF-8', 15:51:15 INFO - 'LANGUAGE': 'en_US:en', 15:51:15 INFO - 'LOGNAME': 'cltbld', 15:51:15 INFO - 'MAIL': '/var/mail/cltbld', 15:51:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:15 INFO - 'MOZ_NO_REMOTE': '1', 15:51:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:15 INFO - 'NO_EM_RESTART': '1', 15:51:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:15 INFO - 'PWD': '/builds/slave/test', 15:51:15 INFO - 'SHELL': '/bin/bash', 15:51:15 INFO - 'SHLVL': '1', 15:51:15 INFO - 'TERM': 'linux', 15:51:15 INFO - 'TMOUT': '86400', 15:51:15 INFO - 'USER': 'cltbld', 15:51:15 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1464648596.87734-1303288114', 15:51:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:15 INFO - '_': '/tools/buildbot/bin/python'} 15:51:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:51:15 INFO - Running setup.py (path:/tmp/pip-4UZyCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:51:15 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:51:15 INFO - Running setup.py (path:/tmp/pip-QZCfwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:51:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:51:15 INFO - Running setup.py (path:/tmp/pip-GjsHnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:51:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:51:15 INFO - Running setup.py (path:/tmp/pip-lFtlDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:51:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:51:16 INFO - Running setup.py (path:/tmp/pip-vMQodO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:51:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:51:16 INFO - Running setup.py (path:/tmp/pip-hRhl7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:51:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:51:16 INFO - Running setup.py (path:/tmp/pip-C1XyG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:51:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:51:16 INFO - Running setup.py (path:/tmp/pip-XzIoDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:51:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:51:16 INFO - Running setup.py (path:/tmp/pip-sPq3wo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:51:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:51:16 INFO - Running setup.py (path:/tmp/pip-tlnKl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:51:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:51:16 INFO - Running setup.py (path:/tmp/pip-yx7Tru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:51:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:51:16 INFO - Running setup.py (path:/tmp/pip-WItEqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:51:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:51:16 INFO - Running setup.py (path:/tmp/pip-ky1XfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:51:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:51:16 INFO - Running setup.py (path:/tmp/pip-kT3kxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:51:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:16 INFO - Running setup.py (path:/tmp/pip-iJAbqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:51:16 INFO - Running setup.py (path:/tmp/pip-Zc5PIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:51:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:51:16 INFO - Running setup.py (path:/tmp/pip-jGXzVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:51:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:51:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:51:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:51:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:51:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:51:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:51:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:18 INFO - Downloading blessings-1.6.tar.gz 15:51:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:51:18 INFO - Installing collected packages: blessings 15:51:18 INFO - Running setup.py install for blessings 15:51:19 INFO - Successfully installed blessings 15:51:19 INFO - Cleaning up... 15:51:19 INFO - Return code: 0 15:51:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:51:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:51:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:51:19 INFO - Reading from file tmpfile_stdout 15:51:19 INFO - Current package versions: 15:51:19 INFO - argparse == 1.2.1 15:51:19 INFO - blessings == 1.6 15:51:19 INFO - blobuploader == 1.2.4 15:51:19 INFO - docopt == 0.6.1 15:51:19 INFO - manifestparser == 1.1 15:51:19 INFO - mozInstall == 1.12 15:51:19 INFO - mozcrash == 0.17 15:51:19 INFO - mozdebug == 0.1 15:51:19 INFO - mozdevice == 0.48 15:51:19 INFO - mozfile == 1.2 15:51:19 INFO - mozhttpd == 0.7 15:51:19 INFO - mozinfo == 0.9 15:51:19 INFO - mozleak == 0.1 15:51:19 INFO - mozlog == 3.1 15:51:19 INFO - moznetwork == 0.27 15:51:19 INFO - mozprocess == 0.22 15:51:19 INFO - mozprofile == 0.28 15:51:19 INFO - mozrunner == 6.11 15:51:19 INFO - mozscreenshot == 0.1 15:51:19 INFO - mozsystemmonitor == 0.0 15:51:19 INFO - moztest == 0.7 15:51:19 INFO - mozversion == 1.4 15:51:19 INFO - psutil == 3.1.1 15:51:19 INFO - requests == 1.2.3 15:51:19 INFO - wsgiref == 0.1.2 15:51:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:19 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 0x7ffe23c22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf445a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd3410>, '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 0xfd4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd47a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1464648596.87734-1303288114', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:51:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:51:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:51:19 INFO - Using env: {'DISPLAY': ':0', 15:51:19 INFO - 'HOME': '/home/cltbld', 15:51:19 INFO - 'LANG': 'en_US.UTF-8', 15:51:19 INFO - 'LANGUAGE': 'en_US:en', 15:51:19 INFO - 'LOGNAME': 'cltbld', 15:51:19 INFO - 'MAIL': '/var/mail/cltbld', 15:51:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:19 INFO - 'MOZ_NO_REMOTE': '1', 15:51:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:19 INFO - 'NO_EM_RESTART': '1', 15:51:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:19 INFO - 'PWD': '/builds/slave/test', 15:51:19 INFO - 'SHELL': '/bin/bash', 15:51:19 INFO - 'SHLVL': '1', 15:51:19 INFO - 'TERM': 'linux', 15:51:19 INFO - 'TMOUT': '86400', 15:51:19 INFO - 'USER': 'cltbld', 15:51:19 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1464648596.87734-1303288114', 15:51:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:19 INFO - '_': '/tools/buildbot/bin/python'} 15:51:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:51:19 INFO - Cleaning up... 15:51:19 INFO - Return code: 0 15:51:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:19 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 0x7ffe23c22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf445a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd3410>, '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 0xfd4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd47a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1464648596.87734-1303288114', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:51:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:51:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:51:19 INFO - Using env: {'DISPLAY': ':0', 15:51:19 INFO - 'HOME': '/home/cltbld', 15:51:19 INFO - 'LANG': 'en_US.UTF-8', 15:51:19 INFO - 'LANGUAGE': 'en_US:en', 15:51:19 INFO - 'LOGNAME': 'cltbld', 15:51:19 INFO - 'MAIL': '/var/mail/cltbld', 15:51:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:19 INFO - 'MOZ_NO_REMOTE': '1', 15:51:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:19 INFO - 'NO_EM_RESTART': '1', 15:51:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:19 INFO - 'PWD': '/builds/slave/test', 15:51:19 INFO - 'SHELL': '/bin/bash', 15:51:19 INFO - 'SHLVL': '1', 15:51:19 INFO - 'TERM': 'linux', 15:51:19 INFO - 'TMOUT': '86400', 15:51:19 INFO - 'USER': 'cltbld', 15:51:19 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1464648596.87734-1303288114', 15:51:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:19 INFO - '_': '/tools/buildbot/bin/python'} 15:51:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:19 INFO - Downloading/unpacking jsonschema 15:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:51:21 INFO - Downloading/unpacking functools32 (from jsonschema) 15:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:21 INFO - Downloading functools32-3.2.3-2.tar.gz 15:51:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:51:21 INFO - warning: no files found matching '*.txt' 15:51:21 INFO - no previously-included directories found matching 'build' 15:51:21 INFO - no previously-included directories found matching 'dist' 15:51:21 INFO - no previously-included directories found matching '.git*' 15:51:21 INFO - Installing collected packages: jsonschema, functools32 15:51:21 INFO - Running setup.py install for functools32 15:51:22 INFO - warning: no files found matching '*.txt' 15:51:22 INFO - no previously-included directories found matching 'build' 15:51:22 INFO - no previously-included directories found matching 'dist' 15:51:22 INFO - no previously-included directories found matching '.git*' 15:51:22 INFO - Successfully installed jsonschema functools32 15:51:22 INFO - Cleaning up... 15:51:22 INFO - Return code: 0 15:51:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:51:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:22 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 0x7ffe23c22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf445a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd3410>, '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 0xfd4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd47a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1464648596.87734-1303288114', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:51:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 15:51:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:51:22 INFO - Using env: {'DISPLAY': ':0', 15:51:22 INFO - 'HOME': '/home/cltbld', 15:51:22 INFO - 'LANG': 'en_US.UTF-8', 15:51:22 INFO - 'LANGUAGE': 'en_US:en', 15:51:22 INFO - 'LOGNAME': 'cltbld', 15:51:22 INFO - 'MAIL': '/var/mail/cltbld', 15:51:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:22 INFO - 'MOZ_NO_REMOTE': '1', 15:51:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:22 INFO - 'NO_EM_RESTART': '1', 15:51:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:22 INFO - 'PWD': '/builds/slave/test', 15:51:22 INFO - 'SHELL': '/bin/bash', 15:51:22 INFO - 'SHLVL': '1', 15:51:22 INFO - 'TERM': 'linux', 15:51:22 INFO - 'TMOUT': '86400', 15:51:22 INFO - 'USER': 'cltbld', 15:51:22 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1464648596.87734-1303288114', 15:51:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:22 INFO - '_': '/tools/buildbot/bin/python'} 15:51:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:22 INFO - Downloading/unpacking flake8 15:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:51:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:51:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:51:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:51:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:51:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:51:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:51:24 INFO - no previously-included directories found matching 'docs/_build' 15:51:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:51:25 INFO - Running setup.py install for pep8 15:51:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:51:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:51:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:51:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:51:25 INFO - no previously-included directories found matching 'docs/_build' 15:51:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:51:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:51:25 INFO - Cleaning up... 15:51:25 INFO - Return code: 0 15:51:25 INFO - Running post-action listener: _resource_record_post_action 15:51:25 INFO - Running post-action listener: _start_resource_monitoring 15:51:25 INFO - Starting resource monitoring. 15:51:25 INFO - ##### 15:51:25 INFO - ##### Running install step. 15:51:25 INFO - ##### 15:51:25 INFO - Running pre-action listener: _resource_record_pre_action 15:51:25 INFO - Running main action method: install 15:51:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:51:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:51:25 INFO - Reading from file tmpfile_stdout 15:51:25 INFO - Detecting whether we're running mozinstall >=1.0... 15:51:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:51:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:51:25 INFO - Reading from file tmpfile_stdout 15:51:25 INFO - Output received: 15:51:25 INFO - Usage: mozinstall [options] installer 15:51:25 INFO - Options: 15:51:25 INFO - -h, --help show this help message and exit 15:51:25 INFO - -d DEST, --destination=DEST 15:51:25 INFO - Directory to install application into. [default: 15:51:25 INFO - "/builds/slave/test"] 15:51:25 INFO - --app=APP Application being installed. [default: firefox] 15:51:25 INFO - mkdir: /builds/slave/test/build/application 15:51:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:51:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:51:41 INFO - Reading from file tmpfile_stdout 15:51:41 INFO - Output received: 15:51:41 INFO - /builds/slave/test/build/application/firefox/firefox 15:51:41 INFO - Running post-action listener: _resource_record_post_action 15:51:41 INFO - ##### 15:51:41 INFO - ##### Running run-tests step. 15:51:41 INFO - ##### 15:51:41 INFO - Running pre-action listener: _resource_record_pre_action 15:51:41 INFO - Running main action method: run_tests 15:51:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:51:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:51:41 INFO - Python 2.7.3 15:51:41 INFO - Return code: 0 15:51:41 INFO - grabbing minidump binary from tooltool 15:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:41 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 0xfd3410>, '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 0xfd4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd47a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:51:41 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:51:41 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:51:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:51:41 INFO - Return code: 0 15:51:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:51:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:51:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:51:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:51:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:51:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:51:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:51:42 INFO - Return code: 0 15:51:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:51:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:51:42 INFO - Using env: {'DISPLAY': ':0', 15:51:42 INFO - 'HOME': '/home/cltbld', 15:51:42 INFO - 'LANG': 'en_US.UTF-8', 15:51:42 INFO - 'LANGUAGE': 'en_US:en', 15:51:42 INFO - 'LOGNAME': 'cltbld', 15:51:42 INFO - 'MAIL': '/var/mail/cltbld', 15:51:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:51:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:51:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:42 INFO - 'MOZ_NO_REMOTE': '1', 15:51:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:51:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:42 INFO - 'NO_EM_RESTART': '1', 15:51:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:42 INFO - 'PWD': '/builds/slave/test', 15:51:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:51:42 INFO - 'SHELL': '/bin/bash', 15:51:42 INFO - 'SHLVL': '1', 15:51:42 INFO - 'TERM': 'linux', 15:51:42 INFO - 'TMOUT': '86400', 15:51:42 INFO - 'USER': 'cltbld', 15:51:42 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1464648596.87734-1303288114', 15:51:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:42 INFO - '_': '/tools/buildbot/bin/python'} 15:51:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:51:42 INFO - mozversion application_buildid: 20160530120549 15:51:42 INFO - mozversion application_changeset: 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 15:51:42 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:51:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:51:42 INFO - mozversion application_name: Firefox 15:51:42 INFO - mozversion application_remotingname: firefox-dev 15:51:42 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:51:42 INFO - mozversion application_vendor: Mozilla 15:51:42 INFO - mozversion application_version: 48.0a2 15:51:42 INFO - mozversion platform_buildid: 20160530120549 15:51:42 INFO - mozversion platform_changeset: 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 15:51:42 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:51:42 INFO - mozversion platform_version: 48.0a2 15:51:42 INFO - using testdate: 1464648702 15:51:42 INFO - actual date: 1464648702 15:51:42 INFO - starting webserver on 'localhost:41226' 15:51:42 INFO - SUITE-START | Running 2 tests 15:51:42 INFO - TEST-START | dromaeo_css 15:51:42 INFO - operating with platform_type : linux_ 15:51:42 INFO - Initialising browser for dromaeo_css test... 15:51:42 INFO - TEST-INFO | started process 7685 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGC10v4/profile http://localhost:41226/getInfo.html) 15:51:46 INFO - PROCESS | 7685 | __metrics Screen width/height:1600/1200 15:51:46 INFO - PROCESS | 7685 | colorDepth:24 15:51:46 INFO - PROCESS | 7685 | Browser inner width/height: 1024/697 15:51:46 INFO - PROCESS | 7685 | __metrics 15:51:47 ERROR - PROCESS | 7685 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:51:48 INFO - TEST-INFO | 7685: exit 0 15:51:48 INFO - Browser initialized. 15:51:48 INFO - Running cycle 1/1 for dromaeo_css test... 15:51:48 INFO - TEST-INFO | started process 7776 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGC10v4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:51:59 INFO - PROCESS | 7776 | RSS: Main: 142180352 15:51:59 INFO - PROCESS | 7776 | 15:52:50 INFO - PROCESS | 7776 | 1464648770983 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:54:58 INFO - PROCESS | 7776 | Cycle 1(1): loaded http://localhost:41226/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41226/tests/dromaeo/cssquery-ext.html) 15:54:59 INFO - PROCESS | 7776 | RSS: Main: 253374464 15:54:59 INFO - PROCESS | 7776 | 15:58:01 INFO - PROCESS | 7776 | Cycle 1(1): loaded http://localhost:41226/tests/dromaeo/cssquery-ext.html (next: http://localhost:41226/tests/dromaeo/cssquery-jquery.html) 15:58:02 INFO - PROCESS | 7776 | RSS: Main: 220479488 15:58:02 INFO - PROCESS | 7776 | 16:01:04 INFO - PROCESS | 7776 | Cycle 1(1): loaded http://localhost:41226/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41226/tests/dromaeo/cssquery-mootools.html) 16:01:04 INFO - PROCESS | 7776 | RSS: Main: 212770816 16:01:04 INFO - PROCESS | 7776 | 16:04:06 INFO - PROCESS | 7776 | Cycle 1(1): loaded http://localhost:41226/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41226/tests/dromaeo/cssquery-prototype.html) 16:04:07 INFO - PROCESS | 7776 | RSS: Main: 214470656 16:04:07 INFO - PROCESS | 7776 | 16:07:09 INFO - PROCESS | 7776 | Cycle 1(1): loaded http://localhost:41226/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41226/tests/dromaeo/cssquery-yui.html) 16:07:10 INFO - PROCESS | 7776 | RSS: Main: 184242176 16:07:10 INFO - PROCESS | 7776 | 16:10:12 INFO - PROCESS | 7776 | Cycle 1(1): loaded http://localhost:41226/tests/dromaeo/cssquery-yui.html (next: http://localhost:41226/tests/dromaeo/cssquery-dojo.html) 16:10:13 INFO - PROCESS | 7776 | RSS: Main: 234774528 16:10:13 INFO - PROCESS | 7776 | 16:10:13 INFO - PROCESS | 7776 | __start_tp_report 16:10:13 INFO - PROCESS | 7776 | _x_x_mozilla_page_load 16:10:13 INFO - PROCESS | 7776 | _x_x_mozilla_page_load_details 16:10:13 INFO - PROCESS | 7776 | |i|pagename|runs| 16:10:13 INFO - PROCESS | 7776 | |0;dojo.html;3368.1579605098727;3404.5403870477494;3405.795652260864;3426.623071462137;3441.17411821163;5574.972125139374;5593.888122237553;5606.1310496873;5620.57845661576;5627.577931655127;5545.584081193916;5604.327480702311;5608.10270356743;5622.128570071635;5628.0713682242385;4869.732164730956;5079.771410286546;5162.664426812245;5215.504527069941;5248.816291429801;5061.949380506203;5108.565771909392;5113.642045056848;5114.156164232897;5115.10485665009;5001.774920128603;5118.4113826909825;5178.611604129686;5195.038917800219;5197.324347834776;5113.974430127862;5115.10485665009;5118;5118.872028199306;5153.175491921312;4960.181570040939;5010;5012.924806127911;5051.393832740058;5090.669106508065;5428.61999660024;5429.945700542983;5471.671699698031;5471.7264136793;5476.726163691839;5987.251593550806;5993.370696076936;5996.5202783777195;6001.369856165127;6003.429674180946;6031.939680603182;6036.366181550961;6055.512177169498;6084.6336287604545;6107.26712794463;5649.322081350223;5694.174344719992;5695.971520142456;5697.4302569742695;5704.629199102045;6039.214902062704;6203.31763506014;6204.875902482016;6205.689715514206;6206.472449841814;5948.434898684704;6000.759969601254;6006.699665016819;6006.729697163638;6017.759289628366;6061.36355682647;6070.666113363807;6071.544634152457;6072;6082.1789058477425;5854.648721076749;5916.408359164049;6028.698565071729;6032.698365081728;6039.879202416015;5984.850378740479;5994.340622531518;6003.729832157564;6026.819195424145;6043.758249669964;4580.473245576734;4580.541945805393;4581.725096494221;4595.862124136282;4614.10025045113;3987.8205480753436;4066.6136717011836;4069.7354671946227;4114.485689288839;4152.5432202457705;5650.576206784508;5680.602357834994;5695.316562012585;5705.71471426427;5718.485336319751;6006.819795406145;6035.064564992434;6054.878902421927;6060.727267272895;6069.089636554552;5620.100783874642;5703.74333155009;5716.314042314949;5733.885322293614;5803;5178.352705911761;5190.987757387349;5191.870203244949;5191.896162076738;5197.688138711689;6271.560990730696;6273.686315684197;6282.4974002079725;6287.742451509716;6288.654124023131;5916.852078698067;5969.91045134332;5995.550333725076;6023.728932197974;6040.1241819934985;6208.906866396917;6237.500999919905;6239.469645080219;6248.12526246335;6248.500119990299;5841.649501029951;5894.20428242199;5911.970440147772;5913.432835820896;5947.078202878561;6070.1501789750355;6121.757838957599;6126.975740326223;6129.328227221949;6140.631562106288;5868.061110222344;5901.262342207224;5902.675352855634;5905.320888097752;5905.498032667271;5692.800751973661;5771.68255745938;5781.5663825214115;5861.35525092231;5871.324797648325;5830.766769329349;5836.533077353886;5837.445442682938;5838.883222335615;5874.5887787854435;5945;5947.256592925884;5955.40445955401;5958.314793798769;5966.403359663999;5651.265335506522;5771.480566749013;5817.418258174149;5854.385289544536;5868.149118377897 16:10:13 INFO - PROCESS | 7776 | |1;ext.html;662.3608218069564;667.7295695243428;668.8595394967057;674.9358810912964;753.0323534258479;31682;39116;39710.40434393486;39823.80088099563;39889;42470.15059698804;43132.78433607828;43139.78430107853;43169.136617267715;43191.35212971808;7978.441509094366;8625.999999999984;8846.115388461134;10203.693889183336;10389.064984151424;10164.390136591792;10333.948330258376;10346.586136554566;10358.585656573765;10360.222983276246;10381.42902140382;10451.216158788084;10452.372857628567;10454.215933804957;10459.21555883308;8232.17678232178;10311;10445.947770261177;10450.738731531772;10451.268411211218;10362.222833287458;10453.05922466974;10470.214733894989;10472.581096756121;10477.26659133861;40087.39868901969;40879.591204087876;40932;40961.590384096075;40994.38508422376;3716.4982727331735;4130.979345103286;4206.894827629334;4234.957650423518;4319.157764235975;34311.31377372439;34578.13554661129;34674.82662586696;34737.652623473696;35071.64928350735;4537.750423726694;4570.771461426915;4619.838305659286;4665.09030739006;4681.414823147106;313261;314404;316713;317730;318401;40392.596074038884;40991.59008409937;67877.66061169762;68446.65776671085;68547;38448;38551.22897542034;38582.42126368107;38630.22739545193;38672.41991370075;15616.76574851378;15848.44530441429;15977.840221597868;16012.039277643378;16013.839861601467;13921.512747053805;14235.28823558818;14235.572932812032;14239.145651260958;14257.786133207803;9204.079592040876;9329.626814927462;9344.486053267136;9351.158395744416;9428.481433521085;3512.315098555808;3586.3903136466342;3587.820608969541;3623.4927110204594;3694.2980833641523;1082.9079528240031;1135.0805847263744;1189.2032338333338;1201.4053043743404;1252.1860790486076;33617.32765344728;33644.40565682222;33912;33998.83000584981;34598.30803383968;1244.7137158453606;1251.7371352016178;1257.528426839935;1262.8358313419196;1294.6051454306528;17722.379716709853;17795.46613601594;17843.910780446015;17938.730919036225;17969.820301797077;490317;492134;497969;499491;500621;62958.055629165596;63676;63837.680811595645;63890.68054659697;63920.36079639237;1480.4374337751585;1500.0474698566488;1528.7477566201674;1553.6115971007475;1572.7247731646917;30865.382692345578;31866.681333187298;32765.672343276263;32918.177045574055;33076.338473230884;50508.24237636512;50690;51015.744921276644;51026.234606481674;51040;297922;297986;298176;299728;300523;27965.440691186468;31372.843135784176;31390.372192555566;31644;31959.680403196602;44349.77825110854;44888.32667509925;45123.774381127885;45706;45828.77085614551;38397.424038638885;38935;39099.218015640094;41675.7916210417;41954.580454195064;40153.39769903395;40562.594374057066;41636;42079.15841683088;42548.57451425446;42322.36516452317;42895.57104428916;43088.569114308455;43425.13149736924;43592.56407436012;34305.65694343125;36787.264254715294;36909;37824.81087594655;37895.62104378921;28694.52478308617;28922.132336029954;28980.7101928978;29151.416971660874;29256.26859328534 16:10:13 INFO - PROCESS | 7776 | |2;jquery.html;422.16832839306556;431.79273948504715;439.9664314551169;445.0920122949184;454.7158026233604;19194.90402547987;19634.90182549085;19907.203711851525;20387.08258128384;20869.582608347824;19987.300444484445;20321.796782032176;20622.1751129955;20717.171313147457;20763.584728305425;5648.971755141219;5679.829605111853;5822.883542329172;5833.533317334624;5888.617239879394;4270.167317373113;5762.049261871786;5821.010428227211;6096.35988221237;6397.520185986046;6372.267189273247;6384.936150638504;6390.424861762441;6401.519886008545;6403.935960640404;5384.91922621159;5641.802536911229;5646.265985421889;5647.661140331552;6319.684015799192;3958.940615890764;5518.696471694056;5530.751116199781;5650.971745141248;5967.791127310524;14056.508022219276;14107.12054185097;14448.277586120757;14575.19836408997;23576.29271121869;2541.2122242105006;2583.7287084856007;2679;2687.932801679954;3069.239094817731;9985.400875947467;10176;10292.691219263359;10851.728706782314;11619.360935148563;2001.4896201468678;2003.2888324644687;2020.6362854686151;2026.827719643832;2057.6913462980524;75721;76969.23030769677;79017;82590.17409825945;86093.13906860913;11161.162912781574;11208.775824483628;11382.373969431761;11719.296842189497;11775.88224117765;16432.507024789276;16453.670926581402;16548.834511654728;16557.25492352847;16577.83422165787;8330.875036874451;8348.206920342558;8553;8563.100874408223;8627.22354988054;8278.172182781795;8323.334133269445;8598.656053757904;8780.078091800397;8913.331500137516;5211.843644690665;5236;5255.448177941337;5260.736963151827;5277.102892508283;1914.2438736698925;2036.9490762730754;2055.1882006607307;2137.2840098566844;2165.224515896981;1105.9447027648746;1115.6318414923055;1132.5130194016651;1149.7642983188593;1169.345166706647;18679.81320186808;18868.245270189313;18874.716879246822;19862.304819331253;19976.50058748543;1020.3928662445833;1087.190043417659;1101.0530943388678;1102.2614848051824;1163.4648061891455;10098;10301.793964120676;10544.420056896945;10597.788044239072;10793.62222322215;558759;559337;566739;571405;594667;98633.50683246681;98695.50652246692;99410;99689;100110;1158.878317776655;1161.3960740414936;1184.5735535207318;1209.7943349630584;1228.8648248692637;16830.495085147464;16876.746848797033;16921;17021.91489042547;17121.97268163914;39234.60765392309;39568;40337.39493907653;40508.39237411382;40749;61861.69069154806;61895.38104618896;62184.378156217856;62318.376816231255;62716.68641656762;8460.661573536989;8607.956960215159;8738.781530461789;8891.510966896883;8938.284937205139;12913.806292905427;13617.727645446837;13720.588382348546;14189;14388.568342949728;12341.938290308492;12520.686982825502;12618.369081545703;12739.745205096031;12749.553765618159;11984.221025633306;12011;12131.575394861491;12412.56556020571;12755.808662869878;9388.765280868032;12388.318642474751;12459.875401245872;12629.305388203737;12659.303738294482;8881.73354799357;8955.970063442788;9041.50271735061;9056.094390561155;9384.155426011692;9057.365984381293;11478.368689722145;11993.220440671677;12105.515779368727;12544.184627999515 16:10:13 INFO - PROCESS | 7776 | |3;mootools.html;1484.7921291019252;1555.8910876238665;1600.431846694423;1804.702224133018;1888.3107665702023;7750.651220695068;8379.413441059121;8564.486130832154;8573.571321433934;8587.999999999993;8362.372822038342;8511;8548.273396761282;8559.786005349853;8593.742187734362;2138.839587030971;2176.923807666732;2366.4202270443766;2420.189236605739;2462.261321603512;2459.963100553493;2473.4434752180796;2473.530029294437;2475.517274131545;2475.814313926454;2366.2664573982033;2376.92869213923;2403.7115546134487;2454.104251948035;2460.8400453970435;2103.852730308879;2381.4641705616273;2427.5144971005693;2430.744771798962;2443.5235129149823;2376.085207195225;2408.5182963407215;2408.9156879509133;2410.5178964207053;2412.662227288181;8405.831883362298;8470.745877623682;8470.872936905951;8472.49165050099;8478.364122690762;5102.540771330598;5125.461826508237;5236.266922630834;5334.413214546396;5374.032674118657;3539.486774417721;3572.5355703758605;3612.5664920209742;3615.6745892869767;3618.059304580802;1161.2625982501088;1166.4459381793665;1171.742216712322;1181.2440038375446;1183.7336599265182;11867.881321186764;11876.406179691066;11895.464704088337;11897.762044759056;11921.34432606215;4632.675712700078;4681.531846815291;4718;4832.791802049488;4845.781939812717;9982.80034399308;10019.098281154731;10024;10031;10065.094141527297;5341.717987683006;5356.8660783479945;5365.061114304981;5366.2487251784005;5376.946230537645;4350.760708161019;4895.339129217581;4912.975435122801;4980.800767969241;4994;4253.5542063313715;4259.615624921913;4301.440812694393;4336.349547567827;4346.978265108654;1375.559820857336;1383.3429121167364;1391.7634002219647;1393.3103113958452;1406.627243780399;1073.6993641780314;1081.2701426537055;1085.56577369053;1110.6279396402135;1113.4210210690396;6166.537509686702;6265.467435267962;6284.402981716821;6299.811005669837;6370.044493326038;501.4459022779849;505.7976809276319;513.7431284357821;518.189034161536;518.9818356357509;4075.673946084306;4075.7347793055255;4099.631033206966;4150.377443383517;4208.200441916088;10630.149588032938;11006.119510439146;11135.610253641245;11140.888591114148;11186.16103792219;10881.292715973437;10895.400752958663;10898;10901.236913415985;10914.181436392302;8151.470154439942;8253.380996425292;8439.873401898976;8456.661733530713;8458.830823383498;6015.218021657157;6099.695015249308;6117.571769976237;6176.104464852661;6221.471174949999;9539.76150596213;9914.107730304308;9937.552810123418;9973.50132493387;10140.9859014098;10177.185825133824;10178.23663225276;10404.323718958243;10430.739231519272;10488;6942.965285173542;7442.739504117547;7521.623918804147;7787.883181752165;7919.881201782093;8414.6213420395;8437.746867593982;8452.239298463168;8464.407491475538;8504.192101750325;7411.295926886937;7570.583617900848;7574.697012119454;7723.227677232232;7744.1094274159195;7625.885611715939;7751.651175696994;7789.143194248742;7839.41204409683;7851.9214807851195;7230.349268565854;7239.565626062453;7279.381252593589;7288.562686238843;7288.890666640111;5220;5242.266082748494;5348.465153484621;5413.458654134555;5418.701971391453;5319.920201197063;5324.707141107277;5400.513953744182;5509.889802204014;5530.446955304437 16:10:13 INFO - PROCESS | 7776 | |4;prototype.html;343.24999875272533;355.65856777493605;358.7363287983332;359.2061543987787;361.37842910194456;6257.217847769029;6257.937420625793;6287.842803929899;6304.558680892328;6340.334264902188;5969.373215812342;6077.63534187948;6117.143599896007;6160.691965401735;6207.813765587029;4787.473377928425;4809.422869255694;4811.326414302001;4813.879653008667;4830.323754674339;4813.446453657839;4821.915069109457;4834.323194752737;4845.685030473026;4847.1032858921035;4525.660575456837;4651.813927442899;4749.90500189996;4759.238521836507;4786.066716990188;4721.811127554928;4766.904661906777;4776.498467660915;4781.450133234688;4781.832635857746;4191;4204.222218889485;4212.13651201506;4217.051163488221;4218.915621687549;5987.700614969234;6000.459958603703;6001.4298641628975;6016.909746353808;6021.6989150542295;5552.444755524456;5566.248556444869;5567.972160139214;5572.192032155355;5576.442355764391;6454.7095380707515;6587.7694280700425;6598.47212223021;6602.2407423146;6614.7684831031165;4584.931226031612;4603.58567728906;4605.792739326738;4612.746298953556;4614.907701845944;6897.068895699117;6901.827454313632;6903.102596662402;6905.965470172617;6906.585604863674;4699.342092107107;4705.364775755229;4710.317004034396;4711.717296962193;4713.6464765142755;4768.928466073012;4772.141014617333;4774.188387974053;4774.283857421345;4777.665563410528;5362.222477740784;5487.945120548823;5505.614606977553;5508.641938274;5509.586780991442;6638.369354911276;6640.402363787282;6648.800535983832;6652.567583107179;6729.899051514231;1620.23848791068;1649.3567508671629;1668.9248983795758;1690.8562772164257;1697.5756060984754;1108.6784832398514;1141.8515592973026;1145.6505765741529;1146.7362506623356;1153.5558809858264;6310.684465776692;6317.557770956081;6326.114343991845;6329.7151628175925;6404.42360187576;6762.492813039042;6808.829779255559;6818.829529261808;6855.417289530346;6859.7256109756045;6401.103845461639;6417;6419.518536109717;6425.357464253537;6426.74293028283;3654.104744337654;3690.760100593453;3698.1863989922176;3703.79629120401;3705.6479634434686;6901.275366086488;7069.8939515907305;7083.256258092826;7104.538205016657;7105.92894071063;6919.37725604688;6933.237343892168;6941.618210998444;6943.097397338414;6946.340097690711;7036.261192574808;7083.787486375417;7084.689332473509;7090.574565526085;7096.53872498286;6785.287544807724;6807.965960170365;6812.114425124702;6819.965900170468;6820.079289295882;6575;6720.260771315249;6721.529492935448;6731.1922569292;6736.66316684154;7055.400290975324;7073.893891591733;7075.858482830417;7082.220955694973;7099.432045436456;4778.402699662543;4779.139754844162;4787.138315103315;4796.088743138932;4801.975990120167;6657.101291325609;6792.694328755317;6799.286074962256;6808.353206445379;6815.829604259933;6578.671066446563;6687.164104486939;6712.798616041527;6721.22705888829;6732.091167692299;6680.665966701548;6690;6696.966515167393;6720.32796720324;6724;6597.50518711089;6598.505112116514;6601.405873471411;6602.6698665067515;6608.603483790988;6626.503012274003;6786.728530858908;6826.385625293548;6833.180018397824;6835.965820170867;6573.211214654272;6599.96700016516;6602.10871532337;6606.3393660635475;6618.139641846529 16:10:13 INFO - PROCESS | 7776 | |5;yui.html;863.9308855291578;891.6656253904786;897.5646811296521;908.2643059122112;937.3672770879655;14452.710945781091;14813.481528146516;15291.388344466208;15603.375864965416;15689.45086921955;15564.688706225868;15616.531504054896;15660.530184094496;15664.530064098068;15695.21523923805;756.5120497279279;914.4650379527984;919.2645883293372;933.3233405780823;935.5930170375874;926.5876684875233;934.6401635370397;937.6952490440634;939.1547607153582;939.3236869454016;967.5307475874196;971.2133172130597;972.1008067537534;972.3290929258789;972.4068318325816;774.3224678406394;938.8685584018277;957.6313119448993;958.3052287091872;963.7494251494627;698.905647737554;699.0458024796168;699.2797418658739;699.6571679876823;700.0304578159286;15036.699266014728;15109.32008059629;15152.924235378863;15161;15163.393464261417;14418.567442976728;14729.852701472955;14741.115533067943;14753.409863605442;14780.70438591233;12074.758504829942;12231.69420764479;12299.077569182258;12305.876941230563;12469;4035.273650742865;4080;4082.1631565528996;4120.2583534964;4208.852690155861;59897.40102598962;60936.999999999556;61001.08498372528;61019.69490152521;61147;11677.708057298465;11901.464434100486;11910;11940.701482463008;12025.759484810254;21027.15891364359;21045.368638940858;21067.8946605266;21141;21147.47131321729;8778.736637900873;8900.109989001048;8952.597133129026;9007.77480562978;9158.313126515404;4909.116359055404;4919.950800491949;4988.975055124701;5051.898962020812;5089.033083714083;3541.6281290464644;3605.9098522536624;3622.855085796539;3629.419292913174;3642.21692336149;583.0059748129429;707.1478867964091;712.7932899459099;715.1668306422958;742.8811390177545;703.8486725354073;706.4101475268106;774.9806254843561;827.8178800663844;838.1241602525375;10162.39025658448;10213.33613315132;10277.588896444207;10279;10282;737.9815504612428;779.4582764978286;796.8127490039836;798.4211446701212;803.501828866095;4701.78841952113;4962.6774259673;4992.925106123411;5004.174311238678;5021.748912554358;66297.66851165713;68264;68578.65710671415;68610;68713;58574.7071264641;59544.511387215665;60037.099443508385;60213;60721.39278607157;52865.73567132217;52977.47022529726;54082.188767168525;54991.45008549943;56013.439865601635;9483.95258023733;9578.856317155387;9766.46284454362;9796.804063918824;9845.409275443497;36789;37527.24945501129;37917;38177.42733858939;41163.38254926119;46541.76729116333;47237.763811180725;48452.7577362111;48773.512264878314;48989.755051224514;13350.666233344244;13353.732925341244;13436.261005644783;13442.731145376842;13615.591532254048;14139.222342771247;14259.786103208253;14353.92823035878;14743;15102.773458397913;11591.826122608336;13504;13845.100068495516;13996.300184990507;14049.297535122998;12512.37438128108;12889.871101288867;12919.354032298535;13682.657933551343;14317.498887539303;12544.059195560187;12565.40316333932;12931.482740690268;13050.216986980431;13093.083484156017;10982.945085274523;11001.944990274997;11041;11198.88801112011;11652.533898644298;10874.021338079294;11226.158038147334;11312.095032397554;11402.94298528502;11490.597829075943 16:10:13 INFO - PROCESS | 7776 | __end_tp_report 16:10:13 INFO - PROCESS | 7776 | __start_cc_report 16:10:13 INFO - PROCESS | 7776 | _x_x_mozilla_cycle_collect,851 16:10:13 INFO - PROCESS | 7776 | __end_cc_report 16:10:13 INFO - PROCESS | 7776 | __startTimestamp1464649813061__endTimestamp 16:10:13 INFO - PROCESS | 7776 | 16:10:13 INFO - PROCESS | 7776 | ------- Summary: start ------- 16:10:13 INFO - PROCESS | 7776 | Number of tests: 6 16:10:13 INFO - PROCESS | 7776 | 16:10:13 INFO - PROCESS | 7776 | [#0] dojo.html Cycles:165 Average:5595.99 Median:5836.53 stddev:629.09 (10.8%) stddev-sans-first:606.26 16:10:13 INFO - PROCESS | 7776 | Values: 3368.2 3404.5 3405.8 3426.6 3441.2 5575.0 5593.9 5606.1 5620.6 5627.6 5545.6 5604.3 5608.1 5622.1 5628.1 4869.7 5079.8 5162.7 5215.5 5248.8 5061.9 5108.6 5113.6 5114.2 5115.1 5001.8 5118.4 5178.6 5195.0 5197.3 5114.0 5115.1 5118.0 5118.9 5153.2 4960.2 5010.0 5012.9 5051.4 5090.7 5428.6 5429.9 5471.7 5471.7 5476.7 5987.3 5993.4 5996.5 6001.4 6003.4 6031.9 6036.4 6055.5 6084.6 6107.3 5649.3 5694.2 5696.0 5697.4 5704.6 6039.2 6203.3 6204.9 6205.7 6206.5 5948.4 6000.8 6006.7 6006.7 6017.8 6061.4 6070.7 6071.5 6072.0 6082.2 5854.6 5916.4 6028.7 6032.7 6039.9 5984.9 5994.3 6003.7 6026.8 6043.8 4580.5 4580.5 4581.7 4595.9 4614.1 3987.8 4066.6 4069.7 4114.5 4152.5 5650.6 5680.6 5695.3 5705.7 5718.5 6006.8 6035.1 6054.9 6060.7 6069.1 5620.1 5703.7 5716.3 5733.9 5803.0 5178.4 5191.0 5191.9 5191.9 5197.7 6271.6 6273.7 6282.5 6287.7 6288.7 5916.9 5969.9 5995.6 6023.7 6040.1 6208.9 6237.5 6239.5 6248.1 6248.5 5841.6 5894.2 5912.0 5913.4 5947.1 6070.2 6121.8 6127.0 6129.3 6140.6 5868.1 5901.3 5902.7 5905.3 5905.5 5692.8 5771.7 5781.6 5861.4 5871.3 5830.8 5836.5 5837.4 5838.9 5874.6 5945.0 5947.3 5955.4 5958.3 5966.4 5651.3 5771.5 5817.4 5854.4 5868.1 16:10:13 INFO - PROCESS | 7776 | 16:10:13 INFO - PROCESS | 7776 | [#1] ext.html Cycles:180 Average:53751.99 Median:3605.66 stddev:100712.23 (2793.2%) stddev-sans-first:100915.87 16:10:13 INFO - PROCESS | 7776 | Values: 662.4 667.7 668.9 674.9 753.0 31682.0 39116.0 39710.4 39823.8 39889.0 42470.2 43132.8 43139.8 43169.1 43191.4 7978.4 8626.0 8846.1 10203.7 10389.1 10164.4 10333.9 10346.6 10358.6 10360.2 10381.4 10451.2 10452.4 10454.2 10459.2 8232.2 10311.0 10445.9 10450.7 10451.3 10362.2 10453.1 10470.2 10472.6 10477.3 40087.4 40879.6 40932.0 40961.6 40994.4 3716.5 4131.0 4206.9 4235.0 4319.2 34311.3 34578.1 34674.8 34737.7 35071.6 4537.8 4570.8 4619.8 4665.1 4681.4 313261.0 314404.0 316713.0 317730.0 318401.0 40392.6 40991.6 67877.7 68446.7 68547.0 38448.0 38551.2 38582.4 38630.2 38672.4 15616.8 15848.4 15977.8 16012.0 16013.8 13921.5 14235.3 14235.6 14239.1 14257.8 9204.1 9329.6 9344.5 9351.2 9428.5 3512.3 3586.4 3587.8 3623.5 3694.3 1082.9 1135.1 1189.2 1201.4 1252.2 33617.3 33644.4 33912.0 33998.8 34598.3 1244.7 1251.7 1257.5 1262.8 1294.6 17722.4 17795.5 17843.9 17938.7 17969.8 490317.0 492134.0 497969.0 499491.0 500621.0 62958.1 63676.0 63837.7 63890.7 63920.4 1480.4 1500.0 1528.7 1553.6 1572.7 30865.4 31866.7 32765.7 32918.2 33076.3 50508.2 50690.0 51015.7 51026.2 51040.0 297922.0 297986.0 298176.0 299728.0 300523.0 27965.4 31372.8 31390.4 31644.0 31959.7 44349.8 44888.3 45123.8 45706.0 45828.8 38397.4 38935.0 39099.2 41675.8 41954.6 40153.4 40562.6 41636.0 42079.2 42548.6 42322.4 42895.6 43088.6 43425.1 43592.6 34305.7 36787.3 36909.0 37824.8 37895.6 28694.5 28922.1 28980.7 29151.4 29256.3 16:10:13 INFO - PROCESS | 7776 | 16:10:13 INFO - PROCESS | 7776 | [#2] jquery.html Cycles:180 Average:31536.17 Median:2151.25 stddev:93789.51 (4359.8%) stddev-sans-first:94023.51 16:10:13 INFO - PROCESS | 7776 | Values: 422.2 431.8 440.0 445.1 454.7 19194.9 19634.9 19907.2 20387.1 20869.6 19987.3 20321.8 20622.2 20717.2 20763.6 5649.0 5679.8 5822.9 5833.5 5888.6 4270.2 5762.0 5821.0 6096.4 6397.5 6372.3 6384.9 6390.4 6401.5 6403.9 5384.9 5641.8 5646.3 5647.7 6319.7 3958.9 5518.7 5530.8 5651.0 5967.8 14056.5 14107.1 14448.3 14575.2 23576.3 2541.2 2583.7 2679.0 2687.9 3069.2 9985.4 10176.0 10292.7 10851.7 11619.4 2001.5 2003.3 2020.6 2026.8 2057.7 75721.0 76969.2 79017.0 82590.2 86093.1 11161.2 11208.8 11382.4 11719.3 11775.9 16432.5 16453.7 16548.8 16557.3 16577.8 8330.9 8348.2 8553.0 8563.1 8627.2 8278.2 8323.3 8598.7 8780.1 8913.3 5211.8 5236.0 5255.4 5260.7 5277.1 1914.2 2036.9 2055.2 2137.3 2165.2 1105.9 1115.6 1132.5 1149.8 1169.3 18679.8 18868.2 18874.7 19862.3 19976.5 1020.4 1087.2 1101.1 1102.3 1163.5 10098.0 10301.8 10544.4 10597.8 10793.6 558759.0 559337.0 566739.0 571405.0 594667.0 98633.5 98695.5 99410.0 99689.0 100110.0 1158.9 1161.4 1184.6 1209.8 1228.9 16830.5 16876.7 16921.0 17021.9 17122.0 39234.6 39568.0 40337.4 40508.4 40749.0 61861.7 61895.4 62184.4 62318.4 62716.7 8460.7 8608.0 8738.8 8891.5 8938.3 12913.8 13617.7 13720.6 14189.0 14388.6 12341.9 12520.7 12618.4 12739.7 12749.6 11984.2 12011.0 12131.6 12412.6 12755.8 9388.8 12388.3 12459.9 12629.3 12659.3 8881.7 8956.0 9041.5 9056.1 9384.2 9057.4 11478.4 11993.2 12105.5 12544.2 16:10:13 INFO - PROCESS | 7776 | 16:10:13 INFO - PROCESS | 7776 | [#3] mootools.html Cycles:180 Average:5819.65 Median:4870.56 stddev:3225.10 (66.2%) stddev-sans-first:3217.69 16:10:13 INFO - PROCESS | 7776 | Values: 1484.8 1555.9 1600.4 1804.7 1888.3 7750.7 8379.4 8564.5 8573.6 8588.0 8362.4 8511.0 8548.3 8559.8 8593.7 2138.8 2176.9 2366.4 2420.2 2462.3 2460.0 2473.4 2473.5 2475.5 2475.8 2366.3 2376.9 2403.7 2454.1 2460.8 2103.9 2381.5 2427.5 2430.7 2443.5 2376.1 2408.5 2408.9 2410.5 2412.7 8405.8 8470.7 8470.9 8472.5 8478.4 5102.5 5125.5 5236.3 5334.4 5374.0 3539.5 3572.5 3612.6 3615.7 3618.1 1161.3 1166.4 1171.7 1181.2 1183.7 11867.9 11876.4 11895.5 11897.8 11921.3 4632.7 4681.5 4718.0 4832.8 4845.8 9982.8 10019.1 10024.0 10031.0 10065.1 5341.7 5356.9 5365.1 5366.2 5376.9 4350.8 4895.3 4913.0 4980.8 4994.0 4253.6 4259.6 4301.4 4336.3 4347.0 1375.6 1383.3 1391.8 1393.3 1406.6 1073.7 1081.3 1085.6 1110.6 1113.4 6166.5 6265.5 6284.4 6299.8 6370.0 501.4 505.8 513.7 518.2 519.0 4075.7 4075.7 4099.6 4150.4 4208.2 10630.1 11006.1 11135.6 11140.9 11186.2 10881.3 10895.4 10898.0 10901.2 10914.2 8151.5 8253.4 8439.9 8456.7 8458.8 6015.2 6099.7 6117.6 6176.1 6221.5 9539.8 9914.1 9937.6 9973.5 10141.0 10177.2 10178.2 10404.3 10430.7 10488.0 6943.0 7442.7 7521.6 7787.9 7919.9 8414.6 8437.7 8452.2 8464.4 8504.2 7411.3 7570.6 7574.7 7723.2 7744.1 7625.9 7751.7 7789.1 7839.4 7851.9 7230.3 7239.6 7279.4 7288.6 7288.9 5220.0 5242.3 5348.5 5413.5 5418.7 5319.9 5324.7 5400.5 5509.9 5530.4 16:10:13 INFO - PROCESS | 7776 | 16:10:13 INFO - PROCESS | 7776 | [#4] prototype.html Cycles:180 Average:5555.34 Median:6321.84 stddev:1669.62 (26.4%) stddev-sans-first:1627.83 16:10:13 INFO - PROCESS | 7776 | Values: 343.2 355.7 358.7 359.2 361.4 6257.2 6257.9 6287.8 6304.6 6340.3 5969.4 6077.6 6117.1 6160.7 6207.8 4787.5 4809.4 4811.3 4813.9 4830.3 4813.4 4821.9 4834.3 4845.7 4847.1 4525.7 4651.8 4749.9 4759.2 4786.1 4721.8 4766.9 4776.5 4781.5 4781.8 4191.0 4204.2 4212.1 4217.1 4218.9 5987.7 6000.5 6001.4 6016.9 6021.7 5552.4 5566.2 5568.0 5572.2 5576.4 6454.7 6587.8 6598.5 6602.2 6614.8 4584.9 4603.6 4605.8 4612.7 4614.9 6897.1 6901.8 6903.1 6906.0 6906.6 4699.3 4705.4 4710.3 4711.7 4713.6 4768.9 4772.1 4774.2 4774.3 4777.7 5362.2 5487.9 5505.6 5508.6 5509.6 6638.4 6640.4 6648.8 6652.6 6729.9 1620.2 1649.4 1668.9 1690.9 1697.6 1108.7 1141.9 1145.7 1146.7 1153.6 6310.7 6317.6 6326.1 6329.7 6404.4 6762.5 6808.8 6818.8 6855.4 6859.7 6401.1 6417.0 6419.5 6425.4 6426.7 3654.1 3690.8 3698.2 3703.8 3705.6 6901.3 7069.9 7083.3 7104.5 7105.9 6919.4 6933.2 6941.6 6943.1 6946.3 7036.3 7083.8 7084.7 7090.6 7096.5 6785.3 6808.0 6812.1 6820.0 6820.1 6575.0 6720.3 6721.5 6731.2 6736.7 7055.4 7073.9 7075.9 7082.2 7099.4 4778.4 4779.1 4787.1 4796.1 4802.0 6657.1 6792.7 6799.3 6808.4 6815.8 6578.7 6687.2 6712.8 6721.2 6732.1 6680.7 6690.0 6697.0 6720.3 6724.0 6597.5 6598.5 6601.4 6602.7 6608.6 6626.5 6786.7 6826.4 6833.2 6836.0 6573.2 6600.0 6602.1 6606.3 6618.1 16:10:13 INFO - PROCESS | 7776 | 16:10:13 INFO - PROCESS | 7776 | [#5] yui.html Cycles:180 Average:16085.54 Median:25621.78 stddev:18683.53 (72.9%) stddev-sans-first:18700.98 16:10:13 INFO - PROCESS | 7776 | Values: 863.9 891.7 897.6 908.3 937.4 14452.7 14813.5 15291.4 15603.4 15689.5 15564.7 15616.5 15660.5 15664.5 15695.2 756.5 914.5 919.3 933.3 935.6 926.6 934.6 937.7 939.2 939.3 967.5 971.2 972.1 972.3 972.4 774.3 938.9 957.6 958.3 963.7 698.9 699.0 699.3 699.7 700.0 15036.7 15109.3 15152.9 15161.0 15163.4 14418.6 14729.9 14741.1 14753.4 14780.7 12074.8 12231.7 12299.1 12305.9 12469.0 4035.3 4080.0 4082.2 4120.3 4208.9 59897.4 60937.0 61001.1 61019.7 61147.0 11677.7 11901.5 11910.0 11940.7 12025.8 21027.2 21045.4 21067.9 21141.0 21147.5 8778.7 8900.1 8952.6 9007.8 9158.3 4909.1 4920.0 4989.0 5051.9 5089.0 3541.6 3605.9 3622.9 3629.4 3642.2 583.0 707.1 712.8 715.2 742.9 703.8 706.4 775.0 827.8 838.1 10162.4 10213.3 10277.6 10279.0 10282.0 738.0 779.5 796.8 798.4 803.5 4701.8 4962.7 4992.9 5004.2 5021.7 66297.7 68264.0 68578.7 68610.0 68713.0 58574.7 59544.5 60037.1 60213.0 60721.4 52865.7 52977.5 54082.2 54991.5 56013.4 9484.0 9578.9 9766.5 9796.8 9845.4 36789.0 37527.2 37917.0 38177.4 41163.4 46541.8 47237.8 48452.8 48773.5 48989.8 13350.7 13353.7 13436.3 13442.7 13615.6 14139.2 14259.8 14353.9 14743.0 15102.8 11591.8 13504.0 13845.1 13996.3 14049.3 12512.4 12889.9 12919.4 13682.7 14317.5 12544.1 12565.4 12931.5 13050.2 13093.1 10982.9 11001.9 11041.0 11198.9 11652.5 10874.0 11226.2 11312.1 11402.9 11490.6 16:10:13 INFO - PROCESS | 7776 | -------- Summary: end -------- 16:10:13 INFO - PROCESS | 7776 | 16:10:13 INFO - TEST-INFO | 7776: exit 0 16:10:13 INFO - TEST-OK | dromaeo_css | took 1111483ms 16:10:13 INFO - TEST-START | kraken 16:10:13 INFO - operating with platform_type : linux_ 16:10:13 INFO - Initialising browser for kraken test... 16:10:13 INFO - TEST-INFO | started process 7968 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMOzICQ/profile http://localhost:41226/getInfo.html) 16:10:17 INFO - PROCESS | 7968 | __metrics Screen width/height:1600/1200 16:10:17 INFO - PROCESS | 7968 | colorDepth:24 16:10:17 INFO - PROCESS | 7968 | Browser inner width/height: 1024/697 16:10:17 INFO - PROCESS | 7968 | __metrics 16:10:18 ERROR - PROCESS | 7968 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:10:19 INFO - TEST-INFO | 7968: exit 0 16:10:19 INFO - Browser initialized. 16:10:19 INFO - Running cycle 1/1 for kraken test... 16:10:19 INFO - TEST-INFO | started process 8061 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMOzICQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:10:31 INFO - PROCESS | 8061 | RSS: Main: 142118912 16:10:31 INFO - PROCESS | 8061 | 16:10:33 INFO - PROCESS | 8061 | Cycle 1(1): loaded http://localhost:41226/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41226/tests/kraken/driver.html?testName=audio-beat-detection) 16:10:34 INFO - PROCESS | 8061 | RSS: Main: 196845568 16:10:34 INFO - PROCESS | 8061 | 16:10:37 INFO - PROCESS | 8061 | Cycle 1(1): loaded http://localhost:41226/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41226/tests/kraken/driver.html?testName=audio-dft) 16:10:37 INFO - PROCESS | 8061 | RSS: Main: 180842496 16:10:37 INFO - PROCESS | 8061 | 16:10:40 INFO - PROCESS | 8061 | Cycle 1(1): loaded http://localhost:41226/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41226/tests/kraken/driver.html?testName=audio-fft) 16:10:41 INFO - PROCESS | 8061 | RSS: Main: 271773696 16:10:41 INFO - PROCESS | 8061 | 16:10:43 INFO - PROCESS | 8061 | Cycle 1(1): loaded http://localhost:41226/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41226/tests/kraken/driver.html?testName=audio-oscillator) 16:10:43 INFO - PROCESS | 8061 | RSS: Main: 178708480 16:10:43 INFO - PROCESS | 8061 | 16:10:45 INFO - PROCESS | 8061 | Cycle 1(1): loaded http://localhost:41226/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41226/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:10:46 INFO - PROCESS | 8061 | RSS: Main: 176885760 16:10:46 INFO - PROCESS | 8061 | 16:10:49 INFO - PROCESS | 8061 | Cycle 1(1): loaded http://localhost:41226/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41226/tests/kraken/driver.html?testName=imaging-darkroom) 16:10:50 INFO - PROCESS | 8061 | RSS: Main: 210927616 16:10:50 INFO - PROCESS | 8061 | 16:10:53 INFO - PROCESS | 8061 | Cycle 1(1): loaded http://localhost:41226/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41226/tests/kraken/driver.html?testName=imaging-desaturate) 16:10:53 INFO - PROCESS | 8061 | RSS: Main: 212017152 16:10:53 INFO - PROCESS | 8061 | 16:10:56 INFO - PROCESS | 8061 | Cycle 1(1): loaded http://localhost:41226/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41226/tests/kraken/driver.html?testName=json-parse-financial) 16:10:57 INFO - PROCESS | 8061 | RSS: Main: 211894272 16:10:57 INFO - PROCESS | 8061 | 16:10:58 INFO - PROCESS | 8061 | Cycle 1(1): loaded http://localhost:41226/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41226/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:10:59 INFO - PROCESS | 8061 | RSS: Main: 191827968 16:10:59 INFO - PROCESS | 8061 | 16:11:01 INFO - PROCESS | 8061 | Cycle 1(1): loaded http://localhost:41226/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41226/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:11:01 INFO - PROCESS | 8061 | RSS: Main: 194732032 16:11:01 INFO - PROCESS | 8061 | 16:11:03 INFO - PROCESS | 8061 | Cycle 1(1): loaded http://localhost:41226/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41226/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:11:04 INFO - PROCESS | 8061 | RSS: Main: 207835136 16:11:04 INFO - PROCESS | 8061 | 16:11:06 INFO - PROCESS | 8061 | Cycle 1(1): loaded http://localhost:41226/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41226/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:11:07 INFO - PROCESS | 8061 | RSS: Main: 213741568 16:11:07 INFO - PROCESS | 8061 | 16:11:09 INFO - PROCESS | 8061 | Cycle 1(1): loaded http://localhost:41226/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41226/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:11:10 INFO - PROCESS | 8061 | RSS: Main: 209240064 16:11:10 INFO - PROCESS | 8061 | 16:11:12 INFO - PROCESS | 8061 | Cycle 1(1): loaded http://localhost:41226/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41226/tests/kraken/driver.html?testName=ai-astar) 16:11:12 INFO - PROCESS | 8061 | RSS: Main: 273330176 16:11:12 INFO - PROCESS | 8061 | 16:11:12 INFO - PROCESS | 8061 | __start_tp_report 16:11:12 INFO - PROCESS | 8061 | _x_x_mozilla_page_load 16:11:12 INFO - PROCESS | 8061 | _x_x_mozilla_page_load_details 16:11:12 INFO - PROCESS | 8061 | |i|pagename|runs| 16:11:12 INFO - PROCESS | 8061 | |0;ai-astar;110;110;110;109;110;110;106;110;110;110 16:11:12 INFO - PROCESS | 8061 | |1;audio-beat-detection;153;135;155;168;126;157;156;126;175;126 16:11:12 INFO - PROCESS | 8061 | |2;audio-dft;161;162;160;160;162;161;160;160;159;160 16:11:12 INFO - PROCESS | 8061 | |3;audio-fft;76;77;77;168;76;76;73;76;161;76 16:11:12 INFO - PROCESS | 8061 | |4;audio-oscillator;92;92;150;92;93;93;145;91;94;152 16:11:12 INFO - PROCESS | 8061 | |5;imaging-gaussian-blur;116;117;116;117;118;117;117;117;116;117 16:11:12 INFO - PROCESS | 8061 | |6;imaging-darkroom;146;145;145;145;145;145;145;146;145;145 16:11:12 INFO - PROCESS | 8061 | |7;imaging-desaturate;95;94;95;94;94;94;94;94;94;94 16:11:12 INFO - PROCESS | 8061 | |8;json-parse-financial;54;54;54;54;53;54;53;75;51;59 16:11:12 INFO - PROCESS | 8061 | |9;json-stringify-tinderbox;57;57;56;57;57;59;56;58;57;57 16:11:12 INFO - PROCESS | 8061 | |10;stanford-crypto-aes;71;73;71;76;73;73;73;73;73;73 16:11:12 INFO - PROCESS | 8061 | |11;stanford-crypto-ccm;117;113;112;118;115;119;109;115;130;126 16:11:12 INFO - PROCESS | 8061 | |12;stanford-crypto-pbkdf2;159;159;156;159;161;158;159;159;155;163 16:11:12 INFO - PROCESS | 8061 | |13;stanford-crypto-sha256-iterative;66;64;67;64;66;68;65;63;64;64 16:11:12 INFO - PROCESS | 8061 | __end_tp_report 16:11:12 INFO - PROCESS | 8061 | __start_cc_report 16:11:12 INFO - PROCESS | 8061 | _x_x_mozilla_cycle_collect,1579 16:11:12 INFO - PROCESS | 8061 | __end_cc_report 16:11:12 INFO - PROCESS | 8061 | __startTimestamp1464649872471__endTimestamp 16:11:12 INFO - PROCESS | 8061 | 16:11:12 INFO - PROCESS | 8061 | ------- Summary: start ------- 16:11:12 INFO - PROCESS | 8061 | Number of tests: 14 16:11:12 INFO - PROCESS | 8061 | 16:11:12 INFO - PROCESS | 8061 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.00 stddev:1.27 (1.2%) stddev-sans-first:1.33 16:11:12 INFO - PROCESS | 8061 | Values: 110.0 110.0 110.0 109.0 110.0 110.0 106.0 110.0 110.0 110.0 16:11:12 INFO - PROCESS | 8061 | 16:11:12 INFO - PROCESS | 8061 | [#1] audio-beat-detection Cycles:10 Average:147.70 Median:155.50 stddev:18.16 (11.7%) stddev-sans-first:19.16 16:11:12 INFO - PROCESS | 8061 | Values: 153.0 135.0 155.0 168.0 126.0 157.0 156.0 126.0 175.0 126.0 16:11:12 INFO - PROCESS | 8061 | 16:11:12 INFO - PROCESS | 8061 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:0.97 (0.6%) stddev-sans-first:1.01 16:11:12 INFO - PROCESS | 8061 | Values: 161.0 162.0 160.0 160.0 162.0 161.0 160.0 160.0 159.0 160.0 16:11:12 INFO - PROCESS | 8061 | 16:11:12 INFO - PROCESS | 8061 | [#3] audio-fft Cycles:10 Average:93.60 Median:76.00 stddev:37.42 (49.2%) stddev-sans-first:39.14 16:11:12 INFO - PROCESS | 8061 | Values: 76.0 77.0 77.0 168.0 76.0 76.0 73.0 76.0 161.0 76.0 16:11:12 INFO - PROCESS | 8061 | 16:11:12 INFO - PROCESS | 8061 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:92.00 stddev:27.39 (29.8%) stddev-sans-first:28.32 16:11:12 INFO - PROCESS | 8061 | Values: 92.0 92.0 150.0 92.0 93.0 93.0 145.0 91.0 94.0 152.0 16:11:12 INFO - PROCESS | 8061 | 16:11:12 INFO - PROCESS | 8061 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 16:11:12 INFO - PROCESS | 8061 | Values: 116.0 117.0 116.0 117.0 118.0 117.0 117.0 117.0 116.0 117.0 16:11:12 INFO - PROCESS | 8061 | 16:11:12 INFO - PROCESS | 8061 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 16:11:12 INFO - PROCESS | 8061 | Values: 146.0 145.0 145.0 145.0 145.0 145.0 145.0 146.0 145.0 145.0 16:11:12 INFO - PROCESS | 8061 | 16:11:12 INFO - PROCESS | 8061 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 16:11:12 INFO - PROCESS | 8061 | Values: 95.0 94.0 95.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 16:11:12 INFO - PROCESS | 8061 | 16:11:12 INFO - PROCESS | 8061 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:54.00 stddev:6.94 (12.8%) stddev-sans-first:7.31 16:11:12 INFO - PROCESS | 8061 | Values: 54.0 54.0 54.0 54.0 53.0 54.0 53.0 75.0 51.0 59.0 16:11:12 INFO - PROCESS | 8061 | 16:11:12 INFO - PROCESS | 8061 | [#9] json-stringify-tinderbox Cycles:10 Average:57.10 Median:57.00 stddev:0.88 (1.5%) stddev-sans-first:0.93 16:11:12 INFO - PROCESS | 8061 | Values: 57.0 57.0 56.0 57.0 57.0 59.0 56.0 58.0 57.0 57.0 16:11:12 INFO - PROCESS | 8061 | 16:11:12 INFO - PROCESS | 8061 | [#10] stanford-crypto-aes Cycles:10 Average:72.90 Median:73.00 stddev:1.37 (1.9%) stddev-sans-first:1.27 16:11:12 INFO - PROCESS | 8061 | Values: 71.0 73.0 71.0 76.0 73.0 73.0 73.0 73.0 73.0 73.0 16:11:12 INFO - PROCESS | 8061 | 16:11:12 INFO - PROCESS | 8061 | [#11] stanford-crypto-ccm Cycles:10 Average:117.40 Median:117.50 stddev:6.38 (5.4%) stddev-sans-first:6.77 16:11:12 INFO - PROCESS | 8061 | Values: 117.0 113.0 112.0 118.0 115.0 119.0 109.0 115.0 130.0 126.0 16:11:12 INFO - PROCESS | 8061 | 16:11:12 INFO - PROCESS | 8061 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.80 Median:159.00 stddev:2.25 (1.4%) stddev-sans-first:2.39 16:11:12 INFO - PROCESS | 8061 | Values: 159.0 159.0 156.0 159.0 161.0 158.0 159.0 159.0 155.0 163.0 16:11:12 INFO - PROCESS | 8061 | 16:11:12 INFO - PROCESS | 8061 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.50 stddev:1.60 (2.4%) stddev-sans-first:1.66 16:11:12 INFO - PROCESS | 8061 | Values: 66.0 64.0 67.0 64.0 66.0 68.0 65.0 63.0 64.0 64.0 16:11:12 INFO - PROCESS | 8061 | -------- Summary: end -------- 16:11:12 INFO - PROCESS | 8061 | 16:11:13 INFO - TEST-INFO | 8061: exit 0 16:11:13 INFO - TEST-OK | kraken | took 59667ms 16:11:13 INFO - SUITE-END | took 1171s 16:11:13 INFO - Completed test suite (00:19:31) 16:11:13 INFO - javascript benchmark 16:11:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3368.1579605098727, 3404.5403870477494, 3405.795652260864, 3426.623071462137, 3441.17411821163, 5574.972125139374, 5593.888122237553, 5606.1310496873, 5620.57845661576, 5627.577931655127, 5545.584081193916, 5604.327480702311, 5608.10270356743, 5622.128570071635, 5628.0713682242385, 4869.732164730956, 5079.771410286546, 5162.664426812245, 5215.504527069941, 5248.816291429801, 5061.949380506203, 5108.565771909392, 5113.642045056848, 5114.156164232897, 5115.10485665009, 5001.774920128603, 5118.4113826909825, 5178.611604129686, 5195.038917800219, 5197.324347834776, 5113.974430127862, 5115.10485665009, 5118.0, 5118.872028199306, 5153.175491921312, 4960.181570040939, 5010.0, 5012.924806127911, 5051.393832740058, 5090.669106508065, 5428.61999660024, 5429.945700542983, 5471.671699698031, 5471.7264136793, 5476.726163691839, 5987.251593550806, 5993.370696076936, 5996.5202783777195, 6001.369856165127, 6003.429674180946, 6031.939680603182, 6036.366181550961, 6055.512177169498, 6084.6336287604545, 6107.26712794463, 5649.322081350223, 5694.174344719992, 5695.971520142456, 5697.4302569742695, 5704.629199102045, 6039.214902062704, 6203.31763506014, 6204.875902482016, 6205.689715514206, 6206.472449841814, 5948.434898684704, 6000.759969601254, 6006.699665016819, 6006.729697163638, 6017.759289628366, 6061.36355682647, 6070.666113363807, 6071.544634152457, 6072.0, 6082.1789058477425, 5854.648721076749, 5916.408359164049, 6028.698565071729, 6032.698365081728, 6039.879202416015, 5984.850378740479, 5994.340622531518, 6003.729832157564, 6026.819195424145, 6043.758249669964, 4580.473245576734, 4580.541945805393, 4581.725096494221, 4595.862124136282, 4614.10025045113, 3987.8205480753436, 4066.6136717011836, 4069.7354671946227, 4114.485689288839, 4152.5432202457705, 5650.576206784508, 5680.602357834994, 5695.316562012585, 5705.71471426427, 5718.485336319751, 6006.819795406145, 6035.064564992434, 6054.878902421927, 6060.727267272895, 6069.089636554552, 5620.100783874642, 5703.74333155009, 5716.314042314949, 5733.885322293614, 5803.0, 5178.352705911761, 5190.987757387349, 5191.870203244949, 5191.896162076738, 5197.688138711689, 6271.560990730696, 6273.686315684197, 6282.4974002079725, 6287.742451509716, 6288.654124023131, 5916.852078698067, 5969.91045134332, 5995.550333725076, 6023.728932197974, 6040.1241819934985, 6208.906866396917, 6237.500999919905, 6239.469645080219, 6248.12526246335, 6248.500119990299, 5841.649501029951, 5894.20428242199, 5911.970440147772, 5913.432835820896, 5947.078202878561, 6070.1501789750355, 6121.757838957599, 6126.975740326223, 6129.328227221949, 6140.631562106288, 5868.061110222344, 5901.262342207224, 5902.675352855634, 5905.320888097752, 5905.498032667271, 5692.800751973661, 5771.68255745938, 5781.5663825214115, 5861.35525092231, 5871.324797648325, 5830.766769329349, 5836.533077353886, 5837.445442682938, 5838.883222335615, 5874.5887787854435, 5945.0, 5947.256592925884, 5955.40445955401, 5958.314793798769, 5966.403359663999, 5651.265335506522, 5771.480566749013, 5817.418258174149, 5854.385289544536, 5868.149118377897], "value": 5554.818006326466, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [662.3608218069564, 667.7295695243428, 668.8595394967057, 674.9358810912964, 753.0323534258479, 31682.0, 39116.0, 39710.40434393486, 39823.80088099563, 39889.0, 42470.15059698804, 43132.78433607828, 43139.78430107853, 43169.136617267715, 43191.35212971808, 7978.441509094366, 8625.999999999984, 8846.115388461134, 10203.693889183336, 10389.064984151424, 10164.390136591792, 10333.948330258376, 10346.586136554566, 10358.585656573765, 10360.222983276246, 10381.42902140382, 10451.216158788084, 10452.372857628567, 10454.215933804957, 10459.21555883308, 8232.17678232178, 10311.0, 10445.947770261177, 10450.738731531772, 10451.268411211218, 10362.222833287458, 10453.05922466974, 10470.214733894989, 10472.581096756121, 10477.26659133861, 40087.39868901969, 40879.591204087876, 40932.0, 40961.590384096075, 40994.38508422376, 3716.4982727331735, 4130.979345103286, 4206.894827629334, 4234.957650423518, 4319.157764235975, 34311.31377372439, 34578.13554661129, 34674.82662586696, 34737.652623473696, 35071.64928350735, 4537.750423726694, 4570.771461426915, 4619.838305659286, 4665.09030739006, 4681.414823147106, 313261.0, 314404.0, 316713.0, 317730.0, 318401.0, 40392.596074038884, 40991.59008409937, 67877.66061169762, 68446.65776671085, 68547.0, 38448.0, 38551.22897542034, 38582.42126368107, 38630.22739545193, 38672.41991370075, 15616.76574851378, 15848.44530441429, 15977.840221597868, 16012.039277643378, 16013.839861601467, 13921.512747053805, 14235.28823558818, 14235.572932812032, 14239.145651260958, 14257.786133207803, 9204.079592040876, 9329.626814927462, 9344.486053267136, 9351.158395744416, 9428.481433521085, 3512.315098555808, 3586.3903136466342, 3587.820608969541, 3623.4927110204594, 3694.2980833641523, 1082.9079528240031, 1135.0805847263744, 1189.2032338333338, 1201.4053043743404, 1252.1860790486076, 33617.32765344728, 33644.40565682222, 33912.0, 33998.83000584981, 34598.30803383968, 1244.7137158453606, 1251.7371352016178, 1257.528426839935, 1262.8358313419196, 1294.6051454306528, 17722.379716709853, 17795.46613601594, 17843.910780446015, 17938.730919036225, 17969.820301797077, 490317.0, 492134.0, 497969.0, 499491.0, 500621.0, 62958.055629165596, 63676.0, 63837.680811595645, 63890.68054659697, 63920.36079639237, 1480.4374337751585, 1500.0474698566488, 1528.7477566201674, 1553.6115971007475, 1572.7247731646917, 30865.382692345578, 31866.681333187298, 32765.672343276263, 32918.177045574055, 33076.338473230884, 50508.24237636512, 50690.0, 51015.744921276644, 51026.234606481674, 51040.0, 297922.0, 297986.0, 298176.0, 299728.0, 300523.0, 27965.440691186468, 31372.843135784176, 31390.372192555566, 31644.0, 31959.680403196602, 44349.77825110854, 44888.32667509925, 45123.774381127885, 45706.0, 45828.77085614551, 38397.424038638885, 38935.0, 39099.218015640094, 41675.7916210417, 41954.580454195064, 40153.39769903395, 40562.594374057066, 41636.0, 42079.15841683088, 42548.57451425446, 42322.36516452317, 42895.57104428916, 43088.569114308455, 43425.13149736924, 43592.56407436012, 34305.65694343125, 36787.264254715294, 36909.0, 37824.81087594655, 37895.62104378921, 28694.52478308617, 28922.132336029954, 28980.7101928978, 29151.416971660874, 29256.26859328534], "value": 19662.52727064351, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.16832839306556, 431.79273948504715, 439.9664314551169, 445.0920122949184, 454.7158026233604, 19194.90402547987, 19634.90182549085, 19907.203711851525, 20387.08258128384, 20869.582608347824, 19987.300444484445, 20321.796782032176, 20622.1751129955, 20717.171313147457, 20763.584728305425, 5648.971755141219, 5679.829605111853, 5822.883542329172, 5833.533317334624, 5888.617239879394, 4270.167317373113, 5762.049261871786, 5821.010428227211, 6096.35988221237, 6397.520185986046, 6372.267189273247, 6384.936150638504, 6390.424861762441, 6401.519886008545, 6403.935960640404, 5384.91922621159, 5641.802536911229, 5646.265985421889, 5647.661140331552, 6319.684015799192, 3958.940615890764, 5518.696471694056, 5530.751116199781, 5650.971745141248, 5967.791127310524, 14056.508022219276, 14107.12054185097, 14448.277586120757, 14575.19836408997, 23576.29271121869, 2541.2122242105006, 2583.7287084856007, 2679.0, 2687.932801679954, 3069.239094817731, 9985.400875947467, 10176.0, 10292.691219263359, 10851.728706782314, 11619.360935148563, 2001.4896201468678, 2003.2888324644687, 2020.6362854686151, 2026.827719643832, 2057.6913462980524, 75721.0, 76969.23030769677, 79017.0, 82590.17409825945, 86093.13906860913, 11161.162912781574, 11208.775824483628, 11382.373969431761, 11719.296842189497, 11775.88224117765, 16432.507024789276, 16453.670926581402, 16548.834511654728, 16557.25492352847, 16577.83422165787, 8330.875036874451, 8348.206920342558, 8553.0, 8563.100874408223, 8627.22354988054, 8278.172182781795, 8323.334133269445, 8598.656053757904, 8780.078091800397, 8913.331500137516, 5211.843644690665, 5236.0, 5255.448177941337, 5260.736963151827, 5277.102892508283, 1914.2438736698925, 2036.9490762730754, 2055.1882006607307, 2137.2840098566844, 2165.224515896981, 1105.9447027648746, 1115.6318414923055, 1132.5130194016651, 1149.7642983188593, 1169.345166706647, 18679.81320186808, 18868.245270189313, 18874.716879246822, 19862.304819331253, 19976.50058748543, 1020.3928662445833, 1087.190043417659, 1101.0530943388678, 1102.2614848051824, 1163.4648061891455, 10098.0, 10301.793964120676, 10544.420056896945, 10597.788044239072, 10793.62222322215, 558759.0, 559337.0, 566739.0, 571405.0, 594667.0, 98633.50683246681, 98695.50652246692, 99410.0, 99689.0, 100110.0, 1158.878317776655, 1161.3960740414936, 1184.5735535207318, 1209.7943349630584, 1228.8648248692637, 16830.495085147464, 16876.746848797033, 16921.0, 17021.91489042547, 17121.97268163914, 39234.60765392309, 39568.0, 40337.39493907653, 40508.39237411382, 40749.0, 61861.69069154806, 61895.38104618896, 62184.378156217856, 62318.376816231255, 62716.68641656762, 8460.661573536989, 8607.956960215159, 8738.781530461789, 8891.510966896883, 8938.284937205139, 12913.806292905427, 13617.727645446837, 13720.588382348546, 14189.0, 14388.568342949728, 12341.938290308492, 12520.686982825502, 12618.369081545703, 12739.745205096031, 12749.553765618159, 11984.221025633306, 12011.0, 12131.575394861491, 12412.56556020571, 12755.808662869878, 9388.765280868032, 12388.318642474751, 12459.875401245872, 12629.305388203737, 12659.303738294482, 8881.73354799357, 8955.970063442788, 9041.50271735061, 9056.094390561155, 9384.155426011692, 9057.365984381293, 11478.368689722145, 11993.220440671677, 12105.515779368727, 12544.184627999515], "value": 9575.906294906328, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1484.7921291019252, 1555.8910876238665, 1600.431846694423, 1804.702224133018, 1888.3107665702023, 7750.651220695068, 8379.413441059121, 8564.486130832154, 8573.571321433934, 8587.999999999993, 8362.372822038342, 8511.0, 8548.273396761282, 8559.786005349853, 8593.742187734362, 2138.839587030971, 2176.923807666732, 2366.4202270443766, 2420.189236605739, 2462.261321603512, 2459.963100553493, 2473.4434752180796, 2473.530029294437, 2475.517274131545, 2475.814313926454, 2366.2664573982033, 2376.92869213923, 2403.7115546134487, 2454.104251948035, 2460.8400453970435, 2103.852730308879, 2381.4641705616273, 2427.5144971005693, 2430.744771798962, 2443.5235129149823, 2376.085207195225, 2408.5182963407215, 2408.9156879509133, 2410.5178964207053, 2412.662227288181, 8405.831883362298, 8470.745877623682, 8470.872936905951, 8472.49165050099, 8478.364122690762, 5102.540771330598, 5125.461826508237, 5236.266922630834, 5334.413214546396, 5374.032674118657, 3539.486774417721, 3572.5355703758605, 3612.5664920209742, 3615.6745892869767, 3618.059304580802, 1161.2625982501088, 1166.4459381793665, 1171.742216712322, 1181.2440038375446, 1183.7336599265182, 11867.881321186764, 11876.406179691066, 11895.464704088337, 11897.762044759056, 11921.34432606215, 4632.675712700078, 4681.531846815291, 4718.0, 4832.791802049488, 4845.781939812717, 9982.80034399308, 10019.098281154731, 10024.0, 10031.0, 10065.094141527297, 5341.717987683006, 5356.8660783479945, 5365.061114304981, 5366.2487251784005, 5376.946230537645, 4350.760708161019, 4895.339129217581, 4912.975435122801, 4980.800767969241, 4994.0, 4253.5542063313715, 4259.615624921913, 4301.440812694393, 4336.349547567827, 4346.978265108654, 1375.559820857336, 1383.3429121167364, 1391.7634002219647, 1393.3103113958452, 1406.627243780399, 1073.6993641780314, 1081.2701426537055, 1085.56577369053, 1110.6279396402135, 1113.4210210690396, 6166.537509686702, 6265.467435267962, 6284.402981716821, 6299.811005669837, 6370.044493326038, 501.4459022779849, 505.7976809276319, 513.7431284357821, 518.189034161536, 518.9818356357509, 4075.673946084306, 4075.7347793055255, 4099.631033206966, 4150.377443383517, 4208.200441916088, 10630.149588032938, 11006.119510439146, 11135.610253641245, 11140.888591114148, 11186.16103792219, 10881.292715973437, 10895.400752958663, 10898.0, 10901.236913415985, 10914.181436392302, 8151.470154439942, 8253.380996425292, 8439.873401898976, 8456.661733530713, 8458.830823383498, 6015.218021657157, 6099.695015249308, 6117.571769976237, 6176.104464852661, 6221.471174949999, 9539.76150596213, 9914.107730304308, 9937.552810123418, 9973.50132493387, 10140.9859014098, 10177.185825133824, 10178.23663225276, 10404.323718958243, 10430.739231519272, 10488.0, 6942.965285173542, 7442.739504117547, 7521.623918804147, 7787.883181752165, 7919.881201782093, 8414.6213420395, 8437.746867593982, 8452.239298463168, 8464.407491475538, 8504.192101750325, 7411.295926886937, 7570.583617900848, 7574.697012119454, 7723.227677232232, 7744.1094274159195, 7625.885611715939, 7751.651175696994, 7789.143194248742, 7839.41204409683, 7851.9214807851195, 7230.349268565854, 7239.565626062453, 7279.381252593589, 7288.562686238843, 7288.890666640111, 5220.0, 5242.266082748494, 5348.465153484621, 5413.458654134555, 5418.701971391453, 5319.920201197063, 5324.707141107277, 5400.513953744182, 5509.889802204014, 5530.446955304437], "value": 4652.670395920091, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.24999875272533, 355.65856777493605, 358.7363287983332, 359.2061543987787, 361.37842910194456, 6257.217847769029, 6257.937420625793, 6287.842803929899, 6304.558680892328, 6340.334264902188, 5969.373215812342, 6077.63534187948, 6117.143599896007, 6160.691965401735, 6207.813765587029, 4787.473377928425, 4809.422869255694, 4811.326414302001, 4813.879653008667, 4830.323754674339, 4813.446453657839, 4821.915069109457, 4834.323194752737, 4845.685030473026, 4847.1032858921035, 4525.660575456837, 4651.813927442899, 4749.90500189996, 4759.238521836507, 4786.066716990188, 4721.811127554928, 4766.904661906777, 4776.498467660915, 4781.450133234688, 4781.832635857746, 4191.0, 4204.222218889485, 4212.13651201506, 4217.051163488221, 4218.915621687549, 5987.700614969234, 6000.459958603703, 6001.4298641628975, 6016.909746353808, 6021.6989150542295, 5552.444755524456, 5566.248556444869, 5567.972160139214, 5572.192032155355, 5576.442355764391, 6454.7095380707515, 6587.7694280700425, 6598.47212223021, 6602.2407423146, 6614.7684831031165, 4584.931226031612, 4603.58567728906, 4605.792739326738, 4612.746298953556, 4614.907701845944, 6897.068895699117, 6901.827454313632, 6903.102596662402, 6905.965470172617, 6906.585604863674, 4699.342092107107, 4705.364775755229, 4710.317004034396, 4711.717296962193, 4713.6464765142755, 4768.928466073012, 4772.141014617333, 4774.188387974053, 4774.283857421345, 4777.665563410528, 5362.222477740784, 5487.945120548823, 5505.614606977553, 5508.641938274, 5509.586780991442, 6638.369354911276, 6640.402363787282, 6648.800535983832, 6652.567583107179, 6729.899051514231, 1620.23848791068, 1649.3567508671629, 1668.9248983795758, 1690.8562772164257, 1697.5756060984754, 1108.6784832398514, 1141.8515592973026, 1145.6505765741529, 1146.7362506623356, 1153.5558809858264, 6310.684465776692, 6317.557770956081, 6326.114343991845, 6329.7151628175925, 6404.42360187576, 6762.492813039042, 6808.829779255559, 6818.829529261808, 6855.417289530346, 6859.7256109756045, 6401.103845461639, 6417.0, 6419.518536109717, 6425.357464253537, 6426.74293028283, 3654.104744337654, 3690.760100593453, 3698.1863989922176, 3703.79629120401, 3705.6479634434686, 6901.275366086488, 7069.8939515907305, 7083.256258092826, 7104.538205016657, 7105.92894071063, 6919.37725604688, 6933.237343892168, 6941.618210998444, 6943.097397338414, 6946.340097690711, 7036.261192574808, 7083.787486375417, 7084.689332473509, 7090.574565526085, 7096.53872498286, 6785.287544807724, 6807.965960170365, 6812.114425124702, 6819.965900170468, 6820.079289295882, 6575.0, 6720.260771315249, 6721.529492935448, 6731.1922569292, 6736.66316684154, 7055.400290975324, 7073.893891591733, 7075.858482830417, 7082.220955694973, 7099.432045436456, 4778.402699662543, 4779.139754844162, 4787.138315103315, 4796.088743138932, 4801.975990120167, 6657.101291325609, 6792.694328755317, 6799.286074962256, 6808.353206445379, 6815.829604259933, 6578.671066446563, 6687.164104486939, 6712.798616041527, 6721.22705888829, 6732.091167692299, 6680.665966701548, 6690.0, 6696.966515167393, 6720.32796720324, 6724.0, 6597.50518711089, 6598.505112116514, 6601.405873471411, 6602.6698665067515, 6608.603483790988, 6626.503012274003, 6786.728530858908, 6826.385625293548, 6833.180018397824, 6835.965820170867, 6573.211214654272, 6599.96700016516, 6602.10871532337, 6606.3393660635475, 6618.139641846529], "value": 5013.269617145345, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [863.9308855291578, 891.6656253904786, 897.5646811296521, 908.2643059122112, 937.3672770879655, 14452.710945781091, 14813.481528146516, 15291.388344466208, 15603.375864965416, 15689.45086921955, 15564.688706225868, 15616.531504054896, 15660.530184094496, 15664.530064098068, 15695.21523923805, 756.5120497279279, 914.4650379527984, 919.2645883293372, 933.3233405780823, 935.5930170375874, 926.5876684875233, 934.6401635370397, 937.6952490440634, 939.1547607153582, 939.3236869454016, 967.5307475874196, 971.2133172130597, 972.1008067537534, 972.3290929258789, 972.4068318325816, 774.3224678406394, 938.8685584018277, 957.6313119448993, 958.3052287091872, 963.7494251494627, 698.905647737554, 699.0458024796168, 699.2797418658739, 699.6571679876823, 700.0304578159286, 15036.699266014728, 15109.32008059629, 15152.924235378863, 15161.0, 15163.393464261417, 14418.567442976728, 14729.852701472955, 14741.115533067943, 14753.409863605442, 14780.70438591233, 12074.758504829942, 12231.69420764479, 12299.077569182258, 12305.876941230563, 12469.0, 4035.273650742865, 4080.0, 4082.1631565528996, 4120.2583534964, 4208.852690155861, 59897.40102598962, 60936.999999999556, 61001.08498372528, 61019.69490152521, 61147.0, 11677.708057298465, 11901.464434100486, 11910.0, 11940.701482463008, 12025.759484810254, 21027.15891364359, 21045.368638940858, 21067.8946605266, 21141.0, 21147.47131321729, 8778.736637900873, 8900.109989001048, 8952.597133129026, 9007.77480562978, 9158.313126515404, 4909.116359055404, 4919.950800491949, 4988.975055124701, 5051.898962020812, 5089.033083714083, 3541.6281290464644, 3605.9098522536624, 3622.855085796539, 3629.419292913174, 3642.21692336149, 583.0059748129429, 707.1478867964091, 712.7932899459099, 715.1668306422958, 742.8811390177545, 703.8486725354073, 706.4101475268106, 774.9806254843561, 827.8178800663844, 838.1241602525375, 10162.39025658448, 10213.33613315132, 10277.588896444207, 10279.0, 10282.0, 737.9815504612428, 779.4582764978286, 796.8127490039836, 798.4211446701212, 803.501828866095, 4701.78841952113, 4962.6774259673, 4992.925106123411, 5004.174311238678, 5021.748912554358, 66297.66851165713, 68264.0, 68578.65710671415, 68610.0, 68713.0, 58574.7071264641, 59544.511387215665, 60037.099443508385, 60213.0, 60721.39278607157, 52865.73567132217, 52977.47022529726, 54082.188767168525, 54991.45008549943, 56013.439865601635, 9483.95258023733, 9578.856317155387, 9766.46284454362, 9796.804063918824, 9845.409275443497, 36789.0, 37527.24945501129, 37917.0, 38177.42733858939, 41163.38254926119, 46541.76729116333, 47237.763811180725, 48452.7577362111, 48773.512264878314, 48989.755051224514, 13350.666233344244, 13353.732925341244, 13436.261005644783, 13442.731145376842, 13615.591532254048, 14139.222342771247, 14259.786103208253, 14353.92823035878, 14743.0, 15102.773458397913, 11591.826122608336, 13504.0, 13845.100068495516, 13996.300184990507, 14049.297535122998, 12512.37438128108, 12889.871101288867, 12919.354032298535, 13682.657933551343, 14317.498887539303, 12544.059195560187, 12565.40316333932, 12931.482740690268, 13050.216986980431, 13093.083484156017, 10982.945085274523, 11001.944990274997, 11041.0, 11198.88801112011, 11652.533898644298, 10874.021338079294, 11226.158038147334, 11312.095032397554, 11402.94298528502, 11490.597829075943], "value": 7336.326134897245, "unit": "score"}], "name": "dromaeo_css", "value": 7507.087062486561, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 106.0, 110.0, 110.0, 110.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 135.0, 155.0, 168.0, 126.0, 157.0, 156.0, 126.0, 175.0, 126.0], "value": 147.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 160.0, 162.0, 161.0, 160.0, 160.0, 159.0, 160.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 168.0, 76.0, 76.0, 73.0, 76.0, 161.0, 76.0], "value": 93.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 150.0, 92.0, 93.0, 93.0, 145.0, 91.0, 94.0, 152.0], "value": 109.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 118.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 53.0, 54.0, 53.0, 75.0, 51.0, 59.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 56.0, 57.0, 57.0, 59.0, 56.0, 58.0, 57.0, 57.0], "value": 57.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 73.0, 71.0, 76.0, 73.0, 73.0, 73.0, 73.0, 73.0, 73.0], "value": 72.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 113.0, 112.0, 118.0, 115.0, 119.0, 109.0, 115.0, 130.0, 126.0], "value": 117.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 156.0, 159.0, 161.0, 158.0, 159.0, 159.0, 155.0, 163.0], "value": 158.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 67.0, 64.0, 66.0, 68.0, 65.0, 63.0, 64.0, 64.0], "value": 65.1, "unit": "score"}], "name": "kraken", "value": 1504.2999999999997, "alertThreshold": 2.0}]} 16:11:13 INFO - Return code: 0 16:11:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:11:13 ERROR - # TBPL SUCCESS # 16:11:13 INFO - Running post-action listener: _resource_record_post_action 16:11:13 INFO - Running post-run listener: _resource_record_post_run 16:11:14 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 510750720; Read time: 16; Write time: 516944 16:11:14 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 259137536; Read time: 0; Write time: 315212 16:11:14 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 251015168; Read time: 16; Write time: 201732 16:11:14 INFO - Running post-run listener: _upload_blobber_files 16:11:14 INFO - Blob upload gear active. 16:11:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:11: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 16:11: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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:11: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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:11:15 INFO - (blobuploader) - INFO - Open directory for files ... 16:11:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:11:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:11:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:15 INFO - (blobuploader) - INFO - Done attempting. 16:11:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:11:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:11:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:16 INFO - (blobuploader) - INFO - Done attempting. 16:11:16 INFO - (blobuploader) - INFO - Iteration through files over. 16:11:16 INFO - Return code: 0 16:11:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:11:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:11:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/93c36afb8b3aac698741da721854b26cb2bdb924328fe51f0417044679f476f91260eb3cc267baf6a0d9413657f1e313f32e0b1a968671eb36501242689c7098", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ac46c5f3907371f948b41d2edeafd9c78019bf2f3cd49f0e4c2ad5420975ef00bcc0eef504c530ff67f446add482adadf302c53a6dc6e8f2c74ea9343ca593aa"} 16:11:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:11:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:11:16 INFO - Contents: 16:11:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/93c36afb8b3aac698741da721854b26cb2bdb924328fe51f0417044679f476f91260eb3cc267baf6a0d9413657f1e313f32e0b1a968671eb36501242689c7098", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ac46c5f3907371f948b41d2edeafd9c78019bf2f3cd49f0e4c2ad5420975ef00bcc0eef504c530ff67f446add482adadf302c53a6dc6e8f2c74ea9343ca593aa"} 16:11:16 INFO - Running post-run listener: copy_logs_to_upload_dir 16:11:16 INFO - Copying logs to upload dir... 16:11:16 INFO - mkdir: /builds/slave/test/build/upload/logs 16:11:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.021054 ========= master_lag: 0.20 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-05-30 16:11:16.703011) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 16:11:16.710873) ========= 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=c6927cf182745ad25b1d38b9000001fe-1464648596.87734-1303288114 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/93c36afb8b3aac698741da721854b26cb2bdb924328fe51f0417044679f476f91260eb3cc267baf6a0d9413657f1e313f32e0b1a968671eb36501242689c7098", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ac46c5f3907371f948b41d2edeafd9c78019bf2f3cd49f0e4c2ad5420975ef00bcc0eef504c530ff67f446add482adadf302c53a6dc6e8f2c74ea9343ca593aa"} build_url:https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011282 build_url: 'https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/93c36afb8b3aac698741da721854b26cb2bdb924328fe51f0417044679f476f91260eb3cc267baf6a0d9413657f1e313f32e0b1a968671eb36501242689c7098", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ac46c5f3907371f948b41d2edeafd9c78019bf2f3cd49f0e4c2ad5420975ef00bcc0eef504c530ff67f446add482adadf302c53a6dc6e8f2c74ea9343ca593aa"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 16:11:16.739086) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:11:16.739416) ========= 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=c6927cf182745ad25b1d38b9000001fe-1464648596.87734-1303288114 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004698 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:11:16.788234) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 16:11:16.791586) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 16:11:16.791887) ========= ========= Total master_lag: 0.35 =========