builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-002 starttime: 1464648648.77 results: success (0) buildid: 20160530120549 builduid: 7997d47d310b490c9d491deb39fe4327 revision: 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.772215) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.772803) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.773136) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.788421) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.788768) ========= 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=a0d2d2de893abaa8702a9954000001a7-1464644118.922297-1557251915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 15:50:49-- 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% 66.7M=0s 2016-05-30 15:50:49 (66.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121466 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.925215) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.925643) ========= 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=a0d2d2de893abaa8702a9954000001a7-1464644118.922297-1557251915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019666 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.977408) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.977869) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 --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=a0d2d2de893abaa8702a9954000001a7-1464644118.922297-1557251915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 15:50:49,369 truncating revision to first 12 chars 2016-05-30 15:50:49,369 Setting DEBUG logging. 2016-05-30 15:50:49,369 attempt 1/10 2016-05-30 15:50:49,369 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3c7a33fe0b64?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 15:50:49,710 unpacking tar archive at: mozilla-aurora-3c7a33fe0b64/testing/mozharness/ program finished with exit code 0 elapsedTime=0.673287 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:49.668546) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:49.669136) ========= script_repo_revision: 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:49.669819) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:49.670241) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:49.682779) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-05-30 15:50:49.683389) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1464644118.922297-1557251915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:50:50 INFO - MultiFileLogger online at 20160530 15:50:50 in /builds/slave/test 15:50:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 15:50:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:50:50 INFO - {'append_to_log': False, 15:50:50 INFO - 'base_work_dir': '/builds/slave/test', 15:50:50 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:50:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:50:50 INFO - 'branch': 'Mozilla-Aurora', 15:50:50 INFO - 'buildbot_json_path': 'buildprops.json', 15:50:50 INFO - 'config_files': ('talos/linux_config.py',), 15:50:50 INFO - 'default_actions': ('clobber', 15:50:50 INFO - 'read-buildbot-config', 15:50:50 INFO - 'download-and-extract', 15:50:50 INFO - 'populate-webroot', 15:50:50 INFO - 'create-virtualenv', 15:50:50 INFO - 'install', 15:50:50 INFO - 'run-tests'), 15:50:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:50:50 INFO - 'download_minidump_stackwalk': True, 15:50:50 INFO - 'download_symbols': 'ondemand', 15:50:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:50:50 INFO - 'tooltool.py': '/tools/tooltool.py', 15:50:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:50:50 INFO - '/tools/misc-python/virtualenv.py')}, 15:50:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:50:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:50:50 INFO - 'installer_path': 'installer.exe', 15:50:50 INFO - 'log_level': 'info', 15:50:50 INFO - 'log_name': 'talos', 15:50:50 INFO - 'log_to_console': True, 15:50:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:50:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:50:50 INFO - 'opt_config_files': (), 15:50:50 INFO - 'pip_index': False, 15:50:50 INFO - 'sps_profile': False, 15:50:50 INFO - 'sps_profile_interval': 0, 15:50:50 INFO - 'suite': 'dromaeojs', 15:50:50 INFO - 'system_bits': '32', 15:50:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:50:50 INFO - 'title': 'talos-linux64-ix-002', 15:50:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:50:50 INFO - 'use_talos_json': True, 15:50:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:50:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:50:50 INFO - 'work_dir': 'build'} 15:50:50 INFO - ##### 15:50:50 INFO - ##### Running clobber step. 15:50:50 INFO - ##### 15:50:50 INFO - Running pre-action listener: _resource_record_pre_action 15:50:50 INFO - Running main action method: clobber 15:50:50 INFO - rmtree: /builds/slave/test/build 15:50:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:50:50 INFO - Running post-action listener: _resource_record_post_action 15:50:50 INFO - ##### 15:50:50 INFO - ##### Running read-buildbot-config step. 15:50:50 INFO - ##### 15:50:50 INFO - Running pre-action listener: _resource_record_pre_action 15:50:50 INFO - Running main action method: read_buildbot_config 15:50:50 INFO - Using buildbot properties: 15:50:50 INFO - { 15:50:50 INFO - "project": "", 15:50:50 INFO - "product": "firefox", 15:50:50 INFO - "script_repo_revision": "production", 15:50:50 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 15:50:50 INFO - "repository": "", 15:50:50 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 15:50:50 INFO - "buildid": "20160530120549", 15:50:50 INFO - "pgo_build": "True", 15:50:50 INFO - "basedir": "/builds/slave/test", 15:50:50 INFO - "buildnumber": 537, 15:50:50 INFO - "slavename": "talos-linux64-ix-002", 15:50:50 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:50:50 INFO - "platform": "ubuntu64_hw", 15:50:50 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 15:50:50 INFO - "branch": "mozilla-aurora", 15:50:50 INFO - "repo_path": "releases/mozilla-aurora", 15:50:50 INFO - "revision": "3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4", 15:50:50 INFO - "stage_platform": "linux64-pgo", 15:50:50 INFO - "builduid": "7997d47d310b490c9d491deb39fe4327", 15:50:50 INFO - "slavebuilddir": "test" 15:50:50 INFO - } 15:50:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 15:50:50 INFO - Running post-action listener: _resource_record_post_action 15:50:50 INFO - ##### 15:50:50 INFO - ##### Running download-and-extract step. 15:50:50 INFO - ##### 15:50:50 INFO - Running pre-action listener: _resource_record_pre_action 15:50:50 INFO - Running main action method: download_and_extract 15:50:50 INFO - mkdir: /builds/slave/test/build/tests 15:50:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:50:50 INFO - https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:50:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 15:50:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 15:50:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 15:50:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:50:53 INFO - Downloaded 1361 bytes. 15:50:53 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 15:50:53 INFO - Using the following test package requirements: 15:50:53 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 15:50:53 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:50:53 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 15:50:53 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:50:53 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 15:50:53 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:50:53 INFO - u'jsshell-linux-x86_64.zip'], 15:50:53 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:50:53 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 15:50:53 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 15:50:53 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:50:53 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 15:50:53 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:50:53 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 15:50:53 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:50:53 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 15:50:53 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:50:53 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 15:50:53 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:50:53 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')]} 15:50:53 INFO - https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:50:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 15:50:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 15:50:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 15:50:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:50:55 INFO - Downloaded 24173994 bytes. 15:50:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:50:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:50:56 INFO - Return code: 0 15:50:56 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:50:56 INFO - https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:50:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 15:50:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 15:50:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 15:50:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:50:57 INFO - Downloaded 24173994 bytes. 15:50:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:50:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:50:59 INFO - Return code: 0 15:50:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:50:59 INFO - https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:50:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 15:50:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 15:50:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 15:50:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:51:00 INFO - Downloaded 10840145 bytes. 15:51:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:51:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:51:00 INFO - Return code: 0 15:51: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')]} 15:51:00 INFO - https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:51:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 15:51:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 15:51:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 15:51:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:51:03 INFO - Downloaded 62800628 bytes. 15:51:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 15:51:03 INFO - mkdir: /builds/slave/test/properties 15:51:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:51:03 INFO - Writing to file /builds/slave/test/properties/build_url 15:51:03 INFO - Contents: 15:51:03 INFO - build_url:https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 15:51:04 INFO - Running post-action listener: _resource_record_post_action 15:51:04 INFO - Running post-action listener: set_extra_try_arguments 15:51:04 INFO - ##### 15:51:04 INFO - ##### Running populate-webroot step. 15:51:04 INFO - ##### 15:51:04 INFO - Running pre-action listener: _resource_record_pre_action 15:51:04 INFO - Running main action method: populate_webroot 15:51:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:51:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:51:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:51:04 INFO - '--tppagecycles', 15:51:04 INFO - '7'], 15:51:04 INFO - 'tests': ['tsvgm']}}, 15:51:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:51:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:51:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:51:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:51:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:51:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:51:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:04 INFO - 'talos_options': ['--disable-e10s'], 15:51:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:51:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:51:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:04 INFO - 'talos_options': ['--disable-e10s'], 15:51:04 INFO - 'tests': ['damp', 'tps']}, 15:51:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:04 INFO - 'tests': ['damp', 'tps']}, 15:51:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:51:04 INFO - 'tests': ['dromaeo_dom']}, 15:51:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:51:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:51:04 INFO - 'tests': ['a11yr', 15:51:04 INFO - 'ts_paint', 15:51:04 INFO - 'tpaint', 15:51:04 INFO - 'sessionrestore', 15:51:04 INFO - 'sessionrestore_no_auto_restore', 15:51:04 INFO - 'tabpaint']}, 15:51:04 INFO - 'other-e10s': {'tests': ['a11yr', 15:51:04 INFO - 'ts_paint', 15:51:04 INFO - 'tpaint', 15:51:04 INFO - 'sessionrestore', 15:51:04 INFO - 'sessionrestore_no_auto_restore', 15:51:04 INFO - 'tabpaint']}, 15:51:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:51:04 INFO - 'ts_paint', 15:51:04 INFO - 'tpaint', 15:51:04 INFO - 'sessionrestore', 15:51:04 INFO - 'sessionrestore_no_auto_restore', 15:51:04 INFO - 'tabpaint']}, 15:51:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:51:04 INFO - 'ts_paint', 15:51:04 INFO - 'tpaint', 15:51:04 INFO - 'sessionrestore', 15:51:04 INFO - 'sessionrestore_no_auto_restore', 15:51:04 INFO - 'tabpaint']}, 15:51:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:51:04 INFO - 'tests': ['a11yr', 15:51:04 INFO - 'ts_paint', 15:51:04 INFO - 'tpaint', 15:51:04 INFO - 'sessionrestore', 15:51:04 INFO - 'sessionrestore_no_auto_restore', 15:51:04 INFO - 'tabpaint']}, 15:51:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:51:04 INFO - 'tests': ['a11yr', 15:51:04 INFO - 'ts_paint', 15:51:04 INFO - 'tpaint', 15:51:04 INFO - 'sessionrestore', 15:51:04 INFO - 'sessionrestore_no_auto_restore', 15:51:04 INFO - 'tabpaint']}, 15:51:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:51:04 INFO - 'tests': ['tsvgx', 15:51:04 INFO - 'tsvgr_opacity', 15:51:04 INFO - 'tart', 15:51:04 INFO - 'tscrollx', 15:51:04 INFO - 'cart']}, 15:51:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:51:04 INFO - 'tsvgr_opacity', 15:51:04 INFO - 'tart', 15:51:04 INFO - 'tscrollx', 15:51:04 INFO - 'cart']}, 15:51:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:04 INFO - 'talos_options': ['--disable-e10s'], 15:51:04 INFO - 'tests': ['tp5o']}, 15:51:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:04 INFO - 'tests': ['tp5o']}, 15:51:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:04 INFO - 'talos_options': ['--disable-e10s', 15:51:04 INFO - '--xperf_path', 15:51:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:51:04 INFO - 'tests': ['tp5n']}, 15:51:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:04 INFO - 'talos_options': ['--xperf_path', 15:51:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:51:04 INFO - 'tests': ['tp5n']}}, 15:51:04 INFO - 'talos.zip': {'path': '', 15:51:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:51:04 INFO - Running post-action listener: _resource_record_post_action 15:51:04 INFO - ##### 15:51:04 INFO - ##### Running create-virtualenv step. 15:51:04 INFO - ##### 15:51:04 INFO - Running pre-action listener: _resource_record_pre_action 15:51:04 INFO - Running main action method: create_virtualenv 15:51:04 INFO - Creating virtualenv /builds/slave/test/build/venv 15:51:04 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 15:51:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:51:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:51:04 INFO - Using real prefix '/usr' 15:51:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:51:05 INFO - Installing distribute.............................................................................................................................................................................................done. 15:51:07 INFO - Installing pip.................done. 15:51:07 INFO - Return code: 0 15:51:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:51: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')]} 15:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51: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')]} 15:51:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7150460f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181a410>, '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 0x181b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181b7a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1464644118.922297-1557251915', '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 15:51:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:51:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:51:07 INFO - Using env: {'DISPLAY': ':0', 15:51:07 INFO - 'HOME': '/home/cltbld', 15:51:07 INFO - 'LANG': 'en_US.UTF-8', 15:51:07 INFO - 'LANGUAGE': 'en_US:en', 15:51:07 INFO - 'LOGNAME': 'cltbld', 15:51:07 INFO - 'MAIL': '/var/mail/cltbld', 15:51:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:07 INFO - 'MOZ_NO_REMOTE': '1', 15:51:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:07 INFO - 'NO_EM_RESTART': '1', 15:51:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:07 INFO - 'PWD': '/builds/slave/test', 15:51:07 INFO - 'SHELL': '/bin/bash', 15:51:07 INFO - 'SHLVL': '1', 15:51:07 INFO - 'TERM': 'linux', 15:51:07 INFO - 'TMOUT': '86400', 15:51:07 INFO - 'USER': 'cltbld', 15:51:07 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1464644118.922297-1557251915', 15:51:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:07 INFO - '_': '/tools/buildbot/bin/python'} 15:51:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:51:07 INFO - Cleaning up... 15:51:07 INFO - Return code: 0 15:51:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:51: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')]} 15:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51: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')]} 15:51:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7150460f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181a410>, '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 0x181b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181b7a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1464644118.922297-1557251915', '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 15:51:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 15:51:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:51:07 INFO - Using env: {'DISPLAY': ':0', 15:51:07 INFO - 'HOME': '/home/cltbld', 15:51:07 INFO - 'LANG': 'en_US.UTF-8', 15:51:07 INFO - 'LANGUAGE': 'en_US:en', 15:51:07 INFO - 'LOGNAME': 'cltbld', 15:51:07 INFO - 'MAIL': '/var/mail/cltbld', 15:51:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:07 INFO - 'MOZ_NO_REMOTE': '1', 15:51:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:07 INFO - 'NO_EM_RESTART': '1', 15:51:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:07 INFO - 'PWD': '/builds/slave/test', 15:51:07 INFO - 'SHELL': '/bin/bash', 15:51:07 INFO - 'SHLVL': '1', 15:51:07 INFO - 'TERM': 'linux', 15:51:07 INFO - 'TMOUT': '86400', 15:51:07 INFO - 'USER': 'cltbld', 15:51:07 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1464644118.922297-1557251915', 15:51:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:07 INFO - '_': '/tools/buildbot/bin/python'} 15:51:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:07 INFO - Downloading/unpacking psutil>=0.7.1 15:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:51:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:51:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:51:09 INFO - Installing collected packages: psutil 15:51:09 INFO - Running setup.py install for psutil 15:51:09 INFO - building 'psutil._psutil_linux' extension 15:51:09 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 15:51:09 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 15:51:09 INFO - building 'psutil._psutil_posix' extension 15:51:09 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 15:51:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:51:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:51:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:51:10 INFO - Successfully installed psutil 15:51:10 INFO - Cleaning up... 15:51:10 INFO - Return code: 0 15:51:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:51:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7150460f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181a410>, '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 0x181b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181b7a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1464644118.922297-1557251915', '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 15:51:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 15:51:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:51:10 INFO - Using env: {'DISPLAY': ':0', 15:51:10 INFO - 'HOME': '/home/cltbld', 15:51:10 INFO - 'LANG': 'en_US.UTF-8', 15:51:10 INFO - 'LANGUAGE': 'en_US:en', 15:51:10 INFO - 'LOGNAME': 'cltbld', 15:51:10 INFO - 'MAIL': '/var/mail/cltbld', 15:51:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:10 INFO - 'MOZ_NO_REMOTE': '1', 15:51:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:10 INFO - 'NO_EM_RESTART': '1', 15:51:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:10 INFO - 'PWD': '/builds/slave/test', 15:51:10 INFO - 'SHELL': '/bin/bash', 15:51:10 INFO - 'SHLVL': '1', 15:51:10 INFO - 'TERM': 'linux', 15:51:10 INFO - 'TMOUT': '86400', 15:51:10 INFO - 'USER': 'cltbld', 15:51:10 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1464644118.922297-1557251915', 15:51:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:10 INFO - '_': '/tools/buildbot/bin/python'} 15:51:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:51:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:51:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:51:12 INFO - Installing collected packages: mozsystemmonitor 15:51:12 INFO - Running setup.py install for mozsystemmonitor 15:51:12 INFO - Successfully installed mozsystemmonitor 15:51:12 INFO - Cleaning up... 15:51:12 INFO - Return code: 0 15:51:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:51: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')]} 15:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51: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')]} 15:51:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7150460f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181a410>, '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 0x181b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181b7a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1464644118.922297-1557251915', '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 15:51:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:51:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:51:12 INFO - Using env: {'DISPLAY': ':0', 15:51:12 INFO - 'HOME': '/home/cltbld', 15:51:12 INFO - 'LANG': 'en_US.UTF-8', 15:51:12 INFO - 'LANGUAGE': 'en_US:en', 15:51:12 INFO - 'LOGNAME': 'cltbld', 15:51:12 INFO - 'MAIL': '/var/mail/cltbld', 15:51:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:12 INFO - 'MOZ_NO_REMOTE': '1', 15:51:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:12 INFO - 'NO_EM_RESTART': '1', 15:51:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:12 INFO - 'PWD': '/builds/slave/test', 15:51:12 INFO - 'SHELL': '/bin/bash', 15:51:12 INFO - 'SHLVL': '1', 15:51:12 INFO - 'TERM': 'linux', 15:51:12 INFO - 'TMOUT': '86400', 15:51:12 INFO - 'USER': 'cltbld', 15:51:12 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1464644118.922297-1557251915', 15:51:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:12 INFO - '_': '/tools/buildbot/bin/python'} 15:51:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:12 INFO - Downloading/unpacking blobuploader==1.2.4 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51:14 INFO - Downloading blobuploader-1.2.4.tar.gz 15:51:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:51:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:51:14 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 15:51:14 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 15:51:14 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 15:51:14 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 15:51:14 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 15:51:14 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 15:51:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:51:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51:15 INFO - Downloading docopt-0.6.1.tar.gz 15:51:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:51:15 INFO - Installing collected packages: blobuploader, requests, docopt 15:51:15 INFO - Running setup.py install for blobuploader 15:51:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:51:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:51:15 INFO - Running setup.py install for requests 15:51:15 INFO - Running setup.py install for docopt 15:51:15 INFO - Successfully installed blobuploader requests docopt 15:51:15 INFO - Cleaning up... 15:51:15 INFO - Return code: 0 15:51:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51: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')]} 15:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51: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')]} 15:51:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:15 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 0x7f7150460f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181a410>, '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 0x181b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181b7a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1464644118.922297-1557251915', '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 15:51:15 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 15:51:15 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 15:51:15 INFO - Using env: {'DISPLAY': ':0', 15:51:15 INFO - 'HOME': '/home/cltbld', 15:51:15 INFO - 'LANG': 'en_US.UTF-8', 15:51:15 INFO - 'LANGUAGE': 'en_US:en', 15:51:15 INFO - 'LOGNAME': 'cltbld', 15:51:15 INFO - 'MAIL': '/var/mail/cltbld', 15:51:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:15 INFO - 'MOZ_NO_REMOTE': '1', 15:51:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:15 INFO - 'NO_EM_RESTART': '1', 15:51:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:15 INFO - 'PWD': '/builds/slave/test', 15:51:15 INFO - 'SHELL': '/bin/bash', 15:51:15 INFO - 'SHLVL': '1', 15:51:15 INFO - 'TERM': 'linux', 15:51:15 INFO - 'TMOUT': '86400', 15:51:15 INFO - 'USER': 'cltbld', 15:51:15 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1464644118.922297-1557251915', 15:51:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:15 INFO - '_': '/tools/buildbot/bin/python'} 15:51:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:51:16 INFO - Running setup.py (path:/tmp/pip-dsDy1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:51:16 INFO - Running setup.py (path:/tmp/pip-KI1e46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:51:16 INFO - Running setup.py (path:/tmp/pip-_Ud19m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:51:16 INFO - Running setup.py (path:/tmp/pip-NnsO5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:51:16 INFO - Running setup.py (path:/tmp/pip-lQKJzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:51:16 INFO - Running setup.py (path:/tmp/pip-KuN9OG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:51:16 INFO - Running setup.py (path:/tmp/pip-Y_gZiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:51:16 INFO - Running setup.py (path:/tmp/pip-dSJziU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:51:16 INFO - Running setup.py (path:/tmp/pip-aP9JaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:51:16 INFO - Running setup.py (path:/tmp/pip-8iCdWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:51:16 INFO - Running setup.py (path:/tmp/pip-NpED8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:51:16 INFO - Running setup.py (path:/tmp/pip-GiCb9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:51:17 INFO - Running setup.py (path:/tmp/pip-IMfgzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:51:17 INFO - Running setup.py (path:/tmp/pip-Ql66j4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:17 INFO - Running setup.py (path:/tmp/pip-KOIoro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:51:17 INFO - Running setup.py (path:/tmp/pip-Sbqz9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:51:17 INFO - Running setup.py (path:/tmp/pip-wCAC_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:51:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:51:17 INFO - Running setup.py install for manifestparser 15:51:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:51:17 INFO - Running setup.py install for mozcrash 15:51:17 INFO - Running setup.py install for mozdebug 15:51:17 INFO - Running setup.py install for mozdevice 15:51:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:51:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:51:17 INFO - Running setup.py install for mozfile 15:51:17 INFO - Running setup.py install for mozhttpd 15:51:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:51:17 INFO - Running setup.py install for mozinfo 15:51:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:51:18 INFO - Running setup.py install for mozInstall 15:51:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:51:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:51:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:51:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:51:18 INFO - Running setup.py install for mozleak 15:51:18 INFO - Running setup.py install for mozlog 15:51:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:51:18 INFO - Running setup.py install for moznetwork 15:51:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:51:18 INFO - Running setup.py install for mozprocess 15:51:18 INFO - Running setup.py install for mozprofile 15:51:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:51:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:51:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:51:18 INFO - Running setup.py install for mozrunner 15:51:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:51:18 INFO - Running setup.py install for mozscreenshot 15:51:18 INFO - Running setup.py install for moztest 15:51:19 INFO - Running setup.py install for mozversion 15:51:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:51:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:51:19 INFO - Cleaning up... 15:51:19 INFO - Return code: 0 15:51:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7150460f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181a410>, '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 0x181b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181b7a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1464644118.922297-1557251915', '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 15:51:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:51:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:51:19 INFO - Using env: {'DISPLAY': ':0', 15:51:19 INFO - 'HOME': '/home/cltbld', 15:51:19 INFO - 'LANG': 'en_US.UTF-8', 15:51:19 INFO - 'LANGUAGE': 'en_US:en', 15:51:19 INFO - 'LOGNAME': 'cltbld', 15:51:19 INFO - 'MAIL': '/var/mail/cltbld', 15:51:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:19 INFO - 'MOZ_NO_REMOTE': '1', 15:51:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:19 INFO - 'NO_EM_RESTART': '1', 15:51:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:19 INFO - 'PWD': '/builds/slave/test', 15:51:19 INFO - 'SHELL': '/bin/bash', 15:51:19 INFO - 'SHLVL': '1', 15:51:19 INFO - 'TERM': 'linux', 15:51:19 INFO - 'TMOUT': '86400', 15:51:19 INFO - 'USER': 'cltbld', 15:51:19 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1464644118.922297-1557251915', 15:51:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:19 INFO - '_': '/tools/buildbot/bin/python'} 15:51:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:51:19 INFO - Running setup.py (path:/tmp/pip-EYfKAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:51:19 INFO - Running setup.py (path:/tmp/pip-RmuLzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:51:19 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)) 15:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:51:19 INFO - Running setup.py (path:/tmp/pip-62mXoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:51:19 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)) 15:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:51:19 INFO - Running setup.py (path:/tmp/pip-bKvJMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:51:19 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)) 15:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:51:19 INFO - Running setup.py (path:/tmp/pip-YVWK9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:51:19 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)) 15:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:51:19 INFO - Running setup.py (path:/tmp/pip-2HNHlP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:51:19 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)) 15:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:51:19 INFO - Running setup.py (path:/tmp/pip-I1zbda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:51:19 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)) 15:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:51:19 INFO - Running setup.py (path:/tmp/pip-gSCoMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:51:19 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)) 15:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:51:19 INFO - Running setup.py (path:/tmp/pip-zq8T_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:51:19 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)) 15:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:51:20 INFO - Running setup.py (path:/tmp/pip-BDyKrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:51:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:51:20 INFO - Running setup.py (path:/tmp/pip-gVCOg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:51:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:51:20 INFO - Running setup.py (path:/tmp/pip-qpHYrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:51:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:51:20 INFO - Running setup.py (path:/tmp/pip-CVEU93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:51:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:51:20 INFO - Running setup.py (path:/tmp/pip-kQ2lzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:51:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:20 INFO - Running setup.py (path:/tmp/pip-K6W4z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:51:20 INFO - Running setup.py (path:/tmp/pip-Tfu17F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:51:20 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)) 15:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:51:20 INFO - Running setup.py (path:/tmp/pip-KAymps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:51:20 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)) 15:51:20 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)) 15:51:20 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)) 15:51:20 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)) 15:51:20 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)) 15:51:20 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)) 15:51:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51:22 INFO - Downloading blessings-1.6.tar.gz 15:51:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:51:22 INFO - Installing collected packages: blessings 15:51:22 INFO - Running setup.py install for blessings 15:51:22 INFO - Successfully installed blessings 15:51:22 INFO - Cleaning up... 15:51:22 INFO - Return code: 0 15:51:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:51:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:51:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:51:23 INFO - Reading from file tmpfile_stdout 15:51:23 INFO - Current package versions: 15:51:23 INFO - argparse == 1.2.1 15:51:23 INFO - blessings == 1.6 15:51:23 INFO - blobuploader == 1.2.4 15:51:23 INFO - docopt == 0.6.1 15:51:23 INFO - manifestparser == 1.1 15:51:23 INFO - mozInstall == 1.12 15:51:23 INFO - mozcrash == 0.17 15:51:23 INFO - mozdebug == 0.1 15:51:23 INFO - mozdevice == 0.48 15:51:23 INFO - mozfile == 1.2 15:51:23 INFO - mozhttpd == 0.7 15:51:23 INFO - mozinfo == 0.9 15:51:23 INFO - mozleak == 0.1 15:51:23 INFO - mozlog == 3.1 15:51:23 INFO - moznetwork == 0.27 15:51:23 INFO - mozprocess == 0.22 15:51:23 INFO - mozprofile == 0.28 15:51:23 INFO - mozrunner == 6.11 15:51:23 INFO - mozscreenshot == 0.1 15:51:23 INFO - mozsystemmonitor == 0.0 15:51:23 INFO - moztest == 0.7 15:51:23 INFO - mozversion == 1.4 15:51:23 INFO - psutil == 3.1.1 15:51:23 INFO - requests == 1.2.3 15:51:23 INFO - wsgiref == 0.1.2 15:51:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7150460f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181a410>, '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 0x181b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181b7a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1464644118.922297-1557251915', '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 15:51:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:51:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:51:23 INFO - Using env: {'DISPLAY': ':0', 15:51:23 INFO - 'HOME': '/home/cltbld', 15:51:23 INFO - 'LANG': 'en_US.UTF-8', 15:51:23 INFO - 'LANGUAGE': 'en_US:en', 15:51:23 INFO - 'LOGNAME': 'cltbld', 15:51:23 INFO - 'MAIL': '/var/mail/cltbld', 15:51:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:23 INFO - 'MOZ_NO_REMOTE': '1', 15:51:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:23 INFO - 'NO_EM_RESTART': '1', 15:51:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:23 INFO - 'PWD': '/builds/slave/test', 15:51:23 INFO - 'SHELL': '/bin/bash', 15:51:23 INFO - 'SHLVL': '1', 15:51:23 INFO - 'TERM': 'linux', 15:51:23 INFO - 'TMOUT': '86400', 15:51:23 INFO - 'USER': 'cltbld', 15:51:23 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1464644118.922297-1557251915', 15:51:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:23 INFO - '_': '/tools/buildbot/bin/python'} 15:51:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:51:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:51:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:51:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:51:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:51:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:51:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:51:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:51:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:51:23 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:51:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:51:23 INFO - Cleaning up... 15:51:23 INFO - Return code: 0 15:51:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:51:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7150460f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181a410>, '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 0x181b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181b7a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1464644118.922297-1557251915', '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 15:51:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:51:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:51:23 INFO - Using env: {'DISPLAY': ':0', 15:51:23 INFO - 'HOME': '/home/cltbld', 15:51:23 INFO - 'LANG': 'en_US.UTF-8', 15:51:23 INFO - 'LANGUAGE': 'en_US:en', 15:51:23 INFO - 'LOGNAME': 'cltbld', 15:51:23 INFO - 'MAIL': '/var/mail/cltbld', 15:51:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:23 INFO - 'MOZ_NO_REMOTE': '1', 15:51:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:23 INFO - 'NO_EM_RESTART': '1', 15:51:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:23 INFO - 'PWD': '/builds/slave/test', 15:51:23 INFO - 'SHELL': '/bin/bash', 15:51:23 INFO - 'SHLVL': '1', 15:51:23 INFO - 'TERM': 'linux', 15:51:23 INFO - 'TMOUT': '86400', 15:51:23 INFO - 'USER': 'cltbld', 15:51:23 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1464644118.922297-1557251915', 15:51:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:23 INFO - '_': '/tools/buildbot/bin/python'} 15:51:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:23 INFO - Downloading/unpacking jsonschema 15:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:51:25 INFO - Downloading/unpacking functools32 (from jsonschema) 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51:25 INFO - Downloading functools32-3.2.3-2.tar.gz 15:51:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:51:25 INFO - warning: no files found matching '*.txt' 15:51:25 INFO - no previously-included directories found matching 'build' 15:51:25 INFO - no previously-included directories found matching 'dist' 15:51:25 INFO - no previously-included directories found matching '.git*' 15:51:25 INFO - Installing collected packages: jsonschema, functools32 15:51:25 INFO - Running setup.py install for functools32 15:51:25 INFO - warning: no files found matching '*.txt' 15:51:25 INFO - no previously-included directories found matching 'build' 15:51:25 INFO - no previously-included directories found matching 'dist' 15:51:25 INFO - no previously-included directories found matching '.git*' 15:51:25 INFO - Successfully installed jsonschema functools32 15:51:25 INFO - Cleaning up... 15:51:25 INFO - Return code: 0 15:51:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:51:25 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')]} 15:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:25 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')]} 15:51:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:25 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 0x7f7150460f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181a410>, '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 0x181b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181b7a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1464644118.922297-1557251915', '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 15:51:25 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 15:51:25 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 15:51:25 INFO - Using env: {'DISPLAY': ':0', 15:51:25 INFO - 'HOME': '/home/cltbld', 15:51:25 INFO - 'LANG': 'en_US.UTF-8', 15:51:25 INFO - 'LANGUAGE': 'en_US:en', 15:51:25 INFO - 'LOGNAME': 'cltbld', 15:51:25 INFO - 'MAIL': '/var/mail/cltbld', 15:51:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:25 INFO - 'MOZ_NO_REMOTE': '1', 15:51:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:25 INFO - 'NO_EM_RESTART': '1', 15:51:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:25 INFO - 'PWD': '/builds/slave/test', 15:51:25 INFO - 'SHELL': '/bin/bash', 15:51:25 INFO - 'SHLVL': '1', 15:51:25 INFO - 'TERM': 'linux', 15:51:25 INFO - 'TMOUT': '86400', 15:51:25 INFO - 'USER': 'cltbld', 15:51:25 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1464644118.922297-1557251915', 15:51:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:25 INFO - '_': '/tools/buildbot/bin/python'} 15:51:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:26 INFO - Downloading/unpacking flake8 15:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:51:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:51:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:51:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:51:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:51:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:51:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:51:28 INFO - no previously-included directories found matching 'docs/_build' 15:51:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:51:28 INFO - Running setup.py install for pep8 15:51:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:51:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:51:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:51:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:51:28 INFO - no previously-included directories found matching 'docs/_build' 15:51:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:51:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:51:28 INFO - Cleaning up... 15:51:28 INFO - Return code: 0 15:51:28 INFO - Running post-action listener: _resource_record_post_action 15:51:28 INFO - Running post-action listener: _start_resource_monitoring 15:51:28 INFO - Starting resource monitoring. 15:51:28 INFO - ##### 15:51:28 INFO - ##### Running install step. 15:51:28 INFO - ##### 15:51:28 INFO - Running pre-action listener: _resource_record_pre_action 15:51:28 INFO - Running main action method: install 15:51:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:51:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:51:29 INFO - Reading from file tmpfile_stdout 15:51:29 INFO - Detecting whether we're running mozinstall >=1.0... 15:51:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:51:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:51:29 INFO - Reading from file tmpfile_stdout 15:51:29 INFO - Output received: 15:51:29 INFO - Usage: mozinstall [options] installer 15:51:29 INFO - Options: 15:51:29 INFO - -h, --help show this help message and exit 15:51:29 INFO - -d DEST, --destination=DEST 15:51:29 INFO - Directory to install application into. [default: 15:51:29 INFO - "/builds/slave/test"] 15:51:29 INFO - --app=APP Application being installed. [default: firefox] 15:51:29 INFO - mkdir: /builds/slave/test/build/application 15:51:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:51:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:51:44 INFO - Reading from file tmpfile_stdout 15:51:44 INFO - Output received: 15:51:44 INFO - /builds/slave/test/build/application/firefox/firefox 15:51:44 INFO - Running post-action listener: _resource_record_post_action 15:51:44 INFO - ##### 15:51:44 INFO - ##### Running run-tests step. 15:51:44 INFO - ##### 15:51:44 INFO - Running pre-action listener: _resource_record_pre_action 15:51:44 INFO - Running main action method: run_tests 15:51:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:51:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:51:44 INFO - Python 2.7.3 15:51:44 INFO - Return code: 0 15:51:44 INFO - grabbing minidump binary from tooltool 15:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:44 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 0x181a410>, '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 0x181b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181b7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:51:44 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 15:51:44 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 15:51:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:51:44 INFO - Return code: 0 15:51:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:51:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:51:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:51:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:51:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:51:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:51:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:51:45 INFO - Return code: 0 15:51:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 15:51:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 15:51:45 INFO - Using env: {'DISPLAY': ':0', 15:51:45 INFO - 'HOME': '/home/cltbld', 15:51:45 INFO - 'LANG': 'en_US.UTF-8', 15:51:45 INFO - 'LANGUAGE': 'en_US:en', 15:51:45 INFO - 'LOGNAME': 'cltbld', 15:51:45 INFO - 'MAIL': '/var/mail/cltbld', 15:51:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:51:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:45 INFO - 'MOZ_NO_REMOTE': '1', 15:51:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:51:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:45 INFO - 'NO_EM_RESTART': '1', 15:51:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:45 INFO - 'PWD': '/builds/slave/test', 15:51:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:51:45 INFO - 'SHELL': '/bin/bash', 15:51:45 INFO - 'SHLVL': '1', 15:51:45 INFO - 'TERM': 'linux', 15:51:45 INFO - 'TMOUT': '86400', 15:51:45 INFO - 'USER': 'cltbld', 15:51:45 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1464644118.922297-1557251915', 15:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:45 INFO - '_': '/tools/buildbot/bin/python'} 15:51:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 15:51:46 INFO - mozversion application_buildid: 20160530120549 15:51:46 INFO - mozversion application_changeset: 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 15:51:46 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:51:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:51:46 INFO - mozversion application_name: Firefox 15:51:46 INFO - mozversion application_remotingname: firefox-dev 15:51:46 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:51:46 INFO - mozversion application_vendor: Mozilla 15:51:46 INFO - mozversion application_version: 48.0a2 15:51:46 INFO - mozversion platform_buildid: 20160530120549 15:51:46 INFO - mozversion platform_changeset: 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 15:51:46 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:51:46 INFO - mozversion platform_version: 48.0a2 15:51:46 INFO - using testdate: 1464648706 15:51:46 INFO - actual date: 1464648706 15:51:46 INFO - starting webserver on 'localhost:51295' 15:51:46 INFO - SUITE-START | Running 2 tests 15:51:46 INFO - TEST-START | dromaeo_css 15:51:46 INFO - operating with platform_type : linux_ 15:51:46 INFO - Initialising browser for dromaeo_css test... 15:51:46 INFO - TEST-INFO | started process 9664 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpexJHI2/profile http://localhost:51295/getInfo.html) 15:51:50 INFO - PROCESS | 9664 | __metrics Screen width/height:1600/1200 15:51:50 INFO - PROCESS | 9664 | colorDepth:24 15:51:50 INFO - PROCESS | 9664 | Browser inner width/height: 1024/697 15:51:50 INFO - PROCESS | 9664 | __metrics 15:51:51 ERROR - PROCESS | 9664 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:51:51 INFO - TEST-INFO | 9664: exit 0 15:51:51 INFO - Browser initialized. 15:51:51 INFO - Running cycle 1/1 for dromaeo_css test... 15:51:51 INFO - TEST-INFO | started process 9755 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpexJHI2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:52:03 INFO - PROCESS | 9755 | RSS: Main: 141950976 15:52:03 INFO - PROCESS | 9755 | 15:52:54 INFO - PROCESS | 9755 | 1464648774607 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] 15:55:02 INFO - PROCESS | 9755 | Cycle 1(1): loaded http://localhost:51295/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51295/tests/dromaeo/cssquery-ext.html) 15:55:03 INFO - PROCESS | 9755 | RSS: Main: 247066624 15:55:03 INFO - PROCESS | 9755 | 15:58:05 INFO - PROCESS | 9755 | Cycle 1(1): loaded http://localhost:51295/tests/dromaeo/cssquery-ext.html (next: http://localhost:51295/tests/dromaeo/cssquery-jquery.html) 15:58:06 INFO - PROCESS | 9755 | RSS: Main: 221519872 15:58:06 INFO - PROCESS | 9755 | 16:01:07 INFO - PROCESS | 9755 | Cycle 1(1): loaded http://localhost:51295/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51295/tests/dromaeo/cssquery-mootools.html) 16:01:08 INFO - PROCESS | 9755 | RSS: Main: 223375360 16:01:08 INFO - PROCESS | 9755 | 16:04:10 INFO - PROCESS | 9755 | Cycle 1(1): loaded http://localhost:51295/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51295/tests/dromaeo/cssquery-prototype.html) 16:04:10 INFO - PROCESS | 9755 | RSS: Main: 219676672 16:04:10 INFO - PROCESS | 9755 | 16:07:13 INFO - PROCESS | 9755 | Cycle 1(1): loaded http://localhost:51295/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51295/tests/dromaeo/cssquery-yui.html) 16:07:13 INFO - PROCESS | 9755 | RSS: Main: 213180416 16:07:13 INFO - PROCESS | 9755 | 16:10:16 INFO - PROCESS | 9755 | Cycle 1(1): loaded http://localhost:51295/tests/dromaeo/cssquery-yui.html (next: http://localhost:51295/tests/dromaeo/cssquery-dojo.html) 16:10:16 INFO - PROCESS | 9755 | RSS: Main: 256262144 16:10:16 INFO - PROCESS | 9755 | 16:10:16 INFO - PROCESS | 9755 | __start_tp_report 16:10:16 INFO - PROCESS | 9755 | _x_x_mozilla_page_load 16:10:16 INFO - PROCESS | 9755 | _x_x_mozilla_page_load_details 16:10:16 INFO - PROCESS | 9755 | |i|pagename|runs| 16:10:16 INFO - PROCESS | 9755 | |0;dojo.html;3336.733061355091;3353.8993830185104;3368.898933032009;3389.220479289762;3389.4746314321287;5549.056660367737;5582.078956972095;5583.8604034899145;5600.4959553640165;5607.859803504909;5550.750216240269;5582.051051321275;5594.24477695511;5605.915911261334;5637.46444087811;4928.654994150411;5053.039922414739;5159.974200128994;5220.791168353261;5239.869003274911;5087.364079490064;5112.590992720592;5113;5119.4880511948695;5120.334356533645;5105.5149760772665;5150.871228219287;5152.819651312205;5171.896562068757;5182.6631268967585;5184.766685499161;5185.922211166836;5188.740562971836;5230.398504172031;5256.763445644936;5039.44566097729;5048.7980480780725;5068.72122033288;5076.873078173038;5112.488751124895;5484.149956756709;5532.197831314437;5534.833954981357;5550.611457197998;5551.444855514456;6050.939490605126;6057.515398768088;6059.909101363439;6060.454559089659;6063.636181829104;6066.636001839904;6067.816775728735;6100.69496525172;6113.174721412597;6116.12274041307;5610.831675049755;5664.376918538957;5665.8583535411535;5665.886682266331;5699.401562835926;6141.516692814182;6182.938170618326;6186.597871138361;6190.845228869314;6265.216847894013;5831.562632802472;5900.1739756434135;5906.675132867647;5913.5564832636865;5913.58604897653;5978.192943952511;5980.282366116007;5982.4017598239825;5983.551233657493;5989.2812862456785;5837.124431335334;5938.851528711731;5940.910886336708;5950.9702451487465;5994.460498555064;6008.03871380577;6025;6038.245219347582;6038.516918646497;6065.150878876961;4572.1312950539295;4585.1746685596245;4586.610138138229;4591.494935557086;4611.146937816515;4020.1356708307853;4051.513818341818;4109.712320137562;4122.196171746481;4140;5798.420157984167;5820.330661973842;5822.534197264209;5825.621334613236;5856.121581762684;6068.362821903725;6120.449159575571;6128.540359472968;6129.08063790435;6131.294901086343;5593.804216852391;5713.6857472838565;5808.767649293981;5818.359980402152;5885.146653735184;5169.250458683545;5171.456997015259;5171.81898633546;5175.171972484384;5181.5854731621375;6254.312025677172;6261.060840873905;6265.843353916189;6270.372962703693;6272.905906411407;5926;6023.728932197974;6033.849153771103;6069.362716914837;6098.359672234352;6202.41077097675;6226.62640241587;6258.593191442542;6262.405071518198;6285.371462853678;5968.70156492165;5975.43233392827;5987.131865879336;5989.299489859401;6023.548233882389;5909.143174239797;6044.304904935989;6103.084537319438;6135.998322733915;6136.88672321611;5904.0553511437965;5905.822825315247;5907.586468947133;5911.645301281937;5931.6441013539325;5831.154482599914;5900.262467191601;5900.468957793819;5904.261967254093;5906.350301466749;5732.082866741302;5903.26209223847;5911.054231322968;5963.582549221513;5972.820815375546;5896.14505896634;5917.053271476543;5919.4080591940465;5926.851828704317;5935.347111817783;5670.291213598301;5779.884402312015;5786.710664466844;5787.508061814625;5818.6217895836635 16:10:16 INFO - PROCESS | 9755 | |1;ext.html;678.7658257901024;682.7405585877366;684.4763755726867;739.8606146534335;753.3972821742605;32089.19777005576;32772.67227327726;32785.18037049072;32839.343213135726;32853.17867053325;35713;36571.63428365716;44418.11163776722;45137.32294015584;45197.54802451975;9139.360244782867;9292.44245345278;9345.2991025673;9349.532523373839;9366.438013719164;8216.507009579414;9123.817523649523;9252.722418327461;9257.39826911252;9258.76853078675;10893.291936024134;11211.887881121165;11218.887811121866;11221.60724374647;11223.887761122365;10886.455677216147;10997.450127493594;10997.945010274978;11002.614908478205;11023.1732620053;8188.222118898755;8386.496810191407;10341.586336546605;10862.72843178919;10981.286216395989;40953;41639.583604163876;41640.375394368806;41693.583064169274;41695.583044169776;3823.636754508317;3905.9609403905883;4006.979965100156;4227.133437645306;4460.442444694413;30554;32056.198595035312;32292.192695182574;32294.285983523965;32836.507452388236;4586.610138138262;4663.883402914954;4701.388819453449;4718.150732868083;4746.288056791474;320214;322822;323054;323272;323430;70196;71285.2871471289;71340;71448;71461.64269178621;74222;74262;74598;74735.62632186913;74937.25062749302;18866.71699924502;19541.218351266074;19597.902010489855;19609;19626;13546;13674.247916364497;13713.17720936727;13729.725405492034;13747.106438081493;18987.81012189888;20898.791012089685;21299.254526091514;21680.457988550097;21711.674324885138;7460.776176714708;7526.623668816537;7530.397568194531;7812.648430820626;7927.682892684344;1155.064397837754;1192.8151136573845;1220.8107743299802;1284.9421776020101;1299.7660421124099;33832.49251261233;34179.487307690404;34485.48271775875;34781.1304717379;34797;1239.0892693869998;1243.7823380908305;1290.5612091888802;1305.9608211753662;1317.911110889232;18217.45347639573;18670;18960.810391895906;19008.904955475133;19322.227110915686;458352;464785;465561;467482;468252;65658.34341656617;66327;66355.66822165955;66439.66780166069;66456.6677166611;1368.8973327000515;1474.8525147485166;1510.8187017557964;1538.6384199713282;1549.6280892585924;30530.389392211586;31047.534286986163;31654.366912662077;31931.623253646434;32030;52901.470985289656;53911;53927.460725392244;53967.19049214186;53997.73001135126;301063;301850;303123;303280;303993;27779.722202777713;30428.391432171677;31213;31266.21834454157;31904;45691.77154114208;53211.73394133004;53464.46535534595;53833.730831345594;54242;38581.294159913465;39217;42068.78965605152;42148;42842.78578607087;41252;41944.370834438116;42064.1587168261;42653.5734642662;43089.78455107704;42202.15595688007;42461.78769106135;42462.150756985306;43566;43651.34522982221;37025.44461833128;38117.23765524729;38196.80901595474;38402;38780.80609596934;29031.274218144714;29235.415291694473;29483.557746634247;29700.851495742383;31470 16:10:16 INFO - PROCESS | 9755 | |2;jquery.html;439.13928699748493;439.4879964840961;443.2464809823301;446.15231060984127;453.55778116336575;20113.396598102063;20455.795442045575;20549.589008219864;20562.69155962662;21256.787432125693;18913.338033168842;19380.4185874424;19927.900360498177;20593.27923522677;20694.172233110694;5691.630044047134;5881.411858814127;5886.087656413241;5895.764169433239;5897.675627840467;4264.083222107246;5790.276215473066;5866.384029676865;6141.692915354237;6458.93541064588;6423.807285781434;6431.646259455728;6445.8710825783455;6446.967765161167;6449.290578036413;5743.224664670279;6014.699265036731;6021.337652858182;6028.276606807167;6386.137871387373;3917.373220284741;5660.3490598581275;5853.76584936602;5865.677387743673;5913.497352725023;13580.524681636194;13632.386542605607;13699.863001370059;13830.585082447542;13854.376553055137;2551.323899166722;2602.206327070243;2671.479061582992;2706.5534186859145;3087.444260033193;10455.895441045644;10536.157107431387;10563.207759418074;10783.299085559414;10945.45272736368;2034.6642803937332;2105.3157723739846;2105.473631592102;2108.620448319302;2144.9785502144937;77571;77668.61165694192;79125.60437197777;79571;79819;11197.328160310408;11241.15691323154;11337.659870203906;11403.885961140448;11698.883011169779;15531.611709707347;15606.609834754221;15634;15639.218039098;15688.76466852998;8455.49267043967;8606.182412670787;8957.910420895838;8958.462492250486;9016.729498115066;8659.26814637075;8669.436486628349;8699.739007829776;8745;8769.429987050822;4936.802527898915;4977.278294647328;5168.173092305213;5227.660202086852;5283.418823929364;1904.4001139640968;2054;2130.5632345369163;2140.1118535807464;2213.4687674957895;1023.4780262066399;1046.984295235572;1064.1699474409972;1109.6116359274351;1113.1317572293624;19185.136668849937;19333.806661933482;19443;19570.412887613395;19815.10832012563;1041.7864337810731;1091.4815462655333;1104.0725790335996;1114.4929057278919;1115.7154925493946;10621.468926553642;11098.334099954029;11132.721681957853;11306.773864522827;11427.200095993367;518654;521930;522672;530217;546624;94853.52573237228;96177;96685.51657241669;97274;98432;1068.871735391758;1100.7908497385472;1104.9944750276197;1116.0569318925495;1119.7872404243167;17196.31214751396;17322.74015889788;17436.651266974335;17532.2110505025;17626.383076592258;38960.22079558449;39909;40725.98185045397;41423.37864932089;41856;58502.414975851396;58720.70639646774;59229.703851480466;59334;60582.39417605944;9198.310126740387;9270.940589605549;9303.302252331237;9440;9464.1009104135;12703.809442858179;13416.12795168311;13540;13548.525801596898;13984.930075349965;11719.296842189497;12168.391580420766;12314.753704925672;12356.814647780471;12546.309952952675;11489.482973266391;11970.281783093042;12145.271283723005;12212.816807747713;12369.072319575887;12594.307313097868;12769.61691149267;12876.935615321863;12989.220646761225;13063.216207027608;9111.544422778701;9328.253739700944;9343.112404321579;9472.970682934974;9521.714348569554;10505.264631475724;11986.580469683518;12148.088893333212;12171.208871423329;12280.508779648713 16:10:16 INFO - PROCESS | 9755 | |3;mootools.html;1432.44134787433;1593.6493971326308;1611.677664467107;1844.160906787411;1974.1412485568778;8213.137620549845;8355.080941096474;8364.289035431988;8366.83266334673;8377.790555236123;8526.829463410744;8713.520756358397;8723.345749068814;8727.476351418904;8731.126887311282;2379.7620237976153;2385.2486466763003;2407.7832995030444;2407.9157229496973;2408.289554581394;2447.2046584859904;2478.8512689238705;2517.169334119736;2520.9495810083786;2532.3289328327915;2406.5186962607463;2417.3110663460916;2426.284246147382;2439.9390015249583;2444.960891621054;2437.926862194137;2457.69278840145;2470.851748895072;2473.468204336067;2481.6773819403543;2415.9894575005405;2466.2231397109854;2482.8262021658493;2482.900683972639;2498.925032249035;8557;8762.036176020632;8793.868091978626;8812.471251724917;8814.030456649763;5540.085885828834;5654.180143879114;5681.318241810968;5694.373618901917;5700.914486282709;3485.3900567400606;3487.1805125795418;3510.596281427643;3624.3657359961903;3685.5024571682748;1107.1474964277543;1165.2134809003974;1169.7426566155432;1175.4416652090274;1221.3832014832542;12118.151729378947;12572.559960401433;12631.115821892472;12631.93684031574;12682.492700291978;4811;4863.927041094386;4884.1941079722155;4929;4931.235658472942;9879.654212102541;9891.604335826487;9917.752056198653;9919.404835709736;9935.155511781435;5601.579881508903;5642.379338272786;5643.971780141155;5653.660780353192;5655.264815574032;4449.666275029385;4986.7257300848805;5079.466656001066;5116.104681680691;5237.895242095136;3941.724079314478;3977.7812220327583;4004.3993400990084;4024.9195016099516;4060.127072679388;1250.5810553464692;1263.91784534005;1278.1947373154853;1285.6207418811473;1293.2111412038648;876.5792419638609;1061.1775873697945;1082.1667316166508;1089.3246187363727;1108.0858291909208;6041.969790151021;6340.3342649022115;6400.71196796136;6486.805395838132;6507.284198738135;1001.5242759689235;1086.0659832544006;1092.6612750047511;1094.5293523784849;1131.8811524789778;4363.3018717005125;4402.6037656610415;4418.624416924533;4420.31485119807;4421.314696222091;10844.240903136862;11240.662780116609;11261.605843795427;11264.155188360906;11266.042386397085;10396.948015259875;10697.518611662339;11138.276012059352;11149.052330551995;11152;8173.754787356389;8260.091389947102;8288.295494882881;8288.958555207186;8361.03848057469;6054.66699331541;6168.660723660242;6185.505159587312;6236.34518375564;6326.398992095744;9634.421934683942;9741.123298903132;9772.267079969173;9783.657571984946;9806.166475849348;9420.905790942003;9680.370775899544;9688.079632434907;9794.65718699842;9817.165540929102;7022.367986881205;7498.550086994798;7677.9616101921365;7712.344450721752;7912.129665736879;8302.87545686803;8319.542425166674;8379.49723016621;8380.832383352421;8381.53901535397;7413.777586672409;7561.7731468056045;7600.049993750781;7679.923200768144;7759.107702614046;7061.505694601328;7113.359797618239;7126.679299431435;7226.819329516804;7240.094988126484;7279.890801637874;7280.963595182202;7324.194338622854;7329.963350183215;7340.11918569775;5140.7429628517675;5269.077911365573;5297.735113244399;5324.227986941949;5336.332958380202;5462.453754624506;5518.33779946409;5547.140193270049;5584.497395234448;5588.413216612197 16:10:16 INFO - PROCESS | 9755 | |4;prototype.html;325.8419666461766;328.63521491144826;341.2288228603356;345.7320576553171;346.2434580441737;6163.660998645073;6216.378362163781;6225.439710426061;6232.501399888015;6318.747250110002;6232.189815324002;6246.687665616712;6252.906206406908;6254.655993920333;6264.279607845087;4529.04889973106;4652.883677908062;4758.833440829554;4779.139754844126;4786.641001924852;4755.571998520132;4776.832810851621;4791.47293797682;4801.207800712878;4808.519148085198;4525.185466616008;4752.215884379073;4753.120672675549;4760.166970780099;4760.761961901909;4601.562851529116;4716.858494245161;4717.551832575899;4742.857714268577;4747.311639812208;4154;4155.31437312843;4166.91666166678;4170.70805043647;4181.540030596632;5989.251343582052;5999.520038396918;6020.6989650517735;6027.427394397525;6034.456898879078;5512.586556008316;5524.475174858382;5525.557955363562;5532.972335138339;5545.445455454463;6410.487161027107;6542.4438922691625;6562.212534495843;6577.40803327698;6579.0460383244645;4545.863624091249;4558.749268790215;4559.589636932659;4563.840265590688;4583.656225783079;6825.419839313664;6860.862782744367;6869.931300686979;6874.828129296808;6879.484038697168;4645.279981602789;4660.13787449323;4662.510436404129;4662.976685116552;4672.929906051412;4726.527347265314;4726.692764970335;4727.456342520654;4737.549932756383;4738.810447582058;5449.782008719607;5459.481349271813;5463.754131064112;5468.863278418072;5482.259894914136;6396.520260980352;6612.239592446834;6618.735250590019;6633.4693224541925;6635.369639884299;1612.3631165689487;1615.3780794394243;1618.3041292244213;1619.6436783907523;1624.3746157729358;979.8775153105862;1052.726291164303;1057.8043062033548;1073.4847273308856;1078.0567003871613;6426;6433.131527243856;6433.388828061326;6433.903491447539;6442.35576442352;6783.423409010289;6788.2193547742645;6794.76218332356;6799.150106236721;6809.761658341934;6357.237131544244;6359.682015899279;6360.300366959631;6365.013422919455;6416.101745755598;3632.0738211755834;3646.288973650113;3655.9817200913826;3668.449732540087;3677.595464498903;6915.827104322331;7071.611061391673;7076.186238582526;7078.150621925299;7081.185663648644;6884.965575172192;6888.242293347727;6911.272181954511;6912.688928998207;6916.273791251947;7046.577205367695;7047.506674532733;7048.753293634801;7059.788206353817;7059.8235044123285;6750.932490675227;6755.86488270222;6759.966200168968;6767.289434609295;6770.830729231611;6491.156149700509;6602.10871532337;6653.2016158059405;6661.700223489857;6665.400113989765;6982.7206911725;7000.439964802702;7012.649367531705;7019.684114214975;7022.08712867324;4594.88512787183;4599.080183963288;4603.769811509478;4604.355390245301;4605.355250264898;6720.831979200363;6723.7646682365885;6725.461963042847;6725.630090345078;6727.831804204934;6388.8083357499345;6552.770653027121;6566.474682025522;6570.113034740249;6586.769463068769;6511.674416279072;6539.70571324282;6547.083408322744;6554.442872355903;6565.901511477427;6469.288378278292;6539.182602174728;6543.901841472477;6552.934470655233;6556.082148499118;6693.866122677617;6705.932940670726;6709.7316107355155;6712.49656275791;6714.630695311805;6419.5013717523125;6512.413882750575;6530;6543.312952139957;6543.803685889431 16:10:16 INFO - PROCESS | 9755 | |5;yui.html;935.4808081514759;935.5930170375891;937.1565590968123;947.2280091725241;975.3903810118676;13389.665258368534;14939.103653780781;15167.772483412744;15263.694726105472;15293.311800968955;14269.50056748014;14342.928285358585;14345;14354.28228588569;14363.066400683974;756.4553521464537;764.1670579068814;764.6711913877031;765.2959277464746;907.2787134228271;923.9353245272833;927.0914503786294;927.9118483744033;928.5078908178676;928.558934506111;962.5187406296851;972.2707969023232;974.7758015656403;975.2149519636689;976.6923419122953;969.6509256667593;971.1939090554822;971.218169373654;972.2513664478347;972.6060945317158;590.1030433740733;694.1115372323434;708.677551713974;709.0250905005618;718.7232915327636;13863;13929.791053134211;13973.650658733512;14011.509597164153;14128.293585320693;14326;14613.123212607277;14898.180600066991;14937.17845518496;15134.924325378302;11952.64142075739;12002.339871307162;12070.155089143764;12111.757764844742;12312.384380780924;4078.5004901329785;4092.1406504634065;4118.045997646246;4180.581941805795;4232.682548808821;55699.44300556983;56498;56629.43370566324;56632;57267.713661431844;12315.384230788424;12332.81500777489;12422.627321180378;12468.937655311847;12554.058445616616;21927.451813704465;22016.33950981473;22057.558848822933;22087;22097.779022209892;8777.385583009256;9045.68340108093;9045.819083618291;9076.319276054322;9399.154076133182;4884.95115048852;4956.231784073474;4979.726115063706;5063.569596584258;5112.207607820794;3807.4479200516325;3864.1305706215876;3868.9613103869165;3869.9226015479535;3878.5345758508597;650.9186351706037;652.8367908022994;653.6078352988264;663.171036204744;676.3034074902858;757.6363345594145;784.8273379856422;786.8780339047457;788.7357735158786;799.8000499875031;9930.751731206634;10232.64185753495;10246.692599222035;10350.120239779553;10425.165986721044;735.937445317154;752.2439947852482;782.4718315137374;788.4835432791531;809.0049239435527;4602.723836569817;4617.538246175355;4650.4186976627925;4663.813447462064;4984.252362145708;67423.66288168528;67608;67644.6617766908;68237;72282;59573.404265956786;59835;60888;61206.38793612096;61818.69090654518;53699.19451208235;53957.730211348695;54506.18240726392;54814.72592637011;56114.43885561174;10210.489475526343;10402.43732451856;10417.789488392495;10680.57277708914;10751.354918704903;39103.21793564056;39232.411513826744;39407.60592394039;40016.3997540043;40525.39211911765;46818;51094.48905510897;51386.48613513817;52356.73821630867;52574;12842.229466232056;12860.485580577046;12977.610671679864;13195.076344656165;13255.270960097287;13933;14027.08184204252;14131.15213087218;14239.15267857595;14577.489787857374;14103;14112.905232254208;14149.504767333094;14340.139591624536;14539.854601454274;14060.222563811594;14066.226357550433;14144.363503642566;14156.079854809404;14623.415063397344;13415.731685366043;13650.112742671694;13963.58109256724;14095;14107;11473.827892581785;11638.12714046433;11815.350155741517;11879.505303885935;12122.212056216318;11315.886841131813;11599.616475570401;11841.526338946345;12035;12058.457369418222 16:10:16 INFO - PROCESS | 9755 | __end_tp_report 16:10:16 INFO - PROCESS | 9755 | __start_cc_report 16:10:16 INFO - PROCESS | 9755 | _x_x_mozilla_cycle_collect,797 16:10:16 INFO - PROCESS | 9755 | __end_cc_report 16:10:16 INFO - PROCESS | 9755 | __startTimestamp1464649816518__endTimestamp 16:10:16 INFO - PROCESS | 9755 | 16:10:16 INFO - PROCESS | 9755 | ------- Summary: start ------- 16:10:16 INFO - PROCESS | 9755 | Number of tests: 6 16:10:16 INFO - PROCESS | 9755 | 16:10:16 INFO - PROCESS | 9755 | [#0] dojo.html Cycles:165 Average:5609.89 Median:5856.12 stddev:632.82 (10.8%) stddev-sans-first:609.11 16:10:16 INFO - PROCESS | 9755 | Values: 3336.7 3353.9 3368.9 3389.2 3389.5 5549.1 5582.1 5583.9 5600.5 5607.9 5550.8 5582.1 5594.2 5605.9 5637.5 4928.7 5053.0 5160.0 5220.8 5239.9 5087.4 5112.6 5113.0 5119.5 5120.3 5105.5 5150.9 5152.8 5171.9 5182.7 5184.8 5185.9 5188.7 5230.4 5256.8 5039.4 5048.8 5068.7 5076.9 5112.5 5484.1 5532.2 5534.8 5550.6 5551.4 6050.9 6057.5 6059.9 6060.5 6063.6 6066.6 6067.8 6100.7 6113.2 6116.1 5610.8 5664.4 5665.9 5665.9 5699.4 6141.5 6182.9 6186.6 6190.8 6265.2 5831.6 5900.2 5906.7 5913.6 5913.6 5978.2 5980.3 5982.4 5983.6 5989.3 5837.1 5938.9 5940.9 5951.0 5994.5 6008.0 6025.0 6038.2 6038.5 6065.2 4572.1 4585.2 4586.6 4591.5 4611.1 4020.1 4051.5 4109.7 4122.2 4140.0 5798.4 5820.3 5822.5 5825.6 5856.1 6068.4 6120.4 6128.5 6129.1 6131.3 5593.8 5713.7 5808.8 5818.4 5885.1 5169.3 5171.5 5171.8 5175.2 5181.6 6254.3 6261.1 6265.8 6270.4 6272.9 5926.0 6023.7 6033.8 6069.4 6098.4 6202.4 6226.6 6258.6 6262.4 6285.4 5968.7 5975.4 5987.1 5989.3 6023.5 5909.1 6044.3 6103.1 6136.0 6136.9 5904.1 5905.8 5907.6 5911.6 5931.6 5831.2 5900.3 5900.5 5904.3 5906.4 5732.1 5903.3 5911.1 5963.6 5972.8 5896.1 5917.1 5919.4 5926.9 5935.3 5670.3 5779.9 5786.7 5787.5 5818.6 16:10:16 INFO - PROCESS | 9755 | 16:10:16 INFO - PROCESS | 9755 | [#1] ext.html Cycles:180 Average:55277.92 Median:37571.34 stddev:97549.44 (259.6%) stddev-sans-first:97736.95 16:10:16 INFO - PROCESS | 9755 | Values: 678.8 682.7 684.5 739.9 753.4 32089.2 32772.7 32785.2 32839.3 32853.2 35713.0 36571.6 44418.1 45137.3 45197.5 9139.4 9292.4 9345.3 9349.5 9366.4 8216.5 9123.8 9252.7 9257.4 9258.8 10893.3 11211.9 11218.9 11221.6 11223.9 10886.5 10997.5 10997.9 11002.6 11023.2 8188.2 8386.5 10341.6 10862.7 10981.3 40953.0 41639.6 41640.4 41693.6 41695.6 3823.6 3906.0 4007.0 4227.1 4460.4 30554.0 32056.2 32292.2 32294.3 32836.5 4586.6 4663.9 4701.4 4718.2 4746.3 320214.0 322822.0 323054.0 323272.0 323430.0 70196.0 71285.3 71340.0 71448.0 71461.6 74222.0 74262.0 74598.0 74735.6 74937.3 18866.7 19541.2 19597.9 19609.0 19626.0 13546.0 13674.2 13713.2 13729.7 13747.1 18987.8 20898.8 21299.3 21680.5 21711.7 7460.8 7526.6 7530.4 7812.6 7927.7 1155.1 1192.8 1220.8 1284.9 1299.8 33832.5 34179.5 34485.5 34781.1 34797.0 1239.1 1243.8 1290.6 1306.0 1317.9 18217.5 18670.0 18960.8 19008.9 19322.2 458352.0 464785.0 465561.0 467482.0 468252.0 65658.3 66327.0 66355.7 66439.7 66456.7 1368.9 1474.9 1510.8 1538.6 1549.6 30530.4 31047.5 31654.4 31931.6 32030.0 52901.5 53911.0 53927.5 53967.2 53997.7 301063.0 301850.0 303123.0 303280.0 303993.0 27779.7 30428.4 31213.0 31266.2 31904.0 45691.8 53211.7 53464.5 53833.7 54242.0 38581.3 39217.0 42068.8 42148.0 42842.8 41252.0 41944.4 42064.2 42653.6 43089.8 42202.2 42461.8 42462.2 43566.0 43651.3 37025.4 38117.2 38196.8 38402.0 38780.8 29031.3 29235.4 29483.6 29700.9 31470.0 16:10:16 INFO - PROCESS | 9755 | 16:10:16 INFO - PROCESS | 9755 | [#2] jquery.html Cycles:180 Average:30193.47 Median:11693.68 stddev:86913.55 (743.3%) stddev-sans-first:87128.65 16:10:16 INFO - PROCESS | 9755 | Values: 439.1 439.5 443.2 446.2 453.6 20113.4 20455.8 20549.6 20562.7 21256.8 18913.3 19380.4 19927.9 20593.3 20694.2 5691.6 5881.4 5886.1 5895.8 5897.7 4264.1 5790.3 5866.4 6141.7 6458.9 6423.8 6431.6 6445.9 6447.0 6449.3 5743.2 6014.7 6021.3 6028.3 6386.1 3917.4 5660.3 5853.8 5865.7 5913.5 13580.5 13632.4 13699.9 13830.6 13854.4 2551.3 2602.2 2671.5 2706.6 3087.4 10455.9 10536.2 10563.2 10783.3 10945.5 2034.7 2105.3 2105.5 2108.6 2145.0 77571.0 77668.6 79125.6 79571.0 79819.0 11197.3 11241.2 11337.7 11403.9 11698.9 15531.6 15606.6 15634.0 15639.2 15688.8 8455.5 8606.2 8957.9 8958.5 9016.7 8659.3 8669.4 8699.7 8745.0 8769.4 4936.8 4977.3 5168.2 5227.7 5283.4 1904.4 2054.0 2130.6 2140.1 2213.5 1023.5 1047.0 1064.2 1109.6 1113.1 19185.1 19333.8 19443.0 19570.4 19815.1 1041.8 1091.5 1104.1 1114.5 1115.7 10621.5 11098.3 11132.7 11306.8 11427.2 518654.0 521930.0 522672.0 530217.0 546624.0 94853.5 96177.0 96685.5 97274.0 98432.0 1068.9 1100.8 1105.0 1116.1 1119.8 17196.3 17322.7 17436.7 17532.2 17626.4 38960.2 39909.0 40726.0 41423.4 41856.0 58502.4 58720.7 59229.7 59334.0 60582.4 9198.3 9270.9 9303.3 9440.0 9464.1 12703.8 13416.1 13540.0 13548.5 13984.9 11719.3 12168.4 12314.8 12356.8 12546.3 11489.5 11970.3 12145.3 12212.8 12369.1 12594.3 12769.6 12876.9 12989.2 13063.2 9111.5 9328.3 9343.1 9473.0 9521.7 10505.3 11986.6 12148.1 12171.2 12280.5 16:10:16 INFO - PROCESS | 9755 | 16:10:16 INFO - PROCESS | 9755 | [#3] mootools.html Cycles:180 Average:5860.27 Median:5283.41 stddev:3201.97 (60.6%) stddev-sans-first:3193.66 16:10:16 INFO - PROCESS | 9755 | Values: 1432.4 1593.6 1611.7 1844.2 1974.1 8213.1 8355.1 8364.3 8366.8 8377.8 8526.8 8713.5 8723.3 8727.5 8731.1 2379.8 2385.2 2407.8 2407.9 2408.3 2447.2 2478.9 2517.2 2520.9 2532.3 2406.5 2417.3 2426.3 2439.9 2445.0 2437.9 2457.7 2470.9 2473.5 2481.7 2416.0 2466.2 2482.8 2482.9 2498.9 8557.0 8762.0 8793.9 8812.5 8814.0 5540.1 5654.2 5681.3 5694.4 5700.9 3485.4 3487.2 3510.6 3624.4 3685.5 1107.1 1165.2 1169.7 1175.4 1221.4 12118.2 12572.6 12631.1 12631.9 12682.5 4811.0 4863.9 4884.2 4929.0 4931.2 9879.7 9891.6 9917.8 9919.4 9935.2 5601.6 5642.4 5644.0 5653.7 5655.3 4449.7 4986.7 5079.5 5116.1 5237.9 3941.7 3977.8 4004.4 4024.9 4060.1 1250.6 1263.9 1278.2 1285.6 1293.2 876.6 1061.2 1082.2 1089.3 1108.1 6042.0 6340.3 6400.7 6486.8 6507.3 1001.5 1086.1 1092.7 1094.5 1131.9 4363.3 4402.6 4418.6 4420.3 4421.3 10844.2 11240.7 11261.6 11264.2 11266.0 10396.9 10697.5 11138.3 11149.1 11152.0 8173.8 8260.1 8288.3 8289.0 8361.0 6054.7 6168.7 6185.5 6236.3 6326.4 9634.4 9741.1 9772.3 9783.7 9806.2 9420.9 9680.4 9688.1 9794.7 9817.2 7022.4 7498.6 7678.0 7712.3 7912.1 8302.9 8319.5 8379.5 8380.8 8381.5 7413.8 7561.8 7600.0 7679.9 7759.1 7061.5 7113.4 7126.7 7226.8 7240.1 7279.9 7281.0 7324.2 7330.0 7340.1 5140.7 5269.1 5297.7 5324.2 5336.3 5462.5 5518.3 5547.1 5584.5 5588.4 16:10:16 INFO - PROCESS | 9755 | 16:10:16 INFO - PROCESS | 9755 | [#4] prototype.html Cycles:180 Average:5507.89 Median:6359.99 stddev:1671.22 (26.3%) stddev-sans-first:1630.02 16:10:16 INFO - PROCESS | 9755 | Values: 325.8 328.6 341.2 345.7 346.2 6163.7 6216.4 6225.4 6232.5 6318.7 6232.2 6246.7 6252.9 6254.7 6264.3 4529.0 4652.9 4758.8 4779.1 4786.6 4755.6 4776.8 4791.5 4801.2 4808.5 4525.2 4752.2 4753.1 4760.2 4760.8 4601.6 4716.9 4717.6 4742.9 4747.3 4154.0 4155.3 4166.9 4170.7 4181.5 5989.3 5999.5 6020.7 6027.4 6034.5 5512.6 5524.5 5525.6 5533.0 5545.4 6410.5 6542.4 6562.2 6577.4 6579.0 4545.9 4558.7 4559.6 4563.8 4583.7 6825.4 6860.9 6869.9 6874.8 6879.5 4645.3 4660.1 4662.5 4663.0 4672.9 4726.5 4726.7 4727.5 4737.5 4738.8 5449.8 5459.5 5463.8 5468.9 5482.3 6396.5 6612.2 6618.7 6633.5 6635.4 1612.4 1615.4 1618.3 1619.6 1624.4 979.9 1052.7 1057.8 1073.5 1078.1 6426.0 6433.1 6433.4 6433.9 6442.4 6783.4 6788.2 6794.8 6799.2 6809.8 6357.2 6359.7 6360.3 6365.0 6416.1 3632.1 3646.3 3656.0 3668.4 3677.6 6915.8 7071.6 7076.2 7078.2 7081.2 6885.0 6888.2 6911.3 6912.7 6916.3 7046.6 7047.5 7048.8 7059.8 7059.8 6750.9 6755.9 6760.0 6767.3 6770.8 6491.2 6602.1 6653.2 6661.7 6665.4 6982.7 7000.4 7012.6 7019.7 7022.1 4594.9 4599.1 4603.8 4604.4 4605.4 6720.8 6723.8 6725.5 6725.6 6727.8 6388.8 6552.8 6566.5 6570.1 6586.8 6511.7 6539.7 6547.1 6554.4 6565.9 6469.3 6539.2 6543.9 6552.9 6556.1 6693.9 6705.9 6709.7 6712.5 6714.6 6419.5 6512.4 6530.0 6543.3 6543.8 16:10:16 INFO - PROCESS | 9755 | 16:10:16 INFO - PROCESS | 9755 | [#5] yui.html Cycles:180 Average:16208.41 Median:4105.09 stddev:18712.51 (455.8%) stddev-sans-first:18729.85 16:10:16 INFO - PROCESS | 9755 | Values: 935.5 935.6 937.2 947.2 975.4 13389.7 14939.1 15167.8 15263.7 15293.3 14269.5 14342.9 14345.0 14354.3 14363.1 756.5 764.2 764.7 765.3 907.3 923.9 927.1 927.9 928.5 928.6 962.5 972.3 974.8 975.2 976.7 969.7 971.2 971.2 972.3 972.6 590.1 694.1 708.7 709.0 718.7 13863.0 13929.8 13973.7 14011.5 14128.3 14326.0 14613.1 14898.2 14937.2 15134.9 11952.6 12002.3 12070.2 12111.8 12312.4 4078.5 4092.1 4118.0 4180.6 4232.7 55699.4 56498.0 56629.4 56632.0 57267.7 12315.4 12332.8 12422.6 12468.9 12554.1 21927.5 22016.3 22057.6 22087.0 22097.8 8777.4 9045.7 9045.8 9076.3 9399.2 4885.0 4956.2 4979.7 5063.6 5112.2 3807.4 3864.1 3869.0 3869.9 3878.5 650.9 652.8 653.6 663.2 676.3 757.6 784.8 786.9 788.7 799.8 9930.8 10232.6 10246.7 10350.1 10425.2 735.9 752.2 782.5 788.5 809.0 4602.7 4617.5 4650.4 4663.8 4984.3 67423.7 67608.0 67644.7 68237.0 72282.0 59573.4 59835.0 60888.0 61206.4 61818.7 53699.2 53957.7 54506.2 54814.7 56114.4 10210.5 10402.4 10417.8 10680.6 10751.4 39103.2 39232.4 39407.6 40016.4 40525.4 46818.0 51094.5 51386.5 52356.7 52574.0 12842.2 12860.5 12977.6 13195.1 13255.3 13933.0 14027.1 14131.2 14239.2 14577.5 14103.0 14112.9 14149.5 14340.1 14539.9 14060.2 14066.2 14144.4 14156.1 14623.4 13415.7 13650.1 13963.6 14095.0 14107.0 11473.8 11638.1 11815.4 11879.5 12122.2 11315.9 11599.6 11841.5 12035.0 12058.5 16:10:16 INFO - PROCESS | 9755 | -------- Summary: end -------- 16:10:16 INFO - PROCESS | 9755 | 16:10:17 INFO - TEST-INFO | 9755: exit 0 16:10:17 INFO - TEST-OK | dromaeo_css | took 1111215ms 16:10:17 INFO - TEST-START | kraken 16:10:17 INFO - operating with platform_type : linux_ 16:10:17 INFO - Initialising browser for kraken test... 16:10:17 INFO - TEST-INFO | started process 9942 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm2yPou/profile http://localhost:51295/getInfo.html) 16:10:21 INFO - PROCESS | 9942 | __metrics Screen width/height:1600/1200 16:10:21 INFO - PROCESS | 9942 | colorDepth:24 16:10:21 INFO - PROCESS | 9942 | Browser inner width/height: 1024/697 16:10:21 INFO - PROCESS | 9942 | __metrics 16:10:22 ERROR - PROCESS | 9942 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:10:23 INFO - TEST-INFO | 9942: exit 0 16:10:23 INFO - Browser initialized. 16:10:23 INFO - Running cycle 1/1 for kraken test... 16:10:23 INFO - TEST-INFO | started process 10032 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm2yPou/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:10:34 INFO - PROCESS | 10032 | RSS: Main: 142123008 16:10:34 INFO - PROCESS | 10032 | 16:10:37 INFO - PROCESS | 10032 | Cycle 1(1): loaded http://localhost:51295/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51295/tests/kraken/driver.html?testName=audio-beat-detection) 16:10:38 INFO - PROCESS | 10032 | RSS: Main: 197234688 16:10:38 INFO - PROCESS | 10032 | 16:10:40 INFO - PROCESS | 10032 | Cycle 1(1): loaded http://localhost:51295/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51295/tests/kraken/driver.html?testName=audio-dft) 16:10:41 INFO - PROCESS | 10032 | RSS: Main: 181350400 16:10:41 INFO - PROCESS | 10032 | 16:10:44 INFO - PROCESS | 10032 | Cycle 1(1): loaded http://localhost:51295/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51295/tests/kraken/driver.html?testName=audio-fft) 16:10:44 INFO - PROCESS | 10032 | RSS: Main: 272240640 16:10:44 INFO - PROCESS | 10032 | 16:10:46 INFO - PROCESS | 10032 | Cycle 1(1): loaded http://localhost:51295/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51295/tests/kraken/driver.html?testName=audio-oscillator) 16:10:47 INFO - PROCESS | 10032 | RSS: Main: 178040832 16:10:47 INFO - PROCESS | 10032 | 16:10:49 INFO - PROCESS | 10032 | Cycle 1(1): loaded http://localhost:51295/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51295/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:10:50 INFO - PROCESS | 10032 | RSS: Main: 177295360 16:10:50 INFO - PROCESS | 10032 | 16:10:53 INFO - PROCESS | 10032 | Cycle 1(1): loaded http://localhost:51295/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51295/tests/kraken/driver.html?testName=imaging-darkroom) 16:10:53 INFO - PROCESS | 10032 | RSS: Main: 211689472 16:10:53 INFO - PROCESS | 10032 | 16:10:57 INFO - PROCESS | 10032 | Cycle 1(1): loaded http://localhost:51295/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51295/tests/kraken/driver.html?testName=imaging-desaturate) 16:10:57 INFO - PROCESS | 10032 | RSS: Main: 211402752 16:10:57 INFO - PROCESS | 10032 | 16:11:00 INFO - PROCESS | 10032 | Cycle 1(1): loaded http://localhost:51295/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51295/tests/kraken/driver.html?testName=json-parse-financial) 16:11:01 INFO - PROCESS | 10032 | RSS: Main: 212045824 16:11:01 INFO - PROCESS | 10032 | 16:11:02 INFO - PROCESS | 10032 | Cycle 1(1): loaded http://localhost:51295/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51295/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:11:03 INFO - PROCESS | 10032 | RSS: Main: 192274432 16:11:03 INFO - PROCESS | 10032 | 16:11:04 INFO - PROCESS | 10032 | Cycle 1(1): loaded http://localhost:51295/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51295/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:11:05 INFO - PROCESS | 10032 | RSS: Main: 193560576 16:11:05 INFO - PROCESS | 10032 | 16:11:07 INFO - PROCESS | 10032 | Cycle 1(1): loaded http://localhost:51295/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51295/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:11:08 INFO - PROCESS | 10032 | RSS: Main: 205889536 16:11:08 INFO - PROCESS | 10032 | 16:11:10 INFO - PROCESS | 10032 | Cycle 1(1): loaded http://localhost:51295/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51295/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:11:11 INFO - PROCESS | 10032 | RSS: Main: 208265216 16:11:11 INFO - PROCESS | 10032 | 16:11:13 INFO - PROCESS | 10032 | Cycle 1(1): loaded http://localhost:51295/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51295/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:11:14 INFO - PROCESS | 10032 | RSS: Main: 205729792 16:11:14 INFO - PROCESS | 10032 | 16:11:16 INFO - PROCESS | 10032 | Cycle 1(1): loaded http://localhost:51295/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51295/tests/kraken/driver.html?testName=ai-astar) 16:11:16 INFO - PROCESS | 10032 | RSS: Main: 269766656 16:11:16 INFO - PROCESS | 10032 | 16:11:16 INFO - PROCESS | 10032 | __start_tp_report 16:11:16 INFO - PROCESS | 10032 | _x_x_mozilla_page_load 16:11:16 INFO - PROCESS | 10032 | _x_x_mozilla_page_load_details 16:11:16 INFO - PROCESS | 10032 | |i|pagename|runs| 16:11:16 INFO - PROCESS | 10032 | |0;ai-astar;110;111;111;109;110;110;106;108;109;109 16:11:16 INFO - PROCESS | 10032 | |1;audio-beat-detection;156;125;159;184;127;152;154;125;196;125 16:11:16 INFO - PROCESS | 10032 | |2;audio-dft;161;162;161;161;160;161;160;162;161;161 16:11:16 INFO - PROCESS | 10032 | |3;audio-fft;76;76;74;173;76;74;75;75;167;75 16:11:16 INFO - PROCESS | 10032 | |4;audio-oscillator;93;92;148;92;92;91;150;93;92;144 16:11:16 INFO - PROCESS | 10032 | |5;imaging-gaussian-blur;116;117;116;116;117;117;117;116;116;117 16:11:16 INFO - PROCESS | 10032 | |6;imaging-darkroom;145;145;145;145;145;146;145;145;145;146 16:11:16 INFO - PROCESS | 10032 | |7;imaging-desaturate;95;94;95;95;95;94;94;95;95;94 16:11:16 INFO - PROCESS | 10032 | |8;json-parse-financial;54;52;53;54;53;52;57;75;52;51 16:11:16 INFO - PROCESS | 10032 | |9;json-stringify-tinderbox;57;58;56;57;58;57;58;58;58;57 16:11:16 INFO - PROCESS | 10032 | |10;stanford-crypto-aes;72;73;72;72;75;73;73;75;86;74 16:11:16 INFO - PROCESS | 10032 | |11;stanford-crypto-ccm;125;129;111;115;115;114;123;117;168;111 16:11:16 INFO - PROCESS | 10032 | |12;stanford-crypto-pbkdf2;164;158;162;169;156;161;159;162;159;159 16:11:16 INFO - PROCESS | 10032 | |13;stanford-crypto-sha256-iterative;65;74;66;66;65;67;65;65;65;64 16:11:16 INFO - PROCESS | 10032 | __end_tp_report 16:11:16 INFO - PROCESS | 10032 | __start_cc_report 16:11:16 INFO - PROCESS | 10032 | _x_x_mozilla_cycle_collect,1605 16:11:16 INFO - PROCESS | 10032 | __end_cc_report 16:11:16 INFO - PROCESS | 10032 | __startTimestamp1464649876361__endTimestamp 16:11:16 INFO - PROCESS | 10032 | 16:11:16 INFO - PROCESS | 10032 | ------- Summary: start ------- 16:11:16 INFO - PROCESS | 10032 | Number of tests: 14 16:11:16 INFO - PROCESS | 10032 | 16:11:16 INFO - PROCESS | 10032 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.00 stddev:1.49 (1.4%) stddev-sans-first:1.56 16:11:16 INFO - PROCESS | 10032 | Values: 110.0 111.0 111.0 109.0 110.0 110.0 106.0 108.0 109.0 109.0 16:11:16 INFO - PROCESS | 10032 | 16:11:16 INFO - PROCESS | 10032 | [#1] audio-beat-detection Cycles:10 Average:150.30 Median:155.00 stddev:25.41 (16.4%) stddev-sans-first:26.87 16:11:16 INFO - PROCESS | 10032 | Values: 156.0 125.0 159.0 184.0 127.0 152.0 154.0 125.0 196.0 125.0 16:11:16 INFO - PROCESS | 10032 | 16:11:16 INFO - PROCESS | 10032 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 16:11:16 INFO - PROCESS | 10032 | Values: 161.0 162.0 161.0 161.0 160.0 161.0 160.0 162.0 161.0 161.0 16:11:16 INFO - PROCESS | 10032 | 16:11:16 INFO - PROCESS | 10032 | [#3] audio-fft Cycles:10 Average:94.10 Median:75.00 stddev:40.03 (53.4%) stddev-sans-first:41.92 16:11:16 INFO - PROCESS | 10032 | Values: 76.0 76.0 74.0 173.0 76.0 74.0 75.0 75.0 167.0 75.0 16:11:16 INFO - PROCESS | 10032 | 16:11:16 INFO - PROCESS | 10032 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:92.00 stddev:26.70 (29.0%) stddev-sans-first:27.71 16:11:16 INFO - PROCESS | 10032 | Values: 93.0 92.0 148.0 92.0 92.0 91.0 150.0 93.0 92.0 144.0 16:11:16 INFO - PROCESS | 10032 | 16:11:16 INFO - PROCESS | 10032 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 16:11:16 INFO - PROCESS | 10032 | Values: 116.0 117.0 116.0 116.0 117.0 117.0 117.0 116.0 116.0 117.0 16:11:16 INFO - PROCESS | 10032 | 16:11:16 INFO - PROCESS | 10032 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 16:11:16 INFO - PROCESS | 10032 | Values: 145.0 145.0 145.0 145.0 145.0 146.0 145.0 145.0 145.0 146.0 16:11:16 INFO - PROCESS | 10032 | 16:11:16 INFO - PROCESS | 10032 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 16:11:16 INFO - PROCESS | 10032 | Values: 95.0 94.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 94.0 16:11:16 INFO - PROCESS | 10032 | 16:11:16 INFO - PROCESS | 10032 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:53.50 stddev:7.12 (13.3%) stddev-sans-first:7.54 16:11:16 INFO - PROCESS | 10032 | Values: 54.0 52.0 53.0 54.0 53.0 52.0 57.0 75.0 52.0 51.0 16:11:16 INFO - PROCESS | 10032 | 16:11:16 INFO - PROCESS | 10032 | [#9] json-stringify-tinderbox Cycles:10 Average:57.40 Median:58.00 stddev:0.70 (1.2%) stddev-sans-first:0.73 16:11:16 INFO - PROCESS | 10032 | Values: 57.0 58.0 56.0 57.0 58.0 57.0 58.0 58.0 58.0 57.0 16:11:16 INFO - PROCESS | 10032 | 16:11:16 INFO - PROCESS | 10032 | [#10] stanford-crypto-aes Cycles:10 Average:74.50 Median:73.50 stddev:4.20 (5.7%) stddev-sans-first:4.35 16:11:16 INFO - PROCESS | 10032 | Values: 72.0 73.0 72.0 72.0 75.0 73.0 73.0 75.0 86.0 74.0 16:11:16 INFO - PROCESS | 10032 | 16:11:16 INFO - PROCESS | 10032 | [#11] stanford-crypto-ccm Cycles:10 Average:122.80 Median:120.00 stddev:16.99 (14.2%) stddev-sans-first:18.00 16:11:16 INFO - PROCESS | 10032 | Values: 125.0 129.0 111.0 115.0 115.0 114.0 123.0 117.0 168.0 111.0 16:11:16 INFO - PROCESS | 10032 | 16:11:16 INFO - PROCESS | 10032 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.90 Median:161.50 stddev:3.67 (2.3%) stddev-sans-first:3.71 16:11:16 INFO - PROCESS | 10032 | Values: 164.0 158.0 162.0 169.0 156.0 161.0 159.0 162.0 159.0 159.0 16:11:16 INFO - PROCESS | 10032 | 16:11:16 INFO - PROCESS | 10032 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:65.50 stddev:2.86 (4.4%) stddev-sans-first:3.00 16:11:16 INFO - PROCESS | 10032 | Values: 65.0 74.0 66.0 66.0 65.0 67.0 65.0 65.0 65.0 64.0 16:11:16 INFO - PROCESS | 10032 | -------- Summary: end -------- 16:11:16 INFO - PROCESS | 10032 | 16:11:17 INFO - TEST-INFO | 10032: exit 0 16:11:17 INFO - TEST-OK | kraken | took 60056ms 16:11:17 INFO - SUITE-END | took 1171s 16:11:17 INFO - Completed test suite (00:19:31) 16:11:17 INFO - javascript benchmark 16:11:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3336.733061355091, 3353.8993830185104, 3368.898933032009, 3389.220479289762, 3389.4746314321287, 5549.056660367737, 5582.078956972095, 5583.8604034899145, 5600.4959553640165, 5607.859803504909, 5550.750216240269, 5582.051051321275, 5594.24477695511, 5605.915911261334, 5637.46444087811, 4928.654994150411, 5053.039922414739, 5159.974200128994, 5220.791168353261, 5239.869003274911, 5087.364079490064, 5112.590992720592, 5113.0, 5119.4880511948695, 5120.334356533645, 5105.5149760772665, 5150.871228219287, 5152.819651312205, 5171.896562068757, 5182.6631268967585, 5184.766685499161, 5185.922211166836, 5188.740562971836, 5230.398504172031, 5256.763445644936, 5039.44566097729, 5048.7980480780725, 5068.72122033288, 5076.873078173038, 5112.488751124895, 5484.149956756709, 5532.197831314437, 5534.833954981357, 5550.611457197998, 5551.444855514456, 6050.939490605126, 6057.515398768088, 6059.909101363439, 6060.454559089659, 6063.636181829104, 6066.636001839904, 6067.816775728735, 6100.69496525172, 6113.174721412597, 6116.12274041307, 5610.831675049755, 5664.376918538957, 5665.8583535411535, 5665.886682266331, 5699.401562835926, 6141.516692814182, 6182.938170618326, 6186.597871138361, 6190.845228869314, 6265.216847894013, 5831.562632802472, 5900.1739756434135, 5906.675132867647, 5913.5564832636865, 5913.58604897653, 5978.192943952511, 5980.282366116007, 5982.4017598239825, 5983.551233657493, 5989.2812862456785, 5837.124431335334, 5938.851528711731, 5940.910886336708, 5950.9702451487465, 5994.460498555064, 6008.03871380577, 6025.0, 6038.245219347582, 6038.516918646497, 6065.150878876961, 4572.1312950539295, 4585.1746685596245, 4586.610138138229, 4591.494935557086, 4611.146937816515, 4020.1356708307853, 4051.513818341818, 4109.712320137562, 4122.196171746481, 4140.0, 5798.420157984167, 5820.330661973842, 5822.534197264209, 5825.621334613236, 5856.121581762684, 6068.362821903725, 6120.449159575571, 6128.540359472968, 6129.08063790435, 6131.294901086343, 5593.804216852391, 5713.6857472838565, 5808.767649293981, 5818.359980402152, 5885.146653735184, 5169.250458683545, 5171.456997015259, 5171.81898633546, 5175.171972484384, 5181.5854731621375, 6254.312025677172, 6261.060840873905, 6265.843353916189, 6270.372962703693, 6272.905906411407, 5926.0, 6023.728932197974, 6033.849153771103, 6069.362716914837, 6098.359672234352, 6202.41077097675, 6226.62640241587, 6258.593191442542, 6262.405071518198, 6285.371462853678, 5968.70156492165, 5975.43233392827, 5987.131865879336, 5989.299489859401, 6023.548233882389, 5909.143174239797, 6044.304904935989, 6103.084537319438, 6135.998322733915, 6136.88672321611, 5904.0553511437965, 5905.822825315247, 5907.586468947133, 5911.645301281937, 5931.6441013539325, 5831.154482599914, 5900.262467191601, 5900.468957793819, 5904.261967254093, 5906.350301466749, 5732.082866741302, 5903.26209223847, 5911.054231322968, 5963.582549221513, 5972.820815375546, 5896.14505896634, 5917.053271476543, 5919.4080591940465, 5926.851828704317, 5935.347111817783, 5670.291213598301, 5779.884402312015, 5786.710664466844, 5787.508061814625, 5818.6217895836635], "value": 5567.964342018116, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [678.7658257901024, 682.7405585877366, 684.4763755726867, 739.8606146534335, 753.3972821742605, 32089.19777005576, 32772.67227327726, 32785.18037049072, 32839.343213135726, 32853.17867053325, 35713.0, 36571.63428365716, 44418.11163776722, 45137.32294015584, 45197.54802451975, 9139.360244782867, 9292.44245345278, 9345.2991025673, 9349.532523373839, 9366.438013719164, 8216.507009579414, 9123.817523649523, 9252.722418327461, 9257.39826911252, 9258.76853078675, 10893.291936024134, 11211.887881121165, 11218.887811121866, 11221.60724374647, 11223.887761122365, 10886.455677216147, 10997.450127493594, 10997.945010274978, 11002.614908478205, 11023.1732620053, 8188.222118898755, 8386.496810191407, 10341.586336546605, 10862.72843178919, 10981.286216395989, 40953.0, 41639.583604163876, 41640.375394368806, 41693.583064169274, 41695.583044169776, 3823.636754508317, 3905.9609403905883, 4006.979965100156, 4227.133437645306, 4460.442444694413, 30554.0, 32056.198595035312, 32292.192695182574, 32294.285983523965, 32836.507452388236, 4586.610138138262, 4663.883402914954, 4701.388819453449, 4718.150732868083, 4746.288056791474, 320214.0, 322822.0, 323054.0, 323272.0, 323430.0, 70196.0, 71285.2871471289, 71340.0, 71448.0, 71461.64269178621, 74222.0, 74262.0, 74598.0, 74735.62632186913, 74937.25062749302, 18866.71699924502, 19541.218351266074, 19597.902010489855, 19609.0, 19626.0, 13546.0, 13674.247916364497, 13713.17720936727, 13729.725405492034, 13747.106438081493, 18987.81012189888, 20898.791012089685, 21299.254526091514, 21680.457988550097, 21711.674324885138, 7460.776176714708, 7526.623668816537, 7530.397568194531, 7812.648430820626, 7927.682892684344, 1155.064397837754, 1192.8151136573845, 1220.8107743299802, 1284.9421776020101, 1299.7660421124099, 33832.49251261233, 34179.487307690404, 34485.48271775875, 34781.1304717379, 34797.0, 1239.0892693869998, 1243.7823380908305, 1290.5612091888802, 1305.9608211753662, 1317.911110889232, 18217.45347639573, 18670.0, 18960.810391895906, 19008.904955475133, 19322.227110915686, 458352.0, 464785.0, 465561.0, 467482.0, 468252.0, 65658.34341656617, 66327.0, 66355.66822165955, 66439.66780166069, 66456.6677166611, 1368.8973327000515, 1474.8525147485166, 1510.8187017557964, 1538.6384199713282, 1549.6280892585924, 30530.389392211586, 31047.534286986163, 31654.366912662077, 31931.623253646434, 32030.0, 52901.470985289656, 53911.0, 53927.460725392244, 53967.19049214186, 53997.73001135126, 301063.0, 301850.0, 303123.0, 303280.0, 303993.0, 27779.722202777713, 30428.391432171677, 31213.0, 31266.21834454157, 31904.0, 45691.77154114208, 53211.73394133004, 53464.46535534595, 53833.730831345594, 54242.0, 38581.294159913465, 39217.0, 42068.78965605152, 42148.0, 42842.78578607087, 41252.0, 41944.370834438116, 42064.1587168261, 42653.5734642662, 43089.78455107704, 42202.15595688007, 42461.78769106135, 42462.150756985306, 43566.0, 43651.34522982221, 37025.44461833128, 38117.23765524729, 38196.80901595474, 38402.0, 38780.80609596934, 29031.274218144714, 29235.415291694473, 29483.557746634247, 29700.851495742383, 31470.0], "value": 21211.431724567494, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [439.13928699748493, 439.4879964840961, 443.2464809823301, 446.15231060984127, 453.55778116336575, 20113.396598102063, 20455.795442045575, 20549.589008219864, 20562.69155962662, 21256.787432125693, 18913.338033168842, 19380.4185874424, 19927.900360498177, 20593.27923522677, 20694.172233110694, 5691.630044047134, 5881.411858814127, 5886.087656413241, 5895.764169433239, 5897.675627840467, 4264.083222107246, 5790.276215473066, 5866.384029676865, 6141.692915354237, 6458.93541064588, 6423.807285781434, 6431.646259455728, 6445.8710825783455, 6446.967765161167, 6449.290578036413, 5743.224664670279, 6014.699265036731, 6021.337652858182, 6028.276606807167, 6386.137871387373, 3917.373220284741, 5660.3490598581275, 5853.76584936602, 5865.677387743673, 5913.497352725023, 13580.524681636194, 13632.386542605607, 13699.863001370059, 13830.585082447542, 13854.376553055137, 2551.323899166722, 2602.206327070243, 2671.479061582992, 2706.5534186859145, 3087.444260033193, 10455.895441045644, 10536.157107431387, 10563.207759418074, 10783.299085559414, 10945.45272736368, 2034.6642803937332, 2105.3157723739846, 2105.473631592102, 2108.620448319302, 2144.9785502144937, 77571.0, 77668.61165694192, 79125.60437197777, 79571.0, 79819.0, 11197.328160310408, 11241.15691323154, 11337.659870203906, 11403.885961140448, 11698.883011169779, 15531.611709707347, 15606.609834754221, 15634.0, 15639.218039098, 15688.76466852998, 8455.49267043967, 8606.182412670787, 8957.910420895838, 8958.462492250486, 9016.729498115066, 8659.26814637075, 8669.436486628349, 8699.739007829776, 8745.0, 8769.429987050822, 4936.802527898915, 4977.278294647328, 5168.173092305213, 5227.660202086852, 5283.418823929364, 1904.4001139640968, 2054.0, 2130.5632345369163, 2140.1118535807464, 2213.4687674957895, 1023.4780262066399, 1046.984295235572, 1064.1699474409972, 1109.6116359274351, 1113.1317572293624, 19185.136668849937, 19333.806661933482, 19443.0, 19570.412887613395, 19815.10832012563, 1041.7864337810731, 1091.4815462655333, 1104.0725790335996, 1114.4929057278919, 1115.7154925493946, 10621.468926553642, 11098.334099954029, 11132.721681957853, 11306.773864522827, 11427.200095993367, 518654.0, 521930.0, 522672.0, 530217.0, 546624.0, 94853.52573237228, 96177.0, 96685.51657241669, 97274.0, 98432.0, 1068.871735391758, 1100.7908497385472, 1104.9944750276197, 1116.0569318925495, 1119.7872404243167, 17196.31214751396, 17322.74015889788, 17436.651266974335, 17532.2110505025, 17626.383076592258, 38960.22079558449, 39909.0, 40725.98185045397, 41423.37864932089, 41856.0, 58502.414975851396, 58720.70639646774, 59229.703851480466, 59334.0, 60582.39417605944, 9198.310126740387, 9270.940589605549, 9303.302252331237, 9440.0, 9464.1009104135, 12703.809442858179, 13416.12795168311, 13540.0, 13548.525801596898, 13984.930075349965, 11719.296842189497, 12168.391580420766, 12314.753704925672, 12356.814647780471, 12546.309952952675, 11489.482973266391, 11970.281783093042, 12145.271283723005, 12212.816807747713, 12369.072319575887, 12594.307313097868, 12769.61691149267, 12876.935615321863, 12989.220646761225, 13063.216207027608, 9111.544422778701, 9328.253739700944, 9343.112404321579, 9472.970682934974, 9521.714348569554, 10505.264631475724, 11986.580469683518, 12148.088893333212, 12171.208871423329, 12280.508779648713], "value": 9555.162870533504, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1432.44134787433, 1593.6493971326308, 1611.677664467107, 1844.160906787411, 1974.1412485568778, 8213.137620549845, 8355.080941096474, 8364.289035431988, 8366.83266334673, 8377.790555236123, 8526.829463410744, 8713.520756358397, 8723.345749068814, 8727.476351418904, 8731.126887311282, 2379.7620237976153, 2385.2486466763003, 2407.7832995030444, 2407.9157229496973, 2408.289554581394, 2447.2046584859904, 2478.8512689238705, 2517.169334119736, 2520.9495810083786, 2532.3289328327915, 2406.5186962607463, 2417.3110663460916, 2426.284246147382, 2439.9390015249583, 2444.960891621054, 2437.926862194137, 2457.69278840145, 2470.851748895072, 2473.468204336067, 2481.6773819403543, 2415.9894575005405, 2466.2231397109854, 2482.8262021658493, 2482.900683972639, 2498.925032249035, 8557.0, 8762.036176020632, 8793.868091978626, 8812.471251724917, 8814.030456649763, 5540.085885828834, 5654.180143879114, 5681.318241810968, 5694.373618901917, 5700.914486282709, 3485.3900567400606, 3487.1805125795418, 3510.596281427643, 3624.3657359961903, 3685.5024571682748, 1107.1474964277543, 1165.2134809003974, 1169.7426566155432, 1175.4416652090274, 1221.3832014832542, 12118.151729378947, 12572.559960401433, 12631.115821892472, 12631.93684031574, 12682.492700291978, 4811.0, 4863.927041094386, 4884.1941079722155, 4929.0, 4931.235658472942, 9879.654212102541, 9891.604335826487, 9917.752056198653, 9919.404835709736, 9935.155511781435, 5601.579881508903, 5642.379338272786, 5643.971780141155, 5653.660780353192, 5655.264815574032, 4449.666275029385, 4986.7257300848805, 5079.466656001066, 5116.104681680691, 5237.895242095136, 3941.724079314478, 3977.7812220327583, 4004.3993400990084, 4024.9195016099516, 4060.127072679388, 1250.5810553464692, 1263.91784534005, 1278.1947373154853, 1285.6207418811473, 1293.2111412038648, 876.5792419638609, 1061.1775873697945, 1082.1667316166508, 1089.3246187363727, 1108.0858291909208, 6041.969790151021, 6340.3342649022115, 6400.71196796136, 6486.805395838132, 6507.284198738135, 1001.5242759689235, 1086.0659832544006, 1092.6612750047511, 1094.5293523784849, 1131.8811524789778, 4363.3018717005125, 4402.6037656610415, 4418.624416924533, 4420.31485119807, 4421.314696222091, 10844.240903136862, 11240.662780116609, 11261.605843795427, 11264.155188360906, 11266.042386397085, 10396.948015259875, 10697.518611662339, 11138.276012059352, 11149.052330551995, 11152.0, 8173.754787356389, 8260.091389947102, 8288.295494882881, 8288.958555207186, 8361.03848057469, 6054.66699331541, 6168.660723660242, 6185.505159587312, 6236.34518375564, 6326.398992095744, 9634.421934683942, 9741.123298903132, 9772.267079969173, 9783.657571984946, 9806.166475849348, 9420.905790942003, 9680.370775899544, 9688.079632434907, 9794.65718699842, 9817.165540929102, 7022.367986881205, 7498.550086994798, 7677.9616101921365, 7712.344450721752, 7912.129665736879, 8302.87545686803, 8319.542425166674, 8379.49723016621, 8380.832383352421, 8381.53901535397, 7413.777586672409, 7561.7731468056045, 7600.049993750781, 7679.923200768144, 7759.107702614046, 7061.505694601328, 7113.359797618239, 7126.679299431435, 7226.819329516804, 7240.094988126484, 7279.890801637874, 7280.963595182202, 7324.194338622854, 7329.963350183215, 7340.11918569775, 5140.7429628517675, 5269.077911365573, 5297.735113244399, 5324.227986941949, 5336.332958380202, 5462.453754624506, 5518.33779946409, 5547.140193270049, 5584.497395234448, 5588.413216612197], "value": 4768.799176982397, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.8419666461766, 328.63521491144826, 341.2288228603356, 345.7320576553171, 346.2434580441737, 6163.660998645073, 6216.378362163781, 6225.439710426061, 6232.501399888015, 6318.747250110002, 6232.189815324002, 6246.687665616712, 6252.906206406908, 6254.655993920333, 6264.279607845087, 4529.04889973106, 4652.883677908062, 4758.833440829554, 4779.139754844126, 4786.641001924852, 4755.571998520132, 4776.832810851621, 4791.47293797682, 4801.207800712878, 4808.519148085198, 4525.185466616008, 4752.215884379073, 4753.120672675549, 4760.166970780099, 4760.761961901909, 4601.562851529116, 4716.858494245161, 4717.551832575899, 4742.857714268577, 4747.311639812208, 4154.0, 4155.31437312843, 4166.91666166678, 4170.70805043647, 4181.540030596632, 5989.251343582052, 5999.520038396918, 6020.6989650517735, 6027.427394397525, 6034.456898879078, 5512.586556008316, 5524.475174858382, 5525.557955363562, 5532.972335138339, 5545.445455454463, 6410.487161027107, 6542.4438922691625, 6562.212534495843, 6577.40803327698, 6579.0460383244645, 4545.863624091249, 4558.749268790215, 4559.589636932659, 4563.840265590688, 4583.656225783079, 6825.419839313664, 6860.862782744367, 6869.931300686979, 6874.828129296808, 6879.484038697168, 4645.279981602789, 4660.13787449323, 4662.510436404129, 4662.976685116552, 4672.929906051412, 4726.527347265314, 4726.692764970335, 4727.456342520654, 4737.549932756383, 4738.810447582058, 5449.782008719607, 5459.481349271813, 5463.754131064112, 5468.863278418072, 5482.259894914136, 6396.520260980352, 6612.239592446834, 6618.735250590019, 6633.4693224541925, 6635.369639884299, 1612.3631165689487, 1615.3780794394243, 1618.3041292244213, 1619.6436783907523, 1624.3746157729358, 979.8775153105862, 1052.726291164303, 1057.8043062033548, 1073.4847273308856, 1078.0567003871613, 6426.0, 6433.131527243856, 6433.388828061326, 6433.903491447539, 6442.35576442352, 6783.423409010289, 6788.2193547742645, 6794.76218332356, 6799.150106236721, 6809.761658341934, 6357.237131544244, 6359.682015899279, 6360.300366959631, 6365.013422919455, 6416.101745755598, 3632.0738211755834, 3646.288973650113, 3655.9817200913826, 3668.449732540087, 3677.595464498903, 6915.827104322331, 7071.611061391673, 7076.186238582526, 7078.150621925299, 7081.185663648644, 6884.965575172192, 6888.242293347727, 6911.272181954511, 6912.688928998207, 6916.273791251947, 7046.577205367695, 7047.506674532733, 7048.753293634801, 7059.788206353817, 7059.8235044123285, 6750.932490675227, 6755.86488270222, 6759.966200168968, 6767.289434609295, 6770.830729231611, 6491.156149700509, 6602.10871532337, 6653.2016158059405, 6661.700223489857, 6665.400113989765, 6982.7206911725, 7000.439964802702, 7012.649367531705, 7019.684114214975, 7022.08712867324, 4594.88512787183, 4599.080183963288, 4603.769811509478, 4604.355390245301, 4605.355250264898, 6720.831979200363, 6723.7646682365885, 6725.461963042847, 6725.630090345078, 6727.831804204934, 6388.8083357499345, 6552.770653027121, 6566.474682025522, 6570.113034740249, 6586.769463068769, 6511.674416279072, 6539.70571324282, 6547.083408322744, 6554.442872355903, 6565.901511477427, 6469.288378278292, 6539.182602174728, 6543.901841472477, 6552.934470655233, 6556.082148499118, 6693.866122677617, 6705.932940670726, 6709.7316107355155, 6712.49656275791, 6714.630695311805, 6419.5013717523125, 6512.413882750575, 6530.0, 6543.312952139957, 6543.803685889431], "value": 4952.892182176118, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [935.4808081514759, 935.5930170375891, 937.1565590968123, 947.2280091725241, 975.3903810118676, 13389.665258368534, 14939.103653780781, 15167.772483412744, 15263.694726105472, 15293.311800968955, 14269.50056748014, 14342.928285358585, 14345.0, 14354.28228588569, 14363.066400683974, 756.4553521464537, 764.1670579068814, 764.6711913877031, 765.2959277464746, 907.2787134228271, 923.9353245272833, 927.0914503786294, 927.9118483744033, 928.5078908178676, 928.558934506111, 962.5187406296851, 972.2707969023232, 974.7758015656403, 975.2149519636689, 976.6923419122953, 969.6509256667593, 971.1939090554822, 971.218169373654, 972.2513664478347, 972.6060945317158, 590.1030433740733, 694.1115372323434, 708.677551713974, 709.0250905005618, 718.7232915327636, 13863.0, 13929.791053134211, 13973.650658733512, 14011.509597164153, 14128.293585320693, 14326.0, 14613.123212607277, 14898.180600066991, 14937.17845518496, 15134.924325378302, 11952.64142075739, 12002.339871307162, 12070.155089143764, 12111.757764844742, 12312.384380780924, 4078.5004901329785, 4092.1406504634065, 4118.045997646246, 4180.581941805795, 4232.682548808821, 55699.44300556983, 56498.0, 56629.43370566324, 56632.0, 57267.713661431844, 12315.384230788424, 12332.81500777489, 12422.627321180378, 12468.937655311847, 12554.058445616616, 21927.451813704465, 22016.33950981473, 22057.558848822933, 22087.0, 22097.779022209892, 8777.385583009256, 9045.68340108093, 9045.819083618291, 9076.319276054322, 9399.154076133182, 4884.95115048852, 4956.231784073474, 4979.726115063706, 5063.569596584258, 5112.207607820794, 3807.4479200516325, 3864.1305706215876, 3868.9613103869165, 3869.9226015479535, 3878.5345758508597, 650.9186351706037, 652.8367908022994, 653.6078352988264, 663.171036204744, 676.3034074902858, 757.6363345594145, 784.8273379856422, 786.8780339047457, 788.7357735158786, 799.8000499875031, 9930.751731206634, 10232.64185753495, 10246.692599222035, 10350.120239779553, 10425.165986721044, 735.937445317154, 752.2439947852482, 782.4718315137374, 788.4835432791531, 809.0049239435527, 4602.723836569817, 4617.538246175355, 4650.4186976627925, 4663.813447462064, 4984.252362145708, 67423.66288168528, 67608.0, 67644.6617766908, 68237.0, 72282.0, 59573.404265956786, 59835.0, 60888.0, 61206.38793612096, 61818.69090654518, 53699.19451208235, 53957.730211348695, 54506.18240726392, 54814.72592637011, 56114.43885561174, 10210.489475526343, 10402.43732451856, 10417.789488392495, 10680.57277708914, 10751.354918704903, 39103.21793564056, 39232.411513826744, 39407.60592394039, 40016.3997540043, 40525.39211911765, 46818.0, 51094.48905510897, 51386.48613513817, 52356.73821630867, 52574.0, 12842.229466232056, 12860.485580577046, 12977.610671679864, 13195.076344656165, 13255.270960097287, 13933.0, 14027.08184204252, 14131.15213087218, 14239.15267857595, 14577.489787857374, 14103.0, 14112.905232254208, 14149.504767333094, 14340.139591624536, 14539.854601454274, 14060.222563811594, 14066.226357550433, 14144.363503642566, 14156.079854809404, 14623.415063397344, 13415.731685366043, 13650.112742671694, 13963.58109256724, 14095.0, 14107.0, 11473.827892581785, 11638.12714046433, 11815.350155741517, 11879.505303885935, 12122.212056216318, 11315.886841131813, 11599.616475570401, 11841.526338946345, 12035.0, 12058.457369418222], "value": 7381.327159622321, "unit": "score"}], "name": "dromaeo_css", "value": 7626.485575142175, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 111.0, 109.0, 110.0, 110.0, 106.0, 108.0, 109.0, 109.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 125.0, 159.0, 184.0, 127.0, 152.0, 154.0, 125.0, 196.0, 125.0], "value": 150.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 161.0, 160.0, 161.0, 160.0, 162.0, 161.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 74.0, 173.0, 76.0, 74.0, 75.0, 75.0, 167.0, 75.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 148.0, 92.0, 92.0, 91.0, 150.0, 93.0, 92.0, 144.0], "value": 108.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 53.0, 54.0, 53.0, 52.0, 57.0, 75.0, 52.0, 51.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 56.0, 57.0, 58.0, 57.0, 58.0, 58.0, 58.0, 57.0], "value": 57.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 72.0, 72.0, 75.0, 73.0, 73.0, 75.0, 86.0, 74.0], "value": 74.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 129.0, 111.0, 115.0, 115.0, 114.0, 123.0, 117.0, 168.0, 111.0], "value": 122.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 158.0, 162.0, 169.0, 156.0, 161.0, 159.0, 162.0, 159.0, 159.0], "value": 160.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 74.0, 66.0, 66.0, 65.0, 67.0, 65.0, 65.0, 65.0, 64.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1516.8000000000004, "alertThreshold": 2.0}]} 16:11:17 INFO - Return code: 0 16:11:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:11:17 ERROR - # TBPL SUCCESS # 16:11:17 INFO - Running post-action listener: _resource_record_post_action 16:11:17 INFO - Running post-run listener: _resource_record_post_run 16:11:18 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 506556416; Read time: 16; Write time: 391300 16:11:18 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 160481280; Read time: 0; Write time: 170012 16:11:18 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 250032128; Read time: 16; Write time: 142248 16:11:18 INFO - Running post-run listener: _upload_blobber_files 16:11:18 INFO - Blob upload gear active. 16:11:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:11:18 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 16:11:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:11:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:11:19 INFO - (blobuploader) - INFO - Open directory for files ... 16:11:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:11:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:11:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:19 INFO - (blobuploader) - INFO - Done attempting. 16:11:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:11:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:11:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:20 INFO - (blobuploader) - INFO - Done attempting. 16:11:20 INFO - (blobuploader) - INFO - Iteration through files over. 16:11:20 INFO - Return code: 0 16:11:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:11:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:11:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/37550a37875b4029c68e6c14506a28fcb3463ec9f6e9d30152e06ed3c6e99d0f2ef25fca527b0a59e70cda2d2b060edad29a49576e6b6f7e44d7218c21124208", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/782b67e3b811c3e1a82c7bb2bb1ce6f236788a8bcfafad789548ce94587fa66d94dcf7859f1a2a6ad9e8671b16e9b014762fa2d41e3a9d1cc22c6e7e93d97ca3"} 16:11:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:11:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:11:20 INFO - Contents: 16:11:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/37550a37875b4029c68e6c14506a28fcb3463ec9f6e9d30152e06ed3c6e99d0f2ef25fca527b0a59e70cda2d2b060edad29a49576e6b6f7e44d7218c21124208", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/782b67e3b811c3e1a82c7bb2bb1ce6f236788a8bcfafad789548ce94587fa66d94dcf7859f1a2a6ad9e8671b16e9b014762fa2d41e3a9d1cc22c6e7e93d97ca3"} 16:11:20 INFO - Running post-run listener: copy_logs_to_upload_dir 16:11:20 INFO - Copying logs to upload dir... 16:11:20 INFO - mkdir: /builds/slave/test/build/upload/logs 16:11:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.904815 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-05-30 16:11:20.610024) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 16:11:20.616727) ========= 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=a0d2d2de893abaa8702a9954000001a7-1464644118.922297-1557251915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/37550a37875b4029c68e6c14506a28fcb3463ec9f6e9d30152e06ed3c6e99d0f2ef25fca527b0a59e70cda2d2b060edad29a49576e6b6f7e44d7218c21124208", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/782b67e3b811c3e1a82c7bb2bb1ce6f236788a8bcfafad789548ce94587fa66d94dcf7859f1a2a6ad9e8671b16e9b014762fa2d41e3a9d1cc22c6e7e93d97ca3"} build_url:https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011955 build_url: 'https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/37550a37875b4029c68e6c14506a28fcb3463ec9f6e9d30152e06ed3c6e99d0f2ef25fca527b0a59e70cda2d2b060edad29a49576e6b6f7e44d7218c21124208", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/782b67e3b811c3e1a82c7bb2bb1ce6f236788a8bcfafad789548ce94587fa66d94dcf7859f1a2a6ad9e8671b16e9b014762fa2d41e3a9d1cc22c6e7e93d97ca3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 16:11:20.646992) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:11:20.647592) ========= 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=a0d2d2de893abaa8702a9954000001a7-1464644118.922297-1557251915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004543 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:11:20.727934) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 16:11:20.728598) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 16:11:20.729993) ========= ========= Total master_lag: 0.18 =========