builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-017 starttime: 1464339438.7 results: success (0) buildid: 20160526231045 builduid: f205f9222a3b4fb79c1695d436806960 revision: 9cbc4f2d34a30255c3a093f6005f87b453491a7a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 01:57:18.697564) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 01:57:18.708324) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 01:57:18.708654) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 01:57:18.725212) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 01:57:18.725513) ========= 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=0333a256a5e4f052382dd180000001b1-1464337381.517840-1276900034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-27 01:57:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-05-27 01:57:19 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131357 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 01:57:18.872288) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 01:57:18.872604) ========= 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=0333a256a5e4f052382dd180000001b1-1464337381.517840-1276900034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021889 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 01:57:18.922290) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 01:57:18.922630) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9cbc4f2d34a30255c3a093f6005f87b453491a7a --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 9cbc4f2d34a30255c3a093f6005f87b453491a7a --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=0333a256a5e4f052382dd180000001b1-1464337381.517840-1276900034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-27 01:57:19,119 truncating revision to first 12 chars 2016-05-27 01:57:19,119 Setting DEBUG logging. 2016-05-27 01:57:19,119 attempt 1/10 2016-05-27 01:57:19,119 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9cbc4f2d34a3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-27 01:57:19,426 unpacking tar archive at: mozilla-aurora-9cbc4f2d34a3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.631983 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 01:57:19.570373) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 01:57:19.570685) ========= script_repo_revision: 9cbc4f2d34a30255c3a093f6005f87b453491a7a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 01:57:19.571046) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 01:57:19.571323) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 01:57:19.582153) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-27 01:57:19.582435) ========= /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=0333a256a5e4f052382dd180000001b1-1464337381.517840-1276900034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:57:19 INFO - MultiFileLogger online at 20160527 01:57:19 in /builds/slave/test 01:57:19 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 01:57:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:57:19 INFO - {'append_to_log': False, 01:57:19 INFO - 'base_work_dir': '/builds/slave/test', 01:57:19 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 01:57:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:57:19 INFO - 'branch': 'Mozilla-Aurora', 01:57:19 INFO - 'buildbot_json_path': 'buildprops.json', 01:57:19 INFO - 'config_files': ('talos/linux_config.py',), 01:57:19 INFO - 'default_actions': ('clobber', 01:57:19 INFO - 'read-buildbot-config', 01:57:19 INFO - 'download-and-extract', 01:57:19 INFO - 'populate-webroot', 01:57:19 INFO - 'create-virtualenv', 01:57:19 INFO - 'install', 01:57:19 INFO - 'run-tests'), 01:57:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:57:19 INFO - 'download_minidump_stackwalk': True, 01:57:19 INFO - 'download_symbols': 'ondemand', 01:57:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:57:19 INFO - 'tooltool.py': '/tools/tooltool.py', 01:57:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:57:19 INFO - '/tools/misc-python/virtualenv.py')}, 01:57:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:57:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:57:19 INFO - 'installer_path': 'installer.exe', 01:57:19 INFO - 'log_level': 'info', 01:57:19 INFO - 'log_name': 'talos', 01:57:19 INFO - 'log_to_console': True, 01:57:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:57:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:57:19 INFO - 'opt_config_files': (), 01:57:19 INFO - 'pip_index': False, 01:57:19 INFO - 'sps_profile': False, 01:57:19 INFO - 'sps_profile_interval': 0, 01:57:19 INFO - 'suite': 'dromaeojs', 01:57:19 INFO - 'system_bits': '32', 01:57:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:57:19 INFO - 'title': 'talos-linux64-ix-017', 01:57:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:57:19 INFO - 'use_talos_json': True, 01:57:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:57:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:57:19 INFO - 'work_dir': 'build'} 01:57:19 INFO - ##### 01:57:19 INFO - ##### Running clobber step. 01:57:19 INFO - ##### 01:57:19 INFO - Running pre-action listener: _resource_record_pre_action 01:57:19 INFO - Running main action method: clobber 01:57:19 INFO - rmtree: /builds/slave/test/build 01:57:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:57:20 INFO - Running post-action listener: _resource_record_post_action 01:57:20 INFO - ##### 01:57:20 INFO - ##### Running read-buildbot-config step. 01:57:20 INFO - ##### 01:57:20 INFO - Running pre-action listener: _resource_record_pre_action 01:57:20 INFO - Running main action method: read_buildbot_config 01:57:20 INFO - Using buildbot properties: 01:57:20 INFO - { 01:57:20 INFO - "project": "", 01:57:20 INFO - "product": "firefox", 01:57:20 INFO - "script_repo_revision": "production", 01:57:20 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 01:57:20 INFO - "repository": "", 01:57:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 01:57:20 INFO - "buildid": "20160526231045", 01:57:20 INFO - "pgo_build": "True", 01:57:20 INFO - "basedir": "/builds/slave/test", 01:57:20 INFO - "buildnumber": 259, 01:57:20 INFO - "slavename": "talos-linux64-ix-017", 01:57:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:57:20 INFO - "platform": "ubuntu64_hw", 01:57:20 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 01:57:20 INFO - "branch": "mozilla-aurora", 01:57:20 INFO - "repo_path": "releases/mozilla-aurora", 01:57:20 INFO - "revision": "9cbc4f2d34a30255c3a093f6005f87b453491a7a", 01:57:20 INFO - "stage_platform": "linux64-pgo", 01:57:20 INFO - "builduid": "f205f9222a3b4fb79c1695d436806960", 01:57:20 INFO - "slavebuilddir": "test" 01:57:20 INFO - } 01:57:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 01:57:20 INFO - Running post-action listener: _resource_record_post_action 01:57:20 INFO - ##### 01:57:20 INFO - ##### Running download-and-extract step. 01:57:20 INFO - ##### 01:57:20 INFO - Running pre-action listener: _resource_record_pre_action 01:57:20 INFO - Running main action method: download_and_extract 01:57:20 INFO - mkdir: /builds/slave/test/build/tests 01:57:20 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')]} 01:57:20 INFO - https://queue.taskcluster.net/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:57:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 01:57:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 01:57:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeshrcsVRlKBAzVvOt_Bjw/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 01:57:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeshrcsVRlKBAzVvOt_Bjw/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 01:57:27 INFO - Downloaded 1361 bytes. 01:57:27 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 01:57:27 INFO - Using the following test package requirements: 01:57:27 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 01:57:27 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 01:57:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 01:57:27 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 01:57:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 01:57:27 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 01:57:27 INFO - u'jsshell-linux-x86_64.zip'], 01:57:27 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 01:57:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 01:57:27 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 01:57:27 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 01:57:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 01:57:27 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 01:57:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 01:57:27 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 01:57:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 01:57:27 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 01:57:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 01:57:27 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:57:27 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')]} 01:57:27 INFO - https://queue.taskcluster.net/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:57:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 01:57:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 01:57:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeshrcsVRlKBAzVvOt_Bjw/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 01:57:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeshrcsVRlKBAzVvOt_Bjw/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 01:57:28 INFO - Downloaded 24136564 bytes. 01:57:28 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'] 01:57:28 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 01:57:29 INFO - Return code: 0 01:57:29 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 01:57:29 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')]} 01:57:29 INFO - https://queue.taskcluster.net/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:57:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 01:57:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 01:57:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeshrcsVRlKBAzVvOt_Bjw/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 01:57:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeshrcsVRlKBAzVvOt_Bjw/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 01:57:31 INFO - Downloaded 24136564 bytes. 01:57:31 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'] 01:57:31 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 01:57:33 INFO - Return code: 0 01:57:33 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')]} 01:57:33 INFO - https://queue.taskcluster.net/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:57:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 01:57:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 01:57:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeshrcsVRlKBAzVvOt_Bjw/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 01:57:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeshrcsVRlKBAzVvOt_Bjw/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 01:57:34 INFO - Downloaded 10840145 bytes. 01:57:34 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'] 01:57:34 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 01:57:35 INFO - Return code: 0 01:57:35 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')]} 01:57:35 INFO - https://queue.taskcluster.net/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:57:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 01:57:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 01:57:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeshrcsVRlKBAzVvOt_Bjw/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 01:57:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeshrcsVRlKBAzVvOt_Bjw/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 01:57:40 INFO - Downloaded 62771461 bytes. 01:57:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 01:57:40 INFO - mkdir: /builds/slave/test/properties 01:57:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:57:40 INFO - Writing to file /builds/slave/test/properties/build_url 01:57:40 INFO - Contents: 01:57:40 INFO - build_url:https://queue.taskcluster.net/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 01:57:40 INFO - Running post-action listener: _resource_record_post_action 01:57:40 INFO - Running post-action listener: set_extra_try_arguments 01:57:40 INFO - ##### 01:57:40 INFO - ##### Running populate-webroot step. 01:57:40 INFO - ##### 01:57:40 INFO - Running pre-action listener: _resource_record_pre_action 01:57:40 INFO - Running main action method: populate_webroot 01:57:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:57:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:57:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:57:40 INFO - '--tppagecycles', 01:57:40 INFO - '7'], 01:57:40 INFO - 'tests': ['tsvgm']}}, 01:57:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:57:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:57:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:57:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:57:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:57:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:57:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:40 INFO - 'talos_options': ['--disable-e10s'], 01:57:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:57:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:57:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:40 INFO - 'talos_options': ['--disable-e10s'], 01:57:40 INFO - 'tests': ['damp', 'tps']}, 01:57:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:40 INFO - 'tests': ['damp', 'tps']}, 01:57:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:57:40 INFO - 'tests': ['dromaeo_dom']}, 01:57:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:57:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:57:40 INFO - 'tests': ['a11yr', 01:57:40 INFO - 'ts_paint', 01:57:40 INFO - 'tpaint', 01:57:40 INFO - 'sessionrestore', 01:57:40 INFO - 'sessionrestore_no_auto_restore', 01:57:40 INFO - 'tabpaint']}, 01:57:40 INFO - 'other-e10s': {'tests': ['a11yr', 01:57:40 INFO - 'ts_paint', 01:57:40 INFO - 'tpaint', 01:57:40 INFO - 'sessionrestore', 01:57:40 INFO - 'sessionrestore_no_auto_restore', 01:57:40 INFO - 'tabpaint']}, 01:57:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:57:40 INFO - 'ts_paint', 01:57:40 INFO - 'tpaint', 01:57:40 INFO - 'sessionrestore', 01:57:40 INFO - 'sessionrestore_no_auto_restore', 01:57:40 INFO - 'tabpaint']}, 01:57:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:57:40 INFO - 'ts_paint', 01:57:40 INFO - 'tpaint', 01:57:40 INFO - 'sessionrestore', 01:57:40 INFO - 'sessionrestore_no_auto_restore', 01:57:40 INFO - 'tabpaint']}, 01:57:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:57:40 INFO - 'tests': ['a11yr', 01:57:40 INFO - 'ts_paint', 01:57:40 INFO - 'tpaint', 01:57:40 INFO - 'sessionrestore', 01:57:40 INFO - 'sessionrestore_no_auto_restore', 01:57:40 INFO - 'tabpaint']}, 01:57:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:57:40 INFO - 'tests': ['a11yr', 01:57:40 INFO - 'ts_paint', 01:57:40 INFO - 'tpaint', 01:57:40 INFO - 'sessionrestore', 01:57:40 INFO - 'sessionrestore_no_auto_restore', 01:57:40 INFO - 'tabpaint']}, 01:57:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:57:40 INFO - 'tests': ['tsvgx', 01:57:40 INFO - 'tsvgr_opacity', 01:57:40 INFO - 'tart', 01:57:40 INFO - 'tscrollx', 01:57:40 INFO - 'cart']}, 01:57:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:57:40 INFO - 'tsvgr_opacity', 01:57:40 INFO - 'tart', 01:57:40 INFO - 'tscrollx', 01:57:40 INFO - 'cart']}, 01:57:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:40 INFO - 'talos_options': ['--disable-e10s'], 01:57:40 INFO - 'tests': ['tp5o']}, 01:57:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:40 INFO - 'tests': ['tp5o']}, 01:57:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:40 INFO - 'talos_options': ['--disable-e10s', 01:57:40 INFO - '--xperf_path', 01:57:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:57:40 INFO - 'tests': ['tp5n']}, 01:57:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:40 INFO - 'talos_options': ['--xperf_path', 01:57:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:57:40 INFO - 'tests': ['tp5n']}}, 01:57:40 INFO - 'talos.zip': {'path': '', 01:57:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:57:40 INFO - Running post-action listener: _resource_record_post_action 01:57:40 INFO - ##### 01:57:40 INFO - ##### Running create-virtualenv step. 01:57:40 INFO - ##### 01:57:40 INFO - Running pre-action listener: _resource_record_pre_action 01:57:40 INFO - Running main action method: create_virtualenv 01:57:40 INFO - Creating virtualenv /builds/slave/test/build/venv 01:57:40 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 01:57:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:57:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:57:41 INFO - Using real prefix '/usr' 01:57:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:57:41 INFO - Installing distribute.............................................................................................................................................................................................done. 01:57:43 INFO - Installing pip.................done. 01:57:43 INFO - Return code: 0 01:57:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:57:43 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')]} 01:57:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:57:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:43 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')]} 01:57:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:57:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:43 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 0x7f9bb4105f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a77410>, '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 0x1a78310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a787a0>, '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': '0333a256a5e4f052382dd180000001b1-1464337381.517840-1276900034', '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 01:57:43 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 01:57:43 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 01:57:43 INFO - Using env: {'DISPLAY': ':0', 01:57:43 INFO - 'HOME': '/home/cltbld', 01:57:43 INFO - 'LANG': 'en_US.UTF-8', 01:57:43 INFO - 'LANGUAGE': 'en_US:en', 01:57:43 INFO - 'LOGNAME': 'cltbld', 01:57:43 INFO - 'MAIL': '/var/mail/cltbld', 01:57:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:43 INFO - 'MOZ_NO_REMOTE': '1', 01:57:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:57:43 INFO - 'NO_EM_RESTART': '1', 01:57:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:57:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:57:43 INFO - 'PWD': '/builds/slave/test', 01:57:43 INFO - 'SHELL': '/bin/bash', 01:57:43 INFO - 'SHLVL': '1', 01:57:43 INFO - 'TERM': 'linux', 01:57:43 INFO - 'TMOUT': '86400', 01:57:43 INFO - 'USER': 'cltbld', 01:57:43 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464337381.517840-1276900034', 01:57:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:43 INFO - '_': '/tools/buildbot/bin/python'} 01:57:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:57:43 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 01:57:43 INFO - Cleaning up... 01:57:43 INFO - Return code: 0 01:57:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:57:43 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')]} 01:57:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:57:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:43 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')]} 01:57:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:57:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:43 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 0x7f9bb4105f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a77410>, '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 0x1a78310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a787a0>, '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': '0333a256a5e4f052382dd180000001b1-1464337381.517840-1276900034', '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 01:57:43 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 01:57:43 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 01:57:43 INFO - Using env: {'DISPLAY': ':0', 01:57:43 INFO - 'HOME': '/home/cltbld', 01:57:43 INFO - 'LANG': 'en_US.UTF-8', 01:57:43 INFO - 'LANGUAGE': 'en_US:en', 01:57:43 INFO - 'LOGNAME': 'cltbld', 01:57:43 INFO - 'MAIL': '/var/mail/cltbld', 01:57:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:43 INFO - 'MOZ_NO_REMOTE': '1', 01:57:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:57:43 INFO - 'NO_EM_RESTART': '1', 01:57:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:57:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:57:43 INFO - 'PWD': '/builds/slave/test', 01:57:43 INFO - 'SHELL': '/bin/bash', 01:57:43 INFO - 'SHLVL': '1', 01:57:43 INFO - 'TERM': 'linux', 01:57:43 INFO - 'TMOUT': '86400', 01:57:43 INFO - 'USER': 'cltbld', 01:57:43 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464337381.517840-1276900034', 01:57:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:43 INFO - '_': '/tools/buildbot/bin/python'} 01:57:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:57:43 INFO - Downloading/unpacking psutil>=0.7.1 01:57:43 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 01:57:43 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 01:57:43 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 01:57:43 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 01:57:43 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 01:57:43 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 01:57:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:57:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:57:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:57:46 INFO - Installing collected packages: psutil 01:57:46 INFO - Running setup.py install for psutil 01:57:46 INFO - building 'psutil._psutil_linux' extension 01:57:46 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 01:57:46 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 01:57:46 INFO - building 'psutil._psutil_posix' extension 01:57:46 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 01:57:46 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 01:57:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:57:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:57:46 INFO - Successfully installed psutil 01:57:46 INFO - Cleaning up... 01:57:46 INFO - Return code: 0 01:57:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:57:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:57:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:57:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:57:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:57:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9bb4105f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a77410>, '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 0x1a78310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a787a0>, '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': '0333a256a5e4f052382dd180000001b1-1464337381.517840-1276900034', '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 01:57:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 01:57:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 01:57:46 INFO - Using env: {'DISPLAY': ':0', 01:57:46 INFO - 'HOME': '/home/cltbld', 01:57:46 INFO - 'LANG': 'en_US.UTF-8', 01:57:46 INFO - 'LANGUAGE': 'en_US:en', 01:57:46 INFO - 'LOGNAME': 'cltbld', 01:57:46 INFO - 'MAIL': '/var/mail/cltbld', 01:57:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:46 INFO - 'MOZ_NO_REMOTE': '1', 01:57:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:57:46 INFO - 'NO_EM_RESTART': '1', 01:57:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:57:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:57:46 INFO - 'PWD': '/builds/slave/test', 01:57:46 INFO - 'SHELL': '/bin/bash', 01:57:46 INFO - 'SHLVL': '1', 01:57:46 INFO - 'TERM': 'linux', 01:57:46 INFO - 'TMOUT': '86400', 01:57:46 INFO - 'USER': 'cltbld', 01:57:46 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464337381.517840-1276900034', 01:57:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:46 INFO - '_': '/tools/buildbot/bin/python'} 01:57:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:57:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:57:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:57:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:57:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:57:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:57:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:57:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:57:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:57:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:57:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:57:48 INFO - Installing collected packages: mozsystemmonitor 01:57:48 INFO - Running setup.py install for mozsystemmonitor 01:57:48 INFO - Successfully installed mozsystemmonitor 01:57:48 INFO - Cleaning up... 01:57:48 INFO - Return code: 0 01:57:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:57:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:57:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:57:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:57:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9bb4105f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a77410>, '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 0x1a78310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a787a0>, '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': '0333a256a5e4f052382dd180000001b1-1464337381.517840-1276900034', '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 01:57:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:57:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:57:48 INFO - Using env: {'DISPLAY': ':0', 01:57:48 INFO - 'HOME': '/home/cltbld', 01:57:48 INFO - 'LANG': 'en_US.UTF-8', 01:57:48 INFO - 'LANGUAGE': 'en_US:en', 01:57:48 INFO - 'LOGNAME': 'cltbld', 01:57:48 INFO - 'MAIL': '/var/mail/cltbld', 01:57:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:48 INFO - 'MOZ_NO_REMOTE': '1', 01:57:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:57:48 INFO - 'NO_EM_RESTART': '1', 01:57:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:57:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:57:48 INFO - 'PWD': '/builds/slave/test', 01:57:48 INFO - 'SHELL': '/bin/bash', 01:57:48 INFO - 'SHLVL': '1', 01:57:48 INFO - 'TERM': 'linux', 01:57:48 INFO - 'TMOUT': '86400', 01:57:48 INFO - 'USER': 'cltbld', 01:57:48 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464337381.517840-1276900034', 01:57:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:48 INFO - '_': '/tools/buildbot/bin/python'} 01:57:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:57:49 INFO - Downloading/unpacking blobuploader==1.2.4 01:57:49 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 01:57:49 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 01:57:49 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 01:57:49 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 01:57:49 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 01:57:49 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 01:57:50 INFO - Downloading blobuploader-1.2.4.tar.gz 01:57:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:57:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:57:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:57:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:57:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:57:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:57:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:57:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:57:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:57:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:57:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:57:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:57:51 INFO - Downloading docopt-0.6.1.tar.gz 01:57:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:57:51 INFO - Installing collected packages: blobuploader, requests, docopt 01:57:51 INFO - Running setup.py install for blobuploader 01:57:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:57:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:57:51 INFO - Running setup.py install for requests 01:57:52 INFO - Running setup.py install for docopt 01:57:52 INFO - Successfully installed blobuploader requests docopt 01:57:52 INFO - Cleaning up... 01:57:52 INFO - Return code: 0 01:57:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:57:52 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')]} 01:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:57:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:52 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')]} 01:57:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:57:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:52 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 0x7f9bb4105f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a77410>, '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 0x1a78310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a787a0>, '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': '0333a256a5e4f052382dd180000001b1-1464337381.517840-1276900034', '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 01:57:52 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 01:57:52 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 01:57:52 INFO - Using env: {'DISPLAY': ':0', 01:57:52 INFO - 'HOME': '/home/cltbld', 01:57:52 INFO - 'LANG': 'en_US.UTF-8', 01:57:52 INFO - 'LANGUAGE': 'en_US:en', 01:57:52 INFO - 'LOGNAME': 'cltbld', 01:57:52 INFO - 'MAIL': '/var/mail/cltbld', 01:57:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:52 INFO - 'MOZ_NO_REMOTE': '1', 01:57:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:57:52 INFO - 'NO_EM_RESTART': '1', 01:57:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:57:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:57:52 INFO - 'PWD': '/builds/slave/test', 01:57:52 INFO - 'SHELL': '/bin/bash', 01:57:52 INFO - 'SHLVL': '1', 01:57:52 INFO - 'TERM': 'linux', 01:57:52 INFO - 'TMOUT': '86400', 01:57:52 INFO - 'USER': 'cltbld', 01:57:52 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464337381.517840-1276900034', 01:57:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:52 INFO - '_': '/tools/buildbot/bin/python'} 01:57:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:57:52 INFO - Running setup.py (path:/tmp/pip-Vp3AKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:57:52 INFO - Running setup.py (path:/tmp/pip-maMV8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:57:52 INFO - Running setup.py (path:/tmp/pip-TXQcXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:57:52 INFO - Running setup.py (path:/tmp/pip-mCF5Wj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:57:52 INFO - Running setup.py (path:/tmp/pip-mAZQ6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:57:52 INFO - Running setup.py (path:/tmp/pip-3Am7CH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:57:53 INFO - Running setup.py (path:/tmp/pip-t0C_Wa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:57:53 INFO - Running setup.py (path:/tmp/pip-f40MWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:57:53 INFO - Running setup.py (path:/tmp/pip-qQPTBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:57:53 INFO - Running setup.py (path:/tmp/pip-6UZ9XJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:57:53 INFO - Running setup.py (path:/tmp/pip-UA6hII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:57:53 INFO - Running setup.py (path:/tmp/pip-RS4Rfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:57:53 INFO - Running setup.py (path:/tmp/pip-arpyQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:57:53 INFO - Running setup.py (path:/tmp/pip-3FY7bD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:57:53 INFO - Running setup.py (path:/tmp/pip-vRrMnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:57:53 INFO - Running setup.py (path:/tmp/pip-bPtoSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:57:53 INFO - Running setup.py (path:/tmp/pip-sgOVVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:57:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:57:53 INFO - Running setup.py install for manifestparser 01:57:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:57:53 INFO - Running setup.py install for mozcrash 01:57:53 INFO - Running setup.py install for mozdebug 01:57:54 INFO - Running setup.py install for mozdevice 01:57:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:57:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:57:54 INFO - Running setup.py install for mozfile 01:57:54 INFO - Running setup.py install for mozhttpd 01:57:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:57:54 INFO - Running setup.py install for mozinfo 01:57:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:57:54 INFO - Running setup.py install for mozInstall 01:57:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:57:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:57:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:57:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:57:54 INFO - Running setup.py install for mozleak 01:57:54 INFO - Running setup.py install for mozlog 01:57:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:57:54 INFO - Running setup.py install for moznetwork 01:57:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:57:54 INFO - Running setup.py install for mozprocess 01:57:54 INFO - Running setup.py install for mozprofile 01:57:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:57:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:57:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:57:55 INFO - Running setup.py install for mozrunner 01:57:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:57:55 INFO - Running setup.py install for mozscreenshot 01:57:55 INFO - Running setup.py install for moztest 01:57:55 INFO - Running setup.py install for mozversion 01:57:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:57:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:57:55 INFO - Cleaning up... 01:57:55 INFO - Return code: 0 01:57:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:57:55 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')]} 01:57:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:57:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:55 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')]} 01:57:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:57:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:55 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 0x7f9bb4105f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a77410>, '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 0x1a78310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a787a0>, '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': '0333a256a5e4f052382dd180000001b1-1464337381.517840-1276900034', '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 01:57:55 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 01:57:55 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 01:57:55 INFO - Using env: {'DISPLAY': ':0', 01:57:55 INFO - 'HOME': '/home/cltbld', 01:57:55 INFO - 'LANG': 'en_US.UTF-8', 01:57:55 INFO - 'LANGUAGE': 'en_US:en', 01:57:55 INFO - 'LOGNAME': 'cltbld', 01:57:55 INFO - 'MAIL': '/var/mail/cltbld', 01:57:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:55 INFO - 'MOZ_NO_REMOTE': '1', 01:57:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:57:55 INFO - 'NO_EM_RESTART': '1', 01:57:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:57:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:57:55 INFO - 'PWD': '/builds/slave/test', 01:57:55 INFO - 'SHELL': '/bin/bash', 01:57:55 INFO - 'SHLVL': '1', 01:57:55 INFO - 'TERM': 'linux', 01:57:55 INFO - 'TMOUT': '86400', 01:57:55 INFO - 'USER': 'cltbld', 01:57:55 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464337381.517840-1276900034', 01:57:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:55 INFO - '_': '/tools/buildbot/bin/python'} 01:57:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:57:55 INFO - Running setup.py (path:/tmp/pip-JrMViV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:57:55 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)) 01:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:57:55 INFO - Running setup.py (path:/tmp/pip-SGKAbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:57:55 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)) 01:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:57:55 INFO - Running setup.py (path:/tmp/pip-GmdW64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:57:55 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)) 01:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:57:55 INFO - Running setup.py (path:/tmp/pip-V1bjiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:57:56 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)) 01:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:57:56 INFO - Running setup.py (path:/tmp/pip-FoqJOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:57:56 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)) 01:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:57:56 INFO - Running setup.py (path:/tmp/pip-82e0eh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:57:56 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)) 01:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:57:56 INFO - Running setup.py (path:/tmp/pip-jAzeex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:57:56 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)) 01:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:57:56 INFO - Running setup.py (path:/tmp/pip-TXGzqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:57:56 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)) 01:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:57:56 INFO - Running setup.py (path:/tmp/pip-f5G004-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:57:56 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)) 01:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:57:56 INFO - Running setup.py (path:/tmp/pip-bVhtFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:57:56 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)) 01:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:57:56 INFO - Running setup.py (path:/tmp/pip-BaNA3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:57:56 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)) 01:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:57:56 INFO - Running setup.py (path:/tmp/pip-BCBJfJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:57:56 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)) 01:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:57:56 INFO - Running setup.py (path:/tmp/pip-mL8m6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:57:56 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)) 01:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:57:56 INFO - Running setup.py (path:/tmp/pip-tT2pvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:57:56 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)) 01:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:57:56 INFO - Running setup.py (path:/tmp/pip-LckZ3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:57:56 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)) 01:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:57:56 INFO - Running setup.py (path:/tmp/pip-low9Qv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:57:56 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)) 01:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:57:56 INFO - Running setup.py (path:/tmp/pip-qclfhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:57:56 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)) 01:57:56 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)) 01:57:56 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)) 01:57:56 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)) 01:57:56 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)) 01:57:56 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)) 01:57:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:57:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:57:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:57:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:57:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:57:58 INFO - Downloading blessings-1.6.tar.gz 01:57:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:57:58 INFO - Installing collected packages: blessings 01:57:58 INFO - Running setup.py install for blessings 01:57:59 INFO - Successfully installed blessings 01:57:59 INFO - Cleaning up... 01:57:59 INFO - Return code: 0 01:57:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:57:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:57:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:57:59 INFO - Reading from file tmpfile_stdout 01:57:59 INFO - Current package versions: 01:57:59 INFO - argparse == 1.2.1 01:57:59 INFO - blessings == 1.6 01:57:59 INFO - blobuploader == 1.2.4 01:57:59 INFO - docopt == 0.6.1 01:57:59 INFO - manifestparser == 1.1 01:57:59 INFO - mozInstall == 1.12 01:57:59 INFO - mozcrash == 0.17 01:57:59 INFO - mozdebug == 0.1 01:57:59 INFO - mozdevice == 0.48 01:57:59 INFO - mozfile == 1.2 01:57:59 INFO - mozhttpd == 0.7 01:57:59 INFO - mozinfo == 0.9 01:57:59 INFO - mozleak == 0.1 01:57:59 INFO - mozlog == 3.1 01:57:59 INFO - moznetwork == 0.27 01:57:59 INFO - mozprocess == 0.22 01:57:59 INFO - mozprofile == 0.28 01:57:59 INFO - mozrunner == 6.11 01:57:59 INFO - mozscreenshot == 0.1 01:57:59 INFO - mozsystemmonitor == 0.0 01:57:59 INFO - moztest == 0.7 01:57:59 INFO - mozversion == 1.4 01:57:59 INFO - psutil == 3.1.1 01:57:59 INFO - requests == 1.2.3 01:57:59 INFO - wsgiref == 0.1.2 01:57:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:57:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:57:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:57:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:57:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:57:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:59 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 0x7f9bb4105f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a77410>, '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 0x1a78310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a787a0>, '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': '0333a256a5e4f052382dd180000001b1-1464337381.517840-1276900034', '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 01:57:59 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 01:57:59 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 01:57:59 INFO - Using env: {'DISPLAY': ':0', 01:57:59 INFO - 'HOME': '/home/cltbld', 01:57:59 INFO - 'LANG': 'en_US.UTF-8', 01:57:59 INFO - 'LANGUAGE': 'en_US:en', 01:57:59 INFO - 'LOGNAME': 'cltbld', 01:57:59 INFO - 'MAIL': '/var/mail/cltbld', 01:57:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:59 INFO - 'MOZ_NO_REMOTE': '1', 01:57:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:57:59 INFO - 'NO_EM_RESTART': '1', 01:57:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:57:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:57:59 INFO - 'PWD': '/builds/slave/test', 01:57:59 INFO - 'SHELL': '/bin/bash', 01:57:59 INFO - 'SHLVL': '1', 01:57:59 INFO - 'TERM': 'linux', 01:57:59 INFO - 'TMOUT': '86400', 01:57:59 INFO - 'USER': 'cltbld', 01:57:59 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464337381.517840-1276900034', 01:57:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:59 INFO - '_': '/tools/buildbot/bin/python'} 01:57:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:57:59 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)) 01:57:59 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)) 01:57:59 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)) 01:57:59 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)) 01:57:59 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)) 01:57:59 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)) 01:57:59 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)) 01:57:59 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)) 01:57:59 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)) 01:57:59 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)) 01:57:59 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)) 01:57:59 INFO - Cleaning up... 01:57:59 INFO - Return code: 0 01:57:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:57:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:57:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:57:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:57:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:57:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bb4105f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a77410>, '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 0x1a78310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a787a0>, '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': '0333a256a5e4f052382dd180000001b1-1464337381.517840-1276900034', '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 01:57:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:57:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:57:59 INFO - Using env: {'DISPLAY': ':0', 01:57:59 INFO - 'HOME': '/home/cltbld', 01:57:59 INFO - 'LANG': 'en_US.UTF-8', 01:57:59 INFO - 'LANGUAGE': 'en_US:en', 01:57:59 INFO - 'LOGNAME': 'cltbld', 01:57:59 INFO - 'MAIL': '/var/mail/cltbld', 01:57:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:59 INFO - 'MOZ_NO_REMOTE': '1', 01:57:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:57:59 INFO - 'NO_EM_RESTART': '1', 01:57:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:57:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:57:59 INFO - 'PWD': '/builds/slave/test', 01:57:59 INFO - 'SHELL': '/bin/bash', 01:57:59 INFO - 'SHLVL': '1', 01:57:59 INFO - 'TERM': 'linux', 01:57:59 INFO - 'TMOUT': '86400', 01:57:59 INFO - 'USER': 'cltbld', 01:57:59 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464337381.517840-1276900034', 01:57:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:59 INFO - '_': '/tools/buildbot/bin/python'} 01:57:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:57:59 INFO - Downloading/unpacking jsonschema 01:57:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:57:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:57:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:57:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:57:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:57:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:58:01 INFO - Downloading/unpacking functools32 (from jsonschema) 01:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:02 INFO - Downloading functools32-3.2.3-2.tar.gz 01:58:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:58:02 INFO - warning: no files found matching '*.txt' 01:58:02 INFO - no previously-included directories found matching 'build' 01:58:02 INFO - no previously-included directories found matching 'dist' 01:58:02 INFO - no previously-included directories found matching '.git*' 01:58:02 INFO - Installing collected packages: jsonschema, functools32 01:58:02 INFO - Running setup.py install for functools32 01:58:02 INFO - warning: no files found matching '*.txt' 01:58:02 INFO - no previously-included directories found matching 'build' 01:58:02 INFO - no previously-included directories found matching 'dist' 01:58:02 INFO - no previously-included directories found matching '.git*' 01:58:02 INFO - Successfully installed jsonschema functools32 01:58:02 INFO - Cleaning up... 01:58:02 INFO - Return code: 0 01:58:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:58:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:58:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:58:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bb4105f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a77410>, '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 0x1a78310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a787a0>, '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': '0333a256a5e4f052382dd180000001b1-1464337381.517840-1276900034', '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 01:58:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 01:58:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:58:02 INFO - Using env: {'DISPLAY': ':0', 01:58:02 INFO - 'HOME': '/home/cltbld', 01:58:02 INFO - 'LANG': 'en_US.UTF-8', 01:58:02 INFO - 'LANGUAGE': 'en_US:en', 01:58:02 INFO - 'LOGNAME': 'cltbld', 01:58:02 INFO - 'MAIL': '/var/mail/cltbld', 01:58:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:02 INFO - 'MOZ_NO_REMOTE': '1', 01:58:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:02 INFO - 'NO_EM_RESTART': '1', 01:58:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:02 INFO - 'PWD': '/builds/slave/test', 01:58:02 INFO - 'SHELL': '/bin/bash', 01:58:02 INFO - 'SHLVL': '1', 01:58:02 INFO - 'TERM': 'linux', 01:58:02 INFO - 'TMOUT': '86400', 01:58:02 INFO - 'USER': 'cltbld', 01:58:02 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464337381.517840-1276900034', 01:58:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:02 INFO - '_': '/tools/buildbot/bin/python'} 01:58:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:02 INFO - Downloading/unpacking flake8 01:58:02 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 01:58:02 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 01:58:02 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 01:58:02 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 01:58:02 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 01:58:02 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 01:58:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:58:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:58:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:58:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:58:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:58:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:58:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:58:05 INFO - no previously-included directories found matching 'docs/_build' 01:58:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:58:05 INFO - Running setup.py install for pep8 01:58:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:58:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:58:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:58:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:58:05 INFO - no previously-included directories found matching 'docs/_build' 01:58:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:58:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:58:05 INFO - Cleaning up... 01:58:05 INFO - Return code: 0 01:58:05 INFO - Running post-action listener: _resource_record_post_action 01:58:05 INFO - Running post-action listener: _start_resource_monitoring 01:58:05 INFO - Starting resource monitoring. 01:58:05 INFO - ##### 01:58:05 INFO - ##### Running install step. 01:58:05 INFO - ##### 01:58:05 INFO - Running pre-action listener: _resource_record_pre_action 01:58:05 INFO - Running main action method: install 01:58:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:58:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:58:05 INFO - Reading from file tmpfile_stdout 01:58:05 INFO - Detecting whether we're running mozinstall >=1.0... 01:58:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:58:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:58:05 INFO - Reading from file tmpfile_stdout 01:58:05 INFO - Output received: 01:58:05 INFO - Usage: mozinstall [options] installer 01:58:05 INFO - Options: 01:58:05 INFO - -h, --help show this help message and exit 01:58:05 INFO - -d DEST, --destination=DEST 01:58:05 INFO - Directory to install application into. [default: 01:58:05 INFO - "/builds/slave/test"] 01:58:05 INFO - --app=APP Application being installed. [default: firefox] 01:58:05 INFO - mkdir: /builds/slave/test/build/application 01:58:05 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'] 01:58:05 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 01:58:21 INFO - Reading from file tmpfile_stdout 01:58:21 INFO - Output received: 01:58:21 INFO - /builds/slave/test/build/application/firefox/firefox 01:58:21 INFO - Running post-action listener: _resource_record_post_action 01:58:21 INFO - ##### 01:58:21 INFO - ##### Running run-tests step. 01:58:21 INFO - ##### 01:58:21 INFO - Running pre-action listener: _resource_record_pre_action 01:58:21 INFO - Running main action method: run_tests 01:58:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:58:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:58:21 INFO - Python 2.7.3 01:58:21 INFO - Return code: 0 01:58:21 INFO - grabbing minidump binary from tooltool 01:58:21 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')]} 01:58:21 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 0x1a77410>, '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 0x1a78310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a787a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:58:21 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 01:58:21 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 01:58:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:58:21 INFO - Return code: 0 01:58:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:58:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:58:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:58:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:58:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:58:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:58:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:58:22 INFO - Return code: 0 01:58:22 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/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 01:58:22 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/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 01:58:22 INFO - Using env: {'DISPLAY': ':0', 01:58:22 INFO - 'HOME': '/home/cltbld', 01:58:22 INFO - 'LANG': 'en_US.UTF-8', 01:58:22 INFO - 'LANGUAGE': 'en_US:en', 01:58:22 INFO - 'LOGNAME': 'cltbld', 01:58:22 INFO - 'MAIL': '/var/mail/cltbld', 01:58:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:58:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:58:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:22 INFO - 'MOZ_NO_REMOTE': '1', 01:58:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:58:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:22 INFO - 'NO_EM_RESTART': '1', 01:58:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:22 INFO - 'PWD': '/builds/slave/test', 01:58:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:58:22 INFO - 'SHELL': '/bin/bash', 01:58:22 INFO - 'SHLVL': '1', 01:58:22 INFO - 'TERM': 'linux', 01:58:22 INFO - 'TMOUT': '86400', 01:58:22 INFO - 'USER': 'cltbld', 01:58:22 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464337381.517840-1276900034', 01:58:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:22 INFO - '_': '/tools/buildbot/bin/python'} 01:58:22 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/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 01:58:22 INFO - mozversion application_buildid: 20160526231045 01:58:22 INFO - mozversion application_changeset: 9cbc4f2d34a30255c3a093f6005f87b453491a7a 01:58:22 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:58:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:58:22 INFO - mozversion application_name: Firefox 01:58:22 INFO - mozversion application_remotingname: firefox-dev 01:58:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:58:22 INFO - mozversion application_vendor: Mozilla 01:58:22 INFO - mozversion application_version: 48.0a2 01:58:22 INFO - mozversion platform_buildid: 20160526231045 01:58:22 INFO - mozversion platform_changeset: 9cbc4f2d34a30255c3a093f6005f87b453491a7a 01:58:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:58:22 INFO - mozversion platform_version: 48.0a2 01:58:22 INFO - using testdate: 1464339502 01:58:22 INFO - actual date: 1464339502 01:58:22 INFO - starting webserver on 'localhost:53153' 01:58:22 INFO - SUITE-START | Running 2 tests 01:58:22 INFO - TEST-START | dromaeo_css 01:58:22 INFO - operating with platform_type : linux_ 01:58:22 INFO - Initialising browser for dromaeo_css test... 01:58:22 INFO - TEST-INFO | started process 13885 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7KjBsh/profile http://localhost:53153/getInfo.html) 01:58:26 INFO - PROCESS | 13885 | __metrics Screen width/height:1600/1200 01:58:26 INFO - PROCESS | 13885 | colorDepth:24 01:58:26 INFO - PROCESS | 13885 | Browser inner width/height: 1024/697 01:58:26 INFO - PROCESS | 13885 | __metrics 01:58:26 ERROR - PROCESS | 13885 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:58:27 INFO - TEST-INFO | 13885: exit 0 01:58:27 INFO - Browser initialized. 01:58:27 INFO - Running cycle 1/1 for dromaeo_css test... 01:58:27 INFO - TEST-INFO | started process 13980 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7KjBsh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:58:39 INFO - PROCESS | 13980 | RSS: Main: 141901824 01:58:39 INFO - PROCESS | 13980 | 01:59:30 INFO - PROCESS | 13980 | 1464339570470 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] 02:01:37 INFO - PROCESS | 13980 | Cycle 1(1): loaded http://localhost:53153/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53153/tests/dromaeo/cssquery-ext.html) 02:01:38 INFO - PROCESS | 13980 | RSS: Main: 248287232 02:01:38 INFO - PROCESS | 13980 | 02:04:40 INFO - PROCESS | 13980 | Cycle 1(1): loaded http://localhost:53153/tests/dromaeo/cssquery-ext.html (next: http://localhost:53153/tests/dromaeo/cssquery-jquery.html) 02:04:41 INFO - PROCESS | 13980 | RSS: Main: 228409344 02:04:41 INFO - PROCESS | 13980 | 02:07:43 INFO - PROCESS | 13980 | Cycle 1(1): loaded http://localhost:53153/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53153/tests/dromaeo/cssquery-mootools.html) 02:07:43 INFO - PROCESS | 13980 | RSS: Main: 214728704 02:07:43 INFO - PROCESS | 13980 | 02:10:45 INFO - PROCESS | 13980 | Cycle 1(1): loaded http://localhost:53153/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53153/tests/dromaeo/cssquery-prototype.html) 02:10:46 INFO - PROCESS | 13980 | RSS: Main: 213188608 02:10:46 INFO - PROCESS | 13980 | 02:13:48 INFO - PROCESS | 13980 | Cycle 1(1): loaded http://localhost:53153/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53153/tests/dromaeo/cssquery-yui.html) 02:13:49 INFO - PROCESS | 13980 | RSS: Main: 187772928 02:13:49 INFO - PROCESS | 13980 | 02:16:51 INFO - PROCESS | 13980 | Cycle 1(1): loaded http://localhost:53153/tests/dromaeo/cssquery-yui.html (next: http://localhost:53153/tests/dromaeo/cssquery-dojo.html) 02:16:51 INFO - PROCESS | 13980 | RSS: Main: 256094208 02:16:51 INFO - PROCESS | 13980 | 02:16:51 INFO - PROCESS | 13980 | __start_tp_report 02:16:51 INFO - PROCESS | 13980 | _x_x_mozilla_page_load 02:16:51 INFO - PROCESS | 13980 | _x_x_mozilla_page_load_details 02:16:51 INFO - PROCESS | 13980 | |i|pagename|runs| 02:16:51 INFO - PROCESS | 13980 | |0;dojo.html;3249.0415327478395;3310.519974603681;3323.1858194742285;3331.650176731445;3354.698077173054;5336.439673834249;5351;5357.946420535794;5367.087595108831;5383.031054410209;5361.222622719703;5366.758495867685;5372.597055220855;5379.569634429246;5388.380336261331;4758.428988521382;4851.2238041913215;4923.80304787808;4999.275105109757;5001.524855138774;4758.191107511731;4821.614270858323;4822.204336284509;4822.7588620569;4829.275608658694;4810.807567697288;4863.392075990501;4866.58634016109;4875.951240487585;4879.536444037811;4914.090893184754;4953.157963146274;4976.2784396262705;4976.651634385595;5010.148274793294;4707.670463067587;4753.263244197155;4830.396200474941;4835.927461088087;4837.032593481318;5205.167173252262;5214.97392513035;5238.895222095537;5251.054810134175;5257.658252213594;5727.341355744101;5729.885402291972;5733.054046082391;5737.598368114233;5741.913871291934;5701.287339082614;5743.368229494752;5769.076947688392;5787.536997040227;5798.594098413113;5334;5356.678599284055;5391.32608423947;5395.892082158413;5409.945900540944;5652;5870.26621672291;5882.441168089024;5889.499392551681;5890.028145356054;5553.416891226444;5584.190292407578;5602;5622.6345287557;5635.380108188096;5708.771649134072;5710.914336284959;5720.256366672306;5720.256366672389;5724.4561766632105;5581.246531718166;5663.801766938137;5677.829665110054;5702.087665973424;5707.914381284284;5707.086866101404;5713.800016999385;5720.256366672306;5721.742521586539;5751.079827227623;4393.0994146199955;4397;4397.252467080604;4399.472063352418;4426.800793964215;3854.807259637007;3931.331673615492;3986.621270979252;3993.121513267077;4017.5781542938157;5408.45915408456;5459.262999495097;5470.070088085035;5478.397376288605;5480.561555075585;5744.023516002289;5747.885042299131;5751.654900705971;5764.538836893039;5767.250257466502;5247.134222853263;5350.946490535122;5434.755436005389;5458.263134476874;5460.781568737206;4975.4527002029745;5027.84916452507;5028.145215313405;5030.471800460972;5053.570446512014;6021.307549631761;6024.608400454044;6040.184575082308;6064.06007068905;6067.514598832083;5616.241807355955;5796.8550786229;5860.706964651836;5868.09044598088;5881.470667639933;6027.6986150693165;6049.032154855202;6071.150038994456;6073.605215660968;6074.088886667036;5529.723513824212;5720.570957178312;5745.339285982165;5747.3103227612955;5760.769569217185;5691.402402747817;5760.020796464695;5761.078227483583;5769.826905192851;5801.042827933344;5511.58663100261;5525.972370138124;5540.722963851872;5560.471755183251;5563.388027317073;5496.780128794803;5504.779808807602;5513.61404701667;5520.447955204608;5607.74765135578;5558.91661625084;5587.1339942309005;5599.244102046172;5600.551955843442;5628.437156284339;5640.548756099584;5642.802501912413;5674.77300907959;5684.317881854204;5693.459121383462;5366.409694933476;5471.425500322568;5509.752061157337;5569.582281328835;5627.493525582717 02:16:51 INFO - PROCESS | 13980 | |1;ext.html;600.1328080923065;624.5160000999222;662.7315937045496;672.398203607771;672.5157886321847;28644;29377.706222937763;29418.852905735494;29473.263168420774;29489.852550737243;29588.260293492673;29964.40071198575;41531.377029344585;42521.149577008444;42587.57412425875;8871.334649901235;9029.593668284942;9031.954840225822;9034.232090272335;9034.638614455447;7773;8783.604737786814;8862.158094981;8897.95551022244;8908.8663670045;10804;11163.38601376928;11163.553457861717;11163.83254251187;11170.162237832155;10279.280450368477;10322.7419314517;10323.58705651773;10328.328658637201;10332.94833525835;7716.228377162239;10215.182785377152;10449.529771160316;10560.366378017343;10567.94716026415;40758.18483630341;41364.79317603393;41449.378259326135;41493.1701365974;41499.58500414987;3726.496922915399;3780.8298626561595;3825.61743825618;3829.463875057494;4271.402003719481;31522.211944701336;32098.037058888272;32115.83942080298;32152.356952861046;33622.49566256508;4540.091981603659;4653.906921861544;4717.740524271164;4726.550977657117;4759.190937540627;341611;342662.9999999975;342739;342860;345996.9999999975;68931.3106868935;69006.65496672485;69414.30585694179;69659;69753.25616859618;74299.62850185715;74675.62662186763;74708.62645686846;74869.62565187139;75141.24858751343;17958.102094895203;18365.173567189508;18365.90817045933;18370.448886533424;18374.632507350045;13633.522826701017;13642.386092625855;13662.521811736542;13674.794878076837;13691;15726.9213653931;18706.25174993012;18946.24215031411;21604.783952160276;21750.129994800347;7753.147153813076;7794.5323280602215;7873.960630196812;7983.361331093499;8015.719449819228;1049.496241803923;1095.2771171027084;1109.2013750099916;1121.0359091181576;1233.4079641772;33777.15557111043;33938;34329.65670343264;34364.31271374608;34497.13757156091;1204.9277043377426;1210.1226610707167;1214.0469731260919;1270.4791035675328;1276.5914907229596;17860;18147.364842230458;18379;18476.445706628823;18908.81091189098;370445;373896;374345;374814;375735;61678.383216168164;63618;63658.68170659117;63699.36300637027;63763.6811815938;1184.4297873614278;1200.4477940147456;1201.5974648492852;1492.731308364483;1497.0568541818802;23115.65326520137;30452;30621.23446913756;31160.220994474414;31277.530837037917;45431.318530222736;45491.772541137085;45658.771706141255;45798.08403831838;45842.31236531388;362448;362626;365543;365702;366241;27708.445831083667;34023.65976340304;46723.29915051209;47856.04287914292;48729.75635121802;37274.627253727114;43674.56325436705;44027;44099.11801763882;44684;37117.44323835199;38211.61788382081;38373.808130959165;39824.20351592894;39838.203235935696;37702;38888;38995.41506877342;39979.200415990934;40081.1983760329;43628.56371436372;44880.32679509875;45293.32060019037;45903;45913.770431147634;39036.219275614894;39248.80375598104;39709.60290397175;40009.79995100006;40437.59562404456;29522.74474180645;29795.702042979294;29938.850305748332;30591;30707.846460768447 02:16:51 INFO - PROCESS | 13980 | |2;jquery.html;415.77340349509524;420.9473815773026;425.5297895825111;426.43923240938165;433.0645805061069;13054.673633159176;18674.15966281517;19281.03594820257;19294.517637059063;19590.510237244074;12795.744085118315;18433.90783046083;18456;18759.906200469013;18840.623187536243;5545.528630066449;5678.403767604404;5682.801101961432;5686.573506986972;5706.1440783882545;5589.720513974285;5639.323281206261;5670.404607516213;5682.6306290091015;5683.715814209294;5340.25236466893;5630.183623374608;5676.176954341618;5677.205191273225;5678.403767604404;5637.154426836008;5655.293088363955;5661.971690141564;5677.460641239076;5686.744096515646;5426.104692725696;5510.559155267609;5512.6692398456225;5563.36021357545;5681.460261275172;13212.207267563977;17160.57098572533;19823.107960141682;20572.38282851502;21216.787832121634;2443.549030559325;2514.53481105996;2653.5621622432277;2812.5921741347593;2852.1586132090874;9569.952150239274;9806.65676701312;9940.80118397628;9943.602255909755;10110.545025473872;2034.1354924157174;2074.7510298764246;2075.5226297951554;2085.09298455171;2088.081244252524;81380.59309703413;81514.59242703748;84043.15956840475;84247;84487.5775621118;10841.67474975752;11022.228444009002;11165.771765105832;11264.831027534594;11825.290482571074;16321.918390407973;16469.91765041191;16492.34030638761;16494.505164845075;16505.83494165043;8388.916110838936;8437.240648341678;8455.492670439793;8760.561971901507;8783.912160878437;8457.788555286044;8477.872831907527;8510.446820956742;8570;8593.656253749905;5046.142155833444;5048.0913435581215;5054.115529782273;5101.7704203310195;5152.819651312261;1777.4045694692422;1973.2994786850747;2048.702938073971;2097.8741275523516;2111.35603640891;933.9953300233456;976.2092704909046;1017.7659138398062;1034.6585626743156;1038.2991480750463;17472;17947.910260448614;17970.730439043426;18193.909030454764;18643.533911652044;987.4618333008527;991.5438898106808;1005.6580762540772;1010.6563768318807;1013.4780587997187;10133.594656213816;10222;10292.176625869912;10345.63790267337;10388.37669739818;556294;563134;568941;585494;590532;56227.71886140543;79562.20437795663;93069.53465232765;96308.51845740726;96928;950.2160717408166;981.4503877828439;999.14073896449;999.1607050077824;1000.7548150703125;15861.365545378518;15865.52403427899;16057.437989670305;16100.194990250675;16201.189940502692;36384.45423318599;39453.21093578055;39922.600773991886;40197.79901100476;41445.378319325835;57170;59440.405595943485;59585;59903.70048149731;60282.69858650678;8511.191436813493;8568.52873091986;8715.215630593024;8835.20483156519;8982.505962172143;9089.545522723705;13214.669633258862;13906.791398129239;14189.858101418853;14854.183019934007;12202.572909948109;12578.811317830057;12607.68480787951;12680.492780288685;13236.338183091;11942.582009629621;12021.579244726392;12460.12779105454;12564.183328084011;12837.165584236995;12829.935850321062;12867.678308042374;12974.286414247306;13011.804822927474;13058.869411305765;8770.736877893672;8824.955875220583;8961.78677368707;8973.685920992733;8977.506237157018;12008.399580020789;12043.638690839289;12049.879501204876;12128.272303661808;12189.75620487603 02:16:51 INFO - PROCESS | 13980 | |3;mootools.html;1187.2401662935717;1518.4457672949372;1582.604348912772;1665.1923816948777;1759.938402155925;7466.141393739715;8361.958190209049;8543;8566.614502347395;8573.314134869212;7927.841443171147;7957.522548647071;7994.040715114194;8013.519188848659;8019.157988411206;2013.798620137989;2337.8129749620034;2358.3396648938237;2358.433975845802;2374.9881250593808;2359.044586942291;2363.5391098735754;2365;2365.550545396369;2371.0989823866907;2337.848039877411;2367.029517897662;2395.784379405853;2399.1483023526657;2402.8678422686744;2003.3589251439473;2284.6344584866506;2330.021391015777;2330.2077293720217;2374.3114496795993;2347.9647805282934;2348.060775689738;2390.4860455002085;2391.9162829301067;2401.7598240176017;8479.491230526188;8479.872801907977;8491.872621910676;8499.830003399959;8512.872306915402;5178.792848286064;5252.1596544552685;5255.080360936859;5272.077386457355;5280.524752772269;3440.36353274645;3458.7405944554257;3497.930041399183;3550.822458877046;3553.662402071825;1129.717570607348;1145.164030257908;1150.683562020451;1157.1437136518916;1197.8442802435716;12148.21036632625;12187.634370968884;12234.265944043296;12238.082143839247;12290.938545307215;4587.357769912215;4676.532346765296;4677.807159174389;4730;4730;10341.689749307532;10354.223433242538;10356.326838755607;10357.533910974023;10363.689089327332;5090.516400941905;5172.017316709888;5174.275601415729;5174.275601415805;5191.065608190486;4086.244044851712;4784.091022705675;4861.6353773467135;4869.220924652039;4871.025794841046;4061.939070913939;4091.7135800494275;4145.481814773153;4151.792410379529;4186.037211441325;1321.5176460591815;1321.7752981993085;1332.3871019331023;1332.586898061604;1334.5329134802741;1048.2714513413105;1056.6724315462232;1059.4596755654673;1077.2943721862193;1092.082650573522;5830.679312637761;5963.254593175853;5976.820695379146;6064.848378790565;6084.665343406155;937.2829785214317;991.6231831903974;1005.2008653120787;1044.8693913260843;1083.864516935383;4081.1837632473625;4081.8163182656854;4082.652974497201;4109.671226301889;4146.202966696895;10267.9486602568;10567.788644227227;10673.252872298865;10679.199060070527;10686.51910664022;10422.322549034288;10491.10825579819;10498.963096219704;10506.21203409732;10508.789824203473;8174.3460523158;8254.876176857351;8352.6241319142;8356.623951922178;8381.119982401882;5742.425757424224;5808.244928159313;5836.766529338779;5840.503557197686;5860.677662728421;9451.102145296185;9637.42175469474;9646.131848133702;9740.366876153028;9793.46135962529;9719.562619682272;9802.068803463659;9907.504624768877;9932.851007234753;9942.055504727039;6574.112494813139;7549;7677.117131529722;7797.493162944391;7922.207779222032;7972.92027079745;8011.479253848481;8036.196380361917;8045.11503734577;8083.3533317333295;7259.310365515267;7473.17795042534;7483.550986940801;7565.130010048915;7654.693812247448;7249.311315425026;7274.163471200668;7327.340539351484;7329.230430804689;7380.298871607189;6660.3672651100005;6713.959336302881;6779.15260592426;6814.557053791487;6833.214180369321;4718.622510199107;4732.171869922819;5022.372203474566;5154.561862241751;5237.397699264633;5348.224507446476;5386.542143917811;5392.299001129828;5432.2123292123215;5480.232767412645 02:16:51 INFO - PROCESS | 13980 | |4;prototype.html;337.02952201746064;339.09461737161774;341.6941837055835;346.3039291025039;350.76148219210944;6070.423309785563;6144.2319710036245;6181.165542651746;6184.876302473948;6216.533759968009;6239.532035097374;6264.436200741932;6265.154204182434;6271.937280627192;6275.748970041204;4715.5048719884435;4744.0511897620445;4747.8338258160975;4750.311204875308;4761.619070474354;4470.687051906368;4552.749598772066;4673.158831410345;4750.121227572893;4754.310624959378;4604.884877878063;4649.767511624405;4649.767511624422;4653.511381304948;4667.603253723438;4634.513376095512;4637.0262244928435;4650.093231819763;4655.7439340836245;4659.767011649438;4029.8589549365925;4040.1313717550865;4042.0703238255073;4045.02919299366;4055.3308704063793;5903.409659034105;5903.822885313448;5904.645721256738;5911.527077833763;5922.555808314393;5397.136458166675;5421.457854214547;5428.050091234058;5432.972835135799;5438.048341540254;6307.621542707407;6463.353664633499;6463.612183269019;6479.514036447285;6593.241777195636;4615.053913947632;4634.814607415699;4650.697704649187;4651.534846515356;4654.348391225231;6831.2144103428245;6879.58722476653;6919.411849992756;6921.480888933401;6922.550034247758;4746.145693775154;4757.548032936866;4761.976190119027;4770.737609431445;4772.045590881838;4816.373871396766;4820.9517904821205;4825.9758701206265;4828.830990915371;4830.734309612934;5398.271233383522;5534.1145416733125;5535.58483113768;5542.667439953535;5542.7782888684005;6619.470442364599;6636.30318816527;6641.701123449457;6645.435138013227;6653;1568.3021055630363;1653.1568899860918;1686.5277722237793;1687.6962146813446;1692.2976964559816;1087.9401632910108;1119.457063324287;1132.0094916947671;1132.6318946342471;1137.0846468592863;6305.747770089145;6318.462930650854;6318.873622527615;6333.619982801047;6336.651484168415;6730.259671436138;6744.325567443217;6745.696443660047;6752.189737231465;6761.29006454325;6321.905171422432;6323.36766323364;6328.46208072319;6329.841753956188;6345.96827015862;3621.7102631789394;3649.4708267301626;3655.1227705350525;3655.1958569114754;3655.5065066216252;6880.380765731108;6953.79138625842;6961.547499412623;7038.824029399306;7049.753258635923;6850.623215723083;6875.415589674833;6885.173779146434;6885.449164066963;6894.758683446055;7005.229424763272;7010.193827709879;7011.92988070123;7021.192562855133;7023.051887995158;6679.0649309097735;6692.6988285526295;6726.562773419712;6754.392104710403;6756.662166891538;6481.611103333815;6630.734770609121;6644.734210631521;6661.233958094881;6664.466842652673;6954.965225173842;6992.1259842519685;6999.0551275577145;7006.544574602634;7011.6494175292055;4720;4758.381410416624;4767.189577771856;4771.212749896367;4778.880527986828;6569;6728.562643428161;6731;6732.528722989344;6760.966195168992;6586.176727909012;6681.231658359351;6707;6714.731410743516;6718.865622687616;6674.866502670016;6704.899426508508;6714.227863795726;6753.864922701617;6763.391294783493;6552.180977377828;6562.048502967138;6566.737330506726;6570.934290657032;6571.408573228432;6517.446017088411;6678.532502724763;6697.933020669731;6722.159730033746;6728.495362847708;6509.316521765147;6524.3149469305035;6528.771492997722;6542.1168142300185;6546.116274302908 02:16:51 INFO - PROCESS | 13980 | |5;yui.html;893.9150780675835;894.9976026849924;896.2471523919907;901.4230892228973;913.2146354135439;15128.848711512881;15166.696666066686;15318.080915145085;15341.84658153418;15469.922650386747;14699.926500367483;14804;14815.481458148966;14820.258987050658;14826.777598336033;502.79636747117473;866.6013633728461;880.2781718990431;892.9330300227476;895.6283142495856;893.6023469556051;895.6730793260479;895.6775560798108;895.789489469974;896.0591379052001;628.1457218183267;632.3865850125394;634.8857205702972;635.3075148088583;636.8248731598801;565.1748447266995;647.090837373491;903.1871315815786;919.2737737187614;920.2453987730064;674.507609445103;677.1873751498222;677.3700458573525;677.7966610016975;678.2742465561851;15184.088954662646;15674.137922414262;15690.13704246266;15707.978981366176;15709.764353534592;14676.19280939548;15238.542843714706;15376.538703838904;15460.768088478682;15474.148921809296;11900.464479098462;12064.336461494615;12121.151519393647;12333;12434.129610927239;4037.6366127048705;4065.10567675111;4075.4701888754566;4078.184363127357;4091.85678501251;61702.38297617011;61827;62158.37841621616;62381.37618623801;62511.6874415625;10174.949125254474;10430.791384172275;10551.788964220672;10903.563857445613;10915.126789856793;17337.046462444436;17340.219690113976;17376.739348909778;17398;17423.39018134359;8388.454750441202;8422.241998220066;8509.446885952393;8535.317174626016;8582.871256931026;4903.509649035068;4983.700977941335;5110.97444512775;5213.478652134756;5288.497592728685;3462.0652423845922;3511;3516.4197907345515;3520.2255503789124;3524.418470952264;627.8555932135635;630.7918386932301;637.3053371824733;639.4309064932214;668.8394785251504;622.1197006236216;638.5721566550329;677.3260605697265;715.4991505945859;754.1591125894588;9399.355112855223;9527.09492598202;9554.235661147091;9679.612815487442;9843.409395436154;647.3849842649407;702.2626242445411;742.1761844352764;755.0750330844671;764.873795823694;4220.873373798791;4398.56014398564;4456.086502267028;4503.7973291201315;4513.75174365413;64765.67617161884;65484;65662;65669.34330656727;65672.34327656758;57418.42581574214;57644.42355576474;57749.13376299359;58019;59409;50771.746141269796;50816.237756433686;51161.744191278805;51480;51518;8938.642454301755;9029.367944244103;9040.41237319572;9066.138716821892;9111.17999380059;39231.80384098061;39438.80280598693;39730.205395892495;40416.797916011405;41328.79335603423;44379.77810110929;44647;48223.27665085097;50780;51721.48278517167;11144.498497567467;11199.496022679163;11252.493637786483;11464.369459679465;11606.94196529012;11589.768204635691;11738.823917641072;11935.880641193477;12203.20679155852;12357.443915023665;11130;11137.665870023913;11268.323900565993;11448;11532.59635912739;11410.372429516456;11525.250858694159;11534.884651153381;11604.187706860777;11753.823692644446;10859.674209773719;11084.889151108386;12466.87533124657;12838.935805320914;13001.544945926848;10409.219308552041;10514.211434142622;10541.683749487527;10768.892311077103;10912.61805836792;10249.795004100026;10256.487175641338;10446.164306855282;10499.422531760521;10582.417967011581 02:16:51 INFO - PROCESS | 13980 | __end_tp_report 02:16:51 INFO - PROCESS | 13980 | __start_cc_report 02:16:51 INFO - PROCESS | 13980 | _x_x_mozilla_cycle_collect,827 02:16:51 INFO - PROCESS | 13980 | __end_cc_report 02:16:51 INFO - PROCESS | 13980 | __startTimestamp1464340611821__endTimestamp 02:16:51 INFO - PROCESS | 13980 | 02:16:51 INFO - PROCESS | 13980 | ------- Summary: start ------- 02:16:51 INFO - PROCESS | 13980 | Number of tests: 6 02:16:51 INFO - PROCESS | 13980 | 02:16:51 INFO - PROCESS | 13980 | [#0] dojo.html Cycles:165 Average:5340.07 Median:5520.45 stddev:585.90 (10.6%) stddev-sans-first:564.27 02:16:51 INFO - PROCESS | 13980 | Values: 3249.0 3310.5 3323.2 3331.7 3354.7 5336.4 5351.0 5357.9 5367.1 5383.0 5361.2 5366.8 5372.6 5379.6 5388.4 4758.4 4851.2 4923.8 4999.3 5001.5 4758.2 4821.6 4822.2 4822.8 4829.3 4810.8 4863.4 4866.6 4876.0 4879.5 4914.1 4953.2 4976.3 4976.7 5010.1 4707.7 4753.3 4830.4 4835.9 4837.0 5205.2 5215.0 5238.9 5251.1 5257.7 5727.3 5729.9 5733.1 5737.6 5741.9 5701.3 5743.4 5769.1 5787.5 5798.6 5334.0 5356.7 5391.3 5395.9 5409.9 5652.0 5870.3 5882.4 5889.5 5890.0 5553.4 5584.2 5602.0 5622.6 5635.4 5708.8 5710.9 5720.3 5720.3 5724.5 5581.2 5663.8 5677.8 5702.1 5707.9 5707.1 5713.8 5720.3 5721.7 5751.1 4393.1 4397.0 4397.3 4399.5 4426.8 3854.8 3931.3 3986.6 3993.1 4017.6 5408.5 5459.3 5470.1 5478.4 5480.6 5744.0 5747.9 5751.7 5764.5 5767.3 5247.1 5350.9 5434.8 5458.3 5460.8 4975.5 5027.8 5028.1 5030.5 5053.6 6021.3 6024.6 6040.2 6064.1 6067.5 5616.2 5796.9 5860.7 5868.1 5881.5 6027.7 6049.0 6071.2 6073.6 6074.1 5529.7 5720.6 5745.3 5747.3 5760.8 5691.4 5760.0 5761.1 5769.8 5801.0 5511.6 5526.0 5540.7 5560.5 5563.4 5496.8 5504.8 5513.6 5520.4 5607.7 5558.9 5587.1 5599.2 5600.6 5628.4 5640.5 5642.8 5674.8 5684.3 5693.5 5366.4 5471.4 5509.8 5569.6 5627.5 02:16:51 INFO - PROCESS | 13980 | 02:16:51 INFO - PROCESS | 13980 | [#1] ext.html Cycles:180 Average:54279.32 Median:20500.56 stddev:94671.05 (461.8%) stddev-sans-first:94850.83 02:16:51 INFO - PROCESS | 13980 | Values: 600.1 624.5 662.7 672.4 672.5 28644.0 29377.7 29418.9 29473.3 29489.9 29588.3 29964.4 41531.4 42521.1 42587.6 8871.3 9029.6 9032.0 9034.2 9034.6 7773.0 8783.6 8862.2 8898.0 8908.9 10804.0 11163.4 11163.6 11163.8 11170.2 10279.3 10322.7 10323.6 10328.3 10332.9 7716.2 10215.2 10449.5 10560.4 10567.9 40758.2 41364.8 41449.4 41493.2 41499.6 3726.5 3780.8 3825.6 3829.5 4271.4 31522.2 32098.0 32115.8 32152.4 33622.5 4540.1 4653.9 4717.7 4726.6 4759.2 341611.0 342663.0 342739.0 342860.0 345997.0 68931.3 69006.7 69414.3 69659.0 69753.3 74299.6 74675.6 74708.6 74869.6 75141.2 17958.1 18365.2 18365.9 18370.4 18374.6 13633.5 13642.4 13662.5 13674.8 13691.0 15726.9 18706.3 18946.2 21604.8 21750.1 7753.1 7794.5 7874.0 7983.4 8015.7 1049.5 1095.3 1109.2 1121.0 1233.4 33777.2 33938.0 34329.7 34364.3 34497.1 1204.9 1210.1 1214.0 1270.5 1276.6 17860.0 18147.4 18379.0 18476.4 18908.8 370445.0 373896.0 374345.0 374814.0 375735.0 61678.4 63618.0 63658.7 63699.4 63763.7 1184.4 1200.4 1201.6 1492.7 1497.1 23115.7 30452.0 30621.2 31160.2 31277.5 45431.3 45491.8 45658.8 45798.1 45842.3 362448.0 362626.0 365543.0 365702.0 366241.0 27708.4 34023.7 46723.3 47856.0 48729.8 37274.6 43674.6 44027.0 44099.1 44684.0 37117.4 38211.6 38373.8 39824.2 39838.2 37702.0 38888.0 38995.4 39979.2 40081.2 43628.6 44880.3 45293.3 45903.0 45913.8 39036.2 39248.8 39709.6 40009.8 40437.6 29522.7 29795.7 29938.9 30591.0 30707.8 02:16:51 INFO - PROCESS | 13980 | 02:16:51 INFO - PROCESS | 13980 | [#2] jquery.html Cycles:180 Average:31002.12 Median:40821.59 stddev:94038.81 (230.4%) stddev-sans-first:94274.57 02:16:51 INFO - PROCESS | 13980 | Values: 415.8 420.9 425.5 426.4 433.1 13054.7 18674.2 19281.0 19294.5 19590.5 12795.7 18433.9 18456.0 18759.9 18840.6 5545.5 5678.4 5682.8 5686.6 5706.1 5589.7 5639.3 5670.4 5682.6 5683.7 5340.3 5630.2 5676.2 5677.2 5678.4 5637.2 5655.3 5662.0 5677.5 5686.7 5426.1 5510.6 5512.7 5563.4 5681.5 13212.2 17160.6 19823.1 20572.4 21216.8 2443.5 2514.5 2653.6 2812.6 2852.2 9570.0 9806.7 9940.8 9943.6 10110.5 2034.1 2074.8 2075.5 2085.1 2088.1 81380.6 81514.6 84043.2 84247.0 84487.6 10841.7 11022.2 11165.8 11264.8 11825.3 16321.9 16469.9 16492.3 16494.5 16505.8 8388.9 8437.2 8455.5 8760.6 8783.9 8457.8 8477.9 8510.4 8570.0 8593.7 5046.1 5048.1 5054.1 5101.8 5152.8 1777.4 1973.3 2048.7 2097.9 2111.4 934.0 976.2 1017.8 1034.7 1038.3 17472.0 17947.9 17970.7 18193.9 18643.5 987.5 991.5 1005.7 1010.7 1013.5 10133.6 10222.0 10292.2 10345.6 10388.4 556294.0 563134.0 568941.0 585494.0 590532.0 56227.7 79562.2 93069.5 96308.5 96928.0 950.2 981.5 999.1 999.2 1000.8 15861.4 15865.5 16057.4 16100.2 16201.2 36384.5 39453.2 39922.6 40197.8 41445.4 57170.0 59440.4 59585.0 59903.7 60282.7 8511.2 8568.5 8715.2 8835.2 8982.5 9089.5 13214.7 13906.8 14189.9 14854.2 12202.6 12578.8 12607.7 12680.5 13236.3 11942.6 12021.6 12460.1 12564.2 12837.2 12829.9 12867.7 12974.3 13011.8 13058.9 8770.7 8825.0 8961.8 8973.7 8977.5 12008.4 12043.6 12049.9 12128.3 12189.8 02:16:51 INFO - PROCESS | 13980 | 02:16:51 INFO - PROCESS | 13980 | [#3] mootools.html Cycles:180 Average:5688.86 Median:4758.13 stddev:3157.46 (66.4%) stddev-sans-first:3148.19 02:16:51 INFO - PROCESS | 13980 | Values: 1187.2 1518.4 1582.6 1665.2 1759.9 7466.1 8362.0 8543.0 8566.6 8573.3 7927.8 7957.5 7994.0 8013.5 8019.2 2013.8 2337.8 2358.3 2358.4 2375.0 2359.0 2363.5 2365.0 2365.6 2371.1 2337.8 2367.0 2395.8 2399.1 2402.9 2003.4 2284.6 2330.0 2330.2 2374.3 2348.0 2348.1 2390.5 2391.9 2401.8 8479.5 8479.9 8491.9 8499.8 8512.9 5178.8 5252.2 5255.1 5272.1 5280.5 3440.4 3458.7 3497.9 3550.8 3553.7 1129.7 1145.2 1150.7 1157.1 1197.8 12148.2 12187.6 12234.3 12238.1 12290.9 4587.4 4676.5 4677.8 4730.0 4730.0 10341.7 10354.2 10356.3 10357.5 10363.7 5090.5 5172.0 5174.3 5174.3 5191.1 4086.2 4784.1 4861.6 4869.2 4871.0 4061.9 4091.7 4145.5 4151.8 4186.0 1321.5 1321.8 1332.4 1332.6 1334.5 1048.3 1056.7 1059.5 1077.3 1092.1 5830.7 5963.3 5976.8 6064.8 6084.7 937.3 991.6 1005.2 1044.9 1083.9 4081.2 4081.8 4082.7 4109.7 4146.2 10267.9 10567.8 10673.3 10679.2 10686.5 10422.3 10491.1 10499.0 10506.2 10508.8 8174.3 8254.9 8352.6 8356.6 8381.1 5742.4 5808.2 5836.8 5840.5 5860.7 9451.1 9637.4 9646.1 9740.4 9793.5 9719.6 9802.1 9907.5 9932.9 9942.1 6574.1 7549.0 7677.1 7797.5 7922.2 7972.9 8011.5 8036.2 8045.1 8083.4 7259.3 7473.2 7483.6 7565.1 7654.7 7249.3 7274.2 7327.3 7329.2 7380.3 6660.4 6714.0 6779.2 6814.6 6833.2 4718.6 4732.2 5022.4 5154.6 5237.4 5348.2 5386.5 5392.3 5432.2 5480.2 02:16:51 INFO - PROCESS | 13980 | 02:16:51 INFO - PROCESS | 13980 | [#4] prototype.html Cycles:180 Average:5505.82 Median:6306.68 stddev:1660.58 (26.3%) stddev-sans-first:1619.28 02:16:51 INFO - PROCESS | 13980 | Values: 337.0 339.1 341.7 346.3 350.8 6070.4 6144.2 6181.2 6184.9 6216.5 6239.5 6264.4 6265.2 6271.9 6275.7 4715.5 4744.1 4747.8 4750.3 4761.6 4470.7 4552.7 4673.2 4750.1 4754.3 4604.9 4649.8 4649.8 4653.5 4667.6 4634.5 4637.0 4650.1 4655.7 4659.8 4029.9 4040.1 4042.1 4045.0 4055.3 5903.4 5903.8 5904.6 5911.5 5922.6 5397.1 5421.5 5428.1 5433.0 5438.0 6307.6 6463.4 6463.6 6479.5 6593.2 4615.1 4634.8 4650.7 4651.5 4654.3 6831.2 6879.6 6919.4 6921.5 6922.6 4746.1 4757.5 4762.0 4770.7 4772.0 4816.4 4821.0 4826.0 4828.8 4830.7 5398.3 5534.1 5535.6 5542.7 5542.8 6619.5 6636.3 6641.7 6645.4 6653.0 1568.3 1653.2 1686.5 1687.7 1692.3 1087.9 1119.5 1132.0 1132.6 1137.1 6305.7 6318.5 6318.9 6333.6 6336.7 6730.3 6744.3 6745.7 6752.2 6761.3 6321.9 6323.4 6328.5 6329.8 6346.0 3621.7 3649.5 3655.1 3655.2 3655.5 6880.4 6953.8 6961.5 7038.8 7049.8 6850.6 6875.4 6885.2 6885.4 6894.8 7005.2 7010.2 7011.9 7021.2 7023.1 6679.1 6692.7 6726.6 6754.4 6756.7 6481.6 6630.7 6644.7 6661.2 6664.5 6955.0 6992.1 6999.1 7006.5 7011.6 4720.0 4758.4 4767.2 4771.2 4778.9 6569.0 6728.6 6731.0 6732.5 6761.0 6586.2 6681.2 6707.0 6714.7 6718.9 6674.9 6704.9 6714.2 6753.9 6763.4 6552.2 6562.0 6566.7 6570.9 6571.4 6517.4 6678.5 6697.9 6722.2 6728.5 6509.3 6524.3 6528.8 6542.1 6546.1 02:16:51 INFO - PROCESS | 13980 | 02:16:51 INFO - PROCESS | 13980 | [#5] yui.html Cycles:180 Average:15445.16 Median:4508.77 stddev:18436.88 (408.9%) stddev-sans-first:18456.22 02:16:51 INFO - PROCESS | 13980 | Values: 893.9 895.0 896.2 901.4 913.2 15128.8 15166.7 15318.1 15341.8 15469.9 14699.9 14804.0 14815.5 14820.3 14826.8 502.8 866.6 880.3 892.9 895.6 893.6 895.7 895.7 895.8 896.1 628.1 632.4 634.9 635.3 636.8 565.2 647.1 903.2 919.3 920.2 674.5 677.2 677.4 677.8 678.3 15184.1 15674.1 15690.1 15708.0 15709.8 14676.2 15238.5 15376.5 15460.8 15474.1 11900.5 12064.3 12121.2 12333.0 12434.1 4037.6 4065.1 4075.5 4078.2 4091.9 61702.4 61827.0 62158.4 62381.4 62511.7 10174.9 10430.8 10551.8 10903.6 10915.1 17337.0 17340.2 17376.7 17398.0 17423.4 8388.5 8422.2 8509.4 8535.3 8582.9 4903.5 4983.7 5111.0 5213.5 5288.5 3462.1 3511.0 3516.4 3520.2 3524.4 627.9 630.8 637.3 639.4 668.8 622.1 638.6 677.3 715.5 754.2 9399.4 9527.1 9554.2 9679.6 9843.4 647.4 702.3 742.2 755.1 764.9 4220.9 4398.6 4456.1 4503.8 4513.8 64765.7 65484.0 65662.0 65669.3 65672.3 57418.4 57644.4 57749.1 58019.0 59409.0 50771.7 50816.2 51161.7 51480.0 51518.0 8938.6 9029.4 9040.4 9066.1 9111.2 39231.8 39438.8 39730.2 40416.8 41328.8 44379.8 44647.0 48223.3 50780.0 51721.5 11144.5 11199.5 11252.5 11464.4 11606.9 11589.8 11738.8 11935.9 12203.2 12357.4 11130.0 11137.7 11268.3 11448.0 11532.6 11410.4 11525.3 11534.9 11604.2 11753.8 10859.7 11084.9 12466.9 12838.9 13001.5 10409.2 10514.2 10541.7 10768.9 10912.6 10249.8 10256.5 10446.2 10499.4 10582.4 02:16:51 INFO - PROCESS | 13980 | -------- Summary: end -------- 02:16:51 INFO - PROCESS | 13980 | 02:16:52 INFO - TEST-INFO | 13980: exit 0 02:16:52 INFO - TEST-OK | dromaeo_css | took 1109917ms 02:16:52 INFO - TEST-START | kraken 02:16:52 INFO - operating with platform_type : linux_ 02:16:52 INFO - Initialising browser for kraken test... 02:16:52 INFO - TEST-INFO | started process 14168 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb18WEs/profile http://localhost:53153/getInfo.html) 02:16:55 INFO - PROCESS | 14168 | __metrics Screen width/height:1600/1200 02:16:55 INFO - PROCESS | 14168 | colorDepth:24 02:16:55 INFO - PROCESS | 14168 | Browser inner width/height: 1024/697 02:16:55 INFO - PROCESS | 14168 | __metrics 02:16:56 ERROR - PROCESS | 14168 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:16:57 INFO - TEST-INFO | 14168: exit 0 02:16:57 INFO - Browser initialized. 02:16:57 INFO - Running cycle 1/1 for kraken test... 02:16:57 INFO - TEST-INFO | started process 14261 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb18WEs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:17:09 INFO - PROCESS | 14261 | RSS: Main: 142475264 02:17:09 INFO - PROCESS | 14261 | 02:17:11 INFO - PROCESS | 14261 | Cycle 1(1): loaded http://localhost:53153/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53153/tests/kraken/driver.html?testName=audio-beat-detection) 02:17:12 INFO - PROCESS | 14261 | RSS: Main: 197021696 02:17:12 INFO - PROCESS | 14261 | 02:17:15 INFO - PROCESS | 14261 | Cycle 1(1): loaded http://localhost:53153/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53153/tests/kraken/driver.html?testName=audio-dft) 02:17:16 INFO - PROCESS | 14261 | RSS: Main: 181628928 02:17:16 INFO - PROCESS | 14261 | 02:17:18 INFO - PROCESS | 14261 | Cycle 1(1): loaded http://localhost:53153/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53153/tests/kraken/driver.html?testName=audio-fft) 02:17:19 INFO - PROCESS | 14261 | RSS: Main: 272371712 02:17:19 INFO - PROCESS | 14261 | 02:17:21 INFO - PROCESS | 14261 | Cycle 1(1): loaded http://localhost:53153/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53153/tests/kraken/driver.html?testName=audio-oscillator) 02:17:22 INFO - PROCESS | 14261 | RSS: Main: 178388992 02:17:22 INFO - PROCESS | 14261 | 02:17:24 INFO - PROCESS | 14261 | Cycle 1(1): loaded http://localhost:53153/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53153/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:17:24 INFO - PROCESS | 14261 | RSS: Main: 177315840 02:17:24 INFO - PROCESS | 14261 | 02:17:27 INFO - PROCESS | 14261 | Cycle 1(1): loaded http://localhost:53153/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53153/tests/kraken/driver.html?testName=imaging-darkroom) 02:17:28 INFO - PROCESS | 14261 | RSS: Main: 211308544 02:17:28 INFO - PROCESS | 14261 | 02:17:31 INFO - PROCESS | 14261 | Cycle 1(1): loaded http://localhost:53153/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53153/tests/kraken/driver.html?testName=imaging-desaturate) 02:17:32 INFO - PROCESS | 14261 | RSS: Main: 211050496 02:17:32 INFO - PROCESS | 14261 | 02:17:35 INFO - PROCESS | 14261 | Cycle 1(1): loaded http://localhost:53153/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53153/tests/kraken/driver.html?testName=json-parse-financial) 02:17:35 INFO - PROCESS | 14261 | RSS: Main: 211513344 02:17:35 INFO - PROCESS | 14261 | 02:17:37 INFO - PROCESS | 14261 | Cycle 1(1): loaded http://localhost:53153/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53153/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:17:37 INFO - PROCESS | 14261 | RSS: Main: 190005248 02:17:37 INFO - PROCESS | 14261 | 02:17:39 INFO - PROCESS | 14261 | Cycle 1(1): loaded http://localhost:53153/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53153/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:17:40 INFO - PROCESS | 14261 | RSS: Main: 193273856 02:17:40 INFO - PROCESS | 14261 | 02:17:42 INFO - PROCESS | 14261 | Cycle 1(1): loaded http://localhost:53153/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53153/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:17:42 INFO - PROCESS | 14261 | RSS: Main: 207421440 02:17:42 INFO - PROCESS | 14261 | 02:17:45 INFO - PROCESS | 14261 | Cycle 1(1): loaded http://localhost:53153/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53153/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:17:45 INFO - PROCESS | 14261 | RSS: Main: 213635072 02:17:45 INFO - PROCESS | 14261 | 02:17:48 INFO - PROCESS | 14261 | Cycle 1(1): loaded http://localhost:53153/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53153/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:17:49 INFO - PROCESS | 14261 | RSS: Main: 210214912 02:17:49 INFO - PROCESS | 14261 | 02:17:50 INFO - PROCESS | 14261 | Cycle 1(1): loaded http://localhost:53153/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53153/tests/kraken/driver.html?testName=ai-astar) 02:17:51 INFO - PROCESS | 14261 | RSS: Main: 273883136 02:17:51 INFO - PROCESS | 14261 | 02:17:51 INFO - PROCESS | 14261 | __start_tp_report 02:17:51 INFO - PROCESS | 14261 | _x_x_mozilla_page_load 02:17:51 INFO - PROCESS | 14261 | _x_x_mozilla_page_load_details 02:17:51 INFO - PROCESS | 14261 | |i|pagename|runs| 02:17:51 INFO - PROCESS | 14261 | |0;ai-astar;109;108;110;112;112;112;105;110;111;109 02:17:51 INFO - PROCESS | 14261 | |1;audio-beat-detection;156;130;153;175;126;161;150;130;188;129 02:17:51 INFO - PROCESS | 14261 | |2;audio-dft;159;161;159;163;160;162;160;159;161;161 02:17:51 INFO - PROCESS | 14261 | |3;audio-fft;76;74;75;184;76;74;86;76;163;77 02:17:51 INFO - PROCESS | 14261 | |4;audio-oscillator;92;92;148;92;92;92;149;91;92;152 02:17:51 INFO - PROCESS | 14261 | |5;imaging-gaussian-blur;117;117;117;116;117;116;117;117;117;118 02:17:51 INFO - PROCESS | 14261 | |6;imaging-darkroom;145;145;145;145;147;146;145;145;146;145 02:17:51 INFO - PROCESS | 14261 | |7;imaging-desaturate;95;95;95;95;94;95;95;95;94;94 02:17:51 INFO - PROCESS | 14261 | |8;json-parse-financial;56;54;54;55;56;55;56;80;53;53 02:17:51 INFO - PROCESS | 14261 | |9;json-stringify-tinderbox;57;57;57;58;58;57;58;57;57;57 02:17:51 INFO - PROCESS | 14261 | |10;stanford-crypto-aes;72;71;71;72;74;73;75;81;73;75 02:17:51 INFO - PROCESS | 14261 | |11;stanford-crypto-ccm;113;115;119;112;113;118;110;113;131;129 02:17:51 INFO - PROCESS | 14261 | |12;stanford-crypto-pbkdf2;160;164;160;157;161;158;158;160;165;159 02:17:51 INFO - PROCESS | 14261 | |13;stanford-crypto-sha256-iterative;67;67;66;66;66;65;66;67;65;65 02:17:51 INFO - PROCESS | 14261 | __end_tp_report 02:17:51 INFO - PROCESS | 14261 | __start_cc_report 02:17:51 INFO - PROCESS | 14261 | _x_x_mozilla_cycle_collect,1602 02:17:51 INFO - PROCESS | 14261 | __end_cc_report 02:17:51 INFO - PROCESS | 14261 | __startTimestamp1464340671054__endTimestamp 02:17:51 INFO - PROCESS | 14261 | 02:17:51 INFO - PROCESS | 14261 | ------- Summary: start ------- 02:17:51 INFO - PROCESS | 14261 | Number of tests: 14 02:17:51 INFO - PROCESS | 14261 | 02:17:51 INFO - PROCESS | 14261 | [#0] ai-astar Cycles:10 Average:109.80 Median:110.50 stddev:2.20 (2.0%) stddev-sans-first:2.32 02:17:51 INFO - PROCESS | 14261 | Values: 109.0 108.0 110.0 112.0 112.0 112.0 105.0 110.0 111.0 109.0 02:17:51 INFO - PROCESS | 14261 | 02:17:51 INFO - PROCESS | 14261 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:154.50 stddev:21.22 (13.7%) stddev-sans-first:22.39 02:17:51 INFO - PROCESS | 14261 | Values: 156.0 130.0 153.0 175.0 126.0 161.0 150.0 130.0 188.0 129.0 02:17:51 INFO - PROCESS | 14261 | 02:17:51 INFO - PROCESS | 14261 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:1.35 (0.8%) stddev-sans-first:1.32 02:17:51 INFO - PROCESS | 14261 | Values: 159.0 161.0 159.0 163.0 160.0 162.0 160.0 159.0 161.0 161.0 02:17:51 INFO - PROCESS | 14261 | 02:17:51 INFO - PROCESS | 14261 | [#3] audio-fft Cycles:10 Average:96.10 Median:76.00 stddev:41.23 (54.3%) stddev-sans-first:43.09 02:17:51 INFO - PROCESS | 14261 | Values: 76.0 74.0 75.0 184.0 76.0 74.0 86.0 76.0 163.0 77.0 02:17:51 INFO - PROCESS | 14261 | 02:17:51 INFO - PROCESS | 14261 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:92.00 stddev:27.94 (30.4%) stddev-sans-first:28.94 02:17:51 INFO - PROCESS | 14261 | Values: 92.0 92.0 148.0 92.0 92.0 92.0 149.0 91.0 92.0 152.0 02:17:51 INFO - PROCESS | 14261 | 02:17:51 INFO - PROCESS | 14261 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 02:17:51 INFO - PROCESS | 14261 | Values: 117.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 118.0 02:17:51 INFO - PROCESS | 14261 | 02:17:51 INFO - PROCESS | 14261 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 02:17:51 INFO - PROCESS | 14261 | Values: 145.0 145.0 145.0 145.0 147.0 146.0 145.0 145.0 146.0 145.0 02:17:51 INFO - PROCESS | 14261 | 02:17:51 INFO - PROCESS | 14261 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 02:17:51 INFO - PROCESS | 14261 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 94.0 94.0 02:17:51 INFO - PROCESS | 14261 | 02:17:51 INFO - PROCESS | 14261 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:55.50 stddev:8.09 (14.6%) stddev-sans-first:8.57 02:17:51 INFO - PROCESS | 14261 | Values: 56.0 54.0 54.0 55.0 56.0 55.0 56.0 80.0 53.0 53.0 02:17:51 INFO - PROCESS | 14261 | 02:17:51 INFO - PROCESS | 14261 | [#9] json-stringify-tinderbox Cycles:10 Average:57.30 Median:57.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 02:17:51 INFO - PROCESS | 14261 | Values: 57.0 57.0 57.0 58.0 58.0 57.0 58.0 57.0 57.0 57.0 02:17:51 INFO - PROCESS | 14261 | 02:17:51 INFO - PROCESS | 14261 | [#10] stanford-crypto-aes Cycles:10 Average:73.70 Median:73.50 stddev:2.95 (4.0%) stddev-sans-first:3.06 02:17:51 INFO - PROCESS | 14261 | Values: 72.0 71.0 71.0 72.0 74.0 73.0 75.0 81.0 73.0 75.0 02:17:51 INFO - PROCESS | 14261 | 02:17:51 INFO - PROCESS | 14261 | [#11] stanford-crypto-ccm Cycles:10 Average:117.30 Median:116.50 stddev:7.23 (6.2%) stddev-sans-first:7.50 02:17:51 INFO - PROCESS | 14261 | Values: 113.0 115.0 119.0 112.0 113.0 118.0 110.0 113.0 131.0 129.0 02:17:51 INFO - PROCESS | 14261 | 02:17:51 INFO - PROCESS | 14261 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.20 Median:160.00 stddev:2.57 (1.6%) stddev-sans-first:2.73 02:17:51 INFO - PROCESS | 14261 | Values: 160.0 164.0 160.0 157.0 161.0 158.0 158.0 160.0 165.0 159.0 02:17:51 INFO - PROCESS | 14261 | 02:17:51 INFO - PROCESS | 14261 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:0.82 (1.2%) stddev-sans-first:0.78 02:17:51 INFO - PROCESS | 14261 | Values: 67.0 67.0 66.0 66.0 66.0 65.0 66.0 67.0 65.0 65.0 02:17:51 INFO - PROCESS | 14261 | -------- Summary: end -------- 02:17:51 INFO - PROCESS | 14261 | 02:17:51 INFO - TEST-INFO | 14261: exit 0 02:17:52 INFO - TEST-OK | kraken | took 59518ms 02:17:52 INFO - SUITE-END | took 1169s 02:17:52 INFO - Completed test suite (00:19:29) 02:17:52 INFO - javascript benchmark 02:17:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3249.0415327478395, 3310.519974603681, 3323.1858194742285, 3331.650176731445, 3354.698077173054, 5336.439673834249, 5351.0, 5357.946420535794, 5367.087595108831, 5383.031054410209, 5361.222622719703, 5366.758495867685, 5372.597055220855, 5379.569634429246, 5388.380336261331, 4758.428988521382, 4851.2238041913215, 4923.80304787808, 4999.275105109757, 5001.524855138774, 4758.191107511731, 4821.614270858323, 4822.204336284509, 4822.7588620569, 4829.275608658694, 4810.807567697288, 4863.392075990501, 4866.58634016109, 4875.951240487585, 4879.536444037811, 4914.090893184754, 4953.157963146274, 4976.2784396262705, 4976.651634385595, 5010.148274793294, 4707.670463067587, 4753.263244197155, 4830.396200474941, 4835.927461088087, 4837.032593481318, 5205.167173252262, 5214.97392513035, 5238.895222095537, 5251.054810134175, 5257.658252213594, 5727.341355744101, 5729.885402291972, 5733.054046082391, 5737.598368114233, 5741.913871291934, 5701.287339082614, 5743.368229494752, 5769.076947688392, 5787.536997040227, 5798.594098413113, 5334.0, 5356.678599284055, 5391.32608423947, 5395.892082158413, 5409.945900540944, 5652.0, 5870.26621672291, 5882.441168089024, 5889.499392551681, 5890.028145356054, 5553.416891226444, 5584.190292407578, 5602.0, 5622.6345287557, 5635.380108188096, 5708.771649134072, 5710.914336284959, 5720.256366672306, 5720.256366672389, 5724.4561766632105, 5581.246531718166, 5663.801766938137, 5677.829665110054, 5702.087665973424, 5707.914381284284, 5707.086866101404, 5713.800016999385, 5720.256366672306, 5721.742521586539, 5751.079827227623, 4393.0994146199955, 4397.0, 4397.252467080604, 4399.472063352418, 4426.800793964215, 3854.807259637007, 3931.331673615492, 3986.621270979252, 3993.121513267077, 4017.5781542938157, 5408.45915408456, 5459.262999495097, 5470.070088085035, 5478.397376288605, 5480.561555075585, 5744.023516002289, 5747.885042299131, 5751.654900705971, 5764.538836893039, 5767.250257466502, 5247.134222853263, 5350.946490535122, 5434.755436005389, 5458.263134476874, 5460.781568737206, 4975.4527002029745, 5027.84916452507, 5028.145215313405, 5030.471800460972, 5053.570446512014, 6021.307549631761, 6024.608400454044, 6040.184575082308, 6064.06007068905, 6067.514598832083, 5616.241807355955, 5796.8550786229, 5860.706964651836, 5868.09044598088, 5881.470667639933, 6027.6986150693165, 6049.032154855202, 6071.150038994456, 6073.605215660968, 6074.088886667036, 5529.723513824212, 5720.570957178312, 5745.339285982165, 5747.3103227612955, 5760.769569217185, 5691.402402747817, 5760.020796464695, 5761.078227483583, 5769.826905192851, 5801.042827933344, 5511.58663100261, 5525.972370138124, 5540.722963851872, 5560.471755183251, 5563.388027317073, 5496.780128794803, 5504.779808807602, 5513.61404701667, 5520.447955204608, 5607.74765135578, 5558.91661625084, 5587.1339942309005, 5599.244102046172, 5600.551955843442, 5628.437156284339, 5640.548756099584, 5642.802501912413, 5674.77300907959, 5684.317881854204, 5693.459121383462, 5366.409694933476, 5471.425500322568, 5509.752061157337, 5569.582281328835, 5627.493525582717], "value": 5303.068233842041, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.1328080923065, 624.5160000999222, 662.7315937045496, 672.398203607771, 672.5157886321847, 28644.0, 29377.706222937763, 29418.852905735494, 29473.263168420774, 29489.852550737243, 29588.260293492673, 29964.40071198575, 41531.377029344585, 42521.149577008444, 42587.57412425875, 8871.334649901235, 9029.593668284942, 9031.954840225822, 9034.232090272335, 9034.638614455447, 7773.0, 8783.604737786814, 8862.158094981, 8897.95551022244, 8908.8663670045, 10804.0, 11163.38601376928, 11163.553457861717, 11163.83254251187, 11170.162237832155, 10279.280450368477, 10322.7419314517, 10323.58705651773, 10328.328658637201, 10332.94833525835, 7716.228377162239, 10215.182785377152, 10449.529771160316, 10560.366378017343, 10567.94716026415, 40758.18483630341, 41364.79317603393, 41449.378259326135, 41493.1701365974, 41499.58500414987, 3726.496922915399, 3780.8298626561595, 3825.61743825618, 3829.463875057494, 4271.402003719481, 31522.211944701336, 32098.037058888272, 32115.83942080298, 32152.356952861046, 33622.49566256508, 4540.091981603659, 4653.906921861544, 4717.740524271164, 4726.550977657117, 4759.190937540627, 341611.0, 342662.9999999975, 342739.0, 342860.0, 345996.9999999975, 68931.3106868935, 69006.65496672485, 69414.30585694179, 69659.0, 69753.25616859618, 74299.62850185715, 74675.62662186763, 74708.62645686846, 74869.62565187139, 75141.24858751343, 17958.102094895203, 18365.173567189508, 18365.90817045933, 18370.448886533424, 18374.632507350045, 13633.522826701017, 13642.386092625855, 13662.521811736542, 13674.794878076837, 13691.0, 15726.9213653931, 18706.25174993012, 18946.24215031411, 21604.783952160276, 21750.129994800347, 7753.147153813076, 7794.5323280602215, 7873.960630196812, 7983.361331093499, 8015.719449819228, 1049.496241803923, 1095.2771171027084, 1109.2013750099916, 1121.0359091181576, 1233.4079641772, 33777.15557111043, 33938.0, 34329.65670343264, 34364.31271374608, 34497.13757156091, 1204.9277043377426, 1210.1226610707167, 1214.0469731260919, 1270.4791035675328, 1276.5914907229596, 17860.0, 18147.364842230458, 18379.0, 18476.445706628823, 18908.81091189098, 370445.0, 373896.0, 374345.0, 374814.0, 375735.0, 61678.383216168164, 63618.0, 63658.68170659117, 63699.36300637027, 63763.6811815938, 1184.4297873614278, 1200.4477940147456, 1201.5974648492852, 1492.731308364483, 1497.0568541818802, 23115.65326520137, 30452.0, 30621.23446913756, 31160.220994474414, 31277.530837037917, 45431.318530222736, 45491.772541137085, 45658.771706141255, 45798.08403831838, 45842.31236531388, 362448.0, 362626.0, 365543.0, 365702.0, 366241.0, 27708.445831083667, 34023.65976340304, 46723.29915051209, 47856.04287914292, 48729.75635121802, 37274.627253727114, 43674.56325436705, 44027.0, 44099.11801763882, 44684.0, 37117.44323835199, 38211.61788382081, 38373.808130959165, 39824.20351592894, 39838.203235935696, 37702.0, 38888.0, 38995.41506877342, 39979.200415990934, 40081.1983760329, 43628.56371436372, 44880.32679509875, 45293.32060019037, 45903.0, 45913.770431147634, 39036.219275614894, 39248.80375598104, 39709.60290397175, 40009.79995100006, 40437.59562404456, 29522.74474180645, 29795.702042979294, 29938.850305748332, 30591.0, 30707.846460768447], "value": 20584.515095669303, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.77340349509524, 420.9473815773026, 425.5297895825111, 426.43923240938165, 433.0645805061069, 13054.673633159176, 18674.15966281517, 19281.03594820257, 19294.517637059063, 19590.510237244074, 12795.744085118315, 18433.90783046083, 18456.0, 18759.906200469013, 18840.623187536243, 5545.528630066449, 5678.403767604404, 5682.801101961432, 5686.573506986972, 5706.1440783882545, 5589.720513974285, 5639.323281206261, 5670.404607516213, 5682.6306290091015, 5683.715814209294, 5340.25236466893, 5630.183623374608, 5676.176954341618, 5677.205191273225, 5678.403767604404, 5637.154426836008, 5655.293088363955, 5661.971690141564, 5677.460641239076, 5686.744096515646, 5426.104692725696, 5510.559155267609, 5512.6692398456225, 5563.36021357545, 5681.460261275172, 13212.207267563977, 17160.57098572533, 19823.107960141682, 20572.38282851502, 21216.787832121634, 2443.549030559325, 2514.53481105996, 2653.5621622432277, 2812.5921741347593, 2852.1586132090874, 9569.952150239274, 9806.65676701312, 9940.80118397628, 9943.602255909755, 10110.545025473872, 2034.1354924157174, 2074.7510298764246, 2075.5226297951554, 2085.09298455171, 2088.081244252524, 81380.59309703413, 81514.59242703748, 84043.15956840475, 84247.0, 84487.5775621118, 10841.67474975752, 11022.228444009002, 11165.771765105832, 11264.831027534594, 11825.290482571074, 16321.918390407973, 16469.91765041191, 16492.34030638761, 16494.505164845075, 16505.83494165043, 8388.916110838936, 8437.240648341678, 8455.492670439793, 8760.561971901507, 8783.912160878437, 8457.788555286044, 8477.872831907527, 8510.446820956742, 8570.0, 8593.656253749905, 5046.142155833444, 5048.0913435581215, 5054.115529782273, 5101.7704203310195, 5152.819651312261, 1777.4045694692422, 1973.2994786850747, 2048.702938073971, 2097.8741275523516, 2111.35603640891, 933.9953300233456, 976.2092704909046, 1017.7659138398062, 1034.6585626743156, 1038.2991480750463, 17472.0, 17947.910260448614, 17970.730439043426, 18193.909030454764, 18643.533911652044, 987.4618333008527, 991.5438898106808, 1005.6580762540772, 1010.6563768318807, 1013.4780587997187, 10133.594656213816, 10222.0, 10292.176625869912, 10345.63790267337, 10388.37669739818, 556294.0, 563134.0, 568941.0, 585494.0, 590532.0, 56227.71886140543, 79562.20437795663, 93069.53465232765, 96308.51845740726, 96928.0, 950.2160717408166, 981.4503877828439, 999.14073896449, 999.1607050077824, 1000.7548150703125, 15861.365545378518, 15865.52403427899, 16057.437989670305, 16100.194990250675, 16201.189940502692, 36384.45423318599, 39453.21093578055, 39922.600773991886, 40197.79901100476, 41445.378319325835, 57170.0, 59440.405595943485, 59585.0, 59903.70048149731, 60282.69858650678, 8511.191436813493, 8568.52873091986, 8715.215630593024, 8835.20483156519, 8982.505962172143, 9089.545522723705, 13214.669633258862, 13906.791398129239, 14189.858101418853, 14854.183019934007, 12202.572909948109, 12578.811317830057, 12607.68480787951, 12680.492780288685, 13236.338183091, 11942.582009629621, 12021.579244726392, 12460.12779105454, 12564.183328084011, 12837.165584236995, 12829.935850321062, 12867.678308042374, 12974.286414247306, 13011.804822927474, 13058.869411305765, 8770.736877893672, 8824.955875220583, 8961.78677368707, 8973.685920992733, 8977.506237157018, 12008.399580020789, 12043.638690839289, 12049.879501204876, 12128.272303661808, 12189.75620487603], "value": 9290.515918260156, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1187.2401662935717, 1518.4457672949372, 1582.604348912772, 1665.1923816948777, 1759.938402155925, 7466.141393739715, 8361.958190209049, 8543.0, 8566.614502347395, 8573.314134869212, 7927.841443171147, 7957.522548647071, 7994.040715114194, 8013.519188848659, 8019.157988411206, 2013.798620137989, 2337.8129749620034, 2358.3396648938237, 2358.433975845802, 2374.9881250593808, 2359.044586942291, 2363.5391098735754, 2365.0, 2365.550545396369, 2371.0989823866907, 2337.848039877411, 2367.029517897662, 2395.784379405853, 2399.1483023526657, 2402.8678422686744, 2003.3589251439473, 2284.6344584866506, 2330.021391015777, 2330.2077293720217, 2374.3114496795993, 2347.9647805282934, 2348.060775689738, 2390.4860455002085, 2391.9162829301067, 2401.7598240176017, 8479.491230526188, 8479.872801907977, 8491.872621910676, 8499.830003399959, 8512.872306915402, 5178.792848286064, 5252.1596544552685, 5255.080360936859, 5272.077386457355, 5280.524752772269, 3440.36353274645, 3458.7405944554257, 3497.930041399183, 3550.822458877046, 3553.662402071825, 1129.717570607348, 1145.164030257908, 1150.683562020451, 1157.1437136518916, 1197.8442802435716, 12148.21036632625, 12187.634370968884, 12234.265944043296, 12238.082143839247, 12290.938545307215, 4587.357769912215, 4676.532346765296, 4677.807159174389, 4730.0, 4730.0, 10341.689749307532, 10354.223433242538, 10356.326838755607, 10357.533910974023, 10363.689089327332, 5090.516400941905, 5172.017316709888, 5174.275601415729, 5174.275601415805, 5191.065608190486, 4086.244044851712, 4784.091022705675, 4861.6353773467135, 4869.220924652039, 4871.025794841046, 4061.939070913939, 4091.7135800494275, 4145.481814773153, 4151.792410379529, 4186.037211441325, 1321.5176460591815, 1321.7752981993085, 1332.3871019331023, 1332.586898061604, 1334.5329134802741, 1048.2714513413105, 1056.6724315462232, 1059.4596755654673, 1077.2943721862193, 1092.082650573522, 5830.679312637761, 5963.254593175853, 5976.820695379146, 6064.848378790565, 6084.665343406155, 937.2829785214317, 991.6231831903974, 1005.2008653120787, 1044.8693913260843, 1083.864516935383, 4081.1837632473625, 4081.8163182656854, 4082.652974497201, 4109.671226301889, 4146.202966696895, 10267.9486602568, 10567.788644227227, 10673.252872298865, 10679.199060070527, 10686.51910664022, 10422.322549034288, 10491.10825579819, 10498.963096219704, 10506.21203409732, 10508.789824203473, 8174.3460523158, 8254.876176857351, 8352.6241319142, 8356.623951922178, 8381.119982401882, 5742.425757424224, 5808.244928159313, 5836.766529338779, 5840.503557197686, 5860.677662728421, 9451.102145296185, 9637.42175469474, 9646.131848133702, 9740.366876153028, 9793.46135962529, 9719.562619682272, 9802.068803463659, 9907.504624768877, 9932.851007234753, 9942.055504727039, 6574.112494813139, 7549.0, 7677.117131529722, 7797.493162944391, 7922.207779222032, 7972.92027079745, 8011.479253848481, 8036.196380361917, 8045.11503734577, 8083.3533317333295, 7259.310365515267, 7473.17795042534, 7483.550986940801, 7565.130010048915, 7654.693812247448, 7249.311315425026, 7274.163471200668, 7327.340539351484, 7329.230430804689, 7380.298871607189, 6660.3672651100005, 6713.959336302881, 6779.15260592426, 6814.557053791487, 6833.214180369321, 4718.622510199107, 4732.171869922819, 5022.372203474566, 5154.561862241751, 5237.397699264633, 5348.224507446476, 5386.542143917811, 5392.299001129828, 5432.2123292123215, 5480.232767412645], "value": 4615.631828927721, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.02952201746064, 339.09461737161774, 341.6941837055835, 346.3039291025039, 350.76148219210944, 6070.423309785563, 6144.2319710036245, 6181.165542651746, 6184.876302473948, 6216.533759968009, 6239.532035097374, 6264.436200741932, 6265.154204182434, 6271.937280627192, 6275.748970041204, 4715.5048719884435, 4744.0511897620445, 4747.8338258160975, 4750.311204875308, 4761.619070474354, 4470.687051906368, 4552.749598772066, 4673.158831410345, 4750.121227572893, 4754.310624959378, 4604.884877878063, 4649.767511624405, 4649.767511624422, 4653.511381304948, 4667.603253723438, 4634.513376095512, 4637.0262244928435, 4650.093231819763, 4655.7439340836245, 4659.767011649438, 4029.8589549365925, 4040.1313717550865, 4042.0703238255073, 4045.02919299366, 4055.3308704063793, 5903.409659034105, 5903.822885313448, 5904.645721256738, 5911.527077833763, 5922.555808314393, 5397.136458166675, 5421.457854214547, 5428.050091234058, 5432.972835135799, 5438.048341540254, 6307.621542707407, 6463.353664633499, 6463.612183269019, 6479.514036447285, 6593.241777195636, 4615.053913947632, 4634.814607415699, 4650.697704649187, 4651.534846515356, 4654.348391225231, 6831.2144103428245, 6879.58722476653, 6919.411849992756, 6921.480888933401, 6922.550034247758, 4746.145693775154, 4757.548032936866, 4761.976190119027, 4770.737609431445, 4772.045590881838, 4816.373871396766, 4820.9517904821205, 4825.9758701206265, 4828.830990915371, 4830.734309612934, 5398.271233383522, 5534.1145416733125, 5535.58483113768, 5542.667439953535, 5542.7782888684005, 6619.470442364599, 6636.30318816527, 6641.701123449457, 6645.435138013227, 6653.0, 1568.3021055630363, 1653.1568899860918, 1686.5277722237793, 1687.6962146813446, 1692.2976964559816, 1087.9401632910108, 1119.457063324287, 1132.0094916947671, 1132.6318946342471, 1137.0846468592863, 6305.747770089145, 6318.462930650854, 6318.873622527615, 6333.619982801047, 6336.651484168415, 6730.259671436138, 6744.325567443217, 6745.696443660047, 6752.189737231465, 6761.29006454325, 6321.905171422432, 6323.36766323364, 6328.46208072319, 6329.841753956188, 6345.96827015862, 3621.7102631789394, 3649.4708267301626, 3655.1227705350525, 3655.1958569114754, 3655.5065066216252, 6880.380765731108, 6953.79138625842, 6961.547499412623, 7038.824029399306, 7049.753258635923, 6850.623215723083, 6875.415589674833, 6885.173779146434, 6885.449164066963, 6894.758683446055, 7005.229424763272, 7010.193827709879, 7011.92988070123, 7021.192562855133, 7023.051887995158, 6679.0649309097735, 6692.6988285526295, 6726.562773419712, 6754.392104710403, 6756.662166891538, 6481.611103333815, 6630.734770609121, 6644.734210631521, 6661.233958094881, 6664.466842652673, 6954.965225173842, 6992.1259842519685, 6999.0551275577145, 7006.544574602634, 7011.6494175292055, 4720.0, 4758.381410416624, 4767.189577771856, 4771.212749896367, 4778.880527986828, 6569.0, 6728.562643428161, 6731.0, 6732.528722989344, 6760.966195168992, 6586.176727909012, 6681.231658359351, 6707.0, 6714.731410743516, 6718.865622687616, 6674.866502670016, 6704.899426508508, 6714.227863795726, 6753.864922701617, 6763.391294783493, 6552.180977377828, 6562.048502967138, 6566.737330506726, 6570.934290657032, 6571.408573228432, 6517.446017088411, 6678.532502724763, 6697.933020669731, 6722.159730033746, 6728.495362847708, 6509.316521765147, 6524.3149469305035, 6528.771492997722, 6542.1168142300185, 6546.116274302908], "value": 4963.1958408981045, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [893.9150780675835, 894.9976026849924, 896.2471523919907, 901.4230892228973, 913.2146354135439, 15128.848711512881, 15166.696666066686, 15318.080915145085, 15341.84658153418, 15469.922650386747, 14699.926500367483, 14804.0, 14815.481458148966, 14820.258987050658, 14826.777598336033, 502.79636747117473, 866.6013633728461, 880.2781718990431, 892.9330300227476, 895.6283142495856, 893.6023469556051, 895.6730793260479, 895.6775560798108, 895.789489469974, 896.0591379052001, 628.1457218183267, 632.3865850125394, 634.8857205702972, 635.3075148088583, 636.8248731598801, 565.1748447266995, 647.090837373491, 903.1871315815786, 919.2737737187614, 920.2453987730064, 674.507609445103, 677.1873751498222, 677.3700458573525, 677.7966610016975, 678.2742465561851, 15184.088954662646, 15674.137922414262, 15690.13704246266, 15707.978981366176, 15709.764353534592, 14676.19280939548, 15238.542843714706, 15376.538703838904, 15460.768088478682, 15474.148921809296, 11900.464479098462, 12064.336461494615, 12121.151519393647, 12333.0, 12434.129610927239, 4037.6366127048705, 4065.10567675111, 4075.4701888754566, 4078.184363127357, 4091.85678501251, 61702.38297617011, 61827.0, 62158.37841621616, 62381.37618623801, 62511.6874415625, 10174.949125254474, 10430.791384172275, 10551.788964220672, 10903.563857445613, 10915.126789856793, 17337.046462444436, 17340.219690113976, 17376.739348909778, 17398.0, 17423.39018134359, 8388.454750441202, 8422.241998220066, 8509.446885952393, 8535.317174626016, 8582.871256931026, 4903.509649035068, 4983.700977941335, 5110.97444512775, 5213.478652134756, 5288.497592728685, 3462.0652423845922, 3511.0, 3516.4197907345515, 3520.2255503789124, 3524.418470952264, 627.8555932135635, 630.7918386932301, 637.3053371824733, 639.4309064932214, 668.8394785251504, 622.1197006236216, 638.5721566550329, 677.3260605697265, 715.4991505945859, 754.1591125894588, 9399.355112855223, 9527.09492598202, 9554.235661147091, 9679.612815487442, 9843.409395436154, 647.3849842649407, 702.2626242445411, 742.1761844352764, 755.0750330844671, 764.873795823694, 4220.873373798791, 4398.56014398564, 4456.086502267028, 4503.7973291201315, 4513.75174365413, 64765.67617161884, 65484.0, 65662.0, 65669.34330656727, 65672.34327656758, 57418.42581574214, 57644.42355576474, 57749.13376299359, 58019.0, 59409.0, 50771.746141269796, 50816.237756433686, 51161.744191278805, 51480.0, 51518.0, 8938.642454301755, 9029.367944244103, 9040.41237319572, 9066.138716821892, 9111.17999380059, 39231.80384098061, 39438.80280598693, 39730.205395892495, 40416.797916011405, 41328.79335603423, 44379.77810110929, 44647.0, 48223.27665085097, 50780.0, 51721.48278517167, 11144.498497567467, 11199.496022679163, 11252.493637786483, 11464.369459679465, 11606.94196529012, 11589.768204635691, 11738.823917641072, 11935.880641193477, 12203.20679155852, 12357.443915023665, 11130.0, 11137.665870023913, 11268.323900565993, 11448.0, 11532.59635912739, 11410.372429516456, 11525.250858694159, 11534.884651153381, 11604.187706860777, 11753.823692644446, 10859.674209773719, 11084.889151108386, 12466.87533124657, 12838.935805320914, 13001.544945926848, 10409.219308552041, 10514.211434142622, 10541.683749487527, 10768.892311077103, 10912.61805836792, 10249.795004100026, 10256.487175641338, 10446.164306855282, 10499.422531760521, 10582.417967011581], "value": 6830.667784452961, "unit": "score"}], "name": "dromaeo_css", "value": 7358.128457381431, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 108.0, 110.0, 112.0, 112.0, 112.0, 105.0, 110.0, 111.0, 109.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 130.0, 153.0, 175.0, 126.0, 161.0, 150.0, 130.0, 188.0, 129.0], "value": 149.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 159.0, 163.0, 160.0, 162.0, 160.0, 159.0, 161.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 184.0, 76.0, 74.0, 86.0, 76.0, 163.0, 77.0], "value": 96.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 148.0, 92.0, 92.0, 92.0, 149.0, 91.0, 92.0, 152.0], "value": 109.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 147.0, 146.0, 145.0, 145.0, 146.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 54.0, 55.0, 56.0, 55.0, 56.0, 80.0, 53.0, 53.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 58.0, 58.0, 57.0, 58.0, 57.0, 57.0, 57.0], "value": 57.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 71.0, 72.0, 74.0, 73.0, 75.0, 81.0, 73.0, 75.0], "value": 73.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 119.0, 112.0, 113.0, 118.0, 110.0, 113.0, 131.0, 129.0], "value": 117.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 164.0, 160.0, 157.0, 161.0, 158.0, 158.0, 160.0, 165.0, 159.0], "value": 160.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 66.0, 66.0, 65.0, 66.0, 67.0, 65.0, 65.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1514.1000000000001, "alertThreshold": 2.0}]} 02:17:52 INFO - Return code: 0 02:17:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:17:52 ERROR - # TBPL SUCCESS # 02:17:52 INFO - Running post-action listener: _resource_record_post_action 02:17:52 INFO - Running post-run listener: _resource_record_post_run 02:17:53 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 274432; Write bytes: 348483584; Read time: 44; Write time: 212784 02:17:53 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107393024; Read time: 0; Write time: 68076 02:17:53 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 274432; Write bytes: 241090560; Read time: 44; Write time: 144708 02:17:53 INFO - Running post-run listener: _upload_blobber_files 02:17:53 INFO - Blob upload gear active. 02:17:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:17:53 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 02:17:53 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'] 02:17:53 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 02:17:53 INFO - (blobuploader) - INFO - Open directory for files ... 02:17:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:17:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:17:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:17:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:17:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:17:54 INFO - (blobuploader) - INFO - Done attempting. 02:17:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:17:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:17:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:17:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:17:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:17:55 INFO - (blobuploader) - INFO - Done attempting. 02:17:55 INFO - (blobuploader) - INFO - Iteration through files over. 02:17:55 INFO - Return code: 0 02:17:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:17:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:17:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea27a3aaef6cae775f12e2655ba4b8832366baea354625df17dffaf9207a8cd57f5c0920673a02a6a989bc9c93d2df5fc43c1c5d4960471ecd4532c8afe64f0f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/42b6fed18bade79ac36ea4ad425d5866961cadb876cfb0944765aee2a9d4ec32660755b8e1b3c8a52877156bf63facc0885e2a55c86a885f54ae143f8a076e0e"} 02:17:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:17:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:17:55 INFO - Contents: 02:17:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea27a3aaef6cae775f12e2655ba4b8832366baea354625df17dffaf9207a8cd57f5c0920673a02a6a989bc9c93d2df5fc43c1c5d4960471ecd4532c8afe64f0f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/42b6fed18bade79ac36ea4ad425d5866961cadb876cfb0944765aee2a9d4ec32660755b8e1b3c8a52877156bf63facc0885e2a55c86a885f54ae143f8a076e0e"} 02:17:55 INFO - Running post-run listener: copy_logs_to_upload_dir 02:17:55 INFO - Copying logs to upload dir... 02:17:55 INFO - mkdir: /builds/slave/test/build/upload/logs 02:17:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.842362 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-27 02:17:55.449759) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 02:17:55.453045) ========= 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=0333a256a5e4f052382dd180000001b1-1464337381.517840-1276900034 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/ea27a3aaef6cae775f12e2655ba4b8832366baea354625df17dffaf9207a8cd57f5c0920673a02a6a989bc9c93d2df5fc43c1c5d4960471ecd4532c8afe64f0f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/42b6fed18bade79ac36ea4ad425d5866961cadb876cfb0944765aee2a9d4ec32660755b8e1b3c8a52877156bf63facc0885e2a55c86a885f54ae143f8a076e0e"} build_url:https://queue.taskcluster.net/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011523 build_url: 'https://queue.taskcluster.net/v1/task/DeshrcsVRlKBAzVvOt_Bjw/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/ea27a3aaef6cae775f12e2655ba4b8832366baea354625df17dffaf9207a8cd57f5c0920673a02a6a989bc9c93d2df5fc43c1c5d4960471ecd4532c8afe64f0f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/42b6fed18bade79ac36ea4ad425d5866961cadb876cfb0944765aee2a9d4ec32660755b8e1b3c8a52877156bf63facc0885e2a55c86a885f54ae143f8a076e0e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 02:17:55.478861) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 02:17:55.479194) ========= 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=0333a256a5e4f052382dd180000001b1-1464337381.517840-1276900034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 02:17:55.563388) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 02:17:55.563742) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 02:17:55.564077) ========= ========= Total master_lag: 0.18 =========