builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-062 starttime: 1461615518.18 results: success (0) buildid: 20160425102203 builduid: 616ed1d5bf4240aba2b902e05f8b1f59 revision: 2045bc8c9e90a7ca0b8c6447ddecd812a71b29e1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 13:18:38.182381) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 13:18:38.182852) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 13:18:38.183211) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 13:18:38.203134) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:18:38.203517) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1461615260.516814-544619035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-25 13:18:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.7M=0s 2016-04-25 13:18:38 (69.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105838 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:18:38.326680) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:18:38.327122) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1461615260.516814-544619035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022683 ========= master_lag: 0.28 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:18:38.626151) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:18:38.626473) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2045bc8c9e90a7ca0b8c6447ddecd812a71b29e1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 2045bc8c9e90a7ca0b8c6447ddecd812a71b29e1 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1461615260.516814-544619035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-25 13:18:38,670 truncating revision to first 12 chars 2016-04-25 13:18:38,671 Setting DEBUG logging. 2016-04-25 13:18:38,671 attempt 1/10 2016-04-25 13:18:38,671 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2045bc8c9e90?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 13:18:38,917 unpacking tar archive at: mozilla-central-2045bc8c9e90/testing/mozharness/ program finished with exit code 0 elapsedTime=0.535723 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:18:39.177927) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 13:18:39.179298) ========= script_repo_revision: 2045bc8c9e90a7ca0b8c6447ddecd812a71b29e1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 13:18:39.179705) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 13:18:39.179979) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 13:18:39.200205) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-04-25 13:18:39.200739) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1461615260.516814-544619035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:18:39 INFO - MultiFileLogger online at 20160425 13:18:39 in /builds/slave/test 13:18:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 13:18:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:18:39 INFO - {'append_to_log': False, 13:18:39 INFO - 'base_work_dir': '/builds/slave/test', 13:18:39 INFO - 'blob_upload_branch': 'Firefox', 13:18:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:18:39 INFO - 'branch': 'Firefox', 13:18:39 INFO - 'buildbot_json_path': 'buildprops.json', 13:18:39 INFO - 'config_files': ('talos/linux_config.py',), 13:18:39 INFO - 'default_actions': ('clobber', 13:18:39 INFO - 'read-buildbot-config', 13:18:39 INFO - 'download-and-extract', 13:18:39 INFO - 'populate-webroot', 13:18:39 INFO - 'create-virtualenv', 13:18:39 INFO - 'install', 13:18:39 INFO - 'run-tests'), 13:18:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:18:39 INFO - 'download_minidump_stackwalk': True, 13:18:39 INFO - 'download_symbols': 'ondemand', 13:18:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:18:39 INFO - 'tooltool.py': '/tools/tooltool.py', 13:18:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:18:39 INFO - '/tools/misc-python/virtualenv.py')}, 13:18:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:18:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:18:39 INFO - 'installer_path': 'installer.exe', 13:18:39 INFO - 'log_level': 'info', 13:18:39 INFO - 'log_name': 'talos', 13:18:39 INFO - 'log_to_console': True, 13:18:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:18:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:18:39 INFO - 'opt_config_files': (), 13:18:39 INFO - 'pip_index': False, 13:18:39 INFO - 'sps_profile': False, 13:18:39 INFO - 'sps_profile_interval': 0, 13:18:39 INFO - 'suite': 'dromaeojs', 13:18:39 INFO - 'system_bits': '32', 13:18:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:18:39 INFO - 'title': 'talos-linux64-ix-062', 13:18:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:18:39 INFO - 'use_talos_json': True, 13:18:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:18:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:18:39 INFO - 'work_dir': 'build'} 13:18:39 INFO - ##### 13:18:39 INFO - ##### Running clobber step. 13:18:39 INFO - ##### 13:18:39 INFO - Running pre-action listener: _resource_record_pre_action 13:18:39 INFO - Running main action method: clobber 13:18:39 INFO - rmtree: /builds/slave/test/build 13:18:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:18:39 INFO - Running post-action listener: _resource_record_post_action 13:18:39 INFO - ##### 13:18:39 INFO - ##### Running read-buildbot-config step. 13:18:39 INFO - ##### 13:18:39 INFO - Running pre-action listener: _resource_record_pre_action 13:18:39 INFO - Running main action method: read_buildbot_config 13:18:39 INFO - Using buildbot properties: 13:18:39 INFO - { 13:18:39 INFO - "project": "", 13:18:39 INFO - "product": "firefox", 13:18:39 INFO - "script_repo_revision": "production", 13:18:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 13:18:39 INFO - "repository": "", 13:18:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 13:18:39 INFO - "buildid": "20160425102203", 13:18:39 INFO - "stage_platform": "linux64-pgo", 13:18:39 INFO - "basedir": "/builds/slave/test", 13:18:39 INFO - "nightly_build": "True", 13:18:39 INFO - "buildnumber": 418, 13:18:39 INFO - "slavename": "talos-linux64-ix-062", 13:18:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:18:39 INFO - "platform": "ubuntu64_hw", 13:18:39 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 13:18:39 INFO - "branch": "mozilla-central", 13:18:39 INFO - "repo_path": "mozilla-central", 13:18:39 INFO - "revision": "2045bc8c9e90a7ca0b8c6447ddecd812a71b29e1", 13:18:39 INFO - "pgo_build": "True", 13:18:39 INFO - "builduid": "616ed1d5bf4240aba2b902e05f8b1f59", 13:18:39 INFO - "slavebuilddir": "test" 13:18:39 INFO - } 13:18:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/Si1evWxDRNefYw2S3rTRHA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 13:18:39 INFO - Running post-action listener: _resource_record_post_action 13:18:39 INFO - ##### 13:18:39 INFO - ##### Running download-and-extract step. 13:18:39 INFO - ##### 13:18:39 INFO - Running pre-action listener: _resource_record_pre_action 13:18:39 INFO - Running main action method: download_and_extract 13:18:39 INFO - mkdir: /builds/slave/test/build/tests 13:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:18:39 INFO - https://queue.taskcluster.net/v1/task/Si1evWxDRNefYw2S3rTRHA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:18:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Si1evWxDRNefYw2S3rTRHA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:18:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Si1evWxDRNefYw2S3rTRHA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:18:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Si1evWxDRNefYw2S3rTRHA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:18:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Si1evWxDRNefYw2S3rTRHA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:18:43 INFO - Downloaded 1361 bytes. 13:18:44 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:18:44 INFO - Using the following test package requirements: 13:18:44 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:18:44 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:18:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:18:44 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:18:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:18:44 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:18:44 INFO - u'jsshell-linux-x86_64.zip'], 13:18:44 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:18:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:18:44 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:18:44 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:18:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:18:44 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:18:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:18:44 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:18:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:18:44 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:18:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:18:44 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:18: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')]} 13:18:44 INFO - https://queue.taskcluster.net/v1/task/Si1evWxDRNefYw2S3rTRHA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:18:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Si1evWxDRNefYw2S3rTRHA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:18:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Si1evWxDRNefYw2S3rTRHA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:18:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Si1evWxDRNefYw2S3rTRHA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:18:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Si1evWxDRNefYw2S3rTRHA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:18:46 INFO - Downloaded 23860391 bytes. 13:18:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:18:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:18:47 INFO - Return code: 0 13:18:47 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:18:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:18:47 INFO - https://queue.taskcluster.net/v1/task/Si1evWxDRNefYw2S3rTRHA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:18:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Si1evWxDRNefYw2S3rTRHA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:18:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Si1evWxDRNefYw2S3rTRHA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:18:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Si1evWxDRNefYw2S3rTRHA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:18:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Si1evWxDRNefYw2S3rTRHA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:19:01 INFO - Downloaded 23860391 bytes. 13:19:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:19:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:19:02 INFO - Return code: 0 13:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:02 INFO - https://queue.taskcluster.net/v1/task/Si1evWxDRNefYw2S3rTRHA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:19:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Si1evWxDRNefYw2S3rTRHA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:19:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Si1evWxDRNefYw2S3rTRHA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:19:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Si1evWxDRNefYw2S3rTRHA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:19:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Si1evWxDRNefYw2S3rTRHA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:19:04 INFO - Downloaded 10840145 bytes. 13:19:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:19:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:19:04 INFO - Return code: 0 13:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:04 INFO - https://queue.taskcluster.net/v1/task/Si1evWxDRNefYw2S3rTRHA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:19:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Si1evWxDRNefYw2S3rTRHA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:19:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Si1evWxDRNefYw2S3rTRHA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:19:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Si1evWxDRNefYw2S3rTRHA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:19:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Si1evWxDRNefYw2S3rTRHA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:19:06 INFO - Downloaded 58351312 bytes. 13:19:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Si1evWxDRNefYw2S3rTRHA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:19:06 INFO - mkdir: /builds/slave/test/properties 13:19:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:19:06 INFO - Writing to file /builds/slave/test/properties/build_url 13:19:06 INFO - Contents: 13:19:06 INFO - build_url:https://queue.taskcluster.net/v1/task/Si1evWxDRNefYw2S3rTRHA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:19:07 INFO - Running post-action listener: _resource_record_post_action 13:19:07 INFO - Running post-action listener: set_extra_try_arguments 13:19:07 INFO - ##### 13:19:07 INFO - ##### Running populate-webroot step. 13:19:07 INFO - ##### 13:19:07 INFO - Running pre-action listener: _resource_record_pre_action 13:19:07 INFO - Running main action method: populate_webroot 13:19:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:19:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:19:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:19:07 INFO - '--tppagecycles', 13:19:07 INFO - '7'], 13:19:07 INFO - 'tests': ['tsvgm']}}, 13:19:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:19:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:19:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:19:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:19:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:19:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:19:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:07 INFO - 'talos_options': ['--disable-e10s'], 13:19:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:19:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:19:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:07 INFO - 'talos_options': ['--disable-e10s'], 13:19:07 INFO - 'tests': ['damp', 'tps']}, 13:19:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:07 INFO - 'tests': ['damp', 'tps']}, 13:19:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:19:07 INFO - 'tests': ['dromaeo_dom']}, 13:19:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:19:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:19:07 INFO - 'tests': ['a11yr', 13:19:07 INFO - 'ts_paint', 13:19:07 INFO - 'tpaint', 13:19:07 INFO - 'sessionrestore', 13:19:07 INFO - 'sessionrestore_no_auto_restore', 13:19:07 INFO - 'tabpaint']}, 13:19:07 INFO - 'other-e10s': {'tests': ['a11yr', 13:19:07 INFO - 'ts_paint', 13:19:07 INFO - 'tpaint', 13:19:07 INFO - 'sessionrestore', 13:19:07 INFO - 'sessionrestore_no_auto_restore', 13:19:07 INFO - 'tabpaint']}, 13:19:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:19:07 INFO - 'ts_paint', 13:19:07 INFO - 'tpaint', 13:19:07 INFO - 'sessionrestore', 13:19:07 INFO - 'sessionrestore_no_auto_restore', 13:19:07 INFO - 'tabpaint']}, 13:19:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:19:07 INFO - 'ts_paint', 13:19:07 INFO - 'tpaint', 13:19:07 INFO - 'sessionrestore', 13:19:07 INFO - 'sessionrestore_no_auto_restore', 13:19:07 INFO - 'tabpaint']}, 13:19:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:19:07 INFO - 'tests': ['a11yr', 13:19:07 INFO - 'ts_paint', 13:19:07 INFO - 'tpaint', 13:19:07 INFO - 'sessionrestore', 13:19:07 INFO - 'sessionrestore_no_auto_restore', 13:19:07 INFO - 'tabpaint']}, 13:19:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:19:07 INFO - 'tests': ['a11yr', 13:19:07 INFO - 'ts_paint', 13:19:07 INFO - 'tpaint', 13:19:07 INFO - 'sessionrestore', 13:19:07 INFO - 'sessionrestore_no_auto_restore', 13:19:07 INFO - 'tabpaint']}, 13:19:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:19:07 INFO - 'tests': ['tsvgx', 13:19:07 INFO - 'tsvgr_opacity', 13:19:07 INFO - 'tart', 13:19:07 INFO - 'tscrollx', 13:19:07 INFO - 'cart']}, 13:19:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:19:07 INFO - 'tsvgr_opacity', 13:19:07 INFO - 'tart', 13:19:07 INFO - 'tscrollx', 13:19:07 INFO - 'cart']}, 13:19:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:07 INFO - 'talos_options': ['--disable-e10s'], 13:19:07 INFO - 'tests': ['tp5o']}, 13:19:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:07 INFO - 'tests': ['tp5o']}, 13:19:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:07 INFO - 'talos_options': ['--disable-e10s', 13:19:07 INFO - '--xperf_path', 13:19:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:19:07 INFO - 'tests': ['tp5n']}, 13:19:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:07 INFO - 'talos_options': ['--xperf_path', 13:19:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:19:07 INFO - 'tests': ['tp5n']}}, 13:19:07 INFO - 'talos.zip': {'path': '', 13:19:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:19:07 INFO - Running post-action listener: _resource_record_post_action 13:19:07 INFO - ##### 13:19:07 INFO - ##### Running create-virtualenv step. 13:19:07 INFO - ##### 13:19:07 INFO - Running pre-action listener: _resource_record_pre_action 13:19:07 INFO - Running main action method: create_virtualenv 13:19:07 INFO - Creating virtualenv /builds/slave/test/build/venv 13:19:07 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:19:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:19:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:19:07 INFO - Using real prefix '/usr' 13:19:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:19:07 INFO - Installing distribute.............................................................................................................................................................................................done. 13:19:09 INFO - Installing pip.................done. 13:19:09 INFO - Return code: 0 13:19:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:09 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 0x7fb81efbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f09a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167f810>, '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 0x1680710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1680ba0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461615260.516814-544619035', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:19:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:19:09 INFO - Using env: {'DISPLAY': ':0', 13:19:09 INFO - 'HOME': '/home/cltbld', 13:19:09 INFO - 'LANG': 'en_US.UTF-8', 13:19:09 INFO - 'LANGUAGE': 'en_US:en', 13:19:09 INFO - 'LOGNAME': 'cltbld', 13:19:09 INFO - 'MAIL': '/var/mail/cltbld', 13:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:09 INFO - 'MOZ_NO_REMOTE': '1', 13:19:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:09 INFO - 'NO_EM_RESTART': '1', 13:19:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:09 INFO - 'PWD': '/builds/slave/test', 13:19:09 INFO - 'SHELL': '/bin/bash', 13:19:09 INFO - 'SHLVL': '1', 13:19:09 INFO - 'TERM': 'linux', 13:19:09 INFO - 'TMOUT': '86400', 13:19:09 INFO - 'USER': 'cltbld', 13:19:09 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461615260.516814-544619035', 13:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:09 INFO - '_': '/tools/buildbot/bin/python'} 13:19:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:19:09 INFO - Cleaning up... 13:19:09 INFO - Return code: 0 13:19:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:09 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 0x7fb81efbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f09a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167f810>, '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 0x1680710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1680ba0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461615260.516814-544619035', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:19:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 13:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 13:19:09 INFO - Using env: {'DISPLAY': ':0', 13:19:09 INFO - 'HOME': '/home/cltbld', 13:19:09 INFO - 'LANG': 'en_US.UTF-8', 13:19:09 INFO - 'LANGUAGE': 'en_US:en', 13:19:09 INFO - 'LOGNAME': 'cltbld', 13:19:09 INFO - 'MAIL': '/var/mail/cltbld', 13:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:09 INFO - 'MOZ_NO_REMOTE': '1', 13:19:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:09 INFO - 'NO_EM_RESTART': '1', 13:19:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:09 INFO - 'PWD': '/builds/slave/test', 13:19:09 INFO - 'SHELL': '/bin/bash', 13:19:09 INFO - 'SHLVL': '1', 13:19:09 INFO - 'TERM': 'linux', 13:19:09 INFO - 'TMOUT': '86400', 13:19:09 INFO - 'USER': 'cltbld', 13:19:09 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461615260.516814-544619035', 13:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:09 INFO - '_': '/tools/buildbot/bin/python'} 13:19:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:10 INFO - Downloading/unpacking psutil>=0.7.1 13:19: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 13:19: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 13:19: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 13:19: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 13:19: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 13:19: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 13:19:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:19:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:19:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:19:12 INFO - Installing collected packages: psutil 13:19:12 INFO - Running setup.py install for psutil 13:19:12 INFO - building 'psutil._psutil_linux' extension 13:19:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 13:19:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 13:19:12 INFO - building 'psutil._psutil_posix' extension 13:19:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 13:19:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 13:19:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:19:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:19:12 INFO - Successfully installed psutil 13:19:12 INFO - Cleaning up... 13:19:12 INFO - Return code: 0 13:19:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:19: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')]} 13:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19: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')]} 13:19:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19: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', '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 0x7fb81efbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f09a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167f810>, '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 0x1680710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1680ba0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461615260.516814-544619035', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:19: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 13:19: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 mozsystemmonitor==0.0.0 13:19:12 INFO - Using env: {'DISPLAY': ':0', 13:19:12 INFO - 'HOME': '/home/cltbld', 13:19:12 INFO - 'LANG': 'en_US.UTF-8', 13:19:12 INFO - 'LANGUAGE': 'en_US:en', 13:19:12 INFO - 'LOGNAME': 'cltbld', 13:19:12 INFO - 'MAIL': '/var/mail/cltbld', 13:19:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:12 INFO - 'MOZ_NO_REMOTE': '1', 13:19:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:12 INFO - 'NO_EM_RESTART': '1', 13:19:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:12 INFO - 'PWD': '/builds/slave/test', 13:19:12 INFO - 'SHELL': '/bin/bash', 13:19:12 INFO - 'SHLVL': '1', 13:19:12 INFO - 'TERM': 'linux', 13:19:12 INFO - 'TMOUT': '86400', 13:19:12 INFO - 'USER': 'cltbld', 13:19:12 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461615260.516814-544619035', 13:19:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:12 INFO - '_': '/tools/buildbot/bin/python'} 13:19:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:19: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 13:19: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 13:19: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 13:19: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 13:19: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 13:19: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 13:19:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:19:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:19:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:19:14 INFO - Installing collected packages: mozsystemmonitor 13:19:14 INFO - Running setup.py install for mozsystemmonitor 13:19:14 INFO - Successfully installed mozsystemmonitor 13:19:14 INFO - Cleaning up... 13:19:14 INFO - Return code: 0 13:19:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:19:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:14 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 0x7fb81efbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f09a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167f810>, '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 0x1680710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1680ba0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461615260.516814-544619035', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:19:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:19:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:19:14 INFO - Using env: {'DISPLAY': ':0', 13:19:14 INFO - 'HOME': '/home/cltbld', 13:19:14 INFO - 'LANG': 'en_US.UTF-8', 13:19:14 INFO - 'LANGUAGE': 'en_US:en', 13:19:14 INFO - 'LOGNAME': 'cltbld', 13:19:14 INFO - 'MAIL': '/var/mail/cltbld', 13:19:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:14 INFO - 'MOZ_NO_REMOTE': '1', 13:19:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:14 INFO - 'NO_EM_RESTART': '1', 13:19:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:14 INFO - 'PWD': '/builds/slave/test', 13:19:14 INFO - 'SHELL': '/bin/bash', 13:19:14 INFO - 'SHLVL': '1', 13:19:14 INFO - 'TERM': 'linux', 13:19:14 INFO - 'TMOUT': '86400', 13:19:14 INFO - 'USER': 'cltbld', 13:19:14 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461615260.516814-544619035', 13:19:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:14 INFO - '_': '/tools/buildbot/bin/python'} 13:19:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:15 INFO - Downloading/unpacking blobuploader==1.2.4 13:19: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 13:19: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 13:19: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 13:19: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 13:19: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 13:19: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 13:19:17 INFO - Downloading blobuploader-1.2.4.tar.gz 13:19:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:19:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:19:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:17 INFO - Downloading docopt-0.6.1.tar.gz 13:19:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:19:17 INFO - Installing collected packages: blobuploader, requests, docopt 13:19:17 INFO - Running setup.py install for blobuploader 13:19:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:19:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:19:17 INFO - Running setup.py install for requests 13:19:18 INFO - Running setup.py install for docopt 13:19:18 INFO - Successfully installed blobuploader requests docopt 13:19:18 INFO - Cleaning up... 13:19:18 INFO - Return code: 0 13:19:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:18 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 0x7fb81efbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f09a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167f810>, '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 0x1680710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1680ba0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461615260.516814-544619035', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:19:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:19:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:19:18 INFO - Using env: {'DISPLAY': ':0', 13:19:18 INFO - 'HOME': '/home/cltbld', 13:19:18 INFO - 'LANG': 'en_US.UTF-8', 13:19:18 INFO - 'LANGUAGE': 'en_US:en', 13:19:18 INFO - 'LOGNAME': 'cltbld', 13:19:18 INFO - 'MAIL': '/var/mail/cltbld', 13:19:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:18 INFO - 'MOZ_NO_REMOTE': '1', 13:19:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:18 INFO - 'NO_EM_RESTART': '1', 13:19:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:18 INFO - 'PWD': '/builds/slave/test', 13:19:18 INFO - 'SHELL': '/bin/bash', 13:19:18 INFO - 'SHLVL': '1', 13:19:18 INFO - 'TERM': 'linux', 13:19:18 INFO - 'TMOUT': '86400', 13:19:18 INFO - 'USER': 'cltbld', 13:19:18 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461615260.516814-544619035', 13:19:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:18 INFO - '_': '/tools/buildbot/bin/python'} 13:19:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:19:18 INFO - Running setup.py (path:/tmp/pip-pzgyQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:19:18 INFO - Running setup.py (path:/tmp/pip-KxRhxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:19:18 INFO - Running setup.py (path:/tmp/pip-MssuXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:19:18 INFO - Running setup.py (path:/tmp/pip-wxAoaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:19:18 INFO - Running setup.py (path:/tmp/pip-VZ5J2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:19:19 INFO - Running setup.py (path:/tmp/pip-r0flpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:19:19 INFO - Running setup.py (path:/tmp/pip-YKOXmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:19:19 INFO - Running setup.py (path:/tmp/pip-FzFIHt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:19:19 INFO - Running setup.py (path:/tmp/pip-e242KY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:19:19 INFO - Running setup.py (path:/tmp/pip-irsXQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:19:19 INFO - Running setup.py (path:/tmp/pip-wHTzyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:19:19 INFO - Running setup.py (path:/tmp/pip-QclhOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:19:19 INFO - Running setup.py (path:/tmp/pip-MG8VWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:19:19 INFO - Running setup.py (path:/tmp/pip-746D9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:19:19 INFO - Running setup.py (path:/tmp/pip-avi9ig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:19:19 INFO - Running setup.py (path:/tmp/pip-hv4BuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:19:19 INFO - Running setup.py (path:/tmp/pip-v7rLFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:19:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:19:19 INFO - Running setup.py install for manifestparser 13:19:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:19:20 INFO - Running setup.py install for mozcrash 13:19:20 INFO - Running setup.py install for mozdebug 13:19:20 INFO - Running setup.py install for mozdevice 13:19:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:19:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:19:20 INFO - Running setup.py install for mozfile 13:19:20 INFO - Running setup.py install for mozhttpd 13:19:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:19:20 INFO - Running setup.py install for mozinfo 13:19:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:19:20 INFO - Running setup.py install for mozInstall 13:19:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:19:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:19:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:19:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:19:20 INFO - Running setup.py install for mozleak 13:19:20 INFO - Running setup.py install for mozlog 13:19:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:19:20 INFO - Running setup.py install for moznetwork 13:19:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:19:21 INFO - Running setup.py install for mozprocess 13:19:21 INFO - Running setup.py install for mozprofile 13:19:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:19:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:19:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:19:21 INFO - Running setup.py install for mozrunner 13:19:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:19:21 INFO - Running setup.py install for mozscreenshot 13:19:21 INFO - Running setup.py install for moztest 13:19:21 INFO - Running setup.py install for mozversion 13:19:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:19:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:19:21 INFO - Cleaning up... 13:19:21 INFO - Return code: 0 13:19:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:21 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 0x7fb81efbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f09a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167f810>, '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 0x1680710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1680ba0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461615260.516814-544619035', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:19:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:19:21 INFO - Using env: {'DISPLAY': ':0', 13:19:21 INFO - 'HOME': '/home/cltbld', 13:19:21 INFO - 'LANG': 'en_US.UTF-8', 13:19:21 INFO - 'LANGUAGE': 'en_US:en', 13:19:21 INFO - 'LOGNAME': 'cltbld', 13:19:21 INFO - 'MAIL': '/var/mail/cltbld', 13:19:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:21 INFO - 'MOZ_NO_REMOTE': '1', 13:19:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:21 INFO - 'NO_EM_RESTART': '1', 13:19:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:21 INFO - 'PWD': '/builds/slave/test', 13:19:21 INFO - 'SHELL': '/bin/bash', 13:19:21 INFO - 'SHLVL': '1', 13:19:21 INFO - 'TERM': 'linux', 13:19:21 INFO - 'TMOUT': '86400', 13:19:21 INFO - 'USER': 'cltbld', 13:19:21 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461615260.516814-544619035', 13:19:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:21 INFO - '_': '/tools/buildbot/bin/python'} 13:19:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:19:21 INFO - Running setup.py (path:/tmp/pip-YiHR0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:19:21 INFO - Running setup.py (path:/tmp/pip-qqkUSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:19:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:19:22 INFO - Running setup.py (path:/tmp/pip-_S4ZFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:19:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:19:22 INFO - Running setup.py (path:/tmp/pip-gVtHSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:19:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:19:22 INFO - Running setup.py (path:/tmp/pip-63YGk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:19:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:19:22 INFO - Running setup.py (path:/tmp/pip-Xqekcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:19:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:19:22 INFO - Running setup.py (path:/tmp/pip-xXFEYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:19:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:19:22 INFO - Running setup.py (path:/tmp/pip-Xzx7Um-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:19:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:19:22 INFO - Running setup.py (path:/tmp/pip-ygKkey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:19:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:19:22 INFO - Running setup.py (path:/tmp/pip-UUqPwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:19:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:19:22 INFO - Running setup.py (path:/tmp/pip-q6x4fF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:19:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:19:22 INFO - Running setup.py (path:/tmp/pip-G50K7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:19:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:19:22 INFO - Running setup.py (path:/tmp/pip-2BUUnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:19:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:19:22 INFO - Running setup.py (path:/tmp/pip-TD_9Fs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:19:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:19:22 INFO - Running setup.py (path:/tmp/pip-SVaqLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:19:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:19:23 INFO - Running setup.py (path:/tmp/pip-6IvjDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:19:23 INFO - Running setup.py (path:/tmp/pip-1m1Hvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:19:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:19: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 13:19: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 13:19: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 13:19: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 13:19: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 13:19: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 13:19:24 INFO - Downloading blessings-1.6.tar.gz 13:19:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:19:25 INFO - Installing collected packages: blessings 13:19:25 INFO - Running setup.py install for blessings 13:19:25 INFO - Successfully installed blessings 13:19:25 INFO - Cleaning up... 13:19:25 INFO - Return code: 0 13:19:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:19:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:19:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:19:25 INFO - Reading from file tmpfile_stdout 13:19:25 INFO - Current package versions: 13:19:25 INFO - argparse == 1.2.1 13:19:25 INFO - blessings == 1.6 13:19:25 INFO - blobuploader == 1.2.4 13:19:25 INFO - docopt == 0.6.1 13:19:25 INFO - manifestparser == 1.1 13:19:25 INFO - mozInstall == 1.12 13:19:25 INFO - mozcrash == 0.17 13:19:25 INFO - mozdebug == 0.1 13:19:25 INFO - mozdevice == 0.48 13:19:25 INFO - mozfile == 1.2 13:19:25 INFO - mozhttpd == 0.7 13:19:25 INFO - mozinfo == 0.9 13:19:25 INFO - mozleak == 0.1 13:19:25 INFO - mozlog == 3.1 13:19:25 INFO - moznetwork == 0.27 13:19:25 INFO - mozprocess == 0.22 13:19:25 INFO - mozprofile == 0.28 13:19:25 INFO - mozrunner == 6.11 13:19:25 INFO - mozscreenshot == 0.1 13:19:25 INFO - mozsystemmonitor == 0.0 13:19:25 INFO - moztest == 0.7 13:19:25 INFO - mozversion == 1.4 13:19:25 INFO - psutil == 3.1.1 13:19:25 INFO - requests == 1.2.3 13:19:25 INFO - wsgiref == 0.1.2 13:19:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:19: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')]} 13:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19: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')]} 13:19:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:25 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 0x7fb81efbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f09a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167f810>, '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 0x1680710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1680ba0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461615260.516814-544619035', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:19:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:19:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:19:25 INFO - Using env: {'DISPLAY': ':0', 13:19:25 INFO - 'HOME': '/home/cltbld', 13:19:25 INFO - 'LANG': 'en_US.UTF-8', 13:19:25 INFO - 'LANGUAGE': 'en_US:en', 13:19:25 INFO - 'LOGNAME': 'cltbld', 13:19:25 INFO - 'MAIL': '/var/mail/cltbld', 13:19:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:25 INFO - 'MOZ_NO_REMOTE': '1', 13:19:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:25 INFO - 'NO_EM_RESTART': '1', 13:19:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:25 INFO - 'PWD': '/builds/slave/test', 13:19:25 INFO - 'SHELL': '/bin/bash', 13:19:25 INFO - 'SHLVL': '1', 13:19:25 INFO - 'TERM': 'linux', 13:19:25 INFO - 'TMOUT': '86400', 13:19:25 INFO - 'USER': 'cltbld', 13:19:25 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461615260.516814-544619035', 13:19:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:25 INFO - '_': '/tools/buildbot/bin/python'} 13:19:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:19:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:19:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:19:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:19:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:19:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:19:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:19:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:19:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:19:25 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:19:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:19:25 INFO - Cleaning up... 13:19:25 INFO - Return code: 0 13:19:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:19: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')]} 13:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19: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')]} 13:19:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb81efbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f09a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167f810>, '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 0x1680710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1680ba0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461615260.516814-544619035', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:19: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', 'jsonschema'] in /builds/slave/test/build 13:19: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 jsonschema 13:19:25 INFO - Using env: {'DISPLAY': ':0', 13:19:25 INFO - 'HOME': '/home/cltbld', 13:19:25 INFO - 'LANG': 'en_US.UTF-8', 13:19:25 INFO - 'LANGUAGE': 'en_US:en', 13:19:25 INFO - 'LOGNAME': 'cltbld', 13:19:25 INFO - 'MAIL': '/var/mail/cltbld', 13:19:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:25 INFO - 'MOZ_NO_REMOTE': '1', 13:19:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:25 INFO - 'NO_EM_RESTART': '1', 13:19:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:25 INFO - 'PWD': '/builds/slave/test', 13:19:25 INFO - 'SHELL': '/bin/bash', 13:19:25 INFO - 'SHLVL': '1', 13:19:25 INFO - 'TERM': 'linux', 13:19:25 INFO - 'TMOUT': '86400', 13:19:25 INFO - 'USER': 'cltbld', 13:19:25 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461615260.516814-544619035', 13:19:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:25 INFO - '_': '/tools/buildbot/bin/python'} 13:19:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:25 INFO - Downloading/unpacking jsonschema 13:19: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 13:19: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 13:19: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 13:19: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 13:19: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 13:19: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 13:19:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:19:28 INFO - Downloading/unpacking functools32 (from jsonschema) 13:19: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 13:19: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 13:19: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 13:19: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 13:19: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 13:19: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 13:19:28 INFO - Downloading functools32-3.2.3-2.tar.gz 13:19:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:19:29 INFO - warning: no files found matching '*.txt' 13:19:29 INFO - no previously-included directories found matching 'build' 13:19:29 INFO - no previously-included directories found matching 'dist' 13:19:29 INFO - no previously-included directories found matching '.git*' 13:19:29 INFO - Installing collected packages: jsonschema, functools32 13:19:29 INFO - Running setup.py install for functools32 13:19:29 INFO - warning: no files found matching '*.txt' 13:19:29 INFO - no previously-included directories found matching 'build' 13:19:29 INFO - no previously-included directories found matching 'dist' 13:19:29 INFO - no previously-included directories found matching '.git*' 13:19:29 INFO - Successfully installed jsonschema functools32 13:19:29 INFO - Cleaning up... 13:19:29 INFO - Return code: 0 13:19:29 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:19:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:29 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 0x7fb81efbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f09a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167f810>, '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 0x1680710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1680ba0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461615260.516814-544619035', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:19:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 13:19:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:19:29 INFO - Using env: {'DISPLAY': ':0', 13:19:29 INFO - 'HOME': '/home/cltbld', 13:19:29 INFO - 'LANG': 'en_US.UTF-8', 13:19:29 INFO - 'LANGUAGE': 'en_US:en', 13:19:29 INFO - 'LOGNAME': 'cltbld', 13:19:29 INFO - 'MAIL': '/var/mail/cltbld', 13:19:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:29 INFO - 'MOZ_NO_REMOTE': '1', 13:19:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:29 INFO - 'NO_EM_RESTART': '1', 13:19:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:29 INFO - 'PWD': '/builds/slave/test', 13:19:29 INFO - 'SHELL': '/bin/bash', 13:19:29 INFO - 'SHLVL': '1', 13:19:29 INFO - 'TERM': 'linux', 13:19:29 INFO - 'TMOUT': '86400', 13:19:29 INFO - 'USER': 'cltbld', 13:19:29 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461615260.516814-544619035', 13:19:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:29 INFO - '_': '/tools/buildbot/bin/python'} 13:19:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:29 INFO - Downloading/unpacking flake8 13:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:19:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:19:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:19:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:19:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:19:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:19:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:19:32 INFO - no previously-included directories found matching 'docs/_build' 13:19:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:19:32 INFO - Running setup.py install for pep8 13:19:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:19:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:19:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:19:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:19:32 INFO - no previously-included directories found matching 'docs/_build' 13:19:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:19:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:19:32 INFO - Cleaning up... 13:19:32 INFO - Return code: 0 13:19:32 INFO - Running post-action listener: _resource_record_post_action 13:19:32 INFO - Running post-action listener: _start_resource_monitoring 13:19:32 INFO - Starting resource monitoring. 13:19:32 INFO - ##### 13:19:32 INFO - ##### Running install step. 13:19:32 INFO - ##### 13:19:32 INFO - Running pre-action listener: _resource_record_pre_action 13:19:32 INFO - Running main action method: install 13:19:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:19:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:19:32 INFO - Reading from file tmpfile_stdout 13:19:32 INFO - Detecting whether we're running mozinstall >=1.0... 13:19:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:19:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:19:32 INFO - Reading from file tmpfile_stdout 13:19:32 INFO - Output received: 13:19:32 INFO - Usage: mozinstall [options] installer 13:19:32 INFO - Options: 13:19:32 INFO - -h, --help show this help message and exit 13:19:32 INFO - -d DEST, --destination=DEST 13:19:32 INFO - Directory to install application into. [default: 13:19:32 INFO - "/builds/slave/test"] 13:19:32 INFO - --app=APP Application being installed. [default: firefox] 13:19:32 INFO - mkdir: /builds/slave/test/build/application 13:19:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:19:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:19:49 INFO - Reading from file tmpfile_stdout 13:19:49 INFO - Output received: 13:19:49 INFO - /builds/slave/test/build/application/firefox/firefox 13:19:49 INFO - Running post-action listener: _resource_record_post_action 13:19:49 INFO - ##### 13:19:49 INFO - ##### Running run-tests step. 13:19:49 INFO - ##### 13:19:49 INFO - Running pre-action listener: _resource_record_pre_action 13:19:49 INFO - Running main action method: run_tests 13:19:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:19:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:19:49 INFO - Python 2.7.3 13:19:49 INFO - Return code: 0 13:19:49 INFO - grabbing minidump binary from tooltool 13:19:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:49 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 0x167f810>, '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 0x1680710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1680ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:19:49 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:19:49 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:19:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:19:49 INFO - Return code: 0 13:19:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:19:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:19:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:19:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:19:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:19:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:19:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:19:50 INFO - Return code: 0 13:19:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Si1evWxDRNefYw2S3rTRHA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 13:19:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Si1evWxDRNefYw2S3rTRHA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 13:19:50 INFO - Using env: {'DISPLAY': ':0', 13:19:50 INFO - 'HOME': '/home/cltbld', 13:19:50 INFO - 'LANG': 'en_US.UTF-8', 13:19:50 INFO - 'LANGUAGE': 'en_US:en', 13:19:50 INFO - 'LOGNAME': 'cltbld', 13:19:50 INFO - 'MAIL': '/var/mail/cltbld', 13:19:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:19:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:19:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:50 INFO - 'MOZ_NO_REMOTE': '1', 13:19:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:19:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:50 INFO - 'NO_EM_RESTART': '1', 13:19:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:50 INFO - 'PWD': '/builds/slave/test', 13:19:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:19:50 INFO - 'SHELL': '/bin/bash', 13:19:50 INFO - 'SHLVL': '1', 13:19:50 INFO - 'TERM': 'linux', 13:19:50 INFO - 'TMOUT': '86400', 13:19:50 INFO - 'USER': 'cltbld', 13:19:50 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461615260.516814-544619035', 13:19:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:50 INFO - '_': '/tools/buildbot/bin/python'} 13:19:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Si1evWxDRNefYw2S3rTRHA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 13:19:50 INFO - mozversion application_buildid: 20160425102203 13:19:50 INFO - mozversion application_changeset: 2045bc8c9e90a7ca0b8c6447ddecd812a71b29e1 13:19:50 INFO - mozversion application_display_name: Nightly 13:19:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:19:50 INFO - mozversion application_name: Firefox 13:19:50 INFO - mozversion application_remotingname: firefox 13:19:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:19:50 INFO - mozversion application_vendor: Mozilla 13:19:50 INFO - mozversion application_version: 49.0a1 13:19:50 INFO - mozversion platform_buildid: 20160425102203 13:19:50 INFO - mozversion platform_changeset: 2045bc8c9e90a7ca0b8c6447ddecd812a71b29e1 13:19:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:19:50 INFO - mozversion platform_version: 49.0a1 13:19:50 INFO - using testdate: 1461615590 13:19:50 INFO - actual date: 1461615590 13:19:50 INFO - starting webserver on 'localhost:54316' 13:19:50 INFO - SUITE-START | Running 2 tests 13:19:50 INFO - TEST-START | dromaeo_css 13:19:50 INFO - operating with platform_type : linux_ 13:19:50 INFO - Initialising browser for dromaeo_css test... 13:19:50 INFO - TEST-INFO | started process 25909 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1TUUk9/profile http://localhost:54316/getInfo.html) 13:19:53 INFO - PROCESS | 25909 | __metrics Screen width/height:1600/1200 13:19:53 INFO - PROCESS | 25909 | colorDepth:24 13:19:53 INFO - PROCESS | 25909 | Browser inner width/height: 1024/697 13:19:53 INFO - PROCESS | 25909 | __metrics 13:19:54 ERROR - PROCESS | 25909 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:19:55 INFO - TEST-INFO | 25909: exit 0 13:19:55 INFO - Browser initialized. 13:19:55 INFO - Running cycle 1/1 for dromaeo_css test... 13:19:55 INFO - TEST-INFO | started process 25988 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1TUUk9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:20:07 INFO - PROCESS | 25988 | RSS: Main: 154947584 13:20:07 INFO - PROCESS | 25988 | 13:20:58 INFO - PROCESS | 25988 | 1461615658433 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 13:23:06 INFO - PROCESS | 25988 | Cycle 1(1): loaded http://localhost:54316/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54316/tests/dromaeo/cssquery-ext.html) 13:23:07 INFO - PROCESS | 25988 | RSS: Main: 241664000 13:23:07 INFO - PROCESS | 25988 | 13:26:09 INFO - PROCESS | 25988 | Cycle 1(1): loaded http://localhost:54316/tests/dromaeo/cssquery-ext.html (next: http://localhost:54316/tests/dromaeo/cssquery-jquery.html) 13:26:09 INFO - PROCESS | 25988 | RSS: Main: 243847168 13:26:09 INFO - PROCESS | 25988 | 13:29:11 INFO - PROCESS | 25988 | Cycle 1(1): loaded http://localhost:54316/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54316/tests/dromaeo/cssquery-mootools.html) 13:29:12 INFO - PROCESS | 25988 | RSS: Main: 242225152 13:29:12 INFO - PROCESS | 25988 | 13:32:14 INFO - PROCESS | 25988 | Cycle 1(1): loaded http://localhost:54316/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54316/tests/dromaeo/cssquery-prototype.html) 13:32:15 INFO - PROCESS | 25988 | RSS: Main: 237469696 13:32:15 INFO - PROCESS | 25988 | 13:35:17 INFO - PROCESS | 25988 | Cycle 1(1): loaded http://localhost:54316/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54316/tests/dromaeo/cssquery-yui.html) 13:35:18 INFO - PROCESS | 25988 | RSS: Main: 226267136 13:35:18 INFO - PROCESS | 25988 | 13:38:20 INFO - PROCESS | 25988 | Cycle 1(1): loaded http://localhost:54316/tests/dromaeo/cssquery-yui.html (next: http://localhost:54316/tests/dromaeo/cssquery-dojo.html) 13:38:20 INFO - PROCESS | 25988 | RSS: Main: 269717504 13:38:20 INFO - PROCESS | 25988 | 13:38:20 INFO - PROCESS | 25988 | __start_tp_report 13:38:20 INFO - PROCESS | 25988 | _x_x_mozilla_page_load 13:38:20 INFO - PROCESS | 25988 | _x_x_mozilla_page_load_details 13:38:20 INFO - PROCESS | 25988 | |i|pagename|runs| 13:38:20 INFO - PROCESS | 25988 | |0;dojo.html;3039.073082709773;3130.686931306871;3160.589123413957;3164.4462219111665;3204.775665703401;5194.688318700871;5280.973595132029;5308.8407347779585;5377.516023557879;5410.458954104588;5249.790008399659;5314.282571852798;5321.733913304339;5324.041672498949;5327.573794096473;4758.738269395182;4797.760111994404;4850.975745121269;4891.755412229392;4913.140200464904;4810.615150787946;4843.491433399495;4852.2721591761165;4886.902261954759;4942.233953737158;4723.4568024677255;4790.520947905182;4798.7840547175465;4829.3721816164025;4844.806207751703;4795.688280261772;4797.160496913061;4810.975945120287;4850.175470170045;4853.514648535118;4741.193997020515;4770.332153498513;4780.49804770501;4789.712617242942;4844.491328410537;5136.691798492103;5216.3218781558535;5217.243499692561;5292.841214763564;5316.415194328621;5589.469000444951;5595.4124816894455;5609.719514024282;5610;5617.466340697627;5636.070048442043;5641.210230567724;5654.9151762723595;5655.943440565624;5661.631993920382;5180.197069454203;5287.07476191665;5327.7336133193185;5380.031594313022;5385.461453854622;5727.799527016535;5761.971190144022;5778.971105144447;5781.624194427349;5787;5375.435579264199;5567.693776842231;5568.888622227614;5571.721413929287;5575.972120139373;5694.544436445074;5707.429257074343;5730.054541000772;5781.364049954502;5782.624129431573;5451.291332126798;5474.890502190014;5479.671219726829;5483.848391837759;5489.58828087895;5461.863453413617;5488;5502.449755024466;5562.110062389998;5639.379668236491;4240;4256.318988961813;4256.68074894378;4283.629238643666;4293.656507479394;3785.1104990327253;3786.3184626767447;3803.391457366808;3838.9040273993373;3840.9231815364096;5169.844904652867;5277.23480095384;5310.336207974004;5367.221752845816;5382.327209098863;5705.91587598355;5725.828225153252;5742.483176514133;5749.597528173072;5790.565707571949;5303.655262407931;5388.434214407509;5390.64960777556;5395.974764794676;5405.756740946588;4769.6661233714;4801.039792041605;4831.758412079382;4878.56092951636;4909.337239472626;5747.5114615257335;5748.798792042342;5754.165645981309;5790.131480277908;5797.652140871477;5573.888522229451;5586.385497595261;5587.497125258747;5602.691851948019;5603.719814009201;5744.224529688438;5752.597318187687;5820.126980952891;5920;5921.792737254175;5566.860828479321;5567.192757050286;5568.49883510486;5577.888442231214;5587.217789509391;5637.830865074055;5638.097904335286;5689.118186681071;5689.630174038674;5692.857678558069;5460.535854452257;5526.944730552804;5555.0834112371;5588.720563971867;5606.523445507178;5497.175423686479;5502.862428439321;5504.4770746778995;5509.586780991522;5527.8894422112135;5300.761465733974;5389.326334208224;5403.108487099585;5415.350157981067;5459.836204913859;5417.4040855506655;5445.128779395436;5475.972620137033;5502.202180683858;5511;5365.436629154039;5383.757730902041;5420.972895135499;5424.864378390414;5433.945660543344 13:38:20 INFO - PROCESS | 25988 | |1;ext.html;630.0612087988897;643.7778966256643;649.5907578225717;652.6377860287539;656.8226578823718;38634.42048369273;40241;40286.59713402865;40307.39538906915;40355.192896142056;41998.37002444966;42750.572494275046;42823;42885.35671964915;42926.35610465846;8601.225889669913;8818.823623527525;8826.514541700204;8828.161324674145;8836.513991730451;8621.267192288631;8784.38509304349;8800.251978581828;8983.820323593523;8990.865137022949;8948.507832069266;9017.323700722472;9019.413738107001;9023.819523609523;9026.548672566378;8909.910900891005;8966.327525435554;8983.921929368518;8986.68546600869;9005.234555062827;8890.155435233642;8991.910080899173;8994.235489983359;9011.828462299925;9017.729468115967;41911.7904410476;42108;42419.363709544385;42538.36192457116;42550.36174457386;3551.254236610289;3613.1509095362567;3776.811159442017;3887.688984881203;4170.082581831992;29371.11886643404;29723.405531889457;29778.70221297781;32646.65255542634;33335.49996750051;3847.6729477994404;3857.24783667185;3865.884023479272;4019.376996565537;4034.616711412411;324434;324469;328022;329536;330116;60458.697706511186;62680.686596566724;62839.371606283356;62846.37153628497;62870.68564657147;51734.22398664023;57570.71214643984;57844;65525;65960.34039659542;16699.165041747863;17185.828141718674;17206.655866882593;17238;17273.222704978307;12536.498540058477;12630;12729.936350318188;12733.681657958625;12735.535413427575;16900;18742.625147496972;19169.61660766777;19286.132124054453;19379.51551211203;7197.280271972761;7226.385757210591;7272.890906636405;7282.380997615156;7286.125664920243;1023.3501726403787;1115.4199816095586;1139.4048332334798;1153.4348169396935;1159.9584730873555;31901.52147717786;33260.334793304;33479.163020924185;33503.664963350544;33778.98774904096;1190.7142285851507;1243.3720970909633;1251.2805137046234;1295.1452041652465;1305.8237137986441;16928.830711692724;17211.569710757332;17302.307907683553;17370.826291737172;17519.211635476433;484681;491374;492726;502080;504406;58791.4120858786;59605.70197149073;59725;59748.70125649431;59844.401555984754;1229.471327329239;1386.923719195454;1414.2151106136193;1416.199847086393;1424.6367176369959;28781;29877.10368688943;30249.546256805726;31407.685923140478;32257.677423226407;46908.7654561725;46971.295430569255;47263;47264.32828060655;47348.52651473579;288829;289558;290955;291099;291304;26955.595666064633;27303.317417064733;41329;41642.167156657306;42111.578884210765;44212;44826.327605086604;45015.32477012913;45604;46754.29868552042;36202;36972;37941.430878537394;41517;41651.166976660905;41248.587514124476;41317;41424.1715165701;41888.3716744243;43129.784351078044;42594;43039;43597.56402435935;43991.56008440003;44127;37427.2514549702;37945.81027094847;38251.426228607146;38352.80823595864;39026.414603780395;28732.239892318164;29128.56307155352;29266.122016339545;29617;29798.851005744833 13:38:20 INFO - PROCESS | 25988 | |2;jquery.html;384.9287881741878;393.484535258811;399.63034193371124;405.6349285642923;407.5537286671094;14657;18068;18343.724844127348;18653.81346186538;18670.346537871177;17964.82035179648;18118.818811811878;19033.90483047586;19431.028448577585;19672.606547869033;5629.774809007645;5773.711314434261;5837.766489340443;5838.970805145968;5839.708014599253;4065.024394145413;5604.467575580314;5782.306123265214;5792.478676919077;6106.3893610639025;6336.84157896054;6362.872742545146;6378.840528986766;6381.298057213703;6382.297947225825;6090.878182436327;6256.124142620037;6297.307296197415;6324.778632747854;6379.808605741812;5533.446655334475;5545.944540554583;5555.805501817129;5562.471565201299;5623.634463759842;22489.550208995894;23369.766302336928;23765.405864853343;23792.40518987022;23928.76071239283;2305.089489651595;2404.7715467030603;2776.7917406194415;3101.4943835917134;3157.2264795125343;9473.810523789485;13409.263552998038;14274.3576539056;14706.632334191623;14993.17537535435;1901.4675890750611;1962.9018549072632;1967.2524440712439;2001.3395579458743;2054.476108592299;80458.5977070111;81796;82626;82859;83047.58476207641;10680.198985076151;10748.516316765765;10799.406032668121;10937.398443085547;10966.506507207196;13679.316034198251;14490.710185796435;14899.70200595982;14976.70046599062;15189.392424302903;8006.559639219899;8026.518408895485;8189.426740128134;8213.589320534069;8243.216894395024;7682.96158519215;7719.3052625264;7779.611019449005;7827.765167044998;7963;4509.751963641966;4618.884527886763;4676.859694209111;4712.410948631421;4744.905101897943;1905.3045638341905;1910.560571068634;1944.5041514414017;1953.5897461533236;1958.412476257117;874.7506960516222;956.258899353007;963.9518024098767;1018.5212949913677;1029.7785976015043;19063.332783352795;19670.40988770339;19797.40607781769;19809.900950495154;19991.100400482013;971.5385192033727;974.8147851908257;983.6606370802061;1042.4527123260198;1044.1438020823005;10397.428141452292;11056.557737690402;11078.895009948084;11146.777064458665;11167.441627918572;487856;517129.0717732087;532138;542797;545892;93519.53240233756;94108;94859.52570237104;95764.52117739506;96460.51769741246;992.0525897767759;1011.9089281964658;1015.0559979219249;1028.1723212813608;1041.796849614333;16819.243134058754;17043.488695339158;17277.39529116475;17408;17680.11599419998;37235.627643723215;38441.80779096087;38450.61549384471;39493.2101357977;40131.799341003105;54252;54931.725341373036;55112;55782.44217557772;56137.43862561486;8627.266682332072;8676.305895528216;8773.956130219309;8787.824243515222;8793.956030219808;9623.663171788954;12795.296258705861;13127.146735462164;13280.80078798838;13622.93188534051;11592.304461732323;11741.236819606698;11755.823662644896;11938.701532461759;12356.135070545335;11674.357910315015;11772.411379431165;11785.762494938252;11910.050665136036;12019.278843269432;11957.820632690342;11982.460789264678;12061.095417843871;12186.329751863732;12307.507699691912;8643.82712345737;8691.087435819149;8700;8802.075782042793;8838.425502342327;8981.730548083568;11150.498227579616;11553.480093395985;11667.824982625098;11758 13:38:20 INFO - PROCESS | 25988 | |3;mootools.html;1379.7102608452224;1502.4966636176885;1539.415022291529;1645.975310370344;1803.269675781309;7514.849703005943;7839.137694853576;7840;7844.843103137934;7854.764357069283;7584.620768961544;7747.264009919063;7750.263724946121;7752.108507521637;7777.533347999124;2020.4140799168224;2048.1909645689943;2193.824494040473;2250.133698526071;2273.4430064634107;2281.361218858714;2289.1530133850497;2294.598445272079;2298.310506847947;2302.3323236261463;2219.4673278413225;2226.3543572364074;2260.7174103237094;2265.4676151104477;2269.841111122222;2014.4057503036565;2200.878951657658;2208.1388258579086;2260.8643481391005;2265.8413911026237;2242.035924552442;2251.358362866575;2263.739669937962;2272.6704627829035;2278.293728944033;7910.564918929456;7928.524288542706;7956.562389068599;7972.920270797275;8003.95998020012;4867.586255168315;4971.1549036663855;5042.369703787027;5049.368828896388;5051.419086805027;3122.266267427153;3173.682631736831;3177.6345720242007;3202.903912882617;3231.7091461768555;1126.6845283320602;1148.4717030166134;1178.0575539568397;1179.911506636997;1200.6758175292623;11184.105271578253;11184.105271578253;11249.943750281196;11255.212135150543;11264.605738799102;4309.913801723948;4354.042110735633;4370.868873933787;4472.753998530112;4483.461984561874;9660.420374777535;9669.274804389699;9686.854697179548;9695;9702.466364349888;4995.150824359867;5145.176771716508;5148.407933087743;5152.175651895679;5153.587712982952;4107.97946010274;4617;4723;4732.100900828831;4751.572358487683;3753;3820.6943444524372;3836.36699944506;3842.058695619591;3922.8626998054933;1241.6275117464725;1250.1748845761754;1267.2016629523525;1271.205496564647;1273.6497463197509;893.6872094766779;899.7525680437932;935.8128374325162;960.2030314838668;975.7902051058915;5582.162675598693;5647.689377084218;5653.462921022497;5718.228039214736;5734.16854556087;941.8304705153001;958.5399008475971;985.2856678907877;987.3138168972639;1000.9249306302056;3997.9400308995387;4074.1647962167685;4108.794560271975;4124.6906482013965;4154.169166166779;9850.261230407748;10142.290039697298;10182.592696292213;10298.17614590831;10302.587896484207;10058.14505767018;10119.190464762949;10219;10223.7444063899;10226.437545934896;7544.849103017909;7727.304542591081;7768.689252429953;7786.1824508426935;7843.764687059512;5785.56608254391;5790.652560846363;5804.709764511842;5853.678047707247;5874.853128671817;9259.907400925904;9297.767555811159;9435.622575097193;9473.147416732527;9570.61717531291;9442.10300021497;9560.856587151338;9671.226301895691;9675.322727409013;9692.951535242279;6879.071325371011;6924.446044316342;7002.439804815501;7064.32888875556;7068.68190931399;7723.884141737991;7727.150013498398;7756.108047574601;7775.883361749691;7784.766457006299;6537.967310163419;6697.732090716511;6719.092922455406;6734.057231987624;6832.93167068323;7126.572405655677;7264.273572642905;7264.418846492374;7264.564126152448;7304.890426643711;6247.718852651551;6327.493800496041;6338.049292606146;6338.873222535616;6361.61830290184;4701.388819453449;4757.857264282077;4763.190257656138;4848.878778030577;4941.43173535048;4825.8069677213925;4852;4925.532074452921;4953.727544984917;4989.825356112518 13:38:20 INFO - PROCESS | 25988 | |4;prototype.html;308.61124937779977;320.97753157279;331.38528030503414;331.83574130805255;334.7874099946534;5122.334096567451;5178.145605975014;5204.375474943012;5213.608979326552;5217;4925.1627223372025;5025.798968041274;5046.022846520552;5051.217061355495;5119.744012799364;3940.172563761599;3980.9800950995277;4079.8164082616204;4095.8771236862794;4139.979300103495;4058.492688413948;4082.4896887889013;4105.158442519291;4106.753594784308;4109.815058322382;3833.5208098987628;3969.876116277792;4020.5778393268724;4090.5295890972475;4108.137291168858;3960.3465428204313;3985.720999530034;3990.8004599769897;4019.778912159845;4022.913813270415;3521.9295614087573;3529.876454324112;3535.381308271042;3535.840887160058;3556.608773034964;4839.7338146401935;5011.32347133136;5014.423341315759;5017.197248440232;5021.949780502185;4543;4572.291294849304;4605.332226827091;4605.953940460586;4614.792334344963;5347.866303342409;5366.517013468768;5370.462953704638;5376;5388.201318070751;3871.399933010388;3892.2365120764293;3901.882943511699;3910.863119790822;3921.5490218624936;5377.193420986844;5551.9722401388135;5581.49766521015;5615.522680572116;5616.691081990489;3963.5243770747693;3971.225611005826;3980.7810570418324;3990.1421194442755;4002.0995276063236;4007.719459637797;4015.193163076627;4033.9596604034173;4034.798260086984;4045.2718510667773;4347.239233134189;4582.358469814229;4583.335416364608;4590.403247577793;4604.102200071021;5408.891822163535;5437.918431223535;5442.972785136129;5446.673199608036;5496.31296087989;1379.8409336157677;1457.3514785920377;1463.7950686903841;1465.3845384938352;1468.1631470061961;1021.2391768132641;1030.6753372687579;1044.556063672936;1045.8326667733127;1054.667779649408;5529.861753456195;5546.611737178439;5555.3333599967455;5567.137093750475;5607.046802043581;5888.175655408247;5893.233879595711;5903.203067585907;5913.137361731041;5914.4381283777975;5385.3268341457315;5543.833684989457;5561.944380556223;5568.44315568448;5580.972095139498;3095.8761649534217;3107.8912238071557;3109.891153809606;3127.1712996056062;3133.435981523302;5872.941270587325;6050.213472248667;6060.787872424444;6074.301455332693;6080.996635555084;6021.969890150521;6043.335233124353;6049.818505444844;6050.546209034252;6052.878942421215;6021.5182785377065;6025.638461692312;6042.425969532887;6065.909011364833;6067.089936509559;5741.5406767459335;5763.740631671669;5840.1531777892815;5848.152017957457;5878.647281163144;5780.190773291826;5800.274965629296;5839.299284085937;5863.413658634103;5877.794277200277;5468.972655136698;6079.452849243589;6081.726322315595;6104.786332478342;6132.41742034506;3900.2004589058606;3907.1404291055924;3924.3328634131694;3927.448657780218;3936.3111455495746;5370.153818476214;5614.915776263278;5649.209110724584;5657.971710141423;5680.857978550569;5303.681779093266;5449.891002180014;5456.208849716848;5474.39781624029;5498.340199176125;5378.757955891916;5388.08402571556;5420.972895135499;5453.918191227214;5489.149181876815;5114.4629813869005;5263.605229607718;5284.9735751320995;5354.946450535601;5360.65155764874;5340.225667278145;5404.8108316208745;5420.430854760193;5442.401335853132;5448.83653490396;5362.758675859518;5366.973165134149;5375.731213439391;5390.434004429479;5400.972995134999 13:38:20 INFO - PROCESS | 25988 | |5;yui.html;663.6117871045439;676.41828027896;692.145200677164;822.3339095332781;828.9709860154894;12990.935045324772;13407.530736424227;13420.530281440151;13460.730785384287;13477.39351729172;12176.391180440987;12336.691582710437;12343.25940443574;12387.318697471635;12398.690032749186;683.0744341417383;822.6051495282268;824.9133840946704;827.1067247372823;830.995845020774;830.211299265697;838.5388036579888;839.6809212499242;841.3311417423163;841.5918279634373;855.8887344645218;856.3662889461784;859.3984211052257;860.4063196394468;863.8704194370863;710.7263703474148;853.3429259470204;856;856.2251162697769;879.2482427524438;642.8489305013318;643.488426700774;643.6234802640414;644.0532417346493;644.2333622988629;12641.620751377473;12651.810222846665;12695.301758403284;12714.61856144317;12735.55425560101;11211;11799.882001179963;12392.070594705343;12728.74542509154;12786.808197877039;10582.259241853073;10656.307340022873;10862.34825910448;10877.67366978992;11016.834747478793;3619.8009109498967;3623.547056617923;3653.0867283179205;3673.981630091859;3690.5202323698018;49533;51163.232551511755;51274.23088653673;51373.22940155901;52634;9032.63869445215;9424.528773561295;9430.528473576294;9590.520473976412;9652.034796520433;16016.199190040452;16238.837611623969;16257.51227463178;16289.837101628833;16316.75524867128;7487.1764105948305;7488.550686958691;7560.9621951889885;7588.354989825816;7771.572563509061;4045.0494133878515;4229.217594744982;4278.807453664593;4297.226499230106;4333.934990975138;3015.909522714322;3077.0768769369547;3078.4612692779124;3080.106769036954;3090.134762266569;523.9161734122522;563.822395945276;579.8173575323759;588.6173986908458;596.7911231069178;633.2148136310941;728.3699599846095;736.8636802191612;743.2121950732242;777.4946284914738;7324.340809327079;7544.585047822313;7641.503302285334;7787.104482984416;7891.053073631087;673.6059405247985;683.0846665468297;689.6034780001519;730.3098571849551;758.4880205861022;3787.5644300905747;3852.9229415411537;3857.7492462989817;3952.4268980997595;3980.960190398117;64363.03455448172;64754.35245647483;66545.66727166333;67791.66104169546;68775;56595;57194.42805571974;57526;58822.411775881694;59093;52913.206301905506;53080.46919530755;53152;53677.7316113417;53907;7753.379729621504;7781.144074151725;7801.687932482864;7826.843463130819;7897.526148431112;32047.198820029687;32283.51574726334;32357.35285294234;32423.351532969682;32489.35021299608;44042;47114;47169.52830471789;47274;48517.75741121272;10018.448985305879;10162.39025658463;10188.388696678223;10242.129418999171;10412.68761937143;9932.205423565953;10276.691699249035;10456.372617642966;10818.783624327627;10867.184961128105;10142.137918276734;10276.17790576737;10314.793704126025;10438.739031524272;10534.262601617813;9406.858897116412;9866.013398660076;10442.63450779219;10531.736706582396;11073.833892491459;10124.34191777532;10207.795844083224;10212.08091271789;10324.07083362501;10580.523876425425;9520.381175223589;9742.123208911233;9752.609895604097;9755.268354873555;9810.460424676712;8858.867116993122;8948.418352807046;9109.362344636076;9113.544322783702;9373.531323433665 13:38:20 INFO - PROCESS | 25988 | __end_tp_report 13:38:20 INFO - PROCESS | 25988 | __start_cc_report 13:38:20 INFO - PROCESS | 25988 | _x_x_mozilla_cycle_collect,795 13:38:20 INFO - PROCESS | 25988 | __end_cc_report 13:38:20 INFO - PROCESS | 25988 | __startTimestamp1461616700941__endTimestamp 13:38:20 INFO - PROCESS | 25988 | 13:38:20 INFO - PROCESS | 25988 | ------- Summary: start ------- 13:38:20 INFO - PROCESS | 25988 | Number of tests: 6 13:38:20 INFO - PROCESS | 25988 | 13:38:20 INFO - PROCESS | 25988 | [#0] dojo.html Cycles:165 Average:5236.92 Median:5417.40 stddev:583.48 (10.8%) stddev-sans-first:559.22 13:38:20 INFO - PROCESS | 25988 | Values: 3039.1 3130.7 3160.6 3164.4 3204.8 5194.7 5281.0 5308.8 5377.5 5410.5 5249.8 5314.3 5321.7 5324.0 5327.6 4758.7 4797.8 4851.0 4891.8 4913.1 4810.6 4843.5 4852.3 4886.9 4942.2 4723.5 4790.5 4798.8 4829.4 4844.8 4795.7 4797.2 4811.0 4850.2 4853.5 4741.2 4770.3 4780.5 4789.7 4844.5 5136.7 5216.3 5217.2 5292.8 5316.4 5589.5 5595.4 5609.7 5610.0 5617.5 5636.1 5641.2 5654.9 5655.9 5661.6 5180.2 5287.1 5327.7 5380.0 5385.5 5727.8 5762.0 5779.0 5781.6 5787.0 5375.4 5567.7 5568.9 5571.7 5576.0 5694.5 5707.4 5730.1 5781.4 5782.6 5451.3 5474.9 5479.7 5483.8 5489.6 5461.9 5488.0 5502.4 5562.1 5639.4 4240.0 4256.3 4256.7 4283.6 4293.7 3785.1 3786.3 3803.4 3838.9 3840.9 5169.8 5277.2 5310.3 5367.2 5382.3 5705.9 5725.8 5742.5 5749.6 5790.6 5303.7 5388.4 5390.6 5396.0 5405.8 4769.7 4801.0 4831.8 4878.6 4909.3 5747.5 5748.8 5754.2 5790.1 5797.7 5573.9 5586.4 5587.5 5602.7 5603.7 5744.2 5752.6 5820.1 5920.0 5921.8 5566.9 5567.2 5568.5 5577.9 5587.2 5637.8 5638.1 5689.1 5689.6 5692.9 5460.5 5526.9 5555.1 5588.7 5606.5 5497.2 5502.9 5504.5 5509.6 5527.9 5300.8 5389.3 5403.1 5415.4 5459.8 5417.4 5445.1 5476.0 5502.2 5511.0 5365.4 5383.8 5421.0 5424.9 5433.9 13:38:20 INFO - PROCESS | 25988 | 13:38:20 INFO - PROCESS | 25988 | [#1] ext.html Cycles:180 Average:54544.19 Median:41323.00 stddev:100748.31 (243.8%) stddev-sans-first:100949.61 13:38:20 INFO - PROCESS | 25988 | Values: 630.1 643.8 649.6 652.6 656.8 38634.4 40241.0 40286.6 40307.4 40355.2 41998.4 42750.6 42823.0 42885.4 42926.4 8601.2 8818.8 8826.5 8828.2 8836.5 8621.3 8784.4 8800.3 8983.8 8990.9 8948.5 9017.3 9019.4 9023.8 9026.5 8909.9 8966.3 8983.9 8986.7 9005.2 8890.2 8991.9 8994.2 9011.8 9017.7 41911.8 42108.0 42419.4 42538.4 42550.4 3551.3 3613.2 3776.8 3887.7 4170.1 29371.1 29723.4 29778.7 32646.7 33335.5 3847.7 3857.2 3865.9 4019.4 4034.6 324434.0 324469.0 328022.0 329536.0 330116.0 60458.7 62680.7 62839.4 62846.4 62870.7 51734.2 57570.7 57844.0 65525.0 65960.3 16699.2 17185.8 17206.7 17238.0 17273.2 12536.5 12630.0 12729.9 12733.7 12735.5 16900.0 18742.6 19169.6 19286.1 19379.5 7197.3 7226.4 7272.9 7282.4 7286.1 1023.4 1115.4 1139.4 1153.4 1160.0 31901.5 33260.3 33479.2 33503.7 33779.0 1190.7 1243.4 1251.3 1295.1 1305.8 16928.8 17211.6 17302.3 17370.8 17519.2 484681.0 491374.0 492726.0 502080.0 504406.0 58791.4 59605.7 59725.0 59748.7 59844.4 1229.5 1386.9 1414.2 1416.2 1424.6 28781.0 29877.1 30249.5 31407.7 32257.7 46908.8 46971.3 47263.0 47264.3 47348.5 288829.0 289558.0 290955.0 291099.0 291304.0 26955.6 27303.3 41329.0 41642.2 42111.6 44212.0 44826.3 45015.3 45604.0 46754.3 36202.0 36972.0 37941.4 41517.0 41651.2 41248.6 41317.0 41424.2 41888.4 43129.8 42594.0 43039.0 43597.6 43991.6 44127.0 37427.3 37945.8 38251.4 38352.8 39026.4 28732.2 29128.6 29266.1 29617.0 29798.9 13:38:20 INFO - PROCESS | 25988 | 13:38:20 INFO - PROCESS | 25988 | [#2] jquery.html Cycles:180 Average:29995.85 Median:18810.28 stddev:86508.68 (459.9%) stddev-sans-first:86722.79 13:38:20 INFO - PROCESS | 25988 | Values: 384.9 393.5 399.6 405.6 407.6 14657.0 18068.0 18343.7 18653.8 18670.3 17964.8 18118.8 19033.9 19431.0 19672.6 5629.8 5773.7 5837.8 5839.0 5839.7 4065.0 5604.5 5782.3 5792.5 6106.4 6336.8 6362.9 6378.8 6381.3 6382.3 6090.9 6256.1 6297.3 6324.8 6379.8 5533.4 5545.9 5555.8 5562.5 5623.6 22489.6 23369.8 23765.4 23792.4 23928.8 2305.1 2404.8 2776.8 3101.5 3157.2 9473.8 13409.3 14274.4 14706.6 14993.2 1901.5 1962.9 1967.3 2001.3 2054.5 80458.6 81796.0 82626.0 82859.0 83047.6 10680.2 10748.5 10799.4 10937.4 10966.5 13679.3 14490.7 14899.7 14976.7 15189.4 8006.6 8026.5 8189.4 8213.6 8243.2 7683.0 7719.3 7779.6 7827.8 7963.0 4509.8 4618.9 4676.9 4712.4 4744.9 1905.3 1910.6 1944.5 1953.6 1958.4 874.8 956.3 964.0 1018.5 1029.8 19063.3 19670.4 19797.4 19809.9 19991.1 971.5 974.8 983.7 1042.5 1044.1 10397.4 11056.6 11078.9 11146.8 11167.4 487856.0 517129.1 532138.0 542797.0 545892.0 93519.5 94108.0 94859.5 95764.5 96460.5 992.1 1011.9 1015.1 1028.2 1041.8 16819.2 17043.5 17277.4 17408.0 17680.1 37235.6 38441.8 38450.6 39493.2 40131.8 54252.0 54931.7 55112.0 55782.4 56137.4 8627.3 8676.3 8774.0 8787.8 8794.0 9623.7 12795.3 13127.1 13280.8 13622.9 11592.3 11741.2 11755.8 11938.7 12356.1 11674.4 11772.4 11785.8 11910.1 12019.3 11957.8 11982.5 12061.1 12186.3 12307.5 8643.8 8691.1 8700.0 8802.1 8838.4 8981.7 11150.5 11553.5 11667.8 11758.0 13:38:20 INFO - PROCESS | 25988 | 13:38:20 INFO - PROCESS | 25988 | [#3] mootools.html Cycles:180 Average:5414.53 Median:4980.49 stddev:2989.89 (60.0%) stddev-sans-first:2982.90 13:38:20 INFO - PROCESS | 25988 | Values: 1379.7 1502.5 1539.4 1646.0 1803.3 7514.8 7839.1 7840.0 7844.8 7854.8 7584.6 7747.3 7750.3 7752.1 7777.5 2020.4 2048.2 2193.8 2250.1 2273.4 2281.4 2289.2 2294.6 2298.3 2302.3 2219.5 2226.4 2260.7 2265.5 2269.8 2014.4 2200.9 2208.1 2260.9 2265.8 2242.0 2251.4 2263.7 2272.7 2278.3 7910.6 7928.5 7956.6 7972.9 8004.0 4867.6 4971.2 5042.4 5049.4 5051.4 3122.3 3173.7 3177.6 3202.9 3231.7 1126.7 1148.5 1178.1 1179.9 1200.7 11184.1 11184.1 11249.9 11255.2 11264.6 4309.9 4354.0 4370.9 4472.8 4483.5 9660.4 9669.3 9686.9 9695.0 9702.5 4995.2 5145.2 5148.4 5152.2 5153.6 4108.0 4617.0 4723.0 4732.1 4751.6 3753.0 3820.7 3836.4 3842.1 3922.9 1241.6 1250.2 1267.2 1271.2 1273.6 893.7 899.8 935.8 960.2 975.8 5582.2 5647.7 5653.5 5718.2 5734.2 941.8 958.5 985.3 987.3 1000.9 3997.9 4074.2 4108.8 4124.7 4154.2 9850.3 10142.3 10182.6 10298.2 10302.6 10058.1 10119.2 10219.0 10223.7 10226.4 7544.8 7727.3 7768.7 7786.2 7843.8 5785.6 5790.7 5804.7 5853.7 5874.9 9259.9 9297.8 9435.6 9473.1 9570.6 9442.1 9560.9 9671.2 9675.3 9693.0 6879.1 6924.4 7002.4 7064.3 7068.7 7723.9 7727.2 7756.1 7775.9 7784.8 6538.0 6697.7 6719.1 6734.1 6832.9 7126.6 7264.3 7264.4 7264.6 7304.9 6247.7 6327.5 6338.0 6338.9 6361.6 4701.4 4757.9 4763.2 4848.9 4941.4 4825.8 4852.0 4925.5 4953.7 4989.8 13:38:20 INFO - PROCESS | 25988 | 13:38:20 INFO - PROCESS | 25988 | [#4] prototype.html Cycles:180 Average:4649.40 Median:5240.30 stddev:1386.30 (26.5%) stddev-sans-first:1351.36 13:38:20 INFO - PROCESS | 25988 | Values: 308.6 321.0 331.4 331.8 334.8 5122.3 5178.1 5204.4 5213.6 5217.0 4925.2 5025.8 5046.0 5051.2 5119.7 3940.2 3981.0 4079.8 4095.9 4140.0 4058.5 4082.5 4105.2 4106.8 4109.8 3833.5 3969.9 4020.6 4090.5 4108.1 3960.3 3985.7 3990.8 4019.8 4022.9 3521.9 3529.9 3535.4 3535.8 3556.6 4839.7 5011.3 5014.4 5017.2 5021.9 4543.0 4572.3 4605.3 4606.0 4614.8 5347.9 5366.5 5370.5 5376.0 5388.2 3871.4 3892.2 3901.9 3910.9 3921.5 5377.2 5552.0 5581.5 5615.5 5616.7 3963.5 3971.2 3980.8 3990.1 4002.1 4007.7 4015.2 4034.0 4034.8 4045.3 4347.2 4582.4 4583.3 4590.4 4604.1 5408.9 5437.9 5443.0 5446.7 5496.3 1379.8 1457.4 1463.8 1465.4 1468.2 1021.2 1030.7 1044.6 1045.8 1054.7 5529.9 5546.6 5555.3 5567.1 5607.0 5888.2 5893.2 5903.2 5913.1 5914.4 5385.3 5543.8 5561.9 5568.4 5581.0 3095.9 3107.9 3109.9 3127.2 3133.4 5872.9 6050.2 6060.8 6074.3 6081.0 6022.0 6043.3 6049.8 6050.5 6052.9 6021.5 6025.6 6042.4 6065.9 6067.1 5741.5 5763.7 5840.2 5848.2 5878.6 5780.2 5800.3 5839.3 5863.4 5877.8 5469.0 6079.5 6081.7 6104.8 6132.4 3900.2 3907.1 3924.3 3927.4 3936.3 5370.2 5614.9 5649.2 5658.0 5680.9 5303.7 5449.9 5456.2 5474.4 5498.3 5378.8 5388.1 5421.0 5453.9 5489.1 5114.5 5263.6 5285.0 5354.9 5360.7 5340.2 5404.8 5420.4 5442.4 5448.8 5362.8 5367.0 5375.7 5390.4 5401.0 13:38:20 INFO - PROCESS | 25988 | 13:38:20 INFO - PROCESS | 25988 | [#5] yui.html Cycles:180 Average:14164.61 Median:53414.87 stddev:17770.49 (33.3%) stddev-sans-first:17791.42 13:38:20 INFO - PROCESS | 25988 | Values: 663.6 676.4 692.1 822.3 829.0 12990.9 13407.5 13420.5 13460.7 13477.4 12176.4 12336.7 12343.3 12387.3 12398.7 683.1 822.6 824.9 827.1 831.0 830.2 838.5 839.7 841.3 841.6 855.9 856.4 859.4 860.4 863.9 710.7 853.3 856.0 856.2 879.2 642.8 643.5 643.6 644.1 644.2 12641.6 12651.8 12695.3 12714.6 12735.6 11211.0 11799.9 12392.1 12728.7 12786.8 10582.3 10656.3 10862.3 10877.7 11016.8 3619.8 3623.5 3653.1 3674.0 3690.5 49533.0 51163.2 51274.2 51373.2 52634.0 9032.6 9424.5 9430.5 9590.5 9652.0 16016.2 16238.8 16257.5 16289.8 16316.8 7487.2 7488.6 7561.0 7588.4 7771.6 4045.0 4229.2 4278.8 4297.2 4333.9 3015.9 3077.1 3078.5 3080.1 3090.1 523.9 563.8 579.8 588.6 596.8 633.2 728.4 736.9 743.2 777.5 7324.3 7544.6 7641.5 7787.1 7891.1 673.6 683.1 689.6 730.3 758.5 3787.6 3852.9 3857.7 3952.4 3981.0 64363.0 64754.4 66545.7 67791.7 68775.0 56595.0 57194.4 57526.0 58822.4 59093.0 52913.2 53080.5 53152.0 53677.7 53907.0 7753.4 7781.1 7801.7 7826.8 7897.5 32047.2 32283.5 32357.4 32423.4 32489.4 44042.0 47114.0 47169.5 47274.0 48517.8 10018.4 10162.4 10188.4 10242.1 10412.7 9932.2 10276.7 10456.4 10818.8 10867.2 10142.1 10276.2 10314.8 10438.7 10534.3 9406.9 9866.0 10442.6 10531.7 11073.8 10124.3 10207.8 10212.1 10324.1 10580.5 9520.4 9742.1 9752.6 9755.3 9810.5 8858.9 8948.4 9109.4 9113.5 9373.5 13:38:20 INFO - PROCESS | 25988 | -------- Summary: end -------- 13:38:20 INFO - PROCESS | 25988 | 13:38:21 INFO - TEST-INFO | 25988: exit 0 13:38:21 INFO - TEST-OK | dromaeo_css | took 1111266ms 13:38:21 INFO - TEST-START | kraken 13:38:21 INFO - operating with platform_type : linux_ 13:38:21 INFO - Initialising browser for kraken test... 13:38:21 INFO - TEST-INFO | started process 26172 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp26Ui1F/profile http://localhost:54316/getInfo.html) 13:38:25 INFO - PROCESS | 26172 | __metrics Screen width/height:1600/1200 13:38:25 INFO - PROCESS | 26172 | colorDepth:24 13:38:25 INFO - PROCESS | 26172 | Browser inner width/height: 1024/697 13:38:25 INFO - PROCESS | 26172 | __metrics 13:38:26 ERROR - PROCESS | 26172 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:38:26 INFO - TEST-INFO | 26172: exit 0 13:38:26 INFO - Browser initialized. 13:38:26 INFO - Running cycle 1/1 for kraken test... 13:38:26 INFO - TEST-INFO | started process 26253 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp26Ui1F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:38:38 INFO - PROCESS | 26253 | RSS: Main: 154144768 13:38:38 INFO - PROCESS | 26253 | 13:38:41 INFO - PROCESS | 26253 | Cycle 1(1): loaded http://localhost:54316/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54316/tests/kraken/driver.html?testName=audio-beat-detection) 13:38:42 INFO - PROCESS | 26253 | RSS: Main: 210112512 13:38:42 INFO - PROCESS | 26253 | 13:38:44 INFO - PROCESS | 26253 | Cycle 1(1): loaded http://localhost:54316/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54316/tests/kraken/driver.html?testName=audio-dft) 13:38:45 INFO - PROCESS | 26253 | RSS: Main: 195239936 13:38:45 INFO - PROCESS | 26253 | 13:38:48 INFO - PROCESS | 26253 | Cycle 1(1): loaded http://localhost:54316/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54316/tests/kraken/driver.html?testName=audio-fft) 13:38:49 INFO - PROCESS | 26253 | RSS: Main: 267358208 13:38:49 INFO - PROCESS | 26253 | 13:38:51 INFO - PROCESS | 26253 | Cycle 1(1): loaded http://localhost:54316/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54316/tests/kraken/driver.html?testName=audio-oscillator) 13:38:51 INFO - PROCESS | 26253 | RSS: Main: 174055424 13:38:51 INFO - PROCESS | 26253 | 13:38:53 INFO - PROCESS | 26253 | Cycle 1(1): loaded http://localhost:54316/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54316/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:38:54 INFO - PROCESS | 26253 | RSS: Main: 178614272 13:38:54 INFO - PROCESS | 26253 | 13:38:57 INFO - PROCESS | 26253 | Cycle 1(1): loaded http://localhost:54316/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54316/tests/kraken/driver.html?testName=imaging-darkroom) 13:38:58 INFO - PROCESS | 26253 | RSS: Main: 214872064 13:38:58 INFO - PROCESS | 26253 | 13:39:01 INFO - PROCESS | 26253 | Cycle 1(1): loaded http://localhost:54316/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54316/tests/kraken/driver.html?testName=imaging-desaturate) 13:39:02 INFO - PROCESS | 26253 | RSS: Main: 216199168 13:39:02 INFO - PROCESS | 26253 | 13:39:04 INFO - PROCESS | 26253 | Cycle 1(1): loaded http://localhost:54316/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54316/tests/kraken/driver.html?testName=json-parse-financial) 13:39:05 INFO - PROCESS | 26253 | RSS: Main: 215334912 13:39:05 INFO - PROCESS | 26253 | 13:39:07 INFO - PROCESS | 26253 | Cycle 1(1): loaded http://localhost:54316/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54316/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:39:07 INFO - PROCESS | 26253 | RSS: Main: 202731520 13:39:07 INFO - PROCESS | 26253 | 13:39:09 INFO - PROCESS | 26253 | Cycle 1(1): loaded http://localhost:54316/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54316/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:39:10 INFO - PROCESS | 26253 | RSS: Main: 204738560 13:39:10 INFO - PROCESS | 26253 | 13:39:12 INFO - PROCESS | 26253 | Cycle 1(1): loaded http://localhost:54316/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54316/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:39:12 INFO - PROCESS | 26253 | RSS: Main: 216293376 13:39:12 INFO - PROCESS | 26253 | 13:39:15 INFO - PROCESS | 26253 | Cycle 1(1): loaded http://localhost:54316/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54316/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:39:15 INFO - PROCESS | 26253 | RSS: Main: 223236096 13:39:15 INFO - PROCESS | 26253 | 13:39:18 INFO - PROCESS | 26253 | Cycle 1(1): loaded http://localhost:54316/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54316/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:39:19 INFO - PROCESS | 26253 | RSS: Main: 219275264 13:39:19 INFO - PROCESS | 26253 | 13:39:21 INFO - PROCESS | 26253 | Cycle 1(1): loaded http://localhost:54316/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54316/tests/kraken/driver.html?testName=ai-astar) 13:39:21 INFO - PROCESS | 26253 | RSS: Main: 283107328 13:39:21 INFO - PROCESS | 26253 | 13:39:21 INFO - PROCESS | 26253 | __start_tp_report 13:39:21 INFO - PROCESS | 26253 | _x_x_mozilla_page_load 13:39:21 INFO - PROCESS | 26253 | _x_x_mozilla_page_load_details 13:39:21 INFO - PROCESS | 26253 | |i|pagename|runs| 13:39:21 INFO - PROCESS | 26253 | |0;ai-astar;111;113;107;113;113;115;102;113;111;113 13:39:21 INFO - PROCESS | 26253 | |1;audio-beat-detection;153;129;159;179;128;156;153;135;199;127 13:39:21 INFO - PROCESS | 26253 | |2;audio-dft;164;161;161;163;161;162;163;162;163;164 13:39:21 INFO - PROCESS | 26253 | |3;audio-fft;75;74;121;115;78;77;74;138;102;78 13:39:21 INFO - PROCESS | 26253 | |4;audio-oscillator;94;93;151;92;96;94;147;92;92;147 13:39:21 INFO - PROCESS | 26253 | |5;imaging-gaussian-blur;117;117;117;117;118;117;118;118;117;119 13:39:21 INFO - PROCESS | 26253 | |6;imaging-darkroom;146;146;145;146;146;146;146;146;146;147 13:39:21 INFO - PROCESS | 26253 | |7;imaging-desaturate;95;94;95;94;94;95;94;95;95;96 13:39:21 INFO - PROCESS | 26253 | |8;json-parse-financial;58;57;57;56;58;57;59;78;63;54 13:39:21 INFO - PROCESS | 26253 | |9;json-stringify-tinderbox;62;62;61;60;61;61;62;62;62;63 13:39:21 INFO - PROCESS | 26253 | |10;stanford-crypto-aes;86;77;77;76;78;86;85;76;77;76 13:39:21 INFO - PROCESS | 26253 | |11;stanford-crypto-ccm;124;129;132;129;126;123;121;123;158;124 13:39:21 INFO - PROCESS | 26253 | |12;stanford-crypto-pbkdf2;171;168;171;167;175;169;164;166;166;174 13:39:21 INFO - PROCESS | 26253 | |13;stanford-crypto-sha256-iterative;69;69;71;70;69;68;68;70;67;68 13:39:21 INFO - PROCESS | 26253 | __end_tp_report 13:39:21 INFO - PROCESS | 26253 | __start_cc_report 13:39:21 INFO - PROCESS | 26253 | _x_x_mozilla_cycle_collect,1619 13:39:21 INFO - PROCESS | 26253 | __end_cc_report 13:39:21 INFO - PROCESS | 26253 | __startTimestamp1461616761251__endTimestamp 13:39:21 INFO - PROCESS | 26253 | 13:39:21 INFO - PROCESS | 26253 | ------- Summary: start ------- 13:39:21 INFO - PROCESS | 26253 | Number of tests: 14 13:39:21 INFO - PROCESS | 26253 | 13:39:21 INFO - PROCESS | 26253 | [#0] ai-astar Cycles:10 Average:111.10 Median:113.00 stddev:3.84 (3.4%) stddev-sans-first:4.08 13:39:21 INFO - PROCESS | 26253 | Values: 111.0 113.0 107.0 113.0 113.0 115.0 102.0 113.0 111.0 113.0 13:39:21 INFO - PROCESS | 26253 | 13:39:21 INFO - PROCESS | 26253 | [#1] audio-beat-detection Cycles:10 Average:151.80 Median:154.50 stddev:23.63 (15.3%) stddev-sans-first:25.05 13:39:21 INFO - PROCESS | 26253 | Values: 153.0 129.0 159.0 179.0 128.0 156.0 153.0 135.0 199.0 127.0 13:39:21 INFO - PROCESS | 26253 | 13:39:21 INFO - PROCESS | 26253 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:1.17 (0.7%) stddev-sans-first:1.09 13:39:21 INFO - PROCESS | 26253 | Values: 164.0 161.0 161.0 163.0 161.0 162.0 163.0 162.0 163.0 164.0 13:39:21 INFO - PROCESS | 26253 | 13:39:21 INFO - PROCESS | 26253 | [#3] audio-fft Cycles:10 Average:93.20 Median:74.50 stddev:23.86 (32.0%) stddev-sans-first:24.39 13:39:21 INFO - PROCESS | 26253 | Values: 75.0 74.0 121.0 115.0 78.0 77.0 74.0 138.0 102.0 78.0 13:39:21 INFO - PROCESS | 26253 | 13:39:21 INFO - PROCESS | 26253 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:92.50 stddev:26.64 (28.8%) stddev-sans-first:27.64 13:39:21 INFO - PROCESS | 26253 | Values: 94.0 93.0 151.0 92.0 96.0 94.0 147.0 92.0 92.0 147.0 13:39:21 INFO - PROCESS | 26253 | 13:39:21 INFO - PROCESS | 26253 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 13:39:21 INFO - PROCESS | 26253 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 118.0 118.0 117.0 119.0 13:39:21 INFO - PROCESS | 26253 | 13:39:21 INFO - PROCESS | 26253 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 13:39:21 INFO - PROCESS | 26253 | Values: 146.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 13:39:21 INFO - PROCESS | 26253 | 13:39:21 INFO - PROCESS | 26253 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 13:39:21 INFO - PROCESS | 26253 | Values: 95.0 94.0 95.0 94.0 94.0 95.0 94.0 95.0 95.0 96.0 13:39:21 INFO - PROCESS | 26253 | 13:39:21 INFO - PROCESS | 26253 | [#8] json-parse-financial Cycles:10 Average:59.70 Median:58.00 stddev:6.83 (11.8%) stddev-sans-first:7.22 13:39:21 INFO - PROCESS | 26253 | Values: 58.0 57.0 57.0 56.0 58.0 57.0 59.0 78.0 63.0 54.0 13:39:21 INFO - PROCESS | 26253 | 13:39:21 INFO - PROCESS | 26253 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:62.00 stddev:0.84 (1.4%) stddev-sans-first:0.88 13:39:21 INFO - PROCESS | 26253 | Values: 62.0 62.0 61.0 60.0 61.0 61.0 62.0 62.0 62.0 63.0 13:39:21 INFO - PROCESS | 26253 | 13:39:21 INFO - PROCESS | 26253 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:77.50 stddev:4.38 (5.6%) stddev-sans-first:3.94 13:39:21 INFO - PROCESS | 26253 | Values: 86.0 77.0 77.0 76.0 78.0 86.0 85.0 76.0 77.0 76.0 13:39:21 INFO - PROCESS | 26253 | 13:39:21 INFO - PROCESS | 26253 | [#11] stanford-crypto-ccm Cycles:10 Average:128.90 Median:127.50 stddev:10.77 (8.5%) stddev-sans-first:11.28 13:39:21 INFO - PROCESS | 26253 | Values: 124.0 129.0 132.0 129.0 126.0 123.0 121.0 123.0 158.0 124.0 13:39:21 INFO - PROCESS | 26253 | 13:39:21 INFO - PROCESS | 26253 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.10 Median:170.00 stddev:3.60 (2.1%) stddev-sans-first:3.76 13:39:21 INFO - PROCESS | 26253 | Values: 171.0 168.0 171.0 167.0 175.0 169.0 164.0 166.0 166.0 174.0 13:39:21 INFO - PROCESS | 26253 | 13:39:21 INFO - PROCESS | 26253 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:1.20 (1.7%) stddev-sans-first:1.27 13:39:21 INFO - PROCESS | 26253 | Values: 69.0 69.0 71.0 70.0 69.0 68.0 68.0 70.0 67.0 68.0 13:39:21 INFO - PROCESS | 26253 | -------- Summary: end -------- 13:39:21 INFO - PROCESS | 26253 | 13:39:22 INFO - TEST-INFO | 26253: exit 0 13:39:22 INFO - TEST-OK | kraken | took 60537ms 13:39:22 INFO - SUITE-END | took 1171s 13:39:22 INFO - Completed test suite (00:19:31) 13:39:22 INFO - javascript benchmark 13:39:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3039.073082709773, 3130.686931306871, 3160.589123413957, 3164.4462219111665, 3204.775665703401, 5194.688318700871, 5280.973595132029, 5308.8407347779585, 5377.516023557879, 5410.458954104588, 5249.790008399659, 5314.282571852798, 5321.733913304339, 5324.041672498949, 5327.573794096473, 4758.738269395182, 4797.760111994404, 4850.975745121269, 4891.755412229392, 4913.140200464904, 4810.615150787946, 4843.491433399495, 4852.2721591761165, 4886.902261954759, 4942.233953737158, 4723.4568024677255, 4790.520947905182, 4798.7840547175465, 4829.3721816164025, 4844.806207751703, 4795.688280261772, 4797.160496913061, 4810.975945120287, 4850.175470170045, 4853.514648535118, 4741.193997020515, 4770.332153498513, 4780.49804770501, 4789.712617242942, 4844.491328410537, 5136.691798492103, 5216.3218781558535, 5217.243499692561, 5292.841214763564, 5316.415194328621, 5589.469000444951, 5595.4124816894455, 5609.719514024282, 5610.0, 5617.466340697627, 5636.070048442043, 5641.210230567724, 5654.9151762723595, 5655.943440565624, 5661.631993920382, 5180.197069454203, 5287.07476191665, 5327.7336133193185, 5380.031594313022, 5385.461453854622, 5727.799527016535, 5761.971190144022, 5778.971105144447, 5781.624194427349, 5787.0, 5375.435579264199, 5567.693776842231, 5568.888622227614, 5571.721413929287, 5575.972120139373, 5694.544436445074, 5707.429257074343, 5730.054541000772, 5781.364049954502, 5782.624129431573, 5451.291332126798, 5474.890502190014, 5479.671219726829, 5483.848391837759, 5489.58828087895, 5461.863453413617, 5488.0, 5502.449755024466, 5562.110062389998, 5639.379668236491, 4240.0, 4256.318988961813, 4256.68074894378, 4283.629238643666, 4293.656507479394, 3785.1104990327253, 3786.3184626767447, 3803.391457366808, 3838.9040273993373, 3840.9231815364096, 5169.844904652867, 5277.23480095384, 5310.336207974004, 5367.221752845816, 5382.327209098863, 5705.91587598355, 5725.828225153252, 5742.483176514133, 5749.597528173072, 5790.565707571949, 5303.655262407931, 5388.434214407509, 5390.64960777556, 5395.974764794676, 5405.756740946588, 4769.6661233714, 4801.039792041605, 4831.758412079382, 4878.56092951636, 4909.337239472626, 5747.5114615257335, 5748.798792042342, 5754.165645981309, 5790.131480277908, 5797.652140871477, 5573.888522229451, 5586.385497595261, 5587.497125258747, 5602.691851948019, 5603.719814009201, 5744.224529688438, 5752.597318187687, 5820.126980952891, 5920.0, 5921.792737254175, 5566.860828479321, 5567.192757050286, 5568.49883510486, 5577.888442231214, 5587.217789509391, 5637.830865074055, 5638.097904335286, 5689.118186681071, 5689.630174038674, 5692.857678558069, 5460.535854452257, 5526.944730552804, 5555.0834112371, 5588.720563971867, 5606.523445507178, 5497.175423686479, 5502.862428439321, 5504.4770746778995, 5509.586780991522, 5527.8894422112135, 5300.761465733974, 5389.326334208224, 5403.108487099585, 5415.350157981067, 5459.836204913859, 5417.4040855506655, 5445.128779395436, 5475.972620137033, 5502.202180683858, 5511.0, 5365.436629154039, 5383.757730902041, 5420.972895135499, 5424.864378390414, 5433.945660543344], "value": 5198.554302223341, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [630.0612087988897, 643.7778966256643, 649.5907578225717, 652.6377860287539, 656.8226578823718, 38634.42048369273, 40241.0, 40286.59713402865, 40307.39538906915, 40355.192896142056, 41998.37002444966, 42750.572494275046, 42823.0, 42885.35671964915, 42926.35610465846, 8601.225889669913, 8818.823623527525, 8826.514541700204, 8828.161324674145, 8836.513991730451, 8621.267192288631, 8784.38509304349, 8800.251978581828, 8983.820323593523, 8990.865137022949, 8948.507832069266, 9017.323700722472, 9019.413738107001, 9023.819523609523, 9026.548672566378, 8909.910900891005, 8966.327525435554, 8983.921929368518, 8986.68546600869, 9005.234555062827, 8890.155435233642, 8991.910080899173, 8994.235489983359, 9011.828462299925, 9017.729468115967, 41911.7904410476, 42108.0, 42419.363709544385, 42538.36192457116, 42550.36174457386, 3551.254236610289, 3613.1509095362567, 3776.811159442017, 3887.688984881203, 4170.082581831992, 29371.11886643404, 29723.405531889457, 29778.70221297781, 32646.65255542634, 33335.49996750051, 3847.6729477994404, 3857.24783667185, 3865.884023479272, 4019.376996565537, 4034.616711412411, 324434.0, 324469.0, 328022.0, 329536.0, 330116.0, 60458.697706511186, 62680.686596566724, 62839.371606283356, 62846.37153628497, 62870.68564657147, 51734.22398664023, 57570.71214643984, 57844.0, 65525.0, 65960.34039659542, 16699.165041747863, 17185.828141718674, 17206.655866882593, 17238.0, 17273.222704978307, 12536.498540058477, 12630.0, 12729.936350318188, 12733.681657958625, 12735.535413427575, 16900.0, 18742.625147496972, 19169.61660766777, 19286.132124054453, 19379.51551211203, 7197.280271972761, 7226.385757210591, 7272.890906636405, 7282.380997615156, 7286.125664920243, 1023.3501726403787, 1115.4199816095586, 1139.4048332334798, 1153.4348169396935, 1159.9584730873555, 31901.52147717786, 33260.334793304, 33479.163020924185, 33503.664963350544, 33778.98774904096, 1190.7142285851507, 1243.3720970909633, 1251.2805137046234, 1295.1452041652465, 1305.8237137986441, 16928.830711692724, 17211.569710757332, 17302.307907683553, 17370.826291737172, 17519.211635476433, 484681.0, 491374.0, 492726.0, 502080.0, 504406.0, 58791.4120858786, 59605.70197149073, 59725.0, 59748.70125649431, 59844.401555984754, 1229.471327329239, 1386.923719195454, 1414.2151106136193, 1416.199847086393, 1424.6367176369959, 28781.0, 29877.10368688943, 30249.546256805726, 31407.685923140478, 32257.677423226407, 46908.7654561725, 46971.295430569255, 47263.0, 47264.32828060655, 47348.52651473579, 288829.0, 289558.0, 290955.0, 291099.0, 291304.0, 26955.595666064633, 27303.317417064733, 41329.0, 41642.167156657306, 42111.578884210765, 44212.0, 44826.327605086604, 45015.32477012913, 45604.0, 46754.29868552042, 36202.0, 36972.0, 37941.430878537394, 41517.0, 41651.166976660905, 41248.587514124476, 41317.0, 41424.1715165701, 41888.3716744243, 43129.784351078044, 42594.0, 43039.0, 43597.56402435935, 43991.56008440003, 44127.0, 37427.2514549702, 37945.81027094847, 38251.426228607146, 38352.80823595864, 39026.414603780395, 28732.239892318164, 29128.56307155352, 29266.122016339545, 29617.0, 29798.851005744833], "value": 20059.50886960024, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.9287881741878, 393.484535258811, 399.63034193371124, 405.6349285642923, 407.5537286671094, 14657.0, 18068.0, 18343.724844127348, 18653.81346186538, 18670.346537871177, 17964.82035179648, 18118.818811811878, 19033.90483047586, 19431.028448577585, 19672.606547869033, 5629.774809007645, 5773.711314434261, 5837.766489340443, 5838.970805145968, 5839.708014599253, 4065.024394145413, 5604.467575580314, 5782.306123265214, 5792.478676919077, 6106.3893610639025, 6336.84157896054, 6362.872742545146, 6378.840528986766, 6381.298057213703, 6382.297947225825, 6090.878182436327, 6256.124142620037, 6297.307296197415, 6324.778632747854, 6379.808605741812, 5533.446655334475, 5545.944540554583, 5555.805501817129, 5562.471565201299, 5623.634463759842, 22489.550208995894, 23369.766302336928, 23765.405864853343, 23792.40518987022, 23928.76071239283, 2305.089489651595, 2404.7715467030603, 2776.7917406194415, 3101.4943835917134, 3157.2264795125343, 9473.810523789485, 13409.263552998038, 14274.3576539056, 14706.632334191623, 14993.17537535435, 1901.4675890750611, 1962.9018549072632, 1967.2524440712439, 2001.3395579458743, 2054.476108592299, 80458.5977070111, 81796.0, 82626.0, 82859.0, 83047.58476207641, 10680.198985076151, 10748.516316765765, 10799.406032668121, 10937.398443085547, 10966.506507207196, 13679.316034198251, 14490.710185796435, 14899.70200595982, 14976.70046599062, 15189.392424302903, 8006.559639219899, 8026.518408895485, 8189.426740128134, 8213.589320534069, 8243.216894395024, 7682.96158519215, 7719.3052625264, 7779.611019449005, 7827.765167044998, 7963.0, 4509.751963641966, 4618.884527886763, 4676.859694209111, 4712.410948631421, 4744.905101897943, 1905.3045638341905, 1910.560571068634, 1944.5041514414017, 1953.5897461533236, 1958.412476257117, 874.7506960516222, 956.258899353007, 963.9518024098767, 1018.5212949913677, 1029.7785976015043, 19063.332783352795, 19670.40988770339, 19797.40607781769, 19809.900950495154, 19991.100400482013, 971.5385192033727, 974.8147851908257, 983.6606370802061, 1042.4527123260198, 1044.1438020823005, 10397.428141452292, 11056.557737690402, 11078.895009948084, 11146.777064458665, 11167.441627918572, 487856.0, 517129.0717732087, 532138.0, 542797.0, 545892.0, 93519.53240233756, 94108.0, 94859.52570237104, 95764.52117739506, 96460.51769741246, 992.0525897767759, 1011.9089281964658, 1015.0559979219249, 1028.1723212813608, 1041.796849614333, 16819.243134058754, 17043.488695339158, 17277.39529116475, 17408.0, 17680.11599419998, 37235.627643723215, 38441.80779096087, 38450.61549384471, 39493.2101357977, 40131.799341003105, 54252.0, 54931.725341373036, 55112.0, 55782.44217557772, 56137.43862561486, 8627.266682332072, 8676.305895528216, 8773.956130219309, 8787.824243515222, 8793.956030219808, 9623.663171788954, 12795.296258705861, 13127.146735462164, 13280.80078798838, 13622.93188534051, 11592.304461732323, 11741.236819606698, 11755.823662644896, 11938.701532461759, 12356.135070545335, 11674.357910315015, 11772.411379431165, 11785.762494938252, 11910.050665136036, 12019.278843269432, 11957.820632690342, 11982.460789264678, 12061.095417843871, 12186.329751863732, 12307.507699691912, 8643.82712345737, 8691.087435819149, 8700.0, 8802.075782042793, 8838.425502342327, 8981.730548083568, 11150.498227579616, 11553.480093395985, 11667.824982625098, 11758.0], "value": 9333.360153622878, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1379.7102608452224, 1502.4966636176885, 1539.415022291529, 1645.975310370344, 1803.269675781309, 7514.849703005943, 7839.137694853576, 7840.0, 7844.843103137934, 7854.764357069283, 7584.620768961544, 7747.264009919063, 7750.263724946121, 7752.108507521637, 7777.533347999124, 2020.4140799168224, 2048.1909645689943, 2193.824494040473, 2250.133698526071, 2273.4430064634107, 2281.361218858714, 2289.1530133850497, 2294.598445272079, 2298.310506847947, 2302.3323236261463, 2219.4673278413225, 2226.3543572364074, 2260.7174103237094, 2265.4676151104477, 2269.841111122222, 2014.4057503036565, 2200.878951657658, 2208.1388258579086, 2260.8643481391005, 2265.8413911026237, 2242.035924552442, 2251.358362866575, 2263.739669937962, 2272.6704627829035, 2278.293728944033, 7910.564918929456, 7928.524288542706, 7956.562389068599, 7972.920270797275, 8003.95998020012, 4867.586255168315, 4971.1549036663855, 5042.369703787027, 5049.368828896388, 5051.419086805027, 3122.266267427153, 3173.682631736831, 3177.6345720242007, 3202.903912882617, 3231.7091461768555, 1126.6845283320602, 1148.4717030166134, 1178.0575539568397, 1179.911506636997, 1200.6758175292623, 11184.105271578253, 11184.105271578253, 11249.943750281196, 11255.212135150543, 11264.605738799102, 4309.913801723948, 4354.042110735633, 4370.868873933787, 4472.753998530112, 4483.461984561874, 9660.420374777535, 9669.274804389699, 9686.854697179548, 9695.0, 9702.466364349888, 4995.150824359867, 5145.176771716508, 5148.407933087743, 5152.175651895679, 5153.587712982952, 4107.97946010274, 4617.0, 4723.0, 4732.100900828831, 4751.572358487683, 3753.0, 3820.6943444524372, 3836.36699944506, 3842.058695619591, 3922.8626998054933, 1241.6275117464725, 1250.1748845761754, 1267.2016629523525, 1271.205496564647, 1273.6497463197509, 893.6872094766779, 899.7525680437932, 935.8128374325162, 960.2030314838668, 975.7902051058915, 5582.162675598693, 5647.689377084218, 5653.462921022497, 5718.228039214736, 5734.16854556087, 941.8304705153001, 958.5399008475971, 985.2856678907877, 987.3138168972639, 1000.9249306302056, 3997.9400308995387, 4074.1647962167685, 4108.794560271975, 4124.6906482013965, 4154.169166166779, 9850.261230407748, 10142.290039697298, 10182.592696292213, 10298.17614590831, 10302.587896484207, 10058.14505767018, 10119.190464762949, 10219.0, 10223.7444063899, 10226.437545934896, 7544.849103017909, 7727.304542591081, 7768.689252429953, 7786.1824508426935, 7843.764687059512, 5785.56608254391, 5790.652560846363, 5804.709764511842, 5853.678047707247, 5874.853128671817, 9259.907400925904, 9297.767555811159, 9435.622575097193, 9473.147416732527, 9570.61717531291, 9442.10300021497, 9560.856587151338, 9671.226301895691, 9675.322727409013, 9692.951535242279, 6879.071325371011, 6924.446044316342, 7002.439804815501, 7064.32888875556, 7068.68190931399, 7723.884141737991, 7727.150013498398, 7756.108047574601, 7775.883361749691, 7784.766457006299, 6537.967310163419, 6697.732090716511, 6719.092922455406, 6734.057231987624, 6832.93167068323, 7126.572405655677, 7264.273572642905, 7264.418846492374, 7264.564126152448, 7304.890426643711, 6247.718852651551, 6327.493800496041, 6338.049292606146, 6338.873222535616, 6361.61830290184, 4701.388819453449, 4757.857264282077, 4763.190257656138, 4848.878778030577, 4941.43173535048, 4825.8069677213925, 4852.0, 4925.532074452921, 4953.727544984917, 4989.825356112518], "value": 4399.571137715927, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.61124937779977, 320.97753157279, 331.38528030503414, 331.83574130805255, 334.7874099946534, 5122.334096567451, 5178.145605975014, 5204.375474943012, 5213.608979326552, 5217.0, 4925.1627223372025, 5025.798968041274, 5046.022846520552, 5051.217061355495, 5119.744012799364, 3940.172563761599, 3980.9800950995277, 4079.8164082616204, 4095.8771236862794, 4139.979300103495, 4058.492688413948, 4082.4896887889013, 4105.158442519291, 4106.753594784308, 4109.815058322382, 3833.5208098987628, 3969.876116277792, 4020.5778393268724, 4090.5295890972475, 4108.137291168858, 3960.3465428204313, 3985.720999530034, 3990.8004599769897, 4019.778912159845, 4022.913813270415, 3521.9295614087573, 3529.876454324112, 3535.381308271042, 3535.840887160058, 3556.608773034964, 4839.7338146401935, 5011.32347133136, 5014.423341315759, 5017.197248440232, 5021.949780502185, 4543.0, 4572.291294849304, 4605.332226827091, 4605.953940460586, 4614.792334344963, 5347.866303342409, 5366.517013468768, 5370.462953704638, 5376.0, 5388.201318070751, 3871.399933010388, 3892.2365120764293, 3901.882943511699, 3910.863119790822, 3921.5490218624936, 5377.193420986844, 5551.9722401388135, 5581.49766521015, 5615.522680572116, 5616.691081990489, 3963.5243770747693, 3971.225611005826, 3980.7810570418324, 3990.1421194442755, 4002.0995276063236, 4007.719459637797, 4015.193163076627, 4033.9596604034173, 4034.798260086984, 4045.2718510667773, 4347.239233134189, 4582.358469814229, 4583.335416364608, 4590.403247577793, 4604.102200071021, 5408.891822163535, 5437.918431223535, 5442.972785136129, 5446.673199608036, 5496.31296087989, 1379.8409336157677, 1457.3514785920377, 1463.7950686903841, 1465.3845384938352, 1468.1631470061961, 1021.2391768132641, 1030.6753372687579, 1044.556063672936, 1045.8326667733127, 1054.667779649408, 5529.861753456195, 5546.611737178439, 5555.3333599967455, 5567.137093750475, 5607.046802043581, 5888.175655408247, 5893.233879595711, 5903.203067585907, 5913.137361731041, 5914.4381283777975, 5385.3268341457315, 5543.833684989457, 5561.944380556223, 5568.44315568448, 5580.972095139498, 3095.8761649534217, 3107.8912238071557, 3109.891153809606, 3127.1712996056062, 3133.435981523302, 5872.941270587325, 6050.213472248667, 6060.787872424444, 6074.301455332693, 6080.996635555084, 6021.969890150521, 6043.335233124353, 6049.818505444844, 6050.546209034252, 6052.878942421215, 6021.5182785377065, 6025.638461692312, 6042.425969532887, 6065.909011364833, 6067.089936509559, 5741.5406767459335, 5763.740631671669, 5840.1531777892815, 5848.152017957457, 5878.647281163144, 5780.190773291826, 5800.274965629296, 5839.299284085937, 5863.413658634103, 5877.794277200277, 5468.972655136698, 6079.452849243589, 6081.726322315595, 6104.786332478342, 6132.41742034506, 3900.2004589058606, 3907.1404291055924, 3924.3328634131694, 3927.448657780218, 3936.3111455495746, 5370.153818476214, 5614.915776263278, 5649.209110724584, 5657.971710141423, 5680.857978550569, 5303.681779093266, 5449.891002180014, 5456.208849716848, 5474.39781624029, 5498.340199176125, 5378.757955891916, 5388.08402571556, 5420.972895135499, 5453.918191227214, 5489.149181876815, 5114.4629813869005, 5263.605229607718, 5284.9735751320995, 5354.946450535601, 5360.65155764874, 5340.225667278145, 5404.8108316208745, 5420.430854760193, 5442.401335853132, 5448.83653490396, 5362.758675859518, 5366.973165134149, 5375.731213439391, 5390.434004429479, 5400.972995134999], "value": 4217.222961172318, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [663.6117871045439, 676.41828027896, 692.145200677164, 822.3339095332781, 828.9709860154894, 12990.935045324772, 13407.530736424227, 13420.530281440151, 13460.730785384287, 13477.39351729172, 12176.391180440987, 12336.691582710437, 12343.25940443574, 12387.318697471635, 12398.690032749186, 683.0744341417383, 822.6051495282268, 824.9133840946704, 827.1067247372823, 830.995845020774, 830.211299265697, 838.5388036579888, 839.6809212499242, 841.3311417423163, 841.5918279634373, 855.8887344645218, 856.3662889461784, 859.3984211052257, 860.4063196394468, 863.8704194370863, 710.7263703474148, 853.3429259470204, 856.0, 856.2251162697769, 879.2482427524438, 642.8489305013318, 643.488426700774, 643.6234802640414, 644.0532417346493, 644.2333622988629, 12641.620751377473, 12651.810222846665, 12695.301758403284, 12714.61856144317, 12735.55425560101, 11211.0, 11799.882001179963, 12392.070594705343, 12728.74542509154, 12786.808197877039, 10582.259241853073, 10656.307340022873, 10862.34825910448, 10877.67366978992, 11016.834747478793, 3619.8009109498967, 3623.547056617923, 3653.0867283179205, 3673.981630091859, 3690.5202323698018, 49533.0, 51163.232551511755, 51274.23088653673, 51373.22940155901, 52634.0, 9032.63869445215, 9424.528773561295, 9430.528473576294, 9590.520473976412, 9652.034796520433, 16016.199190040452, 16238.837611623969, 16257.51227463178, 16289.837101628833, 16316.75524867128, 7487.1764105948305, 7488.550686958691, 7560.9621951889885, 7588.354989825816, 7771.572563509061, 4045.0494133878515, 4229.217594744982, 4278.807453664593, 4297.226499230106, 4333.934990975138, 3015.909522714322, 3077.0768769369547, 3078.4612692779124, 3080.106769036954, 3090.134762266569, 523.9161734122522, 563.822395945276, 579.8173575323759, 588.6173986908458, 596.7911231069178, 633.2148136310941, 728.3699599846095, 736.8636802191612, 743.2121950732242, 777.4946284914738, 7324.340809327079, 7544.585047822313, 7641.503302285334, 7787.104482984416, 7891.053073631087, 673.6059405247985, 683.0846665468297, 689.6034780001519, 730.3098571849551, 758.4880205861022, 3787.5644300905747, 3852.9229415411537, 3857.7492462989817, 3952.4268980997595, 3980.960190398117, 64363.03455448172, 64754.35245647483, 66545.66727166333, 67791.66104169546, 68775.0, 56595.0, 57194.42805571974, 57526.0, 58822.411775881694, 59093.0, 52913.206301905506, 53080.46919530755, 53152.0, 53677.7316113417, 53907.0, 7753.379729621504, 7781.144074151725, 7801.687932482864, 7826.843463130819, 7897.526148431112, 32047.198820029687, 32283.51574726334, 32357.35285294234, 32423.351532969682, 32489.35021299608, 44042.0, 47114.0, 47169.52830471789, 47274.0, 48517.75741121272, 10018.448985305879, 10162.39025658463, 10188.388696678223, 10242.129418999171, 10412.68761937143, 9932.205423565953, 10276.691699249035, 10456.372617642966, 10818.783624327627, 10867.184961128105, 10142.137918276734, 10276.17790576737, 10314.793704126025, 10438.739031524272, 10534.262601617813, 9406.858897116412, 9866.013398660076, 10442.63450779219, 10531.736706582396, 11073.833892491459, 10124.34191777532, 10207.795844083224, 10212.08091271789, 10324.07083362501, 10580.523876425425, 9520.381175223589, 9742.123208911233, 9752.609895604097, 9755.268354873555, 9810.460424676712, 8858.867116993122, 8948.418352807046, 9109.362344636076, 9113.544322783702, 9373.531323433665], "value": 6222.5874459194765, "unit": "score"}], "name": "dromaeo_css", "value": 6946.768379493668, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 107.0, 113.0, 113.0, 115.0, 102.0, 113.0, 111.0, 113.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 129.0, 159.0, 179.0, 128.0, 156.0, 153.0, 135.0, 199.0, 127.0], "value": 151.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 161.0, 161.0, 163.0, 161.0, 162.0, 163.0, 162.0, 163.0, 164.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 121.0, 115.0, 78.0, 77.0, 74.0, 138.0, 102.0, 78.0], "value": 93.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 151.0, 92.0, 96.0, 94.0, 147.0, 92.0, 92.0, 147.0], "value": 109.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 119.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 96.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 57.0, 56.0, 58.0, 57.0, 59.0, 78.0, 63.0, 54.0], "value": 59.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 60.0, 61.0, 61.0, 62.0, 62.0, 62.0, 63.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 77.0, 77.0, 76.0, 78.0, 86.0, 85.0, 76.0, 77.0, 76.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 129.0, 132.0, 129.0, 126.0, 123.0, 121.0, 123.0, 158.0, 124.0], "value": 128.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 168.0, 171.0, 167.0, 175.0, 169.0, 164.0, 166.0, 166.0, 174.0], "value": 169.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 71.0, 70.0, 69.0, 68.0, 68.0, 70.0, 67.0, 68.0], "value": 68.9, "unit": "score"}], "name": "kraken", "value": 1554.1000000000001, "alertThreshold": 2.0}]} 13:39:22 INFO - Return code: 0 13:39:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:39:22 ERROR - # TBPL SUCCESS # 13:39:22 INFO - Running post-action listener: _resource_record_post_action 13:39:22 INFO - Running post-run listener: _resource_record_post_run 13:39:23 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 538390528; Read time: 12; Write time: 549836 13:39:23 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 210489344; Read time: 0; Write time: 317372 13:39:23 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293613568; Read time: 12; Write time: 224148 13:39:23 INFO - Running post-run listener: _upload_blobber_files 13:39:23 INFO - Blob upload gear active. 13:39:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:39:23 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:39:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:39:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:39:24 INFO - (blobuploader) - INFO - Open directory for files ... 13:39:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:39:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:39:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:39:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:39:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:39:24 INFO - (blobuploader) - INFO - Done attempting. 13:39:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:39:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:39:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:39:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:39:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:39:25 INFO - (blobuploader) - INFO - Done attempting. 13:39:25 INFO - (blobuploader) - INFO - Iteration through files over. 13:39:25 INFO - Return code: 0 13:39:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:39:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:39:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d474127d02e79567b7e77c3f941edc13c243d877af2130e8c1f4985fe51b82b0321fb74213c0e9103bc3b69fad2cd2bbca3bd58fc0c6cf31739f54753e90eaf0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6be7c0a686606e5ab257cc94b91b61b4bf5a8fcbd8315c96857d3a91b04eb69e1814b4156332098a398e048950eb5cea714713967dd68455d63383766ca5034e"} 13:39:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:39:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:39:25 INFO - Contents: 13:39:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d474127d02e79567b7e77c3f941edc13c243d877af2130e8c1f4985fe51b82b0321fb74213c0e9103bc3b69fad2cd2bbca3bd58fc0c6cf31739f54753e90eaf0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6be7c0a686606e5ab257cc94b91b61b4bf5a8fcbd8315c96857d3a91b04eb69e1814b4156332098a398e048950eb5cea714713967dd68455d63383766ca5034e"} 13:39:25 INFO - Running post-run listener: copy_logs_to_upload_dir 13:39:25 INFO - Copying logs to upload dir... 13:39:25 INFO - mkdir: /builds/slave/test/build/upload/logs 13:39:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.535293 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-04-25 13:39:25.752222) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 13:39:25.755487) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1461615260.516814-544619035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d474127d02e79567b7e77c3f941edc13c243d877af2130e8c1f4985fe51b82b0321fb74213c0e9103bc3b69fad2cd2bbca3bd58fc0c6cf31739f54753e90eaf0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6be7c0a686606e5ab257cc94b91b61b4bf5a8fcbd8315c96857d3a91b04eb69e1814b4156332098a398e048950eb5cea714713967dd68455d63383766ca5034e"} build_url:https://queue.taskcluster.net/v1/task/Si1evWxDRNefYw2S3rTRHA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011133 build_url: 'https://queue.taskcluster.net/v1/task/Si1evWxDRNefYw2S3rTRHA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d474127d02e79567b7e77c3f941edc13c243d877af2130e8c1f4985fe51b82b0321fb74213c0e9103bc3b69fad2cd2bbca3bd58fc0c6cf31739f54753e90eaf0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6be7c0a686606e5ab257cc94b91b61b4bf5a8fcbd8315c96857d3a91b04eb69e1814b4156332098a398e048950eb5cea714713967dd68455d63383766ca5034e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 13:39:25.780739) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:39:25.781233) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1461615260.516814-544619035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004457 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:39:25.863574) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 13:39:25.863975) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 13:39:25.864347) ========= ========= Total master_lag: 0.42 =========