builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-020 starttime: 1464075154.45 results: success (0) buildid: 20160523220203 builduid: ef737131239b46eea1c42de17647cc5f revision: 9b9a73a98de81f22189dd3972c922459bce28393 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 00:32:34.454748) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 00:32:34.455161) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 00:32:34.455438) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 00:32:34.474229) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 00:32:34.474549) ========= 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=af724c981e2a0f424dbabf99000001e7-1464075154.635586-1271058610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-24 00:32:35-- 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% 103M=0s 2016-05-24 00:32:35 (103 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.075452 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 00:32:34.563324) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 00:32:34.563635) ========= 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=af724c981e2a0f424dbabf99000001e7-1464075154.635586-1271058610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019388 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 00:32:34.614043) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-24 00:32:34.614610) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9b9a73a98de81f22189dd3972c922459bce28393 --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 9b9a73a98de81f22189dd3972c922459bce28393 --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=af724c981e2a0f424dbabf99000001e7-1464075154.635586-1271058610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-24 00:32:35,450 truncating revision to first 12 chars 2016-05-24 00:32:35,450 Setting DEBUG logging. 2016-05-24 00:32:35,450 attempt 1/10 2016-05-24 00:32:35,450 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9b9a73a98de8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-24 00:32:36,889 unpacking tar archive at: mozilla-aurora-9b9a73a98de8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.723306 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-24 00:32:36.352846) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 00:32:36.353170) ========= script_repo_revision: 9b9a73a98de81f22189dd3972c922459bce28393 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 00:32:36.353546) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 00:32:36.353825) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 00:32:36.364059) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-05-24 00:32:36.364377) ========= /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=af724c981e2a0f424dbabf99000001e7-1464075154.635586-1271058610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:32:37 INFO - MultiFileLogger online at 20160524 00:32:37 in /builds/slave/test 00:32:37 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 00:32:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:32:37 INFO - {'append_to_log': False, 00:32:37 INFO - 'base_work_dir': '/builds/slave/test', 00:32:37 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 00:32:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:32:37 INFO - 'branch': 'Mozilla-Aurora', 00:32:37 INFO - 'buildbot_json_path': 'buildprops.json', 00:32:37 INFO - 'config_files': ('talos/linux_config.py',), 00:32:37 INFO - 'default_actions': ('clobber', 00:32:37 INFO - 'read-buildbot-config', 00:32:37 INFO - 'download-and-extract', 00:32:37 INFO - 'populate-webroot', 00:32:37 INFO - 'create-virtualenv', 00:32:37 INFO - 'install', 00:32:37 INFO - 'run-tests'), 00:32:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:32:37 INFO - 'download_minidump_stackwalk': True, 00:32:37 INFO - 'download_symbols': 'ondemand', 00:32:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:32:37 INFO - 'tooltool.py': '/tools/tooltool.py', 00:32:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:32:37 INFO - '/tools/misc-python/virtualenv.py')}, 00:32:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:32:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:32:37 INFO - 'installer_path': 'installer.exe', 00:32:37 INFO - 'log_level': 'info', 00:32:37 INFO - 'log_name': 'talos', 00:32:37 INFO - 'log_to_console': True, 00:32:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:32:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:32:37 INFO - 'opt_config_files': (), 00:32:37 INFO - 'pip_index': False, 00:32:37 INFO - 'sps_profile': False, 00:32:37 INFO - 'sps_profile_interval': 0, 00:32:37 INFO - 'suite': 'dromaeojs', 00:32:37 INFO - 'system_bits': '32', 00:32:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:32:37 INFO - 'title': 'talos-linux64-ix-020', 00:32:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:32:37 INFO - 'use_talos_json': True, 00:32:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:32:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:32:37 INFO - 'work_dir': 'build'} 00:32:37 INFO - ##### 00:32:37 INFO - ##### Running clobber step. 00:32:37 INFO - ##### 00:32:37 INFO - Running pre-action listener: _resource_record_pre_action 00:32:37 INFO - Running main action method: clobber 00:32:37 INFO - rmtree: /builds/slave/test/build 00:32:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:32:38 INFO - Running post-action listener: _resource_record_post_action 00:32:38 INFO - ##### 00:32:38 INFO - ##### Running read-buildbot-config step. 00:32:38 INFO - ##### 00:32:38 INFO - Running pre-action listener: _resource_record_pre_action 00:32:38 INFO - Running main action method: read_buildbot_config 00:32:38 INFO - Using buildbot properties: 00:32:38 INFO - { 00:32:38 INFO - "project": "", 00:32:38 INFO - "product": "firefox", 00:32:38 INFO - "script_repo_revision": "production", 00:32:38 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 00:32:38 INFO - "repository": "", 00:32:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 00:32:38 INFO - "buildid": "20160523220203", 00:32:38 INFO - "pgo_build": "True", 00:32:38 INFO - "basedir": "/builds/slave/test", 00:32:38 INFO - "buildnumber": 515, 00:32:38 INFO - "slavename": "talos-linux64-ix-020", 00:32:38 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 00:32:38 INFO - "platform": "ubuntu64_hw", 00:32:38 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 00:32:38 INFO - "branch": "mozilla-aurora", 00:32:38 INFO - "repo_path": "releases/mozilla-aurora", 00:32:38 INFO - "revision": "9b9a73a98de81f22189dd3972c922459bce28393", 00:32:38 INFO - "stage_platform": "linux64-pgo", 00:32:38 INFO - "builduid": "ef737131239b46eea1c42de17647cc5f", 00:32:38 INFO - "slavebuilddir": "test" 00:32:38 INFO - } 00:32:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/dUdz_rolRl2DIdohw8QTuA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 00:32:38 INFO - Running post-action listener: _resource_record_post_action 00:32:38 INFO - ##### 00:32:38 INFO - ##### Running download-and-extract step. 00:32:38 INFO - ##### 00:32:38 INFO - Running pre-action listener: _resource_record_pre_action 00:32:38 INFO - Running main action method: download_and_extract 00:32:38 INFO - mkdir: /builds/slave/test/build/tests 00:32:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:32:38 INFO - https://queue.taskcluster.net/v1/task/dUdz_rolRl2DIdohw8QTuA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 00:32:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUdz_rolRl2DIdohw8QTuA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 00:32:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUdz_rolRl2DIdohw8QTuA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 00:32:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUdz_rolRl2DIdohw8QTuA/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 00:32:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUdz_rolRl2DIdohw8QTuA/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 00:32:39 INFO - Downloaded 1361 bytes. 00:32:39 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 00:32:39 INFO - Using the following test package requirements: 00:32:39 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 00:32:39 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 00:32:39 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 00:32:39 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 00:32:39 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 00:32:39 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 00:32:39 INFO - u'jsshell-linux-x86_64.zip'], 00:32:39 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 00:32:39 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 00:32:39 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 00:32:39 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 00:32:39 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 00:32:39 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 00:32:39 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 00:32:39 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 00:32:39 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 00:32:39 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 00:32:39 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 00:32:39 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:32:39 INFO - https://queue.taskcluster.net/v1/task/dUdz_rolRl2DIdohw8QTuA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:32:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUdz_rolRl2DIdohw8QTuA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 00:32:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUdz_rolRl2DIdohw8QTuA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 00:32:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUdz_rolRl2DIdohw8QTuA/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 00:32:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUdz_rolRl2DIdohw8QTuA/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 00:32:41 INFO - Downloaded 23812944 bytes. 00:32:41 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'] 00:32:41 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 00:32:42 INFO - Return code: 0 00:32:42 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 00:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:32:42 INFO - https://queue.taskcluster.net/v1/task/dUdz_rolRl2DIdohw8QTuA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:32:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUdz_rolRl2DIdohw8QTuA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 00:32:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUdz_rolRl2DIdohw8QTuA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 00:32:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUdz_rolRl2DIdohw8QTuA/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 00:32:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUdz_rolRl2DIdohw8QTuA/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 00:32:43 INFO - Downloaded 23812944 bytes. 00:32:43 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'] 00:32:43 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 00:32:45 INFO - Return code: 0 00:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:32:45 INFO - https://queue.taskcluster.net/v1/task/dUdz_rolRl2DIdohw8QTuA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:32:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUdz_rolRl2DIdohw8QTuA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 00:32:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUdz_rolRl2DIdohw8QTuA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 00:32:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUdz_rolRl2DIdohw8QTuA/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 00:32:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUdz_rolRl2DIdohw8QTuA/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 00:32:45 INFO - Downloaded 10840145 bytes. 00:32:45 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'] 00:32:45 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 00:32:46 INFO - Return code: 0 00:32: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')]} 00:32:46 INFO - https://queue.taskcluster.net/v1/task/dUdz_rolRl2DIdohw8QTuA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:32:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUdz_rolRl2DIdohw8QTuA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 00:32:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUdz_rolRl2DIdohw8QTuA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 00:32:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUdz_rolRl2DIdohw8QTuA/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 00:32:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUdz_rolRl2DIdohw8QTuA/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 00:32:48 INFO - Downloaded 62732471 bytes. 00:32:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dUdz_rolRl2DIdohw8QTuA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 00:32:48 INFO - mkdir: /builds/slave/test/properties 00:32:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:32:48 INFO - Writing to file /builds/slave/test/properties/build_url 00:32:48 INFO - Contents: 00:32:48 INFO - build_url:https://queue.taskcluster.net/v1/task/dUdz_rolRl2DIdohw8QTuA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 00:32:48 INFO - Running post-action listener: _resource_record_post_action 00:32:48 INFO - Running post-action listener: set_extra_try_arguments 00:32:48 INFO - ##### 00:32:48 INFO - ##### Running populate-webroot step. 00:32:48 INFO - ##### 00:32:48 INFO - Running pre-action listener: _resource_record_pre_action 00:32:48 INFO - Running main action method: populate_webroot 00:32:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:32:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:32:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:32:48 INFO - '--tppagecycles', 00:32:48 INFO - '7'], 00:32:48 INFO - 'tests': ['tsvgm']}}, 00:32:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:32:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:32:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:32:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:32:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:32:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:32:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:32:48 INFO - 'talos_options': ['--disable-e10s'], 00:32:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:32:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:32:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:32:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:32:48 INFO - 'talos_options': ['--disable-e10s'], 00:32:48 INFO - 'tests': ['damp', 'tps']}, 00:32:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:32:48 INFO - 'tests': ['damp', 'tps']}, 00:32:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:32:48 INFO - 'tests': ['dromaeo_dom']}, 00:32:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:32:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:32:48 INFO - 'tests': ['a11yr', 00:32:48 INFO - 'ts_paint', 00:32:48 INFO - 'tpaint', 00:32:48 INFO - 'sessionrestore', 00:32:48 INFO - 'sessionrestore_no_auto_restore', 00:32:48 INFO - 'tabpaint']}, 00:32:48 INFO - 'other-e10s': {'tests': ['a11yr', 00:32:48 INFO - 'ts_paint', 00:32:48 INFO - 'tpaint', 00:32:48 INFO - 'sessionrestore', 00:32:48 INFO - 'sessionrestore_no_auto_restore', 00:32:48 INFO - 'tabpaint']}, 00:32:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:32:48 INFO - 'ts_paint', 00:32:48 INFO - 'tpaint', 00:32:48 INFO - 'sessionrestore', 00:32:48 INFO - 'sessionrestore_no_auto_restore', 00:32:48 INFO - 'tabpaint']}, 00:32:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:32:48 INFO - 'ts_paint', 00:32:48 INFO - 'tpaint', 00:32:48 INFO - 'sessionrestore', 00:32:48 INFO - 'sessionrestore_no_auto_restore', 00:32:48 INFO - 'tabpaint']}, 00:32:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:32:48 INFO - 'tests': ['a11yr', 00:32:48 INFO - 'ts_paint', 00:32:48 INFO - 'tpaint', 00:32:48 INFO - 'sessionrestore', 00:32:48 INFO - 'sessionrestore_no_auto_restore', 00:32:48 INFO - 'tabpaint']}, 00:32:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:32:48 INFO - 'tests': ['a11yr', 00:32:48 INFO - 'ts_paint', 00:32:48 INFO - 'tpaint', 00:32:48 INFO - 'sessionrestore', 00:32:48 INFO - 'sessionrestore_no_auto_restore', 00:32:48 INFO - 'tabpaint']}, 00:32:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:32:48 INFO - 'tests': ['tsvgx', 00:32:48 INFO - 'tsvgr_opacity', 00:32:48 INFO - 'tart', 00:32:48 INFO - 'tscrollx', 00:32:48 INFO - 'cart']}, 00:32:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:32:48 INFO - 'tsvgr_opacity', 00:32:48 INFO - 'tart', 00:32:48 INFO - 'tscrollx', 00:32:48 INFO - 'cart']}, 00:32:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:32:48 INFO - 'talos_options': ['--disable-e10s'], 00:32:48 INFO - 'tests': ['tp5o']}, 00:32:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:32:48 INFO - 'tests': ['tp5o']}, 00:32:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:32:48 INFO - 'talos_options': ['--disable-e10s', 00:32:48 INFO - '--xperf_path', 00:32:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:32:48 INFO - 'tests': ['tp5n']}, 00:32:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:32:48 INFO - 'talos_options': ['--xperf_path', 00:32:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:32:48 INFO - 'tests': ['tp5n']}}, 00:32:48 INFO - 'talos.zip': {'path': '', 00:32:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:32:48 INFO - Running post-action listener: _resource_record_post_action 00:32:48 INFO - ##### 00:32:48 INFO - ##### Running create-virtualenv step. 00:32:48 INFO - ##### 00:32:48 INFO - Running pre-action listener: _resource_record_pre_action 00:32:48 INFO - Running main action method: create_virtualenv 00:32:48 INFO - Creating virtualenv /builds/slave/test/build/venv 00:32:48 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 00:32:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:32:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:32:48 INFO - Using real prefix '/usr' 00:32:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:32:49 INFO - Installing distribute.............................................................................................................................................................................................done. 00:32:51 INFO - Installing pip.................done. 00:32:51 INFO - Return code: 0 00:32:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:32:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:32:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:32:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:32:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2c42522f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f2c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbb410>, '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 0x1fbc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbc7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1464075154.635586-1271058610', '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 00:32:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:32:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:32:51 INFO - Using env: {'DISPLAY': ':0', 00:32:51 INFO - 'HOME': '/home/cltbld', 00:32:51 INFO - 'LANG': 'en_US.UTF-8', 00:32:51 INFO - 'LANGUAGE': 'en_US:en', 00:32:51 INFO - 'LOGNAME': 'cltbld', 00:32:51 INFO - 'MAIL': '/var/mail/cltbld', 00:32:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:32:51 INFO - 'MOZ_NO_REMOTE': '1', 00:32:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:32:51 INFO - 'NO_EM_RESTART': '1', 00:32:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:32:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:32:51 INFO - 'PWD': '/builds/slave/test', 00:32:51 INFO - 'SHELL': '/bin/bash', 00:32:51 INFO - 'SHLVL': '1', 00:32:51 INFO - 'TERM': 'linux', 00:32:51 INFO - 'TMOUT': '86400', 00:32:51 INFO - 'USER': 'cltbld', 00:32:51 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1464075154.635586-1271058610', 00:32:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:32:51 INFO - '_': '/tools/buildbot/bin/python'} 00:32:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 00:32:51 INFO - Cleaning up... 00:32:51 INFO - Return code: 0 00:32:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 00:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:32:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:32:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:32:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:32:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2c42522f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f2c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbb410>, '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 0x1fbc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbc7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1464075154.635586-1271058610', '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 00:32:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 00:32:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 00:32:51 INFO - Using env: {'DISPLAY': ':0', 00:32:51 INFO - 'HOME': '/home/cltbld', 00:32:51 INFO - 'LANG': 'en_US.UTF-8', 00:32:51 INFO - 'LANGUAGE': 'en_US:en', 00:32:51 INFO - 'LOGNAME': 'cltbld', 00:32:51 INFO - 'MAIL': '/var/mail/cltbld', 00:32:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:32:51 INFO - 'MOZ_NO_REMOTE': '1', 00:32:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:32:51 INFO - 'NO_EM_RESTART': '1', 00:32:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:32:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:32:51 INFO - 'PWD': '/builds/slave/test', 00:32:51 INFO - 'SHELL': '/bin/bash', 00:32:51 INFO - 'SHLVL': '1', 00:32:51 INFO - 'TERM': 'linux', 00:32:51 INFO - 'TMOUT': '86400', 00:32:51 INFO - 'USER': 'cltbld', 00:32:51 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1464075154.635586-1271058610', 00:32:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:32:51 INFO - '_': '/tools/buildbot/bin/python'} 00:32:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:32:51 INFO - Downloading/unpacking psutil>=0.7.1 00:32: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 00:32: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 00:32: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 00:32: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 00:32: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 00:32: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 00:32:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:32:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:32:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:32:53 INFO - Installing collected packages: psutil 00:32:53 INFO - Running setup.py install for psutil 00:32:53 INFO - building 'psutil._psutil_linux' extension 00:32:53 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 00:32:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 00:32:54 INFO - building 'psutil._psutil_posix' extension 00:32:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 00:32:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 00:32:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:32:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:32:54 INFO - Successfully installed psutil 00:32:54 INFO - Cleaning up... 00:32:54 INFO - Return code: 0 00:32:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 00:32:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:32:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:32:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:32:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:32:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:32:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2c42522f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f2c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbb410>, '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 0x1fbc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbc7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1464075154.635586-1271058610', '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 00:32:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 00:32:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 00:32:54 INFO - Using env: {'DISPLAY': ':0', 00:32:54 INFO - 'HOME': '/home/cltbld', 00:32:54 INFO - 'LANG': 'en_US.UTF-8', 00:32:54 INFO - 'LANGUAGE': 'en_US:en', 00:32:54 INFO - 'LOGNAME': 'cltbld', 00:32:54 INFO - 'MAIL': '/var/mail/cltbld', 00:32:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:32:54 INFO - 'MOZ_NO_REMOTE': '1', 00:32:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:32:54 INFO - 'NO_EM_RESTART': '1', 00:32:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:32:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:32:54 INFO - 'PWD': '/builds/slave/test', 00:32:54 INFO - 'SHELL': '/bin/bash', 00:32:54 INFO - 'SHLVL': '1', 00:32:54 INFO - 'TERM': 'linux', 00:32:54 INFO - 'TMOUT': '86400', 00:32:54 INFO - 'USER': 'cltbld', 00:32:54 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1464075154.635586-1271058610', 00:32:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:32:54 INFO - '_': '/tools/buildbot/bin/python'} 00:32:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:32:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:32:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:32:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:32:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:32:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:32:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:32:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:32:56 INFO - Installing collected packages: mozsystemmonitor 00:32:56 INFO - Running setup.py install for mozsystemmonitor 00:32:56 INFO - Successfully installed mozsystemmonitor 00:32:56 INFO - Cleaning up... 00:32:56 INFO - Return code: 0 00:32:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:32:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:32:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:32:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:32:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2c42522f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f2c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbb410>, '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 0x1fbc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbc7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1464075154.635586-1271058610', '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 00:32:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:32:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:32:56 INFO - Using env: {'DISPLAY': ':0', 00:32:56 INFO - 'HOME': '/home/cltbld', 00:32:56 INFO - 'LANG': 'en_US.UTF-8', 00:32:56 INFO - 'LANGUAGE': 'en_US:en', 00:32:56 INFO - 'LOGNAME': 'cltbld', 00:32:56 INFO - 'MAIL': '/var/mail/cltbld', 00:32:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:32:56 INFO - 'MOZ_NO_REMOTE': '1', 00:32:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:32:56 INFO - 'NO_EM_RESTART': '1', 00:32:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:32:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:32:56 INFO - 'PWD': '/builds/slave/test', 00:32:56 INFO - 'SHELL': '/bin/bash', 00:32:56 INFO - 'SHLVL': '1', 00:32:56 INFO - 'TERM': 'linux', 00:32:56 INFO - 'TMOUT': '86400', 00:32:56 INFO - 'USER': 'cltbld', 00:32:56 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1464075154.635586-1271058610', 00:32:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:32:56 INFO - '_': '/tools/buildbot/bin/python'} 00:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:32:56 INFO - Downloading/unpacking blobuploader==1.2.4 00:32: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 00:32: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 00:32: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 00:32: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 00:32: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 00:32: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 00:32:58 INFO - Downloading blobuploader-1.2.4.tar.gz 00:32:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:32:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:32:58 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 00:32:58 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 00:32:58 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 00:32:58 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 00:32:58 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 00:32:58 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 00:32:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:32:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:32: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 00:32: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 00:32: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 00:32: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 00:32: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 00:32: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 00:32:59 INFO - Downloading docopt-0.6.1.tar.gz 00:32:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:32:59 INFO - Installing collected packages: blobuploader, requests, docopt 00:32:59 INFO - Running setup.py install for blobuploader 00:32:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:32:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:32:59 INFO - Running setup.py install for requests 00:33:00 INFO - Running setup.py install for docopt 00:33:00 INFO - Successfully installed blobuploader requests docopt 00:33:00 INFO - Cleaning up... 00:33:00 INFO - Return code: 0 00:33:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:33:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2c42522f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f2c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbb410>, '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 0x1fbc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbc7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1464075154.635586-1271058610', '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 00:33:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 00:33:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:33:00 INFO - Using env: {'DISPLAY': ':0', 00:33:00 INFO - 'HOME': '/home/cltbld', 00:33:00 INFO - 'LANG': 'en_US.UTF-8', 00:33:00 INFO - 'LANGUAGE': 'en_US:en', 00:33:00 INFO - 'LOGNAME': 'cltbld', 00:33:00 INFO - 'MAIL': '/var/mail/cltbld', 00:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:33:00 INFO - 'MOZ_NO_REMOTE': '1', 00:33:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:33:00 INFO - 'NO_EM_RESTART': '1', 00:33:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:33:00 INFO - 'PWD': '/builds/slave/test', 00:33:00 INFO - 'SHELL': '/bin/bash', 00:33:00 INFO - 'SHLVL': '1', 00:33:00 INFO - 'TERM': 'linux', 00:33:00 INFO - 'TMOUT': '86400', 00:33:00 INFO - 'USER': 'cltbld', 00:33:00 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1464075154.635586-1271058610', 00:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:33:00 INFO - '_': '/tools/buildbot/bin/python'} 00:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:33:00 INFO - Running setup.py (path:/tmp/pip-rPLvRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:33:00 INFO - Running setup.py (path:/tmp/pip-K3Bkb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:33:00 INFO - Running setup.py (path:/tmp/pip-KyEOYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:33:00 INFO - Running setup.py (path:/tmp/pip-rPay8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:33:00 INFO - Running setup.py (path:/tmp/pip-YMSnsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:33:00 INFO - Running setup.py (path:/tmp/pip-HnHSEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:33:00 INFO - Running setup.py (path:/tmp/pip-ETPQTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:33:00 INFO - Running setup.py (path:/tmp/pip-iuN0Gc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:33:00 INFO - Running setup.py (path:/tmp/pip-lc15vM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:33:01 INFO - Running setup.py (path:/tmp/pip-RzuiPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:33:01 INFO - Running setup.py (path:/tmp/pip-hwDnEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:33:01 INFO - Running setup.py (path:/tmp/pip-PntbyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:33:01 INFO - Running setup.py (path:/tmp/pip-V4YUav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:33:01 INFO - Running setup.py (path:/tmp/pip-Gsqvf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:33:01 INFO - Running setup.py (path:/tmp/pip-DBlEb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:33:01 INFO - Running setup.py (path:/tmp/pip-8ZT4Vi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:33:01 INFO - Running setup.py (path:/tmp/pip-JZ9ZPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:33:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:33:01 INFO - Running setup.py install for manifestparser 00:33:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:33:01 INFO - Running setup.py install for mozcrash 00:33:01 INFO - Running setup.py install for mozdebug 00:33:01 INFO - Running setup.py install for mozdevice 00:33:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:33:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:33:02 INFO - Running setup.py install for mozfile 00:33:02 INFO - Running setup.py install for mozhttpd 00:33:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:33:02 INFO - Running setup.py install for mozinfo 00:33:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:33:02 INFO - Running setup.py install for mozInstall 00:33:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:33:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:33:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:33:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:33:02 INFO - Running setup.py install for mozleak 00:33:02 INFO - Running setup.py install for mozlog 00:33:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:33:02 INFO - Running setup.py install for moznetwork 00:33:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:33:02 INFO - Running setup.py install for mozprocess 00:33:02 INFO - Running setup.py install for mozprofile 00:33:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:33:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:33:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:33:02 INFO - Running setup.py install for mozrunner 00:33:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:33:03 INFO - Running setup.py install for mozscreenshot 00:33:03 INFO - Running setup.py install for moztest 00:33:03 INFO - Running setup.py install for mozversion 00:33:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:33:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:33:03 INFO - Cleaning up... 00:33:03 INFO - Return code: 0 00:33:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:33:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:33:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:33:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:33:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:33:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:33:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2c42522f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f2c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbb410>, '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 0x1fbc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbc7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1464075154.635586-1271058610', '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 00:33:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 00:33:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:33:03 INFO - Using env: {'DISPLAY': ':0', 00:33:03 INFO - 'HOME': '/home/cltbld', 00:33:03 INFO - 'LANG': 'en_US.UTF-8', 00:33:03 INFO - 'LANGUAGE': 'en_US:en', 00:33:03 INFO - 'LOGNAME': 'cltbld', 00:33:03 INFO - 'MAIL': '/var/mail/cltbld', 00:33:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:33:03 INFO - 'MOZ_NO_REMOTE': '1', 00:33:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:33:03 INFO - 'NO_EM_RESTART': '1', 00:33:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:33:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:33:03 INFO - 'PWD': '/builds/slave/test', 00:33:03 INFO - 'SHELL': '/bin/bash', 00:33:03 INFO - 'SHLVL': '1', 00:33:03 INFO - 'TERM': 'linux', 00:33:03 INFO - 'TMOUT': '86400', 00:33:03 INFO - 'USER': 'cltbld', 00:33:03 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1464075154.635586-1271058610', 00:33:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:33:03 INFO - '_': '/tools/buildbot/bin/python'} 00:33:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:33:03 INFO - Running setup.py (path:/tmp/pip-hg7cny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:33:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 00:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:33:03 INFO - Running setup.py (path:/tmp/pip-Qmr9MB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:33:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:33:03 INFO - Running setup.py (path:/tmp/pip-nld3_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:33:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 00:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:33:03 INFO - Running setup.py (path:/tmp/pip-m2KSz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:33:03 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)) 00:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:33:03 INFO - Running setup.py (path:/tmp/pip-ucUl_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:33:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 00:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:33:04 INFO - Running setup.py (path:/tmp/pip-O3imps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:33:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 00:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:33:04 INFO - Running setup.py (path:/tmp/pip-nWQow9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:33:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 00:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:33:04 INFO - Running setup.py (path:/tmp/pip-hWXRET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:33:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 00:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:33:04 INFO - Running setup.py (path:/tmp/pip-gkUGCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:33:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 00:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:33:04 INFO - Running setup.py (path:/tmp/pip-uV7mGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:33:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:33:04 INFO - Running setup.py (path:/tmp/pip-_sPunB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:33:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 00:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:33:04 INFO - Running setup.py (path:/tmp/pip-ljQWgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:33:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 00:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:33:04 INFO - Running setup.py (path:/tmp/pip-nleWYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:33:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 00:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:33:04 INFO - Running setup.py (path:/tmp/pip-oeWatw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:33:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 00:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:33:04 INFO - Running setup.py (path:/tmp/pip-bn3uxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:33:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 00:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:33:04 INFO - Running setup.py (path:/tmp/pip-x39bIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:33:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 00:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:33:04 INFO - Running setup.py (path:/tmp/pip-_i5zgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:33:04 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)) 00:33:04 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)) 00:33:04 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)) 00:33:04 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)) 00:33:04 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)) 00:33:04 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)) 00:33:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:33: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 00:33: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 00:33: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 00:33: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 00:33: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 00:33: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 00:33:06 INFO - Downloading blessings-1.6.tar.gz 00:33:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:33:06 INFO - Installing collected packages: blessings 00:33:06 INFO - Running setup.py install for blessings 00:33:06 INFO - Successfully installed blessings 00:33:06 INFO - Cleaning up... 00:33:07 INFO - Return code: 0 00:33:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:33:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:33:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:33:07 INFO - Reading from file tmpfile_stdout 00:33:07 INFO - Current package versions: 00:33:07 INFO - argparse == 1.2.1 00:33:07 INFO - blessings == 1.6 00:33:07 INFO - blobuploader == 1.2.4 00:33:07 INFO - docopt == 0.6.1 00:33:07 INFO - manifestparser == 1.1 00:33:07 INFO - mozInstall == 1.12 00:33:07 INFO - mozcrash == 0.17 00:33:07 INFO - mozdebug == 0.1 00:33:07 INFO - mozdevice == 0.48 00:33:07 INFO - mozfile == 1.2 00:33:07 INFO - mozhttpd == 0.7 00:33:07 INFO - mozinfo == 0.9 00:33:07 INFO - mozleak == 0.1 00:33:07 INFO - mozlog == 3.1 00:33:07 INFO - moznetwork == 0.27 00:33:07 INFO - mozprocess == 0.22 00:33:07 INFO - mozprofile == 0.28 00:33:07 INFO - mozrunner == 6.11 00:33:07 INFO - mozscreenshot == 0.1 00:33:07 INFO - mozsystemmonitor == 0.0 00:33:07 INFO - moztest == 0.7 00:33:07 INFO - mozversion == 1.4 00:33:07 INFO - psutil == 3.1.1 00:33:07 INFO - requests == 1.2.3 00:33:07 INFO - wsgiref == 0.1.2 00:33:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:33:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:33:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:33:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:33:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2c42522f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f2c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbb410>, '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 0x1fbc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbc7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1464075154.635586-1271058610', '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 00:33:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 00:33:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:33:07 INFO - Using env: {'DISPLAY': ':0', 00:33:07 INFO - 'HOME': '/home/cltbld', 00:33:07 INFO - 'LANG': 'en_US.UTF-8', 00:33:07 INFO - 'LANGUAGE': 'en_US:en', 00:33:07 INFO - 'LOGNAME': 'cltbld', 00:33:07 INFO - 'MAIL': '/var/mail/cltbld', 00:33:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:33:07 INFO - 'MOZ_NO_REMOTE': '1', 00:33:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:33:07 INFO - 'NO_EM_RESTART': '1', 00:33:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:33:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:33:07 INFO - 'PWD': '/builds/slave/test', 00:33:07 INFO - 'SHELL': '/bin/bash', 00:33:07 INFO - 'SHLVL': '1', 00:33:07 INFO - 'TERM': 'linux', 00:33:07 INFO - 'TMOUT': '86400', 00:33:07 INFO - 'USER': 'cltbld', 00:33:07 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1464075154.635586-1271058610', 00:33:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:33:07 INFO - '_': '/tools/buildbot/bin/python'} 00:33:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 00:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 00:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 00:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 00:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 00:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 00:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 00:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 00:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 00:33:07 INFO - Cleaning up... 00:33:07 INFO - Return code: 0 00:33:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:33:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:33:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:33:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:33:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2c42522f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f2c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbb410>, '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 0x1fbc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbc7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1464075154.635586-1271058610', '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 00:33:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:33:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:33:07 INFO - Using env: {'DISPLAY': ':0', 00:33:07 INFO - 'HOME': '/home/cltbld', 00:33:07 INFO - 'LANG': 'en_US.UTF-8', 00:33:07 INFO - 'LANGUAGE': 'en_US:en', 00:33:07 INFO - 'LOGNAME': 'cltbld', 00:33:07 INFO - 'MAIL': '/var/mail/cltbld', 00:33:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:33:07 INFO - 'MOZ_NO_REMOTE': '1', 00:33:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:33:07 INFO - 'NO_EM_RESTART': '1', 00:33:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:33:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:33:07 INFO - 'PWD': '/builds/slave/test', 00:33:07 INFO - 'SHELL': '/bin/bash', 00:33:07 INFO - 'SHLVL': '1', 00:33:07 INFO - 'TERM': 'linux', 00:33:07 INFO - 'TMOUT': '86400', 00:33:07 INFO - 'USER': 'cltbld', 00:33:07 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1464075154.635586-1271058610', 00:33:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:33:07 INFO - '_': '/tools/buildbot/bin/python'} 00:33:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:33:07 INFO - Downloading/unpacking jsonschema 00:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:33:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:33:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:33:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:33:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:33:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:33:09 INFO - Downloading/unpacking functools32 (from jsonschema) 00:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:33:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:33:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:33:09 INFO - Downloading functools32-3.2.3-2.tar.gz 00:33:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:33:09 INFO - warning: no files found matching '*.txt' 00:33:09 INFO - no previously-included directories found matching 'build' 00:33:09 INFO - no previously-included directories found matching 'dist' 00:33:09 INFO - no previously-included directories found matching '.git*' 00:33:09 INFO - Installing collected packages: jsonschema, functools32 00:33:09 INFO - Running setup.py install for functools32 00:33:10 INFO - warning: no files found matching '*.txt' 00:33:10 INFO - no previously-included directories found matching 'build' 00:33:10 INFO - no previously-included directories found matching 'dist' 00:33:10 INFO - no previously-included directories found matching '.git*' 00:33:10 INFO - Successfully installed jsonschema functools32 00:33:10 INFO - Cleaning up... 00:33:10 INFO - Return code: 0 00:33:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 00:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:33:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:33:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:33:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:33:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2c42522f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f2c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbb410>, '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 0x1fbc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbc7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1464075154.635586-1271058610', '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 00:33:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 00:33:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 00:33:10 INFO - Using env: {'DISPLAY': ':0', 00:33:10 INFO - 'HOME': '/home/cltbld', 00:33:10 INFO - 'LANG': 'en_US.UTF-8', 00:33:10 INFO - 'LANGUAGE': 'en_US:en', 00:33:10 INFO - 'LOGNAME': 'cltbld', 00:33:10 INFO - 'MAIL': '/var/mail/cltbld', 00:33:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:33:10 INFO - 'MOZ_NO_REMOTE': '1', 00:33:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:33:10 INFO - 'NO_EM_RESTART': '1', 00:33:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:33:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:33:10 INFO - 'PWD': '/builds/slave/test', 00:33:10 INFO - 'SHELL': '/bin/bash', 00:33:10 INFO - 'SHLVL': '1', 00:33:10 INFO - 'TERM': 'linux', 00:33:10 INFO - 'TMOUT': '86400', 00:33:10 INFO - 'USER': 'cltbld', 00:33:10 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1464075154.635586-1271058610', 00:33:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:33:10 INFO - '_': '/tools/buildbot/bin/python'} 00:33:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:33:10 INFO - Downloading/unpacking flake8 00:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:33:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:33:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:33:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:33:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:33:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:33:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:33:12 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 00:33:12 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 00:33:12 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 00:33:12 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 00:33:12 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 00:33:12 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 00:33:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:33:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:33:12 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 00:33:12 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 00:33:12 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 00:33:12 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 00:33:12 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 00:33:12 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 00:33:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:33:12 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 00:33:12 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 00:33:12 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 00:33:12 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 00:33:12 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 00:33:12 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 00:33:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 00:33:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:33:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:33:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:33:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:33:13 INFO - no previously-included directories found matching 'docs/_build' 00:33:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:33:13 INFO - Running setup.py install for pep8 00:33:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:33:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:33:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:33:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:33:13 INFO - no previously-included directories found matching 'docs/_build' 00:33:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 00:33:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:33:13 INFO - Cleaning up... 00:33:13 INFO - Return code: 0 00:33:13 INFO - Running post-action listener: _resource_record_post_action 00:33:13 INFO - Running post-action listener: _start_resource_monitoring 00:33:13 INFO - Starting resource monitoring. 00:33:13 INFO - ##### 00:33:13 INFO - ##### Running install step. 00:33:13 INFO - ##### 00:33:13 INFO - Running pre-action listener: _resource_record_pre_action 00:33:13 INFO - Running main action method: install 00:33:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:33:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:33:13 INFO - Reading from file tmpfile_stdout 00:33:13 INFO - Detecting whether we're running mozinstall >=1.0... 00:33:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:33:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:33:13 INFO - Reading from file tmpfile_stdout 00:33:13 INFO - Output received: 00:33:13 INFO - Usage: mozinstall [options] installer 00:33:13 INFO - Options: 00:33:13 INFO - -h, --help show this help message and exit 00:33:13 INFO - -d DEST, --destination=DEST 00:33:13 INFO - Directory to install application into. [default: 00:33:13 INFO - "/builds/slave/test"] 00:33:13 INFO - --app=APP Application being installed. [default: firefox] 00:33:13 INFO - mkdir: /builds/slave/test/build/application 00:33:13 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'] 00:33:13 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 00:33:29 INFO - Reading from file tmpfile_stdout 00:33:29 INFO - Output received: 00:33:29 INFO - /builds/slave/test/build/application/firefox/firefox 00:33:29 INFO - Running post-action listener: _resource_record_post_action 00:33:29 INFO - ##### 00:33:29 INFO - ##### Running run-tests step. 00:33:29 INFO - ##### 00:33:29 INFO - Running pre-action listener: _resource_record_pre_action 00:33:29 INFO - Running main action method: run_tests 00:33:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:33:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:33:29 INFO - Python 2.7.3 00:33:29 INFO - Return code: 0 00:33:29 INFO - grabbing minidump binary from tooltool 00:33: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')]} 00:33:29 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 0x1fbb410>, '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 0x1fbc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbc7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:33:29 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 00:33:29 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 00:33:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:33:29 INFO - Return code: 0 00:33:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:33:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:33:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:33:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:33:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:33:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 00:33:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 00:33:30 INFO - Return code: 0 00:33:30 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/dUdz_rolRl2DIdohw8QTuA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 00:33:30 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/dUdz_rolRl2DIdohw8QTuA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 00:33:30 INFO - Using env: {'DISPLAY': ':0', 00:33:30 INFO - 'HOME': '/home/cltbld', 00:33:30 INFO - 'LANG': 'en_US.UTF-8', 00:33:30 INFO - 'LANGUAGE': 'en_US:en', 00:33:30 INFO - 'LOGNAME': 'cltbld', 00:33:30 INFO - 'MAIL': '/var/mail/cltbld', 00:33:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:33:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:33:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:33:30 INFO - 'MOZ_NO_REMOTE': '1', 00:33:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:33:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:33:30 INFO - 'NO_EM_RESTART': '1', 00:33:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:33:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:33:30 INFO - 'PWD': '/builds/slave/test', 00:33:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:33:30 INFO - 'SHELL': '/bin/bash', 00:33:30 INFO - 'SHLVL': '1', 00:33:30 INFO - 'TERM': 'linux', 00:33:30 INFO - 'TMOUT': '86400', 00:33:30 INFO - 'USER': 'cltbld', 00:33:30 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1464075154.635586-1271058610', 00:33:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:33:30 INFO - '_': '/tools/buildbot/bin/python'} 00:33:30 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/dUdz_rolRl2DIdohw8QTuA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 00:33:30 INFO - mozversion application_buildid: 20160523220203 00:33:30 INFO - mozversion application_changeset: 9b9a73a98de81f22189dd3972c922459bce28393 00:33:30 INFO - mozversion application_display_name: FirefoxDeveloperEdition 00:33:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:33:30 INFO - mozversion application_name: Firefox 00:33:30 INFO - mozversion application_remotingname: firefox-dev 00:33:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 00:33:30 INFO - mozversion application_vendor: Mozilla 00:33:30 INFO - mozversion application_version: 48.0a2 00:33:30 INFO - mozversion platform_buildid: 20160523220203 00:33:30 INFO - mozversion platform_changeset: 9b9a73a98de81f22189dd3972c922459bce28393 00:33:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 00:33:30 INFO - mozversion platform_version: 48.0a2 00:33:30 INFO - using testdate: 1464075210 00:33:30 INFO - actual date: 1464075210 00:33:30 INFO - starting webserver on 'localhost:48628' 00:33:30 INFO - SUITE-START | Running 2 tests 00:33:30 INFO - TEST-START | dromaeo_css 00:33:30 INFO - operating with platform_type : linux_ 00:33:30 INFO - Initialising browser for dromaeo_css test... 00:33:30 INFO - TEST-INFO | started process 22254 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTTwuaz/profile http://localhost:48628/getInfo.html) 00:33:34 INFO - PROCESS | 22254 | __metrics Screen width/height:1600/1200 00:33:34 INFO - PROCESS | 22254 | colorDepth:24 00:33:34 INFO - PROCESS | 22254 | Browser inner width/height: 1024/697 00:33:34 INFO - PROCESS | 22254 | __metrics 00:33:35 ERROR - PROCESS | 22254 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 00:33:37 INFO - TEST-INFO | 22254: exit 0 00:33:37 INFO - Browser initialized. 00:33:37 INFO - Running cycle 1/1 for dromaeo_css test... 00:33:37 INFO - TEST-INFO | started process 22343 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTTwuaz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:33:48 INFO - PROCESS | 22343 | RSS: Main: 141934592 00:33:48 INFO - PROCESS | 22343 | 00:34:39 INFO - PROCESS | 22343 | 1464075279486 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] 00:36:47 INFO - PROCESS | 22343 | Cycle 1(1): loaded http://localhost:48628/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48628/tests/dromaeo/cssquery-ext.html) 00:36:48 INFO - PROCESS | 22343 | RSS: Main: 261083136 00:36:48 INFO - PROCESS | 22343 | 00:39:50 INFO - PROCESS | 22343 | Cycle 1(1): loaded http://localhost:48628/tests/dromaeo/cssquery-ext.html (next: http://localhost:48628/tests/dromaeo/cssquery-jquery.html) 00:39:51 INFO - PROCESS | 22343 | RSS: Main: 224669696 00:39:51 INFO - PROCESS | 22343 | 00:42:53 INFO - PROCESS | 22343 | Cycle 1(1): loaded http://localhost:48628/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48628/tests/dromaeo/cssquery-mootools.html) 00:42:53 INFO - PROCESS | 22343 | RSS: Main: 222760960 00:42:53 INFO - PROCESS | 22343 | 00:45:55 INFO - PROCESS | 22343 | Cycle 1(1): loaded http://localhost:48628/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48628/tests/dromaeo/cssquery-prototype.html) 00:45:56 INFO - PROCESS | 22343 | RSS: Main: 216829952 00:45:56 INFO - PROCESS | 22343 | 00:48:58 INFO - PROCESS | 22343 | Cycle 1(1): loaded http://localhost:48628/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48628/tests/dromaeo/cssquery-yui.html) 00:48:59 INFO - PROCESS | 22343 | RSS: Main: 185262080 00:48:59 INFO - PROCESS | 22343 | 00:52:01 INFO - PROCESS | 22343 | Cycle 1(1): loaded http://localhost:48628/tests/dromaeo/cssquery-yui.html (next: http://localhost:48628/tests/dromaeo/cssquery-dojo.html) 00:52:01 INFO - PROCESS | 22343 | RSS: Main: 257724416 00:52:01 INFO - PROCESS | 22343 | 00:52:01 INFO - PROCESS | 22343 | __start_tp_report 00:52:01 INFO - PROCESS | 22343 | _x_x_mozilla_page_load 00:52:01 INFO - PROCESS | 22343 | _x_x_mozilla_page_load_details 00:52:01 INFO - PROCESS | 22343 | |i|pagename|runs| 00:52:01 INFO - PROCESS | 22343 | |0;dojo.html;3294.9835250823744;3344.7658663893535;3350.8157051362173;3367.983160084202;3388.8983330500077;5428.864278393037;5443.945560544398;5444.156155795853;5455.399906010336;5459.344878614562;5447.645903016311;5482.835514934548;5487.012337779198;5488.341399032111;5506.476884695958;4757;4933.728644924537;5030.698158110525;5059;5101.770420331094;4844.249141383091;4951.405831300249;5014.749262536877;5027.84916452507;5034.24486327052;4986.950130498685;5014.598832093442;5037.244413337992;5048.62135339851;5053.823116190934;5033.169527028036;5046.84859454217;5051.924221136685;5060.316857224265;5084.542391184774;4626.9074618507775;4871.171900776876;4959.330490383824;4965.081459929925;4997.825076122318;5408.296921400232;5440.020796256672;5451.236826844245;5455.727213639302;5469.124940009579;5842.824715258549;5845.795397161079;5862.912056319158;5877;5896.587238893279;5751.827445176651;5781.884362312772;5834.883302333972;5887.264091988502;5940.405959404068;5482.424345443711;5497.505224529811;5504.4770746779395;5504.6421982571;5532.1425179097305;5943.197668314809;5955.37468565803;5957.165996760457;5961.046232602849;5968.671723055274;5641.041023026095;5665.631733937281;5733.71331433435;5738.282714660668;5793.2179155814265;5819.214406055128;5823.767049318065;5828.358880523139;5832.066869300891;5856.502197313191;5805.767769289266;5807.041838096667;5810.331811841608;5812.215350927655;5813.854653633693;5573.164025396142;5758.107493338539;5814.796482123105;5862.237909071793;5863.560232982543;4456.799444025027;4465.017696106851;4488.102379524108;4490.326451032372;4506.616937560344;4004.799760011988;4017.8995525112105;4026.154507553388;4045.939310910339;4047.8988025299604;5395.541378982752;5398.568114550826;5478.890422191534;5499.917501237404;5502.669839809544;5834.8541286467325;5856.267966504187;5856.59003869725;5860.560457965669;5864.912026319608;5430.321209848769;5440.782368705208;5444.128939369761;5492.752826122834;5497.615166938276;4904.779284932187;4978.929530151035;5051.2423136529815;5054.519820617035;5088.109580823341;6032.939670603238;6033.095035744674;6052.455279024821;6096.146539484475;6099.939000610026;5708.8572785679025;5872.236609240771;5874.530037597067;5875.559333050124;5875.853103672357;6060.060690592965;6139.216166136355;6148.877022459436;6155.876882462415;6158.538109641705;5721.513671337816;5751.079827227623;5758.884822303614;5762.250907382014;5797.304323481209;5721.427857214412;5808.82573522795;5811;5824.15549745293;5825.621334613236;5718.428157184248;5721.942780572141;5727.255456790591;5733.913991290051;5757.251557297524;5676.659400435987;5680.4319568042865;5682.971585142048;5684;5691.800786972436;5398.244245805512;5596.580256480862;5603.075492543685;5605.103183490622;5711.600187986967;5742;5744.195812586157;5760.395158508296;5775.826725198251;5792.507636850914;5558.583106266965;5609.635373700697;5612.466815652507;5639.2668953035845;5644.491995720405 00:52:01 INFO - PROCESS | 22343 | |1;ext.html;668.7358493395109;670.8356452669094;677.12650680622;679.5481005131588;740.1118657610865;32741.18147046325;39649.80175099124;40289.59710402895;40375.1924961501;40500;43765.78117109418;44532.33201501972;44548.3317750234;44585.7770711146;44608.3308750369;7872.842543149133;8862.335324850646;9048.728538143867;9050.275977921783;10392.896071039306;10463.162946964225;10561.577536898514;10605.84091238632;10611.946940265289;10616.522256498438;10604.734881627983;10708.1433485321;10716.089132423753;10719.35683858967;10720.678379648623;10506;10610.416427096507;10612.62855800051;10618.415987120705;10623.78752424951;10551.577936882515;10943.726406839813;11019.83470247947;11020.338779673246;11021.724456888562;43095;43640.3453948191;43640.563594364285;43724.56275437269;43752;3829.7510661807173;3988.3219852625125;4047.1905618876344;4441.444819397575;4678.6491013174145;31864.840675796706;32307.6769232307;32423.703051877896;32639;34032;4539.591436770706;4562.064776720765;4600.953990460086;4607.539246075399;4695.929561056587;261667;385855;390985;392579;393209;62766.37233627697;63606;63656.36343636597;63818;63903.680481598225;74539.62730186315;76020.61989690016;76575;76660.61669691616;76764.2323576757;17912.820871791377;18012.2795088195;18028;18029.278828846698;18217.36239231647;14880.851191488164;15310.081395116105;15316;15324;15328.770068448983;21254.25610103639;21602.891985540286;21673.34979950604;21712.782872171076;21756.673649895263;7840.490368126054;7946.609343364888;8064.193580641889;8197.426180167331;8236.299914507214;1129.711923459529;1166.5742004168417;1185.5968970550055;1210.9636710898687;1230.772307123185;33139.83430082882;33367.3326533468;33517.49723754146;33542.329153416795;34825.129371765404;1245.4457766294092;1258.5469231076804;1288.439528804954;1342.89256859451;1360.6666366740014;17487.475375738748;17534.473965781046;17792.822071779374;17915.283388664568;17977.280908763765;502375;510519;511756;513087;517678;62643.686781566714;64431.67784161049;64513;64593.03110453347;64616.353836461974;1457.1330058615108;1482.6960473103204;1503.8571335723088;1517.3627076627843;1560.4304428883602;30051;33695.3260934775;34493.310133797684;34826.651733483355;35141;60957.085643716266;61301.38698612957;62021.37978620156;62112.68943655253;62197.68901155646;482738;491755;492132;492237;492638;40609.59390406058;48208.51791482181;48501;48534.75732621314;52492.737536312074;50240;50593.494065058876;51335.74332128465;51588.74205628948;51861.740691296305;42018;42589;42697.146057079306;42740;43630.56369436265;40734.592654074266;41475.79262103791;41733.1653366937;41909.371359430246;42752.14495710131;43188.784056079516;43659.56340436555;43687.56312436835;44070.559294407925;44151.558484414745;35931.82034089813;36760;36817.815910920275;38114;38242.808785955895;28429.30403657851;28836.567451488663;29012.854935725187;29119.980800671874;29158.27104322409 00:52:01 INFO - PROCESS | 22343 | |2;jquery.html;419.0801191384911;420.64455535072864;424.61572277089226;428.91850548395803;433.5426125437664;14101.858981410209;18663;19340.419787406365;19357.322493712705;19925.701114483294;15929.920350398232;18291.451256462293;18978.52553686155;19334.129964151613;19649.11578978946;5586.692731899754;5713.885722285552;5717.771289148429;5719;5741.82774516763;5636.520895723868;5698;5719;5720.2849643794525;5733.48398644122;4230.830766769325;6129.233845769279;6395.488360931115;6412.583182093149;6422.325655806143;6165.907511387333;6325.367463253684;6333.619982801047;6347.174867267248;6367.267764207106;5671.120976248688;5705.286839145107;5730.856728581777;5731.312242530923;5734.168545560912;23281;23571;23883.402914927094;24095.518089638284;24109;2544.8137813297208;2588.7540683635025;2591.883365248568;2603.9847951232714;2687.3013016615623;14698.118112913153;15028.872834537453;15199.088054716753;15409.460668876536;15658.843411565853;1916.865819392643;2007.3175120458968;2023.3120738948828;2110.7045013698093;2119.9046042928107;77901;79515.60242198753;79530;80181.59909200475;80614.19385806184;10413.375197488174;10529.631462898762;10692.465376731132;10863.945680271549;11213.87861213872;15658.060516369054;15805.920970395304;15956;15996.120213388143;16015;8738.606762695694;8758.992715837632;8821.2060914518;8899.065598112235;9038.909610903938;8873.201411872962;8888.511131887808;8890.110988901188;8992.775180620536;9016.909830901606;6253.155823963798;6472.190976127984;6687.230968438595;6739.730410783513;6974.197967233732;1920.2415046056728;1945.8735182213395;1964.950876228077;2023.1300540767318;2075.3462659262586;1041.994790026045;1070.71626019105;1103.2442776697987;1186.347508870118;1200.0939290835363;17394.65210695779;18208.45374638763;18559.907200463913;19599;19663.901680491792;1177.2988032293254;1212.4786341872903;1244.3964677131585;1245.620085873799;1267.454994352419;10812.459377031117;11271.54913803455;11279.548818047351;11601.303921764722;11673.766524669629;563784;581169;587577;591153;593179;56013.439865601635;93594;93763;94301;95679.52160239294;1157.6874243954253;1160.1414952934767;1167.9007284380752;1171.1918776044502;1183.3136780667191;18189.818101819343;18360.632787344446;18381.26474941041;18384.54038648991;18595.628087438447;41200;41230;41952.370714439916;42319.7884010578;42663.146737065705;58048.54878627899;58426.415735843795;58615.70692146512;58991;59052.40947590469;8973.192412682889;8994.865077023718;9031.548422578977;9095.636174553209;9175.44947303164;9898.505074746377;13580.185188888698;13962.301884905512;14002.03971444019;14251.50119745804;11646.94176529112;11751.471183796579;11960.521579136737;12096.45565949552;12435.06736994711;11267.887321126684;11476.713082172679;11897.762044758883;12158.696032599255;12596.622101336974;12129.818052729039;12563.497460101858;12566.497340106293;12927.418266177856;13008.674783130498;8583.227509524173;8771.254443372385;8881.777955551162;8942.195202431813;9242.168204861595;10448.529816158443;11328.32030078198;11365.886341136484;11381.658550243506;11418.771624567296 00:52:01 INFO - PROCESS | 22343 | |3;mootools.html;1390.8331000279968;1540.3299564689362;1562.2032763290727;1755.6839768841612;1886.999999999999;7970.92029079709;8207.83584328313;8222.876656850145;8240.835183296338;8256.091829898707;8077.596120193996;8218.219269169434;8220.506769593829;8239.876401853977;8240.91759082409;1954.9218031278804;1996.2214736252872;2388.773066558674;2403.230966090852;2424.8181386396004;2304.596695578267;2312.190733243368;2312.838101332899;2318.4783423729696;2319.3969567912295;2354.4702441950594;2387.307680772574;2391.8325717199805;2415.1788391946734;2422.164353298118;2060.6393881070826;2174.1194816099505;2218.301235110935;2324.721033475985;2331.1957374705785;2367.538330025646;2407.8194135439735;2408.2775167449695;2408.6989126359204;2414.167112346238;8134.186581341818;8164.183581641848;8179;8197.75406737793;8197.754067377988;4955.90088198234;5069;5084.211947148198;5090.134677104901;5091.338126043628;3399.8980030599123;3434.690877821008;3525.435930251173;3546.5034895114704;3739.6634302912867;1189.9167058305923;1203.2299328429813;1285.5372066056211;2192.4190089626263;2226.821854251672;11799.292042477393;12012.45943932534;12030.939845300805;12041.277523348626;12052.819207711891;4541.046380260116;4550.840720574764;4605.078984203173;4639.466461356988;4645.72125672454;9264.861027084598;9278.025807290272;9284.48935308551;9293.256539476826;9305.674301399418;5122.052420302256;5153.1497302945345;5169.612279079084;5171.043356978971;5216.921746173811;4179.644730197967;4262.083652014831;4718.245080787057;4844.8304309349005;4872.488388719134;3802.961970380316;3854.5374555053572;3906.7851268180525;3925.2542017016676;3957.9604203957592;1183.7099910521806;1195.205188549622;1196.3719047500133;1210.8304837322783;1222.2727477151082;961.7451375385389;1023.1303392116641;1033.7829055898346;1045.858809060767;1046.3094357723867;5839.883202335929;5914.349421563625;5984.790532331347;6043.425874541999;6148.385161483816;927.4018258223408;971.4317124482116;1006.7332156978407;1021.1983592879554;1028.136365453023;4092.3452247640234;4189.832406703758;4195.314998401026;4214.283571792803;4263.189993901149;10787;11125.109991200685;11270.211085223955;11287.830682539769;11301.208915375844;11075.113990880871;11085;11095.944520277508;11100.777984440267;11110.16673749456;7980.600969951595;8018.79953001168;8045.758627241192;8077.959610201911;8095.150009249061;5851.707414629337;5912.201852749996;5972.104184372379;6030.668313242813;6088.786892458743;9480.478573678238;9591.952040239754;9607;9644.662436814679;9683.51582420862;9388.57751401175;9665.033496650278;9909.851352229578;9920.801583968425;9929.602815887283;6851.862962740817;7395.223501532477;7603.619819008917;7643.350315223268;7725.343345815444;8040.798980025546;8063.959680201796;8095.2714255717265;8130.593470326342;8146.14465481116;7189.784306470814;7302.96348518254;7417.962910185631;7420.888686669812;7438.256174382518;7172.784816455514;7205.7838264852135;7231.059962204879;7238.420926325986;7316.158641756053;6765.763198288037;6768.593884366954;6784.151981002375;6796.184457865088;6826.931730682828;5087.694738315713;5118.718470484159;5162.664426812245;5189.896202076013;5233.084210263112;5059;5213.6350455467755;5250.238715386324;5281.287026251407;5396.109641909041 00:52:01 INFO - PROCESS | 22343 | |4;prototype.html;357.11257525050246;359.21332282301756;362.2031530632608;364.91059690375863;365.4828417788829;6122.47958923492;6229.6573688447115;6261.812145635638;6283;6298;6284.905726414107;6299.748010079603;6306.432421082101;6310.9902415613515;6321.589096708711;4830.661853670244;4830.806767729287;4836.637252206098;4853.199222128363;4860.343853579774;4572.108438854425;4689.718616882981;4805.807767689288;4857.319975203474;4861.538153875376;4775.856724298276;4790.305405716169;4791.28130780384;4792.065547218293;4803.087413391462;4783.593394561466;4784.569388755029;4791.808327666889;4806.0628177505405;4808.422989241296;4204.864686534649;4227.640650544708;4229.302165142748;4230.661547076226;4241.639460645849;6065.575409721321;6071.241094863142;6073.483753880925;6075.696215189223;6085.756569737206;5337.092694241988;5602.327720673505;5603.131514615241;5612.859678508029;5613.578981576357;6602.9669851650915;6614.603123812587;6628.138342015507;6631.204255489324;6633.2703402625675;4576.199165146119;4580.038191979688;4581.908361832745;4587.610053145487;4596.1267359201975;6846.5892046477375;6930.965345173292;6931.09895713559;6937.340952609494;6944.652767361612;4705.435347758291;4705.835295764632;4716.127516409407;4717.834875779331;4719.268513380432;4669.322948172496;4773.164696178224;4774.904501909942;4775.188218002948;4778.474367819606;5507.779688812483;5512.3385193777;5512.6692398456225;5518.227448157261;5526.47498487643;6589.439897608757;6633.369829866155;6634.436072933758;6641.867162656817;6652.83367915806;1574.2915687940472;1636.1900859074833;1672.7992640883172;1672.8327167283173;1674.9497515074568;1086.41333679812;1096.6490722968574;1099.7855418193535;1106.3417266726285;1108.3128460354633;6372.394622510854;6424.518161137933;6437.774677886345;6447.774327898501;6448.838779030561;6820.31796820314;6832.350926661959;6834.829129271709;6836.213835408892;6838.931610683929;6347.68261586928;6352.237731472161;6354;6356.2054743157105;6367.299597044322;3667.6149004354693;3702.7037836972977;3706.6664000240107;3711.109333759878;3712.1090938175184;6939.410150137194;7107.82230444243;7120.465965052538;7121.750738724223;7139.607321597362;6937.375636192767;6941.34057264559;6949.096617439802;6949.687264073129;6954.23503414624;7095.858082838315;7103.431725461951;7119.608421536762;7119.75080872167;7119.857602847914;6771.3905748482875;6782.96608516974;6783.219929708147;6783.4573234142135;6788.253292137762;6626.6686665667485;6718.596884186964;6875.209350924508;6880.174379074543;6893.414059804973;7214.567125972459;7223.674934628059;7248.383887369632;7249.601271929883;7263.128424589083;4721.952780472151;4779;4782.019685964299;4783.760811959319;4784.497627749036;6676.265610782907;6830.556013859084;6945.583265004116;6946.652667366712;6958.165020197609;6747.325267473213;6763.560368576027;6765.391114799691;6779.423748981392;6793.048973143665;6739.93260067393;6793.558418702769;6794.66026698673;6808.523403361915;6812.693428795816;6614.470842332698;6619.271880093283;6640.335966403321;6690.29751876046;6690.59856408617;6627.072209890523;6760.628165450751;6792.0830687856505;6798.926327470169;6800.047993281044;6573.769918052845;6591.736330546724;6599.142111525471;6599.934000659932;6617.371349721769 00:52:01 INFO - PROCESS | 22343 | |5;yui.html;827.5862068965517;843.7510934274388;900.4012331799352;916.674580523914;949.1410273702297;13605;13829.930850345747;13831.308434578255;13831.930840345809;13905.860941390596;12573.182743121713;13606.251656158907;14255.643608909782;14395.568132956001;14418.206998615073;907.1518130547943;913.0458670689146;923.7321176858703;923.7690577355661;923.9722808315728;888.7289376740124;897.1656359585583;897.5512243878061;899.7255836969722;900.2392977933636;939.3002213351028;940.6989763275755;942.7737343037655;943;943.3443756589173;940.1538615246264;940.1914353655816;940.7365937537501;941.0260380506178;941.6233506597347;693.32054586505;696.3871792822284;696.467202590019;696.7422053840112;696.8118607975869;12634.178778379375;12818.230906145662;12857.292848893307;12903.032272579594;12937.417816198295;13017.28404937728;13019.609411717664;13040.739185216242;13055.673608159777;13128.146670466485;11000.889991100066;11088.944555277252;11204.327740335524;11243.718907027307;11573.826392604118;3912.080661044652;3942.9014274643077;3995.3407687731487;4023.4568333274924;4045.110075783323;54272;54803.451965480635;57842.7107864458;64563;65267.67366163186;12199.207051541622;12425.93787031059;12436.129470936947;12607.43266552989;12884;22071.448213794785;22103.889480552814;22121.446963826034;22131.336059918227;22140.114395424003;8883.600237989305;8967.641294348154;8976.775580610538;9288.674896378729;9351;5052.757019786956;5135.87160320995;5192.065428222881;5275.472452754694;5297.443768404339;3417.5898892133105;3558.1638314995957;3577.964220357815;3684.18947831482;3760.6803421708914;677.5934439336457;681.8534015186659;687.4706476013441;688.2669956496316;693.0747452151435;732;734.1997223026926;740.1044735869658;743.3198623259765;743.6616339565485;9468.195203407788;9809.656662016796;9810.117089461983;9957.302988790716;10015.499225038864;760.3233122520961;765.961701914902;777.5995362388261;783.2519943453988;783.8824176373475;4536.931946020813;4582.931256031162;4615.538446155358;4630.281602221254;4668.696534725232;65704.67147664231;66393.33606663872;66947;67161;69342;54089;55443;56033;56981.71509142428;64006;58146;58386.12420813691;58551.4144858546;59974;60953.69523152356;10246.573152699386;10373.844392334271;10449.895501044892;10642.73393165177;10643.414612196404;40838.59161408348;40843.795781020905;41493.585064148974;41714.79142604268;42636.360454592585;51687.22469163041;52770.472295278094;53224.4677553235;53947.730261350014;54039;13126.40931158081;13354.599362019155;13564.394334829489;13577.932110339385;13841.238731869844;14245;14570.198639074953;14608.342624582132;14653.194074326015;15204.391824327346;13355.53255636048;13552.661183470493;13738.793918091436;13769.449222031006;13917;12588.244705317711;12793.976481881613;12912.16070955385;12932.676683082998;13537.526186583817;13233.669158271121;13305.866941330463;13767.655808604864;13792.310384480536;13863.861361386256;11168.21822472419;11172.608958686407;11312.547498100314;11494.827577586175;11506.137039722222;11438.714032149262;11467.827982580102;11617.6514704559;11766.52933882635;11824.586139485076 00:52:01 INFO - PROCESS | 22343 | __end_tp_report 00:52:01 INFO - PROCESS | 22343 | __start_cc_report 00:52:01 INFO - PROCESS | 22343 | _x_x_mozilla_cycle_collect,813 00:52:01 INFO - PROCESS | 22343 | __end_cc_report 00:52:01 INFO - PROCESS | 22343 | __startTimestamp1464076321712__endTimestamp 00:52:01 INFO - PROCESS | 22343 | 00:52:01 INFO - PROCESS | 22343 | ------- Summary: start ------- 00:52:01 INFO - PROCESS | 22343 | Number of tests: 6 00:52:01 INFO - PROCESS | 22343 | 00:52:01 INFO - PROCESS | 22343 | [#0] dojo.html Cycles:165 Average:5430.34 Median:5612.47 stddev:590.26 (10.5%) stddev-sans-first:567.80 00:52:01 INFO - PROCESS | 22343 | Values: 3295.0 3344.8 3350.8 3368.0 3388.9 5428.9 5443.9 5444.2 5455.4 5459.3 5447.6 5482.8 5487.0 5488.3 5506.5 4757.0 4933.7 5030.7 5059.0 5101.8 4844.2 4951.4 5014.7 5027.8 5034.2 4987.0 5014.6 5037.2 5048.6 5053.8 5033.2 5046.8 5051.9 5060.3 5084.5 4626.9 4871.2 4959.3 4965.1 4997.8 5408.3 5440.0 5451.2 5455.7 5469.1 5842.8 5845.8 5862.9 5877.0 5896.6 5751.8 5781.9 5834.9 5887.3 5940.4 5482.4 5497.5 5504.5 5504.6 5532.1 5943.2 5955.4 5957.2 5961.0 5968.7 5641.0 5665.6 5733.7 5738.3 5793.2 5819.2 5823.8 5828.4 5832.1 5856.5 5805.8 5807.0 5810.3 5812.2 5813.9 5573.2 5758.1 5814.8 5862.2 5863.6 4456.8 4465.0 4488.1 4490.3 4506.6 4004.8 4017.9 4026.2 4045.9 4047.9 5395.5 5398.6 5478.9 5499.9 5502.7 5834.9 5856.3 5856.6 5860.6 5864.9 5430.3 5440.8 5444.1 5492.8 5497.6 4904.8 4978.9 5051.2 5054.5 5088.1 6032.9 6033.1 6052.5 6096.1 6099.9 5708.9 5872.2 5874.5 5875.6 5875.9 6060.1 6139.2 6148.9 6155.9 6158.5 5721.5 5751.1 5758.9 5762.3 5797.3 5721.4 5808.8 5811.0 5824.2 5825.6 5718.4 5721.9 5727.3 5733.9 5757.3 5676.7 5680.4 5683.0 5684.0 5691.8 5398.2 5596.6 5603.1 5605.1 5711.6 5742.0 5744.2 5760.4 5775.8 5792.5 5558.6 5609.6 5612.5 5639.3 5644.5 00:52:01 INFO - PROCESS | 22343 | 00:52:01 INFO - PROCESS | 22343 | [#1] ext.html Cycles:180 Average:63819.20 Median:40332.39 stddev:121888.08 (302.2%) stddev-sans-first:122137.78 00:52:01 INFO - PROCESS | 22343 | Values: 668.7 670.8 677.1 679.5 740.1 32741.2 39649.8 40289.6 40375.2 40500.0 43765.8 44532.3 44548.3 44585.8 44608.3 7872.8 8862.3 9048.7 9050.3 10392.9 10463.2 10561.6 10605.8 10611.9 10616.5 10604.7 10708.1 10716.1 10719.4 10720.7 10506.0 10610.4 10612.6 10618.4 10623.8 10551.6 10943.7 11019.8 11020.3 11021.7 43095.0 43640.3 43640.6 43724.6 43752.0 3829.8 3988.3 4047.2 4441.4 4678.6 31864.8 32307.7 32423.7 32639.0 34032.0 4539.6 4562.1 4601.0 4607.5 4695.9 261667.0 385855.0 390985.0 392579.0 393209.0 62766.4 63606.0 63656.4 63818.0 63903.7 74539.6 76020.6 76575.0 76660.6 76764.2 17912.8 18012.3 18028.0 18029.3 18217.4 14880.9 15310.1 15316.0 15324.0 15328.8 21254.3 21602.9 21673.3 21712.8 21756.7 7840.5 7946.6 8064.2 8197.4 8236.3 1129.7 1166.6 1185.6 1211.0 1230.8 33139.8 33367.3 33517.5 33542.3 34825.1 1245.4 1258.5 1288.4 1342.9 1360.7 17487.5 17534.5 17792.8 17915.3 17977.3 502375.0 510519.0 511756.0 513087.0 517678.0 62643.7 64431.7 64513.0 64593.0 64616.4 1457.1 1482.7 1503.9 1517.4 1560.4 30051.0 33695.3 34493.3 34826.7 35141.0 60957.1 61301.4 62021.4 62112.7 62197.7 482738.0 491755.0 492132.0 492237.0 492638.0 40609.6 48208.5 48501.0 48534.8 52492.7 50240.0 50593.5 51335.7 51588.7 51861.7 42018.0 42589.0 42697.1 42740.0 43630.6 40734.6 41475.8 41733.2 41909.4 42752.1 43188.8 43659.6 43687.6 44070.6 44151.6 35931.8 36760.0 36817.8 38114.0 38242.8 28429.3 28836.6 29012.9 29120.0 29158.3 00:52:01 INFO - PROCESS | 22343 | 00:52:01 INFO - PROCESS | 22343 | [#2] jquery.html Cycles:180 Average:31774.83 Median:23727.20 stddev:95618.85 (403.0%) stddev-sans-first:95858.10 00:52:01 INFO - PROCESS | 22343 | Values: 419.1 420.6 424.6 428.9 433.5 14101.9 18663.0 19340.4 19357.3 19925.7 15929.9 18291.5 18978.5 19334.1 19649.1 5586.7 5713.9 5717.8 5719.0 5741.8 5636.5 5698.0 5719.0 5720.3 5733.5 4230.8 6129.2 6395.5 6412.6 6422.3 6165.9 6325.4 6333.6 6347.2 6367.3 5671.1 5705.3 5730.9 5731.3 5734.2 23281.0 23571.0 23883.4 24095.5 24109.0 2544.8 2588.8 2591.9 2604.0 2687.3 14698.1 15028.9 15199.1 15409.5 15658.8 1916.9 2007.3 2023.3 2110.7 2119.9 77901.0 79515.6 79530.0 80181.6 80614.2 10413.4 10529.6 10692.5 10863.9 11213.9 15658.1 15805.9 15956.0 15996.1 16015.0 8738.6 8759.0 8821.2 8899.1 9038.9 8873.2 8888.5 8890.1 8992.8 9016.9 6253.2 6472.2 6687.2 6739.7 6974.2 1920.2 1945.9 1965.0 2023.1 2075.3 1042.0 1070.7 1103.2 1186.3 1200.1 17394.7 18208.5 18559.9 19599.0 19663.9 1177.3 1212.5 1244.4 1245.6 1267.5 10812.5 11271.5 11279.5 11601.3 11673.8 563784.0 581169.0 587577.0 591153.0 593179.0 56013.4 93594.0 93763.0 94301.0 95679.5 1157.7 1160.1 1167.9 1171.2 1183.3 18189.8 18360.6 18381.3 18384.5 18595.6 41200.0 41230.0 41952.4 42319.8 42663.1 58048.5 58426.4 58615.7 58991.0 59052.4 8973.2 8994.9 9031.5 9095.6 9175.4 9898.5 13580.2 13962.3 14002.0 14251.5 11646.9 11751.5 11960.5 12096.5 12435.1 11267.9 11476.7 11897.8 12158.7 12596.6 12129.8 12563.5 12566.5 12927.4 13008.7 8583.2 8771.3 8881.8 8942.2 9242.2 10448.5 11328.3 11365.9 11381.7 11418.8 00:52:01 INFO - PROCESS | 22343 | 00:52:01 INFO - PROCESS | 22343 | [#3] mootools.html Cycles:180 Average:5660.68 Median:5085.95 stddev:3134.23 (61.6%) stddev-sans-first:3126.60 00:52:01 INFO - PROCESS | 22343 | Values: 1390.8 1540.3 1562.2 1755.7 1887.0 7970.9 8207.8 8222.9 8240.8 8256.1 8077.6 8218.2 8220.5 8239.9 8240.9 1954.9 1996.2 2388.8 2403.2 2424.8 2304.6 2312.2 2312.8 2318.5 2319.4 2354.5 2387.3 2391.8 2415.2 2422.2 2060.6 2174.1 2218.3 2324.7 2331.2 2367.5 2407.8 2408.3 2408.7 2414.2 8134.2 8164.2 8179.0 8197.8 8197.8 4955.9 5069.0 5084.2 5090.1 5091.3 3399.9 3434.7 3525.4 3546.5 3739.7 1189.9 1203.2 1285.5 2192.4 2226.8 11799.3 12012.5 12030.9 12041.3 12052.8 4541.0 4550.8 4605.1 4639.5 4645.7 9264.9 9278.0 9284.5 9293.3 9305.7 5122.1 5153.1 5169.6 5171.0 5216.9 4179.6 4262.1 4718.2 4844.8 4872.5 3803.0 3854.5 3906.8 3925.3 3958.0 1183.7 1195.2 1196.4 1210.8 1222.3 961.7 1023.1 1033.8 1045.9 1046.3 5839.9 5914.3 5984.8 6043.4 6148.4 927.4 971.4 1006.7 1021.2 1028.1 4092.3 4189.8 4195.3 4214.3 4263.2 10787.0 11125.1 11270.2 11287.8 11301.2 11075.1 11085.0 11095.9 11100.8 11110.2 7980.6 8018.8 8045.8 8078.0 8095.2 5851.7 5912.2 5972.1 6030.7 6088.8 9480.5 9592.0 9607.0 9644.7 9683.5 9388.6 9665.0 9909.9 9920.8 9929.6 6851.9 7395.2 7603.6 7643.4 7725.3 8040.8 8064.0 8095.3 8130.6 8146.1 7189.8 7303.0 7418.0 7420.9 7438.3 7172.8 7205.8 7231.1 7238.4 7316.2 6765.8 6768.6 6784.2 6796.2 6826.9 5087.7 5118.7 5162.7 5189.9 5233.1 5059.0 5213.6 5250.2 5281.3 5396.1 00:52:01 INFO - PROCESS | 22343 | 00:52:01 INFO - PROCESS | 22343 | [#4] prototype.html Cycles:180 Average:5580.89 Median:6349.96 stddev:1688.84 (26.6%) stddev-sans-first:1647.43 00:52:01 INFO - PROCESS | 22343 | Values: 357.1 359.2 362.2 364.9 365.5 6122.5 6229.7 6261.8 6283.0 6298.0 6284.9 6299.7 6306.4 6311.0 6321.6 4830.7 4830.8 4836.6 4853.2 4860.3 4572.1 4689.7 4805.8 4857.3 4861.5 4775.9 4790.3 4791.3 4792.1 4803.1 4783.6 4784.6 4791.8 4806.1 4808.4 4204.9 4227.6 4229.3 4230.7 4241.6 6065.6 6071.2 6073.5 6075.7 6085.8 5337.1 5602.3 5603.1 5612.9 5613.6 6603.0 6614.6 6628.1 6631.2 6633.3 4576.2 4580.0 4581.9 4587.6 4596.1 6846.6 6931.0 6931.1 6937.3 6944.7 4705.4 4705.8 4716.1 4717.8 4719.3 4669.3 4773.2 4774.9 4775.2 4778.5 5507.8 5512.3 5512.7 5518.2 5526.5 6589.4 6633.4 6634.4 6641.9 6652.8 1574.3 1636.2 1672.8 1672.8 1674.9 1086.4 1096.6 1099.8 1106.3 1108.3 6372.4 6424.5 6437.8 6447.8 6448.8 6820.3 6832.4 6834.8 6836.2 6838.9 6347.7 6352.2 6354.0 6356.2 6367.3 3667.6 3702.7 3706.7 3711.1 3712.1 6939.4 7107.8 7120.5 7121.8 7139.6 6937.4 6941.3 6949.1 6949.7 6954.2 7095.9 7103.4 7119.6 7119.8 7119.9 6771.4 6783.0 6783.2 6783.5 6788.3 6626.7 6718.6 6875.2 6880.2 6893.4 7214.6 7223.7 7248.4 7249.6 7263.1 4722.0 4779.0 4782.0 4783.8 4784.5 6676.3 6830.6 6945.6 6946.7 6958.2 6747.3 6763.6 6765.4 6779.4 6793.0 6739.9 6793.6 6794.7 6808.5 6812.7 6614.5 6619.3 6640.3 6690.3 6690.6 6627.1 6760.6 6792.1 6798.9 6800.0 6573.8 6591.7 6599.1 6599.9 6617.4 00:52:01 INFO - PROCESS | 22343 | 00:52:01 INFO - PROCESS | 22343 | [#5] yui.html Cycles:180 Average:16181.77 Median:23586.65 stddev:19081.11 (80.9%) stddev-sans-first:19099.80 00:52:01 INFO - PROCESS | 22343 | Values: 827.6 843.8 900.4 916.7 949.1 13605.0 13829.9 13831.3 13831.9 13905.9 12573.2 13606.3 14255.6 14395.6 14418.2 907.2 913.0 923.7 923.8 924.0 888.7 897.2 897.6 899.7 900.2 939.3 940.7 942.8 943.0 943.3 940.2 940.2 940.7 941.0 941.6 693.3 696.4 696.5 696.7 696.8 12634.2 12818.2 12857.3 12903.0 12937.4 13017.3 13019.6 13040.7 13055.7 13128.1 11000.9 11088.9 11204.3 11243.7 11573.8 3912.1 3942.9 3995.3 4023.5 4045.1 54272.0 54803.5 57842.7 64563.0 65267.7 12199.2 12425.9 12436.1 12607.4 12884.0 22071.4 22103.9 22121.4 22131.3 22140.1 8883.6 8967.6 8976.8 9288.7 9351.0 5052.8 5135.9 5192.1 5275.5 5297.4 3417.6 3558.2 3578.0 3684.2 3760.7 677.6 681.9 687.5 688.3 693.1 732.0 734.2 740.1 743.3 743.7 9468.2 9809.7 9810.1 9957.3 10015.5 760.3 766.0 777.6 783.3 783.9 4536.9 4582.9 4615.5 4630.3 4668.7 65704.7 66393.3 66947.0 67161.0 69342.0 54089.0 55443.0 56033.0 56981.7 64006.0 58146.0 58386.1 58551.4 59974.0 60953.7 10246.6 10373.8 10449.9 10642.7 10643.4 40838.6 40843.8 41493.6 41714.8 42636.4 51687.2 52770.5 53224.5 53947.7 54039.0 13126.4 13354.6 13564.4 13577.9 13841.2 14245.0 14570.2 14608.3 14653.2 15204.4 13355.5 13552.7 13738.8 13769.4 13917.0 12588.2 12794.0 12912.2 12932.7 13537.5 13233.7 13305.9 13767.7 13792.3 13863.9 11168.2 11172.6 11312.5 11494.8 11506.1 11438.7 11467.8 11617.7 11766.5 11824.6 00:52:01 INFO - PROCESS | 22343 | -------- Summary: end -------- 00:52:01 INFO - PROCESS | 22343 | 00:52:02 INFO - TEST-INFO | 22343: exit 0 00:52:02 INFO - TEST-OK | dromaeo_css | took 1111890ms 00:52:02 INFO - TEST-START | kraken 00:52:02 INFO - operating with platform_type : linux_ 00:52:02 INFO - Initialising browser for kraken test... 00:52:02 INFO - TEST-INFO | started process 22534 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvIf1we/profile http://localhost:48628/getInfo.html) 00:52:06 INFO - PROCESS | 22534 | __metrics Screen width/height:1600/1200 00:52:06 INFO - PROCESS | 22534 | colorDepth:24 00:52:06 INFO - PROCESS | 22534 | Browser inner width/height: 1024/697 00:52:06 INFO - PROCESS | 22534 | __metrics 00:52:07 ERROR - PROCESS | 22534 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 00:52:08 INFO - TEST-INFO | 22534: exit 0 00:52:08 INFO - Browser initialized. 00:52:08 INFO - Running cycle 1/1 for kraken test... 00:52:08 INFO - TEST-INFO | started process 22628 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvIf1we/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:52:20 INFO - PROCESS | 22628 | RSS: Main: 141594624 00:52:20 INFO - PROCESS | 22628 | 00:52:22 INFO - PROCESS | 22628 | Cycle 1(1): loaded http://localhost:48628/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48628/tests/kraken/driver.html?testName=audio-beat-detection) 00:52:23 INFO - PROCESS | 22628 | RSS: Main: 196296704 00:52:23 INFO - PROCESS | 22628 | 00:52:26 INFO - PROCESS | 22628 | Cycle 1(1): loaded http://localhost:48628/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48628/tests/kraken/driver.html?testName=audio-dft) 00:52:26 INFO - PROCESS | 22628 | RSS: Main: 182284288 00:52:26 INFO - PROCESS | 22628 | 00:52:29 INFO - PROCESS | 22628 | Cycle 1(1): loaded http://localhost:48628/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48628/tests/kraken/driver.html?testName=audio-fft) 00:52:30 INFO - PROCESS | 22628 | RSS: Main: 272666624 00:52:30 INFO - PROCESS | 22628 | 00:52:32 INFO - PROCESS | 22628 | Cycle 1(1): loaded http://localhost:48628/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48628/tests/kraken/driver.html?testName=audio-oscillator) 00:52:32 INFO - PROCESS | 22628 | RSS: Main: 178302976 00:52:32 INFO - PROCESS | 22628 | 00:52:35 INFO - PROCESS | 22628 | Cycle 1(1): loaded http://localhost:48628/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48628/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:52:35 INFO - PROCESS | 22628 | RSS: Main: 177545216 00:52:35 INFO - PROCESS | 22628 | 00:52:38 INFO - PROCESS | 22628 | Cycle 1(1): loaded http://localhost:48628/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48628/tests/kraken/driver.html?testName=imaging-darkroom) 00:52:39 INFO - PROCESS | 22628 | RSS: Main: 212217856 00:52:39 INFO - PROCESS | 22628 | 00:52:42 INFO - PROCESS | 22628 | Cycle 1(1): loaded http://localhost:48628/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48628/tests/kraken/driver.html?testName=imaging-desaturate) 00:52:43 INFO - PROCESS | 22628 | RSS: Main: 212422656 00:52:43 INFO - PROCESS | 22628 | 00:52:45 INFO - PROCESS | 22628 | Cycle 1(1): loaded http://localhost:48628/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48628/tests/kraken/driver.html?testName=json-parse-financial) 00:52:46 INFO - PROCESS | 22628 | RSS: Main: 212377600 00:52:46 INFO - PROCESS | 22628 | 00:52:48 INFO - PROCESS | 22628 | Cycle 1(1): loaded http://localhost:48628/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48628/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:52:48 INFO - PROCESS | 22628 | RSS: Main: 191684608 00:52:48 INFO - PROCESS | 22628 | 00:52:50 INFO - PROCESS | 22628 | Cycle 1(1): loaded http://localhost:48628/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48628/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:52:50 INFO - PROCESS | 22628 | RSS: Main: 194801664 00:52:50 INFO - PROCESS | 22628 | 00:52:52 INFO - PROCESS | 22628 | Cycle 1(1): loaded http://localhost:48628/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48628/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:52:53 INFO - PROCESS | 22628 | RSS: Main: 208232448 00:52:53 INFO - PROCESS | 22628 | 00:52:55 INFO - PROCESS | 22628 | Cycle 1(1): loaded http://localhost:48628/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48628/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:52:56 INFO - PROCESS | 22628 | RSS: Main: 211984384 00:52:56 INFO - PROCESS | 22628 | 00:52:59 INFO - PROCESS | 22628 | Cycle 1(1): loaded http://localhost:48628/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48628/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:52:59 INFO - PROCESS | 22628 | RSS: Main: 208351232 00:52:59 INFO - PROCESS | 22628 | 00:53:01 INFO - PROCESS | 22628 | Cycle 1(1): loaded http://localhost:48628/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48628/tests/kraken/driver.html?testName=ai-astar) 00:53:01 INFO - PROCESS | 22628 | RSS: Main: 272003072 00:53:01 INFO - PROCESS | 22628 | 00:53:01 INFO - PROCESS | 22628 | __start_tp_report 00:53:01 INFO - PROCESS | 22628 | _x_x_mozilla_page_load 00:53:01 INFO - PROCESS | 22628 | _x_x_mozilla_page_load_details 00:53:01 INFO - PROCESS | 22628 | |i|pagename|runs| 00:53:01 INFO - PROCESS | 22628 | |0;ai-astar;114;111;110;109;110;110;106;111;109;110 00:53:01 INFO - PROCESS | 22628 | |1;audio-beat-detection;151;126;159;178;134;161;159;129;177;125 00:53:01 INFO - PROCESS | 22628 | |2;audio-dft;159;161;159;160;159;159;160;160;160;161 00:53:01 INFO - PROCESS | 22628 | |3;audio-fft;72;77;76;169;77;77;76;77;169;75 00:53:01 INFO - PROCESS | 22628 | |4;audio-oscillator;93;91;148;92;92;92;146;92;92;153 00:53:01 INFO - PROCESS | 22628 | |5;imaging-gaussian-blur;116;116;116;116;117;116;116;116;117;117 00:53:01 INFO - PROCESS | 22628 | |6;imaging-darkroom;144;145;146;147;147;147;145;146;145;145 00:53:01 INFO - PROCESS | 22628 | |7;imaging-desaturate;94;94;95;94;94;94;94;94;94;94 00:53:01 INFO - PROCESS | 22628 | |8;json-parse-financial;53;52;53;53;52;52;54;70;53;52 00:53:01 INFO - PROCESS | 22628 | |9;json-stringify-tinderbox;57;58;58;57;57;57;57;57;57;57 00:53:01 INFO - PROCESS | 22628 | |10;stanford-crypto-aes;70;71;72;71;80;72;72;72;73;79 00:53:01 INFO - PROCESS | 22628 | |11;stanford-crypto-ccm;110;112;111;112;111;109;110;111;126;134 00:53:01 INFO - PROCESS | 22628 | |12;stanford-crypto-pbkdf2;164;161;156;158;159;158;164;161;154;157 00:53:01 INFO - PROCESS | 22628 | |13;stanford-crypto-sha256-iterative;67;67;64;65;66;75;66;66;65;63 00:53:01 INFO - PROCESS | 22628 | __end_tp_report 00:53:01 INFO - PROCESS | 22628 | __start_cc_report 00:53:01 INFO - PROCESS | 22628 | _x_x_mozilla_cycle_collect,1598 00:53:01 INFO - PROCESS | 22628 | __end_cc_report 00:53:01 INFO - PROCESS | 22628 | __startTimestamp1464076381718__endTimestamp 00:53:01 INFO - PROCESS | 22628 | 00:53:01 INFO - PROCESS | 22628 | ------- Summary: start ------- 00:53:01 INFO - PROCESS | 22628 | Number of tests: 14 00:53:01 INFO - PROCESS | 22628 | 00:53:01 INFO - PROCESS | 22628 | [#0] ai-astar Cycles:10 Average:110.00 Median:110.00 stddev:2.00 (1.8%) stddev-sans-first:1.51 00:53:01 INFO - PROCESS | 22628 | Values: 114.0 111.0 110.0 109.0 110.0 110.0 106.0 111.0 109.0 110.0 00:53:01 INFO - PROCESS | 22628 | 00:53:01 INFO - PROCESS | 22628 | [#1] audio-beat-detection Cycles:10 Average:149.90 Median:159.00 stddev:20.26 (12.7%) stddev-sans-first:21.49 00:53:01 INFO - PROCESS | 22628 | Values: 151.0 126.0 159.0 178.0 134.0 161.0 159.0 129.0 177.0 125.0 00:53:01 INFO - PROCESS | 22628 | 00:53:01 INFO - PROCESS | 22628 | [#2] audio-dft Cycles:10 Average:159.80 Median:160.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 00:53:01 INFO - PROCESS | 22628 | Values: 159.0 161.0 159.0 160.0 159.0 159.0 160.0 160.0 160.0 161.0 00:53:01 INFO - PROCESS | 22628 | 00:53:01 INFO - PROCESS | 22628 | [#3] audio-fft Cycles:10 Average:94.50 Median:76.50 stddev:39.29 (51.4%) stddev-sans-first:40.83 00:53:01 INFO - PROCESS | 22628 | Values: 72.0 77.0 76.0 169.0 77.0 77.0 76.0 77.0 169.0 75.0 00:53:01 INFO - PROCESS | 22628 | 00:53:01 INFO - PROCESS | 22628 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:92.00 stddev:27.59 (30.0%) stddev-sans-first:28.64 00:53:01 INFO - PROCESS | 22628 | Values: 93.0 91.0 148.0 92.0 92.0 92.0 146.0 92.0 92.0 153.0 00:53:01 INFO - PROCESS | 22628 | 00:53:01 INFO - PROCESS | 22628 | [#5] imaging-gaussian-blur Cycles:10 Average:116.30 Median:116.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 00:53:01 INFO - PROCESS | 22628 | Values: 116.0 116.0 116.0 116.0 117.0 116.0 116.0 116.0 117.0 117.0 00:53:01 INFO - PROCESS | 22628 | 00:53:01 INFO - PROCESS | 22628 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:1.06 (0.7%) stddev-sans-first:0.93 00:53:01 INFO - PROCESS | 22628 | Values: 144.0 145.0 146.0 147.0 147.0 147.0 145.0 146.0 145.0 145.0 00:53:01 INFO - PROCESS | 22628 | 00:53:01 INFO - PROCESS | 22628 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 00:53:01 INFO - PROCESS | 22628 | Values: 94.0 94.0 95.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 00:53:01 INFO - PROCESS | 22628 | 00:53:01 INFO - PROCESS | 22628 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:53.00 stddev:5.52 (10.4%) stddev-sans-first:5.83 00:53:01 INFO - PROCESS | 22628 | Values: 53.0 52.0 53.0 53.0 52.0 52.0 54.0 70.0 53.0 52.0 00:53:01 INFO - PROCESS | 22628 | 00:53:01 INFO - PROCESS | 22628 | [#9] json-stringify-tinderbox Cycles:10 Average:57.20 Median:57.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 00:53:01 INFO - PROCESS | 22628 | Values: 57.0 58.0 58.0 57.0 57.0 57.0 57.0 57.0 57.0 57.0 00:53:01 INFO - PROCESS | 22628 | 00:53:01 INFO - PROCESS | 22628 | [#10] stanford-crypto-aes Cycles:10 Average:73.20 Median:72.00 stddev:3.43 (4.8%) stddev-sans-first:3.43 00:53:01 INFO - PROCESS | 22628 | Values: 70.0 71.0 72.0 71.0 80.0 72.0 72.0 72.0 73.0 79.0 00:53:01 INFO - PROCESS | 22628 | 00:53:01 INFO - PROCESS | 22628 | [#11] stanford-crypto-ccm Cycles:10 Average:114.60 Median:111.50 stddev:8.38 (7.5%) stddev-sans-first:8.72 00:53:01 INFO - PROCESS | 22628 | Values: 110.0 112.0 111.0 112.0 111.0 109.0 110.0 111.0 126.0 134.0 00:53:01 INFO - PROCESS | 22628 | 00:53:01 INFO - PROCESS | 22628 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.20 Median:160.00 stddev:3.29 (2.1%) stddev-sans-first:3.00 00:53:01 INFO - PROCESS | 22628 | Values: 164.0 161.0 156.0 158.0 159.0 158.0 164.0 161.0 154.0 157.0 00:53:01 INFO - PROCESS | 22628 | 00:53:01 INFO - PROCESS | 22628 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.00 stddev:3.27 (5.0%) stddev-sans-first:3.46 00:53:01 INFO - PROCESS | 22628 | Values: 67.0 67.0 64.0 65.0 66.0 75.0 66.0 66.0 65.0 63.0 00:53:01 INFO - PROCESS | 22628 | -------- Summary: end -------- 00:53:01 INFO - PROCESS | 22628 | 00:53:02 INFO - TEST-INFO | 22628: exit 0 00:53:02 INFO - TEST-OK | kraken | took 60249ms 00:53:02 INFO - SUITE-END | took 1172s 00:53:02 INFO - Completed test suite (00:19:32) 00:53:02 INFO - javascript benchmark 00:53:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3294.9835250823744, 3344.7658663893535, 3350.8157051362173, 3367.983160084202, 3388.8983330500077, 5428.864278393037, 5443.945560544398, 5444.156155795853, 5455.399906010336, 5459.344878614562, 5447.645903016311, 5482.835514934548, 5487.012337779198, 5488.341399032111, 5506.476884695958, 4757.0, 4933.728644924537, 5030.698158110525, 5059.0, 5101.770420331094, 4844.249141383091, 4951.405831300249, 5014.749262536877, 5027.84916452507, 5034.24486327052, 4986.950130498685, 5014.598832093442, 5037.244413337992, 5048.62135339851, 5053.823116190934, 5033.169527028036, 5046.84859454217, 5051.924221136685, 5060.316857224265, 5084.542391184774, 4626.9074618507775, 4871.171900776876, 4959.330490383824, 4965.081459929925, 4997.825076122318, 5408.296921400232, 5440.020796256672, 5451.236826844245, 5455.727213639302, 5469.124940009579, 5842.824715258549, 5845.795397161079, 5862.912056319158, 5877.0, 5896.587238893279, 5751.827445176651, 5781.884362312772, 5834.883302333972, 5887.264091988502, 5940.405959404068, 5482.424345443711, 5497.505224529811, 5504.4770746779395, 5504.6421982571, 5532.1425179097305, 5943.197668314809, 5955.37468565803, 5957.165996760457, 5961.046232602849, 5968.671723055274, 5641.041023026095, 5665.631733937281, 5733.71331433435, 5738.282714660668, 5793.2179155814265, 5819.214406055128, 5823.767049318065, 5828.358880523139, 5832.066869300891, 5856.502197313191, 5805.767769289266, 5807.041838096667, 5810.331811841608, 5812.215350927655, 5813.854653633693, 5573.164025396142, 5758.107493338539, 5814.796482123105, 5862.237909071793, 5863.560232982543, 4456.799444025027, 4465.017696106851, 4488.102379524108, 4490.326451032372, 4506.616937560344, 4004.799760011988, 4017.8995525112105, 4026.154507553388, 4045.939310910339, 4047.8988025299604, 5395.541378982752, 5398.568114550826, 5478.890422191534, 5499.917501237404, 5502.669839809544, 5834.8541286467325, 5856.267966504187, 5856.59003869725, 5860.560457965669, 5864.912026319608, 5430.321209848769, 5440.782368705208, 5444.128939369761, 5492.752826122834, 5497.615166938276, 4904.779284932187, 4978.929530151035, 5051.2423136529815, 5054.519820617035, 5088.109580823341, 6032.939670603238, 6033.095035744674, 6052.455279024821, 6096.146539484475, 6099.939000610026, 5708.8572785679025, 5872.236609240771, 5874.530037597067, 5875.559333050124, 5875.853103672357, 6060.060690592965, 6139.216166136355, 6148.877022459436, 6155.876882462415, 6158.538109641705, 5721.513671337816, 5751.079827227623, 5758.884822303614, 5762.250907382014, 5797.304323481209, 5721.427857214412, 5808.82573522795, 5811.0, 5824.15549745293, 5825.621334613236, 5718.428157184248, 5721.942780572141, 5727.255456790591, 5733.913991290051, 5757.251557297524, 5676.659400435987, 5680.4319568042865, 5682.971585142048, 5684.0, 5691.800786972436, 5398.244245805512, 5596.580256480862, 5603.075492543685, 5605.103183490622, 5711.600187986967, 5742.0, 5744.195812586157, 5760.395158508296, 5775.826725198251, 5792.507636850914, 5558.583106266965, 5609.635373700697, 5612.466815652507, 5639.2668953035845, 5644.491995720405], "value": 5393.206649319846, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.7358493395109, 670.8356452669094, 677.12650680622, 679.5481005131588, 740.1118657610865, 32741.18147046325, 39649.80175099124, 40289.59710402895, 40375.1924961501, 40500.0, 43765.78117109418, 44532.33201501972, 44548.3317750234, 44585.7770711146, 44608.3308750369, 7872.842543149133, 8862.335324850646, 9048.728538143867, 9050.275977921783, 10392.896071039306, 10463.162946964225, 10561.577536898514, 10605.84091238632, 10611.946940265289, 10616.522256498438, 10604.734881627983, 10708.1433485321, 10716.089132423753, 10719.35683858967, 10720.678379648623, 10506.0, 10610.416427096507, 10612.62855800051, 10618.415987120705, 10623.78752424951, 10551.577936882515, 10943.726406839813, 11019.83470247947, 11020.338779673246, 11021.724456888562, 43095.0, 43640.3453948191, 43640.563594364285, 43724.56275437269, 43752.0, 3829.7510661807173, 3988.3219852625125, 4047.1905618876344, 4441.444819397575, 4678.6491013174145, 31864.840675796706, 32307.6769232307, 32423.703051877896, 32639.0, 34032.0, 4539.591436770706, 4562.064776720765, 4600.953990460086, 4607.539246075399, 4695.929561056587, 261667.0, 385855.0, 390985.0, 392579.0, 393209.0, 62766.37233627697, 63606.0, 63656.36343636597, 63818.0, 63903.680481598225, 74539.62730186315, 76020.61989690016, 76575.0, 76660.61669691616, 76764.2323576757, 17912.820871791377, 18012.2795088195, 18028.0, 18029.278828846698, 18217.36239231647, 14880.851191488164, 15310.081395116105, 15316.0, 15324.0, 15328.770068448983, 21254.25610103639, 21602.891985540286, 21673.34979950604, 21712.782872171076, 21756.673649895263, 7840.490368126054, 7946.609343364888, 8064.193580641889, 8197.426180167331, 8236.299914507214, 1129.711923459529, 1166.5742004168417, 1185.5968970550055, 1210.9636710898687, 1230.772307123185, 33139.83430082882, 33367.3326533468, 33517.49723754146, 33542.329153416795, 34825.129371765404, 1245.4457766294092, 1258.5469231076804, 1288.439528804954, 1342.89256859451, 1360.6666366740014, 17487.475375738748, 17534.473965781046, 17792.822071779374, 17915.283388664568, 17977.280908763765, 502375.0, 510519.0, 511756.0, 513087.0, 517678.0, 62643.686781566714, 64431.67784161049, 64513.0, 64593.03110453347, 64616.353836461974, 1457.1330058615108, 1482.6960473103204, 1503.8571335723088, 1517.3627076627843, 1560.4304428883602, 30051.0, 33695.3260934775, 34493.310133797684, 34826.651733483355, 35141.0, 60957.085643716266, 61301.38698612957, 62021.37978620156, 62112.68943655253, 62197.68901155646, 482738.0, 491755.0, 492132.0, 492237.0, 492638.0, 40609.59390406058, 48208.51791482181, 48501.0, 48534.75732621314, 52492.737536312074, 50240.0, 50593.494065058876, 51335.74332128465, 51588.74205628948, 51861.740691296305, 42018.0, 42589.0, 42697.146057079306, 42740.0, 43630.56369436265, 40734.592654074266, 41475.79262103791, 41733.1653366937, 41909.371359430246, 42752.14495710131, 43188.784056079516, 43659.56340436555, 43687.56312436835, 44070.559294407925, 44151.558484414745, 35931.82034089813, 36760.0, 36817.815910920275, 38114.0, 38242.808785955895, 28429.30403657851, 28836.567451488663, 29012.854935725187, 29119.980800671874, 29158.27104322409], "value": 22225.64354870189, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [419.0801191384911, 420.64455535072864, 424.61572277089226, 428.91850548395803, 433.5426125437664, 14101.858981410209, 18663.0, 19340.419787406365, 19357.322493712705, 19925.701114483294, 15929.920350398232, 18291.451256462293, 18978.52553686155, 19334.129964151613, 19649.11578978946, 5586.692731899754, 5713.885722285552, 5717.771289148429, 5719.0, 5741.82774516763, 5636.520895723868, 5698.0, 5719.0, 5720.2849643794525, 5733.48398644122, 4230.830766769325, 6129.233845769279, 6395.488360931115, 6412.583182093149, 6422.325655806143, 6165.907511387333, 6325.367463253684, 6333.619982801047, 6347.174867267248, 6367.267764207106, 5671.120976248688, 5705.286839145107, 5730.856728581777, 5731.312242530923, 5734.168545560912, 23281.0, 23571.0, 23883.402914927094, 24095.518089638284, 24109.0, 2544.8137813297208, 2588.7540683635025, 2591.883365248568, 2603.9847951232714, 2687.3013016615623, 14698.118112913153, 15028.872834537453, 15199.088054716753, 15409.460668876536, 15658.843411565853, 1916.865819392643, 2007.3175120458968, 2023.3120738948828, 2110.7045013698093, 2119.9046042928107, 77901.0, 79515.60242198753, 79530.0, 80181.59909200475, 80614.19385806184, 10413.375197488174, 10529.631462898762, 10692.465376731132, 10863.945680271549, 11213.87861213872, 15658.060516369054, 15805.920970395304, 15956.0, 15996.120213388143, 16015.0, 8738.606762695694, 8758.992715837632, 8821.2060914518, 8899.065598112235, 9038.909610903938, 8873.201411872962, 8888.511131887808, 8890.110988901188, 8992.775180620536, 9016.909830901606, 6253.155823963798, 6472.190976127984, 6687.230968438595, 6739.730410783513, 6974.197967233732, 1920.2415046056728, 1945.8735182213395, 1964.950876228077, 2023.1300540767318, 2075.3462659262586, 1041.994790026045, 1070.71626019105, 1103.2442776697987, 1186.347508870118, 1200.0939290835363, 17394.65210695779, 18208.45374638763, 18559.907200463913, 19599.0, 19663.901680491792, 1177.2988032293254, 1212.4786341872903, 1244.3964677131585, 1245.620085873799, 1267.454994352419, 10812.459377031117, 11271.54913803455, 11279.548818047351, 11601.303921764722, 11673.766524669629, 563784.0, 581169.0, 587577.0, 591153.0, 593179.0, 56013.439865601635, 93594.0, 93763.0, 94301.0, 95679.52160239294, 1157.6874243954253, 1160.1414952934767, 1167.9007284380752, 1171.1918776044502, 1183.3136780667191, 18189.818101819343, 18360.632787344446, 18381.26474941041, 18384.54038648991, 18595.628087438447, 41200.0, 41230.0, 41952.370714439916, 42319.7884010578, 42663.146737065705, 58048.54878627899, 58426.415735843795, 58615.70692146512, 58991.0, 59052.40947590469, 8973.192412682889, 8994.865077023718, 9031.548422578977, 9095.636174553209, 9175.44947303164, 9898.505074746377, 13580.185188888698, 13962.301884905512, 14002.03971444019, 14251.50119745804, 11646.94176529112, 11751.471183796579, 11960.521579136737, 12096.45565949552, 12435.06736994711, 11267.887321126684, 11476.713082172679, 11897.762044758883, 12158.696032599255, 12596.622101336974, 12129.818052729039, 12563.497460101858, 12566.497340106293, 12927.418266177856, 13008.674783130498, 8583.227509524173, 8771.254443372385, 8881.777955551162, 8942.195202431813, 9242.168204861595, 10448.529816158443, 11328.32030078198, 11365.886341136484, 11381.658550243506, 11418.771624567296], "value": 9778.396015982342, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1390.8331000279968, 1540.3299564689362, 1562.2032763290727, 1755.6839768841612, 1886.999999999999, 7970.92029079709, 8207.83584328313, 8222.876656850145, 8240.835183296338, 8256.091829898707, 8077.596120193996, 8218.219269169434, 8220.506769593829, 8239.876401853977, 8240.91759082409, 1954.9218031278804, 1996.2214736252872, 2388.773066558674, 2403.230966090852, 2424.8181386396004, 2304.596695578267, 2312.190733243368, 2312.838101332899, 2318.4783423729696, 2319.3969567912295, 2354.4702441950594, 2387.307680772574, 2391.8325717199805, 2415.1788391946734, 2422.164353298118, 2060.6393881070826, 2174.1194816099505, 2218.301235110935, 2324.721033475985, 2331.1957374705785, 2367.538330025646, 2407.8194135439735, 2408.2775167449695, 2408.6989126359204, 2414.167112346238, 8134.186581341818, 8164.183581641848, 8179.0, 8197.75406737793, 8197.754067377988, 4955.90088198234, 5069.0, 5084.211947148198, 5090.134677104901, 5091.338126043628, 3399.8980030599123, 3434.690877821008, 3525.435930251173, 3546.5034895114704, 3739.6634302912867, 1189.9167058305923, 1203.2299328429813, 1285.5372066056211, 2192.4190089626263, 2226.821854251672, 11799.292042477393, 12012.45943932534, 12030.939845300805, 12041.277523348626, 12052.819207711891, 4541.046380260116, 4550.840720574764, 4605.078984203173, 4639.466461356988, 4645.72125672454, 9264.861027084598, 9278.025807290272, 9284.48935308551, 9293.256539476826, 9305.674301399418, 5122.052420302256, 5153.1497302945345, 5169.612279079084, 5171.043356978971, 5216.921746173811, 4179.644730197967, 4262.083652014831, 4718.245080787057, 4844.8304309349005, 4872.488388719134, 3802.961970380316, 3854.5374555053572, 3906.7851268180525, 3925.2542017016676, 3957.9604203957592, 1183.7099910521806, 1195.205188549622, 1196.3719047500133, 1210.8304837322783, 1222.2727477151082, 961.7451375385389, 1023.1303392116641, 1033.7829055898346, 1045.858809060767, 1046.3094357723867, 5839.883202335929, 5914.349421563625, 5984.790532331347, 6043.425874541999, 6148.385161483816, 927.4018258223408, 971.4317124482116, 1006.7332156978407, 1021.1983592879554, 1028.136365453023, 4092.3452247640234, 4189.832406703758, 4195.314998401026, 4214.283571792803, 4263.189993901149, 10787.0, 11125.109991200685, 11270.211085223955, 11287.830682539769, 11301.208915375844, 11075.113990880871, 11085.0, 11095.944520277508, 11100.777984440267, 11110.16673749456, 7980.600969951595, 8018.79953001168, 8045.758627241192, 8077.959610201911, 8095.150009249061, 5851.707414629337, 5912.201852749996, 5972.104184372379, 6030.668313242813, 6088.786892458743, 9480.478573678238, 9591.952040239754, 9607.0, 9644.662436814679, 9683.51582420862, 9388.57751401175, 9665.033496650278, 9909.851352229578, 9920.801583968425, 9929.602815887283, 6851.862962740817, 7395.223501532477, 7603.619819008917, 7643.350315223268, 7725.343345815444, 8040.798980025546, 8063.959680201796, 8095.2714255717265, 8130.593470326342, 8146.14465481116, 7189.784306470814, 7302.96348518254, 7417.962910185631, 7420.888686669812, 7438.256174382518, 7172.784816455514, 7205.7838264852135, 7231.059962204879, 7238.420926325986, 7316.158641756053, 6765.763198288037, 6768.593884366954, 6784.151981002375, 6796.184457865088, 6826.931730682828, 5087.694738315713, 5118.718470484159, 5162.664426812245, 5189.896202076013, 5233.084210263112, 5059.0, 5213.6350455467755, 5250.238715386324, 5281.287026251407, 5396.109641909041], "value": 4613.435498332419, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.11257525050246, 359.21332282301756, 362.2031530632608, 364.91059690375863, 365.4828417788829, 6122.47958923492, 6229.6573688447115, 6261.812145635638, 6283.0, 6298.0, 6284.905726414107, 6299.748010079603, 6306.432421082101, 6310.9902415613515, 6321.589096708711, 4830.661853670244, 4830.806767729287, 4836.637252206098, 4853.199222128363, 4860.343853579774, 4572.108438854425, 4689.718616882981, 4805.807767689288, 4857.319975203474, 4861.538153875376, 4775.856724298276, 4790.305405716169, 4791.28130780384, 4792.065547218293, 4803.087413391462, 4783.593394561466, 4784.569388755029, 4791.808327666889, 4806.0628177505405, 4808.422989241296, 4204.864686534649, 4227.640650544708, 4229.302165142748, 4230.661547076226, 4241.639460645849, 6065.575409721321, 6071.241094863142, 6073.483753880925, 6075.696215189223, 6085.756569737206, 5337.092694241988, 5602.327720673505, 5603.131514615241, 5612.859678508029, 5613.578981576357, 6602.9669851650915, 6614.603123812587, 6628.138342015507, 6631.204255489324, 6633.2703402625675, 4576.199165146119, 4580.038191979688, 4581.908361832745, 4587.610053145487, 4596.1267359201975, 6846.5892046477375, 6930.965345173292, 6931.09895713559, 6937.340952609494, 6944.652767361612, 4705.435347758291, 4705.835295764632, 4716.127516409407, 4717.834875779331, 4719.268513380432, 4669.322948172496, 4773.164696178224, 4774.904501909942, 4775.188218002948, 4778.474367819606, 5507.779688812483, 5512.3385193777, 5512.6692398456225, 5518.227448157261, 5526.47498487643, 6589.439897608757, 6633.369829866155, 6634.436072933758, 6641.867162656817, 6652.83367915806, 1574.2915687940472, 1636.1900859074833, 1672.7992640883172, 1672.8327167283173, 1674.9497515074568, 1086.41333679812, 1096.6490722968574, 1099.7855418193535, 1106.3417266726285, 1108.3128460354633, 6372.394622510854, 6424.518161137933, 6437.774677886345, 6447.774327898501, 6448.838779030561, 6820.31796820314, 6832.350926661959, 6834.829129271709, 6836.213835408892, 6838.931610683929, 6347.68261586928, 6352.237731472161, 6354.0, 6356.2054743157105, 6367.299597044322, 3667.6149004354693, 3702.7037836972977, 3706.6664000240107, 3711.109333759878, 3712.1090938175184, 6939.410150137194, 7107.82230444243, 7120.465965052538, 7121.750738724223, 7139.607321597362, 6937.375636192767, 6941.34057264559, 6949.096617439802, 6949.687264073129, 6954.23503414624, 7095.858082838315, 7103.431725461951, 7119.608421536762, 7119.75080872167, 7119.857602847914, 6771.3905748482875, 6782.96608516974, 6783.219929708147, 6783.4573234142135, 6788.253292137762, 6626.6686665667485, 6718.596884186964, 6875.209350924508, 6880.174379074543, 6893.414059804973, 7214.567125972459, 7223.674934628059, 7248.383887369632, 7249.601271929883, 7263.128424589083, 4721.952780472151, 4779.0, 4782.019685964299, 4783.760811959319, 4784.497627749036, 6676.265610782907, 6830.556013859084, 6945.583265004116, 6946.652667366712, 6958.165020197609, 6747.325267473213, 6763.560368576027, 6765.391114799691, 6779.423748981392, 6793.048973143665, 6739.93260067393, 6793.558418702769, 6794.66026698673, 6808.523403361915, 6812.693428795816, 6614.470842332698, 6619.271880093283, 6640.335966403321, 6690.29751876046, 6690.59856408617, 6627.072209890523, 6760.628165450751, 6792.0830687856505, 6798.926327470169, 6800.047993281044, 6573.769918052845, 6591.736330546724, 6599.142111525471, 6599.934000659932, 6617.371349721769], "value": 5030.171613746507, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [827.5862068965517, 843.7510934274388, 900.4012331799352, 916.674580523914, 949.1410273702297, 13605.0, 13829.930850345747, 13831.308434578255, 13831.930840345809, 13905.860941390596, 12573.182743121713, 13606.251656158907, 14255.643608909782, 14395.568132956001, 14418.206998615073, 907.1518130547943, 913.0458670689146, 923.7321176858703, 923.7690577355661, 923.9722808315728, 888.7289376740124, 897.1656359585583, 897.5512243878061, 899.7255836969722, 900.2392977933636, 939.3002213351028, 940.6989763275755, 942.7737343037655, 943.0, 943.3443756589173, 940.1538615246264, 940.1914353655816, 940.7365937537501, 941.0260380506178, 941.6233506597347, 693.32054586505, 696.3871792822284, 696.467202590019, 696.7422053840112, 696.8118607975869, 12634.178778379375, 12818.230906145662, 12857.292848893307, 12903.032272579594, 12937.417816198295, 13017.28404937728, 13019.609411717664, 13040.739185216242, 13055.673608159777, 13128.146670466485, 11000.889991100066, 11088.944555277252, 11204.327740335524, 11243.718907027307, 11573.826392604118, 3912.080661044652, 3942.9014274643077, 3995.3407687731487, 4023.4568333274924, 4045.110075783323, 54272.0, 54803.451965480635, 57842.7107864458, 64563.0, 65267.67366163186, 12199.207051541622, 12425.93787031059, 12436.129470936947, 12607.43266552989, 12884.0, 22071.448213794785, 22103.889480552814, 22121.446963826034, 22131.336059918227, 22140.114395424003, 8883.600237989305, 8967.641294348154, 8976.775580610538, 9288.674896378729, 9351.0, 5052.757019786956, 5135.87160320995, 5192.065428222881, 5275.472452754694, 5297.443768404339, 3417.5898892133105, 3558.1638314995957, 3577.964220357815, 3684.18947831482, 3760.6803421708914, 677.5934439336457, 681.8534015186659, 687.4706476013441, 688.2669956496316, 693.0747452151435, 732.0, 734.1997223026926, 740.1044735869658, 743.3198623259765, 743.6616339565485, 9468.195203407788, 9809.656662016796, 9810.117089461983, 9957.302988790716, 10015.499225038864, 760.3233122520961, 765.961701914902, 777.5995362388261, 783.2519943453988, 783.8824176373475, 4536.931946020813, 4582.931256031162, 4615.538446155358, 4630.281602221254, 4668.696534725232, 65704.67147664231, 66393.33606663872, 66947.0, 67161.0, 69342.0, 54089.0, 55443.0, 56033.0, 56981.71509142428, 64006.0, 58146.0, 58386.12420813691, 58551.4144858546, 59974.0, 60953.69523152356, 10246.573152699386, 10373.844392334271, 10449.895501044892, 10642.73393165177, 10643.414612196404, 40838.59161408348, 40843.795781020905, 41493.585064148974, 41714.79142604268, 42636.360454592585, 51687.22469163041, 52770.472295278094, 53224.4677553235, 53947.730261350014, 54039.0, 13126.40931158081, 13354.599362019155, 13564.394334829489, 13577.932110339385, 13841.238731869844, 14245.0, 14570.198639074953, 14608.342624582132, 14653.194074326015, 15204.391824327346, 13355.53255636048, 13552.661183470493, 13738.793918091436, 13769.449222031006, 13917.0, 12588.244705317711, 12793.976481881613, 12912.16070955385, 12932.676683082998, 13537.526186583817, 13233.669158271121, 13305.866941330463, 13767.655808604864, 13792.310384480536, 13863.861361386256, 11168.21822472419, 11172.608958686407, 11312.547498100314, 11494.827577586175, 11506.137039722222, 11438.714032149262, 11467.827982580102, 11617.6514704559, 11766.52933882635, 11824.586139485076], "value": 7274.623218733728, "unit": "score"}], "name": "dromaeo_css", "value": 7633.757282223294, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 111.0, 110.0, 109.0, 110.0, 110.0, 106.0, 111.0, 109.0, 110.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 126.0, 159.0, 178.0, 134.0, 161.0, 159.0, 129.0, 177.0, 125.0], "value": 149.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 159.0, 160.0, 159.0, 159.0, 160.0, 160.0, 160.0, 161.0], "value": 159.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 77.0, 76.0, 169.0, 77.0, 77.0, 76.0, 77.0, 169.0, 75.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 91.0, 148.0, 92.0, 92.0, 92.0, 146.0, 92.0, 92.0, 153.0], "value": 109.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 116.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0], "value": 116.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 145.0, 146.0, 147.0, 147.0, 147.0, 145.0, 146.0, 145.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 53.0, 52.0, 52.0, 54.0, 70.0, 53.0, 52.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 57.0, 57.0, 57.0, 57.0, 57.0, 57.0, 57.0], "value": 57.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 72.0, 71.0, 80.0, 72.0, 72.0, 72.0, 73.0, 79.0], "value": 73.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 111.0, 112.0, 111.0, 109.0, 110.0, 111.0, 126.0, 134.0], "value": 114.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 161.0, 156.0, 158.0, 159.0, 158.0, 164.0, 161.0, 154.0, 157.0], "value": 159.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 64.0, 65.0, 66.0, 75.0, 66.0, 66.0, 65.0, 63.0], "value": 66.4, "unit": "score"}], "name": "kraken", "value": 1504.4, "alertThreshold": 2.0}]} 00:53:02 INFO - Return code: 0 00:53:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 00:53:03 ERROR - # TBPL SUCCESS # 00:53:03 INFO - Running post-action listener: _resource_record_post_action 00:53:03 INFO - Running post-run listener: _resource_record_post_run 00:53:04 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 262144; Write bytes: 497397760; Read time: 20; Write time: 805208 00:53:04 INFO - install - Wall time: 16s; CPU: 17.0%; Read bytes: 0; Write bytes: 248725504; Read time: 0; Write time: 547932 00:53:04 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 262144; Write bytes: 248672256; Read time: 20; Write time: 257276 00:53:04 INFO - Running post-run listener: _upload_blobber_files 00:53:04 INFO - Blob upload gear active. 00:53:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:53:04 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 00:53:04 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'] 00:53:04 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 00:53:04 INFO - (blobuploader) - INFO - Open directory for files ... 00:53:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:53:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:53:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:53:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:53:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:53:05 INFO - (blobuploader) - INFO - Done attempting. 00:53:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:53:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:53:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:53:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:53:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:53:06 INFO - (blobuploader) - INFO - Done attempting. 00:53:06 INFO - (blobuploader) - INFO - Iteration through files over. 00:53:06 INFO - Return code: 0 00:53:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:53:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:53:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2171b0b949f081f9003140cf5372dc662b84190914520417a8a3bbd54bca287c0f621d5dca9b9d53b3ba55696783625916d5de55b5e17fbedd173d1eb04d5044", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fcfd91a0da6f00a7ad56aebc12d6a3e35cc2a145a5742f48e5d6fe3e772c49513549d8eff194efe1161ef64b0d5826b654a827238d843719116251a48493355b"} 00:53:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:53:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:53:06 INFO - Contents: 00:53:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2171b0b949f081f9003140cf5372dc662b84190914520417a8a3bbd54bca287c0f621d5dca9b9d53b3ba55696783625916d5de55b5e17fbedd173d1eb04d5044", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fcfd91a0da6f00a7ad56aebc12d6a3e35cc2a145a5742f48e5d6fe3e772c49513549d8eff194efe1161ef64b0d5826b654a827238d843719116251a48493355b"} 00:53:06 INFO - Running post-run listener: copy_logs_to_upload_dir 00:53:06 INFO - Copying logs to upload dir... 00:53:06 INFO - mkdir: /builds/slave/test/build/upload/logs 00:53:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.021373 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-05-24 00:53:05.399436) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 00:53:05.403123) ========= 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=af724c981e2a0f424dbabf99000001e7-1464075154.635586-1271058610 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/2171b0b949f081f9003140cf5372dc662b84190914520417a8a3bbd54bca287c0f621d5dca9b9d53b3ba55696783625916d5de55b5e17fbedd173d1eb04d5044", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fcfd91a0da6f00a7ad56aebc12d6a3e35cc2a145a5742f48e5d6fe3e772c49513549d8eff194efe1161ef64b0d5826b654a827238d843719116251a48493355b"} build_url:https://queue.taskcluster.net/v1/task/dUdz_rolRl2DIdohw8QTuA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011330 build_url: 'https://queue.taskcluster.net/v1/task/dUdz_rolRl2DIdohw8QTuA/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/2171b0b949f081f9003140cf5372dc662b84190914520417a8a3bbd54bca287c0f621d5dca9b9d53b3ba55696783625916d5de55b5e17fbedd173d1eb04d5044", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fcfd91a0da6f00a7ad56aebc12d6a3e35cc2a145a5742f48e5d6fe3e772c49513549d8eff194efe1161ef64b0d5826b654a827238d843719116251a48493355b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 00:53:05.428171) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 00:53:05.428514) ========= 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=af724c981e2a0f424dbabf99000001e7-1464075154.635586-1271058610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 00:53:05.512950) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 00:53:05.513260) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 00:53:05.513541) ========= ========= Total master_lag: 0.17 =========