builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-008 starttime: 1461615752.84 results: success (0) buildid: 20160425103042 builduid: c20892775a3b488796cfc1fa5f391749 revision: 2045bc8c9e90a7ca0b8c6447ddecd812a71b29e1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 13:22:32.841969) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 13:22:32.842620) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 13:22:32.843014) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 13:22:32.855835) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:22:32.856226) ========= 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=32c5991c409366f7fec8a718000001d2-1461615687.559999-824256985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-25 13:22:32-- 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% 38.0M=0s 2016-04-25 13:22:33 (38.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081629 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:22:32.949847) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:22:32.950335) ========= 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=32c5991c409366f7fec8a718000001d2-1461615687.559999-824256985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019935 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:22:33.000568) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 13:22:33.001085) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2045bc8c9e90a7ca0b8c6447ddecd812a71b29e1 --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 2045bc8c9e90a7ca0b8c6447ddecd812a71b29e1 --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=32c5991c409366f7fec8a718000001d2-1461615687.559999-824256985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-25 13:22:33,141 truncating revision to first 12 chars 2016-04-25 13:22:33,141 Setting DEBUG logging. 2016-04-25 13:22:33,141 attempt 1/10 2016-04-25 13:22:33,141 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2045bc8c9e90?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 13:22:33,417 unpacking tar archive at: mozilla-central-2045bc8c9e90/testing/mozharness/ program finished with exit code 0 elapsedTime=0.571501 ========= master_lag: 0.68 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 13:22:34.248315) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 13:22:34.248711) ========= script_repo_revision: 2045bc8c9e90a7ca0b8c6447ddecd812a71b29e1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 13:22:34.249208) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 13:22:34.249530) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 13:22:34.267711) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-04-25 13:22:34.268163) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=32c5991c409366f7fec8a718000001d2-1461615687.559999-824256985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:22:34 INFO - MultiFileLogger online at 20160425 13:22:34 in /builds/slave/test 13:22:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 13:22:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:22:34 INFO - {'append_to_log': False, 13:22:34 INFO - 'base_work_dir': '/builds/slave/test', 13:22:34 INFO - 'blob_upload_branch': 'Firefox', 13:22:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:22:34 INFO - 'branch': 'Firefox', 13:22:34 INFO - 'buildbot_json_path': 'buildprops.json', 13:22:34 INFO - 'config_files': ('talos/linux_config.py',), 13:22:34 INFO - 'default_actions': ('clobber', 13:22:34 INFO - 'read-buildbot-config', 13:22:34 INFO - 'download-and-extract', 13:22:34 INFO - 'populate-webroot', 13:22:34 INFO - 'create-virtualenv', 13:22:34 INFO - 'install', 13:22:34 INFO - 'run-tests'), 13:22:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:22:34 INFO - 'download_minidump_stackwalk': True, 13:22:34 INFO - 'download_symbols': 'ondemand', 13:22:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:22:34 INFO - 'tooltool.py': '/tools/tooltool.py', 13:22:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:22:34 INFO - '/tools/misc-python/virtualenv.py')}, 13:22:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:22:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:22:34 INFO - 'installer_path': 'installer.exe', 13:22:34 INFO - 'log_level': 'info', 13:22:34 INFO - 'log_name': 'talos', 13:22:34 INFO - 'log_to_console': True, 13:22:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:22:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:22:34 INFO - 'opt_config_files': (), 13:22:34 INFO - 'pip_index': False, 13:22:34 INFO - 'sps_profile': False, 13:22:34 INFO - 'sps_profile_interval': 0, 13:22:34 INFO - 'suite': 'dromaeojs-e10s', 13:22:34 INFO - 'system_bits': '32', 13:22:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:22:34 INFO - 'title': 'talos-linux64-ix-008', 13:22:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:22:34 INFO - 'use_talos_json': True, 13:22:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:22:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:22:34 INFO - 'work_dir': 'build'} 13:22:34 INFO - ##### 13:22:34 INFO - ##### Running clobber step. 13:22:34 INFO - ##### 13:22:34 INFO - Running pre-action listener: _resource_record_pre_action 13:22:34 INFO - Running main action method: clobber 13:22:34 INFO - rmtree: /builds/slave/test/build 13:22:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:22:35 INFO - Running post-action listener: _resource_record_post_action 13:22:35 INFO - ##### 13:22:35 INFO - ##### Running read-buildbot-config step. 13:22:35 INFO - ##### 13:22:35 INFO - Running pre-action listener: _resource_record_pre_action 13:22:35 INFO - Running main action method: read_buildbot_config 13:22:35 INFO - Using buildbot properties: 13:22:35 INFO - { 13:22:35 INFO - "project": "", 13:22:35 INFO - "product": "firefox", 13:22:35 INFO - "script_repo_revision": "production", 13:22:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 13:22:35 INFO - "repository": "", 13:22:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 13:22:35 INFO - "buildid": "20160425103042", 13:22:35 INFO - "pgo_build": "True", 13:22:35 INFO - "basedir": "/builds/slave/test", 13:22:35 INFO - "buildnumber": 4, 13:22:35 INFO - "slavename": "talos-linux64-ix-008", 13:22:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:22:35 INFO - "platform": "ubuntu64_hw", 13:22:35 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 13:22:35 INFO - "branch": "mozilla-central", 13:22:35 INFO - "repo_path": "mozilla-central", 13:22:35 INFO - "revision": "2045bc8c9e90a7ca0b8c6447ddecd812a71b29e1", 13:22:35 INFO - "stage_platform": "linux64-pgo", 13:22:35 INFO - "builduid": "c20892775a3b488796cfc1fa5f391749", 13:22:35 INFO - "slavebuilddir": "test" 13:22:35 INFO - } 13:22:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/RvEmcoRSQRKXtBB_HaBodw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 13:22:35 INFO - Running post-action listener: _resource_record_post_action 13:22:35 INFO - ##### 13:22:35 INFO - ##### Running download-and-extract step. 13:22:35 INFO - ##### 13:22:35 INFO - Running pre-action listener: _resource_record_pre_action 13:22:35 INFO - Running main action method: download_and_extract 13:22:35 INFO - mkdir: /builds/slave/test/build/tests 13:22:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:22:35 INFO - https://queue.taskcluster.net/v1/task/RvEmcoRSQRKXtBB_HaBodw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:22:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RvEmcoRSQRKXtBB_HaBodw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:22:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RvEmcoRSQRKXtBB_HaBodw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:22:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RvEmcoRSQRKXtBB_HaBodw/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 13:22:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RvEmcoRSQRKXtBB_HaBodw/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 13:22:36 INFO - Downloaded 1361 bytes. 13:22:36 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:22:36 INFO - Using the following test package requirements: 13:22:36 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:22:36 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:22:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:22:36 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:22:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:22:36 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:22:36 INFO - u'jsshell-linux-x86_64.zip'], 13:22:36 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:22:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:22:36 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:22:36 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:22:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:22:36 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:22:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:22:36 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:22:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:22:36 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:22:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:22:36 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:22:36 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')]} 13:22:36 INFO - https://queue.taskcluster.net/v1/task/RvEmcoRSQRKXtBB_HaBodw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:22:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RvEmcoRSQRKXtBB_HaBodw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:22:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RvEmcoRSQRKXtBB_HaBodw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:22:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RvEmcoRSQRKXtBB_HaBodw/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 13:22:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RvEmcoRSQRKXtBB_HaBodw/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 13:22:37 INFO - Downloaded 23860712 bytes. 13:22:37 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'] 13:22:37 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 13:22:39 INFO - Return code: 0 13:22:39 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 13:22:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:22:39 INFO - https://queue.taskcluster.net/v1/task/RvEmcoRSQRKXtBB_HaBodw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:22:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RvEmcoRSQRKXtBB_HaBodw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:22:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RvEmcoRSQRKXtBB_HaBodw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:22:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RvEmcoRSQRKXtBB_HaBodw/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 13:22:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RvEmcoRSQRKXtBB_HaBodw/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 13:22:40 INFO - Downloaded 23860712 bytes. 13:22:40 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'] 13:22:40 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 13:22:42 INFO - Return code: 0 13:22: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')]} 13:22:42 INFO - https://queue.taskcluster.net/v1/task/RvEmcoRSQRKXtBB_HaBodw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:22:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RvEmcoRSQRKXtBB_HaBodw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:22:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RvEmcoRSQRKXtBB_HaBodw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:22:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RvEmcoRSQRKXtBB_HaBodw/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 13:22:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RvEmcoRSQRKXtBB_HaBodw/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 13:22:43 INFO - Downloaded 10840145 bytes. 13:22:43 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'] 13:22:43 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 13:22:43 INFO - Return code: 0 13:22:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:22:43 INFO - https://queue.taskcluster.net/v1/task/RvEmcoRSQRKXtBB_HaBodw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:22:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RvEmcoRSQRKXtBB_HaBodw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:22:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RvEmcoRSQRKXtBB_HaBodw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:22:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RvEmcoRSQRKXtBB_HaBodw/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 13:22:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RvEmcoRSQRKXtBB_HaBodw/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 13:22:46 INFO - Downloaded 58339604 bytes. 13:22:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RvEmcoRSQRKXtBB_HaBodw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:22:46 INFO - mkdir: /builds/slave/test/properties 13:22:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:22:46 INFO - Writing to file /builds/slave/test/properties/build_url 13:22:46 INFO - Contents: 13:22:46 INFO - build_url:https://queue.taskcluster.net/v1/task/RvEmcoRSQRKXtBB_HaBodw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:22:47 INFO - Running post-action listener: _resource_record_post_action 13:22:47 INFO - Running post-action listener: set_extra_try_arguments 13:22:47 INFO - ##### 13:22:47 INFO - ##### Running populate-webroot step. 13:22:47 INFO - ##### 13:22:47 INFO - Running pre-action listener: _resource_record_pre_action 13:22:47 INFO - Running main action method: populate_webroot 13:22:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:22:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:22:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:22:47 INFO - '--tppagecycles', 13:22:47 INFO - '7'], 13:22:47 INFO - 'tests': ['tsvgm']}}, 13:22:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:22:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:22:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:22:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:22:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:22:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:22:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:22:47 INFO - 'talos_options': ['--disable-e10s'], 13:22:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:22:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:22:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:22:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:22:47 INFO - 'talos_options': ['--disable-e10s'], 13:22:47 INFO - 'tests': ['damp', 'tps']}, 13:22:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:22:47 INFO - 'tests': ['damp', 'tps']}, 13:22:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:22:47 INFO - 'tests': ['dromaeo_dom']}, 13:22:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:22:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:22:47 INFO - 'tests': ['a11yr', 13:22:47 INFO - 'ts_paint', 13:22:47 INFO - 'tpaint', 13:22:47 INFO - 'sessionrestore', 13:22:47 INFO - 'sessionrestore_no_auto_restore', 13:22:47 INFO - 'tabpaint']}, 13:22:47 INFO - 'other-e10s': {'tests': ['a11yr', 13:22:47 INFO - 'ts_paint', 13:22:47 INFO - 'tpaint', 13:22:47 INFO - 'sessionrestore', 13:22:47 INFO - 'sessionrestore_no_auto_restore', 13:22:47 INFO - 'tabpaint']}, 13:22:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:22:47 INFO - 'ts_paint', 13:22:47 INFO - 'tpaint', 13:22:47 INFO - 'sessionrestore', 13:22:47 INFO - 'sessionrestore_no_auto_restore', 13:22:47 INFO - 'tabpaint']}, 13:22:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:22:47 INFO - 'ts_paint', 13:22:47 INFO - 'tpaint', 13:22:47 INFO - 'sessionrestore', 13:22:47 INFO - 'sessionrestore_no_auto_restore', 13:22:47 INFO - 'tabpaint']}, 13:22:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:22:47 INFO - 'tests': ['a11yr', 13:22:47 INFO - 'ts_paint', 13:22:47 INFO - 'tpaint', 13:22:47 INFO - 'sessionrestore', 13:22:47 INFO - 'sessionrestore_no_auto_restore', 13:22:47 INFO - 'tabpaint']}, 13:22:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:22:47 INFO - 'tests': ['a11yr', 13:22:47 INFO - 'ts_paint', 13:22:47 INFO - 'tpaint', 13:22:47 INFO - 'sessionrestore', 13:22:47 INFO - 'sessionrestore_no_auto_restore', 13:22:47 INFO - 'tabpaint']}, 13:22:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:22:47 INFO - 'tests': ['tsvgx', 13:22:47 INFO - 'tsvgr_opacity', 13:22:47 INFO - 'tart', 13:22:47 INFO - 'tscrollx', 13:22:47 INFO - 'cart']}, 13:22:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:22:47 INFO - 'tsvgr_opacity', 13:22:47 INFO - 'tart', 13:22:47 INFO - 'tscrollx', 13:22:47 INFO - 'cart']}, 13:22:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:22:47 INFO - 'talos_options': ['--disable-e10s'], 13:22:47 INFO - 'tests': ['tp5o']}, 13:22:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:22:47 INFO - 'tests': ['tp5o']}, 13:22:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:22:47 INFO - 'talos_options': ['--disable-e10s', 13:22:47 INFO - '--xperf_path', 13:22:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:22:47 INFO - 'tests': ['tp5n']}, 13:22:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:22:47 INFO - 'talos_options': ['--xperf_path', 13:22:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:22:47 INFO - 'tests': ['tp5n']}}, 13:22:47 INFO - 'talos.zip': {'path': '', 13:22:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:22:47 INFO - Running post-action listener: _resource_record_post_action 13:22:47 INFO - ##### 13:22:47 INFO - ##### Running create-virtualenv step. 13:22:47 INFO - ##### 13:22:47 INFO - Running pre-action listener: _resource_record_pre_action 13:22:47 INFO - Running main action method: create_virtualenv 13:22:47 INFO - Creating virtualenv /builds/slave/test/build/venv 13:22:47 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 13:22:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:22:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:22:47 INFO - Using real prefix '/usr' 13:22:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:22:47 INFO - Installing distribute.............................................................................................................................................................................................done. 13:22:49 INFO - Installing pip.................done. 13:22:49 INFO - Return code: 0 13:22:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:22:49 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')]} 13:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:22:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:49 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')]} 13:22:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:22:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:49 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 0x7f838b093f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27435a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d2410>, '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 0x27d3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d37a0>, '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': '32c5991c409366f7fec8a718000001d2-1461615687.559999-824256985', '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 13:22:49 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 13:22:49 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 13:22:49 INFO - Using env: {'DISPLAY': ':0', 13:22:49 INFO - 'HOME': '/home/cltbld', 13:22:49 INFO - 'LANG': 'en_US.UTF-8', 13:22:49 INFO - 'LANGUAGE': 'en_US:en', 13:22:49 INFO - 'LOGNAME': 'cltbld', 13:22:49 INFO - 'MAIL': '/var/mail/cltbld', 13:22:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:22:49 INFO - 'MOZ_NO_REMOTE': '1', 13:22:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:22:49 INFO - 'NO_EM_RESTART': '1', 13:22:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:22:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:22:49 INFO - 'PWD': '/builds/slave/test', 13:22:49 INFO - 'SHELL': '/bin/bash', 13:22:49 INFO - 'SHLVL': '1', 13:22:49 INFO - 'TERM': 'linux', 13:22:49 INFO - 'TMOUT': '86400', 13:22:49 INFO - 'USER': 'cltbld', 13:22:49 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461615687.559999-824256985', 13:22:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:22:49 INFO - '_': '/tools/buildbot/bin/python'} 13:22:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:22:50 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 13:22:50 INFO - Cleaning up... 13:22:50 INFO - Return code: 0 13:22:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:22:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:22:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:22:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:22:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:50 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 0x7f838b093f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27435a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d2410>, '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 0x27d3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d37a0>, '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': '32c5991c409366f7fec8a718000001d2-1461615687.559999-824256985', '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 13:22:50 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 13:22:50 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 13:22:50 INFO - Using env: {'DISPLAY': ':0', 13:22:50 INFO - 'HOME': '/home/cltbld', 13:22:50 INFO - 'LANG': 'en_US.UTF-8', 13:22:50 INFO - 'LANGUAGE': 'en_US:en', 13:22:50 INFO - 'LOGNAME': 'cltbld', 13:22:50 INFO - 'MAIL': '/var/mail/cltbld', 13:22:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:22:50 INFO - 'MOZ_NO_REMOTE': '1', 13:22:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:22:50 INFO - 'NO_EM_RESTART': '1', 13:22:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:22:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:22:50 INFO - 'PWD': '/builds/slave/test', 13:22:50 INFO - 'SHELL': '/bin/bash', 13:22:50 INFO - 'SHLVL': '1', 13:22:50 INFO - 'TERM': 'linux', 13:22:50 INFO - 'TMOUT': '86400', 13:22:50 INFO - 'USER': 'cltbld', 13:22:50 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461615687.559999-824256985', 13:22:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:22:50 INFO - '_': '/tools/buildbot/bin/python'} 13:22:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:22:50 INFO - Downloading/unpacking psutil>=0.7.1 13:22:50 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 13:22:50 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 13:22:50 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 13:22:50 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 13:22:50 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 13:22:50 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 13:22:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:22:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:22:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:22:52 INFO - Installing collected packages: psutil 13:22:52 INFO - Running setup.py install for psutil 13:22:52 INFO - building 'psutil._psutil_linux' extension 13:22:52 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 13:22:52 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 13:22:52 INFO - building 'psutil._psutil_posix' extension 13:22:52 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 13:22:52 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 13:22:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:22:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:22:52 INFO - Successfully installed psutil 13:22:52 INFO - Cleaning up... 13:22:52 INFO - Return code: 0 13:22:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:22:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:22:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:22:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:22:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:52 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 0x7f838b093f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27435a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d2410>, '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 0x27d3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d37a0>, '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': '32c5991c409366f7fec8a718000001d2-1461615687.559999-824256985', '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 13:22:52 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 13:22:52 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 13:22:52 INFO - Using env: {'DISPLAY': ':0', 13:22:52 INFO - 'HOME': '/home/cltbld', 13:22:52 INFO - 'LANG': 'en_US.UTF-8', 13:22:52 INFO - 'LANGUAGE': 'en_US:en', 13:22:52 INFO - 'LOGNAME': 'cltbld', 13:22:52 INFO - 'MAIL': '/var/mail/cltbld', 13:22:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:22:52 INFO - 'MOZ_NO_REMOTE': '1', 13:22:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:22:52 INFO - 'NO_EM_RESTART': '1', 13:22:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:22:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:22:52 INFO - 'PWD': '/builds/slave/test', 13:22:52 INFO - 'SHELL': '/bin/bash', 13:22:52 INFO - 'SHLVL': '1', 13:22:52 INFO - 'TERM': 'linux', 13:22:52 INFO - 'TMOUT': '86400', 13:22:52 INFO - 'USER': 'cltbld', 13:22:52 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461615687.559999-824256985', 13:22:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:22:52 INFO - '_': '/tools/buildbot/bin/python'} 13:22:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:22:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:22:53 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 13:22:53 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 13:22:53 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 13:22:53 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 13:22:53 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 13:22:53 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 13:22:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:22:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:22:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:22:55 INFO - Installing collected packages: mozsystemmonitor 13:22:55 INFO - Running setup.py install for mozsystemmonitor 13:22:55 INFO - Successfully installed mozsystemmonitor 13:22:55 INFO - Cleaning up... 13:22:55 INFO - Return code: 0 13:22:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:22:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:22:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:22:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:22:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:55 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 0x7f838b093f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27435a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d2410>, '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 0x27d3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d37a0>, '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': '32c5991c409366f7fec8a718000001d2-1461615687.559999-824256985', '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 13:22:55 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 13:22:55 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 13:22:55 INFO - Using env: {'DISPLAY': ':0', 13:22:55 INFO - 'HOME': '/home/cltbld', 13:22:55 INFO - 'LANG': 'en_US.UTF-8', 13:22:55 INFO - 'LANGUAGE': 'en_US:en', 13:22:55 INFO - 'LOGNAME': 'cltbld', 13:22:55 INFO - 'MAIL': '/var/mail/cltbld', 13:22:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:22:55 INFO - 'MOZ_NO_REMOTE': '1', 13:22:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:22:55 INFO - 'NO_EM_RESTART': '1', 13:22:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:22:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:22:55 INFO - 'PWD': '/builds/slave/test', 13:22:55 INFO - 'SHELL': '/bin/bash', 13:22:55 INFO - 'SHLVL': '1', 13:22:55 INFO - 'TERM': 'linux', 13:22:55 INFO - 'TMOUT': '86400', 13:22:55 INFO - 'USER': 'cltbld', 13:22:55 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461615687.559999-824256985', 13:22:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:22:55 INFO - '_': '/tools/buildbot/bin/python'} 13:22:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:22:55 INFO - Downloading/unpacking blobuploader==1.2.4 13:22:55 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 13:22:55 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 13:22:55 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 13:22:55 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 13:22:55 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 13:22:55 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 13:22:57 INFO - Downloading blobuploader-1.2.4.tar.gz 13:22:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:22:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:22:57 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 13:22:57 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 13:22:57 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 13:22:57 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 13:22:57 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 13:22:57 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 13:22:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:22:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:22:57 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 13:22:57 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 13:22:57 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 13:22:57 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 13:22:57 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 13:22:57 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 13:22:57 INFO - Downloading docopt-0.6.1.tar.gz 13:22:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:22:57 INFO - Installing collected packages: blobuploader, requests, docopt 13:22:57 INFO - Running setup.py install for blobuploader 13:22:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:22:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:22:58 INFO - Running setup.py install for requests 13:22:58 INFO - Running setup.py install for docopt 13:22:58 INFO - Successfully installed blobuploader requests docopt 13:22:58 INFO - Cleaning up... 13:22:58 INFO - Return code: 0 13:22:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:22:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:22:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:22:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:22:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:58 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 0x7f838b093f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27435a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d2410>, '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 0x27d3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d37a0>, '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': '32c5991c409366f7fec8a718000001d2-1461615687.559999-824256985', '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 13:22:58 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 13:22:58 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 13:22:58 INFO - Using env: {'DISPLAY': ':0', 13:22:58 INFO - 'HOME': '/home/cltbld', 13:22:58 INFO - 'LANG': 'en_US.UTF-8', 13:22:58 INFO - 'LANGUAGE': 'en_US:en', 13:22:58 INFO - 'LOGNAME': 'cltbld', 13:22:58 INFO - 'MAIL': '/var/mail/cltbld', 13:22:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:22:58 INFO - 'MOZ_NO_REMOTE': '1', 13:22:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:22:58 INFO - 'NO_EM_RESTART': '1', 13:22:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:22:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:22:58 INFO - 'PWD': '/builds/slave/test', 13:22:58 INFO - 'SHELL': '/bin/bash', 13:22:58 INFO - 'SHLVL': '1', 13:22:58 INFO - 'TERM': 'linux', 13:22:58 INFO - 'TMOUT': '86400', 13:22:58 INFO - 'USER': 'cltbld', 13:22:58 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461615687.559999-824256985', 13:22:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:22:58 INFO - '_': '/tools/buildbot/bin/python'} 13:22:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:22:58 INFO - Running setup.py (path:/tmp/pip-yqS6lp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:22:58 INFO - Running setup.py (path:/tmp/pip-_HEmRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:22:58 INFO - Running setup.py (path:/tmp/pip-NmRjxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:22:59 INFO - Running setup.py (path:/tmp/pip-XA2wn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:22:59 INFO - Running setup.py (path:/tmp/pip-dADzLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:22:59 INFO - Running setup.py (path:/tmp/pip-uH9MDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:22:59 INFO - Running setup.py (path:/tmp/pip-22P9OI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:22:59 INFO - Running setup.py (path:/tmp/pip-Q0aj4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:22:59 INFO - Running setup.py (path:/tmp/pip-swUGWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:22:59 INFO - Running setup.py (path:/tmp/pip-eqmP52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:22:59 INFO - Running setup.py (path:/tmp/pip-XwVZDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:22:59 INFO - Running setup.py (path:/tmp/pip-pP2m2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:22:59 INFO - Running setup.py (path:/tmp/pip-D57EAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:22:59 INFO - Running setup.py (path:/tmp/pip-IPra4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:22:59 INFO - Running setup.py (path:/tmp/pip-VndVfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:22:59 INFO - Running setup.py (path:/tmp/pip-cZ_TCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:22:59 INFO - Running setup.py (path:/tmp/pip-Qwbxp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:23:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:23:00 INFO - Running setup.py install for manifestparser 13:23:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:23:00 INFO - Running setup.py install for mozcrash 13:23:00 INFO - Running setup.py install for mozdebug 13:23:00 INFO - Running setup.py install for mozdevice 13:23:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:23:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:23:00 INFO - Running setup.py install for mozfile 13:23:00 INFO - Running setup.py install for mozhttpd 13:23:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:23:00 INFO - Running setup.py install for mozinfo 13:23:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:23:00 INFO - Running setup.py install for mozInstall 13:23:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:23:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:23:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:23:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:23:00 INFO - Running setup.py install for mozleak 13:23:00 INFO - Running setup.py install for mozlog 13:23:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:23:01 INFO - Running setup.py install for moznetwork 13:23:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:23:01 INFO - Running setup.py install for mozprocess 13:23:01 INFO - Running setup.py install for mozprofile 13:23:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:23:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:23:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:23:01 INFO - Running setup.py install for mozrunner 13:23:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:23:01 INFO - Running setup.py install for mozscreenshot 13:23:01 INFO - Running setup.py install for moztest 13:23:01 INFO - Running setup.py install for mozversion 13:23:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:23:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:23:01 INFO - Cleaning up... 13:23:01 INFO - Return code: 0 13:23:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:23: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')]} 13:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23: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')]} 13:23:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:01 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 0x7f838b093f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27435a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d2410>, '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 0x27d3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d37a0>, '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': '32c5991c409366f7fec8a718000001d2-1461615687.559999-824256985', '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 13:23:01 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 13:23:01 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 13:23:01 INFO - Using env: {'DISPLAY': ':0', 13:23:01 INFO - 'HOME': '/home/cltbld', 13:23:01 INFO - 'LANG': 'en_US.UTF-8', 13:23:01 INFO - 'LANGUAGE': 'en_US:en', 13:23:01 INFO - 'LOGNAME': 'cltbld', 13:23:01 INFO - 'MAIL': '/var/mail/cltbld', 13:23:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:01 INFO - 'MOZ_NO_REMOTE': '1', 13:23:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:01 INFO - 'NO_EM_RESTART': '1', 13:23:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:01 INFO - 'PWD': '/builds/slave/test', 13:23:01 INFO - 'SHELL': '/bin/bash', 13:23:01 INFO - 'SHLVL': '1', 13:23:01 INFO - 'TERM': 'linux', 13:23:01 INFO - 'TMOUT': '86400', 13:23:01 INFO - 'USER': 'cltbld', 13:23:01 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461615687.559999-824256985', 13:23:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:01 INFO - '_': '/tools/buildbot/bin/python'} 13:23:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:23:02 INFO - Running setup.py (path:/tmp/pip-RFMI4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:23:02 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)) 13:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:23:02 INFO - Running setup.py (path:/tmp/pip-VxYN4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:23:02 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)) 13:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:23:02 INFO - Running setup.py (path:/tmp/pip-_OL20N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:23:02 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)) 13:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:23:02 INFO - Running setup.py (path:/tmp/pip-dpc0bb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:23:02 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)) 13:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:23:02 INFO - Running setup.py (path:/tmp/pip-wIlNDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:23:02 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)) 13:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:23:02 INFO - Running setup.py (path:/tmp/pip-lrzXFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:23:02 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)) 13:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:23:02 INFO - Running setup.py (path:/tmp/pip-ZTY3ZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:23:02 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)) 13:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:23:02 INFO - Running setup.py (path:/tmp/pip-8JF_ls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:23:02 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)) 13:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:23:02 INFO - Running setup.py (path:/tmp/pip-jf_sDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:23:02 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)) 13:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:23:02 INFO - Running setup.py (path:/tmp/pip-oNrMEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:23:02 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)) 13:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:23:02 INFO - Running setup.py (path:/tmp/pip-Wfx7jj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:23:02 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)) 13:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:23:02 INFO - Running setup.py (path:/tmp/pip-lRQ321-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:23:02 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)) 13:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:23:02 INFO - Running setup.py (path:/tmp/pip-CQu8qx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:23:02 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)) 13:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:23:03 INFO - Running setup.py (path:/tmp/pip-gzO__z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:23:03 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)) 13:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:23:03 INFO - Running setup.py (path:/tmp/pip-k6H9dI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:23:03 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)) 13:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:23:03 INFO - Running setup.py (path:/tmp/pip-X5hHFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:23:03 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)) 13:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:23:03 INFO - Running setup.py (path:/tmp/pip-nigdwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:23:03 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)) 13:23:03 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)) 13:23:03 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)) 13:23:03 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)) 13:23:03 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)) 13:23:03 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)) 13:23:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:23:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:05 INFO - Downloading blessings-1.6.tar.gz 13:23:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:23:05 INFO - Installing collected packages: blessings 13:23:05 INFO - Running setup.py install for blessings 13:23:05 INFO - Successfully installed blessings 13:23:05 INFO - Cleaning up... 13:23:05 INFO - Return code: 0 13:23:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:23:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:23:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:23:05 INFO - Reading from file tmpfile_stdout 13:23:05 INFO - Current package versions: 13:23:05 INFO - argparse == 1.2.1 13:23:05 INFO - blessings == 1.6 13:23:05 INFO - blobuploader == 1.2.4 13:23:05 INFO - docopt == 0.6.1 13:23:05 INFO - manifestparser == 1.1 13:23:05 INFO - mozInstall == 1.12 13:23:05 INFO - mozcrash == 0.17 13:23:05 INFO - mozdebug == 0.1 13:23:05 INFO - mozdevice == 0.48 13:23:05 INFO - mozfile == 1.2 13:23:05 INFO - mozhttpd == 0.7 13:23:05 INFO - mozinfo == 0.9 13:23:05 INFO - mozleak == 0.1 13:23:05 INFO - mozlog == 3.1 13:23:05 INFO - moznetwork == 0.27 13:23:05 INFO - mozprocess == 0.22 13:23:05 INFO - mozprofile == 0.28 13:23:05 INFO - mozrunner == 6.11 13:23:05 INFO - mozscreenshot == 0.1 13:23:05 INFO - mozsystemmonitor == 0.0 13:23:05 INFO - moztest == 0.7 13:23:05 INFO - mozversion == 1.4 13:23:05 INFO - psutil == 3.1.1 13:23:05 INFO - requests == 1.2.3 13:23:05 INFO - wsgiref == 0.1.2 13:23:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:05 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 0x7f838b093f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27435a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d2410>, '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 0x27d3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d37a0>, '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': '32c5991c409366f7fec8a718000001d2-1461615687.559999-824256985', '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 13:23:05 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 13:23:05 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 13:23:05 INFO - Using env: {'DISPLAY': ':0', 13:23:05 INFO - 'HOME': '/home/cltbld', 13:23:05 INFO - 'LANG': 'en_US.UTF-8', 13:23:05 INFO - 'LANGUAGE': 'en_US:en', 13:23:05 INFO - 'LOGNAME': 'cltbld', 13:23:05 INFO - 'MAIL': '/var/mail/cltbld', 13:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:05 INFO - 'MOZ_NO_REMOTE': '1', 13:23:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:05 INFO - 'NO_EM_RESTART': '1', 13:23:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:05 INFO - 'PWD': '/builds/slave/test', 13:23:05 INFO - 'SHELL': '/bin/bash', 13:23:05 INFO - 'SHLVL': '1', 13:23:05 INFO - 'TERM': 'linux', 13:23:05 INFO - 'TMOUT': '86400', 13:23:05 INFO - 'USER': 'cltbld', 13:23:05 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461615687.559999-824256985', 13:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:05 INFO - '_': '/tools/buildbot/bin/python'} 13:23:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:05 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)) 13:23:05 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)) 13:23:05 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)) 13:23:05 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)) 13:23:05 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)) 13:23:05 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)) 13:23:05 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)) 13:23:05 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)) 13:23:05 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)) 13:23:05 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)) 13:23:05 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)) 13:23:05 INFO - Cleaning up... 13:23:05 INFO - Return code: 0 13:23:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f838b093f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27435a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d2410>, '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 0x27d3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d37a0>, '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': '32c5991c409366f7fec8a718000001d2-1461615687.559999-824256985', '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 13:23:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:23:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:23:05 INFO - Using env: {'DISPLAY': ':0', 13:23:05 INFO - 'HOME': '/home/cltbld', 13:23:05 INFO - 'LANG': 'en_US.UTF-8', 13:23:05 INFO - 'LANGUAGE': 'en_US:en', 13:23:05 INFO - 'LOGNAME': 'cltbld', 13:23:05 INFO - 'MAIL': '/var/mail/cltbld', 13:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:05 INFO - 'MOZ_NO_REMOTE': '1', 13:23:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:05 INFO - 'NO_EM_RESTART': '1', 13:23:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:05 INFO - 'PWD': '/builds/slave/test', 13:23:05 INFO - 'SHELL': '/bin/bash', 13:23:05 INFO - 'SHLVL': '1', 13:23:05 INFO - 'TERM': 'linux', 13:23:05 INFO - 'TMOUT': '86400', 13:23:05 INFO - 'USER': 'cltbld', 13:23:05 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461615687.559999-824256985', 13:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:05 INFO - '_': '/tools/buildbot/bin/python'} 13:23:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:06 INFO - Downloading/unpacking jsonschema 13:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:23:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:23:07 INFO - Downloading/unpacking functools32 (from jsonschema) 13:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:23:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:08 INFO - Downloading functools32-3.2.3-2.tar.gz 13:23:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:23:08 INFO - warning: no files found matching '*.txt' 13:23:08 INFO - no previously-included directories found matching 'build' 13:23:08 INFO - no previously-included directories found matching 'dist' 13:23:08 INFO - no previously-included directories found matching '.git*' 13:23:08 INFO - Installing collected packages: jsonschema, functools32 13:23:08 INFO - Running setup.py install for functools32 13:23:08 INFO - warning: no files found matching '*.txt' 13:23:08 INFO - no previously-included directories found matching 'build' 13:23:08 INFO - no previously-included directories found matching 'dist' 13:23:08 INFO - no previously-included directories found matching '.git*' 13:23:08 INFO - Successfully installed jsonschema functools32 13:23:08 INFO - Cleaning up... 13:23:08 INFO - Return code: 0 13:23:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:23:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f838b093f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27435a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d2410>, '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 0x27d3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d37a0>, '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': '32c5991c409366f7fec8a718000001d2-1461615687.559999-824256985', '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 13:23:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 13:23:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:23:08 INFO - Using env: {'DISPLAY': ':0', 13:23:08 INFO - 'HOME': '/home/cltbld', 13:23:08 INFO - 'LANG': 'en_US.UTF-8', 13:23:08 INFO - 'LANGUAGE': 'en_US:en', 13:23:08 INFO - 'LOGNAME': 'cltbld', 13:23:08 INFO - 'MAIL': '/var/mail/cltbld', 13:23:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:08 INFO - 'MOZ_NO_REMOTE': '1', 13:23:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:08 INFO - 'NO_EM_RESTART': '1', 13:23:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:08 INFO - 'PWD': '/builds/slave/test', 13:23:08 INFO - 'SHELL': '/bin/bash', 13:23:08 INFO - 'SHLVL': '1', 13:23:08 INFO - 'TERM': 'linux', 13:23:08 INFO - 'TMOUT': '86400', 13:23:08 INFO - 'USER': 'cltbld', 13:23:08 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461615687.559999-824256985', 13:23:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:08 INFO - '_': '/tools/buildbot/bin/python'} 13:23:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:08 INFO - Downloading/unpacking flake8 13:23: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 13:23: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 13:23: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 13:23: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 13:23: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 13:23: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 13:23:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:23:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:23:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:23:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:23:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:23:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:23:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:23:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:23:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:23:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:23:12 INFO - no previously-included directories found matching 'docs/_build' 13:23:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:23:12 INFO - Running setup.py install for pep8 13:23:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:23:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:23:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:23:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:23:12 INFO - no previously-included directories found matching 'docs/_build' 13:23:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:23:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:23:12 INFO - Cleaning up... 13:23:12 INFO - Return code: 0 13:23:12 INFO - Running post-action listener: _resource_record_post_action 13:23:12 INFO - Running post-action listener: _start_resource_monitoring 13:23:12 INFO - Starting resource monitoring. 13:23:12 INFO - ##### 13:23:12 INFO - ##### Running install step. 13:23:12 INFO - ##### 13:23:12 INFO - Running pre-action listener: _resource_record_pre_action 13:23:12 INFO - Running main action method: install 13:23:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:23:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:23:12 INFO - Reading from file tmpfile_stdout 13:23:12 INFO - Detecting whether we're running mozinstall >=1.0... 13:23:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:23:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:23:12 INFO - Reading from file tmpfile_stdout 13:23:12 INFO - Output received: 13:23:12 INFO - Usage: mozinstall [options] installer 13:23:12 INFO - Options: 13:23:12 INFO - -h, --help show this help message and exit 13:23:12 INFO - -d DEST, --destination=DEST 13:23:12 INFO - Directory to install application into. [default: 13:23:12 INFO - "/builds/slave/test"] 13:23:12 INFO - --app=APP Application being installed. [default: firefox] 13:23:12 INFO - mkdir: /builds/slave/test/build/application 13:23:12 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'] 13:23:12 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 13:23:29 INFO - Reading from file tmpfile_stdout 13:23:29 INFO - Output received: 13:23:29 INFO - /builds/slave/test/build/application/firefox/firefox 13:23:29 INFO - Running post-action listener: _resource_record_post_action 13:23:29 INFO - ##### 13:23:29 INFO - ##### Running run-tests step. 13:23:29 INFO - ##### 13:23:29 INFO - Running pre-action listener: _resource_record_pre_action 13:23:29 INFO - Running main action method: run_tests 13:23:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:23:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:23:29 INFO - Python 2.7.3 13:23:29 INFO - Return code: 0 13:23:29 INFO - grabbing minidump binary from tooltool 13:23:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:29 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d2410>, '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 0x27d3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d37a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:23:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:23:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:23:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:23:29 INFO - Return code: 0 13:23:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:23:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:23:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:23:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:23:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:23:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:23:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:23:30 INFO - Return code: 0 13:23:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RvEmcoRSQRKXtBB_HaBodw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:23:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RvEmcoRSQRKXtBB_HaBodw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:23:30 INFO - Using env: {'DISPLAY': ':0', 13:23:30 INFO - 'HOME': '/home/cltbld', 13:23:30 INFO - 'LANG': 'en_US.UTF-8', 13:23:30 INFO - 'LANGUAGE': 'en_US:en', 13:23:30 INFO - 'LOGNAME': 'cltbld', 13:23:30 INFO - 'MAIL': '/var/mail/cltbld', 13:23:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:23:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:23:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:30 INFO - 'MOZ_NO_REMOTE': '1', 13:23:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:23:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:30 INFO - 'NO_EM_RESTART': '1', 13:23:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:30 INFO - 'PWD': '/builds/slave/test', 13:23:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:23:30 INFO - 'SHELL': '/bin/bash', 13:23:30 INFO - 'SHLVL': '1', 13:23:30 INFO - 'TERM': 'linux', 13:23:30 INFO - 'TMOUT': '86400', 13:23:30 INFO - 'USER': 'cltbld', 13:23:30 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461615687.559999-824256985', 13:23:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:30 INFO - '_': '/tools/buildbot/bin/python'} 13:23:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RvEmcoRSQRKXtBB_HaBodw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:23:30 INFO - mozversion application_buildid: 20160425103042 13:23:30 INFO - mozversion application_changeset: 2045bc8c9e90a7ca0b8c6447ddecd812a71b29e1 13:23:30 INFO - mozversion application_display_name: Nightly 13:23:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:23:30 INFO - mozversion application_name: Firefox 13:23:30 INFO - mozversion application_remotingname: firefox 13:23:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:23:30 INFO - mozversion application_vendor: Mozilla 13:23:30 INFO - mozversion application_version: 49.0a1 13:23:30 INFO - mozversion platform_buildid: 20160425103042 13:23:30 INFO - mozversion platform_changeset: 2045bc8c9e90a7ca0b8c6447ddecd812a71b29e1 13:23:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:23:30 INFO - mozversion platform_version: 49.0a1 13:23:30 INFO - using testdate: 1461615810 13:23:30 INFO - actual date: 1461615810 13:23:30 INFO - starting webserver on 'localhost:57371' 13:23:30 INFO - SUITE-START | Running 2 tests 13:23:30 INFO - TEST-START | dromaeo_css 13:23:30 INFO - operating with platform_type : linux_ 13:23:30 INFO - Initialising browser for dromaeo_css test... 13:23:30 INFO - TEST-INFO | started process 19418 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpye_7n6/profile http://localhost:57371/getInfo.html) 13:23:34 INFO - PROCESS | 19418 | 13:23:34 INFO - PROCESS | 19418 | (process:19485): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:23:35 INFO - PROCESS | 19418 | __metrics Screen width/height:1600/1200 13:23:35 INFO - PROCESS | 19418 | colorDepth:24 13:23:35 INFO - PROCESS | 19418 | Browser inner width/height: 1024/697 13:23:35 INFO - PROCESS | 19418 | __metrics 13:23:35 ERROR - PROCESS | 19418 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 13:23:36 INFO - TEST-INFO | 19418: exit 0 13:23:36 INFO - Browser initialized. 13:23:36 INFO - Running cycle 1/1 for dromaeo_css test... 13:23:36 INFO - TEST-INFO | started process 19536 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpye_7n6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:23:38 INFO - PROCESS | 19536 | 13:23:38 INFO - PROCESS | 19536 | (process:19600): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:23:48 INFO - PROCESS | 19536 | RSS: Main: 165171200 13:23:48 INFO - PROCESS | 19536 | 13:24:37 INFO - PROCESS | 19536 | 1461615877996 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] 13:26:45 INFO - PROCESS | 19536 | Cycle 1(1): loaded http://localhost:57371/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57371/tests/dromaeo/cssquery-ext.html) 13:26:46 INFO - PROCESS | 19536 | RSS: Main: 169717760 13:26:46 INFO - PROCESS | 19536 | 13:29:48 INFO - PROCESS | 19536 | Cycle 1(1): loaded http://localhost:57371/tests/dromaeo/cssquery-ext.html (next: http://localhost:57371/tests/dromaeo/cssquery-jquery.html) 13:29:49 INFO - PROCESS | 19536 | RSS: Main: 168603648 13:29:49 INFO - PROCESS | 19536 | 13:32:51 INFO - PROCESS | 19536 | Cycle 1(1): loaded http://localhost:57371/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57371/tests/dromaeo/cssquery-mootools.html) 13:32:51 INFO - PROCESS | 19536 | RSS: Main: 168083456 13:32:51 INFO - PROCESS | 19536 | 13:35:53 INFO - PROCESS | 19536 | Cycle 1(1): loaded http://localhost:57371/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57371/tests/dromaeo/cssquery-prototype.html) 13:35:54 INFO - PROCESS | 19536 | RSS: Main: 165855232 13:35:54 INFO - PROCESS | 19536 | 13:38:56 INFO - PROCESS | 19536 | Cycle 1(1): loaded http://localhost:57371/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57371/tests/dromaeo/cssquery-yui.html) 13:38:57 INFO - PROCESS | 19536 | RSS: Main: 167129088 13:38:57 INFO - PROCESS | 19536 | 13:41:59 INFO - PROCESS | 19536 | Cycle 1(1): loaded http://localhost:57371/tests/dromaeo/cssquery-yui.html (next: http://localhost:57371/tests/dromaeo/cssquery-dojo.html) 13:41:59 INFO - PROCESS | 19536 | RSS: Main: 169336832 13:41:59 INFO - PROCESS | 19536 | 13:41:59 INFO - PROCESS | 19536 | __start_tp_report 13:41:59 INFO - PROCESS | 19536 | _x_x_mozilla_page_load 13:41:59 INFO - PROCESS | 19536 | _x_x_mozilla_page_load_details 13:41:59 INFO - PROCESS | 19536 | |i|pagename|runs| 13:41:59 INFO - PROCESS | 19536 | |0;dojo.html;3174.23818283612;3187.760917931155;3206.5350524173987;3221.790583612065;3223.597050368704;5348.812791552296;5408.405075441703;5412.702301373432;5417.431169727181;5497.890042199158;5450.700211488366;5479.835604931848;5527.5301599364;5559.555235581154;5560.054790685583;4961.776720047606;4984.077945580079;5025.924611130836;5055.9241611375855;5083.085044691954;4935.383077115361;5069.366329208849;5101.285819985186;5101.974490127544;5107.821226257081;4962.0324036812835;4963.4540200578085;4979.900401991958;5003.249512573107;5047.4447810740785;4985.052839960396;5024.67339622927;5025.321581586476;5029.145045342264;5073.289739436482;5006.249062640597;5014.172661510846;5022.383883603799;5023.874403139914;5037.924431133536;5455.481729235717;5469.425710300401;5481.314835645544;5486.61593688442;5512.118061110203;5905.763769449217;5926.318473375574;5931.851703707399;5937.050071988504;5937.881242375129;5705.115707065412;5846.269216347957;5951.3751056139345;5981.850453738648;5983.461488466059;5532.197831314477;5542.7782888684405;5558.777648894039;5566.499015088621;5593.552515798727;6047.667378294236;6053.213082299273;6065.484433823174;6068.75724971005;6075.088736689444;5697.715114244271;5732.799352022743;5784.942150578525;5830.183774271521;5831.737571809279;5887.705614719247;5894.115882617642;5896.7641294348605;5908;5944.940550594525;5759.136129580513;5776.768929242783;5803.245578074823;5853.502452291517;5855.677937713466;5843.2695913010875;5858.209141765892;5867.3839246879315;5874.471297583238;5930.2883653960935;4407.294832826797;4408.140412619572;4412.161689279027;4423.336499525032;4460.843870464518;3880.3985382265796;3884.8834534964;3919.431682406035;3926;3971.146203566247;5467.9453205468235;5611.158326251013;5645.322561292671;5688.089905615082;5692.857678557986;5867.941320586825;5883.588148829541;5889.175515427758;5892.852678683067;5902.8819423611285;5535;5539.25220095282;5540.058190107691;5541.251930989265;5543.750531226105;4940.777665005012;5039.21892106724;5063.11395505785;5070.923936140961;5100.744962751847;5941.108833674897;5964.821055368346;5983.940160598426;6000;6001.36985616504;5688.288963879515;5817.680027598522;5846.619969701956;5851.882962340729;5854.209681692917;5939.673317967553;5989.550783691154;6005.249343832021;6046.546509011754;6060.878782424239;5813.128030795246;5822.214001109796;5827.213326201078;5830.387809279964;5838.416158384128;5800.332961709458;5892.086726557391;5920.230370051866;5932.644041357532;5966.373530779206;5803.593748437737;5823.242978412779;5824;5824.271966004249;5875.794347197828;5779.479846813807;5788.855278618068;5790.594658373873;5798.5651076168615;5807.796727114531;5537.612367134423;5626.1842032905815;5690.9430905690415;5695.544356451391;5703.230063941315;5555.194496798023;5680.573956953162;5712.34308054579;5739.426057394227;5843.29880414336;5647.661140331593;5669.262995810518;5670.319561652628;5689.6586204827845;5709.20071190042 13:41:59 INFO - PROCESS | 19536 | |1;ext.html;606.9150318955348;645.5835985789165;646.812424396925;650.7104338569338;663.0518358746992;38506.422403663935;39514.60485395149;39714.801425992904;39796.403053954215;39905.40141897874;40618;40900;41091.17817643653;41127.177456450925;41228.58771412285;8500.744977650666;8699.39104262702;8705.434146780439;8706.869396959051;8733.7816554586;8533.658653653847;8654.48073115615;8685;8709.651613935435;8827.426217295855;8736.912630873705;8830.337724670644;8904.198622124008;8909.599068041922;8914.50970196639;8831.690890818823;8882.289416846668;8883.644654213824;8897.955510222408;8900.910990890074;8609.741707748777;8734.213920747163;8759.211670949646;8763.386562940534;8777.561121943942;40695.1860962782;40785.184296314204;40815.1836963262;40928;41013.1797364054;3558.448440491728;3622.1487950331652;3632.527771389729;3721.423179407196;4121.031557583965;30698.23254418635;31296.21759456009;31344;31437.056888293388;31713.365732685448;4190.937135942963;4204.096119334357;4279.272523670983;4295.677824163169;4467.798949047301;209926;210887;211009;211656;211923;46794.5320546797;52104.47895521072;55514.44485555093;56531.71734141385;56618.43381566214;54652.45347546474;54894.17658735122;55079.724601376736;55186.724066379415;55469.44530554723;13742.587722368346;14021.5277395874;14027.228502432261;14049.22729249901;14152.29238538069;10830.891691083147;10894.836577451344;10977;10986.615468458565;11069.778604428027;16658.50024499267;16781.496555103367;17329.56676083083;17351.13244337778;17396.652066958843;5948.851278718067;6114.052321890114;6114.74647697221;6166.599171053867;6202.100695399142;1057.0222544146634;1099.7910397024539;1100.2793170473353;1168.9473973671206;1171.0690001448697;31291.68708312933;31522.52716209259;31623.841880790907;31631.52552711711;32202.83898580492;1135.28477059452;1138.6754774889116;1140.4582823159099;1211.4790640024873;1254.3414707278753;16737.24058474115;16851;16997;17116.828831711773;17194.484165474805;462578;465498;469622;470084;471561;56742.432575673716;56800;57260.42739572634;57453.42546574481;57473.425265747646;1325.0790700463085;1374.6906945937285;1383.7301726163503;1397.224540380099;1492.9626759331104;30738.385232294782;30844.22889427782;31102.37795244128;31578.526322104728;31817;44467.33299000582;44908.77545612251;44949.77525112354;44991.77504112459;45045;403006;406650;407821;408316;410057;40948;41755.37366939438;42700;43282.78358608187;43487.78256108699;48012.7599362001;48490.51509485001;48665;48974.510254896995;48997.26504102512;40284.39573406343;40523.39214911838;41275.38086928758;41449.79275103605;42278.154436910474;40201.58286545677;40312.59687403206;40835.79582102071;42022.15955680808;42166.36750448807;38275.42586861143;38994.4150837732;39138.80430597829;39196.41205381865;41351;31763.68236317607;32611.34777304488;32939;35839.28321433609;36544;26872;27228.863855680596;27746.306342341602;28141.155765327072;28217.57673634856 13:41:59 INFO - PROCESS | 19536 | |2;jquery.html;395.10311592684604;395.4187344603434;400.65143325306985;406.3579544319975;406.3822989056634;17965.730514042283;18646.62706745864;18822.435326940198;18878.90560547197;19965.604127504685;18381.44855654329;18421.53946151347;18709.62580748384;19476.220951161973;19601.41195764126;5561.5272701820195;5698.116791897252;5789.073748200289;5789.218455508516;5944.7027648617395;5705.942940570582;5747.568932330071;5786.479216870481;5793.217915581406;5794.246747922764;5469.316335458067;5728.942710572904;5743.3108027036815;5755.136729490568;5770;5660.377358490563;5734;5734.541236701096;5738.885222295572;5760.395158508359;5260.28986086881;5516.696581688006;5540.584456165763;5541.307336582927;5554.91667624986;12320.815187772101;12941.87058129416;12942.676433089155;12962.675933101653;20710.275140370166;2197.165077270643;2205.184081889695;2314.2247347138727;2362.0315670575155;2383.451806084593;9776.217902567778;9948.154406875425;10129.341592796445;10255.384676919408;10367.429791361472;1867.2437662746474;1943.5918457124021;1957.9412617621495;1959.0694420150458;1960.4412742368356;68228.3177168227;71015.2898471019;77165.61417192934;82666.58666706688;85646;9994.252155441709;10135.239857010754;10584.788304233873;10600.734981625521;10675.0392464677;14676.192809395372;14699.412023519153;14790.556283311518;14832.777508337384;14851.331690073972;7247.311505406978;7352.77941661751;7364.815879603053;7377.446691498159;7449.441291903129;6906.343897329745;7011.92988070123;7372.705091796268;7413.962930185315;7554.357879580188;4336.696431249846;4449.644028477714;4464.2633965396;4668.929966050512;4786.305985632064;1910.6083252933115;1974.2450756045964;1976.3280484635293;1986.6126105409307;2038.1949130093826;906.6464079009191;1014.4116412480744;1094.485591771866;1127.763169734365;1154.342025045716;18816.776909500837;18857.151428185764;19302.613947720965;19513.512162196057;20069.29757458482;1024.2164743970868;1026.2559644257854;1028.6913925822223;1031.4997226345217;1048.4128887822844;10661.200409969284;11039.39283339424;11100.722481938015;11149.16381271408;11173.497192626352;480636;482674;483478;489079;517351;95960.52019739996;96910;98739;100997;104654;1028.7068185567077;1050.2280823594804;1076.531708706715;1096.9122470202365;1102.459794700607;17109;17119.57201069983;17149.399771007957;17231.56921076983;17272.94531499816;39402;39959.40060899147;40512.392314114724;40530.79734601308;41544;57554.42445575491;58400.70799645974;58637;59623;60129.699351504714;8412.369072319478;8505.87241191395;8529.872051919103;8626;8744.431611945203;10082.495875206358;10909.909009099027;11132.1650876183;13482.258475783927;13864.584062478141;11672.591459298883;12018.519259229533;12097.33464659417;12157.939210303892;12247.69380765488;11420.371879546705;11609.187356884937;11847.881521184678;12179;12295.200811947196;12043.518259269531;12080.637580872588;12092;12162.878371216528;12296.75406491883;8933.776655583402;11469.1055452605;12596.685082873002;13002.869971300166;13131.212127272394;11606.535738570363;11757;12060;12257.509699612272;12395.070369722487 13:41:59 INFO - PROCESS | 19536 | |3;mootools.html;1486.9628259293515;1526.1914631162074;1669.0069408701818;1734.7831521059868;1779.6618642457931;7452.664630091645;7975.7208497702595;8007;8325.87511187332;8352.123027082152;8005.079415867162;8009.559474228915;8034.39742019348;8073.071596766374;8087.636056377462;2266.3994041578994;2278.51012032413;2303.7811407916306;2305.8616483011074;2310.607196776552;2248.8875556222206;2252.279270633398;2261.7851304126166;2277.8861056947085;2279.0314116500504;2261.3329067925;2273.6930514380597;2293.816494680422;2318.6985691860036;2323.1984965186984;2192.802647761709;2200.3618950504333;2204.55908818237;2216.1689366487485;2220.733511978565;2227.610168220555;2227.855189412683;2237.1387015998794;2239.2498512998163;2244.539869326784;8208.507489550646;8295.792605184859;8303.418760686754;8303.875441868377;8326.333893288522;4984.501549845023;5106.668066575698;5170.922436163423;5171.276021356975;5180.430152683201;3124.3438877835683;3232.91917702057;3285.8192799396024;3297.142742886843;3306.9834650826833;1031.3240983401972;1057.2123767792966;1111.2110401614864;1116.385987706758;1127.5433449452985;11371.943140284246;11406.258593191416;11470.311781293232;11481.425928703615;11489.080873530182;4498.5501449854755;4579.6794224403975;4676.2985552166765;4686.226772582554;4702.506236845151;9646.42121472714;9674.613015479303;9676.758081047888;9683.273754468302;9712.805743885083;5194.948050519522;5221.112410890158;5224.03355379256;5225.973870130625;5235.790568377299;4196.496420429568;4611.054733779567;4638.814447422133;4737.715737055788;4745.193317136095;3840.078381188495;3864.594217607167;3945.743526670815;3963.504561929759;3976.0855003349393;1259.2947949148506;1291.7158225190442;1303.1724854717322;1313.6321829887647;1321.6960099177243;956.8325543029941;975.707287813653;980.8921018687938;987.3779518903045;994.1847684898314;5248.895022099537;5401.054815407367;5420.186971954238;5660.858478537987;5840.445157710011;438.0472472372577;439.0122224993764;444.7398272010845;452.5293694557689;463.76116300105474;3962.722609417313;3987.282289187916;3990.4014397839974;4020.979895100506;4028.7179897407486;9976.201903847676;10209.591616335412;10246.38521688701;10302.896971030194;10315.27793054479;9983.450910199863;10070.69787906364;10093.646722364829;10162.18702503798;10172.949135254275;7738.458307918391;7791.532508049535;7797.805054873674;7811.921880781233;7983.760487185394;5611.971940140274;5668.631538949955;5720.771169153188;5721.113227449752;5739.446560443128;9062.818743625223;9277;9289.396189247676;9369.250459963323;9407.482588457427;9271.953640231755;9325.160735533835;9333.393329433566;9416.62333506652;9472.95263523678;6700.66496675174;7120.786376408716;7272.672729727069;7533.849323013618;7864.606769661608;7697.576633285223;7749.806254843674;7749.806254843674;7793.142754297136;7839.33365663925;6892.931070689429;7078.787636370917;7313.122425308997;7359.153697324876;7485.850282994418;6939.167299924042;7144.64276786169;7144.714211431485;7188;7241.456890733321;6438.484921206386;6669.833254168685;6693.196816382066;6717.1267735194115;6736.898946515708;4876.609871210366;4961.2806143109765;4972.577330926767;5027.346444962278;5072.51811077947;4974.900501990012;4986.900261994812;5000.449950505369;5028.949710502849;5045.4450010498085 13:41:59 INFO - PROCESS | 19536 | |4;prototype.html;315.8405005472236;324.7629230661617;327.6805115012863;327.78693848998154;329.30188001436954;5520.309961254843;5568.415316391782;5591.440855914407;5625.859353516164;5694;5563.777448902039;5590;5622.859428514279;5631.8028868989495;5648.406917273689;4310.288802347609;4321.135772845428;4329.155814616143;4333.566643335673;4343.674224433164;4223.767692776896;4297.419848320468;4307.203167414023;4320.243957307459;4324.005478739876;4190.245755763961;4240.872773816791;4255.404243405926;4267.850625228118;4290;4200.85297014603;4220.894477638069;4248.4477017987465;4270.188664153801;4272.786360681969;3678.0391784613375;3715.5727091384565;3719.888403347904;3738.140227747633;3747.362948298796;5354.571634269249;5407.972960135214;5414.756335964891;5424.647397919122;5460.863478413032;4795.736234507101;4801.231802911552;4857.82997595086;4860.781264843055;4871.732054736988;5664.49019588239;5769.711514424262;5772.853794681909;5784.16129661201;5829.562782791308;4116.341385378325;4120.011197312653;4123.402106694512;4138.172365526877;4139.627433530966;5724.742386592613;5873.913326034697;6089.969550152266;6110.297315808694;6160.168377269056;4211.642010429148;4213.557576454428;4215.292806413346;4219.113986062961;4221.134667393177;4248.936265956013;4254.723442976197;4255.808488617958;4273.487181538173;4276.893077673083;4683.250679891269;4867.902641947141;4871.5128487151005;4916.70499770015;4927.7926907907795;5815.302163740378;5827.970860145672;5894.410558944071;5899.970500147472;5922.7927022554;1530.2348825587205;1548.481258778322;1551.06935838496;1553.5572361877037;1559.0957244798217;990.7919336939179;992.9205663546899;1005.4319309590204;1028.2134167361974;1043.7390652336917;6066.817995460143;6070.726817293233;6070.848228794315;6086.2087928569;6100.816975490654;6413.935860641333;6476.413278746737;6482.319356467598;6501.447376972916;6518.413342799076;5939.287285525678;6023.909641355383;6044.969775151096;6054.636721796706;6071.423214794588;3449.8098156136093;3470.8958731238104;3472.166679996833;3474.5309383233443;3480.4953281774;6456.451201647818;6624.436922861514;6658.9001164982565;6659.300773418819;6707.564008339442;6519.217693876765;6549.967250163814;6550.737970481127;6566.80299591013;6569.310222426672;6496.252930912911;6593.637349945799;6635.5023373247195;6656.767013154419;6735.955926831349;6430.774922877864;6439.613623182624;6444.967775161282;6447.677616119082;6479.870402592016;5708.686022268815;6362.777302794565;6387.265464471459;6397.808065758035;6415.133956915756;6191.535634827496;6236.690295038093;6265.843353916006;6282.089097080989;6309.179806625293;4110.568390319093;4115.382692596135;4116.567760385116;4121.52602450722;4145.564715704808;5843.2403787507355;6020.4280593343565;6049.606775559574;6091.664958427329;6108.511319094373;5854.912176317273;5874.265716785402;5890.145928840208;5897.233359663216;5916.437938396018;5776.191333213437;5888.263967004124;5890.440408161217;5897.67562784051;5935.762569497172;5722.828315150552;5755.7122143893475;5777.6822274775295;5789.739461724148;5817.156512305776;5950.166976623363;5954.7320370582565;5958.553108516792;5959.28488581373;5986.221791167294;5631.577631677723;5751.424857514216;5840.415958404125;5844.298684157929;5876.08920617305 13:41:59 INFO - PROCESS | 19536 | |5;yui.html;767.8272388712538;774.477227871187;817.5952903312857;820.7168526858231;834.7662654456747;13868.1679099254;14086.718265634681;14226;14335.928320358384;14340.569782906503;13068.93465532671;13140.671483212924;13173.538926137588;13184.802227966587;13232.867671323284;675.9222689390709;802.6187560908551;820.1552401026952;830.4436027861317;830.900291964965;823.2302796884902;825.1748251748252;826.396730386818;827.6027506796742;827.9503229806231;868.1925808997661;870.4342177584589;871.1810897756089;874.5059041641484;874.7332063720563;863.0765081362944;868.3227082875368;868.5396739727954;869.6477926439802;872.3326655108847;623.2583225961092;624.7407325959721;625.4589779840405;630.0045927434688;630.4609558827183;13805.861941380557;13853.099548529313;13870.791938120936;13903.721925561433;14016.43934242629;13053.54312599064;13217;13494.932525337408;13521.932390337985;13713.794293085612;10707.464626768631;10721.62474313403;11021.283616564897;11165.218434709574;11223.046041086518;3733.9813300933592;3749.643783840531;3772.512982029491;3802.201537677091;3809.3904975204114;54050;54482.72758636221;55379.16931246035;55452;57883.421165787804;10100.494975251355;10204.693859184237;10644.787104257872;10738.94630526858;10822.621208257831;18625.7206141908;18644;18704.438866834018;19619.901900490408;19888.801111988694;7382.667779949915;7383.372413344819;7422.072240969879;7654.655540500691;7660.3488703460835;4280.72175308604;4292.892677683083;4554.476235232924;4644.535546445396;4703.082898834695;3359.143418428334;3436.278381539905;3438.2435864109857;3444.156181735441;3451.5858097028017;541.1142169539153;603.1405247522263;616.4205646692095;617.5029101573186;618.0204376063989;716.759885438384;727.7016423266541;729.773770131261;743.1750756660103;758.852023855354;9082.591283392263;9221.216196623362;9269.536523173814;9443.763905902408;9550.522473876417;715.1596873673413;727.421699748701;746.5931067568189;760.69572171132;772.0889350566385;4145.647619952278;4393.912121757611;4421.270490369117;4441.444819397575;4499.88750281239;54922.72538637281;56711.43288567144;56765.71617141888;67151;69840.65079674569;49420.505794942306;49502;59882;60676.39323606707;62182.68908655518;54255.186172207446;54664;54820.45179548233;55670.72164639151;55837.720811396495;8824.735257942271;8867.600957956778;8964.296783611093;9022.097790220925;9196.26429885621;33983;34076.14809629779;34872.82563587267;35755.28489430249;35823.28353432865;42897.571024290606;46202.53797461982;49819.50180498294;50178.247326289405;50665.24002139897;11659.242149260272;11752.76494470123;12272.693182670504;12392.442340094538;12594.24434533931;12060.336681482251;12119.333436661069;12223.327716975651;12382;12671.429785659851;11434.599789007345;11777.003829557392;11801.940990294994;12216.144869859025;12384.75230495403;11572.537098515964;11581.189316747746;11611;11638.72719829859;11697;10246.282760206714;11086.334819910831;11140.721481963015;11596.710082248012;11618.360990145286;8957.686480973396;9097.13577210164;9294.209992150743;9324.254059675346;9549.331546791936;10170.542325595514;10352.430616316175;10481.266311358131;10601.575936962436;10659.94670026645 13:41:59 INFO - PROCESS | 19536 | __end_tp_report 13:41:59 INFO - PROCESS | 19536 | __start_cc_report 13:41:59 INFO - PROCESS | 19536 | _x_x_mozilla_cycle_collect,357 13:41:59 INFO - PROCESS | 19536 | __end_cc_report 13:41:59 INFO - PROCESS | 19536 | __startTimestamp1461616919599__endTimestamp 13:41:59 INFO - PROCESS | 19536 | 13:41:59 INFO - PROCESS | 19536 | ------- Summary: start ------- 13:41:59 INFO - PROCESS | 19536 | Number of tests: 6 13:41:59 INFO - PROCESS | 19536 | 13:41:59 INFO - PROCESS | 19536 | [#0] dojo.html Cycles:165 Average:5459.51 Median:5689.66 stddev:623.47 (11.0%) stddev-sans-first:599.06 13:41:59 INFO - PROCESS | 19536 | Values: 3174.2 3187.8 3206.5 3221.8 3223.6 5348.8 5408.4 5412.7 5417.4 5497.9 5450.7 5479.8 5527.5 5559.6 5560.1 4961.8 4984.1 5025.9 5055.9 5083.1 4935.4 5069.4 5101.3 5102.0 5107.8 4962.0 4963.5 4979.9 5003.2 5047.4 4985.1 5024.7 5025.3 5029.1 5073.3 5006.2 5014.2 5022.4 5023.9 5037.9 5455.5 5469.4 5481.3 5486.6 5512.1 5905.8 5926.3 5931.9 5937.1 5937.9 5705.1 5846.3 5951.4 5981.9 5983.5 5532.2 5542.8 5558.8 5566.5 5593.6 6047.7 6053.2 6065.5 6068.8 6075.1 5697.7 5732.8 5784.9 5830.2 5831.7 5887.7 5894.1 5896.8 5908.0 5944.9 5759.1 5776.8 5803.2 5853.5 5855.7 5843.3 5858.2 5867.4 5874.5 5930.3 4407.3 4408.1 4412.2 4423.3 4460.8 3880.4 3884.9 3919.4 3926.0 3971.1 5467.9 5611.2 5645.3 5688.1 5692.9 5867.9 5883.6 5889.2 5892.9 5902.9 5535.0 5539.3 5540.1 5541.3 5543.8 4940.8 5039.2 5063.1 5070.9 5100.7 5941.1 5964.8 5983.9 6000.0 6001.4 5688.3 5817.7 5846.6 5851.9 5854.2 5939.7 5989.6 6005.2 6046.5 6060.9 5813.1 5822.2 5827.2 5830.4 5838.4 5800.3 5892.1 5920.2 5932.6 5966.4 5803.6 5823.2 5824.0 5824.3 5875.8 5779.5 5788.9 5790.6 5798.6 5807.8 5537.6 5626.2 5690.9 5695.5 5703.2 5555.2 5680.6 5712.3 5739.4 5843.3 5647.7 5669.3 5670.3 5689.7 5709.2 13:41:59 INFO - PROCESS | 19536 | 13:41:59 INFO - PROCESS | 19536 | [#1] ext.html Cycles:180 Average:52994.99 Median:40867.90 stddev:100221.62 (245.2%) stddev-sans-first:100425.58 13:41:59 INFO - PROCESS | 19536 | Values: 606.9 645.6 646.8 650.7 663.1 38506.4 39514.6 39714.8 39796.4 39905.4 40618.0 40900.0 41091.2 41127.2 41228.6 8500.7 8699.4 8705.4 8706.9 8733.8 8533.7 8654.5 8685.0 8709.7 8827.4 8736.9 8830.3 8904.2 8909.6 8914.5 8831.7 8882.3 8883.6 8898.0 8900.9 8609.7 8734.2 8759.2 8763.4 8777.6 40695.2 40785.2 40815.2 40928.0 41013.2 3558.4 3622.1 3632.5 3721.4 4121.0 30698.2 31296.2 31344.0 31437.1 31713.4 4190.9 4204.1 4279.3 4295.7 4467.8 209926.0 210887.0 211009.0 211656.0 211923.0 46794.5 52104.5 55514.4 56531.7 56618.4 54652.5 54894.2 55079.7 55186.7 55469.4 13742.6 14021.5 14027.2 14049.2 14152.3 10830.9 10894.8 10977.0 10986.6 11069.8 16658.5 16781.5 17329.6 17351.1 17396.7 5948.9 6114.1 6114.7 6166.6 6202.1 1057.0 1099.8 1100.3 1168.9 1171.1 31291.7 31522.5 31623.8 31631.5 32202.8 1135.3 1138.7 1140.5 1211.5 1254.3 16737.2 16851.0 16997.0 17116.8 17194.5 462578.0 465498.0 469622.0 470084.0 471561.0 56742.4 56800.0 57260.4 57453.4 57473.4 1325.1 1374.7 1383.7 1397.2 1493.0 30738.4 30844.2 31102.4 31578.5 31817.0 44467.3 44908.8 44949.8 44991.8 45045.0 403006.0 406650.0 407821.0 408316.0 410057.0 40948.0 41755.4 42700.0 43282.8 43487.8 48012.8 48490.5 48665.0 48974.5 48997.3 40284.4 40523.4 41275.4 41449.8 42278.2 40201.6 40312.6 40835.8 42022.2 42166.4 38275.4 38994.4 39138.8 39196.4 41351.0 31763.7 32611.3 32939.0 35839.3 36544.0 26872.0 27228.9 27746.3 28141.2 28217.6 13:41:59 INFO - PROCESS | 19536 | 13:41:59 INFO - PROCESS | 19536 | [#2] jquery.html Cycles:180 Average:28858.74 Median:1975.29 stddev:81070.04 (4104.2%) stddev-sans-first:81269.29 13:41:59 INFO - PROCESS | 19536 | Values: 395.1 395.4 400.7 406.4 406.4 17965.7 18646.6 18822.4 18878.9 19965.6 18381.4 18421.5 18709.6 19476.2 19601.4 5561.5 5698.1 5789.1 5789.2 5944.7 5705.9 5747.6 5786.5 5793.2 5794.2 5469.3 5728.9 5743.3 5755.1 5770.0 5660.4 5734.0 5734.5 5738.9 5760.4 5260.3 5516.7 5540.6 5541.3 5554.9 12320.8 12941.9 12942.7 12962.7 20710.3 2197.2 2205.2 2314.2 2362.0 2383.5 9776.2 9948.2 10129.3 10255.4 10367.4 1867.2 1943.6 1957.9 1959.1 1960.4 68228.3 71015.3 77165.6 82666.6 85646.0 9994.3 10135.2 10584.8 10600.7 10675.0 14676.2 14699.4 14790.6 14832.8 14851.3 7247.3 7352.8 7364.8 7377.4 7449.4 6906.3 7011.9 7372.7 7414.0 7554.4 4336.7 4449.6 4464.3 4668.9 4786.3 1910.6 1974.2 1976.3 1986.6 2038.2 906.6 1014.4 1094.5 1127.8 1154.3 18816.8 18857.2 19302.6 19513.5 20069.3 1024.2 1026.3 1028.7 1031.5 1048.4 10661.2 11039.4 11100.7 11149.2 11173.5 480636.0 482674.0 483478.0 489079.0 517351.0 95960.5 96910.0 98739.0 100997.0 104654.0 1028.7 1050.2 1076.5 1096.9 1102.5 17109.0 17119.6 17149.4 17231.6 17272.9 39402.0 39959.4 40512.4 40530.8 41544.0 57554.4 58400.7 58637.0 59623.0 60129.7 8412.4 8505.9 8529.9 8626.0 8744.4 10082.5 10909.9 11132.2 13482.3 13864.6 11672.6 12018.5 12097.3 12157.9 12247.7 11420.4 11609.2 11847.9 12179.0 12295.2 12043.5 12080.6 12092.0 12162.9 12296.8 8933.8 11469.1 12596.7 13002.9 13131.2 11606.5 11757.0 12060.0 12257.5 12395.1 13:41:59 INFO - PROCESS | 19536 | 13:41:59 INFO - PROCESS | 19536 | [#3] mootools.html Cycles:180 Average:5471.93 Median:5028.15 stddev:3035.45 (60.4%) stddev-sans-first:3029.19 13:41:59 INFO - PROCESS | 19536 | Values: 1487.0 1526.2 1669.0 1734.8 1779.7 7452.7 7975.7 8007.0 8325.9 8352.1 8005.1 8009.6 8034.4 8073.1 8087.6 2266.4 2278.5 2303.8 2305.9 2310.6 2248.9 2252.3 2261.8 2277.9 2279.0 2261.3 2273.7 2293.8 2318.7 2323.2 2192.8 2200.4 2204.6 2216.2 2220.7 2227.6 2227.9 2237.1 2239.2 2244.5 8208.5 8295.8 8303.4 8303.9 8326.3 4984.5 5106.7 5170.9 5171.3 5180.4 3124.3 3232.9 3285.8 3297.1 3307.0 1031.3 1057.2 1111.2 1116.4 1127.5 11371.9 11406.3 11470.3 11481.4 11489.1 4498.6 4579.7 4676.3 4686.2 4702.5 9646.4 9674.6 9676.8 9683.3 9712.8 5194.9 5221.1 5224.0 5226.0 5235.8 4196.5 4611.1 4638.8 4737.7 4745.2 3840.1 3864.6 3945.7 3963.5 3976.1 1259.3 1291.7 1303.2 1313.6 1321.7 956.8 975.7 980.9 987.4 994.2 5248.9 5401.1 5420.2 5660.9 5840.4 438.0 439.0 444.7 452.5 463.8 3962.7 3987.3 3990.4 4021.0 4028.7 9976.2 10209.6 10246.4 10302.9 10315.3 9983.5 10070.7 10093.6 10162.2 10172.9 7738.5 7791.5 7797.8 7811.9 7983.8 5612.0 5668.6 5720.8 5721.1 5739.4 9062.8 9277.0 9289.4 9369.3 9407.5 9272.0 9325.2 9333.4 9416.6 9473.0 6700.7 7120.8 7272.7 7533.8 7864.6 7697.6 7749.8 7749.8 7793.1 7839.3 6892.9 7078.8 7313.1 7359.2 7485.9 6939.2 7144.6 7144.7 7188.0 7241.5 6438.5 6669.8 6693.2 6717.1 6736.9 4876.6 4961.3 4972.6 5027.3 5072.5 4974.9 4986.9 5000.4 5028.9 5045.4 13:41:59 INFO - PROCESS | 19536 | 13:41:59 INFO - PROCESS | 19536 | [#4] prototype.html Cycles:180 Average:5014.16 Median:5715.76 stddev:1531.28 (26.8%) stddev-sans-first:1494.42 13:41:59 INFO - PROCESS | 19536 | Values: 315.8 324.8 327.7 327.8 329.3 5520.3 5568.4 5591.4 5625.9 5694.0 5563.8 5590.0 5622.9 5631.8 5648.4 4310.3 4321.1 4329.2 4333.6 4343.7 4223.8 4297.4 4307.2 4320.2 4324.0 4190.2 4240.9 4255.4 4267.9 4290.0 4200.9 4220.9 4248.4 4270.2 4272.8 3678.0 3715.6 3719.9 3738.1 3747.4 5354.6 5408.0 5414.8 5424.6 5460.9 4795.7 4801.2 4857.8 4860.8 4871.7 5664.5 5769.7 5772.9 5784.2 5829.6 4116.3 4120.0 4123.4 4138.2 4139.6 5724.7 5873.9 6090.0 6110.3 6160.2 4211.6 4213.6 4215.3 4219.1 4221.1 4248.9 4254.7 4255.8 4273.5 4276.9 4683.3 4867.9 4871.5 4916.7 4927.8 5815.3 5828.0 5894.4 5900.0 5922.8 1530.2 1548.5 1551.1 1553.6 1559.1 990.8 992.9 1005.4 1028.2 1043.7 6066.8 6070.7 6070.8 6086.2 6100.8 6413.9 6476.4 6482.3 6501.4 6518.4 5939.3 6023.9 6045.0 6054.6 6071.4 3449.8 3470.9 3472.2 3474.5 3480.5 6456.5 6624.4 6658.9 6659.3 6707.6 6519.2 6550.0 6550.7 6566.8 6569.3 6496.3 6593.6 6635.5 6656.8 6736.0 6430.8 6439.6 6445.0 6447.7 6479.9 5708.7 6362.8 6387.3 6397.8 6415.1 6191.5 6236.7 6265.8 6282.1 6309.2 4110.6 4115.4 4116.6 4121.5 4145.6 5843.2 6020.4 6049.6 6091.7 6108.5 5854.9 5874.3 5890.1 5897.2 5916.4 5776.2 5888.3 5890.4 5897.7 5935.8 5722.8 5755.7 5777.7 5789.7 5817.2 5950.2 5954.7 5958.6 5959.3 5986.2 5631.6 5751.4 5840.4 5844.3 5876.1 13:41:59 INFO - PROCESS | 19536 | 13:41:59 INFO - PROCESS | 19536 | [#5] yui.html Cycles:180 Average:14819.12 Median:4673.81 stddev:17714.28 (379.0%) stddev-sans-first:17732.54 13:41:59 INFO - PROCESS | 19536 | Values: 767.8 774.5 817.6 820.7 834.8 13868.2 14086.7 14226.0 14335.9 14340.6 13068.9 13140.7 13173.5 13184.8 13232.9 675.9 802.6 820.2 830.4 830.9 823.2 825.2 826.4 827.6 828.0 868.2 870.4 871.2 874.5 874.7 863.1 868.3 868.5 869.6 872.3 623.3 624.7 625.5 630.0 630.5 13805.9 13853.1 13870.8 13903.7 14016.4 13053.5 13217.0 13494.9 13521.9 13713.8 10707.5 10721.6 11021.3 11165.2 11223.0 3734.0 3749.6 3772.5 3802.2 3809.4 54050.0 54482.7 55379.2 55452.0 57883.4 10100.5 10204.7 10644.8 10738.9 10822.6 18625.7 18644.0 18704.4 19619.9 19888.8 7382.7 7383.4 7422.1 7654.7 7660.3 4280.7 4292.9 4554.5 4644.5 4703.1 3359.1 3436.3 3438.2 3444.2 3451.6 541.1 603.1 616.4 617.5 618.0 716.8 727.7 729.8 743.2 758.9 9082.6 9221.2 9269.5 9443.8 9550.5 715.2 727.4 746.6 760.7 772.1 4145.6 4393.9 4421.3 4441.4 4499.9 54922.7 56711.4 56765.7 67151.0 69840.7 49420.5 49502.0 59882.0 60676.4 62182.7 54255.2 54664.0 54820.5 55670.7 55837.7 8824.7 8867.6 8964.3 9022.1 9196.3 33983.0 34076.1 34872.8 35755.3 35823.3 42897.6 46202.5 49819.5 50178.2 50665.2 11659.2 11752.8 12272.7 12392.4 12594.2 12060.3 12119.3 12223.3 12382.0 12671.4 11434.6 11777.0 11801.9 12216.1 12384.8 11572.5 11581.2 11611.0 11638.7 11697.0 10246.3 11086.3 11140.7 11596.7 11618.4 8957.7 9097.1 9294.2 9324.3 9549.3 10170.5 10352.4 10481.3 10601.6 10659.9 13:41:59 INFO - PROCESS | 19536 | -------- Summary: end -------- 13:41:59 INFO - PROCESS | 19536 | 13:42:00 INFO - TEST-INFO | 19536: exit 0 13:42:00 INFO - TEST-OK | dromaeo_css | took 1109794ms 13:42:00 INFO - TEST-START | kraken 13:42:00 INFO - operating with platform_type : linux_ 13:42:00 INFO - Initialising browser for kraken test... 13:42:00 INFO - TEST-INFO | started process 19773 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOAhssj/profile http://localhost:57371/getInfo.html) 13:42:03 INFO - PROCESS | 19773 | 13:42:03 INFO - PROCESS | 19773 | (process:19841): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:42:04 INFO - PROCESS | 19773 | __metrics Screen width/height:1600/1200 13:42:04 INFO - PROCESS | 19773 | colorDepth:24 13:42:04 INFO - PROCESS | 19773 | Browser inner width/height: 1024/697 13:42:04 INFO - PROCESS | 19773 | __metrics 13:42:05 ERROR - PROCESS | 19773 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 13:42:05 INFO - TEST-INFO | 19773: exit 0 13:42:05 INFO - Browser initialized. 13:42:05 INFO - Running cycle 1/1 for kraken test... 13:42:05 INFO - TEST-INFO | started process 19892 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOAhssj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:42:07 INFO - PROCESS | 19892 | 13:42:07 INFO - PROCESS | 19892 | (process:19952): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:42:17 INFO - PROCESS | 19892 | RSS: Main: 164925440 13:42:17 INFO - PROCESS | 19892 | 13:42:20 INFO - PROCESS | 19892 | Cycle 1(1): loaded http://localhost:57371/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57371/tests/kraken/driver.html?testName=audio-beat-detection) 13:42:21 INFO - PROCESS | 19892 | RSS: Main: 169873408 13:42:21 INFO - PROCESS | 19892 | 13:42:23 INFO - PROCESS | 19892 | Cycle 1(1): loaded http://localhost:57371/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57371/tests/kraken/driver.html?testName=audio-dft) 13:42:24 INFO - PROCESS | 19892 | RSS: Main: 173146112 13:42:24 INFO - PROCESS | 19892 | 13:42:27 INFO - PROCESS | 19892 | Cycle 1(1): loaded http://localhost:57371/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57371/tests/kraken/driver.html?testName=audio-fft) 13:42:28 INFO - PROCESS | 19892 | RSS: Main: 164265984 13:42:28 INFO - PROCESS | 19892 | 13:42:30 INFO - PROCESS | 19892 | Cycle 1(1): loaded http://localhost:57371/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57371/tests/kraken/driver.html?testName=audio-oscillator) 13:42:30 INFO - PROCESS | 19892 | RSS: Main: 164691968 13:42:30 INFO - PROCESS | 19892 | 13:42:32 INFO - PROCESS | 19892 | Cycle 1(1): loaded http://localhost:57371/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57371/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:42:33 INFO - PROCESS | 19892 | RSS: Main: 164966400 13:42:33 INFO - PROCESS | 19892 | 13:42:36 INFO - PROCESS | 19892 | Cycle 1(1): loaded http://localhost:57371/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57371/tests/kraken/driver.html?testName=imaging-darkroom) 13:42:37 INFO - PROCESS | 19892 | RSS: Main: 165142528 13:42:37 INFO - PROCESS | 19892 | 13:42:40 INFO - PROCESS | 19892 | Cycle 1(1): loaded http://localhost:57371/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57371/tests/kraken/driver.html?testName=imaging-desaturate) 13:42:41 INFO - PROCESS | 19892 | RSS: Main: 165588992 13:42:41 INFO - PROCESS | 19892 | 13:42:44 INFO - PROCESS | 19892 | Cycle 1(1): loaded http://localhost:57371/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57371/tests/kraken/driver.html?testName=json-parse-financial) 13:42:44 INFO - PROCESS | 19892 | RSS: Main: 168292352 13:42:44 INFO - PROCESS | 19892 | 13:42:46 INFO - PROCESS | 19892 | Cycle 1(1): loaded http://localhost:57371/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57371/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:42:46 INFO - PROCESS | 19892 | RSS: Main: 168005632 13:42:46 INFO - PROCESS | 19892 | 13:42:48 INFO - PROCESS | 19892 | Cycle 1(1): loaded http://localhost:57371/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57371/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:42:49 INFO - PROCESS | 19892 | RSS: Main: 167821312 13:42:49 INFO - PROCESS | 19892 | 13:42:51 INFO - PROCESS | 19892 | Cycle 1(1): loaded http://localhost:57371/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57371/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:42:51 INFO - PROCESS | 19892 | RSS: Main: 168157184 13:42:51 INFO - PROCESS | 19892 | 13:42:54 INFO - PROCESS | 19892 | Cycle 1(1): loaded http://localhost:57371/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57371/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:42:55 INFO - PROCESS | 19892 | RSS: Main: 168771584 13:42:55 INFO - PROCESS | 19892 | 13:42:57 INFO - PROCESS | 19892 | Cycle 1(1): loaded http://localhost:57371/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57371/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:42:58 INFO - PROCESS | 19892 | RSS: Main: 168591360 13:42:58 INFO - PROCESS | 19892 | 13:43:00 INFO - PROCESS | 19892 | Cycle 1(1): loaded http://localhost:57371/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57371/tests/kraken/driver.html?testName=ai-astar) 13:43:00 INFO - PROCESS | 19892 | RSS: Main: 170094592 13:43:00 INFO - PROCESS | 19892 | 13:43:00 INFO - PROCESS | 19892 | __start_tp_report 13:43:00 INFO - PROCESS | 19892 | _x_x_mozilla_page_load 13:43:00 INFO - PROCESS | 19892 | _x_x_mozilla_page_load_details 13:43:00 INFO - PROCESS | 19892 | |i|pagename|runs| 13:43:00 INFO - PROCESS | 19892 | |0;ai-astar;111;105;111;110;111;123;111;109;111;110 13:43:00 INFO - PROCESS | 19892 | |1;audio-beat-detection;154;124;155;181;136;159;160;130;195;128 13:43:00 INFO - PROCESS | 19892 | |2;audio-dft;161;162;164;161;164;163;171;162;165;161 13:43:00 INFO - PROCESS | 19892 | |3;audio-fft;76;83;73;160;74;76;76;76;163;76 13:43:00 INFO - PROCESS | 19892 | |4;audio-oscillator;92;94;156;93;91;93;147;93;92;138 13:43:00 INFO - PROCESS | 19892 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;118;117;118 13:43:00 INFO - PROCESS | 19892 | |6;imaging-darkroom;147;146;146;146;148;148;148;146;147;146 13:43:00 INFO - PROCESS | 19892 | |7;imaging-desaturate;95;95;95;94;95;95;95;95;96;95 13:43:00 INFO - PROCESS | 19892 | |8;json-parse-financial;65;58;58;58;59;60;65;73;57;56 13:43:00 INFO - PROCESS | 19892 | |9;json-stringify-tinderbox;61;60;60;61;61;60;60;60;62;60 13:43:00 INFO - PROCESS | 19892 | |10;stanford-crypto-aes;77;76;77;77;77;78;78;81;78;85 13:43:00 INFO - PROCESS | 19892 | |11;stanford-crypto-ccm;121;124;122;121;127;122;122;126;208;126 13:43:00 INFO - PROCESS | 19892 | |12;stanford-crypto-pbkdf2;169;166;166;166;166;163;170;167;168;162 13:43:00 INFO - PROCESS | 19892 | |13;stanford-crypto-sha256-iterative;70;67;69;68;68;70;68;67;65;66 13:43:00 INFO - PROCESS | 19892 | __end_tp_report 13:43:00 INFO - PROCESS | 19892 | __start_cc_report 13:43:00 INFO - PROCESS | 19892 | _x_x_mozilla_cycle_collect,848 13:43:00 INFO - PROCESS | 19892 | __end_cc_report 13:43:00 INFO - PROCESS | 19892 | __startTimestamp1461616980488__endTimestamp 13:43:00 INFO - PROCESS | 19892 | 13:43:00 INFO - PROCESS | 19892 | ------- Summary: start ------- 13:43:00 INFO - PROCESS | 19892 | Number of tests: 14 13:43:00 INFO - PROCESS | 19892 | 13:43:00 INFO - PROCESS | 19892 | [#0] ai-astar Cycles:10 Average:111.20 Median:111.00 stddev:4.54 (4.1%) stddev-sans-first:4.82 13:43:00 INFO - PROCESS | 19892 | Values: 111.0 105.0 111.0 110.0 111.0 123.0 111.0 109.0 111.0 110.0 13:43:00 INFO - PROCESS | 19892 | 13:43:00 INFO - PROCESS | 19892 | [#1] audio-beat-detection Cycles:10 Average:152.20 Median:157.00 stddev:23.37 (14.9%) stddev-sans-first:24.78 13:43:00 INFO - PROCESS | 19892 | Values: 154.0 124.0 155.0 181.0 136.0 159.0 160.0 130.0 195.0 128.0 13:43:00 INFO - PROCESS | 19892 | 13:43:00 INFO - PROCESS | 19892 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.50 stddev:3.03 (1.9%) stddev-sans-first:3.08 13:43:00 INFO - PROCESS | 19892 | Values: 161.0 162.0 164.0 161.0 164.0 163.0 171.0 162.0 165.0 161.0 13:43:00 INFO - PROCESS | 19892 | 13:43:00 INFO - PROCESS | 19892 | [#3] audio-fft Cycles:10 Average:93.30 Median:76.00 stddev:36.05 (47.4%) stddev-sans-first:37.69 13:43:00 INFO - PROCESS | 19892 | Values: 76.0 83.0 73.0 160.0 74.0 76.0 76.0 76.0 163.0 76.0 13:43:00 INFO - PROCESS | 19892 | 13:43:00 INFO - PROCESS | 19892 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:92.50 stddev:26.64 (28.8%) stddev-sans-first:27.55 13:43:00 INFO - PROCESS | 19892 | Values: 92.0 94.0 156.0 93.0 91.0 93.0 147.0 93.0 92.0 138.0 13:43:00 INFO - PROCESS | 19892 | 13:43:00 INFO - PROCESS | 19892 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 13:43:00 INFO - PROCESS | 19892 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 118.0 13:43:00 INFO - PROCESS | 19892 | 13:43:00 INFO - PROCESS | 19892 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 13:43:00 INFO - PROCESS | 19892 | Values: 147.0 146.0 146.0 146.0 148.0 148.0 148.0 146.0 147.0 146.0 13:43:00 INFO - PROCESS | 19892 | 13:43:00 INFO - PROCESS | 19892 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 13:43:00 INFO - PROCESS | 19892 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 96.0 95.0 13:43:00 INFO - PROCESS | 19892 | 13:43:00 INFO - PROCESS | 19892 | [#8] json-parse-financial Cycles:10 Average:60.90 Median:59.50 stddev:5.26 (8.8%) stddev-sans-first:5.36 13:43:00 INFO - PROCESS | 19892 | Values: 65.0 58.0 58.0 58.0 59.0 60.0 65.0 73.0 57.0 56.0 13:43:00 INFO - PROCESS | 19892 | 13:43:00 INFO - PROCESS | 19892 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:60.50 stddev:0.71 (1.2%) stddev-sans-first:0.73 13:43:00 INFO - PROCESS | 19892 | Values: 61.0 60.0 60.0 61.0 61.0 60.0 60.0 60.0 62.0 60.0 13:43:00 INFO - PROCESS | 19892 | 13:43:00 INFO - PROCESS | 19892 | [#10] stanford-crypto-aes Cycles:10 Average:78.40 Median:78.00 stddev:2.67 (3.4%) stddev-sans-first:2.79 13:43:00 INFO - PROCESS | 19892 | Values: 77.0 76.0 77.0 77.0 77.0 78.0 78.0 81.0 78.0 85.0 13:43:00 INFO - PROCESS | 19892 | 13:43:00 INFO - PROCESS | 19892 | [#11] stanford-crypto-ccm Cycles:10 Average:131.90 Median:125.00 stddev:26.83 (21.5%) stddev-sans-first:28.17 13:43:00 INFO - PROCESS | 19892 | Values: 121.0 124.0 122.0 121.0 127.0 122.0 122.0 126.0 208.0 126.0 13:43:00 INFO - PROCESS | 19892 | 13:43:00 INFO - PROCESS | 19892 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.30 Median:166.50 stddev:2.45 (1.5%) stddev-sans-first:2.40 13:43:00 INFO - PROCESS | 19892 | Values: 169.0 166.0 166.0 166.0 166.0 163.0 170.0 167.0 168.0 162.0 13:43:00 INFO - PROCESS | 19892 | 13:43:00 INFO - PROCESS | 19892 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:1.62 (2.4%) stddev-sans-first:1.51 13:43:00 INFO - PROCESS | 19892 | Values: 70.0 67.0 69.0 68.0 68.0 70.0 68.0 67.0 65.0 66.0 13:43:00 INFO - PROCESS | 19892 | -------- Summary: end -------- 13:43:00 INFO - PROCESS | 19892 | 13:43:01 INFO - TEST-INFO | 19892: exit 0 13:43:01 INFO - TEST-OK | kraken | took 61171ms 13:43:01 INFO - SUITE-END | took 1170s 13:43:01 INFO - Completed test suite (00:19:31) 13:43:01 INFO - javascript benchmark 13:43:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3174.23818283612, 3187.760917931155, 3206.5350524173987, 3221.790583612065, 3223.597050368704, 5348.812791552296, 5408.405075441703, 5412.702301373432, 5417.431169727181, 5497.890042199158, 5450.700211488366, 5479.835604931848, 5527.5301599364, 5559.555235581154, 5560.054790685583, 4961.776720047606, 4984.077945580079, 5025.924611130836, 5055.9241611375855, 5083.085044691954, 4935.383077115361, 5069.366329208849, 5101.285819985186, 5101.974490127544, 5107.821226257081, 4962.0324036812835, 4963.4540200578085, 4979.900401991958, 5003.249512573107, 5047.4447810740785, 4985.052839960396, 5024.67339622927, 5025.321581586476, 5029.145045342264, 5073.289739436482, 5006.249062640597, 5014.172661510846, 5022.383883603799, 5023.874403139914, 5037.924431133536, 5455.481729235717, 5469.425710300401, 5481.314835645544, 5486.61593688442, 5512.118061110203, 5905.763769449217, 5926.318473375574, 5931.851703707399, 5937.050071988504, 5937.881242375129, 5705.115707065412, 5846.269216347957, 5951.3751056139345, 5981.850453738648, 5983.461488466059, 5532.197831314477, 5542.7782888684405, 5558.777648894039, 5566.499015088621, 5593.552515798727, 6047.667378294236, 6053.213082299273, 6065.484433823174, 6068.75724971005, 6075.088736689444, 5697.715114244271, 5732.799352022743, 5784.942150578525, 5830.183774271521, 5831.737571809279, 5887.705614719247, 5894.115882617642, 5896.7641294348605, 5908.0, 5944.940550594525, 5759.136129580513, 5776.768929242783, 5803.245578074823, 5853.502452291517, 5855.677937713466, 5843.2695913010875, 5858.209141765892, 5867.3839246879315, 5874.471297583238, 5930.2883653960935, 4407.294832826797, 4408.140412619572, 4412.161689279027, 4423.336499525032, 4460.843870464518, 3880.3985382265796, 3884.8834534964, 3919.431682406035, 3926.0, 3971.146203566247, 5467.9453205468235, 5611.158326251013, 5645.322561292671, 5688.089905615082, 5692.857678557986, 5867.941320586825, 5883.588148829541, 5889.175515427758, 5892.852678683067, 5902.8819423611285, 5535.0, 5539.25220095282, 5540.058190107691, 5541.251930989265, 5543.750531226105, 4940.777665005012, 5039.21892106724, 5063.11395505785, 5070.923936140961, 5100.744962751847, 5941.108833674897, 5964.821055368346, 5983.940160598426, 6000.0, 6001.36985616504, 5688.288963879515, 5817.680027598522, 5846.619969701956, 5851.882962340729, 5854.209681692917, 5939.673317967553, 5989.550783691154, 6005.249343832021, 6046.546509011754, 6060.878782424239, 5813.128030795246, 5822.214001109796, 5827.213326201078, 5830.387809279964, 5838.416158384128, 5800.332961709458, 5892.086726557391, 5920.230370051866, 5932.644041357532, 5966.373530779206, 5803.593748437737, 5823.242978412779, 5824.0, 5824.271966004249, 5875.794347197828, 5779.479846813807, 5788.855278618068, 5790.594658373873, 5798.5651076168615, 5807.796727114531, 5537.612367134423, 5626.1842032905815, 5690.9430905690415, 5695.544356451391, 5703.230063941315, 5555.194496798023, 5680.573956953162, 5712.34308054579, 5739.426057394227, 5843.29880414336, 5647.661140331593, 5669.262995810518, 5670.319561652628, 5689.6586204827845, 5709.20071190042], "value": 5416.988134448544, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [606.9150318955348, 645.5835985789165, 646.812424396925, 650.7104338569338, 663.0518358746992, 38506.422403663935, 39514.60485395149, 39714.801425992904, 39796.403053954215, 39905.40141897874, 40618.0, 40900.0, 41091.17817643653, 41127.177456450925, 41228.58771412285, 8500.744977650666, 8699.39104262702, 8705.434146780439, 8706.869396959051, 8733.7816554586, 8533.658653653847, 8654.48073115615, 8685.0, 8709.651613935435, 8827.426217295855, 8736.912630873705, 8830.337724670644, 8904.198622124008, 8909.599068041922, 8914.50970196639, 8831.690890818823, 8882.289416846668, 8883.644654213824, 8897.955510222408, 8900.910990890074, 8609.741707748777, 8734.213920747163, 8759.211670949646, 8763.386562940534, 8777.561121943942, 40695.1860962782, 40785.184296314204, 40815.1836963262, 40928.0, 41013.1797364054, 3558.448440491728, 3622.1487950331652, 3632.527771389729, 3721.423179407196, 4121.031557583965, 30698.23254418635, 31296.21759456009, 31344.0, 31437.056888293388, 31713.365732685448, 4190.937135942963, 4204.096119334357, 4279.272523670983, 4295.677824163169, 4467.798949047301, 209926.0, 210887.0, 211009.0, 211656.0, 211923.0, 46794.5320546797, 52104.47895521072, 55514.44485555093, 56531.71734141385, 56618.43381566214, 54652.45347546474, 54894.17658735122, 55079.724601376736, 55186.724066379415, 55469.44530554723, 13742.587722368346, 14021.5277395874, 14027.228502432261, 14049.22729249901, 14152.29238538069, 10830.891691083147, 10894.836577451344, 10977.0, 10986.615468458565, 11069.778604428027, 16658.50024499267, 16781.496555103367, 17329.56676083083, 17351.13244337778, 17396.652066958843, 5948.851278718067, 6114.052321890114, 6114.74647697221, 6166.599171053867, 6202.100695399142, 1057.0222544146634, 1099.7910397024539, 1100.2793170473353, 1168.9473973671206, 1171.0690001448697, 31291.68708312933, 31522.52716209259, 31623.841880790907, 31631.52552711711, 32202.83898580492, 1135.28477059452, 1138.6754774889116, 1140.4582823159099, 1211.4790640024873, 1254.3414707278753, 16737.24058474115, 16851.0, 16997.0, 17116.828831711773, 17194.484165474805, 462578.0, 465498.0, 469622.0, 470084.0, 471561.0, 56742.432575673716, 56800.0, 57260.42739572634, 57453.42546574481, 57473.425265747646, 1325.0790700463085, 1374.6906945937285, 1383.7301726163503, 1397.224540380099, 1492.9626759331104, 30738.385232294782, 30844.22889427782, 31102.37795244128, 31578.526322104728, 31817.0, 44467.33299000582, 44908.77545612251, 44949.77525112354, 44991.77504112459, 45045.0, 403006.0, 406650.0, 407821.0, 408316.0, 410057.0, 40948.0, 41755.37366939438, 42700.0, 43282.78358608187, 43487.78256108699, 48012.7599362001, 48490.51509485001, 48665.0, 48974.510254896995, 48997.26504102512, 40284.39573406343, 40523.39214911838, 41275.38086928758, 41449.79275103605, 42278.154436910474, 40201.58286545677, 40312.59687403206, 40835.79582102071, 42022.15955680808, 42166.36750448807, 38275.42586861143, 38994.4150837732, 39138.80430597829, 39196.41205381865, 41351.0, 31763.68236317607, 32611.34777304488, 32939.0, 35839.28321433609, 36544.0, 26872.0, 27228.863855680596, 27746.306342341602, 28141.155765327072, 28217.57673634856], "value": 19361.145800994414, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.10311592684604, 395.4187344603434, 400.65143325306985, 406.3579544319975, 406.3822989056634, 17965.730514042283, 18646.62706745864, 18822.435326940198, 18878.90560547197, 19965.604127504685, 18381.44855654329, 18421.53946151347, 18709.62580748384, 19476.220951161973, 19601.41195764126, 5561.5272701820195, 5698.116791897252, 5789.073748200289, 5789.218455508516, 5944.7027648617395, 5705.942940570582, 5747.568932330071, 5786.479216870481, 5793.217915581406, 5794.246747922764, 5469.316335458067, 5728.942710572904, 5743.3108027036815, 5755.136729490568, 5770.0, 5660.377358490563, 5734.0, 5734.541236701096, 5738.885222295572, 5760.395158508359, 5260.28986086881, 5516.696581688006, 5540.584456165763, 5541.307336582927, 5554.91667624986, 12320.815187772101, 12941.87058129416, 12942.676433089155, 12962.675933101653, 20710.275140370166, 2197.165077270643, 2205.184081889695, 2314.2247347138727, 2362.0315670575155, 2383.451806084593, 9776.217902567778, 9948.154406875425, 10129.341592796445, 10255.384676919408, 10367.429791361472, 1867.2437662746474, 1943.5918457124021, 1957.9412617621495, 1959.0694420150458, 1960.4412742368356, 68228.3177168227, 71015.2898471019, 77165.61417192934, 82666.58666706688, 85646.0, 9994.252155441709, 10135.239857010754, 10584.788304233873, 10600.734981625521, 10675.0392464677, 14676.192809395372, 14699.412023519153, 14790.556283311518, 14832.777508337384, 14851.331690073972, 7247.311505406978, 7352.77941661751, 7364.815879603053, 7377.446691498159, 7449.441291903129, 6906.343897329745, 7011.92988070123, 7372.705091796268, 7413.962930185315, 7554.357879580188, 4336.696431249846, 4449.644028477714, 4464.2633965396, 4668.929966050512, 4786.305985632064, 1910.6083252933115, 1974.2450756045964, 1976.3280484635293, 1986.6126105409307, 2038.1949130093826, 906.6464079009191, 1014.4116412480744, 1094.485591771866, 1127.763169734365, 1154.342025045716, 18816.776909500837, 18857.151428185764, 19302.613947720965, 19513.512162196057, 20069.29757458482, 1024.2164743970868, 1026.2559644257854, 1028.6913925822223, 1031.4997226345217, 1048.4128887822844, 10661.200409969284, 11039.39283339424, 11100.722481938015, 11149.16381271408, 11173.497192626352, 480636.0, 482674.0, 483478.0, 489079.0, 517351.0, 95960.52019739996, 96910.0, 98739.0, 100997.0, 104654.0, 1028.7068185567077, 1050.2280823594804, 1076.531708706715, 1096.9122470202365, 1102.459794700607, 17109.0, 17119.57201069983, 17149.399771007957, 17231.56921076983, 17272.94531499816, 39402.0, 39959.40060899147, 40512.392314114724, 40530.79734601308, 41544.0, 57554.42445575491, 58400.70799645974, 58637.0, 59623.0, 60129.699351504714, 8412.369072319478, 8505.87241191395, 8529.872051919103, 8626.0, 8744.431611945203, 10082.495875206358, 10909.909009099027, 11132.1650876183, 13482.258475783927, 13864.584062478141, 11672.591459298883, 12018.519259229533, 12097.33464659417, 12157.939210303892, 12247.69380765488, 11420.371879546705, 11609.187356884937, 11847.881521184678, 12179.0, 12295.200811947196, 12043.518259269531, 12080.637580872588, 12092.0, 12162.878371216528, 12296.75406491883, 8933.776655583402, 11469.1055452605, 12596.685082873002, 13002.869971300166, 13131.212127272394, 11606.535738570363, 11757.0, 12060.0, 12257.509699612272, 12395.070369722487], "value": 9137.012456926484, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1486.9628259293515, 1526.1914631162074, 1669.0069408701818, 1734.7831521059868, 1779.6618642457931, 7452.664630091645, 7975.7208497702595, 8007.0, 8325.87511187332, 8352.123027082152, 8005.079415867162, 8009.559474228915, 8034.39742019348, 8073.071596766374, 8087.636056377462, 2266.3994041578994, 2278.51012032413, 2303.7811407916306, 2305.8616483011074, 2310.607196776552, 2248.8875556222206, 2252.279270633398, 2261.7851304126166, 2277.8861056947085, 2279.0314116500504, 2261.3329067925, 2273.6930514380597, 2293.816494680422, 2318.6985691860036, 2323.1984965186984, 2192.802647761709, 2200.3618950504333, 2204.55908818237, 2216.1689366487485, 2220.733511978565, 2227.610168220555, 2227.855189412683, 2237.1387015998794, 2239.2498512998163, 2244.539869326784, 8208.507489550646, 8295.792605184859, 8303.418760686754, 8303.875441868377, 8326.333893288522, 4984.501549845023, 5106.668066575698, 5170.922436163423, 5171.276021356975, 5180.430152683201, 3124.3438877835683, 3232.91917702057, 3285.8192799396024, 3297.142742886843, 3306.9834650826833, 1031.3240983401972, 1057.2123767792966, 1111.2110401614864, 1116.385987706758, 1127.5433449452985, 11371.943140284246, 11406.258593191416, 11470.311781293232, 11481.425928703615, 11489.080873530182, 4498.5501449854755, 4579.6794224403975, 4676.2985552166765, 4686.226772582554, 4702.506236845151, 9646.42121472714, 9674.613015479303, 9676.758081047888, 9683.273754468302, 9712.805743885083, 5194.948050519522, 5221.112410890158, 5224.03355379256, 5225.973870130625, 5235.790568377299, 4196.496420429568, 4611.054733779567, 4638.814447422133, 4737.715737055788, 4745.193317136095, 3840.078381188495, 3864.594217607167, 3945.743526670815, 3963.504561929759, 3976.0855003349393, 1259.2947949148506, 1291.7158225190442, 1303.1724854717322, 1313.6321829887647, 1321.6960099177243, 956.8325543029941, 975.707287813653, 980.8921018687938, 987.3779518903045, 994.1847684898314, 5248.895022099537, 5401.054815407367, 5420.186971954238, 5660.858478537987, 5840.445157710011, 438.0472472372577, 439.0122224993764, 444.7398272010845, 452.5293694557689, 463.76116300105474, 3962.722609417313, 3987.282289187916, 3990.4014397839974, 4020.979895100506, 4028.7179897407486, 9976.201903847676, 10209.591616335412, 10246.38521688701, 10302.896971030194, 10315.27793054479, 9983.450910199863, 10070.69787906364, 10093.646722364829, 10162.18702503798, 10172.949135254275, 7738.458307918391, 7791.532508049535, 7797.805054873674, 7811.921880781233, 7983.760487185394, 5611.971940140274, 5668.631538949955, 5720.771169153188, 5721.113227449752, 5739.446560443128, 9062.818743625223, 9277.0, 9289.396189247676, 9369.250459963323, 9407.482588457427, 9271.953640231755, 9325.160735533835, 9333.393329433566, 9416.62333506652, 9472.95263523678, 6700.66496675174, 7120.786376408716, 7272.672729727069, 7533.849323013618, 7864.606769661608, 7697.576633285223, 7749.806254843674, 7749.806254843674, 7793.142754297136, 7839.33365663925, 6892.931070689429, 7078.787636370917, 7313.122425308997, 7359.153697324876, 7485.850282994418, 6939.167299924042, 7144.64276786169, 7144.714211431485, 7188.0, 7241.456890733321, 6438.484921206386, 6669.833254168685, 6693.196816382066, 6717.1267735194115, 6736.898946515708, 4876.609871210366, 4961.2806143109765, 4972.577330926767, 5027.346444962278, 5072.51811077947, 4974.900501990012, 4986.900261994812, 5000.449950505369, 5028.949710502849, 5045.4450010498085], "value": 4364.70817369732, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.8405005472236, 324.7629230661617, 327.6805115012863, 327.78693848998154, 329.30188001436954, 5520.309961254843, 5568.415316391782, 5591.440855914407, 5625.859353516164, 5694.0, 5563.777448902039, 5590.0, 5622.859428514279, 5631.8028868989495, 5648.406917273689, 4310.288802347609, 4321.135772845428, 4329.155814616143, 4333.566643335673, 4343.674224433164, 4223.767692776896, 4297.419848320468, 4307.203167414023, 4320.243957307459, 4324.005478739876, 4190.245755763961, 4240.872773816791, 4255.404243405926, 4267.850625228118, 4290.0, 4200.85297014603, 4220.894477638069, 4248.4477017987465, 4270.188664153801, 4272.786360681969, 3678.0391784613375, 3715.5727091384565, 3719.888403347904, 3738.140227747633, 3747.362948298796, 5354.571634269249, 5407.972960135214, 5414.756335964891, 5424.647397919122, 5460.863478413032, 4795.736234507101, 4801.231802911552, 4857.82997595086, 4860.781264843055, 4871.732054736988, 5664.49019588239, 5769.711514424262, 5772.853794681909, 5784.16129661201, 5829.562782791308, 4116.341385378325, 4120.011197312653, 4123.402106694512, 4138.172365526877, 4139.627433530966, 5724.742386592613, 5873.913326034697, 6089.969550152266, 6110.297315808694, 6160.168377269056, 4211.642010429148, 4213.557576454428, 4215.292806413346, 4219.113986062961, 4221.134667393177, 4248.936265956013, 4254.723442976197, 4255.808488617958, 4273.487181538173, 4276.893077673083, 4683.250679891269, 4867.902641947141, 4871.5128487151005, 4916.70499770015, 4927.7926907907795, 5815.302163740378, 5827.970860145672, 5894.410558944071, 5899.970500147472, 5922.7927022554, 1530.2348825587205, 1548.481258778322, 1551.06935838496, 1553.5572361877037, 1559.0957244798217, 990.7919336939179, 992.9205663546899, 1005.4319309590204, 1028.2134167361974, 1043.7390652336917, 6066.817995460143, 6070.726817293233, 6070.848228794315, 6086.2087928569, 6100.816975490654, 6413.935860641333, 6476.413278746737, 6482.319356467598, 6501.447376972916, 6518.413342799076, 5939.287285525678, 6023.909641355383, 6044.969775151096, 6054.636721796706, 6071.423214794588, 3449.8098156136093, 3470.8958731238104, 3472.166679996833, 3474.5309383233443, 3480.4953281774, 6456.451201647818, 6624.436922861514, 6658.9001164982565, 6659.300773418819, 6707.564008339442, 6519.217693876765, 6549.967250163814, 6550.737970481127, 6566.80299591013, 6569.310222426672, 6496.252930912911, 6593.637349945799, 6635.5023373247195, 6656.767013154419, 6735.955926831349, 6430.774922877864, 6439.613623182624, 6444.967775161282, 6447.677616119082, 6479.870402592016, 5708.686022268815, 6362.777302794565, 6387.265464471459, 6397.808065758035, 6415.133956915756, 6191.535634827496, 6236.690295038093, 6265.843353916006, 6282.089097080989, 6309.179806625293, 4110.568390319093, 4115.382692596135, 4116.567760385116, 4121.52602450722, 4145.564715704808, 5843.2403787507355, 6020.4280593343565, 6049.606775559574, 6091.664958427329, 6108.511319094373, 5854.912176317273, 5874.265716785402, 5890.145928840208, 5897.233359663216, 5916.437938396018, 5776.191333213437, 5888.263967004124, 5890.440408161217, 5897.67562784051, 5935.762569497172, 5722.828315150552, 5755.7122143893475, 5777.6822274775295, 5789.739461724148, 5817.156512305776, 5950.166976623363, 5954.7320370582565, 5958.553108516792, 5959.28488581373, 5986.221791167294, 5631.577631677723, 5751.424857514216, 5840.415958404125, 5844.298684157929, 5876.08920617305], "value": 4522.05145021374, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [767.8272388712538, 774.477227871187, 817.5952903312857, 820.7168526858231, 834.7662654456747, 13868.1679099254, 14086.718265634681, 14226.0, 14335.928320358384, 14340.569782906503, 13068.93465532671, 13140.671483212924, 13173.538926137588, 13184.802227966587, 13232.867671323284, 675.9222689390709, 802.6187560908551, 820.1552401026952, 830.4436027861317, 830.900291964965, 823.2302796884902, 825.1748251748252, 826.396730386818, 827.6027506796742, 827.9503229806231, 868.1925808997661, 870.4342177584589, 871.1810897756089, 874.5059041641484, 874.7332063720563, 863.0765081362944, 868.3227082875368, 868.5396739727954, 869.6477926439802, 872.3326655108847, 623.2583225961092, 624.7407325959721, 625.4589779840405, 630.0045927434688, 630.4609558827183, 13805.861941380557, 13853.099548529313, 13870.791938120936, 13903.721925561433, 14016.43934242629, 13053.54312599064, 13217.0, 13494.932525337408, 13521.932390337985, 13713.794293085612, 10707.464626768631, 10721.62474313403, 11021.283616564897, 11165.218434709574, 11223.046041086518, 3733.9813300933592, 3749.643783840531, 3772.512982029491, 3802.201537677091, 3809.3904975204114, 54050.0, 54482.72758636221, 55379.16931246035, 55452.0, 57883.421165787804, 10100.494975251355, 10204.693859184237, 10644.787104257872, 10738.94630526858, 10822.621208257831, 18625.7206141908, 18644.0, 18704.438866834018, 19619.901900490408, 19888.801111988694, 7382.667779949915, 7383.372413344819, 7422.072240969879, 7654.655540500691, 7660.3488703460835, 4280.72175308604, 4292.892677683083, 4554.476235232924, 4644.535546445396, 4703.082898834695, 3359.143418428334, 3436.278381539905, 3438.2435864109857, 3444.156181735441, 3451.5858097028017, 541.1142169539153, 603.1405247522263, 616.4205646692095, 617.5029101573186, 618.0204376063989, 716.759885438384, 727.7016423266541, 729.773770131261, 743.1750756660103, 758.852023855354, 9082.591283392263, 9221.216196623362, 9269.536523173814, 9443.763905902408, 9550.522473876417, 715.1596873673413, 727.421699748701, 746.5931067568189, 760.69572171132, 772.0889350566385, 4145.647619952278, 4393.912121757611, 4421.270490369117, 4441.444819397575, 4499.88750281239, 54922.72538637281, 56711.43288567144, 56765.71617141888, 67151.0, 69840.65079674569, 49420.505794942306, 49502.0, 59882.0, 60676.39323606707, 62182.68908655518, 54255.186172207446, 54664.0, 54820.45179548233, 55670.72164639151, 55837.720811396495, 8824.735257942271, 8867.600957956778, 8964.296783611093, 9022.097790220925, 9196.26429885621, 33983.0, 34076.14809629779, 34872.82563587267, 35755.28489430249, 35823.28353432865, 42897.571024290606, 46202.53797461982, 49819.50180498294, 50178.247326289405, 50665.24002139897, 11659.242149260272, 11752.76494470123, 12272.693182670504, 12392.442340094538, 12594.24434533931, 12060.336681482251, 12119.333436661069, 12223.327716975651, 12382.0, 12671.429785659851, 11434.599789007345, 11777.003829557392, 11801.940990294994, 12216.144869859025, 12384.75230495403, 11572.537098515964, 11581.189316747746, 11611.0, 11638.72719829859, 11697.0, 10246.282760206714, 11086.334819910831, 11140.721481963015, 11596.710082248012, 11618.360990145286, 8957.686480973396, 9097.13577210164, 9294.209992150743, 9324.254059675346, 9549.331546791936, 10170.542325595514, 10352.430616316175, 10481.266311358131, 10601.575936962436, 10659.94670026645], "value": 6638.515324918284, "unit": "score"}], "name": "dromaeo_css", "value": 7076.463660654202, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 111.0, 110.0, 111.0, 123.0, 111.0, 109.0, 111.0, 110.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 124.0, 155.0, 181.0, 136.0, 159.0, 160.0, 130.0, 195.0, 128.0], "value": 152.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 164.0, 161.0, 164.0, 163.0, 171.0, 162.0, 165.0, 161.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 83.0, 73.0, 160.0, 74.0, 76.0, 76.0, 76.0, 163.0, 76.0], "value": 93.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 156.0, 93.0, 91.0, 93.0, 147.0, 93.0, 92.0, 138.0], "value": 108.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 148.0, 148.0, 148.0, 146.0, 147.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 58.0, 58.0, 58.0, 59.0, 60.0, 65.0, 73.0, 57.0, 56.0], "value": 60.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 61.0, 61.0, 60.0, 60.0, 60.0, 62.0, 60.0], "value": 60.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 77.0, 77.0, 78.0, 78.0, 81.0, 78.0, 85.0], "value": 78.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 124.0, 122.0, 121.0, 127.0, 122.0, 122.0, 126.0, 208.0, 126.0], "value": 131.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 166.0, 166.0, 166.0, 166.0, 163.0, 170.0, 167.0, 168.0, 162.0], "value": 166.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 69.0, 68.0, 68.0, 70.0, 68.0, 67.0, 65.0, 66.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1553.8000000000002, "alertThreshold": 2.0}]} 13:43:01 INFO - Return code: 0 13:43:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:43:01 ERROR - # TBPL SUCCESS # 13:43:01 INFO - Running post-action listener: _resource_record_post_action 13:43:01 INFO - Running post-run listener: _resource_record_post_run 13:43:02 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 536969216; Read time: 8; Write time: 426136 13:43:02 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244592640; Read time: 0; Write time: 260804 13:43:02 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292376576; Read time: 8; Write time: 165332 13:43:02 INFO - Running post-run listener: _upload_blobber_files 13:43:02 INFO - Blob upload gear active. 13:43:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:43:02 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:43:02 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'] 13:43:02 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 13:43:03 INFO - (blobuploader) - INFO - Open directory for files ... 13:43:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:43:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:43:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:43:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:43:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:43:04 INFO - (blobuploader) - INFO - Done attempting. 13:43:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:43:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:43:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:43:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:43:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:43:05 INFO - (blobuploader) - INFO - Done attempting. 13:43:05 INFO - (blobuploader) - INFO - Iteration through files over. 13:43:05 INFO - Return code: 0 13:43:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:43:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:43:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ceae24ea444828fbf64f1f6b56370d2fd496dcba185c1cbffa8f01cca4d69904ff5f851418bb885491458e559ad529a0bbb62d2c6961762b2618acb44823226", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a8fcece8ae698737462e961e03b5f8334bd8b5c48982a4b966082be750428f5b362fc4e9c4b8a5d04ee783b7debe6893953a8268e34aad9c382e6548dc5da25"} 13:43:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:43:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:43:05 INFO - Contents: 13:43:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ceae24ea444828fbf64f1f6b56370d2fd496dcba185c1cbffa8f01cca4d69904ff5f851418bb885491458e559ad529a0bbb62d2c6961762b2618acb44823226", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a8fcece8ae698737462e961e03b5f8334bd8b5c48982a4b966082be750428f5b362fc4e9c4b8a5d04ee783b7debe6893953a8268e34aad9c382e6548dc5da25"} 13:43:05 INFO - Running post-run listener: copy_logs_to_upload_dir 13:43:05 INFO - Copying logs to upload dir... 13:43:05 INFO - mkdir: /builds/slave/test/build/upload/logs 13:43:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.722614 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-04-25 13:43:05.015135) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 13:43:05.018574) ========= 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=32c5991c409366f7fec8a718000001d2-1461615687.559999-824256985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ceae24ea444828fbf64f1f6b56370d2fd496dcba185c1cbffa8f01cca4d69904ff5f851418bb885491458e559ad529a0bbb62d2c6961762b2618acb44823226", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a8fcece8ae698737462e961e03b5f8334bd8b5c48982a4b966082be750428f5b362fc4e9c4b8a5d04ee783b7debe6893953a8268e34aad9c382e6548dc5da25"} build_url:https://queue.taskcluster.net/v1/task/RvEmcoRSQRKXtBB_HaBodw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011148 build_url: 'https://queue.taskcluster.net/v1/task/RvEmcoRSQRKXtBB_HaBodw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ceae24ea444828fbf64f1f6b56370d2fd496dcba185c1cbffa8f01cca4d69904ff5f851418bb885491458e559ad529a0bbb62d2c6961762b2618acb44823226", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a8fcece8ae698737462e961e03b5f8334bd8b5c48982a4b966082be750428f5b362fc4e9c4b8a5d04ee783b7debe6893953a8268e34aad9c382e6548dc5da25"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 13:43:05.043668) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:43:05.044019) ========= 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=32c5991c409366f7fec8a718000001d2-1461615687.559999-824256985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004451 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:43:05.132203) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 13:43:05.132851) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 13:43:05.133535) ========= ========= Total master_lag: 0.84 =========