builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-027 starttime: 1461699880.94 results: success (0) buildid: 20160426120641 builduid: 7cb853e62e4c4fd68d0ab47d1a77adb5 revision: 6bbcf33e1a709cc6bd9a9ab73e303093fc748239 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 12:44:40.945444) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 12:44:40.946170) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 12:44:40.946700) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 12:44:40.999859) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 12:44:41.000312) ========= 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=1f5564757af27664ca02d71f000001b0-1461695049.605483-654579384 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-26 12:44:41-- 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% 223M=0s 2016-04-26 12:44:41 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.169922 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 12:44:41.185799) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 12:44:41.186147) ========= 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=1f5564757af27664ca02d71f000001b0-1461695049.605483-654579384 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018962 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 12:44:41.248236) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 12:44:41.248902) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6bbcf33e1a709cc6bd9a9ab73e303093fc748239 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 6bbcf33e1a709cc6bd9a9ab73e303093fc748239 --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=1f5564757af27664ca02d71f000001b0-1461695049.605483-654579384 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-26 12:44:41,370 truncating revision to first 12 chars 2016-04-26 12:44:41,370 Setting DEBUG logging. 2016-04-26 12:44:41,370 attempt 1/10 2016-04-26 12:44:41,370 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6bbcf33e1a70?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-26 12:44:41,725 unpacking tar archive at: fx-team-6bbcf33e1a70/testing/mozharness/ program finished with exit code 0 elapsedTime=0.622167 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 12:44:41.884193) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 12:44:41.884538) ========= script_repo_revision: 6bbcf33e1a709cc6bd9a9ab73e303093fc748239 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 12:44:41.885032) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 12:44:41.885347) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 12:44:41.897740) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 30 mins, 40 secs) (at 2016-04-26 12:44:41.898131) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1461695049.605483-654579384 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:44:42 INFO - MultiFileLogger online at 20160426 12:44:42 in /builds/slave/test 12:44:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 12:44:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:44:42 INFO - {'append_to_log': False, 12:44:42 INFO - 'base_work_dir': '/builds/slave/test', 12:44:42 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:44:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:44:42 INFO - 'branch': 'Fx-Team-Non-PGO', 12:44:42 INFO - 'buildbot_json_path': 'buildprops.json', 12:44:42 INFO - 'config_files': ('talos/linux_config.py',), 12:44:42 INFO - 'default_actions': ('clobber', 12:44:42 INFO - 'read-buildbot-config', 12:44:42 INFO - 'download-and-extract', 12:44:42 INFO - 'populate-webroot', 12:44:42 INFO - 'create-virtualenv', 12:44:42 INFO - 'install', 12:44:42 INFO - 'run-tests'), 12:44:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:44:42 INFO - 'download_minidump_stackwalk': True, 12:44:42 INFO - 'download_symbols': 'ondemand', 12:44:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:44:42 INFO - 'tooltool.py': '/tools/tooltool.py', 12:44:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:44:42 INFO - '/tools/misc-python/virtualenv.py')}, 12:44:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:44:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:44:42 INFO - 'installer_path': 'installer.exe', 12:44:42 INFO - 'log_level': 'info', 12:44:42 INFO - 'log_name': 'talos', 12:44:42 INFO - 'log_to_console': True, 12:44:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:44:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:44:42 INFO - 'opt_config_files': (), 12:44:42 INFO - 'pip_index': False, 12:44:42 INFO - 'sps_profile': False, 12:44:42 INFO - 'sps_profile_interval': 0, 12:44:42 INFO - 'suite': 'dromaeojs', 12:44:42 INFO - 'system_bits': '32', 12:44:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:44:42 INFO - 'title': 'talos-linux64-ix-027', 12:44:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:44:42 INFO - 'use_talos_json': True, 12:44:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:44:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:44:42 INFO - 'work_dir': 'build'} 12:44:42 INFO - ##### 12:44:42 INFO - ##### Running clobber step. 12:44:42 INFO - ##### 12:44:42 INFO - Running pre-action listener: _resource_record_pre_action 12:44:42 INFO - Running main action method: clobber 12:44:42 INFO - rmtree: /builds/slave/test/build 12:44:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:44:43 INFO - Running post-action listener: _resource_record_post_action 12:44:43 INFO - ##### 12:44:43 INFO - ##### Running read-buildbot-config step. 12:44:43 INFO - ##### 12:44:43 INFO - Running pre-action listener: _resource_record_pre_action 12:44:43 INFO - Running main action method: read_buildbot_config 12:44:43 INFO - Using buildbot properties: 12:44:43 INFO - { 12:44:43 INFO - "project": "", 12:44:43 INFO - "product": "firefox", 12:44:43 INFO - "script_repo_revision": "production", 12:44:43 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:44:43 INFO - "repository": "", 12:44:43 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 12:44:43 INFO - "buildid": "20160426120641", 12:44:43 INFO - "pgo_build": "False", 12:44:43 INFO - "basedir": "/builds/slave/test", 12:44:43 INFO - "buildnumber": 2896, 12:44:43 INFO - "slavename": "talos-linux64-ix-027", 12:44:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:44:43 INFO - "platform": "ubuntu64_hw", 12:44:43 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:44:43 INFO - "branch": "fx-team", 12:44:43 INFO - "repo_path": "integration/fx-team", 12:44:43 INFO - "revision": "6bbcf33e1a709cc6bd9a9ab73e303093fc748239", 12:44:43 INFO - "stage_platform": "linux64", 12:44:43 INFO - "builduid": "7cb853e62e4c4fd68d0ab47d1a77adb5", 12:44:43 INFO - "slavebuilddir": "test" 12:44:43 INFO - } 12:44:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 12:44:43 INFO - Running post-action listener: _resource_record_post_action 12:44:43 INFO - ##### 12:44:43 INFO - ##### Running download-and-extract step. 12:44:43 INFO - ##### 12:44:43 INFO - Running pre-action listener: _resource_record_pre_action 12:44:43 INFO - Running main action method: download_and_extract 12:44:43 INFO - mkdir: /builds/slave/test/build/tests 12:44:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:44:43 INFO - https://queue.taskcluster.net/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:44:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:44:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:44:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:44:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:44:44 INFO - Downloaded 1361 bytes. 12:44:44 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:44:44 INFO - Using the following test package requirements: 12:44:44 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 12:44:44 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:44:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:44:44 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:44:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:44:44 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:44:44 INFO - u'jsshell-linux-x86_64.zip'], 12:44:44 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:44:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:44:44 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 12:44:44 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:44:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:44:44 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:44:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:44:44 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:44:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:44:44 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:44:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:44:44 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:44:44 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')]} 12:44:44 INFO - https://queue.taskcluster.net/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:44:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:44:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:44:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:44:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:44:49 INFO - Downloaded 22291062 bytes. 12:44:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:44:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:44:50 INFO - Return code: 0 12:44:50 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:44:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:44:50 INFO - https://queue.taskcluster.net/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:44:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:44:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:44:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:44:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:44:53 INFO - Downloaded 22291062 bytes. 12:44:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:44:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:44:54 INFO - Return code: 0 12:44: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')]} 12:44:54 INFO - https://queue.taskcluster.net/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:44:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 12:44:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 12:44:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 12:44:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:44:57 INFO - Downloaded 10840145 bytes. 12:44:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:44:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 12:44:57 INFO - Return code: 0 12:44:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:44:57 INFO - https://queue.taskcluster.net/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:44:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:44:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:44:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:44:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:54:56 INFO - Downloaded 54817523 bytes. 12:54:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:54:56 INFO - mkdir: /builds/slave/test/properties 12:54:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:54:56 INFO - Writing to file /builds/slave/test/properties/build_url 12:54:56 INFO - Contents: 12:54:56 INFO - build_url:https://queue.taskcluster.net/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:54:57 INFO - Running post-action listener: _resource_record_post_action 12:54:57 INFO - Running post-action listener: set_extra_try_arguments 12:54:57 INFO - ##### 12:54:57 INFO - ##### Running populate-webroot step. 12:54:57 INFO - ##### 12:54:57 INFO - Running pre-action listener: _resource_record_pre_action 12:54:57 INFO - Running main action method: populate_webroot 12:54:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:54:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:54:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:54:57 INFO - '--tppagecycles', 12:54:57 INFO - '7'], 12:54:57 INFO - 'tests': ['tsvgm']}}, 12:54:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:54:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:54:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:54:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:54:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:54:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:54:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:57 INFO - 'talos_options': ['--disable-e10s'], 12:54:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:54:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:54:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:57 INFO - 'talos_options': ['--disable-e10s'], 12:54:57 INFO - 'tests': ['damp', 'tps']}, 12:54:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:57 INFO - 'tests': ['damp', 'tps']}, 12:54:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:54:57 INFO - 'tests': ['dromaeo_dom']}, 12:54:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:54:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:54:57 INFO - 'tests': ['a11yr', 12:54:57 INFO - 'ts_paint', 12:54:57 INFO - 'tpaint', 12:54:57 INFO - 'sessionrestore', 12:54:57 INFO - 'sessionrestore_no_auto_restore', 12:54:57 INFO - 'tabpaint']}, 12:54:57 INFO - 'other-e10s': {'tests': ['a11yr', 12:54:57 INFO - 'ts_paint', 12:54:57 INFO - 'tpaint', 12:54:57 INFO - 'sessionrestore', 12:54:57 INFO - 'sessionrestore_no_auto_restore', 12:54:57 INFO - 'tabpaint']}, 12:54:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:54:57 INFO - 'ts_paint', 12:54:57 INFO - 'tpaint', 12:54:57 INFO - 'sessionrestore', 12:54:57 INFO - 'sessionrestore_no_auto_restore', 12:54:57 INFO - 'tabpaint']}, 12:54:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:54:57 INFO - 'ts_paint', 12:54:57 INFO - 'tpaint', 12:54:57 INFO - 'sessionrestore', 12:54:57 INFO - 'sessionrestore_no_auto_restore', 12:54:57 INFO - 'tabpaint']}, 12:54:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:54:57 INFO - 'tests': ['a11yr', 12:54:57 INFO - 'ts_paint', 12:54:57 INFO - 'tpaint', 12:54:57 INFO - 'sessionrestore', 12:54:57 INFO - 'sessionrestore_no_auto_restore', 12:54:57 INFO - 'tabpaint']}, 12:54:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:54:57 INFO - 'tests': ['a11yr', 12:54:57 INFO - 'ts_paint', 12:54:57 INFO - 'tpaint', 12:54:57 INFO - 'sessionrestore', 12:54:57 INFO - 'sessionrestore_no_auto_restore', 12:54:57 INFO - 'tabpaint']}, 12:54:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:54:57 INFO - 'tests': ['tsvgx', 12:54:57 INFO - 'tsvgr_opacity', 12:54:57 INFO - 'tart', 12:54:57 INFO - 'tscrollx', 12:54:57 INFO - 'cart']}, 12:54:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:54:57 INFO - 'tsvgr_opacity', 12:54:57 INFO - 'tart', 12:54:57 INFO - 'tscrollx', 12:54:57 INFO - 'cart']}, 12:54:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:57 INFO - 'talos_options': ['--disable-e10s'], 12:54:57 INFO - 'tests': ['tp5o']}, 12:54:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:57 INFO - 'tests': ['tp5o']}, 12:54:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:57 INFO - 'talos_options': ['--disable-e10s', 12:54:57 INFO - '--xperf_path', 12:54:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:54:57 INFO - 'tests': ['tp5n']}, 12:54:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:57 INFO - 'talos_options': ['--xperf_path', 12:54:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:54:57 INFO - 'tests': ['tp5n']}}, 12:54:57 INFO - 'talos.zip': {'path': '', 12:54:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:54:57 INFO - Running post-action listener: _resource_record_post_action 12:54:57 INFO - ##### 12:54:57 INFO - ##### Running create-virtualenv step. 12:54:57 INFO - ##### 12:54:57 INFO - Running pre-action listener: _resource_record_pre_action 12:54:57 INFO - Running main action method: create_virtualenv 12:54:57 INFO - Creating virtualenv /builds/slave/test/build/venv 12:54:57 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 12:54:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:54:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:54:57 INFO - Using real prefix '/usr' 12:54:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:54:57 INFO - Installing distribute.............................................................................................................................................................................................done. 12:54:59 INFO - Installing pip.................done. 12:54:59 INFO - Return code: 0 12:54:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc45ab52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15595a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e8410>, '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 0x15e9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e97a0>, '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': '1f5564757af27664ca02d71f000001b0-1461695049.605483-654579384', '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 12:54:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:54:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:54:59 INFO - Using env: {'DISPLAY': ':0', 12:54:59 INFO - 'HOME': '/home/cltbld', 12:54:59 INFO - 'LANG': 'en_US.UTF-8', 12:54:59 INFO - 'LANGUAGE': 'en_US:en', 12:54:59 INFO - 'LOGNAME': 'cltbld', 12:54:59 INFO - 'MAIL': '/var/mail/cltbld', 12:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:59 INFO - 'MOZ_NO_REMOTE': '1', 12:54:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:59 INFO - 'NO_EM_RESTART': '1', 12:54:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:59 INFO - 'PWD': '/builds/slave/test', 12:54:59 INFO - 'SHELL': '/bin/bash', 12:54:59 INFO - 'SHLVL': '1', 12:54:59 INFO - 'TERM': 'linux', 12:54:59 INFO - 'TMOUT': '86400', 12:54:59 INFO - 'USER': 'cltbld', 12:54:59 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1461695049.605483-654579384', 12:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:59 INFO - '_': '/tools/buildbot/bin/python'} 12:54:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:59 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 12:54:59 INFO - Cleaning up... 12:54:59 INFO - Return code: 0 12:54:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc45ab52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15595a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e8410>, '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 0x15e9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e97a0>, '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': '1f5564757af27664ca02d71f000001b0-1461695049.605483-654579384', '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 12:54:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 12:54:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 12:54:59 INFO - Using env: {'DISPLAY': ':0', 12:54:59 INFO - 'HOME': '/home/cltbld', 12:54:59 INFO - 'LANG': 'en_US.UTF-8', 12:54:59 INFO - 'LANGUAGE': 'en_US:en', 12:54:59 INFO - 'LOGNAME': 'cltbld', 12:54:59 INFO - 'MAIL': '/var/mail/cltbld', 12:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:59 INFO - 'MOZ_NO_REMOTE': '1', 12:54:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:59 INFO - 'NO_EM_RESTART': '1', 12:54:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:59 INFO - 'PWD': '/builds/slave/test', 12:54:59 INFO - 'SHELL': '/bin/bash', 12:54:59 INFO - 'SHLVL': '1', 12:54:59 INFO - 'TERM': 'linux', 12:54:59 INFO - 'TMOUT': '86400', 12:54:59 INFO - 'USER': 'cltbld', 12:54:59 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1461695049.605483-654579384', 12:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:59 INFO - '_': '/tools/buildbot/bin/python'} 12:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:00 INFO - Downloading/unpacking psutil>=0.7.1 12:55:00 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 12:55:00 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 12:55:00 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 12:55:00 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 12:55:00 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 12:55:00 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 12:55:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:55:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:55:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:55:02 INFO - Installing collected packages: psutil 12:55:02 INFO - Running setup.py install for psutil 12:55:02 INFO - building 'psutil._psutil_linux' extension 12:55:02 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 12:55:02 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 12:55:02 INFO - building 'psutil._psutil_posix' extension 12:55:02 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 12:55:02 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 12:55:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:55:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:55:02 INFO - Successfully installed psutil 12:55:02 INFO - Cleaning up... 12:55:02 INFO - Return code: 0 12:55:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:55:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc45ab52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15595a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e8410>, '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 0x15e9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e97a0>, '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': '1f5564757af27664ca02d71f000001b0-1461695049.605483-654579384', '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 12:55:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:55:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:55:02 INFO - Using env: {'DISPLAY': ':0', 12:55:02 INFO - 'HOME': '/home/cltbld', 12:55:02 INFO - 'LANG': 'en_US.UTF-8', 12:55:02 INFO - 'LANGUAGE': 'en_US:en', 12:55:02 INFO - 'LOGNAME': 'cltbld', 12:55:02 INFO - 'MAIL': '/var/mail/cltbld', 12:55:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:02 INFO - 'MOZ_NO_REMOTE': '1', 12:55:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:02 INFO - 'NO_EM_RESTART': '1', 12:55:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:02 INFO - 'PWD': '/builds/slave/test', 12:55:02 INFO - 'SHELL': '/bin/bash', 12:55:02 INFO - 'SHLVL': '1', 12:55:02 INFO - 'TERM': 'linux', 12:55:02 INFO - 'TMOUT': '86400', 12:55:02 INFO - 'USER': 'cltbld', 12:55:02 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1461695049.605483-654579384', 12:55:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:02 INFO - '_': '/tools/buildbot/bin/python'} 12:55:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:55:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:55:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:55:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:55:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:55:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:55:04 INFO - Installing collected packages: mozsystemmonitor 12:55:04 INFO - Running setup.py install for mozsystemmonitor 12:55:05 INFO - Successfully installed mozsystemmonitor 12:55:05 INFO - Cleaning up... 12:55:05 INFO - Return code: 0 12:55:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:55:05 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')]} 12:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:05 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')]} 12:55:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:05 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 0x7fc45ab52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15595a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e8410>, '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 0x15e9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e97a0>, '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': '1f5564757af27664ca02d71f000001b0-1461695049.605483-654579384', '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 12:55:05 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 12:55:05 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 12:55:05 INFO - Using env: {'DISPLAY': ':0', 12:55:05 INFO - 'HOME': '/home/cltbld', 12:55:05 INFO - 'LANG': 'en_US.UTF-8', 12:55:05 INFO - 'LANGUAGE': 'en_US:en', 12:55:05 INFO - 'LOGNAME': 'cltbld', 12:55:05 INFO - 'MAIL': '/var/mail/cltbld', 12:55:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:05 INFO - 'MOZ_NO_REMOTE': '1', 12:55:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:05 INFO - 'NO_EM_RESTART': '1', 12:55:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:05 INFO - 'PWD': '/builds/slave/test', 12:55:05 INFO - 'SHELL': '/bin/bash', 12:55:05 INFO - 'SHLVL': '1', 12:55:05 INFO - 'TERM': 'linux', 12:55:05 INFO - 'TMOUT': '86400', 12:55:05 INFO - 'USER': 'cltbld', 12:55:05 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1461695049.605483-654579384', 12:55:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:05 INFO - '_': '/tools/buildbot/bin/python'} 12:55:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:05 INFO - Downloading/unpacking blobuploader==1.2.4 12:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:55:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:55:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:55:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:07 INFO - Downloading blobuploader-1.2.4.tar.gz 12:55:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:55:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:55: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 12:55: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 12:55: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 12:55: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 12:55: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 12:55: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 12:55:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:55:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:55: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 12:55: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 12:55: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 12:55: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 12:55: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 12:55: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 12:55:07 INFO - Downloading docopt-0.6.1.tar.gz 12:55:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:55:07 INFO - Installing collected packages: blobuploader, requests, docopt 12:55:07 INFO - Running setup.py install for blobuploader 12:55:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:55:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:55:07 INFO - Running setup.py install for requests 12:55:08 INFO - Running setup.py install for docopt 12:55:08 INFO - Successfully installed blobuploader requests docopt 12:55:08 INFO - Cleaning up... 12:55:08 INFO - Return code: 0 12:55:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:55:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:55:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:08 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 0x7fc45ab52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15595a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e8410>, '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 0x15e9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e97a0>, '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': '1f5564757af27664ca02d71f000001b0-1461695049.605483-654579384', '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 12:55:08 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 12:55:08 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 12:55:08 INFO - Using env: {'DISPLAY': ':0', 12:55:08 INFO - 'HOME': '/home/cltbld', 12:55:08 INFO - 'LANG': 'en_US.UTF-8', 12:55:08 INFO - 'LANGUAGE': 'en_US:en', 12:55:08 INFO - 'LOGNAME': 'cltbld', 12:55:08 INFO - 'MAIL': '/var/mail/cltbld', 12:55:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:08 INFO - 'MOZ_NO_REMOTE': '1', 12:55:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:08 INFO - 'NO_EM_RESTART': '1', 12:55:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:08 INFO - 'PWD': '/builds/slave/test', 12:55:08 INFO - 'SHELL': '/bin/bash', 12:55:08 INFO - 'SHLVL': '1', 12:55:08 INFO - 'TERM': 'linux', 12:55:08 INFO - 'TMOUT': '86400', 12:55:08 INFO - 'USER': 'cltbld', 12:55:08 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1461695049.605483-654579384', 12:55:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:08 INFO - '_': '/tools/buildbot/bin/python'} 12:55:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:55:08 INFO - Running setup.py (path:/tmp/pip-ujNvpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:55:08 INFO - Running setup.py (path:/tmp/pip-7Pw4fK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:55:08 INFO - Running setup.py (path:/tmp/pip-Rn2ouW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:55:08 INFO - Running setup.py (path:/tmp/pip-Nix5V8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:55:08 INFO - Running setup.py (path:/tmp/pip-vNYLrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:55:09 INFO - Running setup.py (path:/tmp/pip-5H8Lnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:55:09 INFO - Running setup.py (path:/tmp/pip-Xy9SZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:55:09 INFO - Running setup.py (path:/tmp/pip-m8beur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:55:09 INFO - Running setup.py (path:/tmp/pip-srX_eK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:55:09 INFO - Running setup.py (path:/tmp/pip-mT1P4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:55:09 INFO - Running setup.py (path:/tmp/pip-MxOmVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:55:09 INFO - Running setup.py (path:/tmp/pip-RpziZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:55:09 INFO - Running setup.py (path:/tmp/pip-oryQaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:55:09 INFO - Running setup.py (path:/tmp/pip-36feOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:55:09 INFO - Running setup.py (path:/tmp/pip-N_j7Fj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:55:09 INFO - Running setup.py (path:/tmp/pip-H0smGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:55:09 INFO - Running setup.py (path:/tmp/pip-EkAxUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:55:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:55:09 INFO - Running setup.py install for manifestparser 12:55:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:55:10 INFO - Running setup.py install for mozcrash 12:55:10 INFO - Running setup.py install for mozdebug 12:55:10 INFO - Running setup.py install for mozdevice 12:55:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:55:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:55:10 INFO - Running setup.py install for mozfile 12:55:10 INFO - Running setup.py install for mozhttpd 12:55:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:55:10 INFO - Running setup.py install for mozinfo 12:55:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:55:10 INFO - Running setup.py install for mozInstall 12:55:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:55:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:55:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:55:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:55:10 INFO - Running setup.py install for mozleak 12:55:10 INFO - Running setup.py install for mozlog 12:55:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:55:10 INFO - Running setup.py install for moznetwork 12:55:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:55:11 INFO - Running setup.py install for mozprocess 12:55:11 INFO - Running setup.py install for mozprofile 12:55:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:55:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:55:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:55:11 INFO - Running setup.py install for mozrunner 12:55:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:55:11 INFO - Running setup.py install for mozscreenshot 12:55:11 INFO - Running setup.py install for moztest 12:55:11 INFO - Running setup.py install for mozversion 12:55:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:55:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:55:11 INFO - Cleaning up... 12:55:11 INFO - Return code: 0 12:55:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:55:11 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')]} 12:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:11 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')]} 12:55:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:11 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 0x7fc45ab52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15595a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e8410>, '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 0x15e9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e97a0>, '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': '1f5564757af27664ca02d71f000001b0-1461695049.605483-654579384', '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 12:55:11 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 12:55:11 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 12:55:11 INFO - Using env: {'DISPLAY': ':0', 12:55:11 INFO - 'HOME': '/home/cltbld', 12:55:11 INFO - 'LANG': 'en_US.UTF-8', 12:55:11 INFO - 'LANGUAGE': 'en_US:en', 12:55:11 INFO - 'LOGNAME': 'cltbld', 12:55:11 INFO - 'MAIL': '/var/mail/cltbld', 12:55:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:11 INFO - 'MOZ_NO_REMOTE': '1', 12:55:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:11 INFO - 'NO_EM_RESTART': '1', 12:55:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:11 INFO - 'PWD': '/builds/slave/test', 12:55:11 INFO - 'SHELL': '/bin/bash', 12:55:11 INFO - 'SHLVL': '1', 12:55:11 INFO - 'TERM': 'linux', 12:55:11 INFO - 'TMOUT': '86400', 12:55:11 INFO - 'USER': 'cltbld', 12:55:11 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1461695049.605483-654579384', 12:55:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:11 INFO - '_': '/tools/buildbot/bin/python'} 12:55:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:55:11 INFO - Running setup.py (path:/tmp/pip-h30sIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:55:11 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)) 12:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:55:11 INFO - Running setup.py (path:/tmp/pip-ZLdIkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:55:12 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)) 12:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:55:12 INFO - Running setup.py (path:/tmp/pip-tfmtqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:55:12 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)) 12:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:55:12 INFO - Running setup.py (path:/tmp/pip-NjFrid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:55:12 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)) 12:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:55:12 INFO - Running setup.py (path:/tmp/pip-WrWBUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:55:12 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)) 12:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:55:12 INFO - Running setup.py (path:/tmp/pip-7SeFuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:55:12 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)) 12:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:55:12 INFO - Running setup.py (path:/tmp/pip-w8iByF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:55:12 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)) 12:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:55:12 INFO - Running setup.py (path:/tmp/pip-tyDpk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:55:12 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)) 12:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:55:12 INFO - Running setup.py (path:/tmp/pip-mg1s5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:55:12 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)) 12:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:55:12 INFO - Running setup.py (path:/tmp/pip-FM2vcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:55:12 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)) 12:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:55:12 INFO - Running setup.py (path:/tmp/pip-aGy3NX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:55:12 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)) 12:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:55:12 INFO - Running setup.py (path:/tmp/pip-H1NDuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:55:12 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)) 12:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:55:12 INFO - Running setup.py (path:/tmp/pip-PI9Bru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:55:12 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)) 12:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:55:12 INFO - Running setup.py (path:/tmp/pip-yzDqtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:55:12 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)) 12:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:55:12 INFO - Running setup.py (path:/tmp/pip-8nC_Ur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:55:12 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)) 12:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:55:13 INFO - Running setup.py (path:/tmp/pip-DI21NR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:55:13 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)) 12:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:55:13 INFO - Running setup.py (path:/tmp/pip-9t7np7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:55:13 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)) 12:55:13 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)) 12:55:13 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)) 12:55:13 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)) 12:55:13 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)) 12:55:13 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)) 12:55:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:55:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:55:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:55:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:55:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:55:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:15 INFO - Downloading blessings-1.6.tar.gz 12:55:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:55:15 INFO - Installing collected packages: blessings 12:55:15 INFO - Running setup.py install for blessings 12:55:15 INFO - Successfully installed blessings 12:55:15 INFO - Cleaning up... 12:55:15 INFO - Return code: 0 12:55:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:55:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:55:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:55:15 INFO - Reading from file tmpfile_stdout 12:55:15 INFO - Current package versions: 12:55:15 INFO - argparse == 1.2.1 12:55:15 INFO - blessings == 1.6 12:55:15 INFO - blobuploader == 1.2.4 12:55:15 INFO - docopt == 0.6.1 12:55:15 INFO - manifestparser == 1.1 12:55:15 INFO - mozInstall == 1.12 12:55:15 INFO - mozcrash == 0.17 12:55:15 INFO - mozdebug == 0.1 12:55:15 INFO - mozdevice == 0.48 12:55:15 INFO - mozfile == 1.2 12:55:15 INFO - mozhttpd == 0.7 12:55:15 INFO - mozinfo == 0.9 12:55:15 INFO - mozleak == 0.1 12:55:15 INFO - mozlog == 3.1 12:55:15 INFO - moznetwork == 0.27 12:55:15 INFO - mozprocess == 0.22 12:55:15 INFO - mozprofile == 0.28 12:55:15 INFO - mozrunner == 6.11 12:55:15 INFO - mozscreenshot == 0.1 12:55:15 INFO - mozsystemmonitor == 0.0 12:55:15 INFO - moztest == 0.7 12:55:15 INFO - mozversion == 1.4 12:55:15 INFO - psutil == 3.1.1 12:55:15 INFO - requests == 1.2.3 12:55:15 INFO - wsgiref == 0.1.2 12:55:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:55:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:55:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:15 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 0x7fc45ab52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15595a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e8410>, '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 0x15e9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e97a0>, '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': '1f5564757af27664ca02d71f000001b0-1461695049.605483-654579384', '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 12:55:15 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 12:55:15 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 12:55:15 INFO - Using env: {'DISPLAY': ':0', 12:55:15 INFO - 'HOME': '/home/cltbld', 12:55:15 INFO - 'LANG': 'en_US.UTF-8', 12:55:15 INFO - 'LANGUAGE': 'en_US:en', 12:55:15 INFO - 'LOGNAME': 'cltbld', 12:55:15 INFO - 'MAIL': '/var/mail/cltbld', 12:55:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:15 INFO - 'MOZ_NO_REMOTE': '1', 12:55:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:15 INFO - 'NO_EM_RESTART': '1', 12:55:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:15 INFO - 'PWD': '/builds/slave/test', 12:55:15 INFO - 'SHELL': '/bin/bash', 12:55:15 INFO - 'SHLVL': '1', 12:55:15 INFO - 'TERM': 'linux', 12:55:15 INFO - 'TMOUT': '86400', 12:55:15 INFO - 'USER': 'cltbld', 12:55:15 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1461695049.605483-654579384', 12:55:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:15 INFO - '_': '/tools/buildbot/bin/python'} 12:55:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:15 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)) 12:55:15 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)) 12:55:15 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)) 12:55:15 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)) 12:55:15 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)) 12:55:15 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)) 12:55:15 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)) 12:55:15 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)) 12:55:15 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)) 12:55:15 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)) 12:55:15 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)) 12:55:15 INFO - Cleaning up... 12:55:15 INFO - Return code: 0 12:55:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:55:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:55:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:15 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 0x7fc45ab52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15595a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e8410>, '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 0x15e9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e97a0>, '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': '1f5564757af27664ca02d71f000001b0-1461695049.605483-654579384', '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 12:55:15 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 12:55:15 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 12:55:15 INFO - Using env: {'DISPLAY': ':0', 12:55:15 INFO - 'HOME': '/home/cltbld', 12:55:15 INFO - 'LANG': 'en_US.UTF-8', 12:55:15 INFO - 'LANGUAGE': 'en_US:en', 12:55:15 INFO - 'LOGNAME': 'cltbld', 12:55:15 INFO - 'MAIL': '/var/mail/cltbld', 12:55:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:15 INFO - 'MOZ_NO_REMOTE': '1', 12:55:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:15 INFO - 'NO_EM_RESTART': '1', 12:55:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:15 INFO - 'PWD': '/builds/slave/test', 12:55:15 INFO - 'SHELL': '/bin/bash', 12:55:15 INFO - 'SHLVL': '1', 12:55:15 INFO - 'TERM': 'linux', 12:55:15 INFO - 'TMOUT': '86400', 12:55:15 INFO - 'USER': 'cltbld', 12:55:15 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1461695049.605483-654579384', 12:55:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:15 INFO - '_': '/tools/buildbot/bin/python'} 12:55:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:15 INFO - Downloading/unpacking jsonschema 12:55:15 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 12:55:15 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 12:55:15 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 12:55:15 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 12:55:15 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 12:55:15 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 12:55:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:55:17 INFO - Downloading/unpacking functools32 (from jsonschema) 12:55:17 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 12:55:17 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 12:55:17 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 12:55:17 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 12:55:17 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 12:55:17 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 12:55:17 INFO - Downloading functools32-3.2.3-2.tar.gz 12:55:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:55:18 INFO - warning: no files found matching '*.txt' 12:55:18 INFO - no previously-included directories found matching 'build' 12:55:18 INFO - no previously-included directories found matching 'dist' 12:55:18 INFO - no previously-included directories found matching '.git*' 12:55:18 INFO - Installing collected packages: jsonschema, functools32 12:55:18 INFO - Running setup.py install for functools32 12:55:18 INFO - warning: no files found matching '*.txt' 12:55:18 INFO - no previously-included directories found matching 'build' 12:55:18 INFO - no previously-included directories found matching 'dist' 12:55:18 INFO - no previously-included directories found matching '.git*' 12:55:18 INFO - Successfully installed jsonschema functools32 12:55:18 INFO - Cleaning up... 12:55:18 INFO - Return code: 0 12:55:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:55:18 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')]} 12:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:18 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')]} 12:55:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:18 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 0x7fc45ab52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15595a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e8410>, '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 0x15e9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e97a0>, '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': '1f5564757af27664ca02d71f000001b0-1461695049.605483-654579384', '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 12:55:18 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 12:55:18 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 12:55:18 INFO - Using env: {'DISPLAY': ':0', 12:55:18 INFO - 'HOME': '/home/cltbld', 12:55:18 INFO - 'LANG': 'en_US.UTF-8', 12:55:18 INFO - 'LANGUAGE': 'en_US:en', 12:55:18 INFO - 'LOGNAME': 'cltbld', 12:55:18 INFO - 'MAIL': '/var/mail/cltbld', 12:55:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:18 INFO - 'MOZ_NO_REMOTE': '1', 12:55:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:18 INFO - 'NO_EM_RESTART': '1', 12:55:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:18 INFO - 'PWD': '/builds/slave/test', 12:55:18 INFO - 'SHELL': '/bin/bash', 12:55:18 INFO - 'SHLVL': '1', 12:55:18 INFO - 'TERM': 'linux', 12:55:18 INFO - 'TMOUT': '86400', 12:55:18 INFO - 'USER': 'cltbld', 12:55:18 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1461695049.605483-654579384', 12:55:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:18 INFO - '_': '/tools/buildbot/bin/python'} 12:55:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:18 INFO - Downloading/unpacking flake8 12:55:18 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 12:55:18 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 12:55:18 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 12:55:18 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 12:55:18 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 12:55:18 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 12:55:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:55:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:55:20 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 12:55:20 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 12:55:20 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 12:55:20 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 12:55:20 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 12:55:20 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 12:55:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:55:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:55:20 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 12:55:20 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 12:55:20 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 12:55:20 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 12:55:20 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 12:55:20 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 12:55:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:55:20 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 12:55:20 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 12:55:20 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 12:55:20 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 12:55:20 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 12:55:20 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 12:55:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:55:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:55:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:55:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:55:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:55:20 INFO - no previously-included directories found matching 'docs/_build' 12:55:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:55:21 INFO - Running setup.py install for pep8 12:55:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:55:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:55:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:55:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:55:21 INFO - no previously-included directories found matching 'docs/_build' 12:55:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:55:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:55:21 INFO - Cleaning up... 12:55:21 INFO - Return code: 0 12:55:21 INFO - Running post-action listener: _resource_record_post_action 12:55:21 INFO - Running post-action listener: _start_resource_monitoring 12:55:21 INFO - Starting resource monitoring. 12:55:21 INFO - ##### 12:55:21 INFO - ##### Running install step. 12:55:21 INFO - ##### 12:55:21 INFO - Running pre-action listener: _resource_record_pre_action 12:55:21 INFO - Running main action method: install 12:55:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:55:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:55:21 INFO - Reading from file tmpfile_stdout 12:55:21 INFO - Detecting whether we're running mozinstall >=1.0... 12:55:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:55:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:55:21 INFO - Reading from file tmpfile_stdout 12:55:21 INFO - Output received: 12:55:21 INFO - Usage: mozinstall [options] installer 12:55:21 INFO - Options: 12:55:21 INFO - -h, --help show this help message and exit 12:55:21 INFO - -d DEST, --destination=DEST 12:55:21 INFO - Directory to install application into. [default: 12:55:21 INFO - "/builds/slave/test"] 12:55:21 INFO - --app=APP Application being installed. [default: firefox] 12:55:21 INFO - mkdir: /builds/slave/test/build/application 12:55:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:55:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:55:37 INFO - Reading from file tmpfile_stdout 12:55:37 INFO - Output received: 12:55:37 INFO - /builds/slave/test/build/application/firefox/firefox 12:55:37 INFO - Running post-action listener: _resource_record_post_action 12:55:37 INFO - ##### 12:55:37 INFO - ##### Running run-tests step. 12:55:37 INFO - ##### 12:55:37 INFO - Running pre-action listener: _resource_record_pre_action 12:55:37 INFO - Running main action method: run_tests 12:55:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:55:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:55:37 INFO - Python 2.7.3 12:55:37 INFO - Return code: 0 12:55:37 INFO - grabbing minidump binary from tooltool 12:55:37 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')]} 12:55:37 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 0x15e8410>, '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 0x15e9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e97a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:55:37 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 12:55:37 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 12:55:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:55:37 INFO - Return code: 0 12:55:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:55:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:55:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:55:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:55:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:55:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:55:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:55:38 INFO - Return code: 0 12:55:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 12:55:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 12:55:38 INFO - Using env: {'DISPLAY': ':0', 12:55:38 INFO - 'HOME': '/home/cltbld', 12:55:38 INFO - 'LANG': 'en_US.UTF-8', 12:55:38 INFO - 'LANGUAGE': 'en_US:en', 12:55:38 INFO - 'LOGNAME': 'cltbld', 12:55:38 INFO - 'MAIL': '/var/mail/cltbld', 12:55:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:55:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:55:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:38 INFO - 'MOZ_NO_REMOTE': '1', 12:55:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:55:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:38 INFO - 'NO_EM_RESTART': '1', 12:55:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:38 INFO - 'PWD': '/builds/slave/test', 12:55:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:55:38 INFO - 'SHELL': '/bin/bash', 12:55:38 INFO - 'SHLVL': '1', 12:55:38 INFO - 'TERM': 'linux', 12:55:38 INFO - 'TMOUT': '86400', 12:55:38 INFO - 'USER': 'cltbld', 12:55:38 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1461695049.605483-654579384', 12:55:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:38 INFO - '_': '/tools/buildbot/bin/python'} 12:55:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 12:55:38 INFO - mozversion application_buildid: 20160426120641 12:55:38 INFO - mozversion application_changeset: 6bbcf33e1a709cc6bd9a9ab73e303093fc748239 12:55:38 INFO - mozversion application_display_name: Nightly 12:55:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:55:38 INFO - mozversion application_name: Firefox 12:55:38 INFO - mozversion application_remotingname: firefox 12:55:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:55:38 INFO - mozversion application_vendor: Mozilla 12:55:38 INFO - mozversion application_version: 49.0a1 12:55:38 INFO - mozversion platform_buildid: 20160426120641 12:55:38 INFO - mozversion platform_changeset: 6bbcf33e1a709cc6bd9a9ab73e303093fc748239 12:55:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:55:38 INFO - mozversion platform_version: 49.0a1 12:55:38 INFO - using testdate: 1461700538 12:55:38 INFO - actual date: 1461700538 12:55:38 INFO - starting webserver on 'localhost:60813' 12:55:38 INFO - SUITE-START | Running 2 tests 12:55:38 INFO - TEST-START | dromaeo_css 12:55:38 INFO - operating with platform_type : linux_ 12:55:38 INFO - Initialising browser for dromaeo_css test... 12:55:38 INFO - TEST-INFO | started process 5204 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7K8VV9/profile http://localhost:60813/getInfo.html) 12:55:42 INFO - PROCESS | 5204 | __metrics Screen width/height:1600/1200 12:55:42 INFO - PROCESS | 5204 | colorDepth:24 12:55:42 INFO - PROCESS | 5204 | Browser inner width/height: 1024/697 12:55:42 INFO - PROCESS | 5204 | __metrics 12:55:43 ERROR - PROCESS | 5204 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:55:44 INFO - TEST-INFO | 5204: exit 0 12:55:44 INFO - Browser initialized. 12:55:44 INFO - Running cycle 1/1 for dromaeo_css test... 12:55:44 INFO - TEST-INFO | started process 5283 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7K8VV9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:55:56 INFO - PROCESS | 5283 | RSS: Main: 156061696 12:55:56 INFO - PROCESS | 5283 | 12:56:47 INFO - PROCESS | 5283 | 1461700607116 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] 12:58:58 INFO - PROCESS | 5283 | Cycle 1(1): loaded http://localhost:60813/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60813/tests/dromaeo/cssquery-ext.html) 12:58:59 INFO - PROCESS | 5283 | RSS: Main: 253300736 12:58:59 INFO - PROCESS | 5283 | 13:02:02 INFO - PROCESS | 5283 | Cycle 1(1): loaded http://localhost:60813/tests/dromaeo/cssquery-ext.html (next: http://localhost:60813/tests/dromaeo/cssquery-jquery.html) 13:02:03 INFO - PROCESS | 5283 | RSS: Main: 241000448 13:02:03 INFO - PROCESS | 5283 | 13:05:05 INFO - PROCESS | 5283 | Cycle 1(1): loaded http://localhost:60813/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60813/tests/dromaeo/cssquery-mootools.html) 13:05:05 INFO - PROCESS | 5283 | RSS: Main: 239771648 13:05:05 INFO - PROCESS | 5283 | 13:08:07 INFO - PROCESS | 5283 | Cycle 1(1): loaded http://localhost:60813/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60813/tests/dromaeo/cssquery-prototype.html) 13:08:08 INFO - PROCESS | 5283 | RSS: Main: 226856960 13:08:08 INFO - PROCESS | 5283 | 13:11:11 INFO - PROCESS | 5283 | Cycle 1(1): loaded http://localhost:60813/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60813/tests/dromaeo/cssquery-yui.html) 13:11:11 INFO - PROCESS | 5283 | RSS: Main: 213016576 13:11:11 INFO - PROCESS | 5283 | 13:14:14 INFO - PROCESS | 5283 | Cycle 1(1): loaded http://localhost:60813/tests/dromaeo/cssquery-yui.html (next: http://localhost:60813/tests/dromaeo/cssquery-dojo.html) 13:14:14 INFO - PROCESS | 5283 | RSS: Main: 271900672 13:14:14 INFO - PROCESS | 5283 | 13:14:14 INFO - PROCESS | 5283 | __start_tp_report 13:14:14 INFO - PROCESS | 5283 | _x_x_mozilla_page_load 13:14:14 INFO - PROCESS | 5283 | _x_x_mozilla_page_load_details 13:14:14 INFO - PROCESS | 5283 | |i|pagename|runs| 13:14:14 INFO - PROCESS | 5283 | |0;dojo.html;2558.9360265993346;2644.23317238001;2647.5896236083413;2654.601809728541;2661.5076210900984;4433.069055498349;4531.365608814768;4533.048059907419;4535.863924082283;4554.567316104973;4492.663050271226;4510.819567217315;4597.655175861807;4606;4621.260598304272;4163.625273725364;4167.041580436501;4186.895327616803;4249.043965107857;4343.413639158704;4292;4297.613214810666;4308.9138217235795;4315.374270730742;4351.564843515639;4085.9182816343805;4159.251334759742;4160.417541544186;4216.936745948798;4249.107687385653;4153.937690934638;4154.667626589866;4166.375043743433;4169.687273454503;4174.3112386456505;4144.564820693814;4162.562930892243;4168.353905144708;4174;4216.409702641633;4445.199864024475;4478.776061196927;4487.080148569536;4488.506264310923;4531.864044078683;4795.880102997418;4836.588889944359;4859.489753575859;4860.781264843055;4863.343448634424;4818.855434336941;4833.178359678863;4833.419989601235;4850.8059677612855;4891.755412229374;4493.393391892053;4500.077484115748;4520.977395113004;4530.980529380863;4557.58981691646;4904.705717656881;4918.1884988977135;4955.529224723646;4965.0566392385335;5038.546530812245;4782.665213435096;4802.8799280018275;4804.735739534359;4839.685420447659;4848.733319667382;4874.488178741252;4874.683145595525;4880.6095512358925;4889.364382630235;4930.211166213388;4699.412573428322;4734.076855013308;4804.111239420718;4808.975955120202;4829.782659780319;4733.290006499053;4746;4753.04939012199;4758.405199350082;4814.20565606678;4127.380892866094;4156.542780294165;4160.2303573838935;4171.0823618803815;4206.57934206583;3570.071781336819;3600;3646.1796095878217;3677.558692956862;3727.7763334200035;4155.397467367215;4172.749635021908;4178;4180.561041090703;4222.261104306734;4832.323474713543;4835.564799168092;4835.927461088087;4870.683405578626;4882.7558622068755;4113.259613269581;4198.874033778991;4218.797642671824;4247.702660813775;4261.680373971964;4349.869503914824;4350.6736994725525;4373.737575745466;4416.624586910084;4429.645628349725;4519.457665080211;4559.954400456019;4563.338315944236;4572.9314060289125;4612.192866248461;4830.985493046359;4843.709377437365;4851.417829860439;4851.854444366674;4857.295692124693;4588.816447342069;4615.284630882219;4619.214733495381;4621.676482646317;4644.5123262056995;4636.791344389443;4754.524547545356;4806.639502037291;4812.542808433193;4853.417589889236;4818.253170758538;4835.44392394865;4886.828960986349;4891.63312751538;4894.070126675921;4704.3649107370065;4715.198416269174;4715.552022557851;4718.315844202502;4766.904661906812;4608.28571571407;4672.602828759594;4695.906081878275;4722.858314250578;4759.428868535798;4647.488776234544;4687.531246875285;4695.389599352063;4718.056388722338;4740.6681532292405;4749.097671442415;4767.308740232577;4768.1417344878255;4774.164521208844;4813.518648135158;4503.166914120898;4590.104929538707;4667.509911459248;4677.46209185948;4703.129920964632 13:14:14 INFO - PROCESS | 5283 | |1;ext.html;566.6911533214397;595.1637948682102;596.6360520082749;600.5075837812996;616.7933742196363;23842.28473145804;24272.63591046136;24293.635595466083;24353.391165220855;24369.512609747795;24416.511669766594;29946.550801737936;30781.538276925865;30825.537616935708;30939;7314.707411703525;7464.141623713261;7471;7486.326230639242;7493.587852668128;7395.186529481753;7544.924550754505;7549.433792465559;7551.131619863703;7551.395888328948;7378.33594976452;7436.330730234278;7439.516431431966;7441.59071251081;7577.2422757724335;7554.357879580242;7633.427492937996;7637.885431718529;7642;7658.157602663759;7589.127250366223;7668.041494813148;7671.424643151786;7673.577953212571;7686.385089192907;31332.06003819889;31593.526097108563;31939.520907186412;32455.188620284447;32466.026019219462;2900.5649152627066;2947.2189869684553;2970.524716045444;3097.674744151877;3152;25666.615000775004;25721.871390643115;26068.73931260682;26603.467930641473;26607.20178394651;3449.7067749241346;3494.2836718472654;3510.4734289856724;3548.449990251515;3558.2527669189503;195351;196190;196322;196413;196432;25780;41722.37416438756;42392.36411453831;42447.787761060994;42552.787236063625;27231.727682722918;27279.86360068187;27336.86331568369;27383.315417114733;27386.31534211621;11877.940610296893;12099.395030248452;12118.878811211951;12138.878611213951;12195.146339756131;10133.898661013443;10319.277650564389;10323.741906452398;10336.741581460523;10340.948295258626;7599.962000189964;7654.578998155155;7724.150343462215;7733.4973226740085;7734.419918506134;2918.343372741159;2966.8664910079096;2975.0628552006483;2997.835119068472;3001.654809696869;806.7458750493576;818.8362327534517;838.4172999765104;882.9337799664922;887.2591386192602;23613.1735389264;23796.7620323798;24329.878350608134;25037.62443563348;25886.352841178745;770.8111512679429;890.1009979920327;902.1835239108617;916.706653870755;943.7593413679605;11869.881301186877;12445.564405245774;12513.749725005631;12983.740325193443;13024.804627930589;279766;285618;287394;287554;287860;37145.44281835775;38016.809915950245;38093.14301427348;38130;38133.23733525314;1029.46467836726;1064.9574017039386;1082.2856914436434;1089;1094.4691824465287;23329.650055248847;23722.169724059575;23783.52432951366;23812.809359531606;23959.640605390585;33189.17027074342;33804.66195338015;33855.830720846236;33863.492047619795;33921.830390847885;197529;205807;205987;206744;206791;18739.531511712317;18786.812131878505;19297.324593639154;19304.32434864773;21130.577388452453;30967.69032309648;31328;31399.529007064455;31981.36037279288;31986.360272793947;26879.731202687723;28918.566221507113;29603.555946660388;30023;30954.845225773726;27918.3020424491;28093.45485998208;28459.715402846534;29486.262843429085;30085.398292034475;28023.159305220877;28364.43271134607;28542;28653.426931460835;28699.856500718197;25343.493130137664;25349.746502535476;25952.740472595033;26039;26637.600435993863;20963.475913102295;21060.894695526425;21294.36116916495;21303.78696213018;21328.893355533124 13:14:14 INFO - PROCESS | 5283 | |2;jquery.html;359.3495772651501;361.1224723920873;361.7648528456503;363.99636003639966;376.5989221479126;14295.213763243017;14771.261436928151;15182;15211.315490802926;15221.92389038056;13457.596272111852;13521.594352169426;14202.218877961708;14824.851751482482;14929.701405971875;4792.568668819814;4895.877603059934;4941.382327209099;4957;4973.303737476756;4798.256270278112;4939.827106051289;4944.233643785219;4949.604031677475;4958.181899986516;4916.803327866881;4923.80304787808;4928.852134435972;5050.873728156807;5345.1447768357075;5263.6578622389425;5276.604254680914;5282.471752824726;5288.735563221842;5303.655262407931;4896.804127834882;5121.385433747974;5122.154844450662;5153.407358153785;5155.690658560498;11780.64658060251;11852.229605075643;11914.166008379418;12045.93977030118;13767.449302027906;1867.4024312220095;1875.4467432107424;1882.9246830126779;1966.6361723081134;2008.347287131688;8404.327653787683;8657.956710216471;8864.20222180007;9120.361574689774;9127.954360228156;1695.6608678264274;1701.0984178385474;1710.4270069526724;1745.4938067960277;1753.544078539576;56067.71966140143;56377.43622563804;56812.14781778277;58303;58932.705336473475;9414.576344064533;9502.287328450393;9506.287028472892;9629.277804164716;9861;12921.547745828851;13080.084394092513;13108.868911310956;13123.54067607629;13125.081244312807;6953.269906659829;7048;7122.18094919091;7172;7173.210946795953;6645.568038077509;6666.566673166229;6791;6809.795706128824;6847.828804279833;4211;4214.199302132646;4247.830086796555;4340.52254252032;4381.84663536781;1746.9602890969622;1775.1568005197687;1784.9910750446165;1792.9013904235132;1819.9272029118952;800.6597196191595;802.7832485228955;806.0810675829559;816.5386556595505;880.6257340630335;14370.13779173253;14373.20947347885;14588.34352454142;14992.550223493312;15145.924270378577;793.8928244687008;795.9164287749703;814.1573471457132;821.880827280053;828.3125006244802;8293.295069919124;8313.418060735812;8752.343574231958;9071.59177836999;9280.72157835266;378401;379483;385059;386783;388754;43480;57907.131393029136;62234;63307.6834615824;68082.65958670274;766.896468976681;961.6730311694058;973.1193270090579;1002.2533212756543;1007.4207330784828;13035.47858085704;13909.304534773019;14005.789913151515;14076.507322243673;14401.351939162972;31794.364112718078;33045.83477082695;33525.66474335225;33682.831585841916;33868.153296167795;39880.800595996836;40498.797506012284;41059.58940410558;41824.16351673011;41908.371374428796;7601.353884919844;7712.074551053909;7730.188330225245;7827.25641064098;7900;6828.556143850634;9677;10156.898431015596;10936.835947460635;11632.709182270512;10286.434246116536;10360.844587331045;10427.21795865298;10489.531465594975;10639.680809575726;9880.35777674449;9887.110160085627;9937.492534936566;10240.692779216635;10431.94784026075;10217.795644086927;10276.280660353703;10291.588336466457;10308.948455257676;10500.684979450629;7540.924590754023;7571.46999710015;7638.923610763822;7691.846163076595;7916.208379162038;8418.52675781748;9935.552900119657;10420.42687652156;10599.89400105989;10756.677299681021 13:14:14 INFO - PROCESS | 5283 | |3;mootools.html;1114.1309778372872;1290.4515580878128;1296.792513197888;1320.5246111399895;1497.3561368611493;6207.751689932403;7235.565866048034;7519.812004699886;7529.736459223928;7541.057367829028;7323.670434830432;7480.588567628778;7503.624818759054;7511.286427789365;7512.887306690404;2197.8571392859494;2221.133757834446;2222.822174226058;2224.0325458425555;2227.1091563374616;2151.333086743107;2180.901859416322;2221.3891179925567;2227.654713519407;2234.4078819112947;2176.227439259064;2180.7928246816605;2181.890905454729;2183.661532462463;2225.5882661707556;2115.502856828644;2115.841311901606;2120.692499587551;2127.308624696972;2130.0201907122664;2124.3839286606867;2158.32012915931;2160.1359456217483;2160.6650969099815;2162.232407495348;7203.351698347174;7330.523515971498;7397.038385009968;7486.588237646927;7497.10034795828;4333.761643109628;4526.981429178409;4536.455625324982;4539.4098767160385;4542.454905411372;2768.5570308750503;2805.4389122175444;2883.480973424783;2887.956680649792;2936.060460652592;913.3013244867682;918.1277786103228;924.3714274293478;924.6301479408223;935.0649350649351;10205.2346074044;10413.79172416555;10437.895621043768;10438.68683939483;10520.894791052144;4251.086016506466;4321.6974811762875;4392.868213953587;4395.7582332972;4414.183376075436;8781.692640757543;8816.735497935073;8832.823343533093;8844.204021637956;8866.069062748318;4634.72191668501;4636.11913736389;4650.906981860344;4654.069186162781;4659.58063774262;3614.1326081740194;3944.8422063117728;4039.9192016159514;4098.446709694213;4159.355299928516;3402.625711171769;3470.8091054991714;3504.474328850693;3591.5151454553825;3626.7279954003557;1159.4144956796931;1170.9824352634716;1172.3669218621849;1172.8006238939402;1173.1288594691453;748.547128986966;752.6725874244612;761.1779278379337;762.8474305138994;785.8978332816697;5103.77033033507;5120.052790233819;5146.279520867081;5168.53483186515;5326.0945639240645;402.699988508563;414.08074075552224;414.42188147534023;415.3458303172455;418.5187034909878;3341.74936879735;3473.3921563726753;3505.6669616386403;3520.559930008749;3540.8760693376125;9151.908480915106;9482.38364506305;9643.566039528238;9655.275854310814;9665.178459830853;9548.856767148498;9558.856617150748;9573;9577.473238971923;9581.904180958101;6234.844128896723;6534.738610455529;7151.427885769126;7236.565806051653;7268.309510596485;4992.675476094042;5071.670341427795;5244.239585260192;5285.656432331886;5439.700816454974;8331.95834020826;8423.11557286476;8426.15738426177;8590.926134233221;8712.564371781513;8631.43895646781;8706.04233534298;8762.649494020168;8854.734357969272;8882.60028298741;5665.206871037975;6386.882295598345;6574.934250657432;6627.5360724750735;6781.321867813179;6981.616011119438;6994.230634630085;7030.191527974348;7044.682989265393;7044.753433629799;6207.503399727921;6354.301026887131;6459.61242325462;6611.636360000246;6702.899456508254;6213.937860621336;6358.586691865014;6428.4214420702365;6455.0317452382515;6506.186726659168;5769.394213607511;5818.44724751148;5831.446012628793;5845.590808643354;5850.707464626837;4346.413234213341;4369.169857727022;4498.91002179948;4553.567411095941;4559.4072770539615;4293.8711838644895;4347.9565204347555;4372.672049596229;4443.8444654438235;4446.221911165598 13:14:14 INFO - PROCESS | 5283 | |4;prototype.html;290.19905062028795;300.19847008487335;300.33475850990055;304.160516973154;305.5142323705308;4442.62237709795;4540.682152249344;4616.884577885555;4629.930551041729;4640.071985602876;4438.489573699026;4607.976960115203;4608.285715714062;4632.467266264381;4643.489216186217;3698.2048859495203;3699.4820725098507;3699.5375578052744;3705.4627079073516;3719.497867787841;3499.667531584508;3549.290141971616;3672.338978983782;3680.2150956785936;3691.686206672436;3669.724770642199;3672.8163591820435;3680.723945704083;3686.944695829565;3688.2070354873695;3661.761985470949;3667.486551882725;3671.5227020487164;3689.4834723138515;3695.2424752925585;3266.4936934775146;3272.672732726708;3287.7534184936226;3290.07877794218;3295.2750394913082;4236.533981262059;4470.552944705536;4489.326601009842;4519;4525.637948964075;4122.2579935611575;4153.273177194009;4155.896102597429;4163.791810409498;4169.97915010426;4851.708897466164;4856.3201151838775;4862.927056094126;4868.829590964335;4886;3262.8531716072835;3479.1997840496574;3499.6500349965054;3500.824958752052;3522.876699315512;5005.89988200234;5026.894083301668;5032.4212715537815;5046.6719663221775;5052.7726252318735;3521.964780352215;3525.2773181497732;3544.946825797615;3547.6984456320984;3562.786232826039;3588.7129029677562;3589.3180295743723;3598.514200582888;3601.3877640801124;3618.945715814265;3987.142764305688;4077.44954431148;4121.258173528734;4123.814428350672;4128.690348223835;4800.495947925418;4802.807887684454;4822.541858523435;4838.177509823268;4842.878928026827;1219.4939100273286;1305.614843621134;1315.3094625321783;1372.883304919093;1372.8901687864948;892.7812685891998;933.7992331648728;950.0689324461928;955.2262667239559;963.7301555564453;4472.843450479218;4474.619657329164;4515.3970340529295;4517.277235642281;4559.566841150086;5229.097850692826;5254.973725131426;5267.394249661262;5269.868253293698;5282;4430.357598148251;4518.9548104518535;4565.474970378383;4572.839950601713;4578.6794924355645;2819.3374556979093;2833.121732263005;2839.432113577293;2840.1053668094896;2842.786790990684;4989.700617962933;5023.623228257895;5031.144705400091;5036.7733451994745;5054.82308119214;5137.17805151174;5388.326459192601;5402.621816472809;5418.970395624819;5423;4931.10152591255;4934.136526107988;4949.238578680157;5012.097822391932;5038.370203724535;5174.663646862942;5247.897941432342;5248.343957005374;5263.631545791911;5269.78920843162;5016.043742940184;5103.515166059218;5152.922706159336;5166;5182.352205974254;4990.850274491771;4991.825286115114;4995.3765026365845;5007.499250074963;5021.4225364083595;3885.417187421909;3887.105965627978;3896.2012787379085;3900.219956008753;3909.7849618271266;4826.710397376169;4827.348307978378;5271.841844744664;5281.841544753664;5286.894262114659;4719.669623126349;4913.77887995034;4920.286558448934;4920.630952678492;4936.802527898843;4901.387326584177;4931.235658472942;4952.975235123801;4968.205087186033;4968.527989840959;4625.167469855458;4877.658563900635;4879.341288926092;4880.707157570557;4885.7801398937845;4933.186024306093;4946.431160416598;4950.108980383421;4961.156603377362;4964.957358954515;4882.780274887709;4889.315495830658;4892.510748925079;4893;4912.7543622818 13:14:14 INFO - PROCESS | 5283 | |5;yui.html;622.3030206169092;650.2911826109541;650.5966300893447;673.1114928294652;675.3820254467159;11183.608573699923;11430.54277828887;11455.828162577567;11469.369184694839;11492.712682182939;11482;11542.192046556744;12006.399680015986;12013.399330033508;12023.879761202385;520.1936997653622;522.8928069745712;523.8192823475914;565.9445134823566;575.712143928035;499.4231662429899;533.4159095790104;543.7335705504294;545.2393910494857;545.6562365709598;643.7296335539085;644.9000404937242;649.1723053107279;653.9705713242892;664.2029564522568;530.9230161626581;561.0994354061734;561.2927711084022;562.5246666566744;563.1974436428073;393.4531001907351;403.7032780906032;407.824635406775;410.9034376921421;411.3295328614369;11582.884171158265;11612.12909031826;11615.128865335133;11634.6509604712;11636.360000199986;10819.242653014293;10902.127829773599;11222;11391.259568128127;11635.941820290844;9579.904200957972;9650.75873103171;9657.688271450674;9716.222702183808;9730.659426920094;3248.545203671488;3253.902382928516;3277.3281477297096;3321.368939901411;3335.8999230022896;43489.34765978481;43683;43980.12039759219;44175.558244417465;44202.03272558196;8487.490750554987;8723.476591404537;8790.86813697795;8937.195652391316;9027.63889444428;15561.144137072344;15925.283362248727;16012.919935400249;16115.113668748332;16374.918125409535;5731.598788084794;5751.396103409082;5894.381089985575;5942.346341902387;5948.702564871739;3616.8372423241017;3646.5624125105155;3683.5395575553057;3687.870924517629;3722.050877026341;2641.088824355594;2685.677718673772;2686.8790904409348;2692.5018871508832;2695.4339588686203;461.9307103934437;476.86886106320344;477.2983713940502;487.665948825056;488.9608831293488;474.3833017077785;547.3923944421689;605.125593517372;617.0928734759985;617.6355949989528;8092.595370231465;8249.29880960125;8453.239208471266;8728.127187281221;8747.343949203836;574.9051406517877;578.945000224978;579.3482332376077;585.3473377184408;604.9848753781102;3528.1708798432346;3554.484599733076;3582.1940063486027;3698.1124530113116;3698.260347930425;51474.22788658173;52264.47735522596;53928;53984.730076350155;54010.45989540133;45688.54311456843;46752.7662361686;46969.765151174026;47855.5214447858;49758.253626195634;44556.77721611371;44644.55355446469;44930.55069449329;45247.773761130986;45556.54443455523;7353.742619008309;7580.090389153116;7596.354309883722;7626.9618651906385;7644.617769111411;28655.42689146247;29527.704722952494;29539.409211815215;29706.405871882875;29957.251068723457;37222;37902.810485948496;39826;40643.390349144196;40732.38901416422;9033.187013168847;9091.818163636557;9202.447853128833;9497.762555936157;9575.473348965874;9775.657851975147;9838.803223935338;9941.801163976825;10092.697219083439;10278.640247591298;8242.958785206036;9097.772555685897;9366.625334986524;10880.129589632968;11468.467208693488;10744.785104298027;10821.18841086906;10984;11071.446427678422;11426.812497207224;10958.616448424267;10972;11025.283356581796;11482.311061336346;11662.53349865996;8845.601947912231;8982.82034359296;9312.953435232781;9350.812983740423;9366.718998430058;8784.736457906272;8936.687215947411;8992.910070899468;9067.183953444222;9088 13:14:14 INFO - PROCESS | 5283 | __end_tp_report 13:14:14 INFO - PROCESS | 5283 | __start_cc_report 13:14:14 INFO - PROCESS | 5283 | _x_x_mozilla_cycle_collect,874 13:14:14 INFO - PROCESS | 5283 | __end_cc_report 13:14:14 INFO - PROCESS | 5283 | __startTimestamp1461701654712__endTimestamp 13:14:14 INFO - PROCESS | 5283 | 13:14:14 INFO - PROCESS | 5283 | ------- Summary: start ------- 13:14:14 INFO - PROCESS | 5283 | Number of tests: 6 13:14:14 INFO - PROCESS | 5283 | 13:14:14 INFO - PROCESS | 5283 | [#0] dojo.html Cycles:165 Average:4493.22 Median:4612.19 stddev:446.88 (9.7%) stddev-sans-first:421.70 13:14:14 INFO - PROCESS | 5283 | Values: 2558.9 2644.2 2647.6 2654.6 2661.5 4433.1 4531.4 4533.0 4535.9 4554.6 4492.7 4510.8 4597.7 4606.0 4621.3 4163.6 4167.0 4186.9 4249.0 4343.4 4292.0 4297.6 4308.9 4315.4 4351.6 4085.9 4159.3 4160.4 4216.9 4249.1 4153.9 4154.7 4166.4 4169.7 4174.3 4144.6 4162.6 4168.4 4174.0 4216.4 4445.2 4478.8 4487.1 4488.5 4531.9 4795.9 4836.6 4859.5 4860.8 4863.3 4818.9 4833.2 4833.4 4850.8 4891.8 4493.4 4500.1 4521.0 4531.0 4557.6 4904.7 4918.2 4955.5 4965.1 5038.5 4782.7 4802.9 4804.7 4839.7 4848.7 4874.5 4874.7 4880.6 4889.4 4930.2 4699.4 4734.1 4804.1 4809.0 4829.8 4733.3 4746.0 4753.0 4758.4 4814.2 4127.4 4156.5 4160.2 4171.1 4206.6 3570.1 3600.0 3646.2 3677.6 3727.8 4155.4 4172.7 4178.0 4180.6 4222.3 4832.3 4835.6 4835.9 4870.7 4882.8 4113.3 4198.9 4218.8 4247.7 4261.7 4349.9 4350.7 4373.7 4416.6 4429.6 4519.5 4560.0 4563.3 4572.9 4612.2 4831.0 4843.7 4851.4 4851.9 4857.3 4588.8 4615.3 4619.2 4621.7 4644.5 4636.8 4754.5 4806.6 4812.5 4853.4 4818.3 4835.4 4886.8 4891.6 4894.1 4704.4 4715.2 4715.6 4718.3 4766.9 4608.3 4672.6 4695.9 4722.9 4759.4 4647.5 4687.5 4695.4 4718.1 4740.7 4749.1 4767.3 4768.1 4774.2 4813.5 4503.2 4590.1 4667.5 4677.5 4703.1 13:14:14 INFO - PROCESS | 5283 | 13:14:14 INFO - PROCESS | 5283 | [#1] ext.html Cycles:180 Average:35056.96 Median:29544.91 stddev:60877.49 (206.1%) stddev-sans-first:60993.18 13:14:14 INFO - PROCESS | 5283 | Values: 566.7 595.2 596.6 600.5 616.8 23842.3 24272.6 24293.6 24353.4 24369.5 24416.5 29946.6 30781.5 30825.5 30939.0 7314.7 7464.1 7471.0 7486.3 7493.6 7395.2 7544.9 7549.4 7551.1 7551.4 7378.3 7436.3 7439.5 7441.6 7577.2 7554.4 7633.4 7637.9 7642.0 7658.2 7589.1 7668.0 7671.4 7673.6 7686.4 31332.1 31593.5 31939.5 32455.2 32466.0 2900.6 2947.2 2970.5 3097.7 3152.0 25666.6 25721.9 26068.7 26603.5 26607.2 3449.7 3494.3 3510.5 3548.4 3558.3 195351.0 196190.0 196322.0 196413.0 196432.0 25780.0 41722.4 42392.4 42447.8 42552.8 27231.7 27279.9 27336.9 27383.3 27386.3 11877.9 12099.4 12118.9 12138.9 12195.1 10133.9 10319.3 10323.7 10336.7 10340.9 7600.0 7654.6 7724.2 7733.5 7734.4 2918.3 2966.9 2975.1 2997.8 3001.7 806.7 818.8 838.4 882.9 887.3 23613.2 23796.8 24329.9 25037.6 25886.4 770.8 890.1 902.2 916.7 943.8 11869.9 12445.6 12513.7 12983.7 13024.8 279766.0 285618.0 287394.0 287554.0 287860.0 37145.4 38016.8 38093.1 38130.0 38133.2 1029.5 1065.0 1082.3 1089.0 1094.5 23329.7 23722.2 23783.5 23812.8 23959.6 33189.2 33804.7 33855.8 33863.5 33921.8 197529.0 205807.0 205987.0 206744.0 206791.0 18739.5 18786.8 19297.3 19304.3 21130.6 30967.7 31328.0 31399.5 31981.4 31986.4 26879.7 28918.6 29603.6 30023.0 30954.8 27918.3 28093.5 28459.7 29486.3 30085.4 28023.2 28364.4 28542.0 28653.4 28699.9 25343.5 25349.7 25952.7 26039.0 26637.6 20963.5 21060.9 21294.4 21303.8 21328.9 13:14:14 INFO - PROCESS | 5283 | 13:14:14 INFO - PROCESS | 5283 | [#2] jquery.html Cycles:180 Average:22285.59 Median:4587.21 stddev:62819.21 (1369.4%) stddev-sans-first:62973.86 13:14:14 INFO - PROCESS | 5283 | Values: 359.3 361.1 361.8 364.0 376.6 14295.2 14771.3 15182.0 15211.3 15221.9 13457.6 13521.6 14202.2 14824.9 14929.7 4792.6 4895.9 4941.4 4957.0 4973.3 4798.3 4939.8 4944.2 4949.6 4958.2 4916.8 4923.8 4928.9 5050.9 5345.1 5263.7 5276.6 5282.5 5288.7 5303.7 4896.8 5121.4 5122.2 5153.4 5155.7 11780.6 11852.2 11914.2 12045.9 13767.4 1867.4 1875.4 1882.9 1966.6 2008.3 8404.3 8658.0 8864.2 9120.4 9128.0 1695.7 1701.1 1710.4 1745.5 1753.5 56067.7 56377.4 56812.1 58303.0 58932.7 9414.6 9502.3 9506.3 9629.3 9861.0 12921.5 13080.1 13108.9 13123.5 13125.1 6953.3 7048.0 7122.2 7172.0 7173.2 6645.6 6666.6 6791.0 6809.8 6847.8 4211.0 4214.2 4247.8 4340.5 4381.8 1747.0 1775.2 1785.0 1792.9 1819.9 800.7 802.8 806.1 816.5 880.6 14370.1 14373.2 14588.3 14992.6 15145.9 793.9 795.9 814.2 821.9 828.3 8293.3 8313.4 8752.3 9071.6 9280.7 378401.0 379483.0 385059.0 386783.0 388754.0 43480.0 57907.1 62234.0 63307.7 68082.7 766.9 961.7 973.1 1002.3 1007.4 13035.5 13909.3 14005.8 14076.5 14401.4 31794.4 33045.8 33525.7 33682.8 33868.2 39880.8 40498.8 41059.6 41824.2 41908.4 7601.4 7712.1 7730.2 7827.3 7900.0 6828.6 9677.0 10156.9 10936.8 11632.7 10286.4 10360.8 10427.2 10489.5 10639.7 9880.4 9887.1 9937.5 10240.7 10431.9 10217.8 10276.3 10291.6 10308.9 10500.7 7540.9 7571.5 7638.9 7691.8 7916.2 8418.5 9935.6 10420.4 10599.9 10756.7 13:14:14 INFO - PROCESS | 5283 | 13:14:14 INFO - PROCESS | 5283 | [#3] mootools.html Cycles:180 Average:4962.22 Median:5032.17 stddev:2791.06 (55.5%) stddev-sans-first:2783.91 13:14:14 INFO - PROCESS | 5283 | Values: 1114.1 1290.5 1296.8 1320.5 1497.4 6207.8 7235.6 7519.8 7529.7 7541.1 7323.7 7480.6 7503.6 7511.3 7512.9 2197.9 2221.1 2222.8 2224.0 2227.1 2151.3 2180.9 2221.4 2227.7 2234.4 2176.2 2180.8 2181.9 2183.7 2225.6 2115.5 2115.8 2120.7 2127.3 2130.0 2124.4 2158.3 2160.1 2160.7 2162.2 7203.4 7330.5 7397.0 7486.6 7497.1 4333.8 4527.0 4536.5 4539.4 4542.5 2768.6 2805.4 2883.5 2888.0 2936.1 913.3 918.1 924.4 924.6 935.1 10205.2 10413.8 10437.9 10438.7 10520.9 4251.1 4321.7 4392.9 4395.8 4414.2 8781.7 8816.7 8832.8 8844.2 8866.1 4634.7 4636.1 4650.9 4654.1 4659.6 3614.1 3944.8 4039.9 4098.4 4159.4 3402.6 3470.8 3504.5 3591.5 3626.7 1159.4 1171.0 1172.4 1172.8 1173.1 748.5 752.7 761.2 762.8 785.9 5103.8 5120.1 5146.3 5168.5 5326.1 402.7 414.1 414.4 415.3 418.5 3341.7 3473.4 3505.7 3520.6 3540.9 9151.9 9482.4 9643.6 9655.3 9665.2 9548.9 9558.9 9573.0 9577.5 9581.9 6234.8 6534.7 7151.4 7236.6 7268.3 4992.7 5071.7 5244.2 5285.7 5439.7 8332.0 8423.1 8426.2 8590.9 8712.6 8631.4 8706.0 8762.6 8854.7 8882.6 5665.2 6386.9 6574.9 6627.5 6781.3 6981.6 6994.2 7030.2 7044.7 7044.8 6207.5 6354.3 6459.6 6611.6 6702.9 6213.9 6358.6 6428.4 6455.0 6506.2 5769.4 5818.4 5831.4 5845.6 5850.7 4346.4 4369.2 4498.9 4553.6 4559.4 4293.9 4348.0 4372.7 4443.8 4446.2 13:14:14 INFO - PROCESS | 5283 | 13:14:14 INFO - PROCESS | 5283 | [#4] prototype.html Cycles:180 Average:4139.84 Median:4621.03 stddev:1194.98 (25.9%) stddev-sans-first:1162.88 13:14:14 INFO - PROCESS | 5283 | Values: 290.2 300.2 300.3 304.2 305.5 4442.6 4540.7 4616.9 4629.9 4640.1 4438.5 4608.0 4608.3 4632.5 4643.5 3698.2 3699.5 3699.5 3705.5 3719.5 3499.7 3549.3 3672.3 3680.2 3691.7 3669.7 3672.8 3680.7 3686.9 3688.2 3661.8 3667.5 3671.5 3689.5 3695.2 3266.5 3272.7 3287.8 3290.1 3295.3 4236.5 4470.6 4489.3 4519.0 4525.6 4122.3 4153.3 4155.9 4163.8 4170.0 4851.7 4856.3 4862.9 4868.8 4886.0 3262.9 3479.2 3499.7 3500.8 3522.9 5005.9 5026.9 5032.4 5046.7 5052.8 3522.0 3525.3 3544.9 3547.7 3562.8 3588.7 3589.3 3598.5 3601.4 3618.9 3987.1 4077.4 4121.3 4123.8 4128.7 4800.5 4802.8 4822.5 4838.2 4842.9 1219.5 1305.6 1315.3 1372.9 1372.9 892.8 933.8 950.1 955.2 963.7 4472.8 4474.6 4515.4 4517.3 4559.6 5229.1 5255.0 5267.4 5269.9 5282.0 4430.4 4519.0 4565.5 4572.8 4578.7 2819.3 2833.1 2839.4 2840.1 2842.8 4989.7 5023.6 5031.1 5036.8 5054.8 5137.2 5388.3 5402.6 5419.0 5423.0 4931.1 4934.1 4949.2 5012.1 5038.4 5174.7 5247.9 5248.3 5263.6 5269.8 5016.0 5103.5 5152.9 5166.0 5182.4 4990.9 4991.8 4995.4 5007.5 5021.4 3885.4 3887.1 3896.2 3900.2 3909.8 4826.7 4827.3 5271.8 5281.8 5286.9 4719.7 4913.8 4920.3 4920.6 4936.8 4901.4 4931.2 4953.0 4968.2 4968.5 4625.2 4877.7 4879.3 4880.7 4885.8 4933.2 4946.4 4950.1 4961.2 4965.0 4882.8 4889.3 4892.5 4893.0 4912.8 13:14:14 INFO - PROCESS | 5283 | 13:14:14 INFO - PROCESS | 5283 | [#5] yui.html Cycles:180 Average:12450.31 Median:24166.41 stddev:14685.15 (60.8%) stddev-sans-first:14699.49 13:14:14 INFO - PROCESS | 5283 | Values: 622.3 650.3 650.6 673.1 675.4 11183.6 11430.5 11455.8 11469.4 11492.7 11482.0 11542.2 12006.4 12013.4 12023.9 520.2 522.9 523.8 565.9 575.7 499.4 533.4 543.7 545.2 545.7 643.7 644.9 649.2 654.0 664.2 530.9 561.1 561.3 562.5 563.2 393.5 403.7 407.8 410.9 411.3 11582.9 11612.1 11615.1 11634.7 11636.4 10819.2 10902.1 11222.0 11391.3 11635.9 9579.9 9650.8 9657.7 9716.2 9730.7 3248.5 3253.9 3277.3 3321.4 3335.9 43489.3 43683.0 43980.1 44175.6 44202.0 8487.5 8723.5 8790.9 8937.2 9027.6 15561.1 15925.3 16012.9 16115.1 16374.9 5731.6 5751.4 5894.4 5942.3 5948.7 3616.8 3646.6 3683.5 3687.9 3722.1 2641.1 2685.7 2686.9 2692.5 2695.4 461.9 476.9 477.3 487.7 489.0 474.4 547.4 605.1 617.1 617.6 8092.6 8249.3 8453.2 8728.1 8747.3 574.9 578.9 579.3 585.3 605.0 3528.2 3554.5 3582.2 3698.1 3698.3 51474.2 52264.5 53928.0 53984.7 54010.5 45688.5 46752.8 46969.8 47855.5 49758.3 44556.8 44644.6 44930.6 45247.8 45556.5 7353.7 7580.1 7596.4 7627.0 7644.6 28655.4 29527.7 29539.4 29706.4 29957.3 37222.0 37902.8 39826.0 40643.4 40732.4 9033.2 9091.8 9202.4 9497.8 9575.5 9775.7 9838.8 9941.8 10092.7 10278.6 8243.0 9097.8 9366.6 10880.1 11468.5 10744.8 10821.2 10984.0 11071.4 11426.8 10958.6 10972.0 11025.3 11482.3 11662.5 8845.6 8982.8 9313.0 9350.8 9366.7 8784.7 8936.7 8992.9 9067.2 9088.0 13:14:14 INFO - PROCESS | 5283 | -------- Summary: end -------- 13:14:14 INFO - PROCESS | 5283 | 13:14:15 INFO - TEST-INFO | 5283: exit 0 13:14:15 INFO - TEST-OK | dromaeo_css | took 1116995ms 13:14:15 INFO - TEST-START | kraken 13:14:15 INFO - operating with platform_type : linux_ 13:14:15 INFO - Initialising browser for kraken test... 13:14:15 INFO - TEST-INFO | started process 5464 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXLIw_N/profile http://localhost:60813/getInfo.html) 13:14:19 INFO - PROCESS | 5464 | __metrics Screen width/height:1600/1200 13:14:19 INFO - PROCESS | 5464 | colorDepth:24 13:14:19 INFO - PROCESS | 5464 | Browser inner width/height: 1024/697 13:14:19 INFO - PROCESS | 5464 | __metrics 13:14:20 ERROR - PROCESS | 5464 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:14:21 INFO - TEST-INFO | 5464: exit 0 13:14:21 INFO - Browser initialized. 13:14:21 INFO - Running cycle 1/1 for kraken test... 13:14:21 INFO - TEST-INFO | started process 5545 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXLIw_N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:14:33 INFO - PROCESS | 5545 | RSS: Main: 155934720 13:14:33 INFO - PROCESS | 5545 | 13:14:36 INFO - PROCESS | 5545 | Cycle 1(1): loaded http://localhost:60813/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60813/tests/kraken/driver.html?testName=audio-beat-detection) 13:14:36 INFO - PROCESS | 5545 | RSS: Main: 210628608 13:14:36 INFO - PROCESS | 5545 | 13:14:39 INFO - PROCESS | 5545 | Cycle 1(1): loaded http://localhost:60813/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60813/tests/kraken/driver.html?testName=audio-dft) 13:14:40 INFO - PROCESS | 5545 | RSS: Main: 196530176 13:14:40 INFO - PROCESS | 5545 | 13:14:43 INFO - PROCESS | 5545 | Cycle 1(1): loaded http://localhost:60813/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60813/tests/kraken/driver.html?testName=audio-fft) 13:14:44 INFO - PROCESS | 5545 | RSS: Main: 267935744 13:14:44 INFO - PROCESS | 5545 | 13:14:46 INFO - PROCESS | 5545 | Cycle 1(1): loaded http://localhost:60813/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60813/tests/kraken/driver.html?testName=audio-oscillator) 13:14:46 INFO - PROCESS | 5545 | RSS: Main: 175230976 13:14:46 INFO - PROCESS | 5545 | 13:14:49 INFO - PROCESS | 5545 | Cycle 1(1): loaded http://localhost:60813/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60813/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:14:49 INFO - PROCESS | 5545 | RSS: Main: 179482624 13:14:49 INFO - PROCESS | 5545 | 13:14:52 INFO - PROCESS | 5545 | Cycle 1(1): loaded http://localhost:60813/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60813/tests/kraken/driver.html?testName=imaging-darkroom) 13:14:53 INFO - PROCESS | 5545 | RSS: Main: 215506944 13:14:53 INFO - PROCESS | 5545 | 13:14:57 INFO - PROCESS | 5545 | Cycle 1(1): loaded http://localhost:60813/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60813/tests/kraken/driver.html?testName=imaging-desaturate) 13:14:57 INFO - PROCESS | 5545 | RSS: Main: 216502272 13:14:57 INFO - PROCESS | 5545 | 13:15:00 INFO - PROCESS | 5545 | Cycle 1(1): loaded http://localhost:60813/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60813/tests/kraken/driver.html?testName=json-parse-financial) 13:15:01 INFO - PROCESS | 5545 | RSS: Main: 217092096 13:15:01 INFO - PROCESS | 5545 | 13:15:02 INFO - PROCESS | 5545 | Cycle 1(1): loaded http://localhost:60813/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60813/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:15:03 INFO - PROCESS | 5545 | RSS: Main: 203870208 13:15:03 INFO - PROCESS | 5545 | 13:15:05 INFO - PROCESS | 5545 | Cycle 1(1): loaded http://localhost:60813/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60813/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:15:05 INFO - PROCESS | 5545 | RSS: Main: 203272192 13:15:05 INFO - PROCESS | 5545 | 13:15:07 INFO - PROCESS | 5545 | Cycle 1(1): loaded http://localhost:60813/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60813/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:15:08 INFO - PROCESS | 5545 | RSS: Main: 217034752 13:15:08 INFO - PROCESS | 5545 | 13:15:11 INFO - PROCESS | 5545 | Cycle 1(1): loaded http://localhost:60813/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60813/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:15:12 INFO - PROCESS | 5545 | RSS: Main: 225263616 13:15:12 INFO - PROCESS | 5545 | 13:15:15 INFO - PROCESS | 5545 | Cycle 1(1): loaded http://localhost:60813/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60813/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:15:16 INFO - PROCESS | 5545 | RSS: Main: 220819456 13:15:16 INFO - PROCESS | 5545 | 13:15:17 INFO - PROCESS | 5545 | Cycle 1(1): loaded http://localhost:60813/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60813/tests/kraken/driver.html?testName=ai-astar) 13:15:18 INFO - PROCESS | 5545 | RSS: Main: 283820032 13:15:18 INFO - PROCESS | 5545 | 13:15:18 INFO - PROCESS | 5545 | __start_tp_report 13:15:18 INFO - PROCESS | 5545 | _x_x_mozilla_page_load 13:15:18 INFO - PROCESS | 5545 | _x_x_mozilla_page_load_details 13:15:18 INFO - PROCESS | 5545 | |i|pagename|runs| 13:15:18 INFO - PROCESS | 5545 | |0;ai-astar;113;113;109;113;115;113;103;112;115;115 13:15:18 INFO - PROCESS | 5545 | |1;audio-beat-detection;164;137;161;179;132;158;157;137;195;139 13:15:18 INFO - PROCESS | 5545 | |2;audio-dft;161;161;159;162;162;161;162;161;162;162 13:15:18 INFO - PROCESS | 5545 | |3;audio-fft;73;75;117;107;77;74;73;133;119;74 13:15:18 INFO - PROCESS | 5545 | |4;audio-oscillator;94;94;147;93;95;93;141;94;95;146 13:15:18 INFO - PROCESS | 5545 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;117;117 13:15:18 INFO - PROCESS | 5545 | |6;imaging-darkroom;146;146;146;147;146;146;146;146;147;146 13:15:18 INFO - PROCESS | 5545 | |7;imaging-desaturate;94;95;95;95;95;95;98;95;95;95 13:15:18 INFO - PROCESS | 5545 | |8;json-parse-financial;66;66;67;66;66;65;66;82;65;64 13:15:18 INFO - PROCESS | 5545 | |9;json-stringify-tinderbox;65;65;66;66;66;66;65;65;65;66 13:15:18 INFO - PROCESS | 5545 | |10;stanford-crypto-aes;79;78;78;79;80;81;81;81;79;79 13:15:18 INFO - PROCESS | 5545 | |11;stanford-crypto-ccm;135;133;133;136;133;131;138;136;179;136 13:15:18 INFO - PROCESS | 5545 | |12;stanford-crypto-pbkdf2;214;216;222;217;218;218;220;220;217;217 13:15:18 INFO - PROCESS | 5545 | |13;stanford-crypto-sha256-iterative;77;74;74;76;75;74;84;73;75;74 13:15:18 INFO - PROCESS | 5545 | __end_tp_report 13:15:18 INFO - PROCESS | 5545 | __start_cc_report 13:15:18 INFO - PROCESS | 5545 | _x_x_mozilla_cycle_collect,1894 13:15:18 INFO - PROCESS | 5545 | __end_cc_report 13:15:18 INFO - PROCESS | 5545 | __startTimestamp1461701718174__endTimestamp 13:15:18 INFO - PROCESS | 5545 | 13:15:18 INFO - PROCESS | 5545 | ------- Summary: start ------- 13:15:18 INFO - PROCESS | 5545 | Number of tests: 14 13:15:18 INFO - PROCESS | 5545 | 13:15:18 INFO - PROCESS | 5545 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.00 stddev:3.67 (3.2%) stddev-sans-first:3.87 13:15:18 INFO - PROCESS | 5545 | Values: 113.0 113.0 109.0 113.0 115.0 113.0 103.0 112.0 115.0 115.0 13:15:18 INFO - PROCESS | 5545 | 13:15:18 INFO - PROCESS | 5545 | [#1] audio-beat-detection Cycles:10 Average:155.90 Median:159.50 stddev:20.36 (12.8%) stddev-sans-first:21.38 13:15:18 INFO - PROCESS | 5545 | Values: 164.0 137.0 161.0 179.0 132.0 158.0 157.0 137.0 195.0 139.0 13:15:18 INFO - PROCESS | 5545 | 13:15:18 INFO - PROCESS | 5545 | [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 13:15:18 INFO - PROCESS | 5545 | Values: 161.0 161.0 159.0 162.0 162.0 161.0 162.0 161.0 162.0 162.0 13:15:18 INFO - PROCESS | 5545 | 13:15:18 INFO - PROCESS | 5545 | [#3] audio-fft Cycles:10 Average:92.20 Median:73.50 stddev:23.91 (32.5%) stddev-sans-first:24.33 13:15:18 INFO - PROCESS | 5545 | Values: 73.0 75.0 117.0 107.0 77.0 74.0 73.0 133.0 119.0 74.0 13:15:18 INFO - PROCESS | 5545 | 13:15:18 INFO - PROCESS | 5545 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:94.00 stddev:24.53 (26.1%) stddev-sans-first:25.39 13:15:18 INFO - PROCESS | 5545 | Values: 94.0 94.0 147.0 93.0 95.0 93.0 141.0 94.0 95.0 146.0 13:15:18 INFO - PROCESS | 5545 | 13:15:18 INFO - PROCESS | 5545 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 13:15:18 INFO - PROCESS | 5545 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 13:15:18 INFO - PROCESS | 5545 | 13:15:18 INFO - PROCESS | 5545 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 13:15:18 INFO - PROCESS | 5545 | Values: 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 147.0 146.0 13:15:18 INFO - PROCESS | 5545 | 13:15:18 INFO - PROCESS | 5545 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:1.03 (1.1%) stddev-sans-first:1.00 13:15:18 INFO - PROCESS | 5545 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 98.0 95.0 95.0 95.0 13:15:18 INFO - PROCESS | 5545 | 13:15:18 INFO - PROCESS | 5545 | [#8] json-parse-financial Cycles:10 Average:67.30 Median:66.00 stddev:5.23 (7.9%) stddev-sans-first:5.53 13:15:18 INFO - PROCESS | 5545 | Values: 66.0 66.0 67.0 66.0 66.0 65.0 66.0 82.0 65.0 64.0 13:15:18 INFO - PROCESS | 5545 | 13:15:18 INFO - PROCESS | 5545 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:66.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 13:15:18 INFO - PROCESS | 5545 | Values: 65.0 65.0 66.0 66.0 66.0 66.0 65.0 65.0 65.0 66.0 13:15:18 INFO - PROCESS | 5545 | 13:15:18 INFO - PROCESS | 5545 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:79.50 stddev:1.18 (1.5%) stddev-sans-first:1.24 13:15:18 INFO - PROCESS | 5545 | Values: 79.0 78.0 78.0 79.0 80.0 81.0 81.0 81.0 79.0 79.0 13:15:18 INFO - PROCESS | 5545 | 13:15:18 INFO - PROCESS | 5545 | [#11] stanford-crypto-ccm Cycles:10 Average:139.00 Median:136.00 stddev:14.20 (10.4%) stddev-sans-first:14.99 13:15:18 INFO - PROCESS | 5545 | Values: 135.0 133.0 133.0 136.0 133.0 131.0 138.0 136.0 179.0 136.0 13:15:18 INFO - PROCESS | 5545 | 13:15:18 INFO - PROCESS | 5545 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:217.90 Median:218.00 stddev:2.28 (1.0%) stddev-sans-first:1.94 13:15:18 INFO - PROCESS | 5545 | Values: 214.0 216.0 222.0 217.0 218.0 218.0 220.0 220.0 217.0 217.0 13:15:18 INFO - PROCESS | 5545 | 13:15:18 INFO - PROCESS | 5545 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.60 Median:75.00 stddev:3.17 (4.2%) stddev-sans-first:3.32 13:15:18 INFO - PROCESS | 5545 | Values: 77.0 74.0 74.0 76.0 75.0 74.0 84.0 73.0 75.0 74.0 13:15:18 INFO - PROCESS | 5545 | -------- Summary: end -------- 13:15:18 INFO - PROCESS | 5545 | 13:15:19 INFO - TEST-INFO | 5545: exit 0 13:15:19 INFO - TEST-OK | kraken | took 63645ms 13:15:19 INFO - SUITE-END | took 1180s 13:15:19 INFO - Completed test suite (00:19:40) 13:15:19 INFO - javascript benchmark 13:15:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2558.9360265993346, 2644.23317238001, 2647.5896236083413, 2654.601809728541, 2661.5076210900984, 4433.069055498349, 4531.365608814768, 4533.048059907419, 4535.863924082283, 4554.567316104973, 4492.663050271226, 4510.819567217315, 4597.655175861807, 4606.0, 4621.260598304272, 4163.625273725364, 4167.041580436501, 4186.895327616803, 4249.043965107857, 4343.413639158704, 4292.0, 4297.613214810666, 4308.9138217235795, 4315.374270730742, 4351.564843515639, 4085.9182816343805, 4159.251334759742, 4160.417541544186, 4216.936745948798, 4249.107687385653, 4153.937690934638, 4154.667626589866, 4166.375043743433, 4169.687273454503, 4174.3112386456505, 4144.564820693814, 4162.562930892243, 4168.353905144708, 4174.0, 4216.409702641633, 4445.199864024475, 4478.776061196927, 4487.080148569536, 4488.506264310923, 4531.864044078683, 4795.880102997418, 4836.588889944359, 4859.489753575859, 4860.781264843055, 4863.343448634424, 4818.855434336941, 4833.178359678863, 4833.419989601235, 4850.8059677612855, 4891.755412229374, 4493.393391892053, 4500.077484115748, 4520.977395113004, 4530.980529380863, 4557.58981691646, 4904.705717656881, 4918.1884988977135, 4955.529224723646, 4965.0566392385335, 5038.546530812245, 4782.665213435096, 4802.8799280018275, 4804.735739534359, 4839.685420447659, 4848.733319667382, 4874.488178741252, 4874.683145595525, 4880.6095512358925, 4889.364382630235, 4930.211166213388, 4699.412573428322, 4734.076855013308, 4804.111239420718, 4808.975955120202, 4829.782659780319, 4733.290006499053, 4746.0, 4753.04939012199, 4758.405199350082, 4814.20565606678, 4127.380892866094, 4156.542780294165, 4160.2303573838935, 4171.0823618803815, 4206.57934206583, 3570.071781336819, 3600.0, 3646.1796095878217, 3677.558692956862, 3727.7763334200035, 4155.397467367215, 4172.749635021908, 4178.0, 4180.561041090703, 4222.261104306734, 4832.323474713543, 4835.564799168092, 4835.927461088087, 4870.683405578626, 4882.7558622068755, 4113.259613269581, 4198.874033778991, 4218.797642671824, 4247.702660813775, 4261.680373971964, 4349.869503914824, 4350.6736994725525, 4373.737575745466, 4416.624586910084, 4429.645628349725, 4519.457665080211, 4559.954400456019, 4563.338315944236, 4572.9314060289125, 4612.192866248461, 4830.985493046359, 4843.709377437365, 4851.417829860439, 4851.854444366674, 4857.295692124693, 4588.816447342069, 4615.284630882219, 4619.214733495381, 4621.676482646317, 4644.5123262056995, 4636.791344389443, 4754.524547545356, 4806.639502037291, 4812.542808433193, 4853.417589889236, 4818.253170758538, 4835.44392394865, 4886.828960986349, 4891.63312751538, 4894.070126675921, 4704.3649107370065, 4715.198416269174, 4715.552022557851, 4718.315844202502, 4766.904661906812, 4608.28571571407, 4672.602828759594, 4695.906081878275, 4722.858314250578, 4759.428868535798, 4647.488776234544, 4687.531246875285, 4695.389599352063, 4718.056388722338, 4740.6681532292405, 4749.097671442415, 4767.308740232577, 4768.1417344878255, 4774.164521208844, 4813.518648135158, 4503.166914120898, 4590.104929538707, 4667.509911459248, 4677.46209185948, 4703.129920964632], "value": 4466.44305097716, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.6911533214397, 595.1637948682102, 596.6360520082749, 600.5075837812996, 616.7933742196363, 23842.28473145804, 24272.63591046136, 24293.635595466083, 24353.391165220855, 24369.512609747795, 24416.511669766594, 29946.550801737936, 30781.538276925865, 30825.537616935708, 30939.0, 7314.707411703525, 7464.141623713261, 7471.0, 7486.326230639242, 7493.587852668128, 7395.186529481753, 7544.924550754505, 7549.433792465559, 7551.131619863703, 7551.395888328948, 7378.33594976452, 7436.330730234278, 7439.516431431966, 7441.59071251081, 7577.2422757724335, 7554.357879580242, 7633.427492937996, 7637.885431718529, 7642.0, 7658.157602663759, 7589.127250366223, 7668.041494813148, 7671.424643151786, 7673.577953212571, 7686.385089192907, 31332.06003819889, 31593.526097108563, 31939.520907186412, 32455.188620284447, 32466.026019219462, 2900.5649152627066, 2947.2189869684553, 2970.524716045444, 3097.674744151877, 3152.0, 25666.615000775004, 25721.871390643115, 26068.73931260682, 26603.467930641473, 26607.20178394651, 3449.7067749241346, 3494.2836718472654, 3510.4734289856724, 3548.449990251515, 3558.2527669189503, 195351.0, 196190.0, 196322.0, 196413.0, 196432.0, 25780.0, 41722.37416438756, 42392.36411453831, 42447.787761060994, 42552.787236063625, 27231.727682722918, 27279.86360068187, 27336.86331568369, 27383.315417114733, 27386.31534211621, 11877.940610296893, 12099.395030248452, 12118.878811211951, 12138.878611213951, 12195.146339756131, 10133.898661013443, 10319.277650564389, 10323.741906452398, 10336.741581460523, 10340.948295258626, 7599.962000189964, 7654.578998155155, 7724.150343462215, 7733.4973226740085, 7734.419918506134, 2918.343372741159, 2966.8664910079096, 2975.0628552006483, 2997.835119068472, 3001.654809696869, 806.7458750493576, 818.8362327534517, 838.4172999765104, 882.9337799664922, 887.2591386192602, 23613.1735389264, 23796.7620323798, 24329.878350608134, 25037.62443563348, 25886.352841178745, 770.8111512679429, 890.1009979920327, 902.1835239108617, 916.706653870755, 943.7593413679605, 11869.881301186877, 12445.564405245774, 12513.749725005631, 12983.740325193443, 13024.804627930589, 279766.0, 285618.0, 287394.0, 287554.0, 287860.0, 37145.44281835775, 38016.809915950245, 38093.14301427348, 38130.0, 38133.23733525314, 1029.46467836726, 1064.9574017039386, 1082.2856914436434, 1089.0, 1094.4691824465287, 23329.650055248847, 23722.169724059575, 23783.52432951366, 23812.809359531606, 23959.640605390585, 33189.17027074342, 33804.66195338015, 33855.830720846236, 33863.492047619795, 33921.830390847885, 197529.0, 205807.0, 205987.0, 206744.0, 206791.0, 18739.531511712317, 18786.812131878505, 19297.324593639154, 19304.32434864773, 21130.577388452453, 30967.69032309648, 31328.0, 31399.529007064455, 31981.36037279288, 31986.360272793947, 26879.731202687723, 28918.566221507113, 29603.555946660388, 30023.0, 30954.845225773726, 27918.3020424491, 28093.45485998208, 28459.715402846534, 29486.262843429085, 30085.398292034475, 28023.159305220877, 28364.43271134607, 28542.0, 28653.426931460835, 28699.856500718197, 25343.493130137664, 25349.746502535476, 25952.740472595033, 26039.0, 26637.600435993863, 20963.475913102295, 21060.894695526425, 21294.36116916495, 21303.78696213018, 21328.893355533124], "value": 14021.928007347398, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.3495772651501, 361.1224723920873, 361.7648528456503, 363.99636003639966, 376.5989221479126, 14295.213763243017, 14771.261436928151, 15182.0, 15211.315490802926, 15221.92389038056, 13457.596272111852, 13521.594352169426, 14202.218877961708, 14824.851751482482, 14929.701405971875, 4792.568668819814, 4895.877603059934, 4941.382327209099, 4957.0, 4973.303737476756, 4798.256270278112, 4939.827106051289, 4944.233643785219, 4949.604031677475, 4958.181899986516, 4916.803327866881, 4923.80304787808, 4928.852134435972, 5050.873728156807, 5345.1447768357075, 5263.6578622389425, 5276.604254680914, 5282.471752824726, 5288.735563221842, 5303.655262407931, 4896.804127834882, 5121.385433747974, 5122.154844450662, 5153.407358153785, 5155.690658560498, 11780.64658060251, 11852.229605075643, 11914.166008379418, 12045.93977030118, 13767.449302027906, 1867.4024312220095, 1875.4467432107424, 1882.9246830126779, 1966.6361723081134, 2008.347287131688, 8404.327653787683, 8657.956710216471, 8864.20222180007, 9120.361574689774, 9127.954360228156, 1695.6608678264274, 1701.0984178385474, 1710.4270069526724, 1745.4938067960277, 1753.544078539576, 56067.71966140143, 56377.43622563804, 56812.14781778277, 58303.0, 58932.705336473475, 9414.576344064533, 9502.287328450393, 9506.287028472892, 9629.277804164716, 9861.0, 12921.547745828851, 13080.084394092513, 13108.868911310956, 13123.54067607629, 13125.081244312807, 6953.269906659829, 7048.0, 7122.18094919091, 7172.0, 7173.210946795953, 6645.568038077509, 6666.566673166229, 6791.0, 6809.795706128824, 6847.828804279833, 4211.0, 4214.199302132646, 4247.830086796555, 4340.52254252032, 4381.84663536781, 1746.9602890969622, 1775.1568005197687, 1784.9910750446165, 1792.9013904235132, 1819.9272029118952, 800.6597196191595, 802.7832485228955, 806.0810675829559, 816.5386556595505, 880.6257340630335, 14370.13779173253, 14373.20947347885, 14588.34352454142, 14992.550223493312, 15145.924270378577, 793.8928244687008, 795.9164287749703, 814.1573471457132, 821.880827280053, 828.3125006244802, 8293.295069919124, 8313.418060735812, 8752.343574231958, 9071.59177836999, 9280.72157835266, 378401.0, 379483.0, 385059.0, 386783.0, 388754.0, 43480.0, 57907.131393029136, 62234.0, 63307.6834615824, 68082.65958670274, 766.896468976681, 961.6730311694058, 973.1193270090579, 1002.2533212756543, 1007.4207330784828, 13035.47858085704, 13909.304534773019, 14005.789913151515, 14076.507322243673, 14401.351939162972, 31794.364112718078, 33045.83477082695, 33525.66474335225, 33682.831585841916, 33868.153296167795, 39880.800595996836, 40498.797506012284, 41059.58940410558, 41824.16351673011, 41908.371374428796, 7601.353884919844, 7712.074551053909, 7730.188330225245, 7827.25641064098, 7900.0, 6828.556143850634, 9677.0, 10156.898431015596, 10936.835947460635, 11632.709182270512, 10286.434246116536, 10360.844587331045, 10427.21795865298, 10489.531465594975, 10639.680809575726, 9880.35777674449, 9887.110160085627, 9937.492534936566, 10240.692779216635, 10431.94784026075, 10217.795644086927, 10276.280660353703, 10291.588336466457, 10308.948455257676, 10500.684979450629, 7540.924590754023, 7571.46999710015, 7638.923610763822, 7691.846163076595, 7916.208379162038, 8418.52675781748, 9935.552900119657, 10420.42687652156, 10599.89400105989, 10756.677299681021], "value": 7605.615189194684, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1114.1309778372872, 1290.4515580878128, 1296.792513197888, 1320.5246111399895, 1497.3561368611493, 6207.751689932403, 7235.565866048034, 7519.812004699886, 7529.736459223928, 7541.057367829028, 7323.670434830432, 7480.588567628778, 7503.624818759054, 7511.286427789365, 7512.887306690404, 2197.8571392859494, 2221.133757834446, 2222.822174226058, 2224.0325458425555, 2227.1091563374616, 2151.333086743107, 2180.901859416322, 2221.3891179925567, 2227.654713519407, 2234.4078819112947, 2176.227439259064, 2180.7928246816605, 2181.890905454729, 2183.661532462463, 2225.5882661707556, 2115.502856828644, 2115.841311901606, 2120.692499587551, 2127.308624696972, 2130.0201907122664, 2124.3839286606867, 2158.32012915931, 2160.1359456217483, 2160.6650969099815, 2162.232407495348, 7203.351698347174, 7330.523515971498, 7397.038385009968, 7486.588237646927, 7497.10034795828, 4333.761643109628, 4526.981429178409, 4536.455625324982, 4539.4098767160385, 4542.454905411372, 2768.5570308750503, 2805.4389122175444, 2883.480973424783, 2887.956680649792, 2936.060460652592, 913.3013244867682, 918.1277786103228, 924.3714274293478, 924.6301479408223, 935.0649350649351, 10205.2346074044, 10413.79172416555, 10437.895621043768, 10438.68683939483, 10520.894791052144, 4251.086016506466, 4321.6974811762875, 4392.868213953587, 4395.7582332972, 4414.183376075436, 8781.692640757543, 8816.735497935073, 8832.823343533093, 8844.204021637956, 8866.069062748318, 4634.72191668501, 4636.11913736389, 4650.906981860344, 4654.069186162781, 4659.58063774262, 3614.1326081740194, 3944.8422063117728, 4039.9192016159514, 4098.446709694213, 4159.355299928516, 3402.625711171769, 3470.8091054991714, 3504.474328850693, 3591.5151454553825, 3626.7279954003557, 1159.4144956796931, 1170.9824352634716, 1172.3669218621849, 1172.8006238939402, 1173.1288594691453, 748.547128986966, 752.6725874244612, 761.1779278379337, 762.8474305138994, 785.8978332816697, 5103.77033033507, 5120.052790233819, 5146.279520867081, 5168.53483186515, 5326.0945639240645, 402.699988508563, 414.08074075552224, 414.42188147534023, 415.3458303172455, 418.5187034909878, 3341.74936879735, 3473.3921563726753, 3505.6669616386403, 3520.559930008749, 3540.8760693376125, 9151.908480915106, 9482.38364506305, 9643.566039528238, 9655.275854310814, 9665.178459830853, 9548.856767148498, 9558.856617150748, 9573.0, 9577.473238971923, 9581.904180958101, 6234.844128896723, 6534.738610455529, 7151.427885769126, 7236.565806051653, 7268.309510596485, 4992.675476094042, 5071.670341427795, 5244.239585260192, 5285.656432331886, 5439.700816454974, 8331.95834020826, 8423.11557286476, 8426.15738426177, 8590.926134233221, 8712.564371781513, 8631.43895646781, 8706.04233534298, 8762.649494020168, 8854.734357969272, 8882.60028298741, 5665.206871037975, 6386.882295598345, 6574.934250657432, 6627.5360724750735, 6781.321867813179, 6981.616011119438, 6994.230634630085, 7030.191527974348, 7044.682989265393, 7044.753433629799, 6207.503399727921, 6354.301026887131, 6459.61242325462, 6611.636360000246, 6702.899456508254, 6213.937860621336, 6358.586691865014, 6428.4214420702365, 6455.0317452382515, 6506.186726659168, 5769.394213607511, 5818.44724751148, 5831.446012628793, 5845.590808643354, 5850.707464626837, 4346.413234213341, 4369.169857727022, 4498.91002179948, 4553.567411095941, 4559.4072770539615, 4293.8711838644895, 4347.9565204347555, 4372.672049596229, 4443.8444654438235, 4446.221911165598], "value": 3937.240664435113, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.19905062028795, 300.19847008487335, 300.33475850990055, 304.160516973154, 305.5142323705308, 4442.62237709795, 4540.682152249344, 4616.884577885555, 4629.930551041729, 4640.071985602876, 4438.489573699026, 4607.976960115203, 4608.285715714062, 4632.467266264381, 4643.489216186217, 3698.2048859495203, 3699.4820725098507, 3699.5375578052744, 3705.4627079073516, 3719.497867787841, 3499.667531584508, 3549.290141971616, 3672.338978983782, 3680.2150956785936, 3691.686206672436, 3669.724770642199, 3672.8163591820435, 3680.723945704083, 3686.944695829565, 3688.2070354873695, 3661.761985470949, 3667.486551882725, 3671.5227020487164, 3689.4834723138515, 3695.2424752925585, 3266.4936934775146, 3272.672732726708, 3287.7534184936226, 3290.07877794218, 3295.2750394913082, 4236.533981262059, 4470.552944705536, 4489.326601009842, 4519.0, 4525.637948964075, 4122.2579935611575, 4153.273177194009, 4155.896102597429, 4163.791810409498, 4169.97915010426, 4851.708897466164, 4856.3201151838775, 4862.927056094126, 4868.829590964335, 4886.0, 3262.8531716072835, 3479.1997840496574, 3499.6500349965054, 3500.824958752052, 3522.876699315512, 5005.89988200234, 5026.894083301668, 5032.4212715537815, 5046.6719663221775, 5052.7726252318735, 3521.964780352215, 3525.2773181497732, 3544.946825797615, 3547.6984456320984, 3562.786232826039, 3588.7129029677562, 3589.3180295743723, 3598.514200582888, 3601.3877640801124, 3618.945715814265, 3987.142764305688, 4077.44954431148, 4121.258173528734, 4123.814428350672, 4128.690348223835, 4800.495947925418, 4802.807887684454, 4822.541858523435, 4838.177509823268, 4842.878928026827, 1219.4939100273286, 1305.614843621134, 1315.3094625321783, 1372.883304919093, 1372.8901687864948, 892.7812685891998, 933.7992331648728, 950.0689324461928, 955.2262667239559, 963.7301555564453, 4472.843450479218, 4474.619657329164, 4515.3970340529295, 4517.277235642281, 4559.566841150086, 5229.097850692826, 5254.973725131426, 5267.394249661262, 5269.868253293698, 5282.0, 4430.357598148251, 4518.9548104518535, 4565.474970378383, 4572.839950601713, 4578.6794924355645, 2819.3374556979093, 2833.121732263005, 2839.432113577293, 2840.1053668094896, 2842.786790990684, 4989.700617962933, 5023.623228257895, 5031.144705400091, 5036.7733451994745, 5054.82308119214, 5137.17805151174, 5388.326459192601, 5402.621816472809, 5418.970395624819, 5423.0, 4931.10152591255, 4934.136526107988, 4949.238578680157, 5012.097822391932, 5038.370203724535, 5174.663646862942, 5247.897941432342, 5248.343957005374, 5263.631545791911, 5269.78920843162, 5016.043742940184, 5103.515166059218, 5152.922706159336, 5166.0, 5182.352205974254, 4990.850274491771, 4991.825286115114, 4995.3765026365845, 5007.499250074963, 5021.4225364083595, 3885.417187421909, 3887.105965627978, 3896.2012787379085, 3900.219956008753, 3909.7849618271266, 4826.710397376169, 4827.348307978378, 5271.841844744664, 5281.841544753664, 5286.894262114659, 4719.669623126349, 4913.77887995034, 4920.286558448934, 4920.630952678492, 4936.802527898843, 4901.387326584177, 4931.235658472942, 4952.975235123801, 4968.205087186033, 4968.527989840959, 4625.167469855458, 4877.658563900635, 4879.341288926092, 4880.707157570557, 4885.7801398937845, 4933.186024306093, 4946.431160416598, 4950.108980383421, 4961.156603377362, 4964.957358954515, 4882.780274887709, 4889.315495830658, 4892.510748925079, 4893.0, 4912.7543622818], "value": 3770.1729854309597, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [622.3030206169092, 650.2911826109541, 650.5966300893447, 673.1114928294652, 675.3820254467159, 11183.608573699923, 11430.54277828887, 11455.828162577567, 11469.369184694839, 11492.712682182939, 11482.0, 11542.192046556744, 12006.399680015986, 12013.399330033508, 12023.879761202385, 520.1936997653622, 522.8928069745712, 523.8192823475914, 565.9445134823566, 575.712143928035, 499.4231662429899, 533.4159095790104, 543.7335705504294, 545.2393910494857, 545.6562365709598, 643.7296335539085, 644.9000404937242, 649.1723053107279, 653.9705713242892, 664.2029564522568, 530.9230161626581, 561.0994354061734, 561.2927711084022, 562.5246666566744, 563.1974436428073, 393.4531001907351, 403.7032780906032, 407.824635406775, 410.9034376921421, 411.3295328614369, 11582.884171158265, 11612.12909031826, 11615.128865335133, 11634.6509604712, 11636.360000199986, 10819.242653014293, 10902.127829773599, 11222.0, 11391.259568128127, 11635.941820290844, 9579.904200957972, 9650.75873103171, 9657.688271450674, 9716.222702183808, 9730.659426920094, 3248.545203671488, 3253.902382928516, 3277.3281477297096, 3321.368939901411, 3335.8999230022896, 43489.34765978481, 43683.0, 43980.12039759219, 44175.558244417465, 44202.03272558196, 8487.490750554987, 8723.476591404537, 8790.86813697795, 8937.195652391316, 9027.63889444428, 15561.144137072344, 15925.283362248727, 16012.919935400249, 16115.113668748332, 16374.918125409535, 5731.598788084794, 5751.396103409082, 5894.381089985575, 5942.346341902387, 5948.702564871739, 3616.8372423241017, 3646.5624125105155, 3683.5395575553057, 3687.870924517629, 3722.050877026341, 2641.088824355594, 2685.677718673772, 2686.8790904409348, 2692.5018871508832, 2695.4339588686203, 461.9307103934437, 476.86886106320344, 477.2983713940502, 487.665948825056, 488.9608831293488, 474.3833017077785, 547.3923944421689, 605.125593517372, 617.0928734759985, 617.6355949989528, 8092.595370231465, 8249.29880960125, 8453.239208471266, 8728.127187281221, 8747.343949203836, 574.9051406517877, 578.945000224978, 579.3482332376077, 585.3473377184408, 604.9848753781102, 3528.1708798432346, 3554.484599733076, 3582.1940063486027, 3698.1124530113116, 3698.260347930425, 51474.22788658173, 52264.47735522596, 53928.0, 53984.730076350155, 54010.45989540133, 45688.54311456843, 46752.7662361686, 46969.765151174026, 47855.5214447858, 49758.253626195634, 44556.77721611371, 44644.55355446469, 44930.55069449329, 45247.773761130986, 45556.54443455523, 7353.742619008309, 7580.090389153116, 7596.354309883722, 7626.9618651906385, 7644.617769111411, 28655.42689146247, 29527.704722952494, 29539.409211815215, 29706.405871882875, 29957.251068723457, 37222.0, 37902.810485948496, 39826.0, 40643.390349144196, 40732.38901416422, 9033.187013168847, 9091.818163636557, 9202.447853128833, 9497.762555936157, 9575.473348965874, 9775.657851975147, 9838.803223935338, 9941.801163976825, 10092.697219083439, 10278.640247591298, 8242.958785206036, 9097.772555685897, 9366.625334986524, 10880.129589632968, 11468.467208693488, 10744.785104298027, 10821.18841086906, 10984.0, 11071.446427678422, 11426.812497207224, 10958.616448424267, 10972.0, 11025.283356581796, 11482.311061336346, 11662.53349865996, 8845.601947912231, 8982.82034359296, 9312.953435232781, 9350.812983740423, 9366.718998430058, 8784.736457906272, 8936.687215947411, 8992.910070899468, 9067.183953444222, 9088.0], "value": 5410.783676371385, "unit": "score"}], "name": "dromaeo_css", "value": 5804.87995253205, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 109.0, 113.0, 115.0, 113.0, 103.0, 112.0, 115.0, 115.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 137.0, 161.0, 179.0, 132.0, 158.0, 157.0, 137.0, 195.0, 139.0], "value": 155.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 159.0, 162.0, 162.0, 161.0, 162.0, 161.0, 162.0, 162.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 117.0, 107.0, 77.0, 74.0, 73.0, 133.0, 119.0, 74.0], "value": 92.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 147.0, 93.0, 95.0, 93.0, 141.0, 94.0, 95.0, 146.0], "value": 109.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 98.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 66.0, 66.0, 65.0, 66.0, 82.0, 65.0, 64.0], "value": 67.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 66.0, 66.0, 66.0, 65.0, 65.0, 65.0, 66.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 78.0, 79.0, 80.0, 81.0, 81.0, 81.0, 79.0, 79.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 133.0, 133.0, 136.0, 133.0, 131.0, 138.0, 136.0, 179.0, 136.0], "value": 139.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [214.0, 216.0, 222.0, 217.0, 218.0, 218.0, 220.0, 220.0, 217.0, 217.0], "value": 217.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 74.0, 76.0, 75.0, 74.0, 84.0, 73.0, 75.0, 74.0], "value": 75.6, "unit": "score"}], "name": "kraken", "value": 1633.8, "alertThreshold": 2.0}]} 13:15:19 INFO - Return code: 0 13:15:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:15:19 ERROR - # TBPL SUCCESS # 13:15:19 INFO - Running post-action listener: _resource_record_post_action 13:15:19 INFO - Running post-run listener: _resource_record_post_run 13:15:20 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293945344; Read time: 16; Write time: 237952 13:15:20 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 15450112; Read time: 0; Write time: 12944 13:15:20 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 278495232; Read time: 16; Write time: 225008 13:15:20 INFO - Running post-run listener: _upload_blobber_files 13:15:20 INFO - Blob upload gear active. 13:15:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:15:20 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 13:15:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:15:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:15:20 INFO - (blobuploader) - INFO - Open directory for files ... 13:15:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:15:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:15:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:15:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:15:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:15:21 INFO - (blobuploader) - INFO - Done attempting. 13:15:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:15:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:15:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:15:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:15:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:15:22 INFO - (blobuploader) - INFO - Done attempting. 13:15:22 INFO - (blobuploader) - INFO - Iteration through files over. 13:15:22 INFO - Return code: 0 13:15:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:15:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:15:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e834d15525c331ea994b801ae00c63ecb9828f1263ed78ba56721971d68a5a2ec2ac1e82943b2399d07653a946ceb5607f03f6ed1efea487695be8717cf4d507", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a48b4c4791b05587359c0c3ef666f96a2b92b27a2fc6095e8690a82329ef4c3e9dba624b80eeb23650d273587777d7f57d95ab83447ac405e4c5b925cc9ef8a3"} 13:15:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:15:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:15:22 INFO - Contents: 13:15:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e834d15525c331ea994b801ae00c63ecb9828f1263ed78ba56721971d68a5a2ec2ac1e82943b2399d07653a946ceb5607f03f6ed1efea487695be8717cf4d507", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a48b4c4791b05587359c0c3ef666f96a2b92b27a2fc6095e8690a82329ef4c3e9dba624b80eeb23650d273587777d7f57d95ab83447ac405e4c5b925cc9ef8a3"} 13:15:22 INFO - Running post-run listener: copy_logs_to_upload_dir 13:15:22 INFO - Copying logs to upload dir... 13:15:22 INFO - mkdir: /builds/slave/test/build/upload/logs 13:15:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1840.730097 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 30 mins, 40 secs) (at 2016-04-26 13:15:22.642837) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 13:15:22.646169) ========= 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=1f5564757af27664ca02d71f000001b0-1461695049.605483-654579384 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e834d15525c331ea994b801ae00c63ecb9828f1263ed78ba56721971d68a5a2ec2ac1e82943b2399d07653a946ceb5607f03f6ed1efea487695be8717cf4d507", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a48b4c4791b05587359c0c3ef666f96a2b92b27a2fc6095e8690a82329ef4c3e9dba624b80eeb23650d273587777d7f57d95ab83447ac405e4c5b925cc9ef8a3"} build_url:https://queue.taskcluster.net/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011296 build_url: 'https://queue.taskcluster.net/v1/task/YCvN-5g_RsSjYqlK_I2pBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e834d15525c331ea994b801ae00c63ecb9828f1263ed78ba56721971d68a5a2ec2ac1e82943b2399d07653a946ceb5607f03f6ed1efea487695be8717cf4d507", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a48b4c4791b05587359c0c3ef666f96a2b92b27a2fc6095e8690a82329ef4c3e9dba624b80eeb23650d273587777d7f57d95ab83447ac405e4c5b925cc9ef8a3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 13:15:22.671426) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 13:15:22.671763) ========= 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=1f5564757af27664ca02d71f000001b0-1461695049.605483-654579384 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004336 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 13:15:22.756925) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 13:15:22.757246) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 13:15:22.757595) ========= ========= Total master_lag: 0.18 =========