builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-046 starttime: 1462640800.78 results: success (0) buildid: 20160507073429 builduid: 2b2704438aeb49f5a73da2d2fadbadb5 revision: bae525a694e2dc0aa433885be8751330d4995a49 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-07 10:06:40.775877) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-07 10:06:40.776316) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-07 10:06:40.776594) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-07 10:06:40.818197) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 10:06:40.818458) ========= 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=652eb03db935cfc1c15ebda0000001ad-1462630536.737093-78274672 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-07 10:06: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% 28.3M=0s 2016-05-07 10:06:41 (28.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113641 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 10:06:40.951004) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 10:06:40.951332) ========= 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=652eb03db935cfc1c15ebda0000001ad-1462630536.737093-78274672 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019873 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 10:06:41.016944) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 10:06:41.017299) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bae525a694e2dc0aa433885be8751330d4995a49 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev bae525a694e2dc0aa433885be8751330d4995a49 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1462630536.737093-78274672 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-07 10:06:41,682 truncating revision to first 12 chars 2016-05-07 10:06:41,682 Setting DEBUG logging. 2016-05-07 10:06:41,682 attempt 1/10 2016-05-07 10:06:41,682 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bae525a694e2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-07 10:06:41,940 unpacking tar archive at: mozilla-central-bae525a694e2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.545218 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 10:06:41.580638) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-07 10:06:41.580972) ========= script_repo_revision: bae525a694e2dc0aa433885be8751330d4995a49 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-07 10:06:41.581386) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-07 10:06:41.581669) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-07 10:06:41.591644) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-07 10:06:41.591943) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=652eb03db935cfc1c15ebda0000001ad-1462630536.737093-78274672 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:06:42 INFO - MultiFileLogger online at 20160507 10:06:42 in /builds/slave/test 10:06:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:06:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:06:42 INFO - {'append_to_log': False, 10:06:42 INFO - 'base_work_dir': '/builds/slave/test', 10:06:42 INFO - 'blob_upload_branch': 'Firefox', 10:06:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:06:42 INFO - 'branch': 'Firefox', 10:06:42 INFO - 'buildbot_json_path': 'buildprops.json', 10:06:42 INFO - 'config_files': ('talos/linux_config.py',), 10:06:42 INFO - 'default_actions': ('clobber', 10:06:42 INFO - 'read-buildbot-config', 10:06:42 INFO - 'download-and-extract', 10:06:42 INFO - 'populate-webroot', 10:06:42 INFO - 'create-virtualenv', 10:06:42 INFO - 'install', 10:06:42 INFO - 'run-tests'), 10:06:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:06:42 INFO - 'download_minidump_stackwalk': True, 10:06:42 INFO - 'download_symbols': 'ondemand', 10:06:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:06:42 INFO - 'tooltool.py': '/tools/tooltool.py', 10:06:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:06:42 INFO - '/tools/misc-python/virtualenv.py')}, 10:06:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:06:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:06:42 INFO - 'installer_path': 'installer.exe', 10:06:42 INFO - 'log_level': 'info', 10:06:42 INFO - 'log_name': 'talos', 10:06:42 INFO - 'log_to_console': True, 10:06:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:06:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:06:42 INFO - 'opt_config_files': (), 10:06:42 INFO - 'pip_index': False, 10:06:42 INFO - 'sps_profile': False, 10:06:42 INFO - 'sps_profile_interval': 0, 10:06:42 INFO - 'suite': 'dromaeojs', 10:06:42 INFO - 'system_bits': '32', 10:06:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:06:42 INFO - 'title': 'talos-linux64-ix-046', 10:06:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:06:42 INFO - 'use_talos_json': True, 10:06:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:06:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:06:42 INFO - 'work_dir': 'build'} 10:06:42 INFO - ##### 10:06:42 INFO - ##### Running clobber step. 10:06:42 INFO - ##### 10:06:42 INFO - Running pre-action listener: _resource_record_pre_action 10:06:42 INFO - Running main action method: clobber 10:06:42 INFO - rmtree: /builds/slave/test/build 10:06:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:06:42 INFO - Running post-action listener: _resource_record_post_action 10:06:42 INFO - ##### 10:06:42 INFO - ##### Finished clobber step (success) 10:06:42 INFO - ##### 10:06:42 INFO - ##### 10:06:42 INFO - ##### Running read-buildbot-config step. 10:06:42 INFO - ##### 10:06:42 INFO - Running pre-action listener: _resource_record_pre_action 10:06:42 INFO - Running main action method: read_buildbot_config 10:06:42 INFO - Using buildbot properties: 10:06:42 INFO - { 10:06:42 INFO - "project": "", 10:06:42 INFO - "product": "firefox", 10:06:42 INFO - "script_repo_revision": "production", 10:06:42 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:06:42 INFO - "repository": "", 10:06:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 10:06:42 INFO - "buildid": "20160507073429", 10:06:42 INFO - "pgo_build": "True", 10:06:42 INFO - "basedir": "/builds/slave/test", 10:06:42 INFO - "buildnumber": 766, 10:06:42 INFO - "slavename": "talos-linux64-ix-046", 10:06:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:06:42 INFO - "platform": "ubuntu64_hw", 10:06:42 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:06:42 INFO - "branch": "mozilla-central", 10:06:42 INFO - "repo_path": "mozilla-central", 10:06:42 INFO - "revision": "bae525a694e2dc0aa433885be8751330d4995a49", 10:06:42 INFO - "stage_platform": "linux64-pgo", 10:06:42 INFO - "builduid": "2b2704438aeb49f5a73da2d2fadbadb5", 10:06:42 INFO - "slavebuilddir": "test" 10:06:42 INFO - } 10:06:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/f18FJy7JTqOsLE2b1bDNbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 10:06:42 INFO - Running post-action listener: _resource_record_post_action 10:06:42 INFO - ##### 10:06:42 INFO - ##### Finished read-buildbot-config step (success) 10:06:42 INFO - ##### 10:06:42 INFO - ##### 10:06:42 INFO - ##### Running download-and-extract step. 10:06:42 INFO - ##### 10:06:42 INFO - Running pre-action listener: _resource_record_pre_action 10:06:42 INFO - Running main action method: download_and_extract 10:06:42 INFO - mkdir: /builds/slave/test/build/tests 10:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:42 INFO - https://queue.taskcluster.net/v1/task/f18FJy7JTqOsLE2b1bDNbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:06:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f18FJy7JTqOsLE2b1bDNbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:06:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f18FJy7JTqOsLE2b1bDNbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:06:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f18FJy7JTqOsLE2b1bDNbw/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 10:06:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f18FJy7JTqOsLE2b1bDNbw/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 10:06:45 INFO - Downloaded 1361 bytes. 10:06:45 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:06:45 INFO - Using the following test package requirements: 10:06:45 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:06:45 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:06:45 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:06:45 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:45 INFO - u'jsshell-linux-x86_64.zip'], 10:06:45 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:06:45 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:06:45 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:06:45 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:06:45 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:06:45 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:06:45 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:06:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:45 INFO - https://queue.taskcluster.net/v1/task/f18FJy7JTqOsLE2b1bDNbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:06:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f18FJy7JTqOsLE2b1bDNbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:06:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f18FJy7JTqOsLE2b1bDNbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:06:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f18FJy7JTqOsLE2b1bDNbw/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 10:06:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f18FJy7JTqOsLE2b1bDNbw/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 10:06:46 INFO - Downloaded 23894991 bytes. 10:06:46 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'] 10:06:46 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 10:06:47 INFO - Return code: 0 10:06:47 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 10:06:47 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')]} 10:06:47 INFO - https://queue.taskcluster.net/v1/task/f18FJy7JTqOsLE2b1bDNbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:06:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f18FJy7JTqOsLE2b1bDNbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:06:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f18FJy7JTqOsLE2b1bDNbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:06:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f18FJy7JTqOsLE2b1bDNbw/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 10:06:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f18FJy7JTqOsLE2b1bDNbw/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 10:06:59 INFO - Downloaded 23894991 bytes. 10:06:59 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'] 10:06:59 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 10:07:01 INFO - Return code: 0 10:07:01 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')]} 10:07:01 INFO - https://queue.taskcluster.net/v1/task/f18FJy7JTqOsLE2b1bDNbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:07:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f18FJy7JTqOsLE2b1bDNbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:07:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f18FJy7JTqOsLE2b1bDNbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:07:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f18FJy7JTqOsLE2b1bDNbw/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 10:07:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f18FJy7JTqOsLE2b1bDNbw/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 10:07:02 INFO - Downloaded 10840152 bytes. 10:07:02 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'] 10:07:02 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 10:07:02 INFO - Return code: 0 10:07: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')]} 10:07:02 INFO - https://queue.taskcluster.net/v1/task/f18FJy7JTqOsLE2b1bDNbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:07:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f18FJy7JTqOsLE2b1bDNbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:07:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f18FJy7JTqOsLE2b1bDNbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:07:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f18FJy7JTqOsLE2b1bDNbw/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 10:07:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f18FJy7JTqOsLE2b1bDNbw/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 10:07:04 INFO - Downloaded 58407799 bytes. 10:07:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f18FJy7JTqOsLE2b1bDNbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:07:04 INFO - mkdir: /builds/slave/test/properties 10:07:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:07:04 INFO - Writing to file /builds/slave/test/properties/build_url 10:07:04 INFO - Contents: 10:07:04 INFO - build_url:https://queue.taskcluster.net/v1/task/f18FJy7JTqOsLE2b1bDNbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:07:05 INFO - Running post-action listener: _resource_record_post_action 10:07:05 INFO - Running post-action listener: set_extra_try_arguments 10:07:05 INFO - ##### 10:07:05 INFO - ##### Finished download-and-extract step (success) 10:07:05 INFO - ##### 10:07:05 INFO - ##### 10:07:05 INFO - ##### Running populate-webroot step. 10:07:05 INFO - ##### 10:07:05 INFO - Running pre-action listener: _resource_record_pre_action 10:07:05 INFO - Running main action method: populate_webroot 10:07:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:07:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:07:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:07:05 INFO - '--tppagecycles', 10:07:05 INFO - '7'], 10:07:05 INFO - 'tests': ['tsvgm']}}, 10:07:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:07:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:07:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:07:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:07:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:07:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:07:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:05 INFO - 'talos_options': ['--disable-e10s'], 10:07:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:07:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:07:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:05 INFO - 'talos_options': ['--disable-e10s'], 10:07:05 INFO - 'tests': ['damp', 'tps']}, 10:07:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:05 INFO - 'tests': ['damp', 'tps']}, 10:07:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:07:05 INFO - 'tests': ['dromaeo_dom']}, 10:07:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:07:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:07:05 INFO - 'tests': ['a11yr', 10:07:05 INFO - 'ts_paint', 10:07:05 INFO - 'tpaint', 10:07:05 INFO - 'sessionrestore', 10:07:05 INFO - 'sessionrestore_no_auto_restore', 10:07:05 INFO - 'tabpaint']}, 10:07:05 INFO - 'other-e10s': {'tests': ['a11yr', 10:07:05 INFO - 'ts_paint', 10:07:05 INFO - 'tpaint', 10:07:05 INFO - 'sessionrestore', 10:07:05 INFO - 'sessionrestore_no_auto_restore', 10:07:05 INFO - 'tabpaint']}, 10:07:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:07:05 INFO - 'ts_paint', 10:07:05 INFO - 'tpaint', 10:07:05 INFO - 'sessionrestore', 10:07:05 INFO - 'sessionrestore_no_auto_restore', 10:07:05 INFO - 'tabpaint']}, 10:07:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:07:05 INFO - 'ts_paint', 10:07:05 INFO - 'tpaint', 10:07:05 INFO - 'sessionrestore', 10:07:05 INFO - 'sessionrestore_no_auto_restore', 10:07:05 INFO - 'tabpaint']}, 10:07:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:07:05 INFO - 'tests': ['a11yr', 10:07:05 INFO - 'ts_paint', 10:07:05 INFO - 'tpaint', 10:07:05 INFO - 'sessionrestore', 10:07:05 INFO - 'sessionrestore_no_auto_restore', 10:07:05 INFO - 'tabpaint']}, 10:07:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:07:05 INFO - 'tests': ['a11yr', 10:07:05 INFO - 'ts_paint', 10:07:05 INFO - 'tpaint', 10:07:05 INFO - 'sessionrestore', 10:07:05 INFO - 'sessionrestore_no_auto_restore', 10:07:05 INFO - 'tabpaint']}, 10:07:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:07:05 INFO - 'tests': ['tsvgx', 10:07:05 INFO - 'tsvgr_opacity', 10:07:05 INFO - 'tart', 10:07:05 INFO - 'tscrollx', 10:07:05 INFO - 'cart']}, 10:07:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:07:05 INFO - 'tsvgr_opacity', 10:07:05 INFO - 'tart', 10:07:05 INFO - 'tscrollx', 10:07:05 INFO - 'cart']}, 10:07:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:05 INFO - 'talos_options': ['--disable-e10s'], 10:07:05 INFO - 'tests': ['tp5o']}, 10:07:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:05 INFO - 'tests': ['tp5o']}, 10:07:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:05 INFO - 'talos_options': ['--disable-e10s', 10:07:05 INFO - '--xperf_path', 10:07:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:07:05 INFO - 'tests': ['tp5n']}, 10:07:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:05 INFO - 'talos_options': ['--xperf_path', 10:07:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:07:05 INFO - 'tests': ['tp5n']}}, 10:07:05 INFO - 'talos.zip': {'path': '', 10:07:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:07:05 INFO - Running post-action listener: _resource_record_post_action 10:07:05 INFO - ##### 10:07:05 INFO - ##### Finished populate-webroot step (success) 10:07:05 INFO - ##### 10:07:05 INFO - ##### 10:07:05 INFO - ##### Running create-virtualenv step. 10:07:05 INFO - ##### 10:07:05 INFO - Running pre-action listener: _resource_record_pre_action 10:07:05 INFO - Running main action method: create_virtualenv 10:07:05 INFO - Creating virtualenv /builds/slave/test/build/venv 10:07:05 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 10:07:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:07:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:07:05 INFO - Using real prefix '/usr' 10:07:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:07:05 INFO - Installing distribute.............................................................................................................................................................................................done. 10:07:07 INFO - Installing pip.................done. 10:07:07 INFO - Return code: 0 10:07:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:07:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f31eb3a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc18e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c50b20>, '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 0x1c51a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c51eb0>, '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': '652eb03db935cfc1c15ebda0000001ad-1462630536.737093-78274672', '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 10:07:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:07:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:07:07 INFO - Using env: {'DISPLAY': ':0', 10:07:07 INFO - 'HOME': '/home/cltbld', 10:07:07 INFO - 'LANG': 'en_US.UTF-8', 10:07:07 INFO - 'LANGUAGE': 'en_US:en', 10:07:07 INFO - 'LOGNAME': 'cltbld', 10:07:07 INFO - 'MAIL': '/var/mail/cltbld', 10:07:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:07 INFO - 'MOZ_NO_REMOTE': '1', 10:07:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:07 INFO - 'NO_EM_RESTART': '1', 10:07:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:07 INFO - 'PWD': '/builds/slave/test', 10:07:07 INFO - 'SHELL': '/bin/bash', 10:07:07 INFO - 'SHLVL': '1', 10:07:07 INFO - 'TERM': 'linux', 10:07:07 INFO - 'TMOUT': '86400', 10:07:07 INFO - 'USER': 'cltbld', 10:07:07 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1462630536.737093-78274672', 10:07:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:07 INFO - '_': '/tools/buildbot/bin/python'} 10:07:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:07 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 10:07:07 INFO - Cleaning up... 10:07:07 INFO - Return code: 0 10:07:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:07:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f31eb3a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc18e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c50b20>, '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 0x1c51a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c51eb0>, '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': '652eb03db935cfc1c15ebda0000001ad-1462630536.737093-78274672', '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 10:07:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 10:07:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:07:07 INFO - Using env: {'DISPLAY': ':0', 10:07:07 INFO - 'HOME': '/home/cltbld', 10:07:07 INFO - 'LANG': 'en_US.UTF-8', 10:07:08 INFO - 'LANGUAGE': 'en_US:en', 10:07:08 INFO - 'LOGNAME': 'cltbld', 10:07:08 INFO - 'MAIL': '/var/mail/cltbld', 10:07:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:08 INFO - 'MOZ_NO_REMOTE': '1', 10:07:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:08 INFO - 'NO_EM_RESTART': '1', 10:07:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:08 INFO - 'PWD': '/builds/slave/test', 10:07:08 INFO - 'SHELL': '/bin/bash', 10:07:08 INFO - 'SHLVL': '1', 10:07:08 INFO - 'TERM': 'linux', 10:07:08 INFO - 'TMOUT': '86400', 10:07:08 INFO - 'USER': 'cltbld', 10:07:08 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1462630536.737093-78274672', 10:07:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:08 INFO - '_': '/tools/buildbot/bin/python'} 10:07:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:08 INFO - Downloading/unpacking psutil>=0.7.1 10:07:08 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 10:07:08 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 10:07:08 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 10:07:08 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 10:07:08 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 10:07:08 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 10:07:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:07:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:07:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:07:10 INFO - Installing collected packages: psutil 10:07:10 INFO - Running setup.py install for psutil 10:07:10 INFO - building 'psutil._psutil_linux' extension 10:07:10 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 10:07:10 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 10:07:10 INFO - building 'psutil._psutil_posix' extension 10:07:10 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 10:07:10 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 10:07:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:07:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:07:10 INFO - Successfully installed psutil 10:07:10 INFO - Cleaning up... 10:07:10 INFO - Return code: 0 10:07:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:07:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f31eb3a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc18e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c50b20>, '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 0x1c51a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c51eb0>, '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': '652eb03db935cfc1c15ebda0000001ad-1462630536.737093-78274672', '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 10:07:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:07:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:07:10 INFO - Using env: {'DISPLAY': ':0', 10:07:10 INFO - 'HOME': '/home/cltbld', 10:07:10 INFO - 'LANG': 'en_US.UTF-8', 10:07:10 INFO - 'LANGUAGE': 'en_US:en', 10:07:10 INFO - 'LOGNAME': 'cltbld', 10:07:10 INFO - 'MAIL': '/var/mail/cltbld', 10:07:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:10 INFO - 'MOZ_NO_REMOTE': '1', 10:07:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:10 INFO - 'NO_EM_RESTART': '1', 10:07:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:10 INFO - 'PWD': '/builds/slave/test', 10:07:10 INFO - 'SHELL': '/bin/bash', 10:07:10 INFO - 'SHLVL': '1', 10:07:10 INFO - 'TERM': 'linux', 10:07:10 INFO - 'TMOUT': '86400', 10:07:10 INFO - 'USER': 'cltbld', 10:07:10 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1462630536.737093-78274672', 10:07:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:10 INFO - '_': '/tools/buildbot/bin/python'} 10:07:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:07:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:07:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:07:12 INFO - Installing collected packages: mozsystemmonitor 10:07:12 INFO - Running setup.py install for mozsystemmonitor 10:07:12 INFO - Successfully installed mozsystemmonitor 10:07:12 INFO - Cleaning up... 10:07:12 INFO - Return code: 0 10:07:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:07:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:12 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 0x7f31eb3a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc18e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c50b20>, '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 0x1c51a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c51eb0>, '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': '652eb03db935cfc1c15ebda0000001ad-1462630536.737093-78274672', '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 10:07:12 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 10:07:12 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 10:07:12 INFO - Using env: {'DISPLAY': ':0', 10:07:12 INFO - 'HOME': '/home/cltbld', 10:07:12 INFO - 'LANG': 'en_US.UTF-8', 10:07:12 INFO - 'LANGUAGE': 'en_US:en', 10:07:12 INFO - 'LOGNAME': 'cltbld', 10:07:12 INFO - 'MAIL': '/var/mail/cltbld', 10:07:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:12 INFO - 'MOZ_NO_REMOTE': '1', 10:07:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:12 INFO - 'NO_EM_RESTART': '1', 10:07:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:12 INFO - 'PWD': '/builds/slave/test', 10:07:12 INFO - 'SHELL': '/bin/bash', 10:07:12 INFO - 'SHLVL': '1', 10:07:12 INFO - 'TERM': 'linux', 10:07:12 INFO - 'TMOUT': '86400', 10:07:12 INFO - 'USER': 'cltbld', 10:07:12 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1462630536.737093-78274672', 10:07:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:12 INFO - '_': '/tools/buildbot/bin/python'} 10:07:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:13 INFO - Downloading/unpacking blobuploader==1.2.4 10:07: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 10:07: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 10:07: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 10:07: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 10:07: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 10:07: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 10:07:15 INFO - Downloading blobuploader-1.2.4.tar.gz 10:07:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:07:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:07: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 10:07: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 10:07: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 10:07: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 10:07: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 10:07: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 10:07:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:07:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:07: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 10:07: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 10:07: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 10:07: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 10:07: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 10:07: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 10:07:15 INFO - Downloading docopt-0.6.1.tar.gz 10:07:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:07:15 INFO - Installing collected packages: blobuploader, requests, docopt 10:07:15 INFO - Running setup.py install for blobuploader 10:07:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:07:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:07:15 INFO - Running setup.py install for requests 10:07:16 INFO - Running setup.py install for docopt 10:07:16 INFO - Successfully installed blobuploader requests docopt 10:07:16 INFO - Cleaning up... 10:07:16 INFO - Return code: 0 10:07:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:07:16 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')]} 10:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:16 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')]} 10:07:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:16 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 0x7f31eb3a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc18e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c50b20>, '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 0x1c51a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c51eb0>, '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': '652eb03db935cfc1c15ebda0000001ad-1462630536.737093-78274672', '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 10:07:16 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 10:07:16 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 10:07:16 INFO - Using env: {'DISPLAY': ':0', 10:07:16 INFO - 'HOME': '/home/cltbld', 10:07:16 INFO - 'LANG': 'en_US.UTF-8', 10:07:16 INFO - 'LANGUAGE': 'en_US:en', 10:07:16 INFO - 'LOGNAME': 'cltbld', 10:07:16 INFO - 'MAIL': '/var/mail/cltbld', 10:07:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:16 INFO - 'MOZ_NO_REMOTE': '1', 10:07:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:16 INFO - 'NO_EM_RESTART': '1', 10:07:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:16 INFO - 'PWD': '/builds/slave/test', 10:07:16 INFO - 'SHELL': '/bin/bash', 10:07:16 INFO - 'SHLVL': '1', 10:07:16 INFO - 'TERM': 'linux', 10:07:16 INFO - 'TMOUT': '86400', 10:07:16 INFO - 'USER': 'cltbld', 10:07:16 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1462630536.737093-78274672', 10:07:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:16 INFO - '_': '/tools/buildbot/bin/python'} 10:07:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:07:16 INFO - Running setup.py (path:/tmp/pip-fWsS94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:07:16 INFO - Running setup.py (path:/tmp/pip-1XPFyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:07:16 INFO - Running setup.py (path:/tmp/pip-MARkES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:07:16 INFO - Running setup.py (path:/tmp/pip-4i0MO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:07:16 INFO - Running setup.py (path:/tmp/pip-YjPMY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:07:17 INFO - Running setup.py (path:/tmp/pip-hrHZkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:07:17 INFO - Running setup.py (path:/tmp/pip-eD3jSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:07:17 INFO - Running setup.py (path:/tmp/pip-xsnZ2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:07:17 INFO - Running setup.py (path:/tmp/pip-mvU35Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:07:17 INFO - Running setup.py (path:/tmp/pip-UvTx2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:07:17 INFO - Running setup.py (path:/tmp/pip-7FP9db-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:07:17 INFO - Running setup.py (path:/tmp/pip-rHogzD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:07:17 INFO - Running setup.py (path:/tmp/pip-mbpTmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:07:17 INFO - Running setup.py (path:/tmp/pip-HEbdtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:07:17 INFO - Running setup.py (path:/tmp/pip-aED3bE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:07:17 INFO - Running setup.py (path:/tmp/pip-mBE8KL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:07:17 INFO - Running setup.py (path:/tmp/pip-I0z1vp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:07:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:07:17 INFO - Running setup.py install for manifestparser 10:07:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:07:18 INFO - Running setup.py install for mozcrash 10:07:18 INFO - Running setup.py install for mozdebug 10:07:18 INFO - Running setup.py install for mozdevice 10:07:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:07:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:07:18 INFO - Running setup.py install for mozfile 10:07:18 INFO - Running setup.py install for mozhttpd 10:07:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:07:18 INFO - Running setup.py install for mozinfo 10:07:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:07:18 INFO - Running setup.py install for mozInstall 10:07:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:07:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:07:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:07:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:07:18 INFO - Running setup.py install for mozleak 10:07:18 INFO - Running setup.py install for mozlog 10:07:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:07:18 INFO - Running setup.py install for moznetwork 10:07:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:07:19 INFO - Running setup.py install for mozprocess 10:07:19 INFO - Running setup.py install for mozprofile 10:07:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:07:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:07:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:07:19 INFO - Running setup.py install for mozrunner 10:07:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:07:19 INFO - Running setup.py install for mozscreenshot 10:07:19 INFO - Running setup.py install for moztest 10:07:19 INFO - Running setup.py install for mozversion 10:07:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:07:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:07:19 INFO - Cleaning up... 10:07:19 INFO - Return code: 0 10:07:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:19 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 0x7f31eb3a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc18e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c50b20>, '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 0x1c51a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c51eb0>, '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': '652eb03db935cfc1c15ebda0000001ad-1462630536.737093-78274672', '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 10:07:19 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 10:07:19 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 10:07:19 INFO - Using env: {'DISPLAY': ':0', 10:07:19 INFO - 'HOME': '/home/cltbld', 10:07:19 INFO - 'LANG': 'en_US.UTF-8', 10:07:19 INFO - 'LANGUAGE': 'en_US:en', 10:07:19 INFO - 'LOGNAME': 'cltbld', 10:07:19 INFO - 'MAIL': '/var/mail/cltbld', 10:07:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:19 INFO - 'MOZ_NO_REMOTE': '1', 10:07:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:19 INFO - 'NO_EM_RESTART': '1', 10:07:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:19 INFO - 'PWD': '/builds/slave/test', 10:07:19 INFO - 'SHELL': '/bin/bash', 10:07:19 INFO - 'SHLVL': '1', 10:07:19 INFO - 'TERM': 'linux', 10:07:19 INFO - 'TMOUT': '86400', 10:07:19 INFO - 'USER': 'cltbld', 10:07:19 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1462630536.737093-78274672', 10:07:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:19 INFO - '_': '/tools/buildbot/bin/python'} 10:07:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:07:19 INFO - Running setup.py (path:/tmp/pip-ZF0HbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:07:19 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)) 10:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:07:19 INFO - Running setup.py (path:/tmp/pip-UHFDzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:07:20 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)) 10:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:07:20 INFO - Running setup.py (path:/tmp/pip-3BNDaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:07:20 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)) 10:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:07:20 INFO - Running setup.py (path:/tmp/pip-0BAINJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:07:20 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)) 10:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:07:20 INFO - Running setup.py (path:/tmp/pip-5BL9ol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:07:20 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)) 10:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:07:20 INFO - Running setup.py (path:/tmp/pip-NoqnZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:07:20 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)) 10:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:07:20 INFO - Running setup.py (path:/tmp/pip-R4tP3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:07:20 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)) 10:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:07:20 INFO - Running setup.py (path:/tmp/pip-EIAFVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:07:20 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)) 10:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:07:20 INFO - Running setup.py (path:/tmp/pip-FcHPrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:07:20 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)) 10:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:07:20 INFO - Running setup.py (path:/tmp/pip-cow8f9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:07:20 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)) 10:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:07:20 INFO - Running setup.py (path:/tmp/pip-BUbGpk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:07:20 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)) 10:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:07:20 INFO - Running setup.py (path:/tmp/pip-Tln6sq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:07:20 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)) 10:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:07:20 INFO - Running setup.py (path:/tmp/pip-9zvQoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:07:20 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)) 10:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:07:20 INFO - Running setup.py (path:/tmp/pip-O8m6Ag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:07:20 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)) 10:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:07:20 INFO - Running setup.py (path:/tmp/pip-WmwTtQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:07:20 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)) 10:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:07:20 INFO - Running setup.py (path:/tmp/pip-QxyifG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:07:21 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)) 10:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:07:21 INFO - Running setup.py (path:/tmp/pip-koS2vQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:07:21 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)) 10:07:21 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)) 10:07:21 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)) 10:07:21 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)) 10:07:21 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)) 10:07:21 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)) 10:07:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:22 INFO - Downloading blessings-1.6.tar.gz 10:07:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:07:23 INFO - Installing collected packages: blessings 10:07:23 INFO - Running setup.py install for blessings 10:07:23 INFO - Successfully installed blessings 10:07:23 INFO - Cleaning up... 10:07:23 INFO - Return code: 0 10:07:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:07:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:07:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:07:23 INFO - Reading from file tmpfile_stdout 10:07:23 INFO - Current package versions: 10:07:23 INFO - argparse == 1.2.1 10:07:23 INFO - blessings == 1.6 10:07:23 INFO - blobuploader == 1.2.4 10:07:23 INFO - docopt == 0.6.1 10:07:23 INFO - manifestparser == 1.1 10:07:23 INFO - mozInstall == 1.12 10:07:23 INFO - mozcrash == 0.17 10:07:23 INFO - mozdebug == 0.1 10:07:23 INFO - mozdevice == 0.48 10:07:23 INFO - mozfile == 1.2 10:07:23 INFO - mozhttpd == 0.7 10:07:23 INFO - mozinfo == 0.9 10:07:23 INFO - mozleak == 0.1 10:07:23 INFO - mozlog == 3.1 10:07:23 INFO - moznetwork == 0.27 10:07:23 INFO - mozprocess == 0.22 10:07:23 INFO - mozprofile == 0.28 10:07:23 INFO - mozrunner == 6.11 10:07:23 INFO - mozscreenshot == 0.1 10:07:23 INFO - mozsystemmonitor == 0.0 10:07:23 INFO - moztest == 0.7 10:07:23 INFO - mozversion == 1.4 10:07:23 INFO - psutil == 3.1.1 10:07:23 INFO - requests == 1.2.3 10:07:23 INFO - wsgiref == 0.1.2 10:07:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:07:23 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')]} 10:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:23 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')]} 10:07:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:23 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 0x7f31eb3a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc18e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c50b20>, '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 0x1c51a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c51eb0>, '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': '652eb03db935cfc1c15ebda0000001ad-1462630536.737093-78274672', '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 10:07:23 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 10:07:23 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 10:07:23 INFO - Using env: {'DISPLAY': ':0', 10:07:23 INFO - 'HOME': '/home/cltbld', 10:07:23 INFO - 'LANG': 'en_US.UTF-8', 10:07:23 INFO - 'LANGUAGE': 'en_US:en', 10:07:23 INFO - 'LOGNAME': 'cltbld', 10:07:23 INFO - 'MAIL': '/var/mail/cltbld', 10:07:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:23 INFO - 'MOZ_NO_REMOTE': '1', 10:07:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:23 INFO - 'NO_EM_RESTART': '1', 10:07:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:23 INFO - 'PWD': '/builds/slave/test', 10:07:23 INFO - 'SHELL': '/bin/bash', 10:07:23 INFO - 'SHLVL': '1', 10:07:23 INFO - 'TERM': 'linux', 10:07:23 INFO - 'TMOUT': '86400', 10:07:23 INFO - 'USER': 'cltbld', 10:07:23 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1462630536.737093-78274672', 10:07:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:23 INFO - '_': '/tools/buildbot/bin/python'} 10:07:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:23 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)) 10:07:23 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)) 10:07:23 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)) 10:07:23 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)) 10:07:23 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)) 10:07:23 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)) 10:07:23 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)) 10:07:23 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)) 10:07:23 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)) 10:07:23 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)) 10:07:23 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)) 10:07:23 INFO - Cleaning up... 10:07:23 INFO - Return code: 0 10:07:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:07:23 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')]} 10:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:23 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')]} 10:07:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:23 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 0x7f31eb3a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc18e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c50b20>, '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 0x1c51a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c51eb0>, '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': '652eb03db935cfc1c15ebda0000001ad-1462630536.737093-78274672', '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 10:07:23 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 10:07:23 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 10:07:23 INFO - Using env: {'DISPLAY': ':0', 10:07:23 INFO - 'HOME': '/home/cltbld', 10:07:23 INFO - 'LANG': 'en_US.UTF-8', 10:07:23 INFO - 'LANGUAGE': 'en_US:en', 10:07:23 INFO - 'LOGNAME': 'cltbld', 10:07:23 INFO - 'MAIL': '/var/mail/cltbld', 10:07:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:23 INFO - 'MOZ_NO_REMOTE': '1', 10:07:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:23 INFO - 'NO_EM_RESTART': '1', 10:07:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:23 INFO - 'PWD': '/builds/slave/test', 10:07:23 INFO - 'SHELL': '/bin/bash', 10:07:23 INFO - 'SHLVL': '1', 10:07:23 INFO - 'TERM': 'linux', 10:07:23 INFO - 'TMOUT': '86400', 10:07:23 INFO - 'USER': 'cltbld', 10:07:23 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1462630536.737093-78274672', 10:07:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:23 INFO - '_': '/tools/buildbot/bin/python'} 10:07:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:23 INFO - Downloading/unpacking jsonschema 10:07:23 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 10:07:23 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 10:07:23 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 10:07:23 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 10:07:23 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 10:07:23 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 10:07:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:07:25 INFO - Downloading/unpacking functools32 (from jsonschema) 10:07:25 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 10:07:25 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 10:07:25 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 10:07:25 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 10:07:25 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 10:07:25 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 10:07:25 INFO - Downloading functools32-3.2.3-2.tar.gz 10:07:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:07:25 INFO - warning: no files found matching '*.txt' 10:07:25 INFO - no previously-included directories found matching 'build' 10:07:25 INFO - no previously-included directories found matching 'dist' 10:07:25 INFO - no previously-included directories found matching '.git*' 10:07:25 INFO - Installing collected packages: jsonschema, functools32 10:07:26 INFO - Running setup.py install for functools32 10:07:26 INFO - warning: no files found matching '*.txt' 10:07:26 INFO - no previously-included directories found matching 'build' 10:07:26 INFO - no previously-included directories found matching 'dist' 10:07:26 INFO - no previously-included directories found matching '.git*' 10:07:26 INFO - Successfully installed jsonschema functools32 10:07:26 INFO - Cleaning up... 10:07:26 INFO - Return code: 0 10:07:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:07:26 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')]} 10:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:26 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')]} 10:07:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:26 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 0x7f31eb3a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc18e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c50b20>, '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 0x1c51a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c51eb0>, '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': '652eb03db935cfc1c15ebda0000001ad-1462630536.737093-78274672', '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 10:07:26 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 10:07:26 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 10:07:26 INFO - Using env: {'DISPLAY': ':0', 10:07:26 INFO - 'HOME': '/home/cltbld', 10:07:26 INFO - 'LANG': 'en_US.UTF-8', 10:07:26 INFO - 'LANGUAGE': 'en_US:en', 10:07:26 INFO - 'LOGNAME': 'cltbld', 10:07:26 INFO - 'MAIL': '/var/mail/cltbld', 10:07:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:26 INFO - 'MOZ_NO_REMOTE': '1', 10:07:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:26 INFO - 'NO_EM_RESTART': '1', 10:07:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:26 INFO - 'PWD': '/builds/slave/test', 10:07:26 INFO - 'SHELL': '/bin/bash', 10:07:26 INFO - 'SHLVL': '1', 10:07:26 INFO - 'TERM': 'linux', 10:07:26 INFO - 'TMOUT': '86400', 10:07:26 INFO - 'USER': 'cltbld', 10:07:26 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1462630536.737093-78274672', 10:07:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:26 INFO - '_': '/tools/buildbot/bin/python'} 10:07:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:26 INFO - Downloading/unpacking flake8 10:07:26 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 10:07:26 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 10:07:26 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 10:07:26 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 10:07:26 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 10:07:26 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 10:07:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:07:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:07:28 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 10:07:28 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 10:07:28 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 10:07:28 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 10:07:28 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 10:07:28 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 10:07:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:07:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:07:28 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 10:07:28 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 10:07:28 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 10:07:28 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 10:07:28 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 10:07:28 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 10:07:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:07:28 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 10:07:28 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 10:07:28 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 10:07:28 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 10:07:28 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 10:07:28 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 10:07:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:07:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:07:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:07:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:07:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:07:28 INFO - no previously-included directories found matching 'docs/_build' 10:07:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:07:29 INFO - Running setup.py install for pep8 10:07:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:07:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:07:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:07:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:07:29 INFO - no previously-included directories found matching 'docs/_build' 10:07:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:07:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:07:29 INFO - Cleaning up... 10:07:29 INFO - Return code: 0 10:07:29 INFO - Running post-action listener: _resource_record_post_action 10:07:29 INFO - Running post-action listener: _start_resource_monitoring 10:07:29 INFO - Starting resource monitoring. 10:07:29 INFO - ##### 10:07:29 INFO - ##### Finished create-virtualenv step (success) 10:07:29 INFO - ##### 10:07:29 INFO - ##### 10:07:29 INFO - ##### Running install step. 10:07:29 INFO - ##### 10:07:29 INFO - Running pre-action listener: _resource_record_pre_action 10:07:29 INFO - Running main action method: install 10:07:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:07:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:07:29 INFO - Reading from file tmpfile_stdout 10:07:29 INFO - Detecting whether we're running mozinstall >=1.0... 10:07:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:07:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:07:29 INFO - Reading from file tmpfile_stdout 10:07:29 INFO - Output received: 10:07:29 INFO - Usage: mozinstall [options] installer 10:07:29 INFO - Options: 10:07:29 INFO - -h, --help show this help message and exit 10:07:29 INFO - -d DEST, --destination=DEST 10:07:29 INFO - Directory to install application into. [default: 10:07:29 INFO - "/builds/slave/test"] 10:07:29 INFO - --app=APP Application being installed. [default: firefox] 10:07:29 INFO - mkdir: /builds/slave/test/build/application 10:07:29 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'] 10:07:29 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 10:07:46 INFO - Reading from file tmpfile_stdout 10:07:46 INFO - Output received: 10:07:46 INFO - /builds/slave/test/build/application/firefox/firefox 10:07:46 INFO - Running post-action listener: _resource_record_post_action 10:07:46 INFO - ##### 10:07:46 INFO - ##### Finished install step (success) 10:07:46 INFO - ##### 10:07:46 INFO - ##### 10:07:46 INFO - ##### Running run-tests step. 10:07:46 INFO - ##### 10:07:46 INFO - Running pre-action listener: _resource_record_pre_action 10:07:46 INFO - Running main action method: run_tests 10:07:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:07:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:07:46 INFO - Python 2.7.3 10:07:46 INFO - Return code: 0 10:07:46 INFO - grabbing minidump binary from tooltool 10:07:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:46 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 0x1c50b20>, '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 0x1c51a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c51eb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:07:46 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 10:07:46 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 10:07:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:07:46 INFO - Return code: 0 10:07:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:07:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:07:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:07:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:07:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:07:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:07:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:07:47 INFO - Return code: 0 10:07:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f18FJy7JTqOsLE2b1bDNbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 10:07:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/f18FJy7JTqOsLE2b1bDNbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 10:07:47 INFO - Using env: {'DISPLAY': ':0', 10:07:47 INFO - 'HOME': '/home/cltbld', 10:07:47 INFO - 'LANG': 'en_US.UTF-8', 10:07:47 INFO - 'LANGUAGE': 'en_US:en', 10:07:47 INFO - 'LOGNAME': 'cltbld', 10:07:47 INFO - 'MAIL': '/var/mail/cltbld', 10:07:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:07:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:07:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:47 INFO - 'MOZ_NO_REMOTE': '1', 10:07:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:07:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:47 INFO - 'NO_EM_RESTART': '1', 10:07:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:47 INFO - 'PWD': '/builds/slave/test', 10:07:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:07:47 INFO - 'SHELL': '/bin/bash', 10:07:47 INFO - 'SHLVL': '1', 10:07:47 INFO - 'TERM': 'linux', 10:07:47 INFO - 'TMOUT': '86400', 10:07:47 INFO - 'USER': 'cltbld', 10:07:47 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1462630536.737093-78274672', 10:07:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:47 INFO - '_': '/tools/buildbot/bin/python'} 10:07:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f18FJy7JTqOsLE2b1bDNbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 10:07:47 INFO - mozversion application_buildid: 20160507073429 10:07:47 INFO - mozversion application_changeset: bae525a694e2dc0aa433885be8751330d4995a49 10:07:47 INFO - mozversion application_display_name: Nightly 10:07:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:07:47 INFO - mozversion application_name: Firefox 10:07:47 INFO - mozversion application_remotingname: firefox 10:07:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:07:47 INFO - mozversion application_vendor: Mozilla 10:07:47 INFO - mozversion application_version: 49.0a1 10:07:47 INFO - mozversion platform_buildid: 20160507073429 10:07:47 INFO - mozversion platform_changeset: bae525a694e2dc0aa433885be8751330d4995a49 10:07:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:07:47 INFO - mozversion platform_version: 49.0a1 10:07:47 INFO - using testdate: 1462640867 10:07:47 INFO - actual date: 1462640867 10:07:47 INFO - starting webserver on 'localhost:54203' 10:07:47 INFO - SUITE-START | Running 2 tests 10:07:47 INFO - TEST-START | dromaeo_css 10:07:47 INFO - operating with platform_type : linux_ 10:07:47 INFO - Initialising browser for dromaeo_css test... 10:07:47 INFO - TEST-INFO | started process 25829 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbL1g28/profile http://localhost:54203/getInfo.html) 10:07:51 INFO - PROCESS | 25829 | __metrics Screen width/height:1600/1200 10:07:51 INFO - PROCESS | 25829 | colorDepth:24 10:07:51 INFO - PROCESS | 25829 | Browser inner width/height: 1024/697 10:07:51 INFO - PROCESS | 25829 | __metrics 10:07:52 ERROR - PROCESS | 25829 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:07:53 INFO - TEST-INFO | 25829: exit 0 10:07:53 INFO - Browser initialized. 10:07:53 INFO - Running cycle 1/1 for dromaeo_css test... 10:07:53 INFO - TEST-INFO | started process 25912 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbL1g28/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:08:05 INFO - PROCESS | 25912 | RSS: Main: 152379392 10:08:05 INFO - PROCESS | 25912 | 10:08:55 INFO - PROCESS | 25912 | 1462640935902 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] 10:11:03 INFO - PROCESS | 25912 | Cycle 1(1): loaded http://localhost:54203/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54203/tests/dromaeo/cssquery-ext.html) 10:11:04 INFO - PROCESS | 25912 | RSS: Main: 259096576 10:11:04 INFO - PROCESS | 25912 | 10:14:07 INFO - PROCESS | 25912 | Cycle 1(1): loaded http://localhost:54203/tests/dromaeo/cssquery-ext.html (next: http://localhost:54203/tests/dromaeo/cssquery-jquery.html) 10:14:07 INFO - PROCESS | 25912 | RSS: Main: 236994560 10:14:07 INFO - PROCESS | 25912 | 10:17:09 INFO - PROCESS | 25912 | Cycle 1(1): loaded http://localhost:54203/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54203/tests/dromaeo/cssquery-mootools.html) 10:17:10 INFO - PROCESS | 25912 | RSS: Main: 235053056 10:17:10 INFO - PROCESS | 25912 | 10:20:12 INFO - PROCESS | 25912 | Cycle 1(1): loaded http://localhost:54203/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54203/tests/dromaeo/cssquery-prototype.html) 10:20:12 INFO - PROCESS | 25912 | RSS: Main: 228417536 10:20:12 INFO - PROCESS | 25912 | 10:23:15 INFO - PROCESS | 25912 | Cycle 1(1): loaded http://localhost:54203/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54203/tests/dromaeo/cssquery-yui.html) 10:23:16 INFO - PROCESS | 25912 | RSS: Main: 226168832 10:23:16 INFO - PROCESS | 25912 | 10:26:18 INFO - PROCESS | 25912 | Cycle 1(1): loaded http://localhost:54203/tests/dromaeo/cssquery-yui.html (next: http://localhost:54203/tests/dromaeo/cssquery-dojo.html) 10:26:19 INFO - PROCESS | 25912 | RSS: Main: 270049280 10:26:19 INFO - PROCESS | 25912 | 10:26:19 INFO - PROCESS | 25912 | __start_tp_report 10:26:19 INFO - PROCESS | 25912 | _x_x_mozilla_page_load 10:26:19 INFO - PROCESS | 25912 | _x_x_mozilla_page_load_details 10:26:19 INFO - PROCESS | 25912 | |i|pagename|runs| 10:26:19 INFO - PROCESS | 25912 | |0;dojo.html;3058.2965917838897;3091.829949352786;3112.5331200319947;3124.23456253218;3154.668759780223;5121.334226550548;5181.559567436763;5241.921371179431;5247.895042099156;5252.080885844976;5201.141811601091;5240.135377662681;5252.238425428311;5273.209018647205;5273.9736301318535;4701.482836887948;4739.620830333565;4869.220924652056;4879.780409881564;4907.779149938261;4590.724556526619;4877.685260626767;4908.950910490903;4909.68087074339;4910.386201724785;4740.857774266778;4744.240921452569;4787.473377928425;4795.808167673289;4814.855554333376;4815.49437309081;4815.831445899376;4817.349657796188;4820.831270905502;4850.369451971221;4649;4716.38686970695;4761.880952976203;4795.017021510582;4834.613230941552;5230.895382092375;5238.423773384925;5252.973735131338;5263.289455923439;5267.499587539178;5621.494065534122;5664;5670.149477578396;5674;5675.318961724578;5505.559555235572;5571.749271282802;5605.607607467479;5619.466150715675;5683.403242659544;5250.894982100336;5328.600354973315;5328.786848526054;5333.759980800874;5336.786528538853;5746.683932383676;5759.827205183851;5803.709814509258;5814.895169917702;5818.069108942634;5301.125314323171;5350.892982140335;5379.6234263601955;5391.56867450603;5507.366652834895;5526.806561770319;5528.55771538276;5530.474604912527;5532.114861622121;5574.442555744393;5506.972465137648;5513.5037846594;5515.227868098469;5518.53092487135;5518.91721624176;5542.0301447247375;5591.496765291062;5611.803586874522;5641.294838145232;5641.746121424464;4309.741415515016;4315.136972605492;4317.935230971538;4320.330348795942;4358.76026818528;3761.887143385703;3810.9809450952566;3868.8065596720053;3887.086534664352;3896.785676787747;5350.732463376816;5368.677879327252;5387.8114266001285;5390.0836857734275;5443.700596467233;5671.6597004179885;5680.233168522197;5682.715864206773;5683.573731970118;5688.601797874192;5233;5310.336207974004;5335.253064570963;5367.033933891937;5436.809711660073;4866.367372241657;4872.756362181876;4873.707577545359;4890.779914903838;4895;5824.621399609012;5862.267216597926;5865.794697185578;5874.030784920526;5915.911261331084;5477.726113694379;5485.067538518381;5548.167774833807;5666.575006874501;5673.489385955284;5694.373618901835;5699.316082070178;5701.828945131652;5704.3725190228215;5738.081906894877;5433.673979561081;5441.945580544144;5443.428440013741;5445.373782014961;5445.482679145475;5529.889402211853;5552.194931734956;5552.69460179694;5590.385057643574;5596.552275817843;5482.424345443671;5483.287172667528;5485.61600687948;5489.698066606375;5496.148097044965;5422.267993820784;5439.864003399946;5469;5473.917891231715;5526.17107433872;5265.578753699771;5415.4313797050745;5452.0731475648445;5469.671819690831;5493.340799104133;5602.635828671123;5617.606767526398;5660.858478537904;5665.971670141623;5667.659940403589;5240.947590524046;5441.129419292894;5446.183072539151;5450.618456707993;5515.365732940763 10:26:19 INFO - PROCESS | 25912 | |1;ext.html;577.615885436185;628.6950828848005;631.9810405687828;638.4477427025621;650.3139188156493;43376;44904.32643510346;44962.775186124105;44987;49079;44792.77603611985;45183;45194;45338.7733061335;45367;8793.692220772258;8973.371863969525;8977.551122443885;8982.640694372218;8984.910150898506;8904.777380565472;8926.062763409846;8993.415427997159;9002.594883230271;9007.414518056337;9049.276057915384;9088.091190880925;9094.49980251086;9102.317326200528;9104.635814567442;8975.102489751005;9015.098490150933;9020.323475739313;9021.954890225572;9023.278137748965;8844.071372505923;8972.327075469366;8976.371653984224;8977.32670049749;8988.191062804379;41425.585744142474;41949.1610167798;41984.370234446505;42029.15941681149;42066.789666051474;3177.614653382724;3208.8235147066903;3314.6022477302636;3325.8004519728893;3551.5383000210068;31360.21599460009;31743;31759.52360714591;32106.839465802754;33205.50191747126;4311.892202694927;4319.416878721395;4323.632491238249;4411.911761764747;4415.977920110411;303726.4068398308;304239;304398;304944;305193;59344.10983835246;60040.69979650074;60169.69915150396;60257.39742602606;60324;36776.816115919246;37836.054098647204;37868.8106559471;39984.20031599352;40055.39916901249;17604.559886002953;17641.206145723474;17657.117144142998;17732.55668608295;17783.822161778477;13585.45658173662;13678.863211367958;13707.657308567366;13713.382897769625;13713.520026799015;19799.40601781949;19944.20223191085;20033.198672053248;20081;20088.39734807958;7317.914049735489;7336.303051210127;7412.888806667905;7437.442191835526;7497.737579184703;1022.2180032275315;1100.2848148703247;1112.6495154026618;1208.3656080557778;1210.9283284293288;31481;32048;32165.35669286601;32260.677393226237;32603.347933041205;1141.2809929744208;1162.2445410483253;1189.131933688395;1218.8476440444945;1230.7169351049308;17170.742438863428;17338.479845604652;17387.478375648498;17442.215100320514;17472.825271747373;429618;431506;433216;433404;434046;56504.15243771347;57808.71095644495;57839.42160578424;57851.421485785446;57860;1321.1214542329244;1381.9861801382058;1422.7225690990365;1428.4786053090547;1436.9640758981318;31618.209544761565;33195.83402082974;33224.16939576433;33318.66681333253;33338.66661333355;50925.49074509207;51161.23258151205;51572;51586.74206629093;51669.7416512915;346777;348650;348838;348946;349039;25598.23205303844;28072.43855122927;28482.287942801595;29125.41749165047;29312.387818670177;45344.773276133405;45451.77274113608;45872.54127458682;46423.76788116038;46797.766011169726;38850.41724374193;39039.80480097581;39278.6072139275;39314.331273669755;40366.59633403629;38834.80582597069;39518.40722389109;40524;40816;41318;40442.59557404388;40910.59089409068;41231;41245;41366;33911.15222119368;35433.46849797307;35613.64386356103;36161.095972600895;36603.08492287714;27415;27501.587476188273;27660;27894.44211115807;27908.720912790614 10:26:19 INFO - PROCESS | 25912 | |2;jquery.html;403.68915934730256;410.2840543252025;410.3741793764511;411.79410294852573;421.56789290976747;13014.414351354188;17646.294148234054;19356.3225287115;19454;19486.707699384504;14419.567412977602;18770.43688689338;18799.530011749714;19377.90311048446;19750.70373944392;5594.748236329375;5763.5101016413655;5770.336411312711;5773.595848290622;5801.44886235809;5701.657900525982;5732.541396688255;5751.079827227644;5753.5684823638185;5755.107958266475;4184.351425529033;5962.8807423851495;6268.467180289681;6283.717232724515;6440.420362167404;6126.724297406583;6375.585586936858;6386.712597933104;6407.327230640785;6423.036544518313;5684.630499017592;5703.942960570383;5724.5992780505385;5729.627574207663;5731.512821410185;21929.671054934188;22452.32643020712;22979.195728149603;23338;23341.299761007198;2335.1476711000532;2352.494213744036;2384.618461046224;2438.0979037755965;2687.032668239432;9750.512474376324;10317.380957142595;10337.844932326021;13899.305034748222;14800.037997530126;1975.4172519106899;2037.1036743832667;2081.2195426714984;2088.7806780288156;2098.1187901081585;68502.21034491381;84824;85092;86585.56707216424;87086.5645671774;10692.625758098584;10820.350778953289;10837.078848297826;10899.509522071527;11086.778264434828;14863.628409289855;14869.776953345709;14925.328360223815;14934.701305974037;14966.551003469913;8147.714829980922;8393.412461127784;8425.36809739272;8570.48577085377;8584.91415085841;8243.876341854877;8249.010118785784;8263.586820658944;8385.916140838635;8456.8731469028;4108.239975604522;4506.6169375602785;4531.84138555149;4558.475775285885;4618.376519169869;1799.997068408672;1828.1208883416364;1964.1161477335256;1992.7807941126464;2028.9594208115755;902.8961669407971;1033.751899544104;1055.3193190392153;1064.0742553977934;1071.5231721883688;18396.61519863716;19087.331943381916;19275.22899084049;19382.903085484766;19409.61180776405;1025.5282570017876;1034.8240799064176;1042.8592140061146;1054.135608800776;1069.337011053152;10534.420606866543;10915.072218861485;10923.890761092287;10929.125669946385;10940;416076;417736;423613;438583;441392;89513;91108;95463.52268238753;95507.52246238863;95849;1028.4446398944485;1033.540074666781;1039.5218199628255;1053.1311667874033;1060.7189094890014;16462.588435289214;16828.242729077465;16865.831341686917;17044;17337.133143343035;37206.81396593;38244;38558.80720596379;39276.803615981735;39793;49510.75244623754;51755.48244517507;54415.455845441036;54625.45374546204;54752.726236368566;8310.875336870073;8844.955775221082;8865.423747456394;8881.822363552821;9132;12496.500139994298;13097.672558186121;13277.734445311233;13330.333483325989;13428.530001449903;11299.661010169708;11440.713982150513;11444.94277528607;11492.080633549464;11935.343556104497;11327;11492.712682183012;11531.077513799044;11674.70813229676;11851.703707407383;11599.6520104397;11730.354830484406;11747.823782643096;11813.232139910879;11845.940770296093;7545.320921117126;7851.450398472052;8067.959660201662;8180.304674102768;8494.235518803338;11038.227324087236;11204.495797689287;11537.826932596186;11675.299482031105;12168 10:26:19 INFO - PROCESS | 25912 | |3;mootools.html;1384;1542.6266534375047;1543.1559286652448;1747.0740507531004;1885.0763126068223;7981.84036319274;8346;8347.540885251308;8360.247577718004;8544.316454683625;7871.606419679008;8125.228103330189;8284.668613255477;8307.50154990701;8327.16728327167;1953.9511512212166;1997.3308941504613;2000.3698834867043;2209.1826024370966;2251.4934139818574;2258.322503249027;2334.043042352636;2340.216027630746;2346.1788374069024;2347.5539647467012;2220.3449982255274;2236.39617303328;2288.8855557222155;2307.5961706701346;2310.156792770635;1934.5260411199206;2160.589487997291;2217.301550011749;2251.1220623956588;2251.628481300592;2313.849599776026;2346.4016675747575;2348.6594443805725;2349.9060037598474;2352.8588284702973;8256.793580160544;8288.709895153701;8297.626606802709;8304.045034820952;8314.501129932223;4819.566239038503;4967.279744437036;4967.552920237196;4984.950150498485;5003.949170674163;2927.53159494482;3115.4236466253587;3142.245860993368;3144.528320751883;3146.5122905949383;2021.3127536637467;2062.0823733438624;2077.7714451410334;2126.1282874021576;2169.2190811308074;11662;11847;11883.168178227528;11891;11905.107116966175;4358.0412309291905;4406.074724307867;4478.888027799331;4489.371487991683;4546.340780586796;10130.138938190335;10180.083792458714;10213.234007449471;10213.489325533694;10216.387016779017;5080.441151473335;5114.590832733373;5157.097507936096;5164.793408263702;5168.508991645787;4160.854370097092;4581.2440947243995;4700.764961751899;4720.480747117815;4722.386089808303;3821.541415030214;3916.686665066845;3917.1578110706337;3919.0790164311366;4024.7182697210915;1230.5200971621075;1256.824044633752;1258.4714419943462;1270.4664041102758;1284.101129209557;834.1950018232435;923.3721069672553;931.1061381074245;941.9387739796891;952.8665986761858;5780;5835.44563266489;5933;5995.520358371407;6218.067289906459;987.2842189412762;992.1814503035025;995.3977843404781;1017.6946915925192;1029.264076185531;3951.1702542465828;4021.8391264349098;4050.210209009215;4061.248668996245;4160.147169830238;10070.295079344376;10641.467926603638;10753.301035432673;10768.892311076946;10796.568137274578;10443.373397596168;10596.523156457824;10601.363918164934;10650.520726567323;10661.307015043998;8030.959845200853;8034.317083048007;8070.757877263692;8112.310453611509;8160.061592916772;5814.9070360374935;5833.125031245348;5859.736311865891;5940.970295148497;5970.552208584287;9652.75868103303;9719.222462203148;9803.901960980298;9822.017798220406;9917.900820991987;9986;10004.449755263531;10104.494775261355;10162.796744065225;10173.440460774433;6680.4989625779235;6883.518153729391;6997.47518936092;7029.086218791729;7151.749688760869;7709.383249339927;7897.328727058035;7981.361491080584;8002.159773223961;8003.879941800994;7370.336669699753;7371.631418429164;7397.667104980181;7473.663685134074;7684.346830519468;7377.741779037922;7394.33450989392;7409.296116868889;7471.252874712485;7535.321821036133;6951.409130223988;7000.684969176501;7009.369156775914;7046.929530704832;7048.048513450619;4913.926291105565;5084.745762711776;5087.23691446286;5101.234814777813;5104.719240441663;5057.8735531612;5153;5175.844724658266;5237.476252374732;5346.1980702893325 10:26:19 INFO - PROCESS | 25912 | |4;prototype.html;325.39963766850155;334.2596149528793;337.7348781206753;342.85771404866983;344.03841263668045;5058.418281897583;5143.922841157386;5224.824414506739;5270.81552145675;5289.629725919182;5156.407013193484;5196.662216955895;5207.427183009866;5225.268462415265;5258.973705131469;4108.81510332035;4113.197926404352;4129.398478958252;4140.5859414058505;4159.792010399483;3901.356276214421;3902.804859757001;4104.4664193654935;4133.81397837098;4138.937915931264;3992.2015596880597;4032.4757781488365;4066.7356621819486;4069.409935559342;4078.796060196993;4018.2566225248274;4038;4059.7158198926086;4060.4924384451942;4099.733517321394;3562.608113107556;3607.963920360789;3622.963770362289;3637.672609465161;3640.908977275563;4937.604991600663;5004.474530174352;5026.070177017264;5038.39539255288;5057.519535644108;4602.677812553123;4641.512641172696;4648.2562789953445;4650.837220697259;4673.556012178838;5172.586193104543;5381.946180538183;5385.35375754908;5391.946080539184;5424.647397919122;4000.159966407058;4002.679785617144;4009;4017.4777278953843;4020.336644453662;5675.148727690838;5688.488036076732;5703.458171473703;5716.1711551825165;5736.024875771129;4077.0215148364177;4094.959050409517;4116.217918595457;4119.299719047769;4123.134141830189;3878.5733569307354;4091.608852989938;4096.3409819023345;4097.364908439137;4111.732737372061;4622.19111655459;4645.210314246586;4649.6051184644475;4651.953480465152;4662.6969246999515;5461.754221060062;5485.561155107582;5486.683196032924;5487.341519017664;5531.529819965268;1275.6095855517344;1293.2886912198253;1349.7368013237324;1364.3519328318969;1374.8900087992936;930.5393830054167;930.9441433514011;932.305432452827;940.5109343141528;948.1466679987929;4979.601631869442;5109.441620305843;5138.768755406016;5167.243137333249;5170.302009228706;5373.361124856956;5373.650712703662;5386.542143917733;5390.434004429557;5442.319710036246;4982.377202849644;5095.643304968691;5099.949000509948;5104.881474188244;5125.4874512549195;2801.537746271883;2806.6772321183325;2816.7042460541757;2852.1728698677152;2895.2038189498057;5414.566834653218;5466.9179962300595;5507.256520369779;5535.58483113768;5562.833115006556;5292.206169074592;5379.193121031798;5416.593755468356;5463.262459567907;5525.309336332958;5593.664380137124;5614.24207731951;5619.662820230717;5624.57815663835;5637.43625637433;5248.824461200918;5418.4852439019805;5431.2667789847865;5437.945620543744;5451.100568406168;5263.2104884483115;5293.523582877406;5306.867328316823;5381.73091345439;5391.86520336979;5374.785008599612;5450.890982180414;5485.50630443262;5536.778528858962;5542.889142217214;3783.9387767208987;3881.777240169338;3896.2402331545077;3898.629630185128;3904.590018048064;5294.1794021925125;5315.734213289397;5331.840044798662;5345.9842629900195;5370.865728356823;5182.97408512955;5189.896202076013;5246;5249.107651699144;5261.631685781958;5108.7445627717725;5162.328897243485;5175.896482070413;5193.974030129825;5553.805616803393;5360.571154307724;5406.83779486616;5475.523042867728;5477.370102438271;5494.423085575957;5469.2616496772425;5479.589030822784;5494.955958367897;5497.890042199214;5498.725063746877;5210.53105220532;5380.811671591476;5386.8383948481605;5401.6218864679095;5438.592105592017 10:26:19 INFO - PROCESS | 25912 | |5;yui.html;802.9116797152312;835.9080501144877;838.5262326785365;841.5707988925653;852.4586887326548;14504.782428263585;14945.626359341008;15092.094474331549;15107.244637768095;15140.84859151408;12763.23420594765;13686.657833554165;13694.246816425093;14131.717365652681;14222.573322800306;688.8002479281015;700.086387264622;700.2017699822206;701.2811867835459;706.6749295324157;852.4160949749411;854.4488804720951;854.8418542569644;855.0210009539074;855.3969451536652;894.3515950935553;895.243519226256;895.8924929008496;896.8654701794718;898.6405437824857;884.1114679746878;892.6117139044471;894.5035505294592;894.9149830766066;895.2569367425021;647.7506160128337;648.4747354642755;649.3052433895733;649.5355820588255;649.574528683713;13308.933455332759;13411.262380569065;13446.12600180995;13479.460821567125;13542.93228533861;12434.875651243463;12456.501739930392;12462.189957652814;12569.308688022154;12636.178648387826;10130.594776208944;10158.238132140044;10175.084242418145;10175.440350780704;10398;3795.734298599099;3837.4052021936645;3858;3874.612538746131;3921.8823435296986;46223.76888115538;55967.160492592644;58619.41380586225;58736.41263587352;58757;8645.394822362374;10913.23607347494;11022.283551569282;11110.444477776078;12183.756324873453;19882.801171988383;20061.29785457502;20079.096440659912;20138.69791953122;20230.393088207376;8661.003984541732;8697;8701.955765308203;8763.123687631185;9277.257819374434;4296.76367799774;4387.934180987288;4679.251319788817;4915.4347250065985;5047.318611987408;3325.48454989477;3421.26442814796;3430.1939044324563;3436.5017072524342;3440.0539851541025;647.8671872266174;647.9125318082093;649.9447546958467;654.1920727901038;661.3419647450817;709.7267303931734;730.6200775596766;741.403170447784;746.6266866566716;776.4564804636777;9845.261605379483;10206.897931020743;10258.12805911491;10354.11989980845;11033.779324413466;703.395080231001;740.4076738609199;755.712829124929;762.8512440074243;763.2253262938123;4931.211006238985;4983.6760610560195;4988.825391111366;4998.225275082295;5027.874303142377;61935.38064619296;62149.37850621526;63141.36858631447;63560.682196589645;65112.34887651063;43613.345799813025;47765.52234477611;49332.26001609979;53006.204906926425;56153.38897129671;56382.1542676852;56667.433325666214;57075.714621426625;57118.143227851615;57184.71407642935;8759.430637008574;9731.902680973382;9890;9894.307398482037;10012.549435275285;34799.30401391907;35405;35506.11234719153;35602.64397356097;36483.63516364909;46193.76903115463;48484.272735908286;48908;49035;49071.50928490669;12142.453589588313;12250.816237756619;12311.876881231074;12414.937925310316;12786.68033299175;13472.46110155622;13806.723865522432;13944.51194208198;14491.637709057359;14593.270336482921;13113.147645403018;13285.601431957057;13690;13706.383212755649;14016;13081.084324097223;13348.199108053548;13361.66595835112;13954.511592094228;14019.579412617637;12934.482620695067;12989.935050325066;13201.405936732677;13840.446382145004;13873.72252554923;10623.628173013907;10684.519196636325;10805.891941080488;11020.889791102307;11046.779064418506;11281.943590281997;11448.370339631067;11549.609143107959;11560.364179970182;11615.419229038684 10:26:19 INFO - PROCESS | 25912 | __end_tp_report 10:26:19 INFO - PROCESS | 25912 | __start_cc_report 10:26:19 INFO - PROCESS | 25912 | _x_x_mozilla_cycle_collect,814 10:26:19 INFO - PROCESS | 25912 | __end_cc_report 10:26:19 INFO - PROCESS | 25912 | __startTimestamp1462641979046__endTimestamp 10:26:19 INFO - PROCESS | 25912 | 10:26:19 INFO - PROCESS | 25912 | ------- Summary: start ------- 10:26:19 INFO - PROCESS | 25912 | Number of tests: 6 10:26:19 INFO - PROCESS | 25912 | 10:26:19 INFO - PROCESS | 25912 | [#0] dojo.html Cycles:165 Average:5220.52 Median:5436.81 stddev:575.25 (10.6%) stddev-sans-first:551.44 10:26:19 INFO - PROCESS | 25912 | Values: 3058.3 3091.8 3112.5 3124.2 3154.7 5121.3 5181.6 5241.9 5247.9 5252.1 5201.1 5240.1 5252.2 5273.2 5274.0 4701.5 4739.6 4869.2 4879.8 4907.8 4590.7 4877.7 4909.0 4909.7 4910.4 4740.9 4744.2 4787.5 4795.8 4814.9 4815.5 4815.8 4817.3 4820.8 4850.4 4649.0 4716.4 4761.9 4795.0 4834.6 5230.9 5238.4 5253.0 5263.3 5267.5 5621.5 5664.0 5670.1 5674.0 5675.3 5505.6 5571.7 5605.6 5619.5 5683.4 5250.9 5328.6 5328.8 5333.8 5336.8 5746.7 5759.8 5803.7 5814.9 5818.1 5301.1 5350.9 5379.6 5391.6 5507.4 5526.8 5528.6 5530.5 5532.1 5574.4 5507.0 5513.5 5515.2 5518.5 5518.9 5542.0 5591.5 5611.8 5641.3 5641.7 4309.7 4315.1 4317.9 4320.3 4358.8 3761.9 3811.0 3868.8 3887.1 3896.8 5350.7 5368.7 5387.8 5390.1 5443.7 5671.7 5680.2 5682.7 5683.6 5688.6 5233.0 5310.3 5335.3 5367.0 5436.8 4866.4 4872.8 4873.7 4890.8 4895.0 5824.6 5862.3 5865.8 5874.0 5915.9 5477.7 5485.1 5548.2 5666.6 5673.5 5694.4 5699.3 5701.8 5704.4 5738.1 5433.7 5441.9 5443.4 5445.4 5445.5 5529.9 5552.2 5552.7 5590.4 5596.6 5482.4 5483.3 5485.6 5489.7 5496.1 5422.3 5439.9 5469.0 5473.9 5526.2 5265.6 5415.4 5452.1 5469.7 5493.3 5602.6 5617.6 5660.9 5666.0 5667.7 5240.9 5441.1 5446.2 5450.6 5515.4 10:26:19 INFO - PROCESS | 25912 | 10:26:19 INFO - PROCESS | 25912 | [#1] ext.html Cycles:180 Average:53150.77 Median:40211.00 stddev:96142.14 (239.1%) stddev-sans-first:96330.81 10:26:19 INFO - PROCESS | 25912 | Values: 577.6 628.7 632.0 638.4 650.3 43376.0 44904.3 44962.8 44987.0 49079.0 44792.8 45183.0 45194.0 45338.8 45367.0 8793.7 8973.4 8977.6 8982.6 8984.9 8904.8 8926.1 8993.4 9002.6 9007.4 9049.3 9088.1 9094.5 9102.3 9104.6 8975.1 9015.1 9020.3 9022.0 9023.3 8844.1 8972.3 8976.4 8977.3 8988.2 41425.6 41949.2 41984.4 42029.2 42066.8 3177.6 3208.8 3314.6 3325.8 3551.5 31360.2 31743.0 31759.5 32106.8 33205.5 4311.9 4319.4 4323.6 4411.9 4416.0 303726.4 304239.0 304398.0 304944.0 305193.0 59344.1 60040.7 60169.7 60257.4 60324.0 36776.8 37836.1 37868.8 39984.2 40055.4 17604.6 17641.2 17657.1 17732.6 17783.8 13585.5 13678.9 13707.7 13713.4 13713.5 19799.4 19944.2 20033.2 20081.0 20088.4 7317.9 7336.3 7412.9 7437.4 7497.7 1022.2 1100.3 1112.6 1208.4 1210.9 31481.0 32048.0 32165.4 32260.7 32603.3 1141.3 1162.2 1189.1 1218.8 1230.7 17170.7 17338.5 17387.5 17442.2 17472.8 429618.0 431506.0 433216.0 433404.0 434046.0 56504.2 57808.7 57839.4 57851.4 57860.0 1321.1 1382.0 1422.7 1428.5 1437.0 31618.2 33195.8 33224.2 33318.7 33338.7 50925.5 51161.2 51572.0 51586.7 51669.7 346777.0 348650.0 348838.0 348946.0 349039.0 25598.2 28072.4 28482.3 29125.4 29312.4 45344.8 45451.8 45872.5 46423.8 46797.8 38850.4 39039.8 39278.6 39314.3 40366.6 38834.8 39518.4 40524.0 40816.0 41318.0 40442.6 40910.6 41231.0 41245.0 41366.0 33911.2 35433.5 35613.6 36161.1 36603.1 27415.0 27501.6 27660.0 27894.4 27908.7 10:26:19 INFO - PROCESS | 25912 | 10:26:19 INFO - PROCESS | 25912 | [#2] jquery.html Cycles:180 Average:27087.62 Median:23158.60 stddev:70901.51 (306.2%) stddev-sans-first:71072.10 10:26:19 INFO - PROCESS | 25912 | Values: 403.7 410.3 410.4 411.8 421.6 13014.4 17646.3 19356.3 19454.0 19486.7 14419.6 18770.4 18799.5 19377.9 19750.7 5594.7 5763.5 5770.3 5773.6 5801.4 5701.7 5732.5 5751.1 5753.6 5755.1 4184.4 5962.9 6268.5 6283.7 6440.4 6126.7 6375.6 6386.7 6407.3 6423.0 5684.6 5703.9 5724.6 5729.6 5731.5 21929.7 22452.3 22979.2 23338.0 23341.3 2335.1 2352.5 2384.6 2438.1 2687.0 9750.5 10317.4 10337.8 13899.3 14800.0 1975.4 2037.1 2081.2 2088.8 2098.1 68502.2 84824.0 85092.0 86585.6 87086.6 10692.6 10820.4 10837.1 10899.5 11086.8 14863.6 14869.8 14925.3 14934.7 14966.6 8147.7 8393.4 8425.4 8570.5 8584.9 8243.9 8249.0 8263.6 8385.9 8456.9 4108.2 4506.6 4531.8 4558.5 4618.4 1800.0 1828.1 1964.1 1992.8 2029.0 902.9 1033.8 1055.3 1064.1 1071.5 18396.6 19087.3 19275.2 19382.9 19409.6 1025.5 1034.8 1042.9 1054.1 1069.3 10534.4 10915.1 10923.9 10929.1 10940.0 416076.0 417736.0 423613.0 438583.0 441392.0 89513.0 91108.0 95463.5 95507.5 95849.0 1028.4 1033.5 1039.5 1053.1 1060.7 16462.6 16828.2 16865.8 17044.0 17337.1 37206.8 38244.0 38558.8 39276.8 39793.0 49510.8 51755.5 54415.5 54625.5 54752.7 8310.9 8845.0 8865.4 8881.8 9132.0 12496.5 13097.7 13277.7 13330.3 13428.5 11299.7 11440.7 11444.9 11492.1 11935.3 11327.0 11492.7 11531.1 11674.7 11851.7 11599.7 11730.4 11747.8 11813.2 11845.9 7545.3 7851.5 8068.0 8180.3 8494.2 11038.2 11204.5 11537.8 11675.3 12168.0 10:26:19 INFO - PROCESS | 25912 | 10:26:19 INFO - PROCESS | 25912 | [#3] mootools.html Cycles:180 Average:5641.48 Median:4770.98 stddev:3140.95 (65.8%) stddev-sans-first:3133.47 10:26:19 INFO - PROCESS | 25912 | Values: 1384.0 1542.6 1543.2 1747.1 1885.1 7981.8 8346.0 8347.5 8360.2 8544.3 7871.6 8125.2 8284.7 8307.5 8327.2 1954.0 1997.3 2000.4 2209.2 2251.5 2258.3 2334.0 2340.2 2346.2 2347.6 2220.3 2236.4 2288.9 2307.6 2310.2 1934.5 2160.6 2217.3 2251.1 2251.6 2313.8 2346.4 2348.7 2349.9 2352.9 8256.8 8288.7 8297.6 8304.0 8314.5 4819.6 4967.3 4967.6 4985.0 5003.9 2927.5 3115.4 3142.2 3144.5 3146.5 2021.3 2062.1 2077.8 2126.1 2169.2 11662.0 11847.0 11883.2 11891.0 11905.1 4358.0 4406.1 4478.9 4489.4 4546.3 10130.1 10180.1 10213.2 10213.5 10216.4 5080.4 5114.6 5157.1 5164.8 5168.5 4160.9 4581.2 4700.8 4720.5 4722.4 3821.5 3916.7 3917.2 3919.1 4024.7 1230.5 1256.8 1258.5 1270.5 1284.1 834.2 923.4 931.1 941.9 952.9 5780.0 5835.4 5933.0 5995.5 6218.1 987.3 992.2 995.4 1017.7 1029.3 3951.2 4021.8 4050.2 4061.2 4160.1 10070.3 10641.5 10753.3 10768.9 10796.6 10443.4 10596.5 10601.4 10650.5 10661.3 8031.0 8034.3 8070.8 8112.3 8160.1 5814.9 5833.1 5859.7 5941.0 5970.6 9652.8 9719.2 9803.9 9822.0 9917.9 9986.0 10004.4 10104.5 10162.8 10173.4 6680.5 6883.5 6997.5 7029.1 7151.7 7709.4 7897.3 7981.4 8002.2 8003.9 7370.3 7371.6 7397.7 7473.7 7684.3 7377.7 7394.3 7409.3 7471.3 7535.3 6951.4 7000.7 7009.4 7046.9 7048.0 4913.9 5084.7 5087.2 5101.2 5104.7 5057.9 5153.0 5175.8 5237.5 5346.2 10:26:19 INFO - PROCESS | 25912 | 10:26:19 INFO - PROCESS | 25912 | [#4] prototype.html Cycles:180 Average:4528.77 Median:5174.24 stddev:1308.75 (25.3%) stddev-sans-first:1273.82 10:26:19 INFO - PROCESS | 25912 | Values: 325.4 334.3 337.7 342.9 344.0 5058.4 5143.9 5224.8 5270.8 5289.6 5156.4 5196.7 5207.4 5225.3 5259.0 4108.8 4113.2 4129.4 4140.6 4159.8 3901.4 3902.8 4104.5 4133.8 4138.9 3992.2 4032.5 4066.7 4069.4 4078.8 4018.3 4038.0 4059.7 4060.5 4099.7 3562.6 3608.0 3623.0 3637.7 3640.9 4937.6 5004.5 5026.1 5038.4 5057.5 4602.7 4641.5 4648.3 4650.8 4673.6 5172.6 5381.9 5385.4 5391.9 5424.6 4000.2 4002.7 4009.0 4017.5 4020.3 5675.1 5688.5 5703.5 5716.2 5736.0 4077.0 4095.0 4116.2 4119.3 4123.1 3878.6 4091.6 4096.3 4097.4 4111.7 4622.2 4645.2 4649.6 4652.0 4662.7 5461.8 5485.6 5486.7 5487.3 5531.5 1275.6 1293.3 1349.7 1364.4 1374.9 930.5 930.9 932.3 940.5 948.1 4979.6 5109.4 5138.8 5167.2 5170.3 5373.4 5373.7 5386.5 5390.4 5442.3 4982.4 5095.6 5099.9 5104.9 5125.5 2801.5 2806.7 2816.7 2852.2 2895.2 5414.6 5466.9 5507.3 5535.6 5562.8 5292.2 5379.2 5416.6 5463.3 5525.3 5593.7 5614.2 5619.7 5624.6 5637.4 5248.8 5418.5 5431.3 5437.9 5451.1 5263.2 5293.5 5306.9 5381.7 5391.9 5374.8 5450.9 5485.5 5536.8 5542.9 3783.9 3881.8 3896.2 3898.6 3904.6 5294.2 5315.7 5331.8 5346.0 5370.9 5183.0 5189.9 5246.0 5249.1 5261.6 5108.7 5162.3 5175.9 5194.0 5553.8 5360.6 5406.8 5475.5 5477.4 5494.4 5469.3 5479.6 5495.0 5497.9 5498.7 5210.5 5380.8 5386.8 5401.6 5438.6 10:26:19 INFO - PROCESS | 25912 | 10:26:19 INFO - PROCESS | 25912 | [#5] yui.html Cycles:180 Average:15200.58 Median:24000.64 stddev:17552.28 (73.1%) stddev-sans-first:17568.22 10:26:19 INFO - PROCESS | 25912 | Values: 802.9 835.9 838.5 841.6 852.5 14504.8 14945.6 15092.1 15107.2 15140.8 12763.2 13686.7 13694.2 14131.7 14222.6 688.8 700.1 700.2 701.3 706.7 852.4 854.4 854.8 855.0 855.4 894.4 895.2 895.9 896.9 898.6 884.1 892.6 894.5 894.9 895.3 647.8 648.5 649.3 649.5 649.6 13308.9 13411.3 13446.1 13479.5 13542.9 12434.9 12456.5 12462.2 12569.3 12636.2 10130.6 10158.2 10175.1 10175.4 10398.0 3795.7 3837.4 3858.0 3874.6 3921.9 46223.8 55967.2 58619.4 58736.4 58757.0 8645.4 10913.2 11022.3 11110.4 12183.8 19882.8 20061.3 20079.1 20138.7 20230.4 8661.0 8697.0 8702.0 8763.1 9277.3 4296.8 4387.9 4679.3 4915.4 5047.3 3325.5 3421.3 3430.2 3436.5 3440.1 647.9 647.9 649.9 654.2 661.3 709.7 730.6 741.4 746.6 776.5 9845.3 10206.9 10258.1 10354.1 11033.8 703.4 740.4 755.7 762.9 763.2 4931.2 4983.7 4988.8 4998.2 5027.9 61935.4 62149.4 63141.4 63560.7 65112.3 43613.3 47765.5 49332.3 53006.2 56153.4 56382.2 56667.4 57075.7 57118.1 57184.7 8759.4 9731.9 9890.0 9894.3 10012.5 34799.3 35405.0 35506.1 35602.6 36483.6 46193.8 48484.3 48908.0 49035.0 49071.5 12142.5 12250.8 12311.9 12414.9 12786.7 13472.5 13806.7 13944.5 14491.6 14593.3 13113.1 13285.6 13690.0 13706.4 14016.0 13081.1 13348.2 13361.7 13954.5 14019.6 12934.5 12989.9 13201.4 13840.4 13873.7 10623.6 10684.5 10805.9 11020.9 11046.8 11281.9 11448.4 11549.6 11560.4 11615.4 10:26:19 INFO - PROCESS | 25912 | -------- Summary: end -------- 10:26:19 INFO - PROCESS | 25912 | 10:26:19 INFO - TEST-INFO | 25912: exit 0 10:26:19 INFO - TEST-OK | dromaeo_css | took 1112463ms 10:26:19 INFO - TEST-START | kraken 10:26:19 INFO - operating with platform_type : linux_ 10:26:19 INFO - Initialising browser for kraken test... 10:26:19 INFO - TEST-INFO | started process 26099 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6DC3VW/profile http://localhost:54203/getInfo.html) 10:26:23 INFO - PROCESS | 26099 | __metrics Screen width/height:1600/1200 10:26:23 INFO - PROCESS | 26099 | colorDepth:24 10:26:23 INFO - PROCESS | 26099 | Browser inner width/height: 1024/697 10:26:23 INFO - PROCESS | 26099 | __metrics 10:26:24 ERROR - PROCESS | 26099 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:26:25 INFO - TEST-INFO | 26099: exit 0 10:26:25 INFO - Browser initialized. 10:26:25 INFO - Running cycle 1/1 for kraken test... 10:26:25 INFO - TEST-INFO | started process 26179 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6DC3VW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:26:37 INFO - PROCESS | 26179 | RSS: Main: 152477696 10:26:37 INFO - PROCESS | 26179 | 10:26:39 INFO - PROCESS | 26179 | Cycle 1(1): loaded http://localhost:54203/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54203/tests/kraken/driver.html?testName=audio-beat-detection) 10:26:40 INFO - PROCESS | 26179 | RSS: Main: 209129472 10:26:40 INFO - PROCESS | 26179 | 10:26:43 INFO - PROCESS | 26179 | Cycle 1(1): loaded http://localhost:54203/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54203/tests/kraken/driver.html?testName=audio-dft) 10:26:43 INFO - PROCESS | 26179 | RSS: Main: 197378048 10:26:43 INFO - PROCESS | 26179 | 10:26:47 INFO - PROCESS | 26179 | Cycle 1(1): loaded http://localhost:54203/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54203/tests/kraken/driver.html?testName=audio-fft) 10:26:47 INFO - PROCESS | 26179 | RSS: Main: 265105408 10:26:47 INFO - PROCESS | 26179 | 10:26:49 INFO - PROCESS | 26179 | Cycle 1(1): loaded http://localhost:54203/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54203/tests/kraken/driver.html?testName=audio-oscillator) 10:26:50 INFO - PROCESS | 26179 | RSS: Main: 175026176 10:26:50 INFO - PROCESS | 26179 | 10:26:52 INFO - PROCESS | 26179 | Cycle 1(1): loaded http://localhost:54203/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54203/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:26:53 INFO - PROCESS | 26179 | RSS: Main: 178388992 10:26:53 INFO - PROCESS | 26179 | 10:26:56 INFO - PROCESS | 26179 | Cycle 1(1): loaded http://localhost:54203/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54203/tests/kraken/driver.html?testName=imaging-darkroom) 10:26:56 INFO - PROCESS | 26179 | RSS: Main: 214876160 10:26:56 INFO - PROCESS | 26179 | 10:27:00 INFO - PROCESS | 26179 | Cycle 1(1): loaded http://localhost:54203/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54203/tests/kraken/driver.html?testName=imaging-desaturate) 10:27:00 INFO - PROCESS | 26179 | RSS: Main: 215302144 10:27:00 INFO - PROCESS | 26179 | 10:27:03 INFO - PROCESS | 26179 | Cycle 1(1): loaded http://localhost:54203/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54203/tests/kraken/driver.html?testName=json-parse-financial) 10:27:04 INFO - PROCESS | 26179 | RSS: Main: 215437312 10:27:04 INFO - PROCESS | 26179 | 10:27:05 INFO - PROCESS | 26179 | Cycle 1(1): loaded http://localhost:54203/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54203/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:27:06 INFO - PROCESS | 26179 | RSS: Main: 204890112 10:27:06 INFO - PROCESS | 26179 | 10:27:08 INFO - PROCESS | 26179 | Cycle 1(1): loaded http://localhost:54203/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54203/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:27:08 INFO - PROCESS | 26179 | RSS: Main: 208392192 10:27:08 INFO - PROCESS | 26179 | 10:27:10 INFO - PROCESS | 26179 | Cycle 1(1): loaded http://localhost:54203/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54203/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:27:11 INFO - PROCESS | 26179 | RSS: Main: 217542656 10:27:11 INFO - PROCESS | 26179 | 10:27:14 INFO - PROCESS | 26179 | Cycle 1(1): loaded http://localhost:54203/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54203/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:27:14 INFO - PROCESS | 26179 | RSS: Main: 221220864 10:27:14 INFO - PROCESS | 26179 | 10:27:17 INFO - PROCESS | 26179 | Cycle 1(1): loaded http://localhost:54203/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54203/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:27:18 INFO - PROCESS | 26179 | RSS: Main: 219324416 10:27:18 INFO - PROCESS | 26179 | 10:27:19 INFO - PROCESS | 26179 | Cycle 1(1): loaded http://localhost:54203/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54203/tests/kraken/driver.html?testName=ai-astar) 10:27:19 INFO - PROCESS | 26179 | RSS: Main: 265252864 10:27:19 INFO - PROCESS | 26179 | 10:27:19 INFO - PROCESS | 26179 | __start_tp_report 10:27:19 INFO - PROCESS | 26179 | _x_x_mozilla_page_load 10:27:19 INFO - PROCESS | 26179 | _x_x_mozilla_page_load_details 10:27:19 INFO - PROCESS | 26179 | |i|pagename|runs| 10:27:19 INFO - PROCESS | 26179 | |0;ai-astar;115;107;113;113;112;114;113;113;112;112 10:27:19 INFO - PROCESS | 26179 | |1;audio-beat-detection;162;123;154;183;127;147;156;125;180;130 10:27:19 INFO - PROCESS | 26179 | |2;audio-dft;160;160;160;162;161;160;160;162;161;161 10:27:19 INFO - PROCESS | 26179 | |3;audio-fft;74;74;76;126;76;77;76;73;131;76 10:27:19 INFO - PROCESS | 26179 | |4;audio-oscillator;92;91;120;91;92;92;120;91;91;120 10:27:19 INFO - PROCESS | 26179 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;117;117;117 10:27:19 INFO - PROCESS | 26179 | |6;imaging-darkroom;147;147;145;146;146;146;146;145;146;144 10:27:19 INFO - PROCESS | 26179 | |7;imaging-desaturate;94;95;97;96;94;95;95;94;95;95 10:27:19 INFO - PROCESS | 26179 | |8;json-parse-financial;56;58;58;59;57;57;56;79;54;54 10:27:19 INFO - PROCESS | 26179 | |9;json-stringify-tinderbox;58;59;58;58;60;59;59;59;59;59 10:27:19 INFO - PROCESS | 26179 | |10;stanford-crypto-aes;78;78;79;78;79;81;81;80;84;84 10:27:19 INFO - PROCESS | 26179 | |11;stanford-crypto-ccm;123;133;124;125;124;134;126;124;212;127 10:27:19 INFO - PROCESS | 26179 | |12;stanford-crypto-pbkdf2;169;165;171;168;163;166;167;163;169;171 10:27:19 INFO - PROCESS | 26179 | |13;stanford-crypto-sha256-iterative;65;63;64;64;64;64;64;63;62;63 10:27:19 INFO - PROCESS | 26179 | __end_tp_report 10:27:19 INFO - PROCESS | 26179 | __start_cc_report 10:27:19 INFO - PROCESS | 26179 | _x_x_mozilla_cycle_collect,1568 10:27:19 INFO - PROCESS | 26179 | __end_cc_report 10:27:19 INFO - PROCESS | 26179 | __startTimestamp1462642039945__endTimestamp 10:27:19 INFO - PROCESS | 26179 | 10:27:19 INFO - PROCESS | 26179 | ------- Summary: start ------- 10:27:19 INFO - PROCESS | 26179 | Number of tests: 14 10:27:19 INFO - PROCESS | 26179 | 10:27:19 INFO - PROCESS | 26179 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.00 stddev:2.12 (1.9%) stddev-sans-first:2.03 10:27:19 INFO - PROCESS | 26179 | Values: 115.0 107.0 113.0 113.0 112.0 114.0 113.0 113.0 112.0 112.0 10:27:19 INFO - PROCESS | 26179 | 10:27:19 INFO - PROCESS | 26179 | [#1] audio-beat-detection Cycles:10 Average:148.70 Median:155.00 stddev:22.26 (14.4%) stddev-sans-first:23.09 10:27:19 INFO - PROCESS | 26179 | Values: 162.0 123.0 154.0 183.0 127.0 147.0 156.0 125.0 180.0 130.0 10:27:19 INFO - PROCESS | 26179 | 10:27:19 INFO - PROCESS | 26179 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 10:27:19 INFO - PROCESS | 26179 | Values: 160.0 160.0 160.0 162.0 161.0 160.0 160.0 162.0 161.0 161.0 10:27:19 INFO - PROCESS | 26179 | 10:27:19 INFO - PROCESS | 26179 | [#3] audio-fft Cycles:10 Average:85.90 Median:76.00 stddev:22.52 (29.6%) stddev-sans-first:23.47 10:27:19 INFO - PROCESS | 26179 | Values: 74.0 74.0 76.0 126.0 76.0 77.0 76.0 73.0 131.0 76.0 10:27:19 INFO - PROCESS | 26179 | 10:27:19 INFO - PROCESS | 26179 | [#4] audio-oscillator Cycles:10 Average:100.00 Median:91.00 stddev:13.81 (15.2%) stddev-sans-first:14.34 10:27:19 INFO - PROCESS | 26179 | Values: 92.0 91.0 120.0 91.0 92.0 92.0 120.0 91.0 91.0 120.0 10:27:19 INFO - PROCESS | 26179 | 10:27:19 INFO - PROCESS | 26179 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:27:19 INFO - PROCESS | 26179 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 10:27:19 INFO - PROCESS | 26179 | 10:27:19 INFO - PROCESS | 26179 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 10:27:19 INFO - PROCESS | 26179 | Values: 147.0 147.0 145.0 146.0 146.0 146.0 146.0 145.0 146.0 144.0 10:27:19 INFO - PROCESS | 26179 | 10:27:19 INFO - PROCESS | 26179 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.94 (1.0%) stddev-sans-first:0.93 10:27:19 INFO - PROCESS | 26179 | Values: 94.0 95.0 97.0 96.0 94.0 95.0 95.0 94.0 95.0 95.0 10:27:19 INFO - PROCESS | 26179 | 10:27:19 INFO - PROCESS | 26179 | [#8] json-parse-financial Cycles:10 Average:58.80 Median:57.50 stddev:7.28 (12.7%) stddev-sans-first:7.66 10:27:19 INFO - PROCESS | 26179 | Values: 56.0 58.0 58.0 59.0 57.0 57.0 56.0 79.0 54.0 54.0 10:27:19 INFO - PROCESS | 26179 | 10:27:19 INFO - PROCESS | 26179 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:59.00 stddev:0.63 (1.1%) stddev-sans-first:0.60 10:27:19 INFO - PROCESS | 26179 | Values: 58.0 59.0 58.0 58.0 60.0 59.0 59.0 59.0 59.0 59.0 10:27:19 INFO - PROCESS | 26179 | 10:27:19 INFO - PROCESS | 26179 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:80.50 stddev:2.30 (2.9%) stddev-sans-first:2.30 10:27:19 INFO - PROCESS | 26179 | Values: 78.0 78.0 79.0 78.0 79.0 81.0 81.0 80.0 84.0 84.0 10:27:19 INFO - PROCESS | 26179 | 10:27:19 INFO - PROCESS | 26179 | [#11] stanford-crypto-ccm Cycles:10 Average:135.20 Median:126.50 stddev:27.26 (21.5%) stddev-sans-first:28.55 10:27:19 INFO - PROCESS | 26179 | Values: 123.0 133.0 124.0 125.0 124.0 134.0 126.0 124.0 212.0 127.0 10:27:19 INFO - PROCESS | 26179 | 10:27:19 INFO - PROCESS | 26179 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.20 Median:168.50 stddev:2.94 (1.7%) stddev-sans-first:3.04 10:27:19 INFO - PROCESS | 26179 | Values: 169.0 165.0 171.0 168.0 163.0 166.0 167.0 163.0 169.0 171.0 10:27:19 INFO - PROCESS | 26179 | 10:27:19 INFO - PROCESS | 26179 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:64.00 stddev:0.84 (1.3%) stddev-sans-first:0.73 10:27:19 INFO - PROCESS | 26179 | Values: 65.0 63.0 64.0 64.0 64.0 64.0 64.0 63.0 62.0 63.0 10:27:19 INFO - PROCESS | 26179 | -------- Summary: end -------- 10:27:19 INFO - PROCESS | 26179 | 10:27:20 INFO - TEST-INFO | 26179: exit 0 10:27:20 INFO - TEST-OK | kraken | took 61128ms 10:27:20 INFO - SUITE-END | took 1173s 10:27:21 INFO - Completed test suite (00:19:33) 10:27:21 INFO - javascript benchmark 10:27:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3058.2965917838897, 3091.829949352786, 3112.5331200319947, 3124.23456253218, 3154.668759780223, 5121.334226550548, 5181.559567436763, 5241.921371179431, 5247.895042099156, 5252.080885844976, 5201.141811601091, 5240.135377662681, 5252.238425428311, 5273.209018647205, 5273.9736301318535, 4701.482836887948, 4739.620830333565, 4869.220924652056, 4879.780409881564, 4907.779149938261, 4590.724556526619, 4877.685260626767, 4908.950910490903, 4909.68087074339, 4910.386201724785, 4740.857774266778, 4744.240921452569, 4787.473377928425, 4795.808167673289, 4814.855554333376, 4815.49437309081, 4815.831445899376, 4817.349657796188, 4820.831270905502, 4850.369451971221, 4649.0, 4716.38686970695, 4761.880952976203, 4795.017021510582, 4834.613230941552, 5230.895382092375, 5238.423773384925, 5252.973735131338, 5263.289455923439, 5267.499587539178, 5621.494065534122, 5664.0, 5670.149477578396, 5674.0, 5675.318961724578, 5505.559555235572, 5571.749271282802, 5605.607607467479, 5619.466150715675, 5683.403242659544, 5250.894982100336, 5328.600354973315, 5328.786848526054, 5333.759980800874, 5336.786528538853, 5746.683932383676, 5759.827205183851, 5803.709814509258, 5814.895169917702, 5818.069108942634, 5301.125314323171, 5350.892982140335, 5379.6234263601955, 5391.56867450603, 5507.366652834895, 5526.806561770319, 5528.55771538276, 5530.474604912527, 5532.114861622121, 5574.442555744393, 5506.972465137648, 5513.5037846594, 5515.227868098469, 5518.53092487135, 5518.91721624176, 5542.0301447247375, 5591.496765291062, 5611.803586874522, 5641.294838145232, 5641.746121424464, 4309.741415515016, 4315.136972605492, 4317.935230971538, 4320.330348795942, 4358.76026818528, 3761.887143385703, 3810.9809450952566, 3868.8065596720053, 3887.086534664352, 3896.785676787747, 5350.732463376816, 5368.677879327252, 5387.8114266001285, 5390.0836857734275, 5443.700596467233, 5671.6597004179885, 5680.233168522197, 5682.715864206773, 5683.573731970118, 5688.601797874192, 5233.0, 5310.336207974004, 5335.253064570963, 5367.033933891937, 5436.809711660073, 4866.367372241657, 4872.756362181876, 4873.707577545359, 4890.779914903838, 4895.0, 5824.621399609012, 5862.267216597926, 5865.794697185578, 5874.030784920526, 5915.911261331084, 5477.726113694379, 5485.067538518381, 5548.167774833807, 5666.575006874501, 5673.489385955284, 5694.373618901835, 5699.316082070178, 5701.828945131652, 5704.3725190228215, 5738.081906894877, 5433.673979561081, 5441.945580544144, 5443.428440013741, 5445.373782014961, 5445.482679145475, 5529.889402211853, 5552.194931734956, 5552.69460179694, 5590.385057643574, 5596.552275817843, 5482.424345443671, 5483.287172667528, 5485.61600687948, 5489.698066606375, 5496.148097044965, 5422.267993820784, 5439.864003399946, 5469.0, 5473.917891231715, 5526.17107433872, 5265.578753699771, 5415.4313797050745, 5452.0731475648445, 5469.671819690831, 5493.340799104133, 5602.635828671123, 5617.606767526398, 5660.858478537904, 5665.971670141623, 5667.659940403589, 5240.947590524046, 5441.129419292894, 5446.183072539151, 5450.618456707993, 5515.365732940763], "value": 5183.041925578638, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.615885436185, 628.6950828848005, 631.9810405687828, 638.4477427025621, 650.3139188156493, 43376.0, 44904.32643510346, 44962.775186124105, 44987.0, 49079.0, 44792.77603611985, 45183.0, 45194.0, 45338.7733061335, 45367.0, 8793.692220772258, 8973.371863969525, 8977.551122443885, 8982.640694372218, 8984.910150898506, 8904.777380565472, 8926.062763409846, 8993.415427997159, 9002.594883230271, 9007.414518056337, 9049.276057915384, 9088.091190880925, 9094.49980251086, 9102.317326200528, 9104.635814567442, 8975.102489751005, 9015.098490150933, 9020.323475739313, 9021.954890225572, 9023.278137748965, 8844.071372505923, 8972.327075469366, 8976.371653984224, 8977.32670049749, 8988.191062804379, 41425.585744142474, 41949.1610167798, 41984.370234446505, 42029.15941681149, 42066.789666051474, 3177.614653382724, 3208.8235147066903, 3314.6022477302636, 3325.8004519728893, 3551.5383000210068, 31360.21599460009, 31743.0, 31759.52360714591, 32106.839465802754, 33205.50191747126, 4311.892202694927, 4319.416878721395, 4323.632491238249, 4411.911761764747, 4415.977920110411, 303726.4068398308, 304239.0, 304398.0, 304944.0, 305193.0, 59344.10983835246, 60040.69979650074, 60169.69915150396, 60257.39742602606, 60324.0, 36776.816115919246, 37836.054098647204, 37868.8106559471, 39984.20031599352, 40055.39916901249, 17604.559886002953, 17641.206145723474, 17657.117144142998, 17732.55668608295, 17783.822161778477, 13585.45658173662, 13678.863211367958, 13707.657308567366, 13713.382897769625, 13713.520026799015, 19799.40601781949, 19944.20223191085, 20033.198672053248, 20081.0, 20088.39734807958, 7317.914049735489, 7336.303051210127, 7412.888806667905, 7437.442191835526, 7497.737579184703, 1022.2180032275315, 1100.2848148703247, 1112.6495154026618, 1208.3656080557778, 1210.9283284293288, 31481.0, 32048.0, 32165.35669286601, 32260.677393226237, 32603.347933041205, 1141.2809929744208, 1162.2445410483253, 1189.131933688395, 1218.8476440444945, 1230.7169351049308, 17170.742438863428, 17338.479845604652, 17387.478375648498, 17442.215100320514, 17472.825271747373, 429618.0, 431506.0, 433216.0, 433404.0, 434046.0, 56504.15243771347, 57808.71095644495, 57839.42160578424, 57851.421485785446, 57860.0, 1321.1214542329244, 1381.9861801382058, 1422.7225690990365, 1428.4786053090547, 1436.9640758981318, 31618.209544761565, 33195.83402082974, 33224.16939576433, 33318.66681333253, 33338.66661333355, 50925.49074509207, 51161.23258151205, 51572.0, 51586.74206629093, 51669.7416512915, 346777.0, 348650.0, 348838.0, 348946.0, 349039.0, 25598.23205303844, 28072.43855122927, 28482.287942801595, 29125.41749165047, 29312.387818670177, 45344.773276133405, 45451.77274113608, 45872.54127458682, 46423.76788116038, 46797.766011169726, 38850.41724374193, 39039.80480097581, 39278.6072139275, 39314.331273669755, 40366.59633403629, 38834.80582597069, 39518.40722389109, 40524.0, 40816.0, 41318.0, 40442.59557404388, 40910.59089409068, 41231.0, 41245.0, 41366.0, 33911.15222119368, 35433.46849797307, 35613.64386356103, 36161.095972600895, 36603.08492287714, 27415.0, 27501.587476188273, 27660.0, 27894.44211115807, 27908.720912790614], "value": 19790.406617000823, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.68915934730256, 410.2840543252025, 410.3741793764511, 411.79410294852573, 421.56789290976747, 13014.414351354188, 17646.294148234054, 19356.3225287115, 19454.0, 19486.707699384504, 14419.567412977602, 18770.43688689338, 18799.530011749714, 19377.90311048446, 19750.70373944392, 5594.748236329375, 5763.5101016413655, 5770.336411312711, 5773.595848290622, 5801.44886235809, 5701.657900525982, 5732.541396688255, 5751.079827227644, 5753.5684823638185, 5755.107958266475, 4184.351425529033, 5962.8807423851495, 6268.467180289681, 6283.717232724515, 6440.420362167404, 6126.724297406583, 6375.585586936858, 6386.712597933104, 6407.327230640785, 6423.036544518313, 5684.630499017592, 5703.942960570383, 5724.5992780505385, 5729.627574207663, 5731.512821410185, 21929.671054934188, 22452.32643020712, 22979.195728149603, 23338.0, 23341.299761007198, 2335.1476711000532, 2352.494213744036, 2384.618461046224, 2438.0979037755965, 2687.032668239432, 9750.512474376324, 10317.380957142595, 10337.844932326021, 13899.305034748222, 14800.037997530126, 1975.4172519106899, 2037.1036743832667, 2081.2195426714984, 2088.7806780288156, 2098.1187901081585, 68502.21034491381, 84824.0, 85092.0, 86585.56707216424, 87086.5645671774, 10692.625758098584, 10820.350778953289, 10837.078848297826, 10899.509522071527, 11086.778264434828, 14863.628409289855, 14869.776953345709, 14925.328360223815, 14934.701305974037, 14966.551003469913, 8147.714829980922, 8393.412461127784, 8425.36809739272, 8570.48577085377, 8584.91415085841, 8243.876341854877, 8249.010118785784, 8263.586820658944, 8385.916140838635, 8456.8731469028, 4108.239975604522, 4506.6169375602785, 4531.84138555149, 4558.475775285885, 4618.376519169869, 1799.997068408672, 1828.1208883416364, 1964.1161477335256, 1992.7807941126464, 2028.9594208115755, 902.8961669407971, 1033.751899544104, 1055.3193190392153, 1064.0742553977934, 1071.5231721883688, 18396.61519863716, 19087.331943381916, 19275.22899084049, 19382.903085484766, 19409.61180776405, 1025.5282570017876, 1034.8240799064176, 1042.8592140061146, 1054.135608800776, 1069.337011053152, 10534.420606866543, 10915.072218861485, 10923.890761092287, 10929.125669946385, 10940.0, 416076.0, 417736.0, 423613.0, 438583.0, 441392.0, 89513.0, 91108.0, 95463.52268238753, 95507.52246238863, 95849.0, 1028.4446398944485, 1033.540074666781, 1039.5218199628255, 1053.1311667874033, 1060.7189094890014, 16462.588435289214, 16828.242729077465, 16865.831341686917, 17044.0, 17337.133143343035, 37206.81396593, 38244.0, 38558.80720596379, 39276.803615981735, 39793.0, 49510.75244623754, 51755.48244517507, 54415.455845441036, 54625.45374546204, 54752.726236368566, 8310.875336870073, 8844.955775221082, 8865.423747456394, 8881.822363552821, 9132.0, 12496.500139994298, 13097.672558186121, 13277.734445311233, 13330.333483325989, 13428.530001449903, 11299.661010169708, 11440.713982150513, 11444.94277528607, 11492.080633549464, 11935.343556104497, 11327.0, 11492.712682183012, 11531.077513799044, 11674.70813229676, 11851.703707407383, 11599.6520104397, 11730.354830484406, 11747.823782643096, 11813.232139910879, 11845.940770296093, 7545.320921117126, 7851.450398472052, 8067.959660201662, 8180.304674102768, 8494.235518803338, 11038.227324087236, 11204.495797689287, 11537.826932596186, 11675.299482031105, 12168.0], "value": 9223.781507421001, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1384.0, 1542.6266534375047, 1543.1559286652448, 1747.0740507531004, 1885.0763126068223, 7981.84036319274, 8346.0, 8347.540885251308, 8360.247577718004, 8544.316454683625, 7871.606419679008, 8125.228103330189, 8284.668613255477, 8307.50154990701, 8327.16728327167, 1953.9511512212166, 1997.3308941504613, 2000.3698834867043, 2209.1826024370966, 2251.4934139818574, 2258.322503249027, 2334.043042352636, 2340.216027630746, 2346.1788374069024, 2347.5539647467012, 2220.3449982255274, 2236.39617303328, 2288.8855557222155, 2307.5961706701346, 2310.156792770635, 1934.5260411199206, 2160.589487997291, 2217.301550011749, 2251.1220623956588, 2251.628481300592, 2313.849599776026, 2346.4016675747575, 2348.6594443805725, 2349.9060037598474, 2352.8588284702973, 8256.793580160544, 8288.709895153701, 8297.626606802709, 8304.045034820952, 8314.501129932223, 4819.566239038503, 4967.279744437036, 4967.552920237196, 4984.950150498485, 5003.949170674163, 2927.53159494482, 3115.4236466253587, 3142.245860993368, 3144.528320751883, 3146.5122905949383, 2021.3127536637467, 2062.0823733438624, 2077.7714451410334, 2126.1282874021576, 2169.2190811308074, 11662.0, 11847.0, 11883.168178227528, 11891.0, 11905.107116966175, 4358.0412309291905, 4406.074724307867, 4478.888027799331, 4489.371487991683, 4546.340780586796, 10130.138938190335, 10180.083792458714, 10213.234007449471, 10213.489325533694, 10216.387016779017, 5080.441151473335, 5114.590832733373, 5157.097507936096, 5164.793408263702, 5168.508991645787, 4160.854370097092, 4581.2440947243995, 4700.764961751899, 4720.480747117815, 4722.386089808303, 3821.541415030214, 3916.686665066845, 3917.1578110706337, 3919.0790164311366, 4024.7182697210915, 1230.5200971621075, 1256.824044633752, 1258.4714419943462, 1270.4664041102758, 1284.101129209557, 834.1950018232435, 923.3721069672553, 931.1061381074245, 941.9387739796891, 952.8665986761858, 5780.0, 5835.44563266489, 5933.0, 5995.520358371407, 6218.067289906459, 987.2842189412762, 992.1814503035025, 995.3977843404781, 1017.6946915925192, 1029.264076185531, 3951.1702542465828, 4021.8391264349098, 4050.210209009215, 4061.248668996245, 4160.147169830238, 10070.295079344376, 10641.467926603638, 10753.301035432673, 10768.892311076946, 10796.568137274578, 10443.373397596168, 10596.523156457824, 10601.363918164934, 10650.520726567323, 10661.307015043998, 8030.959845200853, 8034.317083048007, 8070.757877263692, 8112.310453611509, 8160.061592916772, 5814.9070360374935, 5833.125031245348, 5859.736311865891, 5940.970295148497, 5970.552208584287, 9652.75868103303, 9719.222462203148, 9803.901960980298, 9822.017798220406, 9917.900820991987, 9986.0, 10004.449755263531, 10104.494775261355, 10162.796744065225, 10173.440460774433, 6680.4989625779235, 6883.518153729391, 6997.47518936092, 7029.086218791729, 7151.749688760869, 7709.383249339927, 7897.328727058035, 7981.361491080584, 8002.159773223961, 8003.879941800994, 7370.336669699753, 7371.631418429164, 7397.667104980181, 7473.663685134074, 7684.346830519468, 7377.741779037922, 7394.33450989392, 7409.296116868889, 7471.252874712485, 7535.321821036133, 6951.409130223988, 7000.684969176501, 7009.369156775914, 7046.929530704832, 7048.048513450619, 4913.926291105565, 5084.745762711776, 5087.23691446286, 5101.234814777813, 5104.719240441663, 5057.8735531612, 5153.0, 5175.844724658266, 5237.476252374732, 5346.1980702893325], "value": 4590.657278000462, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.39963766850155, 334.2596149528793, 337.7348781206753, 342.85771404866983, 344.03841263668045, 5058.418281897583, 5143.922841157386, 5224.824414506739, 5270.81552145675, 5289.629725919182, 5156.407013193484, 5196.662216955895, 5207.427183009866, 5225.268462415265, 5258.973705131469, 4108.81510332035, 4113.197926404352, 4129.398478958252, 4140.5859414058505, 4159.792010399483, 3901.356276214421, 3902.804859757001, 4104.4664193654935, 4133.81397837098, 4138.937915931264, 3992.2015596880597, 4032.4757781488365, 4066.7356621819486, 4069.409935559342, 4078.796060196993, 4018.2566225248274, 4038.0, 4059.7158198926086, 4060.4924384451942, 4099.733517321394, 3562.608113107556, 3607.963920360789, 3622.963770362289, 3637.672609465161, 3640.908977275563, 4937.604991600663, 5004.474530174352, 5026.070177017264, 5038.39539255288, 5057.519535644108, 4602.677812553123, 4641.512641172696, 4648.2562789953445, 4650.837220697259, 4673.556012178838, 5172.586193104543, 5381.946180538183, 5385.35375754908, 5391.946080539184, 5424.647397919122, 4000.159966407058, 4002.679785617144, 4009.0, 4017.4777278953843, 4020.336644453662, 5675.148727690838, 5688.488036076732, 5703.458171473703, 5716.1711551825165, 5736.024875771129, 4077.0215148364177, 4094.959050409517, 4116.217918595457, 4119.299719047769, 4123.134141830189, 3878.5733569307354, 4091.608852989938, 4096.3409819023345, 4097.364908439137, 4111.732737372061, 4622.19111655459, 4645.210314246586, 4649.6051184644475, 4651.953480465152, 4662.6969246999515, 5461.754221060062, 5485.561155107582, 5486.683196032924, 5487.341519017664, 5531.529819965268, 1275.6095855517344, 1293.2886912198253, 1349.7368013237324, 1364.3519328318969, 1374.8900087992936, 930.5393830054167, 930.9441433514011, 932.305432452827, 940.5109343141528, 948.1466679987929, 4979.601631869442, 5109.441620305843, 5138.768755406016, 5167.243137333249, 5170.302009228706, 5373.361124856956, 5373.650712703662, 5386.542143917733, 5390.434004429557, 5442.319710036246, 4982.377202849644, 5095.643304968691, 5099.949000509948, 5104.881474188244, 5125.4874512549195, 2801.537746271883, 2806.6772321183325, 2816.7042460541757, 2852.1728698677152, 2895.2038189498057, 5414.566834653218, 5466.9179962300595, 5507.256520369779, 5535.58483113768, 5562.833115006556, 5292.206169074592, 5379.193121031798, 5416.593755468356, 5463.262459567907, 5525.309336332958, 5593.664380137124, 5614.24207731951, 5619.662820230717, 5624.57815663835, 5637.43625637433, 5248.824461200918, 5418.4852439019805, 5431.2667789847865, 5437.945620543744, 5451.100568406168, 5263.2104884483115, 5293.523582877406, 5306.867328316823, 5381.73091345439, 5391.86520336979, 5374.785008599612, 5450.890982180414, 5485.50630443262, 5536.778528858962, 5542.889142217214, 3783.9387767208987, 3881.777240169338, 3896.2402331545077, 3898.629630185128, 3904.590018048064, 5294.1794021925125, 5315.734213289397, 5331.840044798662, 5345.9842629900195, 5370.865728356823, 5182.97408512955, 5189.896202076013, 5246.0, 5249.107651699144, 5261.631685781958, 5108.7445627717725, 5162.328897243485, 5175.896482070413, 5193.974030129825, 5553.805616803393, 5360.571154307724, 5406.83779486616, 5475.523042867728, 5477.370102438271, 5494.423085575957, 5469.2616496772425, 5479.589030822784, 5494.955958367897, 5497.890042199214, 5498.725063746877, 5210.53105220532, 5380.811671591476, 5386.8383948481605, 5401.6218864679095, 5438.592105592017], "value": 4113.608294711444, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [802.9116797152312, 835.9080501144877, 838.5262326785365, 841.5707988925653, 852.4586887326548, 14504.782428263585, 14945.626359341008, 15092.094474331549, 15107.244637768095, 15140.84859151408, 12763.23420594765, 13686.657833554165, 13694.246816425093, 14131.717365652681, 14222.573322800306, 688.8002479281015, 700.086387264622, 700.2017699822206, 701.2811867835459, 706.6749295324157, 852.4160949749411, 854.4488804720951, 854.8418542569644, 855.0210009539074, 855.3969451536652, 894.3515950935553, 895.243519226256, 895.8924929008496, 896.8654701794718, 898.6405437824857, 884.1114679746878, 892.6117139044471, 894.5035505294592, 894.9149830766066, 895.2569367425021, 647.7506160128337, 648.4747354642755, 649.3052433895733, 649.5355820588255, 649.574528683713, 13308.933455332759, 13411.262380569065, 13446.12600180995, 13479.460821567125, 13542.93228533861, 12434.875651243463, 12456.501739930392, 12462.189957652814, 12569.308688022154, 12636.178648387826, 10130.594776208944, 10158.238132140044, 10175.084242418145, 10175.440350780704, 10398.0, 3795.734298599099, 3837.4052021936645, 3858.0, 3874.612538746131, 3921.8823435296986, 46223.76888115538, 55967.160492592644, 58619.41380586225, 58736.41263587352, 58757.0, 8645.394822362374, 10913.23607347494, 11022.283551569282, 11110.444477776078, 12183.756324873453, 19882.801171988383, 20061.29785457502, 20079.096440659912, 20138.69791953122, 20230.393088207376, 8661.003984541732, 8697.0, 8701.955765308203, 8763.123687631185, 9277.257819374434, 4296.76367799774, 4387.934180987288, 4679.251319788817, 4915.4347250065985, 5047.318611987408, 3325.48454989477, 3421.26442814796, 3430.1939044324563, 3436.5017072524342, 3440.0539851541025, 647.8671872266174, 647.9125318082093, 649.9447546958467, 654.1920727901038, 661.3419647450817, 709.7267303931734, 730.6200775596766, 741.403170447784, 746.6266866566716, 776.4564804636777, 9845.261605379483, 10206.897931020743, 10258.12805911491, 10354.11989980845, 11033.779324413466, 703.395080231001, 740.4076738609199, 755.712829124929, 762.8512440074243, 763.2253262938123, 4931.211006238985, 4983.6760610560195, 4988.825391111366, 4998.225275082295, 5027.874303142377, 61935.38064619296, 62149.37850621526, 63141.36858631447, 63560.682196589645, 65112.34887651063, 43613.345799813025, 47765.52234477611, 49332.26001609979, 53006.204906926425, 56153.38897129671, 56382.1542676852, 56667.433325666214, 57075.714621426625, 57118.143227851615, 57184.71407642935, 8759.430637008574, 9731.902680973382, 9890.0, 9894.307398482037, 10012.549435275285, 34799.30401391907, 35405.0, 35506.11234719153, 35602.64397356097, 36483.63516364909, 46193.76903115463, 48484.272735908286, 48908.0, 49035.0, 49071.50928490669, 12142.453589588313, 12250.816237756619, 12311.876881231074, 12414.937925310316, 12786.68033299175, 13472.46110155622, 13806.723865522432, 13944.51194208198, 14491.637709057359, 14593.270336482921, 13113.147645403018, 13285.601431957057, 13690.0, 13706.383212755649, 14016.0, 13081.084324097223, 13348.199108053548, 13361.66595835112, 13954.511592094228, 14019.579412617637, 12934.482620695067, 12989.935050325066, 13201.405936732677, 13840.446382145004, 13873.72252554923, 10623.628173013907, 10684.519196636325, 10805.891941080488, 11020.889791102307, 11046.779064418506, 11281.943590281997, 11448.370339631067, 11549.609143107959, 11560.364179970182, 11615.419229038684], "value": 6921.293388835683, "unit": "score"}], "name": "dromaeo_css", "value": 7058.515074042193, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 107.0, 113.0, 113.0, 112.0, 114.0, 113.0, 113.0, 112.0, 112.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 123.0, 154.0, 183.0, 127.0, 147.0, 156.0, 125.0, 180.0, 130.0], "value": 148.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 162.0, 161.0, 160.0, 160.0, 162.0, 161.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 126.0, 76.0, 77.0, 76.0, 73.0, 131.0, 76.0], "value": 85.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 120.0, 91.0, 92.0, 92.0, 120.0, 91.0, 91.0, 120.0], "value": 100.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 144.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 97.0, 96.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 58.0, 59.0, 57.0, 57.0, 56.0, 79.0, 54.0, 54.0], "value": 58.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 58.0, 60.0, 59.0, 59.0, 59.0, 59.0, 59.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 79.0, 78.0, 79.0, 81.0, 81.0, 80.0, 84.0, 84.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 133.0, 124.0, 125.0, 124.0, 134.0, 126.0, 124.0, 212.0, 127.0], "value": 135.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 165.0, 171.0, 168.0, 163.0, 166.0, 167.0, 163.0, 169.0, 171.0], "value": 167.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 64.0, 64.0, 64.0, 64.0, 64.0, 63.0, 62.0, 63.0], "value": 63.6, "unit": "score"}], "name": "kraken", "value": 1529.2, "alertThreshold": 2.0}]} 10:27:21 INFO - Return code: 0 10:27:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:27:21 ERROR - # TBPL SUCCESS # 10:27:21 INFO - Running post-action listener: _resource_record_post_action 10:27:21 INFO - ##### 10:27:21 INFO - ##### Finished run-tests step (success) 10:27:21 INFO - ##### 10:27:21 INFO - Running post-run listener: _resource_record_post_run 10:27:22 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 536788992; Read time: 8; Write time: 510268 10:27:22 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244776960; Read time: 0; Write time: 250128 10:27:22 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292012032; Read time: 8; Write time: 260140 10:27:22 INFO - Running post-run listener: _upload_blobber_files 10:27:22 INFO - Blob upload gear active. 10:27:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:27:22 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 10:27:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:27:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:27:22 INFO - (blobuploader) - INFO - Open directory for files ... 10:27:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:27:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:27:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:27:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:27:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:27:23 INFO - (blobuploader) - INFO - Done attempting. 10:27:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:27:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:27:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:27:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:27:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:27:24 INFO - (blobuploader) - INFO - Done attempting. 10:27:24 INFO - (blobuploader) - INFO - Iteration through files over. 10:27:24 INFO - Return code: 0 10:27:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:27:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:27:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03aa44f22beb56067357a9cedc3e62e726929774274fbd1576d66249afa96332a46df6db0da9c616b5de742d6b96743f9fd0cef3dc666ae0e86d4f43f8db9db5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6419fe7c9e5484865df5d96b99c58368de35914c54e634cf6dd84fc701774445191852076ece4299252f7f322e051e6a435f9729b82d4fa7b6da43a7d1c54575"} 10:27:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:27:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:27:24 INFO - Contents: 10:27:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03aa44f22beb56067357a9cedc3e62e726929774274fbd1576d66249afa96332a46df6db0da9c616b5de742d6b96743f9fd0cef3dc666ae0e86d4f43f8db9db5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6419fe7c9e5484865df5d96b99c58368de35914c54e634cf6dd84fc701774445191852076ece4299252f7f322e051e6a435f9729b82d4fa7b6da43a7d1c54575"} 10:27:24 INFO - Running post-run listener: copy_logs_to_upload_dir 10:27:24 INFO - Copying logs to upload dir... 10:27:24 INFO - mkdir: /builds/slave/test/build/upload/logs 10:27:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.086533 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-07 10:27:23.697075) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-07 10:27:23.700062) ========= 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=652eb03db935cfc1c15ebda0000001ad-1462630536.737093-78274672 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03aa44f22beb56067357a9cedc3e62e726929774274fbd1576d66249afa96332a46df6db0da9c616b5de742d6b96743f9fd0cef3dc666ae0e86d4f43f8db9db5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6419fe7c9e5484865df5d96b99c58368de35914c54e634cf6dd84fc701774445191852076ece4299252f7f322e051e6a435f9729b82d4fa7b6da43a7d1c54575"} build_url:https://queue.taskcluster.net/v1/task/f18FJy7JTqOsLE2b1bDNbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011252 build_url: 'https://queue.taskcluster.net/v1/task/f18FJy7JTqOsLE2b1bDNbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03aa44f22beb56067357a9cedc3e62e726929774274fbd1576d66249afa96332a46df6db0da9c616b5de742d6b96743f9fd0cef3dc666ae0e86d4f43f8db9db5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6419fe7c9e5484865df5d96b99c58368de35914c54e634cf6dd84fc701774445191852076ece4299252f7f322e051e6a435f9729b82d4fa7b6da43a7d1c54575"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-07 10:27:23.724180) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 10:27:23.724462) ========= 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=652eb03db935cfc1c15ebda0000001ad-1462630536.737093-78274672 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004408 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 10:27:23.807623) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-07 10:27:23.807945) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-07 10:27:23.808275) ========= ========= Total master_lag: 0.19 =========