builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-004 starttime: 1468476058.77 results: success (0) buildid: 20160713154642 builduid: 0219f93640ac4a39933847396c8d0f21 revision: 84c59d136a9e54be69571b75a19e8a8ccff7b8a1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 23:00:58.772618) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 23:00:58.773602) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 23:00:58.774319) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 23:00:58.790653) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:00:58.791348) ========= 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=c6927cf182745ad25b1d38b9000001fe-1468476058.395810-1770045172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-13 23:00:59-- 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% 227M=0s 2016-07-13 23:00:59 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105240 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:00:58.912279) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:00:58.912614) ========= 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=c6927cf182745ad25b1d38b9000001fe-1468476058.395810-1770045172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020623 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:00:58.962315) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-13 23:00:58.962695) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 84c59d136a9e54be69571b75a19e8a8ccff7b8a1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 84c59d136a9e54be69571b75a19e8a8ccff7b8a1 --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=c6927cf182745ad25b1d38b9000001fe-1468476058.395810-1770045172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-13 23:00:59,380 truncating revision to first 12 chars 2016-07-13 23:00:59,380 Setting DEBUG logging. 2016-07-13 23:00:59,380 attempt 1/10 2016-07-13 23:00:59,380 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/84c59d136a9e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 23:01:00,052 unpacking tar archive at: mozilla-beta-84c59d136a9e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.017537 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-13 23:00:59.998434) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 23:00:59.998807) ========= script_repo_revision: 84c59d136a9e54be69571b75a19e8a8ccff7b8a1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 23:00:59.999271) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 23:00:59.999584) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 23:01:00.010727) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 23 secs) (at 2016-07-13 23:01:00.011041) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=c6927cf182745ad25b1d38b9000001fe-1468476058.395810-1770045172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:01:00 INFO - MultiFileLogger online at 20160713 23:01:00 in /builds/slave/test 23:01:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 23:01:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:01:00 INFO - {'append_to_log': False, 23:01:00 INFO - 'base_work_dir': '/builds/slave/test', 23:01:00 INFO - 'blob_upload_branch': 'Mozilla-Beta', 23:01:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:01:00 INFO - 'branch': 'Mozilla-Beta', 23:01:00 INFO - 'buildbot_json_path': 'buildprops.json', 23:01:00 INFO - 'config_files': ('talos/linux_config.py',), 23:01:00 INFO - 'default_actions': ('clobber', 23:01:00 INFO - 'read-buildbot-config', 23:01:00 INFO - 'download-and-extract', 23:01:00 INFO - 'populate-webroot', 23:01:00 INFO - 'create-virtualenv', 23:01:00 INFO - 'install', 23:01:00 INFO - 'run-tests'), 23:01:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:01:00 INFO - 'download_minidump_stackwalk': True, 23:01:00 INFO - 'download_symbols': 'ondemand', 23:01:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:01:00 INFO - 'tooltool.py': '/tools/tooltool.py', 23:01:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:01:00 INFO - '/tools/misc-python/virtualenv.py')}, 23:01:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:01:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:01:00 INFO - 'installer_path': 'installer.exe', 23:01:00 INFO - 'log_level': 'info', 23:01:00 INFO - 'log_name': 'talos', 23:01:00 INFO - 'log_to_console': True, 23:01:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:01:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:01:00 INFO - 'opt_config_files': (), 23:01:00 INFO - 'pip_index': False, 23:01:00 INFO - 'sps_profile': False, 23:01:00 INFO - 'sps_profile_interval': 0, 23:01:00 INFO - 'suite': 'dromaeojs', 23:01:00 INFO - 'system_bits': '32', 23:01:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:01:00 INFO - 'title': 'talos-linux64-ix-004', 23:01:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:01:00 INFO - 'use_talos_json': True, 23:01:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:01:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:01:00 INFO - 'work_dir': 'build'} 23:01:00 INFO - ##### 23:01:00 INFO - ##### Running clobber step. 23:01:00 INFO - ##### 23:01:00 INFO - Running pre-action listener: _resource_record_pre_action 23:01:00 INFO - Running main action method: clobber 23:01:00 INFO - rmtree: /builds/slave/test/build 23:01:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:01:00 INFO - Running post-action listener: _resource_record_post_action 23:01:00 INFO - ##### 23:01:00 INFO - ##### Running read-buildbot-config step. 23:01:00 INFO - ##### 23:01:00 INFO - Running pre-action listener: _resource_record_pre_action 23:01:00 INFO - Running main action method: read_buildbot_config 23:01:00 INFO - Using buildbot properties: 23:01:00 INFO - { 23:01:00 INFO - "project": "", 23:01:00 INFO - "product": "firefox", 23:01:00 INFO - "script_repo_revision": "production", 23:01:00 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 23:01:00 INFO - "repository": "", 23:01:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 23:01:00 INFO - "buildid": "20160713154642", 23:01:00 INFO - "pgo_build": "True", 23:01:00 INFO - "basedir": "/builds/slave/test", 23:01:00 INFO - "buildnumber": 168, 23:01:00 INFO - "slavename": "talos-linux64-ix-004", 23:01:00 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:01:00 INFO - "platform": "ubuntu64_hw", 23:01:00 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 23:01:00 INFO - "branch": "mozilla-beta", 23:01:00 INFO - "repo_path": "releases/mozilla-beta", 23:01:00 INFO - "revision": "84c59d136a9e54be69571b75a19e8a8ccff7b8a1", 23:01:00 INFO - "stage_platform": "linux64-pgo", 23:01:00 INFO - "builduid": "0219f93640ac4a39933847396c8d0f21", 23:01:00 INFO - "slavebuilddir": "test" 23:01:00 INFO - } 23:01:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 23:01:00 INFO - Running post-action listener: _resource_record_post_action 23:01:00 INFO - ##### 23:01:00 INFO - ##### Running download-and-extract step. 23:01:00 INFO - ##### 23:01:00 INFO - Running pre-action listener: _resource_record_pre_action 23:01:00 INFO - Running main action method: download_and_extract 23:01:00 INFO - mkdir: /builds/slave/test/build/tests 23:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:01:00 INFO - https://queue.taskcluster.net/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:01:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 23:01:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 23:01:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 23:01:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:01:01 INFO - Downloaded 1327 bytes. 23:01:01 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 23:01:01 INFO - Using the following test package requirements: 23:01:01 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 23:01:01 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:01:01 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 23:01:01 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:01:01 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 23:01:01 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:01:01 INFO - u'jsshell-linux-x86_64.zip'], 23:01:01 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:01:01 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 23:01:01 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 23:01:01 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:01:01 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 23:01:01 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:01:01 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 23:01:01 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:01:01 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 23:01:01 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:01:01 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 23:01:01 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:01: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')]} 23:01:01 INFO - https://queue.taskcluster.net/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:01:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:01:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:01:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:01:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:01:02 INFO - Downloaded 24199658 bytes. 23:01:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:01:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:01:03 INFO - Return code: 0 23:01:03 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:01:03 INFO - https://queue.taskcluster.net/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:01:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:01:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:01:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:01:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:01:04 INFO - Downloaded 24199658 bytes. 23:01:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:01:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:01:06 INFO - Return code: 0 23:01:06 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')]} 23:01:06 INFO - https://queue.taskcluster.net/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:01:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 23:01:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 23:01:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 23:01:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:01:07 INFO - Downloaded 10840145 bytes. 23:01:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:01:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 23:01:07 INFO - Return code: 0 23:01:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:01:07 INFO - https://queue.taskcluster.net/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:01:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 23:01:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 23:01:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 23:01:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:01:08 INFO - Downloaded 56027951 bytes. 23:01:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 23:01:08 INFO - mkdir: /builds/slave/test/properties 23:01:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:01:08 INFO - Writing to file /builds/slave/test/properties/build_url 23:01:08 INFO - Contents: 23:01:08 INFO - build_url:https://queue.taskcluster.net/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 23:01:09 INFO - Running post-action listener: _resource_record_post_action 23:01:09 INFO - Running post-action listener: set_extra_try_arguments 23:01:09 INFO - ##### 23:01:09 INFO - ##### Running populate-webroot step. 23:01:09 INFO - ##### 23:01:09 INFO - Running pre-action listener: _resource_record_pre_action 23:01:09 INFO - Running main action method: populate_webroot 23:01:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:01:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:01:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:01:09 INFO - '--tppagecycles', 23:01:09 INFO - '7'], 23:01:09 INFO - 'tests': ['tsvgm']}}, 23:01:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:01:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:01:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:01:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:01:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:01:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:01:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:01:09 INFO - 'talos_options': ['--disable-e10s'], 23:01:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:01:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:01:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:01:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:01:09 INFO - 'talos_options': ['--disable-e10s'], 23:01:09 INFO - 'tests': ['damp', 'tps']}, 23:01:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:01:09 INFO - 'tests': ['damp', 'tps']}, 23:01:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:01:09 INFO - 'tests': ['dromaeo_dom']}, 23:01:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:01:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:01:09 INFO - 'tests': ['a11yr', 23:01:09 INFO - 'ts_paint', 23:01:09 INFO - 'tpaint', 23:01:09 INFO - 'sessionrestore', 23:01:09 INFO - 'sessionrestore_no_auto_restore', 23:01:09 INFO - 'tabpaint']}, 23:01:09 INFO - 'other-e10s': {'tests': ['a11yr', 23:01:09 INFO - 'ts_paint', 23:01:09 INFO - 'tpaint', 23:01:09 INFO - 'sessionrestore', 23:01:09 INFO - 'sessionrestore_no_auto_restore', 23:01:09 INFO - 'tabpaint']}, 23:01:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:01:09 INFO - 'ts_paint', 23:01:09 INFO - 'tpaint', 23:01:09 INFO - 'sessionrestore', 23:01:09 INFO - 'sessionrestore_no_auto_restore', 23:01:09 INFO - 'tabpaint']}, 23:01:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:01:09 INFO - 'ts_paint', 23:01:09 INFO - 'tpaint', 23:01:09 INFO - 'sessionrestore', 23:01:09 INFO - 'sessionrestore_no_auto_restore', 23:01:09 INFO - 'tabpaint']}, 23:01:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:01:09 INFO - 'tests': ['a11yr', 23:01:09 INFO - 'ts_paint', 23:01:09 INFO - 'tpaint', 23:01:09 INFO - 'sessionrestore', 23:01:09 INFO - 'sessionrestore_no_auto_restore', 23:01:09 INFO - 'tabpaint']}, 23:01:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:01:09 INFO - 'tests': ['a11yr', 23:01:09 INFO - 'ts_paint', 23:01:09 INFO - 'tpaint', 23:01:09 INFO - 'sessionrestore', 23:01:09 INFO - 'sessionrestore_no_auto_restore', 23:01:09 INFO - 'tabpaint']}, 23:01:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:01:09 INFO - 'tests': ['tsvgx', 23:01:09 INFO - 'tsvgr_opacity', 23:01:09 INFO - 'tart', 23:01:09 INFO - 'tscrollx', 23:01:09 INFO - 'cart']}, 23:01:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:01:09 INFO - 'tsvgr_opacity', 23:01:09 INFO - 'tart', 23:01:09 INFO - 'tscrollx', 23:01:09 INFO - 'cart']}, 23:01:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:01:09 INFO - 'talos_options': ['--disable-e10s'], 23:01:09 INFO - 'tests': ['tp5o']}, 23:01:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:01:09 INFO - 'tests': ['tp5o']}, 23:01:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:01:09 INFO - 'talos_options': ['--disable-e10s', 23:01:09 INFO - '--xperf_path', 23:01:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:01:09 INFO - 'tests': ['tp5n']}, 23:01:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:01:09 INFO - 'talos_options': ['--xperf_path', 23:01:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:01:09 INFO - 'tests': ['tp5n']}}, 23:01:09 INFO - 'talos.zip': {'path': '', 23:01:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:01:09 INFO - Running post-action listener: _resource_record_post_action 23:01:09 INFO - ##### 23:01:09 INFO - ##### Running create-virtualenv step. 23:01:09 INFO - ##### 23:01:09 INFO - Running pre-action listener: _resource_record_pre_action 23:01:09 INFO - Running main action method: create_virtualenv 23:01:09 INFO - Creating virtualenv /builds/slave/test/build/venv 23:01:09 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 23:01:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:01:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:01:09 INFO - Using real prefix '/usr' 23:01:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:01:10 INFO - Installing distribute.............................................................................................................................................................................................done. 23:01:12 INFO - Installing pip.................done. 23:01:12 INFO - Return code: 0 23:01:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:01:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:01:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:01:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:01:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4b505fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29f85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a87410>, '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 0x2a88310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a887a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468476058.395810-1770045172', '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 23:01:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:01:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:01:12 INFO - Using env: {'DISPLAY': ':0', 23:01:12 INFO - 'HOME': '/home/cltbld', 23:01:12 INFO - 'LANG': 'en_US.UTF-8', 23:01:12 INFO - 'LANGUAGE': 'en_US:en', 23:01:12 INFO - 'LOGNAME': 'cltbld', 23:01:12 INFO - 'MAIL': '/var/mail/cltbld', 23:01:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:12 INFO - 'MOZ_NO_REMOTE': '1', 23:01:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:01:12 INFO - 'NO_EM_RESTART': '1', 23:01:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:01:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:12 INFO - 'PWD': '/builds/slave/test', 23:01:12 INFO - 'SHELL': '/bin/bash', 23:01:12 INFO - 'SHLVL': '1', 23:01:12 INFO - 'TERM': 'linux', 23:01:12 INFO - 'TMOUT': '86400', 23:01:12 INFO - 'USER': 'cltbld', 23:01:12 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468476058.395810-1770045172', 23:01:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:12 INFO - '_': '/tools/buildbot/bin/python'} 23:01:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:01:12 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 23:01:12 INFO - Cleaning up... 23:01:12 INFO - Return code: 0 23:01:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:01:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:01:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:01:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:01:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4b505fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29f85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a87410>, '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 0x2a88310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a887a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468476058.395810-1770045172', '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 23:01:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 23:01:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 23:01:12 INFO - Using env: {'DISPLAY': ':0', 23:01:12 INFO - 'HOME': '/home/cltbld', 23:01:12 INFO - 'LANG': 'en_US.UTF-8', 23:01:12 INFO - 'LANGUAGE': 'en_US:en', 23:01:12 INFO - 'LOGNAME': 'cltbld', 23:01:12 INFO - 'MAIL': '/var/mail/cltbld', 23:01:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:12 INFO - 'MOZ_NO_REMOTE': '1', 23:01:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:01:12 INFO - 'NO_EM_RESTART': '1', 23:01:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:01:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:12 INFO - 'PWD': '/builds/slave/test', 23:01:12 INFO - 'SHELL': '/bin/bash', 23:01:12 INFO - 'SHLVL': '1', 23:01:12 INFO - 'TERM': 'linux', 23:01:12 INFO - 'TMOUT': '86400', 23:01:12 INFO - 'USER': 'cltbld', 23:01:12 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468476058.395810-1770045172', 23:01:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:12 INFO - '_': '/tools/buildbot/bin/python'} 23:01:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:01:12 INFO - Downloading/unpacking psutil>=0.7.1 23:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:01:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:01:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:01:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:01:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:01:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:01:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:01:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:01:14 INFO - Installing collected packages: psutil 23:01:14 INFO - Running setup.py install for psutil 23:01:14 INFO - building 'psutil._psutil_linux' extension 23:01:14 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 23:01:15 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 23:01:15 INFO - building 'psutil._psutil_posix' extension 23:01:15 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 23:01:15 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 23:01:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:01:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:01:15 INFO - Successfully installed psutil 23:01:15 INFO - Cleaning up... 23:01:15 INFO - Return code: 0 23:01:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:01:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:01:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:01:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:01:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:01:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4b505fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29f85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a87410>, '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 0x2a88310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a887a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468476058.395810-1770045172', '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 23:01:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 23:01:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 23:01:15 INFO - Using env: {'DISPLAY': ':0', 23:01:15 INFO - 'HOME': '/home/cltbld', 23:01:15 INFO - 'LANG': 'en_US.UTF-8', 23:01:15 INFO - 'LANGUAGE': 'en_US:en', 23:01:15 INFO - 'LOGNAME': 'cltbld', 23:01:15 INFO - 'MAIL': '/var/mail/cltbld', 23:01:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:15 INFO - 'MOZ_NO_REMOTE': '1', 23:01:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:01:15 INFO - 'NO_EM_RESTART': '1', 23:01:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:01:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:15 INFO - 'PWD': '/builds/slave/test', 23:01:15 INFO - 'SHELL': '/bin/bash', 23:01:15 INFO - 'SHLVL': '1', 23:01:15 INFO - 'TERM': 'linux', 23:01:15 INFO - 'TMOUT': '86400', 23:01:15 INFO - 'USER': 'cltbld', 23:01:15 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468476058.395810-1770045172', 23:01:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:15 INFO - '_': '/tools/buildbot/bin/python'} 23:01:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:01:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:01:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:01:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:01:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:01:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:01:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:01:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:01:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:01:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:01:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:01:17 INFO - Installing collected packages: mozsystemmonitor 23:01:17 INFO - Running setup.py install for mozsystemmonitor 23:01:17 INFO - Successfully installed mozsystemmonitor 23:01:17 INFO - Cleaning up... 23:01:17 INFO - Return code: 0 23:01:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:01:17 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')]} 23:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:01:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:17 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')]} 23:01:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:01:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:17 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 0x7f4b505fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29f85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a87410>, '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 0x2a88310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a887a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468476058.395810-1770045172', '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 23:01:17 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 23:01:17 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 23:01:17 INFO - Using env: {'DISPLAY': ':0', 23:01:17 INFO - 'HOME': '/home/cltbld', 23:01:17 INFO - 'LANG': 'en_US.UTF-8', 23:01:17 INFO - 'LANGUAGE': 'en_US:en', 23:01:17 INFO - 'LOGNAME': 'cltbld', 23:01:17 INFO - 'MAIL': '/var/mail/cltbld', 23:01:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:17 INFO - 'MOZ_NO_REMOTE': '1', 23:01:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:01:17 INFO - 'NO_EM_RESTART': '1', 23:01:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:01:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:17 INFO - 'PWD': '/builds/slave/test', 23:01:17 INFO - 'SHELL': '/bin/bash', 23:01:17 INFO - 'SHLVL': '1', 23:01:17 INFO - 'TERM': 'linux', 23:01:17 INFO - 'TMOUT': '86400', 23:01:17 INFO - 'USER': 'cltbld', 23:01:17 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468476058.395810-1770045172', 23:01:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:17 INFO - '_': '/tools/buildbot/bin/python'} 23:01:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:01:17 INFO - Downloading/unpacking blobuploader==1.2.4 23:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:01:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:01:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:01:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:01:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:01:19 INFO - Downloading blobuploader-1.2.4.tar.gz 23:01:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:01:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:01:19 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 23:01:19 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 23:01:19 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 23:01:19 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 23:01:19 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 23:01:19 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 23:01:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:01:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:01:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:01:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:01:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:01:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:01:20 INFO - Downloading docopt-0.6.1.tar.gz 23:01:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:01:20 INFO - Installing collected packages: blobuploader, requests, docopt 23:01:20 INFO - Running setup.py install for blobuploader 23:01:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:01:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:01:20 INFO - Running setup.py install for requests 23:01:20 INFO - Running setup.py install for docopt 23:01:21 INFO - Successfully installed blobuploader requests docopt 23:01:21 INFO - Cleaning up... 23:01:21 INFO - Return code: 0 23:01:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:01:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:01:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:01:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:01:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:21 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 0x7f4b505fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29f85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a87410>, '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 0x2a88310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a887a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468476058.395810-1770045172', '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 23:01:21 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 23:01:21 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 23:01:21 INFO - Using env: {'DISPLAY': ':0', 23:01:21 INFO - 'HOME': '/home/cltbld', 23:01:21 INFO - 'LANG': 'en_US.UTF-8', 23:01:21 INFO - 'LANGUAGE': 'en_US:en', 23:01:21 INFO - 'LOGNAME': 'cltbld', 23:01:21 INFO - 'MAIL': '/var/mail/cltbld', 23:01:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:21 INFO - 'MOZ_NO_REMOTE': '1', 23:01:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:01:21 INFO - 'NO_EM_RESTART': '1', 23:01:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:01:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:21 INFO - 'PWD': '/builds/slave/test', 23:01:21 INFO - 'SHELL': '/bin/bash', 23:01:21 INFO - 'SHLVL': '1', 23:01:21 INFO - 'TERM': 'linux', 23:01:21 INFO - 'TMOUT': '86400', 23:01:21 INFO - 'USER': 'cltbld', 23:01:21 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468476058.395810-1770045172', 23:01:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:21 INFO - '_': '/tools/buildbot/bin/python'} 23:01:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:01:21 INFO - Running setup.py (path:/tmp/pip-gYMegL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:01:21 INFO - Running setup.py (path:/tmp/pip-SWqgk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:01:21 INFO - Running setup.py (path:/tmp/pip-cD4KWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:01:21 INFO - Running setup.py (path:/tmp/pip-soekh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:01:21 INFO - Running setup.py (path:/tmp/pip-jGFAJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:01:21 INFO - Running setup.py (path:/tmp/pip-5UfMzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:01:21 INFO - Running setup.py (path:/tmp/pip-NljEhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:01:21 INFO - Running setup.py (path:/tmp/pip-p5uLrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:01:21 INFO - Running setup.py (path:/tmp/pip-MUgZvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:01:21 INFO - Running setup.py (path:/tmp/pip-cOLquA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:01:22 INFO - Running setup.py (path:/tmp/pip-KO_GWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:01:22 INFO - Running setup.py (path:/tmp/pip-yvv1VG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:01:22 INFO - Running setup.py (path:/tmp/pip-izFwW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:01:22 INFO - Running setup.py (path:/tmp/pip-2e7sEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:01:22 INFO - Running setup.py (path:/tmp/pip-kD_Cgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:01:22 INFO - Running setup.py (path:/tmp/pip-pXyr77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:01:22 INFO - Running setup.py (path:/tmp/pip-Q3ArMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:01:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:01:22 INFO - Running setup.py install for manifestparser 23:01:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:01:22 INFO - Running setup.py install for mozcrash 23:01:22 INFO - Running setup.py install for mozdebug 23:01:22 INFO - Running setup.py install for mozdevice 23:01:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:01:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:01:22 INFO - Running setup.py install for mozfile 23:01:23 INFO - Running setup.py install for mozhttpd 23:01:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:01:23 INFO - Running setup.py install for mozinfo 23:01:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:01:23 INFO - Running setup.py install for mozInstall 23:01:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:01:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:01:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:01:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:01:23 INFO - Running setup.py install for mozleak 23:01:23 INFO - Running setup.py install for mozlog 23:01:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:01:23 INFO - Running setup.py install for moznetwork 23:01:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:01:23 INFO - Running setup.py install for mozprocess 23:01:23 INFO - Running setup.py install for mozprofile 23:01:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:01:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:01:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:01:23 INFO - Running setup.py install for mozrunner 23:01:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:01:24 INFO - Running setup.py install for mozscreenshot 23:01:24 INFO - Running setup.py install for moztest 23:01:24 INFO - Running setup.py install for mozversion 23:01:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:01:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:01:24 INFO - Cleaning up... 23:01:24 INFO - Return code: 0 23:01:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:01:24 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')]} 23:01:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:01:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:24 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')]} 23:01:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:01:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:24 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 0x7f4b505fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29f85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a87410>, '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 0x2a88310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a887a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468476058.395810-1770045172', '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 23:01:24 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 23:01:24 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 23:01:24 INFO - Using env: {'DISPLAY': ':0', 23:01:24 INFO - 'HOME': '/home/cltbld', 23:01:24 INFO - 'LANG': 'en_US.UTF-8', 23:01:24 INFO - 'LANGUAGE': 'en_US:en', 23:01:24 INFO - 'LOGNAME': 'cltbld', 23:01:24 INFO - 'MAIL': '/var/mail/cltbld', 23:01:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:24 INFO - 'MOZ_NO_REMOTE': '1', 23:01:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:01:24 INFO - 'NO_EM_RESTART': '1', 23:01:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:01:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:24 INFO - 'PWD': '/builds/slave/test', 23:01:24 INFO - 'SHELL': '/bin/bash', 23:01:24 INFO - 'SHLVL': '1', 23:01:24 INFO - 'TERM': 'linux', 23:01:24 INFO - 'TMOUT': '86400', 23:01:24 INFO - 'USER': 'cltbld', 23:01:24 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468476058.395810-1770045172', 23:01:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:24 INFO - '_': '/tools/buildbot/bin/python'} 23:01:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:01:24 INFO - Running setup.py (path:/tmp/pip-VhPxdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:01:24 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)) 23:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:01:24 INFO - Running setup.py (path:/tmp/pip-wguRvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:01:24 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)) 23:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:01:24 INFO - Running setup.py (path:/tmp/pip-tymvWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:01:24 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)) 23:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:01:24 INFO - Running setup.py (path:/tmp/pip-wsBhxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:01:24 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)) 23:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:01:24 INFO - Running setup.py (path:/tmp/pip-keqEsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:01:24 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)) 23:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:01:24 INFO - Running setup.py (path:/tmp/pip-i9PyqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:01:25 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)) 23:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:01:25 INFO - Running setup.py (path:/tmp/pip-WFgca3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:01:25 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)) 23:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:01:25 INFO - Running setup.py (path:/tmp/pip-_0hVTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:01:25 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)) 23:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:01:25 INFO - Running setup.py (path:/tmp/pip-uR_S0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:01:25 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)) 23:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:01:25 INFO - Running setup.py (path:/tmp/pip-ix1tAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:01:25 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)) 23:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:01:25 INFO - Running setup.py (path:/tmp/pip-hSSkkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:01:25 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)) 23:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:01:25 INFO - Running setup.py (path:/tmp/pip-Q8WlGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:01:25 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)) 23:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:01:25 INFO - Running setup.py (path:/tmp/pip-_dYXZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:01:25 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)) 23:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:01:25 INFO - Running setup.py (path:/tmp/pip-6dIeAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:01:25 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)) 23:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:01:25 INFO - Running setup.py (path:/tmp/pip-cbzieB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:01:25 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)) 23:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:01:25 INFO - Running setup.py (path:/tmp/pip-YHGtrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:01:25 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)) 23:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:01:25 INFO - Running setup.py (path:/tmp/pip-Xf_1St-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:01:25 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)) 23:01:25 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)) 23:01:25 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)) 23:01:25 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)) 23:01:25 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)) 23:01:25 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)) 23:01:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:01:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:01:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:01:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:01:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:01:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:01:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:01:27 INFO - Downloading blessings-1.6.tar.gz 23:01:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:01:27 INFO - Installing collected packages: blessings 23:01:27 INFO - Running setup.py install for blessings 23:01:27 INFO - Successfully installed blessings 23:01:27 INFO - Cleaning up... 23:01:27 INFO - Return code: 0 23:01:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:01:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:01:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:01:28 INFO - Reading from file tmpfile_stdout 23:01:28 INFO - Current package versions: 23:01:28 INFO - argparse == 1.2.1 23:01:28 INFO - blessings == 1.6 23:01:28 INFO - blobuploader == 1.2.4 23:01:28 INFO - docopt == 0.6.1 23:01:28 INFO - manifestparser == 1.1 23:01:28 INFO - mozInstall == 1.12 23:01:28 INFO - mozcrash == 0.17 23:01:28 INFO - mozdebug == 0.1 23:01:28 INFO - mozdevice == 0.48 23:01:28 INFO - mozfile == 1.2 23:01:28 INFO - mozhttpd == 0.7 23:01:28 INFO - mozinfo == 0.9 23:01:28 INFO - mozleak == 0.1 23:01:28 INFO - mozlog == 3.1 23:01:28 INFO - moznetwork == 0.27 23:01:28 INFO - mozprocess == 0.22 23:01:28 INFO - mozprofile == 0.28 23:01:28 INFO - mozrunner == 6.11 23:01:28 INFO - mozscreenshot == 0.1 23:01:28 INFO - mozsystemmonitor == 0.0 23:01:28 INFO - moztest == 0.7 23:01:28 INFO - mozversion == 1.4 23:01:28 INFO - psutil == 3.1.1 23:01:28 INFO - requests == 1.2.3 23:01:28 INFO - wsgiref == 0.1.2 23:01:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:01:28 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')]} 23:01:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:01:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:28 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')]} 23:01:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:01:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:28 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 0x7f4b505fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29f85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a87410>, '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 0x2a88310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a887a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468476058.395810-1770045172', '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 23:01:28 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 23:01:28 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 23:01:28 INFO - Using env: {'DISPLAY': ':0', 23:01:28 INFO - 'HOME': '/home/cltbld', 23:01:28 INFO - 'LANG': 'en_US.UTF-8', 23:01:28 INFO - 'LANGUAGE': 'en_US:en', 23:01:28 INFO - 'LOGNAME': 'cltbld', 23:01:28 INFO - 'MAIL': '/var/mail/cltbld', 23:01:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:28 INFO - 'MOZ_NO_REMOTE': '1', 23:01:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:01:28 INFO - 'NO_EM_RESTART': '1', 23:01:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:01:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:28 INFO - 'PWD': '/builds/slave/test', 23:01:28 INFO - 'SHELL': '/bin/bash', 23:01:28 INFO - 'SHLVL': '1', 23:01:28 INFO - 'TERM': 'linux', 23:01:28 INFO - 'TMOUT': '86400', 23:01:28 INFO - 'USER': 'cltbld', 23:01:28 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468476058.395810-1770045172', 23:01:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:28 INFO - '_': '/tools/buildbot/bin/python'} 23:01:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:01:28 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)) 23:01:28 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)) 23:01:28 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)) 23:01:28 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)) 23:01:28 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)) 23:01:28 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)) 23:01:28 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)) 23:01:28 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)) 23:01:28 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)) 23:01:28 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)) 23:01:28 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)) 23:01:28 INFO - Cleaning up... 23:01:28 INFO - Return code: 0 23:01:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:01:28 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')]} 23:01:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:01:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:28 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')]} 23:01:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:01:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:28 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 0x7f4b505fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29f85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a87410>, '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 0x2a88310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a887a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468476058.395810-1770045172', '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 23:01:28 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 23:01:28 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 23:01:28 INFO - Using env: {'DISPLAY': ':0', 23:01:28 INFO - 'HOME': '/home/cltbld', 23:01:28 INFO - 'LANG': 'en_US.UTF-8', 23:01:28 INFO - 'LANGUAGE': 'en_US:en', 23:01:28 INFO - 'LOGNAME': 'cltbld', 23:01:28 INFO - 'MAIL': '/var/mail/cltbld', 23:01:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:28 INFO - 'MOZ_NO_REMOTE': '1', 23:01:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:01:28 INFO - 'NO_EM_RESTART': '1', 23:01:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:01:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:28 INFO - 'PWD': '/builds/slave/test', 23:01:28 INFO - 'SHELL': '/bin/bash', 23:01:28 INFO - 'SHLVL': '1', 23:01:28 INFO - 'TERM': 'linux', 23:01:28 INFO - 'TMOUT': '86400', 23:01:28 INFO - 'USER': 'cltbld', 23:01:28 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468476058.395810-1770045172', 23:01:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:28 INFO - '_': '/tools/buildbot/bin/python'} 23:01:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:01:28 INFO - Downloading/unpacking jsonschema 23:01:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:01:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:01:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:01:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:01:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:01:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:01:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:01:30 INFO - Downloading/unpacking functools32 (from jsonschema) 23:01:30 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 23:01:30 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 23:01:30 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 23:01:30 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 23:01:30 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 23:01:30 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 23:01:30 INFO - Downloading functools32-3.2.3-2.tar.gz 23:01:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:01:30 INFO - warning: no files found matching '*.txt' 23:01:30 INFO - no previously-included directories found matching 'build' 23:01:30 INFO - no previously-included directories found matching 'dist' 23:01:30 INFO - no previously-included directories found matching '.git*' 23:01:30 INFO - Installing collected packages: jsonschema, functools32 23:01:30 INFO - Running setup.py install for functools32 23:01:30 INFO - warning: no files found matching '*.txt' 23:01:30 INFO - no previously-included directories found matching 'build' 23:01:30 INFO - no previously-included directories found matching 'dist' 23:01:30 INFO - no previously-included directories found matching '.git*' 23:01:30 INFO - Successfully installed jsonschema functools32 23:01:30 INFO - Cleaning up... 23:01:30 INFO - Return code: 0 23:01:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:01:30 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')]} 23:01:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:01:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:30 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')]} 23:01:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:01:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:30 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 0x7f4b505fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29f85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a87410>, '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 0x2a88310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a887a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468476058.395810-1770045172', '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 23:01:30 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 23:01:30 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 23:01:30 INFO - Using env: {'DISPLAY': ':0', 23:01:30 INFO - 'HOME': '/home/cltbld', 23:01:30 INFO - 'LANG': 'en_US.UTF-8', 23:01:30 INFO - 'LANGUAGE': 'en_US:en', 23:01:30 INFO - 'LOGNAME': 'cltbld', 23:01:30 INFO - 'MAIL': '/var/mail/cltbld', 23:01:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:30 INFO - 'MOZ_NO_REMOTE': '1', 23:01:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:01:30 INFO - 'NO_EM_RESTART': '1', 23:01:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:01:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:30 INFO - 'PWD': '/builds/slave/test', 23:01:30 INFO - 'SHELL': '/bin/bash', 23:01:30 INFO - 'SHLVL': '1', 23:01:30 INFO - 'TERM': 'linux', 23:01:30 INFO - 'TMOUT': '86400', 23:01:30 INFO - 'USER': 'cltbld', 23:01:30 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468476058.395810-1770045172', 23:01:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:30 INFO - '_': '/tools/buildbot/bin/python'} 23:01:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:01:31 INFO - Downloading/unpacking flake8 23:01:31 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 23:01:31 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 23:01:31 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 23:01:31 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 23:01:31 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 23:01:31 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 23:01:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:01:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:01:33 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 23:01:33 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 23:01:33 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 23:01:33 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 23:01:33 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 23:01:33 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 23:01:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:01:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:01:33 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 23:01:33 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 23:01:33 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 23:01:33 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 23:01:33 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 23:01:33 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 23:01:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:01:33 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 23:01:33 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 23:01:33 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 23:01:33 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 23:01:33 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 23:01:33 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 23:01:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:01:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:01:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:01:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:01:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:01:33 INFO - no previously-included directories found matching 'docs/_build' 23:01:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:01:33 INFO - Running setup.py install for pep8 23:01:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:01:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:01:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:01:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:01:33 INFO - no previously-included directories found matching 'docs/_build' 23:01:34 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:01:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:01:34 INFO - Cleaning up... 23:01:34 INFO - Return code: 0 23:01:34 INFO - Running post-action listener: _resource_record_post_action 23:01:34 INFO - Running post-action listener: _start_resource_monitoring 23:01:34 INFO - Starting resource monitoring. 23:01:34 INFO - ##### 23:01:34 INFO - ##### Running install step. 23:01:34 INFO - ##### 23:01:34 INFO - Running pre-action listener: _resource_record_pre_action 23:01:34 INFO - Running main action method: install 23:01:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:01:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:01:34 INFO - Reading from file tmpfile_stdout 23:01:34 INFO - Detecting whether we're running mozinstall >=1.0... 23:01:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:01:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:01:34 INFO - Reading from file tmpfile_stdout 23:01:34 INFO - Output received: 23:01:34 INFO - Usage: mozinstall [options] installer 23:01:34 INFO - Options: 23:01:34 INFO - -h, --help show this help message and exit 23:01:34 INFO - -d DEST, --destination=DEST 23:01:34 INFO - Directory to install application into. [default: 23:01:34 INFO - "/builds/slave/test"] 23:01:34 INFO - --app=APP Application being installed. [default: firefox] 23:01:34 INFO - mkdir: /builds/slave/test/build/application 23:01:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:01:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:01:47 INFO - Reading from file tmpfile_stdout 23:01:47 INFO - Output received: 23:01:47 INFO - /builds/slave/test/build/application/firefox/firefox 23:01:47 INFO - Running post-action listener: _resource_record_post_action 23:01:47 INFO - ##### 23:01:47 INFO - ##### Running run-tests step. 23:01:47 INFO - ##### 23:01:47 INFO - Running pre-action listener: _resource_record_pre_action 23:01:47 INFO - Running main action method: run_tests 23:01:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:01:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:01:47 INFO - Python 2.7.3 23:01:47 INFO - Return code: 0 23:01:47 INFO - grabbing minidump binary from tooltool 23:01:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:01:47 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 0x2a87410>, '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 0x2a88310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a887a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:01:47 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 23:01:47 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 23:01:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:01:47 INFO - Return code: 0 23:01:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:01:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:01:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:01:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:01:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:01:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:01:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:01:48 INFO - Return code: 0 23:01:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 23:01:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 23:01:48 INFO - Using env: {'DISPLAY': ':0', 23:01:48 INFO - 'HOME': '/home/cltbld', 23:01:48 INFO - 'LANG': 'en_US.UTF-8', 23:01:48 INFO - 'LANGUAGE': 'en_US:en', 23:01:48 INFO - 'LOGNAME': 'cltbld', 23:01:48 INFO - 'MAIL': '/var/mail/cltbld', 23:01:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:01:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:01:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:48 INFO - 'MOZ_NO_REMOTE': '1', 23:01:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:01:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:01:48 INFO - 'NO_EM_RESTART': '1', 23:01:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:01:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:48 INFO - 'PWD': '/builds/slave/test', 23:01:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:01:48 INFO - 'SHELL': '/bin/bash', 23:01:48 INFO - 'SHLVL': '1', 23:01:48 INFO - 'TERM': 'linux', 23:01:48 INFO - 'TMOUT': '86400', 23:01:48 INFO - 'USER': 'cltbld', 23:01:48 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468476058.395810-1770045172', 23:01:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:48 INFO - '_': '/tools/buildbot/bin/python'} 23:01:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 23:01:48 INFO - mozversion application_buildid: 20160713154642 23:01:48 INFO - mozversion application_changeset: 84c59d136a9e54be69571b75a19e8a8ccff7b8a1 23:01:48 INFO - mozversion application_display_name: Firefox 23:01:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:01:48 INFO - mozversion application_name: Firefox 23:01:48 INFO - mozversion application_remotingname: firefox 23:01:48 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 23:01:48 INFO - mozversion application_vendor: Mozilla 23:01:48 INFO - mozversion application_version: 48.0 23:01:48 INFO - mozversion platform_buildid: 20160713154642 23:01:48 INFO - mozversion platform_changeset: 84c59d136a9e54be69571b75a19e8a8ccff7b8a1 23:01:48 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 23:01:48 INFO - mozversion platform_version: 48.0 23:01:48 INFO - using testdate: 1468476108 23:01:48 INFO - actual date: 1468476108 23:01:48 INFO - starting webserver on 'localhost:49430' 23:01:48 INFO - SUITE-START | Running 2 tests 23:01:48 INFO - TEST-START | dromaeo_css 23:01:48 INFO - operating with platform_type : linux_ 23:01:48 INFO - Initialising browser for dromaeo_css test... 23:01:48 INFO - TEST-INFO | started process 4194 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQOo8mq/profile http://localhost:49430/getInfo.html) 23:01:53 INFO - PROCESS | 4194 | __metrics Screen width/height:1600/1200 23:01:53 INFO - PROCESS | 4194 | colorDepth:24 23:01:53 INFO - PROCESS | 4194 | Browser inner width/height: 1024/697 23:01:53 INFO - PROCESS | 4194 | __metrics 23:01:54 ERROR - PROCESS | 4194 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:01:54 INFO - TEST-INFO | 4194: exit 0 23:01:54 INFO - Browser initialized. 23:01:54 INFO - Running cycle 1/1 for dromaeo_css test... 23:01:54 INFO - TEST-INFO | started process 4288 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQOo8mq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:02:06 INFO - PROCESS | 4288 | RSS: Main: 140025856 23:02:06 INFO - PROCESS | 4288 | 23:02:57 INFO - PROCESS | 4288 | 1468476177746 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] 23:05:05 INFO - PROCESS | 4288 | Cycle 1(1): loaded http://localhost:49430/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49430/tests/dromaeo/cssquery-ext.html) 23:05:06 INFO - PROCESS | 4288 | RSS: Main: 253403136 23:05:06 INFO - PROCESS | 4288 | 23:08:08 INFO - PROCESS | 4288 | Cycle 1(1): loaded http://localhost:49430/tests/dromaeo/cssquery-ext.html (next: http://localhost:49430/tests/dromaeo/cssquery-jquery.html) 23:08:09 INFO - PROCESS | 4288 | RSS: Main: 227811328 23:08:09 INFO - PROCESS | 4288 | 23:11:10 INFO - PROCESS | 4288 | Cycle 1(1): loaded http://localhost:49430/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49430/tests/dromaeo/cssquery-mootools.html) 23:11:11 INFO - PROCESS | 4288 | RSS: Main: 211578880 23:11:11 INFO - PROCESS | 4288 | 23:14:13 INFO - PROCESS | 4288 | Cycle 1(1): loaded http://localhost:49430/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49430/tests/dromaeo/cssquery-prototype.html) 23:14:13 INFO - PROCESS | 4288 | RSS: Main: 218898432 23:14:13 INFO - PROCESS | 4288 | 23:17:16 INFO - PROCESS | 4288 | Cycle 1(1): loaded http://localhost:49430/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49430/tests/dromaeo/cssquery-yui.html) 23:17:16 INFO - PROCESS | 4288 | RSS: Main: 181788672 23:17:16 INFO - PROCESS | 4288 | 23:20:19 INFO - PROCESS | 4288 | Cycle 1(1): loaded http://localhost:49430/tests/dromaeo/cssquery-yui.html (next: http://localhost:49430/tests/dromaeo/cssquery-dojo.html) 23:20:19 INFO - PROCESS | 4288 | RSS: Main: 257130496 23:20:19 INFO - PROCESS | 4288 | 23:20:19 INFO - PROCESS | 4288 | __start_tp_report 23:20:19 INFO - PROCESS | 4288 | _x_x_mozilla_page_load 23:20:19 INFO - PROCESS | 4288 | _x_x_mozilla_page_load_details 23:20:19 INFO - PROCESS | 4288 | |i|pagename|runs| 23:20:19 INFO - PROCESS | 4288 | |0;dojo.html;3281.310924705812;3349.346877358916;3356.379069872073;3383.8308084595765;3398.2863598644285;5445.646033007852;5447.727613619318;5472.206530053145;5473.042217611917;5486.451354864512;5457.617966742329;5496;5505.52843908756;5515.806946756854;5527.977324195027;4830.9516904831025;4850.199717046683;4919.508049195088;5050.393952725678;5084.415292241384;4910.877228069291;4984.601231901439;4991.226359914219;4992.750362481861;4995.800167993276;4920.286558449041;4975.975120124413;4990.775415106311;4999.850004499871;5008.599312055045;5023.974880125595;5036.722980236085;5050.595952323805;5055.216441451581;5084.872878178038;4823.155947709137;4869.342638743759;4905.190643543811;4957.876053098666;4986.850394488171;5317.548008419289;5377.274068000809;5378.139497680352;5395.082835917903;5395.892082158335;5850.912236316459;5899.764009439617;5908.734106965197;5908.793192238251;5908.852278693067;5788.04497257952;5847.795327163529;5855.355910849803;5889.116632505158;5946.583739138262;5476.233327334136;5486.039943009957;5523.834284971457;5597.552195824324;5598.24423702799;5885.529157667376;6070.726817293233;6087.3303936566945;6089.330173680892;6089.634621922699;5787.536997040227;5831.620944638585;5837.241158649434;5846.883062338729;5853.473187413153;5849.356570777211;5852.180694702745;5855.853603659943;5864.2083318752275;5866.5893387462465;5706.172604972338;5776.249087618667;5819.981503236917;5822.184894114827;5828.329742079631;5806.158107074535;5815.680137592473;5823.039198532279;5823.767049318065;5860.413958604191;4479.910401792011;4481.484629267611;4482.282834746425;4490.685652004328;4511.075229577994;3932.174243408859;3968.980155099206;4015.257177422186;4062.431259623655;4063.553009168989;5633.183188437735;5662.8301150965535;5667.4615911488345;5670.262865827416;5671.404502527258;5928.407159284037;5936.7031648417405;5937.554683398763;5941.049432090845;5944.316403613553;5500.614956952975;5636.60543761941;5637.267155269788;5699.544036477072;5726.856828579319;4970.403551573762;4978.676386034968;4981.825636102719;4984.352034235526;5021.874453138701;6093.390660933871;6106.389361063947;6109.5112391008615;6111.236095488064;6117.296510901214;5718.656880587178;5935.940640593712;5975.223220981245;5983.072623743326;5989.071693887455;6092.939070609237;6094.786682466092;6102.664353460602;6103.969480152571;6109.022556391134;5609.411011843697;5723.227364305765;5741.196232527533;5745.482906538432;5770.942290577041;5830.329512105993;5927.881442371215;5927.940720592739;5928.4960778334325;5965.194698715618;5620.522255608319;5655.773769049357;5661.348944871393;5664.348599911063;5668.3198016236665;5610.242617246619;5652.095664693629;5656;5659.122835960433;5659.462351076641;5661.716914154358;5709.029464991045;5710.400407957105;5713.257276554022;5742.885142297214;5762.250907382014;5788.710564471844;5796.536277097738;5811.82564523065;5815.534757219328;5434.755436005468;5535;5587.69267690281;5710.200571920018;5727.255456790591 23:20:19 INFO - PROCESS | 4288 | |1;ext.html;652.4714980865499;660.2473180574143;675.2538445018251;682.423352267334;741.9760730192336;32258.193545161354;32818.50772238418;32841.67158328416;32849;41475.17049659012;45273.641790746246;45531.772341138334;45900.770496147474;45930.31104533435;46015.76992115043;8804.779880503007;8984.595693193822;8987.865182022275;8988.325875559327;8988.77528061797;8806.20744133028;8826.117388261187;8888.244499217575;8908.465492070496;8916.15296546827;8894.066123057082;8920.330975176856;8925.41984770991;9117.635294588208;9194.08059194082;9096.499692516909;9115.772105697377;9159.35884488086;9172.220361269234;9172.816543669089;9111.589978450986;9200.907990920072;9210.447373157565;9215.03242159577;9218.769530761785;43418.78290608527;43908.78045609783;44109.77945110254;44120.779396103135;44156;3700.3709369407266;3894.6105389460827;4278.893027674302;4348.065165989296;4359.912801743947;33753.32493350119;34471;34518;34720.82639586811;35979.64020359815;4577.588017078446;4605.286180642006;4634.559716826896;4645.790939407735;4657.697249678794;325982;326337;327686;327762;327763;40117;63788.362116378245;64985;65005.34994650088;65067.34932650708;38151;38206.42690359647;38278.80860595735;38356.616433835305;38368.04079898025;17421.47735567935;17458.65082698339;17535.824641753417;17551.73672394915;17570.209340579706;13495.122817017058;13506.189628622315;13509.189448632917;13511.324433778469;13515.729685406237;9586.376885502421;9595.42427454355;9651.951740241395;9653.46905920167;9656.95171524138;3628.76413033152;3709.870154544578;3718.8140592970785;3746.4193050076738;3753.868614598476;1155.4742592120565;1173.8239264110452;1175.2537138916678;1198.93294967479;1199.8500187476566;33968.49047264293;34007.4898876517;34538.48192277118;34607.82696086504;34644.13389665228;1219.920705154162;1225.877412258767;1233.2846948769693;1295.578936845529;1302.7174806161108;17730.91134544319;17987.370442034466;18078.728819067725;18095;18110.094495275447;500086;503240;504682;506051;507724.0751758615;63030;63992.68003659952;64077.67961160164;64252.678736606955;64268;1357.6402253402857;1464.0849469081825;1494.7085318363033;1516.9696606067596;1587.1508742822534;30354.392912141193;31218.375632487678;31552.403781465287;31993.68006319907;32237;51739.22391164211;52269;52275.73862130665;52276.47723522716;52404.47595523996;304801;306308;308238;308755;310046;27428.862855685595;31559.053228403183;31615.841920790248;31785.523217151298;32613.836930816142;45284;53366.199507008205;53667.19499207593;53923.19115213196;54413.45586544084;39295.41056884092;40045.79977100096;40509.39235911405;40639.1872162561;41522;41426.37860432156;41744.58255417407;42140.157196856504;43440.78279608582;43473.34789978216;42993.570064298954;43529.34705979476;43582.346264806685;44359.11281774411;44509.77745111254;37075.25849482941;37552.310146042946;38179.42730858984;38302.233955321295;38401.4239786409;28832.711672883004;29291.369852813255;29454;29505.704942950295;29704 23:20:19 INFO - PROCESS | 4288 | |2;jquery.html;431.421894661154;434.68485348122607;435.6188335206694;440.4120499133657;453.94098767160267;18095.547611309707;18322.633547329046;18674.813251867476;20983.47541311468;21300.57398852022;20261.392158235278;20297.49256268594;20620.587588248225;20631.484212894684;20659.793402066014;5482;5967.552433567478;5967.6121052131475;5973.940260597404;5974.8506287342725;4176.18564379946;5784.768609255625;5958.136070269808;6260.123582698426;6539.574927629689;6428.4857211423205;6434.227892652888;6485.93514064858;6503.28463868974;6506.349365063503;5850.912236316459;6121.724522396503;6141.846453838645;6145;6447.935520644781;3793.468914351993;3805.3721136012523;5547.750351234164;5552.77788888444;5812.099124635688;14403.567892963229;14794.556163315117;14868.925655371762;14873.553793386216;21293.5741285175;2441.59713647248;2467.592847180213;2526.456811785475;2563.4250788918703;2603.80471464639;10280.331778434453;10609.310394824312;10660.093892019187;11075.556977720882;13523.98570107236;1985.6128055029276;2076.809130404535;2104.884231367274;2105.2421128393767;2106.557622899193;80972;81045;81933.18066819315;84285.15714842835;93009.53495232548;17166.39917602878;17581.7362739559;17591;17933.551661208574;18018.36935707244;34305;34500.82749586236;34714.30571388558;34984.475232871526;35146.82426587902;10415.635452759117;10724.678259652223;10904.291221070764;11150.107991360672;11482.655520334403;9519.666811661558;9610.327277090537;9639.469829159463;9652;9679.516024198761;9550.856737148948;9562.330636855353;9634;9838.458884761263;9846.212303015742;3124.5781819454537;3274.6397896231397;3715.9071023224096;3759.774413535197;3827.75119617224;1010.5553556435145;1089.319175515303;1100.460774220626;1106.9446527673583;1115.4980258883536;18386.908065459855;18492.907535462506;19112.426627201206;19147;19314.71027934582;1051.3271506236015;1082.5182793656904;1111.4053981120062;1122.5565901468874;1123.6404350607727;10185;10554;10593.152547796159;10620.840687389695;10668.839967400496;463917;466026;480437;481099;488158;55199;59017.114743278886;88326.55836720775;98134;102203;1067.3755852826027;1096.7203363142348;1119.182996412607;1125.5160281079216;1143.3025854228913;17135.314587416364;17305.65388692194;17402.21690023977;17470.563235919202;17895.73156402629;38138.23723525569;38334.424983625824;39283.607163928;39897.00257493586;40043.79978100091;57477.42522574721;57999.71000144972;58053.709731451076;58167;58457.123143152035;8899.866502002606;8905.376623636283;8948.642054317754;9188.494632794993;9194.26445884341;8328.138142595471;10659.786804264026;13283.136596121221;13466.528671496451;13585.52450664222;11297.26567773092;11660.475278612314;11689.357085360387;11993.34036627994;12007.219530730474;11322.660320190407;11427.542898284308;11432.37121958267;11569.595064172714;11589.82615260755;6064.545159113172;9561.569729362334;9756.121949024622;11915.702107447383;11960.401979900797;8680.305575554066;8851.601677924638;8963.507007114671;9017.864732028893;9099.317551183556;11273.267237629529;11897.762044758883;11922.52309907594;11936.28382297065;12112.697182570506 23:20:19 INFO - PROCESS | 4288 | |3;mootools.html;1395.6929475515383;1551.7284475216836;1554.4015554011705;1782.9732554011684;1894.8484121270292;7243.0946131733535;8235.382346324028;8386.958065209681;8405.91594084059;8429.831403371929;8318.91681083189;8493.91506084939;8500.872486912702;8501.829963400729;8503.447275927061;2435.7564243575634;2457.7296497385273;2460.6555082288405;2460.778529932306;2461.876906154685;2364.203995336797;2455.963160552584;2467.1858286765323;2470.814688898331;2472.09768434521;2404.759524047599;2409.6144616861307;2409.7108346998384;2434.4887573609562;2436.2569416328015;2420.068273714615;2426.6360045993156;2431.8297719159664;2438.2807071913826;2480.3303108160876;2407.5305315463493;2409.3976505873534;2433.7201221859536;2436.7319594844553;2439.7682220189054;6966.12923384577;7113.075300210991;8587.141285871425;8630.352723545759;8638.61126249314;5145.3568303962;5250.107481728077;5251.238570407308;5252.947470525284;5257.7108259045735;3282.3435312937268;3288.934221315584;3339.8497067632015;3340.8830690925943;3372.6627337266323;1071.181927034428;1115.8772535021142;1128.1313388690662;1129.8700649425339;1131.4116659337099;12216.816747748791;12333.198342107735;12348.938255308665;12350.320732359716;12358.62924112278;4640.489546149921;4690.718556886598;4758.976205118952;4772;4825.565699087099;10420.166386689047;10485.633002844865;10489.055984961238;10495.737606559896;10497.107745841537;5346.759395827197;5346.8663283417445;5385.78456861729;5387.3804512481565;5395.919061214085;4890.706557606555;4929.383827021622;4932.383452068491;4939.456659767423;4943.258511223274;3964.0882597002274;3998.6801055915457;4022.738521996061;4023.7786921719585;4046.2716710992304;1228.65597632663;1255.6609715376796;1258.3079306381453;1267.7844766389735;1267.8985681145487;909.7543663210896;994.2543092680489;1025.6871654145557;1046.2623850185753;1053.2785042246087;6014.18808460861;6074.757009719562;6131.724072416752;6132.816015519542;6162.7226774795245;1051.4217180550665;1055.8521806947033;1060.2313322840878;1068.3002633275216;1078.6710053433621;4058.1072164123843;4144.668426525871;4174;4178.05993651426;4248.936265956013;10071.59713611462;10239.283250172417;10428;10497.370157790558;10523.52644131016;10330.380177189243;10335.844962325571;10337.483125843677;10345;10357.533910973874;8187.754367368989;8355.791105222297;8363.038250601137;8364.832703345899;8365.1216622255;5787.576109667689;5819.82540523785;5822.243108395882;5828.94171058301;5999.91000135007;9452.196563292197;9477.099675530813;9573.569189386633;9649.710508684751;9720.416774993522;9435.858462123211;9856.704298871045;9873.111419972238;9937.850932236166;9967.40195588267;7843.372530197456;7917.247861453153;7942.920570794449;7952.443328966917;7959.880601790862;8463.873041904499;8512.872306915277;8516.40385173032;8523.701670441505;8524.232819046067;7380.409567234716;7508.136564295176;7508.549487030796;7537.6984920604755;7653.19641437641;7332.120145582564;7362;7368.668409921674;7389.261073892568;7454.92545074564;7150.034745309316;7210;7218.602976836324;7223.674934627849;7225.891611625725;5112.437631860566;5113.8721531962;5208.4270730220405;5219.973900130475;5328;5114.309568208244;5214.478552144907;5222.6083043771105;5285.207218917193;5298.920516192183 23:20:19 INFO - PROCESS | 4288 | |4;prototype.html;335.88076232937306;337.6050021474873;342.50585480093673;348.1279395115236;349.1620111731845;6038.124471951564;6047;6086.7869624563145;6095.847603809902;6113.266408031037;5744.396838331978;5889.558283128772;6076.149339092531;6088.634681919088;6116.327204007567;4579.107074120548;4652.116097941397;4671.205894997858;4671.719696818185;4675.929861052078;4613.354130421743;4641;4679.3682852814945;4703.2239680452685;4707.340972263886;4440.356148358486;4520.163769702599;4591.931121033187;4608.331791890174;4632.351470794075;4601.033782905593;4626.097910907374;4627.190241707722;4649.767511624439;4655.441347038343;4093.570175131628;4099.938500922489;4105.835766569334;4107.835686572534;4108.404281379213;5875.177475153482;5881.500072493843;5886.381929897342;5890.823275301748;5895.734691938873;5436.184572314145;5437.184422336642;5440.646357986719;5446.782128714846;5455.099908515091;6205.503559715212;6419;6427.389398007182;6455.354464553554;6456.28980812115;4557.065801510682;4572.337011133401;4576.885577860547;4579.175748365293;4581.725096494221;6640.568363056386;6718.328167183291;6730.798076057726;6732.528722989393;6742.393184613408;4590.678652494294;4602.930956035662;4604;4605.976970115128;4609.285560738091;4643.976780116078;4660.976695116503;4664.743439110882;4668.626509879202;4669.673122881366;5258;5369.973150134302;5375.811846585429;5387.676739395571;5396.865078373072;6466.191726034246;6473.870522589522;6493;6503.902441463382;6504.414602685686;1563.4527915229805;1626.1706529669952;1627.7558366245157;1666.7166581681142;1671.498550434889;1103.5199688135688;1123.0678536814423;1123.601121601836;1128.328644456547;1130.5534313945946;6265.96867015662;6268.122462855204;6279.937200628026;6285.497160227171;6301.495880329563;6567.113439685677;6605.735770569219;6607.603543787292;6620.867582648417;6624.205095388488;6277.654728989949;6285.497160227171;6288.496920246369;6289.056641503719;6295.905561416583;3542.5926018507685;3558.87543935961;3562.9691076086383;3569.3575156472084;3572.0891172751303;6787.864242715118;6898.793036208922;6914.654267286615;6938.653067346713;6959.164900211906;6749.122614060141;6757.695903684346;6764.0868482754195;6771.864562708718;6774.796756097325;6931.549449285781;6932.23745388007;6936.167659880846;6937.479689023344;6945.37491625746;6590;6591.835204119935;6594.340565943367;6596.70314835824;6600.867982640416;6307.180066591313;6517.315681853337;6533.0853680485725;6584.045313429621;6624.536282460182;6871.312868713088;6912.4815638828295;6915.827104322432;6928.411085057625;6939.757108501179;4642.141203877293;4648.325992730967;4654.48800631937;4655.3249778782565;4655.743934083523;6339.683015849281;6500.25247096571;6564.343565643398;6567.113439685581;6572.671366431564;6367.586106903036;6495.610263384212;6503.317151699192;6503.772367967098;6512.3162067982175;6453.419192272718;6459.063435801876;6470.158879345655;6477.287498375081;6490.870182596416;6341.904871427025;6371.23545174582;6383.553151279366;6401.231852177769;6402.679866006588;6291.622502649856;6489.870202595827;6508.121403610452;6519.771807986698;6522.249941256627;6433.163688720437;6481.351864813481;6505.349465053646;6511.479081673549;6515.2833188348295 23:20:19 INFO - PROCESS | 4288 | |5;yui.html;757.5681861339035;779.3025242408048;836.1554829622083;836.9246767790897;844.9070602233753;14877.776833347509;15170.089794612331;15199.848001519982;15223.619409514768;15268.694626107485;13894.166350019006;13990.090644108152;14053.648658783535;14064.085834420755;14071;733.3326672727819;887.3344991256541;891.8795962545038;905.3617199874105;908.513945039404;895.1004240738049;904.3398319226968;906.2568693671192;906.2568693671192;906.6962567539849;952.0099096939175;956.7129861041694;957.6887511558737;958.9328746987713;959.4914695211514;770.3182683325241;780.6448066129925;933.5005771912063;944.2398868910524;952.0336858089045;698.8427603789107;698.9965050174717;699.1330749870175;699.2552931128383;700.1038670501715;14786.112833230041;14830.406783728638;14854.851451485454;14863.479778207819;14878;14751.77872331916;15113.3199006045;15197.924010379877;15223.771643425358;15347.693046139126;11651.067914566815;11714.941425292818;11793.174477786559;11824.586139485164;11928.403579820973;3888.6500214980506;3968.3452230381954;3975.6223158799867;3993.94009089861;4046.6964977626794;57477.71261143709;57503.13745293824;57520;57901.13148302779;58047.419525804624;10889.237753357347;11143.387113708824;11215.158863085302;11468.4839182237;11708.356040417859;21311.68032479483;21425.785742142692;21478.892605536872;21480.355589332346;21486.892565537073;8371.455855369382;8480.194381533744;8500.277476414574;8606;9018.954905225432;4277.1873344064525;4333.328334108218;4968.72672003036;5025.447200807908;5073.670211436245;3277.868885244611;3332.2502436951977;3332.483465062919;3342.364950659367;3345.7825241359233;585.3970410477215;588.7115313496356;589.2222266608122;595.3926994465621;596.8299034775068;656.5535435903631;747.9775606731806;751.2149803455402;751.4251597527896;751.9962400188074;9341.673041443517;9490.335676502578;9634.71095867125;9693.70918872435;9711.562979665932;615.7383112177307;618.1253526260291;620.0327489116902;661.3512880911917;715.5492040014757;4447.844325448658;4466;4499.617532509773;4510.571495707903;4572.3827283317;68085;69310.65344673244;69451;69487.3051269491;69573.65213173901;53309.7334513325;54609.45390546123;56391;57121.14318285229;57280.42719572834;46371.30443043357;46398.76800615976;46994.00550953139;47844.521554784704;47948.520514795804;9521.476318802532;9578.616855325708;9812.362196457207;10139.239557033105;10232;37924.43113353247;38743;39828.20343593054;39934.001649958984;39983.80008099941;44418.55581444144;45968;49843;50179.74910125426;51673.74163129311;11944.940275298568;12295.446704898122;12370.690732731753;12591.811122833347;12813.93593032029;12776.233425994471;13273.469061237829;13682.589522314347;14233.288335583387;14592.708145836812;12274.877251227374;12975;13035.739285214053;13120.671983200496;13362.599122026355;12414.565490207799;12690.365481725692;12715.364231788559;12814.487420503076;12890.613281601567;13102.279374634487;13214.735705285648;13500.189988600716;13538.120022198525;13685.657858553217;10594.894051059391;10908.61819836302;10923.453827308444;11049.116070714163;11436;11035.613753518588;11130.109591232844;11325.490352934303;11334.60328888485;11524.942375288405 23:20:19 INFO - PROCESS | 4288 | __end_tp_report 23:20:19 INFO - PROCESS | 4288 | __start_cc_report 23:20:19 INFO - PROCESS | 4288 | _x_x_mozilla_cycle_collect,848 23:20:19 INFO - PROCESS | 4288 | __end_cc_report 23:20:19 INFO - PROCESS | 4288 | __startTimestamp1468477219541__endTimestamp 23:20:19 INFO - PROCESS | 4288 | 23:20:19 INFO - PROCESS | 4288 | ------- Summary: start ------- 23:20:19 INFO - PROCESS | 4288 | Number of tests: 6 23:20:19 INFO - PROCESS | 4288 | 23:20:19 INFO - PROCESS | 4288 | [#0] dojo.html Cycles:165 Average:5457.23 Median:5662.83 stddev:607.80 (10.7%) stddev-sans-first:585.20 23:20:19 INFO - PROCESS | 4288 | Values: 3281.3 3349.3 3356.4 3383.8 3398.3 5445.6 5447.7 5472.2 5473.0 5486.5 5457.6 5496.0 5505.5 5515.8 5528.0 4831.0 4850.2 4919.5 5050.4 5084.4 4910.9 4984.6 4991.2 4992.8 4995.8 4920.3 4976.0 4990.8 4999.9 5008.6 5024.0 5036.7 5050.6 5055.2 5084.9 4823.2 4869.3 4905.2 4957.9 4986.9 5317.5 5377.3 5378.1 5395.1 5395.9 5850.9 5899.8 5908.7 5908.8 5908.9 5788.0 5847.8 5855.4 5889.1 5946.6 5476.2 5486.0 5523.8 5597.6 5598.2 5885.5 6070.7 6087.3 6089.3 6089.6 5787.5 5831.6 5837.2 5846.9 5853.5 5849.4 5852.2 5855.9 5864.2 5866.6 5706.2 5776.2 5820.0 5822.2 5828.3 5806.2 5815.7 5823.0 5823.8 5860.4 4479.9 4481.5 4482.3 4490.7 4511.1 3932.2 3969.0 4015.3 4062.4 4063.6 5633.2 5662.8 5667.5 5670.3 5671.4 5928.4 5936.7 5937.6 5941.0 5944.3 5500.6 5636.6 5637.3 5699.5 5726.9 4970.4 4978.7 4981.8 4984.4 5021.9 6093.4 6106.4 6109.5 6111.2 6117.3 5718.7 5935.9 5975.2 5983.1 5989.1 6092.9 6094.8 6102.7 6104.0 6109.0 5609.4 5723.2 5741.2 5745.5 5770.9 5830.3 5927.9 5927.9 5928.5 5965.2 5620.5 5655.8 5661.3 5664.3 5668.3 5610.2 5652.1 5656.0 5659.1 5659.5 5661.7 5709.0 5710.4 5713.3 5742.9 5762.3 5788.7 5796.5 5811.8 5815.5 5434.8 5535.0 5587.7 5710.2 5727.3 23:20:19 INFO - PROCESS | 4288 | 23:20:19 INFO - PROCESS | 4288 | [#1] ext.html Cycles:180 Average:54883.51 Median:41032.78 stddev:103141.07 (251.4%) stddev-sans-first:103350.04 23:20:19 INFO - PROCESS | 4288 | Values: 652.5 660.2 675.3 682.4 742.0 32258.2 32818.5 32841.7 32849.0 41475.2 45273.6 45531.8 45900.8 45930.3 46015.8 8804.8 8984.6 8987.9 8988.3 8988.8 8806.2 8826.1 8888.2 8908.5 8916.2 8894.1 8920.3 8925.4 9117.6 9194.1 9096.5 9115.8 9159.4 9172.2 9172.8 9111.6 9200.9 9210.4 9215.0 9218.8 43418.8 43908.8 44109.8 44120.8 44156.0 3700.4 3894.6 4278.9 4348.1 4359.9 33753.3 34471.0 34518.0 34720.8 35979.6 4577.6 4605.3 4634.6 4645.8 4657.7 325982.0 326337.0 327686.0 327762.0 327763.0 40117.0 63788.4 64985.0 65005.3 65067.3 38151.0 38206.4 38278.8 38356.6 38368.0 17421.5 17458.7 17535.8 17551.7 17570.2 13495.1 13506.2 13509.2 13511.3 13515.7 9586.4 9595.4 9652.0 9653.5 9657.0 3628.8 3709.9 3718.8 3746.4 3753.9 1155.5 1173.8 1175.3 1198.9 1199.9 33968.5 34007.5 34538.5 34607.8 34644.1 1219.9 1225.9 1233.3 1295.6 1302.7 17730.9 17987.4 18078.7 18095.0 18110.1 500086.0 503240.0 504682.0 506051.0 507724.1 63030.0 63992.7 64077.7 64252.7 64268.0 1357.6 1464.1 1494.7 1517.0 1587.2 30354.4 31218.4 31552.4 31993.7 32237.0 51739.2 52269.0 52275.7 52276.5 52404.5 304801.0 306308.0 308238.0 308755.0 310046.0 27428.9 31559.1 31615.8 31785.5 32613.8 45284.0 53366.2 53667.2 53923.2 54413.5 39295.4 40045.8 40509.4 40639.2 41522.0 41426.4 41744.6 42140.2 43440.8 43473.3 42993.6 43529.3 43582.3 44359.1 44509.8 37075.3 37552.3 38179.4 38302.2 38401.4 28832.7 29291.4 29454.0 29505.7 29704.0 23:20:19 INFO - PROCESS | 4288 | 23:20:19 INFO - PROCESS | 4288 | [#2] jquery.html Cycles:180 Average:29176.41 Median:2583.61 stddev:78330.30 (3031.8%) stddev-sans-first:78520.30 23:20:19 INFO - PROCESS | 4288 | Values: 431.4 434.7 435.6 440.4 453.9 18095.5 18322.6 18674.8 20983.5 21300.6 20261.4 20297.5 20620.6 20631.5 20659.8 5482.0 5967.6 5967.6 5973.9 5974.9 4176.2 5784.8 5958.1 6260.1 6539.6 6428.5 6434.2 6485.9 6503.3 6506.3 5850.9 6121.7 6141.8 6145.0 6447.9 3793.5 3805.4 5547.8 5552.8 5812.1 14403.6 14794.6 14868.9 14873.6 21293.6 2441.6 2467.6 2526.5 2563.4 2603.8 10280.3 10609.3 10660.1 11075.6 13524.0 1985.6 2076.8 2104.9 2105.2 2106.6 80972.0 81045.0 81933.2 84285.2 93009.5 17166.4 17581.7 17591.0 17933.6 18018.4 34305.0 34500.8 34714.3 34984.5 35146.8 10415.6 10724.7 10904.3 11150.1 11482.7 9519.7 9610.3 9639.5 9652.0 9679.5 9550.9 9562.3 9634.0 9838.5 9846.2 3124.6 3274.6 3715.9 3759.8 3827.8 1010.6 1089.3 1100.5 1106.9 1115.5 18386.9 18492.9 19112.4 19147.0 19314.7 1051.3 1082.5 1111.4 1122.6 1123.6 10185.0 10554.0 10593.2 10620.8 10668.8 463917.0 466026.0 480437.0 481099.0 488158.0 55199.0 59017.1 88326.6 98134.0 102203.0 1067.4 1096.7 1119.2 1125.5 1143.3 17135.3 17305.7 17402.2 17470.6 17895.7 38138.2 38334.4 39283.6 39897.0 40043.8 57477.4 57999.7 58053.7 58167.0 58457.1 8899.9 8905.4 8948.6 9188.5 9194.3 8328.1 10659.8 13283.1 13466.5 13585.5 11297.3 11660.5 11689.4 11993.3 12007.2 11322.7 11427.5 11432.4 11569.6 11589.8 6064.5 9561.6 9756.1 11915.7 11960.4 8680.3 8851.6 8963.5 9017.9 9099.3 11273.3 11897.8 11922.5 11936.3 12112.7 23:20:19 INFO - PROCESS | 4288 | 23:20:19 INFO - PROCESS | 4288 | [#3] mootools.html Cycles:180 Average:5742.79 Median:4935.92 stddev:3158.28 (64.0%) stddev-sans-first:3150.24 23:20:19 INFO - PROCESS | 4288 | Values: 1395.7 1551.7 1554.4 1783.0 1894.8 7243.1 8235.4 8387.0 8405.9 8429.8 8318.9 8493.9 8500.9 8501.8 8503.4 2435.8 2457.7 2460.7 2460.8 2461.9 2364.2 2456.0 2467.2 2470.8 2472.1 2404.8 2409.6 2409.7 2434.5 2436.3 2420.1 2426.6 2431.8 2438.3 2480.3 2407.5 2409.4 2433.7 2436.7 2439.8 6966.1 7113.1 8587.1 8630.4 8638.6 5145.4 5250.1 5251.2 5252.9 5257.7 3282.3 3288.9 3339.8 3340.9 3372.7 1071.2 1115.9 1128.1 1129.9 1131.4 12216.8 12333.2 12348.9 12350.3 12358.6 4640.5 4690.7 4759.0 4772.0 4825.6 10420.2 10485.6 10489.1 10495.7 10497.1 5346.8 5346.9 5385.8 5387.4 5395.9 4890.7 4929.4 4932.4 4939.5 4943.3 3964.1 3998.7 4022.7 4023.8 4046.3 1228.7 1255.7 1258.3 1267.8 1267.9 909.8 994.3 1025.7 1046.3 1053.3 6014.2 6074.8 6131.7 6132.8 6162.7 1051.4 1055.9 1060.2 1068.3 1078.7 4058.1 4144.7 4174.0 4178.1 4248.9 10071.6 10239.3 10428.0 10497.4 10523.5 10330.4 10335.8 10337.5 10345.0 10357.5 8187.8 8355.8 8363.0 8364.8 8365.1 5787.6 5819.8 5822.2 5828.9 5999.9 9452.2 9477.1 9573.6 9649.7 9720.4 9435.9 9856.7 9873.1 9937.9 9967.4 7843.4 7917.2 7942.9 7952.4 7959.9 8463.9 8512.9 8516.4 8523.7 8524.2 7380.4 7508.1 7508.5 7537.7 7653.2 7332.1 7362.0 7368.7 7389.3 7454.9 7150.0 7210.0 7218.6 7223.7 7225.9 5112.4 5113.9 5208.4 5220.0 5328.0 5114.3 5214.5 5222.6 5285.2 5298.9 23:20:19 INFO - PROCESS | 4288 | 23:20:19 INFO - PROCESS | 4288 | [#4] prototype.html Cycles:180 Average:5407.87 Median:6235.74 stddev:1622.44 (26.0%) stddev-sans-first:1581.70 23:20:19 INFO - PROCESS | 4288 | Values: 335.9 337.6 342.5 348.1 349.2 6038.1 6047.0 6086.8 6095.8 6113.3 5744.4 5889.6 6076.1 6088.6 6116.3 4579.1 4652.1 4671.2 4671.7 4675.9 4613.4 4641.0 4679.4 4703.2 4707.3 4440.4 4520.2 4591.9 4608.3 4632.4 4601.0 4626.1 4627.2 4649.8 4655.4 4093.6 4099.9 4105.8 4107.8 4108.4 5875.2 5881.5 5886.4 5890.8 5895.7 5436.2 5437.2 5440.6 5446.8 5455.1 6205.5 6419.0 6427.4 6455.4 6456.3 4557.1 4572.3 4576.9 4579.2 4581.7 6640.6 6718.3 6730.8 6732.5 6742.4 4590.7 4602.9 4604.0 4606.0 4609.3 4644.0 4661.0 4664.7 4668.6 4669.7 5258.0 5370.0 5375.8 5387.7 5396.9 6466.2 6473.9 6493.0 6503.9 6504.4 1563.5 1626.2 1627.8 1666.7 1671.5 1103.5 1123.1 1123.6 1128.3 1130.6 6266.0 6268.1 6279.9 6285.5 6301.5 6567.1 6605.7 6607.6 6620.9 6624.2 6277.7 6285.5 6288.5 6289.1 6295.9 3542.6 3558.9 3563.0 3569.4 3572.1 6787.9 6898.8 6914.7 6938.7 6959.2 6749.1 6757.7 6764.1 6771.9 6774.8 6931.5 6932.2 6936.2 6937.5 6945.4 6590.0 6591.8 6594.3 6596.7 6600.9 6307.2 6517.3 6533.1 6584.0 6624.5 6871.3 6912.5 6915.8 6928.4 6939.8 4642.1 4648.3 4654.5 4655.3 4655.7 6339.7 6500.3 6564.3 6567.1 6572.7 6367.6 6495.6 6503.3 6503.8 6512.3 6453.4 6459.1 6470.2 6477.3 6490.9 6341.9 6371.2 6383.6 6401.2 6402.7 6291.6 6489.9 6508.1 6519.8 6522.2 6433.2 6481.4 6505.3 6511.5 6515.3 23:20:19 INFO - PROCESS | 4288 | 23:20:19 INFO - PROCESS | 4288 | [#5] yui.html Cycles:180 Average:15559.42 Median:4456.92 stddev:18049.11 (405.0%) stddev-sans-first:18065.51 23:20:19 INFO - PROCESS | 4288 | Values: 757.6 779.3 836.2 836.9 844.9 14877.8 15170.1 15199.8 15223.6 15268.7 13894.2 13990.1 14053.6 14064.1 14071.0 733.3 887.3 891.9 905.4 908.5 895.1 904.3 906.3 906.3 906.7 952.0 956.7 957.7 958.9 959.5 770.3 780.6 933.5 944.2 952.0 698.8 699.0 699.1 699.3 700.1 14786.1 14830.4 14854.9 14863.5 14878.0 14751.8 15113.3 15197.9 15223.8 15347.7 11651.1 11714.9 11793.2 11824.6 11928.4 3888.7 3968.3 3975.6 3993.9 4046.7 57477.7 57503.1 57520.0 57901.1 58047.4 10889.2 11143.4 11215.2 11468.5 11708.4 21311.7 21425.8 21478.9 21480.4 21486.9 8371.5 8480.2 8500.3 8606.0 9019.0 4277.2 4333.3 4968.7 5025.4 5073.7 3277.9 3332.3 3332.5 3342.4 3345.8 585.4 588.7 589.2 595.4 596.8 656.6 748.0 751.2 751.4 752.0 9341.7 9490.3 9634.7 9693.7 9711.6 615.7 618.1 620.0 661.4 715.5 4447.8 4466.0 4499.6 4510.6 4572.4 68085.0 69310.7 69451.0 69487.3 69573.7 53309.7 54609.5 56391.0 57121.1 57280.4 46371.3 46398.8 46994.0 47844.5 47948.5 9521.5 9578.6 9812.4 10139.2 10232.0 37924.4 38743.0 39828.2 39934.0 39983.8 44418.6 45968.0 49843.0 50179.7 51673.7 11944.9 12295.4 12370.7 12591.8 12813.9 12776.2 13273.5 13682.6 14233.3 14592.7 12274.9 12975.0 13035.7 13120.7 13362.6 12414.6 12690.4 12715.4 12814.5 12890.6 13102.3 13214.7 13500.2 13538.1 13685.7 10594.9 10908.6 10923.5 11049.1 11436.0 11035.6 11130.1 11325.5 11334.6 11524.9 23:20:19 INFO - PROCESS | 4288 | -------- Summary: end -------- 23:20:19 INFO - PROCESS | 4288 | 23:20:20 INFO - TEST-INFO | 4288: exit 0 23:20:20 INFO - TEST-OK | dromaeo_css | took 1111350ms 23:20:20 INFO - TEST-START | kraken 23:20:20 INFO - operating with platform_type : linux_ 23:20:20 INFO - Initialising browser for kraken test... 23:20:20 INFO - TEST-INFO | started process 4489 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMZsKG_/profile http://localhost:49430/getInfo.html) 23:20:23 INFO - PROCESS | 4489 | __metrics Screen width/height:1600/1200 23:20:23 INFO - PROCESS | 4489 | colorDepth:24 23:20:23 INFO - PROCESS | 4489 | Browser inner width/height: 1024/697 23:20:23 INFO - PROCESS | 4489 | __metrics 23:20:25 ERROR - PROCESS | 4489 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:20:25 INFO - TEST-INFO | 4489: exit 0 23:20:25 INFO - Browser initialized. 23:20:25 INFO - Running cycle 1/1 for kraken test... 23:20:25 INFO - TEST-INFO | started process 4581 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMZsKG_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:20:37 INFO - PROCESS | 4581 | RSS: Main: 139509760 23:20:37 INFO - PROCESS | 4581 | 23:20:40 INFO - PROCESS | 4581 | Cycle 1(1): loaded http://localhost:49430/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49430/tests/kraken/driver.html?testName=audio-beat-detection) 23:20:40 INFO - PROCESS | 4581 | RSS: Main: 198090752 23:20:40 INFO - PROCESS | 4581 | 23:20:43 INFO - PROCESS | 4581 | Cycle 1(1): loaded http://localhost:49430/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49430/tests/kraken/driver.html?testName=audio-dft) 23:20:44 INFO - PROCESS | 4581 | RSS: Main: 184061952 23:20:44 INFO - PROCESS | 4581 | 23:20:46 INFO - PROCESS | 4581 | Cycle 1(1): loaded http://localhost:49430/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49430/tests/kraken/driver.html?testName=audio-fft) 23:20:47 INFO - PROCESS | 4581 | RSS: Main: 273674240 23:20:47 INFO - PROCESS | 4581 | 23:20:49 INFO - PROCESS | 4581 | Cycle 1(1): loaded http://localhost:49430/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49430/tests/kraken/driver.html?testName=audio-oscillator) 23:20:50 INFO - PROCESS | 4581 | RSS: Main: 179523584 23:20:50 INFO - PROCESS | 4581 | 23:20:52 INFO - PROCESS | 4581 | Cycle 1(1): loaded http://localhost:49430/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49430/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:20:52 INFO - PROCESS | 4581 | RSS: Main: 177913856 23:20:52 INFO - PROCESS | 4581 | 23:20:55 INFO - PROCESS | 4581 | Cycle 1(1): loaded http://localhost:49430/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49430/tests/kraken/driver.html?testName=imaging-darkroom) 23:20:56 INFO - PROCESS | 4581 | RSS: Main: 213028864 23:20:56 INFO - PROCESS | 4581 | 23:20:59 INFO - PROCESS | 4581 | Cycle 1(1): loaded http://localhost:49430/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49430/tests/kraken/driver.html?testName=imaging-desaturate) 23:21:00 INFO - PROCESS | 4581 | RSS: Main: 212840448 23:21:00 INFO - PROCESS | 4581 | 23:21:03 INFO - PROCESS | 4581 | Cycle 1(1): loaded http://localhost:49430/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49430/tests/kraken/driver.html?testName=json-parse-financial) 23:21:03 INFO - PROCESS | 4581 | RSS: Main: 212582400 23:21:03 INFO - PROCESS | 4581 | 23:21:05 INFO - PROCESS | 4581 | Cycle 1(1): loaded http://localhost:49430/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49430/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:21:05 INFO - PROCESS | 4581 | RSS: Main: 192536576 23:21:05 INFO - PROCESS | 4581 | 23:21:07 INFO - PROCESS | 4581 | Cycle 1(1): loaded http://localhost:49430/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49430/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:21:08 INFO - PROCESS | 4581 | RSS: Main: 197562368 23:21:08 INFO - PROCESS | 4581 | 23:21:10 INFO - PROCESS | 4581 | Cycle 1(1): loaded http://localhost:49430/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49430/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:21:10 INFO - PROCESS | 4581 | RSS: Main: 210395136 23:21:10 INFO - PROCESS | 4581 | 23:21:13 INFO - PROCESS | 4581 | Cycle 1(1): loaded http://localhost:49430/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49430/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:21:13 INFO - PROCESS | 4581 | RSS: Main: 216752128 23:21:13 INFO - PROCESS | 4581 | 23:21:16 INFO - PROCESS | 4581 | Cycle 1(1): loaded http://localhost:49430/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49430/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:21:17 INFO - PROCESS | 4581 | RSS: Main: 213843968 23:21:17 INFO - PROCESS | 4581 | 23:21:18 INFO - PROCESS | 4581 | Cycle 1(1): loaded http://localhost:49430/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49430/tests/kraken/driver.html?testName=ai-astar) 23:21:19 INFO - PROCESS | 4581 | RSS: Main: 274341888 23:21:19 INFO - PROCESS | 4581 | 23:21:19 INFO - PROCESS | 4581 | __start_tp_report 23:21:19 INFO - PROCESS | 4581 | _x_x_mozilla_page_load 23:21:19 INFO - PROCESS | 4581 | _x_x_mozilla_page_load_details 23:21:19 INFO - PROCESS | 4581 | |i|pagename|runs| 23:21:19 INFO - PROCESS | 4581 | |0;ai-astar;109;110;110;110;111;113;107;110;111;110 23:21:19 INFO - PROCESS | 4581 | |1;audio-beat-detection;158;127;151;176;133;161;160;134;194;127 23:21:19 INFO - PROCESS | 4581 | |2;audio-dft;161;160;161;162;160;160;160;161;161;160 23:21:19 INFO - PROCESS | 4581 | |3;audio-fft;76;76;73;173;76;76;76;76;174;75 23:21:19 INFO - PROCESS | 4581 | |4;audio-oscillator;92;93;152;93;91;93;151;93;91;158 23:21:19 INFO - PROCESS | 4581 | |5;imaging-gaussian-blur;116;117;116;117;117;116;117;117;118;117 23:21:19 INFO - PROCESS | 4581 | |6;imaging-darkroom;146;146;145;146;145;145;145;147;146;145 23:21:19 INFO - PROCESS | 4581 | |7;imaging-desaturate;95;95;95;95;95;95;95;96;95;95 23:21:19 INFO - PROCESS | 4581 | |8;json-parse-financial;56;58;55;55;56;56;58;74;53;54 23:21:19 INFO - PROCESS | 4581 | |9;json-stringify-tinderbox;60;61;60;59;60;60;62;60;64;61 23:21:19 INFO - PROCESS | 4581 | |10;stanford-crypto-aes;73;71;72;73;73;73;73;72;81;72 23:21:19 INFO - PROCESS | 4581 | |11;stanford-crypto-ccm;118;116;113;114;112;114;113;111;129;129 23:21:19 INFO - PROCESS | 4581 | |12;stanford-crypto-pbkdf2;159;157;167;157;164;161;157;167;156;159 23:21:19 INFO - PROCESS | 4581 | |13;stanford-crypto-sha256-iterative;67;70;68;68;67;68;68;65;66;66 23:21:19 INFO - PROCESS | 4581 | __end_tp_report 23:21:19 INFO - PROCESS | 4581 | __start_cc_report 23:21:19 INFO - PROCESS | 4581 | _x_x_mozilla_cycle_collect,1566 23:21:19 INFO - PROCESS | 4581 | __end_cc_report 23:21:19 INFO - PROCESS | 4581 | __startTimestamp1468477279021__endTimestamp 23:21:19 INFO - PROCESS | 4581 | 23:21:19 INFO - PROCESS | 4581 | ------- Summary: start ------- 23:21:19 INFO - PROCESS | 4581 | Number of tests: 14 23:21:19 INFO - PROCESS | 4581 | 23:21:19 INFO - PROCESS | 4581 | [#0] ai-astar Cycles:10 Average:110.10 Median:110.00 stddev:1.52 (1.4%) stddev-sans-first:1.56 23:21:19 INFO - PROCESS | 4581 | Values: 109.0 110.0 110.0 110.0 111.0 113.0 107.0 110.0 111.0 110.0 23:21:19 INFO - PROCESS | 4581 | 23:21:19 INFO - PROCESS | 4581 | [#1] audio-beat-detection Cycles:10 Average:152.10 Median:159.00 stddev:22.25 (14.0%) stddev-sans-first:23.50 23:21:19 INFO - PROCESS | 4581 | Values: 158.0 127.0 151.0 176.0 133.0 161.0 160.0 134.0 194.0 127.0 23:21:19 INFO - PROCESS | 4581 | 23:21:19 INFO - PROCESS | 4581 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 23:21:19 INFO - PROCESS | 4581 | Values: 161.0 160.0 161.0 162.0 160.0 160.0 160.0 161.0 161.0 160.0 23:21:19 INFO - PROCESS | 4581 | 23:21:19 INFO - PROCESS | 4581 | [#3] audio-fft Cycles:10 Average:95.10 Median:76.00 stddev:41.33 (54.4%) stddev-sans-first:43.26 23:21:19 INFO - PROCESS | 4581 | Values: 76.0 76.0 73.0 173.0 76.0 76.0 76.0 76.0 174.0 75.0 23:21:19 INFO - PROCESS | 4581 | 23:21:19 INFO - PROCESS | 4581 | [#4] audio-oscillator Cycles:10 Average:110.70 Median:92.50 stddev:29.71 (32.1%) stddev-sans-first:30.74 23:21:19 INFO - PROCESS | 4581 | Values: 92.0 93.0 152.0 93.0 91.0 93.0 151.0 93.0 91.0 158.0 23:21:19 INFO - PROCESS | 4581 | 23:21:19 INFO - PROCESS | 4581 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 23:21:19 INFO - PROCESS | 4581 | Values: 116.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 118.0 117.0 23:21:19 INFO - PROCESS | 4581 | 23:21:19 INFO - PROCESS | 4581 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 23:21:19 INFO - PROCESS | 4581 | Values: 146.0 146.0 145.0 146.0 145.0 145.0 145.0 147.0 146.0 145.0 23:21:19 INFO - PROCESS | 4581 | 23:21:19 INFO - PROCESS | 4581 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 23:21:19 INFO - PROCESS | 4581 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 23:21:19 INFO - PROCESS | 4581 | 23:21:19 INFO - PROCESS | 4581 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:56.00 stddev:6.00 (10.7%) stddev-sans-first:6.34 23:21:19 INFO - PROCESS | 4581 | Values: 56.0 58.0 55.0 55.0 56.0 56.0 58.0 74.0 53.0 54.0 23:21:19 INFO - PROCESS | 4581 | 23:21:19 INFO - PROCESS | 4581 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:60.50 stddev:1.42 (2.3%) stddev-sans-first:1.48 23:21:19 INFO - PROCESS | 4581 | Values: 60.0 61.0 60.0 59.0 60.0 60.0 62.0 60.0 64.0 61.0 23:21:19 INFO - PROCESS | 4581 | 23:21:19 INFO - PROCESS | 4581 | [#10] stanford-crypto-aes Cycles:10 Average:73.30 Median:73.00 stddev:2.79 (3.8%) stddev-sans-first:2.96 23:21:19 INFO - PROCESS | 4581 | Values: 73.0 71.0 72.0 73.0 73.0 73.0 73.0 72.0 81.0 72.0 23:21:19 INFO - PROCESS | 4581 | 23:21:19 INFO - PROCESS | 4581 | [#11] stanford-crypto-ccm Cycles:10 Average:116.90 Median:115.00 stddev:6.67 (5.8%) stddev-sans-first:7.07 23:21:19 INFO - PROCESS | 4581 | Values: 118.0 116.0 113.0 114.0 112.0 114.0 113.0 111.0 129.0 129.0 23:21:19 INFO - PROCESS | 4581 | 23:21:19 INFO - PROCESS | 4581 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.40 Median:160.00 stddev:4.20 (2.6%) stddev-sans-first:4.42 23:21:19 INFO - PROCESS | 4581 | Values: 159.0 157.0 167.0 157.0 164.0 161.0 157.0 167.0 156.0 159.0 23:21:19 INFO - PROCESS | 4581 | 23:21:19 INFO - PROCESS | 4581 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:68.00 stddev:1.42 (2.1%) stddev-sans-first:1.50 23:21:19 INFO - PROCESS | 4581 | Values: 67.0 70.0 68.0 68.0 67.0 68.0 68.0 65.0 66.0 66.0 23:21:19 INFO - PROCESS | 4581 | -------- Summary: end -------- 23:21:19 INFO - PROCESS | 4581 | 23:21:20 INFO - TEST-INFO | 4581: exit 0 23:21:20 INFO - TEST-OK | kraken | took 59935ms 23:21:20 INFO - SUITE-END | took 1171s 23:21:20 INFO - Completed test suite (00:19:31) 23:21:20 INFO - javascript benchmark 23:21:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3281.310924705812, 3349.346877358916, 3356.379069872073, 3383.8308084595765, 3398.2863598644285, 5445.646033007852, 5447.727613619318, 5472.206530053145, 5473.042217611917, 5486.451354864512, 5457.617966742329, 5496.0, 5505.52843908756, 5515.806946756854, 5527.977324195027, 4830.9516904831025, 4850.199717046683, 4919.508049195088, 5050.393952725678, 5084.415292241384, 4910.877228069291, 4984.601231901439, 4991.226359914219, 4992.750362481861, 4995.800167993276, 4920.286558449041, 4975.975120124413, 4990.775415106311, 4999.850004499871, 5008.599312055045, 5023.974880125595, 5036.722980236085, 5050.595952323805, 5055.216441451581, 5084.872878178038, 4823.155947709137, 4869.342638743759, 4905.190643543811, 4957.876053098666, 4986.850394488171, 5317.548008419289, 5377.274068000809, 5378.139497680352, 5395.082835917903, 5395.892082158335, 5850.912236316459, 5899.764009439617, 5908.734106965197, 5908.793192238251, 5908.852278693067, 5788.04497257952, 5847.795327163529, 5855.355910849803, 5889.116632505158, 5946.583739138262, 5476.233327334136, 5486.039943009957, 5523.834284971457, 5597.552195824324, 5598.24423702799, 5885.529157667376, 6070.726817293233, 6087.3303936566945, 6089.330173680892, 6089.634621922699, 5787.536997040227, 5831.620944638585, 5837.241158649434, 5846.883062338729, 5853.473187413153, 5849.356570777211, 5852.180694702745, 5855.853603659943, 5864.2083318752275, 5866.5893387462465, 5706.172604972338, 5776.249087618667, 5819.981503236917, 5822.184894114827, 5828.329742079631, 5806.158107074535, 5815.680137592473, 5823.039198532279, 5823.767049318065, 5860.413958604191, 4479.910401792011, 4481.484629267611, 4482.282834746425, 4490.685652004328, 4511.075229577994, 3932.174243408859, 3968.980155099206, 4015.257177422186, 4062.431259623655, 4063.553009168989, 5633.183188437735, 5662.8301150965535, 5667.4615911488345, 5670.262865827416, 5671.404502527258, 5928.407159284037, 5936.7031648417405, 5937.554683398763, 5941.049432090845, 5944.316403613553, 5500.614956952975, 5636.60543761941, 5637.267155269788, 5699.544036477072, 5726.856828579319, 4970.403551573762, 4978.676386034968, 4981.825636102719, 4984.352034235526, 5021.874453138701, 6093.390660933871, 6106.389361063947, 6109.5112391008615, 6111.236095488064, 6117.296510901214, 5718.656880587178, 5935.940640593712, 5975.223220981245, 5983.072623743326, 5989.071693887455, 6092.939070609237, 6094.786682466092, 6102.664353460602, 6103.969480152571, 6109.022556391134, 5609.411011843697, 5723.227364305765, 5741.196232527533, 5745.482906538432, 5770.942290577041, 5830.329512105993, 5927.881442371215, 5927.940720592739, 5928.4960778334325, 5965.194698715618, 5620.522255608319, 5655.773769049357, 5661.348944871393, 5664.348599911063, 5668.3198016236665, 5610.242617246619, 5652.095664693629, 5656.0, 5659.122835960433, 5659.462351076641, 5661.716914154358, 5709.029464991045, 5710.400407957105, 5713.257276554022, 5742.885142297214, 5762.250907382014, 5788.710564471844, 5796.536277097738, 5811.82564523065, 5815.534757219328, 5434.755436005468, 5535.0, 5587.69267690281, 5710.200571920018, 5727.255456790591], "value": 5418.03808446141, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [652.4714980865499, 660.2473180574143, 675.2538445018251, 682.423352267334, 741.9760730192336, 32258.193545161354, 32818.50772238418, 32841.67158328416, 32849.0, 41475.17049659012, 45273.641790746246, 45531.772341138334, 45900.770496147474, 45930.31104533435, 46015.76992115043, 8804.779880503007, 8984.595693193822, 8987.865182022275, 8988.325875559327, 8988.77528061797, 8806.20744133028, 8826.117388261187, 8888.244499217575, 8908.465492070496, 8916.15296546827, 8894.066123057082, 8920.330975176856, 8925.41984770991, 9117.635294588208, 9194.08059194082, 9096.499692516909, 9115.772105697377, 9159.35884488086, 9172.220361269234, 9172.816543669089, 9111.589978450986, 9200.907990920072, 9210.447373157565, 9215.03242159577, 9218.769530761785, 43418.78290608527, 43908.78045609783, 44109.77945110254, 44120.779396103135, 44156.0, 3700.3709369407266, 3894.6105389460827, 4278.893027674302, 4348.065165989296, 4359.912801743947, 33753.32493350119, 34471.0, 34518.0, 34720.82639586811, 35979.64020359815, 4577.588017078446, 4605.286180642006, 4634.559716826896, 4645.790939407735, 4657.697249678794, 325982.0, 326337.0, 327686.0, 327762.0, 327763.0, 40117.0, 63788.362116378245, 64985.0, 65005.34994650088, 65067.34932650708, 38151.0, 38206.42690359647, 38278.80860595735, 38356.616433835305, 38368.04079898025, 17421.47735567935, 17458.65082698339, 17535.824641753417, 17551.73672394915, 17570.209340579706, 13495.122817017058, 13506.189628622315, 13509.189448632917, 13511.324433778469, 13515.729685406237, 9586.376885502421, 9595.42427454355, 9651.951740241395, 9653.46905920167, 9656.95171524138, 3628.76413033152, 3709.870154544578, 3718.8140592970785, 3746.4193050076738, 3753.868614598476, 1155.4742592120565, 1173.8239264110452, 1175.2537138916678, 1198.93294967479, 1199.8500187476566, 33968.49047264293, 34007.4898876517, 34538.48192277118, 34607.82696086504, 34644.13389665228, 1219.920705154162, 1225.877412258767, 1233.2846948769693, 1295.578936845529, 1302.7174806161108, 17730.91134544319, 17987.370442034466, 18078.728819067725, 18095.0, 18110.094495275447, 500086.0, 503240.0, 504682.0, 506051.0, 507724.0751758615, 63030.0, 63992.68003659952, 64077.67961160164, 64252.678736606955, 64268.0, 1357.6402253402857, 1464.0849469081825, 1494.7085318363033, 1516.9696606067596, 1587.1508742822534, 30354.392912141193, 31218.375632487678, 31552.403781465287, 31993.68006319907, 32237.0, 51739.22391164211, 52269.0, 52275.73862130665, 52276.47723522716, 52404.47595523996, 304801.0, 306308.0, 308238.0, 308755.0, 310046.0, 27428.862855685595, 31559.053228403183, 31615.841920790248, 31785.523217151298, 32613.836930816142, 45284.0, 53366.199507008205, 53667.19499207593, 53923.19115213196, 54413.45586544084, 39295.41056884092, 40045.79977100096, 40509.39235911405, 40639.1872162561, 41522.0, 41426.37860432156, 41744.58255417407, 42140.157196856504, 43440.78279608582, 43473.34789978216, 42993.570064298954, 43529.34705979476, 43582.346264806685, 44359.11281774411, 44509.77745111254, 37075.25849482941, 37552.310146042946, 38179.42730858984, 38302.233955321295, 38401.4239786409, 28832.711672883004, 29291.369852813255, 29454.0, 29505.704942950295, 29704.0], "value": 19638.66603796984, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [431.421894661154, 434.68485348122607, 435.6188335206694, 440.4120499133657, 453.94098767160267, 18095.547611309707, 18322.633547329046, 18674.813251867476, 20983.47541311468, 21300.57398852022, 20261.392158235278, 20297.49256268594, 20620.587588248225, 20631.484212894684, 20659.793402066014, 5482.0, 5967.552433567478, 5967.6121052131475, 5973.940260597404, 5974.8506287342725, 4176.18564379946, 5784.768609255625, 5958.136070269808, 6260.123582698426, 6539.574927629689, 6428.4857211423205, 6434.227892652888, 6485.93514064858, 6503.28463868974, 6506.349365063503, 5850.912236316459, 6121.724522396503, 6141.846453838645, 6145.0, 6447.935520644781, 3793.468914351993, 3805.3721136012523, 5547.750351234164, 5552.77788888444, 5812.099124635688, 14403.567892963229, 14794.556163315117, 14868.925655371762, 14873.553793386216, 21293.5741285175, 2441.59713647248, 2467.592847180213, 2526.456811785475, 2563.4250788918703, 2603.80471464639, 10280.331778434453, 10609.310394824312, 10660.093892019187, 11075.556977720882, 13523.98570107236, 1985.6128055029276, 2076.809130404535, 2104.884231367274, 2105.2421128393767, 2106.557622899193, 80972.0, 81045.0, 81933.18066819315, 84285.15714842835, 93009.53495232548, 17166.39917602878, 17581.7362739559, 17591.0, 17933.551661208574, 18018.36935707244, 34305.0, 34500.82749586236, 34714.30571388558, 34984.475232871526, 35146.82426587902, 10415.635452759117, 10724.678259652223, 10904.291221070764, 11150.107991360672, 11482.655520334403, 9519.666811661558, 9610.327277090537, 9639.469829159463, 9652.0, 9679.516024198761, 9550.856737148948, 9562.330636855353, 9634.0, 9838.458884761263, 9846.212303015742, 3124.5781819454537, 3274.6397896231397, 3715.9071023224096, 3759.774413535197, 3827.75119617224, 1010.5553556435145, 1089.319175515303, 1100.460774220626, 1106.9446527673583, 1115.4980258883536, 18386.908065459855, 18492.907535462506, 19112.426627201206, 19147.0, 19314.71027934582, 1051.3271506236015, 1082.5182793656904, 1111.4053981120062, 1122.5565901468874, 1123.6404350607727, 10185.0, 10554.0, 10593.152547796159, 10620.840687389695, 10668.839967400496, 463917.0, 466026.0, 480437.0, 481099.0, 488158.0, 55199.0, 59017.114743278886, 88326.55836720775, 98134.0, 102203.0, 1067.3755852826027, 1096.7203363142348, 1119.182996412607, 1125.5160281079216, 1143.3025854228913, 17135.314587416364, 17305.65388692194, 17402.21690023977, 17470.563235919202, 17895.73156402629, 38138.23723525569, 38334.424983625824, 39283.607163928, 39897.00257493586, 40043.79978100091, 57477.42522574721, 57999.71000144972, 58053.709731451076, 58167.0, 58457.123143152035, 8899.866502002606, 8905.376623636283, 8948.642054317754, 9188.494632794993, 9194.26445884341, 8328.138142595471, 10659.786804264026, 13283.136596121221, 13466.528671496451, 13585.52450664222, 11297.26567773092, 11660.475278612314, 11689.357085360387, 11993.34036627994, 12007.219530730474, 11322.660320190407, 11427.542898284308, 11432.37121958267, 11569.595064172714, 11589.82615260755, 6064.545159113172, 9561.569729362334, 9756.121949024622, 11915.702107447383, 11960.401979900797, 8680.305575554066, 8851.601677924638, 8963.507007114671, 9017.864732028893, 9099.317551183556, 11273.267237629529, 11897.762044758883, 11922.52309907594, 11936.28382297065, 12112.697182570506], "value": 10054.964764935306, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1395.6929475515383, 1551.7284475216836, 1554.4015554011705, 1782.9732554011684, 1894.8484121270292, 7243.0946131733535, 8235.382346324028, 8386.958065209681, 8405.91594084059, 8429.831403371929, 8318.91681083189, 8493.91506084939, 8500.872486912702, 8501.829963400729, 8503.447275927061, 2435.7564243575634, 2457.7296497385273, 2460.6555082288405, 2460.778529932306, 2461.876906154685, 2364.203995336797, 2455.963160552584, 2467.1858286765323, 2470.814688898331, 2472.09768434521, 2404.759524047599, 2409.6144616861307, 2409.7108346998384, 2434.4887573609562, 2436.2569416328015, 2420.068273714615, 2426.6360045993156, 2431.8297719159664, 2438.2807071913826, 2480.3303108160876, 2407.5305315463493, 2409.3976505873534, 2433.7201221859536, 2436.7319594844553, 2439.7682220189054, 6966.12923384577, 7113.075300210991, 8587.141285871425, 8630.352723545759, 8638.61126249314, 5145.3568303962, 5250.107481728077, 5251.238570407308, 5252.947470525284, 5257.7108259045735, 3282.3435312937268, 3288.934221315584, 3339.8497067632015, 3340.8830690925943, 3372.6627337266323, 1071.181927034428, 1115.8772535021142, 1128.1313388690662, 1129.8700649425339, 1131.4116659337099, 12216.816747748791, 12333.198342107735, 12348.938255308665, 12350.320732359716, 12358.62924112278, 4640.489546149921, 4690.718556886598, 4758.976205118952, 4772.0, 4825.565699087099, 10420.166386689047, 10485.633002844865, 10489.055984961238, 10495.737606559896, 10497.107745841537, 5346.759395827197, 5346.8663283417445, 5385.78456861729, 5387.3804512481565, 5395.919061214085, 4890.706557606555, 4929.383827021622, 4932.383452068491, 4939.456659767423, 4943.258511223274, 3964.0882597002274, 3998.6801055915457, 4022.738521996061, 4023.7786921719585, 4046.2716710992304, 1228.65597632663, 1255.6609715376796, 1258.3079306381453, 1267.7844766389735, 1267.8985681145487, 909.7543663210896, 994.2543092680489, 1025.6871654145557, 1046.2623850185753, 1053.2785042246087, 6014.18808460861, 6074.757009719562, 6131.724072416752, 6132.816015519542, 6162.7226774795245, 1051.4217180550665, 1055.8521806947033, 1060.2313322840878, 1068.3002633275216, 1078.6710053433621, 4058.1072164123843, 4144.668426525871, 4174.0, 4178.05993651426, 4248.936265956013, 10071.59713611462, 10239.283250172417, 10428.0, 10497.370157790558, 10523.52644131016, 10330.380177189243, 10335.844962325571, 10337.483125843677, 10345.0, 10357.533910973874, 8187.754367368989, 8355.791105222297, 8363.038250601137, 8364.832703345899, 8365.1216622255, 5787.576109667689, 5819.82540523785, 5822.243108395882, 5828.94171058301, 5999.91000135007, 9452.196563292197, 9477.099675530813, 9573.569189386633, 9649.710508684751, 9720.416774993522, 9435.858462123211, 9856.704298871045, 9873.111419972238, 9937.850932236166, 9967.40195588267, 7843.372530197456, 7917.247861453153, 7942.920570794449, 7952.443328966917, 7959.880601790862, 8463.873041904499, 8512.872306915277, 8516.40385173032, 8523.701670441505, 8524.232819046067, 7380.409567234716, 7508.136564295176, 7508.549487030796, 7537.6984920604755, 7653.19641437641, 7332.120145582564, 7362.0, 7368.668409921674, 7389.261073892568, 7454.92545074564, 7150.034745309316, 7210.0, 7218.602976836324, 7223.674934627849, 7225.891611625725, 5112.437631860566, 5113.8721531962, 5208.4270730220405, 5219.973900130475, 5328.0, 5114.309568208244, 5214.478552144907, 5222.6083043771105, 5285.207218917193, 5298.920516192183], "value": 4664.701496245812, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.88076232937306, 337.6050021474873, 342.50585480093673, 348.1279395115236, 349.1620111731845, 6038.124471951564, 6047.0, 6086.7869624563145, 6095.847603809902, 6113.266408031037, 5744.396838331978, 5889.558283128772, 6076.149339092531, 6088.634681919088, 6116.327204007567, 4579.107074120548, 4652.116097941397, 4671.205894997858, 4671.719696818185, 4675.929861052078, 4613.354130421743, 4641.0, 4679.3682852814945, 4703.2239680452685, 4707.340972263886, 4440.356148358486, 4520.163769702599, 4591.931121033187, 4608.331791890174, 4632.351470794075, 4601.033782905593, 4626.097910907374, 4627.190241707722, 4649.767511624439, 4655.441347038343, 4093.570175131628, 4099.938500922489, 4105.835766569334, 4107.835686572534, 4108.404281379213, 5875.177475153482, 5881.500072493843, 5886.381929897342, 5890.823275301748, 5895.734691938873, 5436.184572314145, 5437.184422336642, 5440.646357986719, 5446.782128714846, 5455.099908515091, 6205.503559715212, 6419.0, 6427.389398007182, 6455.354464553554, 6456.28980812115, 4557.065801510682, 4572.337011133401, 4576.885577860547, 4579.175748365293, 4581.725096494221, 6640.568363056386, 6718.328167183291, 6730.798076057726, 6732.528722989393, 6742.393184613408, 4590.678652494294, 4602.930956035662, 4604.0, 4605.976970115128, 4609.285560738091, 4643.976780116078, 4660.976695116503, 4664.743439110882, 4668.626509879202, 4669.673122881366, 5258.0, 5369.973150134302, 5375.811846585429, 5387.676739395571, 5396.865078373072, 6466.191726034246, 6473.870522589522, 6493.0, 6503.902441463382, 6504.414602685686, 1563.4527915229805, 1626.1706529669952, 1627.7558366245157, 1666.7166581681142, 1671.498550434889, 1103.5199688135688, 1123.0678536814423, 1123.601121601836, 1128.328644456547, 1130.5534313945946, 6265.96867015662, 6268.122462855204, 6279.937200628026, 6285.497160227171, 6301.495880329563, 6567.113439685677, 6605.735770569219, 6607.603543787292, 6620.867582648417, 6624.205095388488, 6277.654728989949, 6285.497160227171, 6288.496920246369, 6289.056641503719, 6295.905561416583, 3542.5926018507685, 3558.87543935961, 3562.9691076086383, 3569.3575156472084, 3572.0891172751303, 6787.864242715118, 6898.793036208922, 6914.654267286615, 6938.653067346713, 6959.164900211906, 6749.122614060141, 6757.695903684346, 6764.0868482754195, 6771.864562708718, 6774.796756097325, 6931.549449285781, 6932.23745388007, 6936.167659880846, 6937.479689023344, 6945.37491625746, 6590.0, 6591.835204119935, 6594.340565943367, 6596.70314835824, 6600.867982640416, 6307.180066591313, 6517.315681853337, 6533.0853680485725, 6584.045313429621, 6624.536282460182, 6871.312868713088, 6912.4815638828295, 6915.827104322432, 6928.411085057625, 6939.757108501179, 4642.141203877293, 4648.325992730967, 4654.48800631937, 4655.3249778782565, 4655.743934083523, 6339.683015849281, 6500.25247096571, 6564.343565643398, 6567.113439685581, 6572.671366431564, 6367.586106903036, 6495.610263384212, 6503.317151699192, 6503.772367967098, 6512.3162067982175, 6453.419192272718, 6459.063435801876, 6470.158879345655, 6477.287498375081, 6490.870182596416, 6341.904871427025, 6371.23545174582, 6383.553151279366, 6401.231852177769, 6402.679866006588, 6291.622502649856, 6489.870202595827, 6508.121403610452, 6519.771807986698, 6522.249941256627, 6433.163688720437, 6481.351864813481, 6505.349465053646, 6511.479081673549, 6515.2833188348295], "value": 4881.018688081138, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [757.5681861339035, 779.3025242408048, 836.1554829622083, 836.9246767790897, 844.9070602233753, 14877.776833347509, 15170.089794612331, 15199.848001519982, 15223.619409514768, 15268.694626107485, 13894.166350019006, 13990.090644108152, 14053.648658783535, 14064.085834420755, 14071.0, 733.3326672727819, 887.3344991256541, 891.8795962545038, 905.3617199874105, 908.513945039404, 895.1004240738049, 904.3398319226968, 906.2568693671192, 906.2568693671192, 906.6962567539849, 952.0099096939175, 956.7129861041694, 957.6887511558737, 958.9328746987713, 959.4914695211514, 770.3182683325241, 780.6448066129925, 933.5005771912063, 944.2398868910524, 952.0336858089045, 698.8427603789107, 698.9965050174717, 699.1330749870175, 699.2552931128383, 700.1038670501715, 14786.112833230041, 14830.406783728638, 14854.851451485454, 14863.479778207819, 14878.0, 14751.77872331916, 15113.3199006045, 15197.924010379877, 15223.771643425358, 15347.693046139126, 11651.067914566815, 11714.941425292818, 11793.174477786559, 11824.586139485164, 11928.403579820973, 3888.6500214980506, 3968.3452230381954, 3975.6223158799867, 3993.94009089861, 4046.6964977626794, 57477.71261143709, 57503.13745293824, 57520.0, 57901.13148302779, 58047.419525804624, 10889.237753357347, 11143.387113708824, 11215.158863085302, 11468.4839182237, 11708.356040417859, 21311.68032479483, 21425.785742142692, 21478.892605536872, 21480.355589332346, 21486.892565537073, 8371.455855369382, 8480.194381533744, 8500.277476414574, 8606.0, 9018.954905225432, 4277.1873344064525, 4333.328334108218, 4968.72672003036, 5025.447200807908, 5073.670211436245, 3277.868885244611, 3332.2502436951977, 3332.483465062919, 3342.364950659367, 3345.7825241359233, 585.3970410477215, 588.7115313496356, 589.2222266608122, 595.3926994465621, 596.8299034775068, 656.5535435903631, 747.9775606731806, 751.2149803455402, 751.4251597527896, 751.9962400188074, 9341.673041443517, 9490.335676502578, 9634.71095867125, 9693.70918872435, 9711.562979665932, 615.7383112177307, 618.1253526260291, 620.0327489116902, 661.3512880911917, 715.5492040014757, 4447.844325448658, 4466.0, 4499.617532509773, 4510.571495707903, 4572.3827283317, 68085.0, 69310.65344673244, 69451.0, 69487.3051269491, 69573.65213173901, 53309.7334513325, 54609.45390546123, 56391.0, 57121.14318285229, 57280.42719572834, 46371.30443043357, 46398.76800615976, 46994.00550953139, 47844.521554784704, 47948.520514795804, 9521.476318802532, 9578.616855325708, 9812.362196457207, 10139.239557033105, 10232.0, 37924.43113353247, 38743.0, 39828.20343593054, 39934.001649958984, 39983.80008099941, 44418.55581444144, 45968.0, 49843.0, 50179.74910125426, 51673.74163129311, 11944.940275298568, 12295.446704898122, 12370.690732731753, 12591.811122833347, 12813.93593032029, 12776.233425994471, 13273.469061237829, 13682.589522314347, 14233.288335583387, 14592.708145836812, 12274.877251227374, 12975.0, 13035.739285214053, 13120.671983200496, 13362.599122026355, 12414.565490207799, 12690.365481725692, 12715.364231788559, 12814.487420503076, 12890.613281601567, 13102.279374634487, 13214.735705285648, 13500.189988600716, 13538.120022198525, 13685.657858553217, 10594.894051059391, 10908.61819836302, 10923.453827308444, 11049.116070714163, 11436.0, 11035.613753518588, 11130.109591232844, 11325.490352934303, 11334.60328888485, 11524.942375288405], "value": 7024.986829289158, "unit": "score"}], "name": "dromaeo_css", "value": 7451.190712276531, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 110.0, 110.0, 111.0, 113.0, 107.0, 110.0, 111.0, 110.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 127.0, 151.0, 176.0, 133.0, 161.0, 160.0, 134.0, 194.0, 127.0], "value": 152.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 162.0, 160.0, 160.0, 160.0, 161.0, 161.0, 160.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 73.0, 173.0, 76.0, 76.0, 76.0, 76.0, 174.0, 75.0], "value": 95.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 152.0, 93.0, 91.0, 93.0, 151.0, 93.0, 91.0, 158.0], "value": 110.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 118.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 147.0, 146.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 55.0, 55.0, 56.0, 56.0, 58.0, 74.0, 53.0, 54.0], "value": 57.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 59.0, 60.0, 60.0, 62.0, 60.0, 64.0, 61.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 71.0, 72.0, 73.0, 73.0, 73.0, 73.0, 72.0, 81.0, 72.0], "value": 73.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 116.0, 113.0, 114.0, 112.0, 114.0, 113.0, 111.0, 129.0, 129.0], "value": 116.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 157.0, 167.0, 157.0, 164.0, 161.0, 157.0, 167.0, 156.0, 159.0], "value": 160.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 68.0, 68.0, 67.0, 68.0, 68.0, 65.0, 66.0, 66.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1522.2, "alertThreshold": 2.0}]} 23:21:20 INFO - Return code: 0 23:21:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:21:20 ERROR - # TBPL SUCCESS # 23:21:20 INFO - Running post-action listener: _resource_record_post_action 23:21:20 INFO - Running post-run listener: _resource_record_post_run 23:21:21 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 465100800; Read time: 0; Write time: 391240 23:21:21 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 242253824; Read time: 0; Write time: 261096 23:21:21 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 222310400; Read time: 0; Write time: 130144 23:21:21 INFO - Running post-run listener: _upload_blobber_files 23:21:21 INFO - Blob upload gear active. 23:21:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:21:21 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 23:21:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:21:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:21:21 INFO - (blobuploader) - INFO - Open directory for files ... 23:21:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:21:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:21:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:21:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:21:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:21:22 INFO - (blobuploader) - INFO - Done attempting. 23:21:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:21:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:21:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:21:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:21:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:21:23 INFO - (blobuploader) - INFO - Done attempting. 23:21:23 INFO - (blobuploader) - INFO - Iteration through files over. 23:21:23 INFO - Return code: 0 23:21:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:21:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:21:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bbfad73ff948dc9d8e2a3abc8f3c8815504f9b9dfdcea2342ad443e63f51e4c5afb6b8ce94ef1eb9fce782bda17ccead19f0368eb04d1fc8b2e3b00bbf31126c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4fa8f921bbba2806757ecc1e3300670dc63b8830a0967b37a99f14efa2762c16c33bc1e9ce379739f12b16c4c26809a4954c5abc97b5934751b7c002e9ec1109"} 23:21:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:21:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:21:23 INFO - Contents: 23:21:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bbfad73ff948dc9d8e2a3abc8f3c8815504f9b9dfdcea2342ad443e63f51e4c5afb6b8ce94ef1eb9fce782bda17ccead19f0368eb04d1fc8b2e3b00bbf31126c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4fa8f921bbba2806757ecc1e3300670dc63b8830a0967b37a99f14efa2762c16c33bc1e9ce379739f12b16c4c26809a4954c5abc97b5934751b7c002e9ec1109"} 23:21:23 INFO - Running post-run listener: copy_logs_to_upload_dir 23:21:23 INFO - Copying logs to upload dir... 23:21:23 INFO - mkdir: /builds/slave/test/build/upload/logs 23:21:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1223.053750 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 23 secs) (at 2016-07-13 23:21:23.080805) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 23:21:23.084682) ========= 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=c6927cf182745ad25b1d38b9000001fe-1468476058.395810-1770045172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bbfad73ff948dc9d8e2a3abc8f3c8815504f9b9dfdcea2342ad443e63f51e4c5afb6b8ce94ef1eb9fce782bda17ccead19f0368eb04d1fc8b2e3b00bbf31126c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4fa8f921bbba2806757ecc1e3300670dc63b8830a0967b37a99f14efa2762c16c33bc1e9ce379739f12b16c4c26809a4954c5abc97b5934751b7c002e9ec1109"} build_url:https://queue.taskcluster.net/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011554 build_url: 'https://queue.taskcluster.net/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bbfad73ff948dc9d8e2a3abc8f3c8815504f9b9dfdcea2342ad443e63f51e4c5afb6b8ce94ef1eb9fce782bda17ccead19f0368eb04d1fc8b2e3b00bbf31126c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4fa8f921bbba2806757ecc1e3300670dc63b8830a0967b37a99f14efa2762c16c33bc1e9ce379739f12b16c4c26809a4954c5abc97b5934751b7c002e9ec1109"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 23:21:23.110760) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:21:23.111084) ========= 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=c6927cf182745ad25b1d38b9000001fe-1468476058.395810-1770045172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004502 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:21:23.193197) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 23:21:23.193523) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 23:21:23.193809) ========= ========= Total master_lag: 0.17 =========