builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1462711652.93 results: success (0) buildid: 20160508030214 builduid: ca7f59a48dfd4613a2d6e6db21fb44f8 revision: bae525a694e2dc0aa433885be8751330d4995a49 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-08 05:47:32.928624) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-08 05:47:32.929082) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-08 05:47:32.929453) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-08 05:47:32.993337) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-08 05:47:32.993610) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1462710340.399280-1014463292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-08 05:47:33-- 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% 40.6M=0s 2016-05-08 05:47:33 (40.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.202831 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-08 05:47:33.221181) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-08 05:47:33.221462) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1462710340.399280-1014463292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015531 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-08 05:47:33.275030) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-08 05:47:33.275346) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bae525a694e2dc0aa433885be8751330d4995a49 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev bae525a694e2dc0aa433885be8751330d4995a49 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1462710340.399280-1014463292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-08 05:47:33,378 truncating revision to first 12 chars 2016-05-08 05:47:33,378 Setting DEBUG logging. 2016-05-08 05:47:33,379 attempt 1/10 2016-05-08 05:47:33,379 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bae525a694e2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-08 05:47:33,649 unpacking tar archive at: mozilla-central-bae525a694e2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.557375 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-08 05:47:33.845005) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-08 05:47:33.845317) ========= script_repo_revision: bae525a694e2dc0aa433885be8751330d4995a49 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-08 05:47:33.845709) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-08 05:47:33.845976) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-08 05:47:33.860230) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-05-08 05:47:33.860494) ========= /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=edae0fb5fee9fb758e8af6d3000002a4-1462710340.399280-1014463292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:47:34 INFO - MultiFileLogger online at 20160508 05:47:34 in /builds/slave/test 05:47:34 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 05:47:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:47:34 INFO - {'append_to_log': False, 05:47:34 INFO - 'base_work_dir': '/builds/slave/test', 05:47:34 INFO - 'blob_upload_branch': 'Firefox', 05:47:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:47:34 INFO - 'branch': 'Firefox', 05:47:34 INFO - 'buildbot_json_path': 'buildprops.json', 05:47:34 INFO - 'config_files': ('talos/linux_config.py',), 05:47:34 INFO - 'default_actions': ('clobber', 05:47:34 INFO - 'read-buildbot-config', 05:47:34 INFO - 'download-and-extract', 05:47:34 INFO - 'populate-webroot', 05:47:34 INFO - 'create-virtualenv', 05:47:34 INFO - 'install', 05:47:34 INFO - 'run-tests'), 05:47:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:47:34 INFO - 'download_minidump_stackwalk': True, 05:47:34 INFO - 'download_symbols': 'ondemand', 05:47:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:47:34 INFO - 'tooltool.py': '/tools/tooltool.py', 05:47:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:47:34 INFO - '/tools/misc-python/virtualenv.py')}, 05:47:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:47:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:47:34 INFO - 'installer_path': 'installer.exe', 05:47:34 INFO - 'log_level': 'info', 05:47:34 INFO - 'log_name': 'talos', 05:47:34 INFO - 'log_to_console': True, 05:47:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:47:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:47:34 INFO - 'opt_config_files': (), 05:47:34 INFO - 'pip_index': False, 05:47:34 INFO - 'sps_profile': False, 05:47:34 INFO - 'sps_profile_interval': 0, 05:47:34 INFO - 'suite': 'dromaeojs', 05:47:34 INFO - 'system_bits': '32', 05:47:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:47:34 INFO - 'title': 'talos-linux64-ix-033', 05:47:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:47:34 INFO - 'use_talos_json': True, 05:47:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:47:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:47:34 INFO - 'work_dir': 'build'} 05:47:34 INFO - ##### 05:47:34 INFO - ##### Running clobber step. 05:47:34 INFO - ##### 05:47:34 INFO - Running pre-action listener: _resource_record_pre_action 05:47:34 INFO - Running main action method: clobber 05:47:34 INFO - rmtree: /builds/slave/test/build 05:47:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:47:34 INFO - Running post-action listener: _resource_record_post_action 05:47:34 INFO - ##### 05:47:34 INFO - ##### Finished clobber step (success) 05:47:34 INFO - ##### 05:47:34 INFO - ##### 05:47:34 INFO - ##### Running read-buildbot-config step. 05:47:34 INFO - ##### 05:47:34 INFO - Running pre-action listener: _resource_record_pre_action 05:47:34 INFO - Running main action method: read_buildbot_config 05:47:34 INFO - Using buildbot properties: 05:47:34 INFO - { 05:47:34 INFO - "project": "", 05:47:34 INFO - "product": "firefox", 05:47:34 INFO - "script_repo_revision": "production", 05:47:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:47:34 INFO - "repository": "", 05:47:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:47:34 INFO - "buildid": "20160508030214", 05:47:34 INFO - "stage_platform": "linux64-pgo", 05:47:34 INFO - "basedir": "/builds/slave/test", 05:47:34 INFO - "nightly_build": "True", 05:47:34 INFO - "buildnumber": 436, 05:47:34 INFO - "slavename": "talos-linux64-ix-033", 05:47:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:47:34 INFO - "platform": "ubuntu64_hw", 05:47:34 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:47:34 INFO - "branch": "mozilla-central", 05:47:34 INFO - "repo_path": "mozilla-central", 05:47:34 INFO - "revision": "bae525a694e2dc0aa433885be8751330d4995a49", 05:47:34 INFO - "pgo_build": "True", 05:47:34 INFO - "builduid": "ca7f59a48dfd4613a2d6e6db21fb44f8", 05:47:34 INFO - "slavebuilddir": "test" 05:47:34 INFO - } 05:47:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/a9hi30nWQ0abDN1Kue7smQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:47:34 INFO - Running post-action listener: _resource_record_post_action 05:47:34 INFO - ##### 05:47:34 INFO - ##### Finished read-buildbot-config step (success) 05:47:34 INFO - ##### 05:47:34 INFO - ##### 05:47:34 INFO - ##### Running download-and-extract step. 05:47:34 INFO - ##### 05:47:34 INFO - Running pre-action listener: _resource_record_pre_action 05:47:34 INFO - Running main action method: download_and_extract 05:47:34 INFO - mkdir: /builds/slave/test/build/tests 05:47:34 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')]} 05:47:34 INFO - https://queue.taskcluster.net/v1/task/a9hi30nWQ0abDN1Kue7smQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:47:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9hi30nWQ0abDN1Kue7smQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:47:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9hi30nWQ0abDN1Kue7smQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:47:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9hi30nWQ0abDN1Kue7smQ/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 05:47:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9hi30nWQ0abDN1Kue7smQ/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 05:47:44 INFO - Downloaded 1361 bytes. 05:47:44 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:47:44 INFO - Using the following test package requirements: 05:47:44 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:47:44 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:47:44 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:47:44 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:44 INFO - u'jsshell-linux-x86_64.zip'], 05:47:44 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:47:44 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:47:44 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:47:44 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:47:44 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:47:44 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:47:44 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:47: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')]} 05:47:44 INFO - https://queue.taskcluster.net/v1/task/a9hi30nWQ0abDN1Kue7smQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:47:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9hi30nWQ0abDN1Kue7smQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:47:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9hi30nWQ0abDN1Kue7smQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:47:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9hi30nWQ0abDN1Kue7smQ/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 05:47:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9hi30nWQ0abDN1Kue7smQ/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 05:47:50 INFO - Downloaded 23894038 bytes. 05:47:50 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'] 05:47:50 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 05:47:51 INFO - Return code: 0 05:47:51 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 05:47:51 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')]} 05:47:51 INFO - https://queue.taskcluster.net/v1/task/a9hi30nWQ0abDN1Kue7smQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:47:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9hi30nWQ0abDN1Kue7smQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:47:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9hi30nWQ0abDN1Kue7smQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:47:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9hi30nWQ0abDN1Kue7smQ/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 05:47:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9hi30nWQ0abDN1Kue7smQ/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 05:47:53 INFO - Downloaded 23894038 bytes. 05:47:53 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'] 05:47:53 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 05:47:55 INFO - Return code: 0 05:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:55 INFO - https://queue.taskcluster.net/v1/task/a9hi30nWQ0abDN1Kue7smQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:47:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9hi30nWQ0abDN1Kue7smQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:47:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9hi30nWQ0abDN1Kue7smQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:47:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9hi30nWQ0abDN1Kue7smQ/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 05:47:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9hi30nWQ0abDN1Kue7smQ/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 05:47:56 INFO - Downloaded 10840152 bytes. 05:47:56 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'] 05:47:56 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 05:47:57 INFO - Return code: 0 05:47:57 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')]} 05:47:57 INFO - https://queue.taskcluster.net/v1/task/a9hi30nWQ0abDN1Kue7smQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:47:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9hi30nWQ0abDN1Kue7smQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:47:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9hi30nWQ0abDN1Kue7smQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:47:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9hi30nWQ0abDN1Kue7smQ/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 05:47:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9hi30nWQ0abDN1Kue7smQ/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 05:47:59 INFO - Downloaded 58413969 bytes. 05:47:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a9hi30nWQ0abDN1Kue7smQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:47:59 INFO - mkdir: /builds/slave/test/properties 05:47:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:47:59 INFO - Writing to file /builds/slave/test/properties/build_url 05:47:59 INFO - Contents: 05:47:59 INFO - build_url:https://queue.taskcluster.net/v1/task/a9hi30nWQ0abDN1Kue7smQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:48:00 INFO - Running post-action listener: _resource_record_post_action 05:48:00 INFO - Running post-action listener: set_extra_try_arguments 05:48:00 INFO - ##### 05:48:00 INFO - ##### Finished download-and-extract step (success) 05:48:00 INFO - ##### 05:48:00 INFO - ##### 05:48:00 INFO - ##### Running populate-webroot step. 05:48:00 INFO - ##### 05:48:00 INFO - Running pre-action listener: _resource_record_pre_action 05:48:00 INFO - Running main action method: populate_webroot 05:48:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:48:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:48:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:48:00 INFO - '--tppagecycles', 05:48:00 INFO - '7'], 05:48:00 INFO - 'tests': ['tsvgm']}}, 05:48:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:48:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:48:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:48:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:48:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:48:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:48:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:00 INFO - 'talos_options': ['--disable-e10s'], 05:48:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:48:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:48:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:00 INFO - 'talos_options': ['--disable-e10s'], 05:48:00 INFO - 'tests': ['damp', 'tps']}, 05:48:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:00 INFO - 'tests': ['damp', 'tps']}, 05:48:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:48:00 INFO - 'tests': ['dromaeo_dom']}, 05:48:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:48:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:48:00 INFO - 'tests': ['a11yr', 05:48:00 INFO - 'ts_paint', 05:48:00 INFO - 'tpaint', 05:48:00 INFO - 'sessionrestore', 05:48:00 INFO - 'sessionrestore_no_auto_restore', 05:48:00 INFO - 'tabpaint']}, 05:48:00 INFO - 'other-e10s': {'tests': ['a11yr', 05:48:00 INFO - 'ts_paint', 05:48:00 INFO - 'tpaint', 05:48:00 INFO - 'sessionrestore', 05:48:00 INFO - 'sessionrestore_no_auto_restore', 05:48:00 INFO - 'tabpaint']}, 05:48:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:48:00 INFO - 'ts_paint', 05:48:00 INFO - 'tpaint', 05:48:00 INFO - 'sessionrestore', 05:48:00 INFO - 'sessionrestore_no_auto_restore', 05:48:00 INFO - 'tabpaint']}, 05:48:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:48:00 INFO - 'ts_paint', 05:48:00 INFO - 'tpaint', 05:48:00 INFO - 'sessionrestore', 05:48:00 INFO - 'sessionrestore_no_auto_restore', 05:48:00 INFO - 'tabpaint']}, 05:48:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:48:00 INFO - 'tests': ['a11yr', 05:48:00 INFO - 'ts_paint', 05:48:00 INFO - 'tpaint', 05:48:00 INFO - 'sessionrestore', 05:48:00 INFO - 'sessionrestore_no_auto_restore', 05:48:00 INFO - 'tabpaint']}, 05:48:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:48:00 INFO - 'tests': ['a11yr', 05:48:00 INFO - 'ts_paint', 05:48:00 INFO - 'tpaint', 05:48:00 INFO - 'sessionrestore', 05:48:00 INFO - 'sessionrestore_no_auto_restore', 05:48:00 INFO - 'tabpaint']}, 05:48:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:48:00 INFO - 'tests': ['tsvgx', 05:48:00 INFO - 'tsvgr_opacity', 05:48:00 INFO - 'tart', 05:48:00 INFO - 'tscrollx', 05:48:00 INFO - 'cart']}, 05:48:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:48:00 INFO - 'tsvgr_opacity', 05:48:00 INFO - 'tart', 05:48:00 INFO - 'tscrollx', 05:48:00 INFO - 'cart']}, 05:48:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:00 INFO - 'talos_options': ['--disable-e10s'], 05:48:00 INFO - 'tests': ['tp5o']}, 05:48:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:00 INFO - 'tests': ['tp5o']}, 05:48:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:00 INFO - 'talos_options': ['--disable-e10s', 05:48:00 INFO - '--xperf_path', 05:48:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:48:00 INFO - 'tests': ['tp5n']}, 05:48:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:00 INFO - 'talos_options': ['--xperf_path', 05:48:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:48:00 INFO - 'tests': ['tp5n']}}, 05:48:00 INFO - 'talos.zip': {'path': '', 05:48:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:48:00 INFO - Running post-action listener: _resource_record_post_action 05:48:00 INFO - ##### 05:48:00 INFO - ##### Finished populate-webroot step (success) 05:48:00 INFO - ##### 05:48:00 INFO - ##### 05:48:00 INFO - ##### Running create-virtualenv step. 05:48:00 INFO - ##### 05:48:00 INFO - Running pre-action listener: _resource_record_pre_action 05:48:00 INFO - Running main action method: create_virtualenv 05:48:00 INFO - Creating virtualenv /builds/slave/test/build/venv 05:48:00 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 05:48:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:48:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:48:00 INFO - Using real prefix '/usr' 05:48:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:48:00 INFO - Installing distribute.............................................................................................................................................................................................done. 05:48:02 INFO - Installing pip.................done. 05:48:02 INFO - Return code: 0 05:48:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:48: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')]} 05:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48: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')]} 05:48:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:02 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 0x7faff4061f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ca770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a599c0>, '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 0x2a5a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5ad50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462710340.399280-1014463292', '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 05:48:02 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 05:48:02 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 05:48:02 INFO - Using env: {'DISPLAY': ':0', 05:48:02 INFO - 'HOME': '/home/cltbld', 05:48:02 INFO - 'LANG': 'en_US.UTF-8', 05:48:02 INFO - 'LANGUAGE': 'en_US:en', 05:48:02 INFO - 'LOGNAME': 'cltbld', 05:48:02 INFO - 'MAIL': '/var/mail/cltbld', 05:48:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:02 INFO - 'MOZ_NO_REMOTE': '1', 05:48:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:02 INFO - 'NO_EM_RESTART': '1', 05:48:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:02 INFO - 'PWD': '/builds/slave/test', 05:48:02 INFO - 'SHELL': '/bin/bash', 05:48:02 INFO - 'SHLVL': '1', 05:48:02 INFO - 'TERM': 'linux', 05:48:02 INFO - 'TMOUT': '86400', 05:48:02 INFO - 'USER': 'cltbld', 05:48:02 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462710340.399280-1014463292', 05:48:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:02 INFO - '_': '/tools/buildbot/bin/python'} 05:48:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:03 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 05:48:03 INFO - Cleaning up... 05:48:03 INFO - Return code: 0 05:48:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:03 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 0x7faff4061f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ca770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a599c0>, '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 0x2a5a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5ad50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462710340.399280-1014463292', '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 05:48:03 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 05:48:03 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 05:48:03 INFO - Using env: {'DISPLAY': ':0', 05:48:03 INFO - 'HOME': '/home/cltbld', 05:48:03 INFO - 'LANG': 'en_US.UTF-8', 05:48:03 INFO - 'LANGUAGE': 'en_US:en', 05:48:03 INFO - 'LOGNAME': 'cltbld', 05:48:03 INFO - 'MAIL': '/var/mail/cltbld', 05:48:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:03 INFO - 'MOZ_NO_REMOTE': '1', 05:48:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:03 INFO - 'NO_EM_RESTART': '1', 05:48:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:03 INFO - 'PWD': '/builds/slave/test', 05:48:03 INFO - 'SHELL': '/bin/bash', 05:48:03 INFO - 'SHLVL': '1', 05:48:03 INFO - 'TERM': 'linux', 05:48:03 INFO - 'TMOUT': '86400', 05:48:03 INFO - 'USER': 'cltbld', 05:48:03 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462710340.399280-1014463292', 05:48:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:03 INFO - '_': '/tools/buildbot/bin/python'} 05:48:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:03 INFO - Downloading/unpacking psutil>=0.7.1 05:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:48:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:48:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:48:05 INFO - Installing collected packages: psutil 05:48:05 INFO - Running setup.py install for psutil 05:48:05 INFO - building 'psutil._psutil_linux' extension 05:48:05 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 05:48:05 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 05:48:05 INFO - building 'psutil._psutil_posix' extension 05:48:05 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 05:48:05 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 05:48:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:48:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:48:05 INFO - Successfully installed psutil 05:48:05 INFO - Cleaning up... 05:48:05 INFO - Return code: 0 05:48:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:48:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7faff4061f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ca770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a599c0>, '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 0x2a5a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5ad50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462710340.399280-1014463292', '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 05:48:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:48:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:48:05 INFO - Using env: {'DISPLAY': ':0', 05:48:05 INFO - 'HOME': '/home/cltbld', 05:48:05 INFO - 'LANG': 'en_US.UTF-8', 05:48:05 INFO - 'LANGUAGE': 'en_US:en', 05:48:05 INFO - 'LOGNAME': 'cltbld', 05:48:05 INFO - 'MAIL': '/var/mail/cltbld', 05:48:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:05 INFO - 'MOZ_NO_REMOTE': '1', 05:48:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:05 INFO - 'NO_EM_RESTART': '1', 05:48:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:05 INFO - 'PWD': '/builds/slave/test', 05:48:05 INFO - 'SHELL': '/bin/bash', 05:48:05 INFO - 'SHLVL': '1', 05:48:05 INFO - 'TERM': 'linux', 05:48:05 INFO - 'TMOUT': '86400', 05:48:05 INFO - 'USER': 'cltbld', 05:48:05 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462710340.399280-1014463292', 05:48:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:05 INFO - '_': '/tools/buildbot/bin/python'} 05:48:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:48:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:48:07 INFO - Installing collected packages: mozsystemmonitor 05:48:07 INFO - Running setup.py install for mozsystemmonitor 05:48:08 INFO - Successfully installed mozsystemmonitor 05:48:08 INFO - Cleaning up... 05:48:08 INFO - Return code: 0 05:48:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:48:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7faff4061f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ca770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a599c0>, '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 0x2a5a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5ad50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462710340.399280-1014463292', '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 05:48:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:48:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:48:08 INFO - Using env: {'DISPLAY': ':0', 05:48:08 INFO - 'HOME': '/home/cltbld', 05:48:08 INFO - 'LANG': 'en_US.UTF-8', 05:48:08 INFO - 'LANGUAGE': 'en_US:en', 05:48:08 INFO - 'LOGNAME': 'cltbld', 05:48:08 INFO - 'MAIL': '/var/mail/cltbld', 05:48:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:08 INFO - 'MOZ_NO_REMOTE': '1', 05:48:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:08 INFO - 'NO_EM_RESTART': '1', 05:48:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:08 INFO - 'PWD': '/builds/slave/test', 05:48:08 INFO - 'SHELL': '/bin/bash', 05:48:08 INFO - 'SHLVL': '1', 05:48:08 INFO - 'TERM': 'linux', 05:48:08 INFO - 'TMOUT': '86400', 05:48:08 INFO - 'USER': 'cltbld', 05:48:08 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462710340.399280-1014463292', 05:48:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:08 INFO - '_': '/tools/buildbot/bin/python'} 05:48:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:08 INFO - Downloading/unpacking blobuploader==1.2.4 05:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:10 INFO - Downloading blobuploader-1.2.4.tar.gz 05:48:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:48:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:48:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48:10 INFO - Downloading docopt-0.6.1.tar.gz 05:48:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:48:11 INFO - Installing collected packages: blobuploader, requests, docopt 05:48:11 INFO - Running setup.py install for blobuploader 05:48:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:48:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:48:11 INFO - Running setup.py install for requests 05:48:11 INFO - Running setup.py install for docopt 05:48:11 INFO - Successfully installed blobuploader requests docopt 05:48:11 INFO - Cleaning up... 05:48:11 INFO - Return code: 0 05:48:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:48:11 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')]} 05:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:11 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')]} 05:48:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:11 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 0x7faff4061f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ca770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a599c0>, '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 0x2a5a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5ad50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462710340.399280-1014463292', '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 05:48:11 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 05:48:11 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 05:48:11 INFO - Using env: {'DISPLAY': ':0', 05:48:11 INFO - 'HOME': '/home/cltbld', 05:48:11 INFO - 'LANG': 'en_US.UTF-8', 05:48:11 INFO - 'LANGUAGE': 'en_US:en', 05:48:11 INFO - 'LOGNAME': 'cltbld', 05:48:11 INFO - 'MAIL': '/var/mail/cltbld', 05:48:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:11 INFO - 'MOZ_NO_REMOTE': '1', 05:48:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:11 INFO - 'NO_EM_RESTART': '1', 05:48:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:11 INFO - 'PWD': '/builds/slave/test', 05:48:11 INFO - 'SHELL': '/bin/bash', 05:48:11 INFO - 'SHLVL': '1', 05:48:11 INFO - 'TERM': 'linux', 05:48:11 INFO - 'TMOUT': '86400', 05:48:11 INFO - 'USER': 'cltbld', 05:48:11 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462710340.399280-1014463292', 05:48:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:11 INFO - '_': '/tools/buildbot/bin/python'} 05:48:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:48:11 INFO - Running setup.py (path:/tmp/pip-dD6ffw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:48:11 INFO - Running setup.py (path:/tmp/pip-s0GlKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:48:11 INFO - Running setup.py (path:/tmp/pip-En5ik2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:48:12 INFO - Running setup.py (path:/tmp/pip-pyH1Bi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:48:12 INFO - Running setup.py (path:/tmp/pip-rT2B5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:48:12 INFO - Running setup.py (path:/tmp/pip-Exg8C2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:48:12 INFO - Running setup.py (path:/tmp/pip-qTpI6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:48:12 INFO - Running setup.py (path:/tmp/pip-qNlMuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:48:12 INFO - Running setup.py (path:/tmp/pip-MDYP6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:48:12 INFO - Running setup.py (path:/tmp/pip-Krg4_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:48:12 INFO - Running setup.py (path:/tmp/pip-8WOJ1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:48:12 INFO - Running setup.py (path:/tmp/pip-mnEmCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:48:12 INFO - Running setup.py (path:/tmp/pip-LZehzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:48:12 INFO - Running setup.py (path:/tmp/pip-mJZjsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:48:12 INFO - Running setup.py (path:/tmp/pip-rPr9Bx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:48:12 INFO - Running setup.py (path:/tmp/pip-WeXgOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:48:12 INFO - Running setup.py (path:/tmp/pip-lO9lBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:48:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:48:13 INFO - Running setup.py install for manifestparser 05:48:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:48:13 INFO - Running setup.py install for mozcrash 05:48:13 INFO - Running setup.py install for mozdebug 05:48:13 INFO - Running setup.py install for mozdevice 05:48:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:48:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:48:13 INFO - Running setup.py install for mozfile 05:48:13 INFO - Running setup.py install for mozhttpd 05:48:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:48:13 INFO - Running setup.py install for mozinfo 05:48:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:48:13 INFO - Running setup.py install for mozInstall 05:48:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:48:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:48:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:48:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:48:13 INFO - Running setup.py install for mozleak 05:48:13 INFO - Running setup.py install for mozlog 05:48:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:48:14 INFO - Running setup.py install for moznetwork 05:48:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:48:14 INFO - Running setup.py install for mozprocess 05:48:14 INFO - Running setup.py install for mozprofile 05:48:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:48:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:48:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:48:14 INFO - Running setup.py install for mozrunner 05:48:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:48:14 INFO - Running setup.py install for mozscreenshot 05:48:14 INFO - Running setup.py install for moztest 05:48:14 INFO - Running setup.py install for mozversion 05:48:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:48:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:48:14 INFO - Cleaning up... 05:48:14 INFO - Return code: 0 05:48:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:48: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')]} 05:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48: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')]} 05:48:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:14 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 0x7faff4061f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ca770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a599c0>, '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 0x2a5a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5ad50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462710340.399280-1014463292', '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 05:48:14 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 05:48:14 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 05:48:14 INFO - Using env: {'DISPLAY': ':0', 05:48:14 INFO - 'HOME': '/home/cltbld', 05:48:14 INFO - 'LANG': 'en_US.UTF-8', 05:48:14 INFO - 'LANGUAGE': 'en_US:en', 05:48:14 INFO - 'LOGNAME': 'cltbld', 05:48:14 INFO - 'MAIL': '/var/mail/cltbld', 05:48:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:14 INFO - 'MOZ_NO_REMOTE': '1', 05:48:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:14 INFO - 'NO_EM_RESTART': '1', 05:48:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:14 INFO - 'PWD': '/builds/slave/test', 05:48:14 INFO - 'SHELL': '/bin/bash', 05:48:14 INFO - 'SHLVL': '1', 05:48:14 INFO - 'TERM': 'linux', 05:48:14 INFO - 'TMOUT': '86400', 05:48:14 INFO - 'USER': 'cltbld', 05:48:14 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462710340.399280-1014463292', 05:48:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:14 INFO - '_': '/tools/buildbot/bin/python'} 05:48:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:48:15 INFO - Running setup.py (path:/tmp/pip-nxQZwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:48:15 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)) 05:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:48:15 INFO - Running setup.py (path:/tmp/pip-Ns27Oj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:48:15 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)) 05:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:48:15 INFO - Running setup.py (path:/tmp/pip-kUmngi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:48:15 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)) 05:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:48:15 INFO - Running setup.py (path:/tmp/pip-VWcNST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:48:15 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)) 05:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:48:15 INFO - Running setup.py (path:/tmp/pip-i5E62_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:48:15 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)) 05:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:48:15 INFO - Running setup.py (path:/tmp/pip-sYCibd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:48:15 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)) 05:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:48:15 INFO - Running setup.py (path:/tmp/pip-UUUooj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:48:15 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)) 05:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:48:15 INFO - Running setup.py (path:/tmp/pip-mlLUG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:48:15 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)) 05:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:48:15 INFO - Running setup.py (path:/tmp/pip-XXKugV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:48:15 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)) 05:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:48:15 INFO - Running setup.py (path:/tmp/pip-BH8yHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:48:15 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)) 05:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:48:15 INFO - Running setup.py (path:/tmp/pip-z9KkUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:48:15 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)) 05:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:48:15 INFO - Running setup.py (path:/tmp/pip-KwDXB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:48:15 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)) 05:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:48:15 INFO - Running setup.py (path:/tmp/pip-K7731o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:48:15 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)) 05:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:48:15 INFO - Running setup.py (path:/tmp/pip-dSvX8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:48:16 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)) 05:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:48:16 INFO - Running setup.py (path:/tmp/pip-cATCng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:48:16 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)) 05:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:48:16 INFO - Running setup.py (path:/tmp/pip-OIG43e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:48:16 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)) 05:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:48:16 INFO - Running setup.py (path:/tmp/pip-_hGgR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:48:16 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)) 05:48:16 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)) 05:48:16 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)) 05:48:16 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)) 05:48:16 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)) 05:48:16 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)) 05:48:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:48:16 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 05:48:16 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 05:48:16 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 05:48:16 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 05:48:16 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 05:48:16 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 05:48:18 INFO - Downloading blessings-1.6.tar.gz 05:48:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:48:18 INFO - Installing collected packages: blessings 05:48:18 INFO - Running setup.py install for blessings 05:48:18 INFO - Successfully installed blessings 05:48:18 INFO - Cleaning up... 05:48:18 INFO - Return code: 0 05:48:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:48:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:48:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:48:18 INFO - Reading from file tmpfile_stdout 05:48:18 INFO - Current package versions: 05:48:18 INFO - argparse == 1.2.1 05:48:18 INFO - blessings == 1.6 05:48:18 INFO - blobuploader == 1.2.4 05:48:18 INFO - docopt == 0.6.1 05:48:18 INFO - manifestparser == 1.1 05:48:18 INFO - mozInstall == 1.12 05:48:18 INFO - mozcrash == 0.17 05:48:18 INFO - mozdebug == 0.1 05:48:18 INFO - mozdevice == 0.48 05:48:18 INFO - mozfile == 1.2 05:48:18 INFO - mozhttpd == 0.7 05:48:18 INFO - mozinfo == 0.9 05:48:18 INFO - mozleak == 0.1 05:48:18 INFO - mozlog == 3.1 05:48:18 INFO - moznetwork == 0.27 05:48:18 INFO - mozprocess == 0.22 05:48:18 INFO - mozprofile == 0.28 05:48:18 INFO - mozrunner == 6.11 05:48:18 INFO - mozscreenshot == 0.1 05:48:18 INFO - mozsystemmonitor == 0.0 05:48:18 INFO - moztest == 0.7 05:48:18 INFO - mozversion == 1.4 05:48:18 INFO - psutil == 3.1.1 05:48:18 INFO - requests == 1.2.3 05:48:18 INFO - wsgiref == 0.1.2 05:48:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:48: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')]} 05:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48: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')]} 05:48:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:18 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 0x7faff4061f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ca770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a599c0>, '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 0x2a5a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5ad50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462710340.399280-1014463292', '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 05:48:18 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 05:48:18 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 05:48:18 INFO - Using env: {'DISPLAY': ':0', 05:48:18 INFO - 'HOME': '/home/cltbld', 05:48:18 INFO - 'LANG': 'en_US.UTF-8', 05:48:18 INFO - 'LANGUAGE': 'en_US:en', 05:48:18 INFO - 'LOGNAME': 'cltbld', 05:48:18 INFO - 'MAIL': '/var/mail/cltbld', 05:48:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:18 INFO - 'MOZ_NO_REMOTE': '1', 05:48:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:18 INFO - 'NO_EM_RESTART': '1', 05:48:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:18 INFO - 'PWD': '/builds/slave/test', 05:48:18 INFO - 'SHELL': '/bin/bash', 05:48:18 INFO - 'SHLVL': '1', 05:48:18 INFO - 'TERM': 'linux', 05:48:18 INFO - 'TMOUT': '86400', 05:48:18 INFO - 'USER': 'cltbld', 05:48:18 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462710340.399280-1014463292', 05:48:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:18 INFO - '_': '/tools/buildbot/bin/python'} 05:48:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:18 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)) 05:48:18 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)) 05:48:18 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)) 05:48:18 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)) 05:48:18 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)) 05:48:18 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)) 05:48:18 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)) 05:48:18 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)) 05:48:18 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)) 05:48:18 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)) 05:48:18 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)) 05:48:18 INFO - Cleaning up... 05:48:18 INFO - Return code: 0 05:48:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:48: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')]} 05:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48: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')]} 05:48:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:18 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 0x7faff4061f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ca770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a599c0>, '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 0x2a5a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5ad50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462710340.399280-1014463292', '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 05:48:18 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 05:48:18 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 05:48:18 INFO - Using env: {'DISPLAY': ':0', 05:48:18 INFO - 'HOME': '/home/cltbld', 05:48:18 INFO - 'LANG': 'en_US.UTF-8', 05:48:18 INFO - 'LANGUAGE': 'en_US:en', 05:48:18 INFO - 'LOGNAME': 'cltbld', 05:48:18 INFO - 'MAIL': '/var/mail/cltbld', 05:48:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:18 INFO - 'MOZ_NO_REMOTE': '1', 05:48:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:18 INFO - 'NO_EM_RESTART': '1', 05:48:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:18 INFO - 'PWD': '/builds/slave/test', 05:48:18 INFO - 'SHELL': '/bin/bash', 05:48:18 INFO - 'SHLVL': '1', 05:48:18 INFO - 'TERM': 'linux', 05:48:18 INFO - 'TMOUT': '86400', 05:48:18 INFO - 'USER': 'cltbld', 05:48:18 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462710340.399280-1014463292', 05:48:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:18 INFO - '_': '/tools/buildbot/bin/python'} 05:48:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:19 INFO - Downloading/unpacking jsonschema 05:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:48:20 INFO - Downloading/unpacking functools32 (from jsonschema) 05:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:21 INFO - Downloading functools32-3.2.3-2.tar.gz 05:48:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:48:21 INFO - warning: no files found matching '*.txt' 05:48:21 INFO - no previously-included directories found matching 'build' 05:48:21 INFO - no previously-included directories found matching 'dist' 05:48:21 INFO - no previously-included directories found matching '.git*' 05:48:21 INFO - Installing collected packages: jsonschema, functools32 05:48:21 INFO - Running setup.py install for functools32 05:48:21 INFO - warning: no files found matching '*.txt' 05:48:21 INFO - no previously-included directories found matching 'build' 05:48:21 INFO - no previously-included directories found matching 'dist' 05:48:21 INFO - no previously-included directories found matching '.git*' 05:48:21 INFO - Successfully installed jsonschema functools32 05:48:21 INFO - Cleaning up... 05:48:21 INFO - Return code: 0 05:48:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:48: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')]} 05:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48: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')]} 05:48:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:21 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 0x7faff4061f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ca770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a599c0>, '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 0x2a5a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5ad50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462710340.399280-1014463292', '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 05:48:21 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 05:48:21 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 05:48:21 INFO - Using env: {'DISPLAY': ':0', 05:48:21 INFO - 'HOME': '/home/cltbld', 05:48:21 INFO - 'LANG': 'en_US.UTF-8', 05:48:21 INFO - 'LANGUAGE': 'en_US:en', 05:48:21 INFO - 'LOGNAME': 'cltbld', 05:48:21 INFO - 'MAIL': '/var/mail/cltbld', 05:48:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:21 INFO - 'MOZ_NO_REMOTE': '1', 05:48:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:21 INFO - 'NO_EM_RESTART': '1', 05:48:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:21 INFO - 'PWD': '/builds/slave/test', 05:48:21 INFO - 'SHELL': '/bin/bash', 05:48:21 INFO - 'SHLVL': '1', 05:48:21 INFO - 'TERM': 'linux', 05:48:21 INFO - 'TMOUT': '86400', 05:48:21 INFO - 'USER': 'cltbld', 05:48:21 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462710340.399280-1014463292', 05:48:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:21 INFO - '_': '/tools/buildbot/bin/python'} 05:48:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:21 INFO - Downloading/unpacking flake8 05:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:48:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:48:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:48:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:48:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:48:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:48:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:48:24 INFO - no previously-included directories found matching 'docs/_build' 05:48:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:48:24 INFO - Running setup.py install for pep8 05:48:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:48:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:48:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:48:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:48:24 INFO - no previously-included directories found matching 'docs/_build' 05:48:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:48:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:48:24 INFO - Cleaning up... 05:48:24 INFO - Return code: 0 05:48:24 INFO - Running post-action listener: _resource_record_post_action 05:48:24 INFO - Running post-action listener: _start_resource_monitoring 05:48:24 INFO - Starting resource monitoring. 05:48:24 INFO - ##### 05:48:24 INFO - ##### Finished create-virtualenv step (success) 05:48:24 INFO - ##### 05:48:24 INFO - ##### 05:48:24 INFO - ##### Running install step. 05:48:24 INFO - ##### 05:48:24 INFO - Running pre-action listener: _resource_record_pre_action 05:48:24 INFO - Running main action method: install 05:48:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:48:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:48:24 INFO - Reading from file tmpfile_stdout 05:48:24 INFO - Detecting whether we're running mozinstall >=1.0... 05:48:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:48:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:48:24 INFO - Reading from file tmpfile_stdout 05:48:24 INFO - Output received: 05:48:24 INFO - Usage: mozinstall [options] installer 05:48:24 INFO - Options: 05:48:24 INFO - -h, --help show this help message and exit 05:48:24 INFO - -d DEST, --destination=DEST 05:48:24 INFO - Directory to install application into. [default: 05:48:24 INFO - "/builds/slave/test"] 05:48:24 INFO - --app=APP Application being installed. [default: firefox] 05:48:24 INFO - mkdir: /builds/slave/test/build/application 05:48:24 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'] 05:48:24 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 05:48:41 INFO - Reading from file tmpfile_stdout 05:48:41 INFO - Output received: 05:48:41 INFO - /builds/slave/test/build/application/firefox/firefox 05:48:41 INFO - Running post-action listener: _resource_record_post_action 05:48:41 INFO - ##### 05:48:41 INFO - ##### Finished install step (success) 05:48:41 INFO - ##### 05:48:41 INFO - ##### 05:48:41 INFO - ##### Running run-tests step. 05:48:41 INFO - ##### 05:48:41 INFO - Running pre-action listener: _resource_record_pre_action 05:48:41 INFO - Running main action method: run_tests 05:48:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:48:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:48:41 INFO - Python 2.7.3 05:48:41 INFO - Return code: 0 05:48:41 INFO - grabbing minidump binary from tooltool 05:48:41 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')]} 05:48:41 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 0x2a599c0>, '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 0x2a5a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5ad50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:48:41 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 05:48:41 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 05:48:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:48:41 INFO - Return code: 0 05:48:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:48:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:48:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:48:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:48:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:48:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:48:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:48:42 INFO - Return code: 0 05:48:42 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/a9hi30nWQ0abDN1Kue7smQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 05:48:42 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/a9hi30nWQ0abDN1Kue7smQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 05:48:42 INFO - Using env: {'DISPLAY': ':0', 05:48:42 INFO - 'HOME': '/home/cltbld', 05:48:42 INFO - 'LANG': 'en_US.UTF-8', 05:48:42 INFO - 'LANGUAGE': 'en_US:en', 05:48:42 INFO - 'LOGNAME': 'cltbld', 05:48:42 INFO - 'MAIL': '/var/mail/cltbld', 05:48:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:48:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:48:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:42 INFO - 'MOZ_NO_REMOTE': '1', 05:48:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:48:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:42 INFO - 'NO_EM_RESTART': '1', 05:48:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:42 INFO - 'PWD': '/builds/slave/test', 05:48:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:48:42 INFO - 'SHELL': '/bin/bash', 05:48:42 INFO - 'SHLVL': '1', 05:48:42 INFO - 'TERM': 'linux', 05:48:42 INFO - 'TMOUT': '86400', 05:48:42 INFO - 'USER': 'cltbld', 05:48:42 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462710340.399280-1014463292', 05:48:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:42 INFO - '_': '/tools/buildbot/bin/python'} 05:48:42 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/a9hi30nWQ0abDN1Kue7smQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 05:48:42 INFO - mozversion application_buildid: 20160508030214 05:48:42 INFO - mozversion application_changeset: bae525a694e2dc0aa433885be8751330d4995a49 05:48:42 INFO - mozversion application_display_name: Nightly 05:48:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:48:42 INFO - mozversion application_name: Firefox 05:48:42 INFO - mozversion application_remotingname: firefox 05:48:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:48:42 INFO - mozversion application_vendor: Mozilla 05:48:42 INFO - mozversion application_version: 49.0a1 05:48:42 INFO - mozversion platform_buildid: 20160508030214 05:48:42 INFO - mozversion platform_changeset: bae525a694e2dc0aa433885be8751330d4995a49 05:48:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:48:42 INFO - mozversion platform_version: 49.0a1 05:48:42 INFO - using testdate: 1462711722 05:48:42 INFO - actual date: 1462711722 05:48:42 INFO - starting webserver on 'localhost:33003' 05:48:42 INFO - SUITE-START | Running 2 tests 05:48:42 INFO - TEST-START | dromaeo_css 05:48:42 INFO - operating with platform_type : linux_ 05:48:42 INFO - Initialising browser for dromaeo_css test... 05:48:42 INFO - TEST-INFO | started process 7648 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFVrOqm/profile http://localhost:33003/getInfo.html) 05:48:47 INFO - PROCESS | 7648 | __metrics Screen width/height:1600/1200 05:48:47 INFO - PROCESS | 7648 | colorDepth:24 05:48:47 INFO - PROCESS | 7648 | Browser inner width/height: 1024/697 05:48:47 INFO - PROCESS | 7648 | __metrics 05:48:48 ERROR - PROCESS | 7648 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:48:49 INFO - TEST-INFO | 7648: exit 0 05:48:49 INFO - Browser initialized. 05:48:49 INFO - Running cycle 1/1 for dromaeo_css test... 05:48:49 INFO - TEST-INFO | started process 7731 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFVrOqm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:49:01 INFO - PROCESS | 7731 | RSS: Main: 152260608 05:49:01 INFO - PROCESS | 7731 | 05:49:52 INFO - PROCESS | 7731 | 1462711792936 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] 05:52:01 INFO - PROCESS | 7731 | Cycle 1(1): loaded http://localhost:33003/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33003/tests/dromaeo/cssquery-ext.html) 05:52:02 INFO - PROCESS | 7731 | RSS: Main: 261115904 05:52:02 INFO - PROCESS | 7731 | 05:55:04 INFO - PROCESS | 7731 | Cycle 1(1): loaded http://localhost:33003/tests/dromaeo/cssquery-ext.html (next: http://localhost:33003/tests/dromaeo/cssquery-jquery.html) 05:55:05 INFO - PROCESS | 7731 | RSS: Main: 239206400 05:55:05 INFO - PROCESS | 7731 | 05:58:07 INFO - PROCESS | 7731 | Cycle 1(1): loaded http://localhost:33003/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33003/tests/dromaeo/cssquery-mootools.html) 05:58:07 INFO - PROCESS | 7731 | RSS: Main: 246509568 05:58:07 INFO - PROCESS | 7731 | 06:01:09 INFO - PROCESS | 7731 | Cycle 1(1): loaded http://localhost:33003/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33003/tests/dromaeo/cssquery-prototype.html) 06:01:10 INFO - PROCESS | 7731 | RSS: Main: 235900928 06:01:10 INFO - PROCESS | 7731 | 06:04:13 INFO - PROCESS | 7731 | Cycle 1(1): loaded http://localhost:33003/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33003/tests/dromaeo/cssquery-yui.html) 06:04:13 INFO - PROCESS | 7731 | RSS: Main: 221073408 06:04:13 INFO - PROCESS | 7731 | 06:07:16 INFO - PROCESS | 7731 | Cycle 1(1): loaded http://localhost:33003/tests/dromaeo/cssquery-yui.html (next: http://localhost:33003/tests/dromaeo/cssquery-dojo.html) 06:07:16 INFO - PROCESS | 7731 | RSS: Main: 278974464 06:07:16 INFO - PROCESS | 7731 | 06:07:16 INFO - PROCESS | 7731 | __start_tp_report 06:07:16 INFO - PROCESS | 7731 | _x_x_mozilla_page_load 06:07:16 INFO - PROCESS | 7731 | _x_x_mozilla_page_load_details 06:07:16 INFO - PROCESS | 7731 | |i|pagename|runs| 06:07:16 INFO - PROCESS | 7731 | |0;dojo.html;3135.0438116374503;3171.7621178411623;3185.7769956103066;3210.2134976930656;3232.0627018164732;5254.395744489385;5331.866703332418;5370.650907690997;5456.945430545693;5499.725013749312;5389.434109418514;5406.08096623574;5440.156775699763;5505.889882202364;5518.33779946406;4800.8319708810195;4841.61267098633;4859.73271470069;4874.122657921573;4978.377702787152;4876.734742744272;4885.828995985141;4923;4931.556159945604;4946.060248552763;4702.506236845134;4795.280707893844;4801.639877009238;4839.758012099381;4927.162382394984;4787.066522028206;4799.544043315879;4861.513848615145;4866.245731911559;4900.730459824708;4720.103180395714;4822.035592881438;4832.226843705025;4840.201366774478;4871.805127794884;5274.26160337553;5352.223927530486;5356.303680521546;5400.162974738922;5432.891342173174;5788.160716696098;5830.7959221427045;5835.824925252249;5861.4724674779045;5872;5649.915251271234;5812.244408226946;5852.092925596497;5881.411858814127;5929.258842644669;5416.377116631559;5539.113741801292;5542.057850165482;5544.695041772701;5551.500364967173;6082.817515474543;6091.086337049478;6095.359987201368;6096.02463605821;6099.4815440688035;5481.013417584793;5639.295088113986;5679.5172410345585;5771.538276937835;5829.562782791308;5798.275215598051;5805.796797112165;5810.970945145247;5813.302403711582;5842.444967728059;5717.485426311652;5760.769569217185;5764.308283005982;5767.682777447197;5775.913361299584;5567.832965010975;5679.318481782213;5727.570432217601;5736.569757268222;5775.27809023872;4381.496127945327;4386.1008493258805;4387.517373088957;4388.802503887333;4425.6238219751685;3908.1402091539817;3914.5693973662874;3916.9020774480864;3929.862454814068;3951.565327813938;5280.577553795764;5427.511523962783;5441.428649991773;5473.562115030788;5498.560115190775;5795.1017592273265;5797.304323481209;5797.88404231913;5813.941860581424;5821.039528477754;5290.994711004897;5442.945570544323;5471.644343117685;5482.972585137049;5491.890162196733;5001.124803159432;5022.84931452057;5040.243963405518;5051.545360917535;5083.364579427572;6104.298005729309;6110.969445152746;6118.938810611837;6122.326544080059;6132.110843927606;5608.327000759935;5746.511546518593;5776.480116789509;5887.4406931341455;5890.52875769946;5979.970100149471;5981.760729570942;5998.970005149947;6010.308814486215;6054.636721796706;5703.771849126155;5710.172025056427;5713.371529131709;5722.513586345207;5724;5589.972050139886;5754.884902302014;5771.653700777967;5813.738381772915;5813.883722325614;5686.857828554319;5687.914681279867;5691.3170419549915;5697.743601537858;5701.486866182064;5626.831195064155;5628.60599758013;5682.9147562785765;5683.06229472149;5691.089425691869;5427.945720542902;5554.555635549065;5557.833265002057;5587.636803607753;5609.4390560943575;5717.656940583578;5725.227094342377;5778.219940308005;5784.971075144597;5787.8553036174435;5384.596155288291;5617.662940223599;5623.8594035149445;5629.521490673339;5669.631473954345 06:07:16 INFO - PROCESS | 7731 | |1;ext.html;604.0606856338395;634.4131678197666;648.3095503288997;651.3128649275019;658.93740094691;44338.556614433845;45580.77209613947;45633;49237.26144107832;49344;44619.553804461946;45012.09975800482;45192;45199.548004519944;45214.32178517325;8935.374523783337;9058.77353066172;9067.455952642862;9072.047435019327;9083.636654533844;8942.748015277866;9060.592273347715;9064.093590640949;9064.730937668732;9071.501067441288;9049.411788233776;9114.908850911472;9116.589753461078;9125;9125.543722813865;9080.500572468512;9106.362554621179;9114.726558203198;9121.635134594608;9123.452592844451;8937.285017198608;9012.369134160612;9013.36906416551;9014.774630634221;9014.86477702835;42158.367624485654;42621.36067958983;42640.78679606582;42697.78651106724;42778.35832462516;3642.7796688109515;3668.963310366889;3804.144067584799;3923.4311024901517;4200.306949353353;32036.359272814414;33054.17364565881;33104.6689533104;33555.83222083874;34270.14324641879;4343.6959412841115;4422.292433210703;4456.821727130943;4460.955390446086;4502.2571275739465;223478;223825;224596;225023;293035;58844;59439.40560594425;59473.40526594765;59483;59501.70249148727;37319.440208396896;38207;38278.23443531114;40044.79977600093;61613.38386616166;17253.741193882102;17350.392736254424;17423.303067877143;17439.302427902996;17448.912755436395;12991.15557488779;13004.739905201843;13073.607791766071;13086.149400289141;13105.737885242243;20212.595748084957;20271.797282027284;20407.795922040885;20430.284940027028;20435.693464598044;7455.589942553212;7537.133229678548;7563.659635316314;7605.163432022473;7621;1005.5826831864695;1034.8240799064176;1075.9677209683566;1180.1915687753917;1182.9885447942058;31674.366512669618;32221.838890805397;32760.672393275763;33183.502247466306;33295.83352083224;1134.2513940799033;1167.5563285951455;1169.6783384569312;1198.646399312205;1244.8630650628425;17666.381676641256;17729.911350443166;17745;17785.644287114443;17787.73318400225;430689;435085;437223;437839.1620628466;439442;58230.4176958225;58639.120413193836;58985.70507147437;58996.70501647464;59240;1360.9183448993092;1430.9499167529295;1446.5371081253898;1465.6775509387705;1468.7943687883705;31173.376532469676;32038.19904502406;32549.34901302008;32565.674343256265;32909.50635740418;52129;52301.215481767045;52491.737541312046;52697.20954185614;52716.20925686041;365596;365637;365669;366128;366641;25739.613905791055;26878.193654190407;28569.571456428584;28998.13005609835;29228.853855730584;46879.59361219169;47648.28527572159;47798.76100619614;48110.5188948106;48440.75779621079;40434.39348409835;41168.79415602903;41216.38175427431;41372.793136034124;42225;40176.7991160054;40327;40538.59461405466;40860;41601.58398415977;37250.8137459311;41879.37180942227;42434.15131697411;42781.35827962521;43338.13323733571;35749.46375804313;37280.813595931846;37531.43702844514;37890.43164352592;38164.236715266095;28763.712362876104;28874;29248.41503169967;29422.411551769274;30060.24849378783 06:07:16 INFO - PROCESS | 7731 | |2;jquery.html;393.9290927633026;395.23127516979486;399.89402808255835;404.2965240481562;413.7331421233305;14775.261236938137;17492.650146997068;18914.905425472854;18970.62058758826;19005.04974751262;15395.461158859442;18427.447176584723;19130.617387652237;19332.903335483337;19946.301879434224;5819.912701309473;5951.107333899928;5961.254843144607;5963.105534169866;5965.940340596582;4235.7246778959425;5830.621009634381;5934.495567876736;6187.969060154715;6532.934670653304;6569.474442044625;6599.47204223661;6604.834879128036;6626.73493060277;6632.6020438773585;6392.712327945207;6474.643894585796;6534.738610455576;6539.117219175422;6557.4754019678785;5516.503514683698;5752.769889204426;5765.596408251424;5769.88460230793;5772.769089236425;22318.442038948993;22971.08115675371;23064.769352306597;23189.652155217686;23244.65133023006;2470.0243403855557;2525.8484490930605;2539.1113110411393;2549.8087643426634;2952.424277265934;7216.603086830222;14371.425142994267;14435.35040923161;14512.686981163228;14691.706165876729;1942.65032294187;2005.298145649011;2042.7650820155575;2050.2516581447812;2122.8620139691025;79084.60457697732;81858;82084;82526.17473825245;82882.17117828866;10465.68602941913;10848;10982.670519884416;10998.945005275082;11051;15118.697626047417;15186.164760938254;15231.16228607415;15234.314455849513;15269.083854968516;8383.16168383169;8451.239388454946;8467.068622451525;8572.228499434956;8577.356698247657;7312;8215.917840821634;8234.382421318425;8252.21603947624;8401.663933442594;6365.96817015912;6674.631700501385;6826.897596536056;6842.657867106725;6890.517663763589;1878.2674756844842;1901.3440363074717;1913.1104036623037;1938.6995015772577;1965.9115339809744;970.8108862387024;988.6687959533637;1032.1123833503182;1094.2668412163869;1121.1535290855516;19341.323053693053;19988.400347989584;20017.499562511053;20266.493337666678;20297;1068.8770791359093;1111.8832522585174;1122.747381839096;1132.7224829916559;1138.8633363996373;11020.50407731654;11510.827337589943;11574.305541667527;11695.707607309885;11700.473478693479;482847;486475;486988;502911;507137;79736.6013169942;81094.59452702699;81885.59057204676;81962;82140;1077.9029887310337;1085.1698450685233;1096.2435919215875;1098.7803538072733;1117.3184357541893;17105.828941710923;17217.13914304305;17574.64850702953;17720.113994299976;17969.460916172535;35271.294574108884;36573.26853462862;36953.63046369609;36970.26059478742;38090.238195236496;49666.255006174215;49758.50241497539;51744.741276293375;52255.477445226585;52323.47676523186;6483.384078512534;8622.78443038929;8733.432326898732;8777.385583009129;8952.731418057469;12925.28910909909;13238.338083096;13306.600801975956;13388;13551.932240338736;11432.314061156358;11592.710182245512;11716.589919352782;11721.941390292994;11738.354390508604;11398.373089480157;11463;11617.709557261136;11635.418229088342;11774.411279435823;11820.881791182323;11924.224925379822;11996.40017999114;12319.499744006407;12372.505099796268;8774.947006359022;8838.204561589488;8888.33337499703;8900.643974241217;9049.140331668481;11893.881061189277;11927.582534611594;12025.098117641386;12143.14997950135;12227.75544489123 06:07:16 INFO - PROCESS | 7731 | |3;mootools.html;1370.1778932640411;1500.3098574655658;1543.9886874097467;1703.735920932256;1840.429466865271;8175.672973081077;8598.140185981407;8626.137386261378;8842.204201621853;8904.287656987442;8658.307335413168;8811.427257228275;8846.955765221164;8852.159044890725;8871.645134194641;2023.9392818215404;2290.3815969688176;2369.7748713872156;2377.4413012941945;2418.0811291709124;2416.492536567323;2425;2425.126954296452;2427.320350301918;2428.1501474483966;2249.089118906845;2281.7490076091617;2297.6668383084443;2299.8505097168713;2302.26327575176;1986.145957238387;2280.600894843396;2359.8112151027876;2365.1249037856105;2377.869217193054;2305.2853615379286;2315.780000899912;2330.067972810872;2333.801626861719;2334.0780391745334;8716.215540601377;8747.475151490931;8771.16673915977;8780.780480487974;8790.86813697795;5277.762500687479;5421;5449.536789372908;5464.3442786865435;5468.835934921959;3287.819169945652;3363.3273345330786;3423.640517745626;3436.381451338758;3446.965530344715;1096.5230124895616;1120.7758448310371;1128.9435528223637;1173.8004539228266;1199.7840388730026;12134.514619415213;12212.145149839514;12231.143819932608;12273.140880138393;12290.385480725929;4539.909201815945;4626.074785042938;4675.064987002545;4697.154512187839;4736.123817093849;9696.127348538665;9713.854292185622;9735.70792876215;9748.853767193497;9765.072318129767;4572.0627271409285;5245.186996015624;5261.973690131525;5350.5184533392185;5354.4645535446925;4763.04739052191;4892.608591312686;4893.4617192108835;4906.067847109038;4918.483559226302;3802.7338086334244;3863.8840834775;3896.7077469189358;3899.8440062397754;3951.7036222283446;1118.3457677258732;1152.7867344541287;1165.44641295384;1170.5025364220173;1188.3582865252667;1040.947952602382;1045.2213101239624;1052.2318707343682;1053.783974285285;1055.403696911258;6098.268207815002;6140.329006746704;6180.381961803783;6255.24937007562;6362.809115726535;459.5725974843361;463.83302011275913;468.6274411842525;1009.535613617744;1078.44460103047;4357.455318085239;4449.888752781207;4459.9331010034875;4477.753723545171;4490.865274041784;10671.092957098579;10816.080633146114;11047.392393418439;11087.944560277147;11129.220954533266;10057.145142662956;10725.731856703489;11002.559897604006;11016.614418495474;11059.391733454737;8267.338612911073;8298.294644955125;8379.62291696875;8425.536595487307;8469.915300847037;6172.259328880563;6395.616263024233;6411.4229719325485;6417.807465776034;6495.805125846043;9958.402495850272;9984.301098923297;10123;10125;10163.339382940085;9779.266555008546;10183.236257280585;10223.948880255552;10309.432981186106;10470.947645261725;6697.531172817856;7481.812954676177;7628.160902300631;7629.2752188542;7812.3359514439635;8607.311415086653;8615.396922215385;8676.652933882575;8677.435966662148;8702.042775294585;7715.8071048222;7904.288614024766;7905.604719763874;7993.400494962785;8113.837723245384;7725.22747725223;7840.686372545262;7915.84168316642;7927.246911543394;7992.280694737501;7042.859142817012;7141.321574450419;7257.455690823103;7257.709691612487;7261.092363454568;5191.870203244949;5228.294180285613;5298.788048478018;5318.228856815663;5375.16684913839;5245.895082098413;5273.235380869829;5394.487523685244;5503.036968530571;5531.502164805026 06:07:16 INFO - PROCESS | 7731 | |4;prototype.html;342.3102448566138;344.1362180925876;347.4267458693156;349.8408224257962;353.46450128055983;5256.448072952342;5259.55293800027;5303.787848486061;5305.734713264335;5408.594355423349;5187.221916712495;5248.53041148478;5308.601854860891;5329.546988505982;5329.600279978998;3829.9234015319676;3934.3311637021634;4072.9389059164137;4094.4472496213075;4102.79486025699;4017.457643218172;4052.9797351013203;4091.509018917734;4095.1195492969005;4105.733127346728;3879.8254078566533;4042.4744783178294;4064.715469917107;4075.286824805662;4103.138340948404;3860.613938606145;4047.392891066334;4059.188162367509;4071.6131967463043;4078.2047500737367;3610.295992281506;3624.5106910567265;3626.184108575576;3628.310620982031;3635.8545658173643;5098.643094983353;5120.308758317617;5126.384833819928;5148.897022059537;5153.793848246066;4552.795124219418;4721.976390118062;4756.549252477993;4757.619390448755;4759.666823322369;5449.155380915964;5458.2904222450825;5462.9726851365485;5470.9452905471235;5478.397376288605;4041.6564592009713;4049.1496785675045;4050.6177341919533;4051.9189616207805;4058.127502586958;5577.637453565546;5656.698959239398;5692.829215123553;5698.943010569883;5724.685142317129;4109.506859176918;4126.834926602963;4128.236276288896;4130.091379896418;4132.173565286895;4174.958250417518;4184.811683474251;4187.350960601112;4187.413762073312;4200.94976255936;4427.977860110679;4625.884352891205;4653.115488227273;4678.134545109166;4701.096056097286;5519.172124181405;5528.7235638218735;5535.612507124462;5557.777688892399;5569.693666848362;1350.898682598809;1367.3505085084705;1367.8221831161886;1372.2041216094642;1383.605672383386;916.3356566489375;930.5626355612851;948.6489998700387;951.6574033347989;957.7461972577272;5086.92369614456;5100.515451032146;5123.231515272664;5128.5640020794235;5177.249298851645;5377.327834020747;5394.244805727201;5408.567314614821;5420.942916131316;5468.64453810509;5047.242913562922;5063.797448102035;5116.232565115262;5135.8957824068;5211.270422140903;2856.9572106181095;2858.6278586278704;2861.7567506762157;2884.79806413549;2917.8249305041763;5524.059596984354;5659.783146623496;5663.631863928831;5687.488126068673;5690.9146362804595;5390.9191362129595;5455.645383050089;5505.651115476734;5506.559475242051;5526.447355264522;5561.443855614406;5569.994801871323;5571.220029195916;5585.776568937278;5635.605507614428;5298.966701493172;5361.249425080414;5425.593080518898;5502.339719233718;5750.281214848144;5628.690422026828;5629.887402252014;5646;5647.887042259214;5686.715664216856;5877.089051197071;5886.41135886425;5894.616849904743;5896.911546326723;5899.616524925866;3964.6630036447227;4009.258287216874;4040.252553277653;4058.2403965302697;4066.430699702103;5630.296212973379;5640.661560306395;5659.688717120598;5669.987154560236;5677.375488696158;5544.805931792368;5549.6680796609335;5568.916466252928;5598.944010559842;5599.188117722989;5286.286351342674;5524.944750552604;5533.944660553504;5572.832815015556;5589.441055894541;5190.506901844319;5312.787488500417;5461.726913654381;5501.312335958005;5506.944930550803;5542.806001789918;5585.357683866245;5612.270404847343;5636;5669.5180909621495;5447.727613619224;5451.48210919962;5522.790883646573;5545.972270138624;5547.778088876561 06:07:16 INFO - PROCESS | 7731 | |5;yui.html;796.0805269913245;816.5019338203695;837.8324335132975;840.9621567029484;866.354565848443;14692.70614587709;15144.77282840757;15322.463713769992;15332.846671533282;15353;13547;13564.32178391079;13767.449302027931;13785.241811700353;13791.448342066331;688.2223087910654;805.7703554486973;825.22428916818;831.3723139030024;841.7390608911227;829.2039641943711;835.8119423129777;838.3083955736512;838.3544670603632;838.9077201507829;884.7390019944099;886.0652012127204;889.6485888074207;890.8262888736699;891.3893982621893;722.7434260837406;748.7042618165848;751.4964973467789;855.7090589199639;885.1590988560861;644.3234603666132;646.2761706888315;646.3988490703643;647.0068444936999;647.6988200486749;14800.185989770558;14829;14834.777478337834;14862.554123376316;14871.107733535915;14190.148591084568;14379.640508987255;14525.78211326831;14655.70688586233;14759.262036898112;12628.494860205581;12628.494860205581;12667.239965602;12707.745845083047;13129.474821007148;4528.275475923836;4556.134334476472;4567.497575266718;4760.7619619018915;4762.452317983441;57232;57277;57388;57544.71227643877;59629.701851491336;10414.271001030007;10635.042846143884;11539.711507212387;11635.476403561861;11958.940205298917;18877.339293124674;18906.43280701581;18966.43100706981;19024.33414830502;19095.52261193481;8169.183081691784;8311.792205194797;8403.831923361498;8609.526476043753;8682.6526938923;4974.950250497449;5004.774785134678;5019.222020586815;5046.798128074836;5097.439281679012;3315;3398.167448975017;3403.3873902697255;3407.148212946763;3408.0287118171204;709.3403135084421;711.3384552366349;711.5979471598633;712.383788023356;719.9604021778748;646.405307117453;656.2518728649344;820.7742870710603;829.4857188543142;849.3375167369338;9207.769805754775;9539.3322467428;9642.951785241028;9718.028197180367;9865.309428339948;768.0936494935918;785.6189747972229;792.4492477728039;798.8122791144076;799.5322736199389;4398.450193725785;4596.517365676623;4599.563041511118;4638.095571363552;4725.810967561259;61094;62417;62487.6875615619;62872.68563657152;63320.683396582725;53861.46138538643;55356;55481;55837.16244256339;58289;50737.49262507402;51163.74418127885;51240.48759512357;51966;52168.739156304735;8715.91284087151;8848.690295839871;8956;8957.28341732673;8983.414014760589;32500;33215.66784332126;33227.33545329032;33467.66532334645;33797.32405351928;41587.376189356575;44724;44845.55154448414;45916.311255330525;46544.767276164755;10982.725431864268;11202.607908723156;11221.60724374643;11435.942820285845;11732.472038758106;12564.183328083645;12983.805242921553;13299.66750831237;13355.933220333836;13618.250996195304;12535.435905384098;12850;13098.73802523925;13205.273709946045;13340.999425042966;12470.68823279389;12606.684832879251;12640.6839829005;12739.426725797546;13365.53220637273;12038.277703337828;12039;12436;12444;12801.93599031999;10048.49757512136;10189.796204076025;10382.377057376581;10607.41659208751;10774.515146818569;10048.196144308291;10256;10303.896961030294;10327.122194613241;10483.842742358718 06:07:16 INFO - PROCESS | 7731 | __end_tp_report 06:07:16 INFO - PROCESS | 7731 | __start_cc_report 06:07:16 INFO - PROCESS | 7731 | _x_x_mozilla_cycle_collect,874 06:07:16 INFO - PROCESS | 7731 | __end_cc_report 06:07:16 INFO - PROCESS | 7731 | __startTimestamp1462712836708__endTimestamp 06:07:16 INFO - PROCESS | 7731 | 06:07:16 INFO - PROCESS | 7731 | ------- Summary: start ------- 06:07:16 INFO - PROCESS | 7731 | Number of tests: 6 06:07:16 INFO - PROCESS | 7731 | 06:07:16 INFO - PROCESS | 7731 | [#0] dojo.html Cycles:165 Average:5378.90 Median:5589.97 stddev:627.45 (11.2%) stddev-sans-first:604.17 06:07:16 INFO - PROCESS | 7731 | Values: 3135.0 3171.8 3185.8 3210.2 3232.1 5254.4 5331.9 5370.7 5456.9 5499.7 5389.4 5406.1 5440.2 5505.9 5518.3 4800.8 4841.6 4859.7 4874.1 4978.4 4876.7 4885.8 4923.0 4931.6 4946.1 4702.5 4795.3 4801.6 4839.8 4927.2 4787.1 4799.5 4861.5 4866.2 4900.7 4720.1 4822.0 4832.2 4840.2 4871.8 5274.3 5352.2 5356.3 5400.2 5432.9 5788.2 5830.8 5835.8 5861.5 5872.0 5649.9 5812.2 5852.1 5881.4 5929.3 5416.4 5539.1 5542.1 5544.7 5551.5 6082.8 6091.1 6095.4 6096.0 6099.5 5481.0 5639.3 5679.5 5771.5 5829.6 5798.3 5805.8 5811.0 5813.3 5842.4 5717.5 5760.8 5764.3 5767.7 5775.9 5567.8 5679.3 5727.6 5736.6 5775.3 4381.5 4386.1 4387.5 4388.8 4425.6 3908.1 3914.6 3916.9 3929.9 3951.6 5280.6 5427.5 5441.4 5473.6 5498.6 5795.1 5797.3 5797.9 5813.9 5821.0 5291.0 5442.9 5471.6 5483.0 5491.9 5001.1 5022.8 5040.2 5051.5 5083.4 6104.3 6111.0 6118.9 6122.3 6132.1 5608.3 5746.5 5776.5 5887.4 5890.5 5980.0 5981.8 5999.0 6010.3 6054.6 5703.8 5710.2 5713.4 5722.5 5724.0 5590.0 5754.9 5771.7 5813.7 5813.9 5686.9 5687.9 5691.3 5697.7 5701.5 5626.8 5628.6 5682.9 5683.1 5691.1 5427.9 5554.6 5557.8 5587.6 5609.4 5717.7 5725.2 5778.2 5785.0 5787.9 5384.6 5617.7 5623.9 5629.5 5669.6 06:07:16 INFO - PROCESS | 7731 | 06:07:16 INFO - PROCESS | 7731 | [#1] ext.html Cycles:180 Average:52389.98 Median:41294.59 stddev:93904.88 (227.4%) stddev-sans-first:94087.81 06:07:16 INFO - PROCESS | 7731 | Values: 604.1 634.4 648.3 651.3 658.9 44338.6 45580.8 45633.0 49237.3 49344.0 44619.6 45012.1 45192.0 45199.5 45214.3 8935.4 9058.8 9067.5 9072.0 9083.6 8942.7 9060.6 9064.1 9064.7 9071.5 9049.4 9114.9 9116.6 9125.0 9125.5 9080.5 9106.4 9114.7 9121.6 9123.5 8937.3 9012.4 9013.4 9014.8 9014.9 42158.4 42621.4 42640.8 42697.8 42778.4 3642.8 3669.0 3804.1 3923.4 4200.3 32036.4 33054.2 33104.7 33555.8 34270.1 4343.7 4422.3 4456.8 4461.0 4502.3 223478.0 223825.0 224596.0 225023.0 293035.0 58844.0 59439.4 59473.4 59483.0 59501.7 37319.4 38207.0 38278.2 40044.8 61613.4 17253.7 17350.4 17423.3 17439.3 17448.9 12991.2 13004.7 13073.6 13086.1 13105.7 20212.6 20271.8 20407.8 20430.3 20435.7 7455.6 7537.1 7563.7 7605.2 7621.0 1005.6 1034.8 1076.0 1180.2 1183.0 31674.4 32221.8 32760.7 33183.5 33295.8 1134.3 1167.6 1169.7 1198.6 1244.9 17666.4 17729.9 17745.0 17785.6 17787.7 430689.0 435085.0 437223.0 437839.2 439442.0 58230.4 58639.1 58985.7 58996.7 59240.0 1360.9 1430.9 1446.5 1465.7 1468.8 31173.4 32038.2 32549.3 32565.7 32909.5 52129.0 52301.2 52491.7 52697.2 52716.2 365596.0 365637.0 365669.0 366128.0 366641.0 25739.6 26878.2 28569.6 28998.1 29228.9 46879.6 47648.3 47798.8 48110.5 48440.8 40434.4 41168.8 41216.4 41372.8 42225.0 40176.8 40327.0 40538.6 40860.0 41601.6 37250.8 41879.4 42434.2 42781.4 43338.1 35749.5 37280.8 37531.4 37890.4 38164.2 28763.7 28874.0 29248.4 29422.4 30060.2 06:07:16 INFO - PROCESS | 7731 | 06:07:16 INFO - PROCESS | 7731 | [#2] jquery.html Cycles:180 Average:28706.71 Median:23217.15 stddev:80993.21 (348.9%) stddev-sans-first:81192.52 06:07:16 INFO - PROCESS | 7731 | Values: 393.9 395.2 399.9 404.3 413.7 14775.3 17492.7 18914.9 18970.6 19005.0 15395.5 18427.4 19130.6 19332.9 19946.3 5819.9 5951.1 5961.3 5963.1 5965.9 4235.7 5830.6 5934.5 6188.0 6532.9 6569.5 6599.5 6604.8 6626.7 6632.6 6392.7 6474.6 6534.7 6539.1 6557.5 5516.5 5752.8 5765.6 5769.9 5772.8 22318.4 22971.1 23064.8 23189.7 23244.7 2470.0 2525.8 2539.1 2549.8 2952.4 7216.6 14371.4 14435.4 14512.7 14691.7 1942.7 2005.3 2042.8 2050.3 2122.9 79084.6 81858.0 82084.0 82526.2 82882.2 10465.7 10848.0 10982.7 10998.9 11051.0 15118.7 15186.2 15231.2 15234.3 15269.1 8383.2 8451.2 8467.1 8572.2 8577.4 7312.0 8215.9 8234.4 8252.2 8401.7 6366.0 6674.6 6826.9 6842.7 6890.5 1878.3 1901.3 1913.1 1938.7 1965.9 970.8 988.7 1032.1 1094.3 1121.2 19341.3 19988.4 20017.5 20266.5 20297.0 1068.9 1111.9 1122.7 1132.7 1138.9 11020.5 11510.8 11574.3 11695.7 11700.5 482847.0 486475.0 486988.0 502911.0 507137.0 79736.6 81094.6 81885.6 81962.0 82140.0 1077.9 1085.2 1096.2 1098.8 1117.3 17105.8 17217.1 17574.6 17720.1 17969.5 35271.3 36573.3 36953.6 36970.3 38090.2 49666.3 49758.5 51744.7 52255.5 52323.5 6483.4 8622.8 8733.4 8777.4 8952.7 12925.3 13238.3 13306.6 13388.0 13551.9 11432.3 11592.7 11716.6 11721.9 11738.4 11398.4 11463.0 11617.7 11635.4 11774.4 11820.9 11924.2 11996.4 12319.5 12372.5 8774.9 8838.2 8888.3 8900.6 9049.1 11893.9 11927.6 12025.1 12143.1 12227.8 06:07:16 INFO - PROCESS | 7731 | 06:07:16 INFO - PROCESS | 7731 | [#3] mootools.html Cycles:180 Average:5831.82 Median:2582.89 stddev:3281.37 (127.0%) stddev-sans-first:3273.45 06:07:16 INFO - PROCESS | 7731 | Values: 1370.2 1500.3 1544.0 1703.7 1840.4 8175.7 8598.1 8626.1 8842.2 8904.3 8658.3 8811.4 8847.0 8852.2 8871.6 2023.9 2290.4 2369.8 2377.4 2418.1 2416.5 2425.0 2425.1 2427.3 2428.2 2249.1 2281.7 2297.7 2299.9 2302.3 1986.1 2280.6 2359.8 2365.1 2377.9 2305.3 2315.8 2330.1 2333.8 2334.1 8716.2 8747.5 8771.2 8780.8 8790.9 5277.8 5421.0 5449.5 5464.3 5468.8 3287.8 3363.3 3423.6 3436.4 3447.0 1096.5 1120.8 1128.9 1173.8 1199.8 12134.5 12212.1 12231.1 12273.1 12290.4 4539.9 4626.1 4675.1 4697.2 4736.1 9696.1 9713.9 9735.7 9748.9 9765.1 4572.1 5245.2 5262.0 5350.5 5354.5 4763.0 4892.6 4893.5 4906.1 4918.5 3802.7 3863.9 3896.7 3899.8 3951.7 1118.3 1152.8 1165.4 1170.5 1188.4 1040.9 1045.2 1052.2 1053.8 1055.4 6098.3 6140.3 6180.4 6255.2 6362.8 459.6 463.8 468.6 1009.5 1078.4 4357.5 4449.9 4459.9 4477.8 4490.9 10671.1 10816.1 11047.4 11087.9 11129.2 10057.1 10725.7 11002.6 11016.6 11059.4 8267.3 8298.3 8379.6 8425.5 8469.9 6172.3 6395.6 6411.4 6417.8 6495.8 9958.4 9984.3 10123.0 10125.0 10163.3 9779.3 10183.2 10223.9 10309.4 10470.9 6697.5 7481.8 7628.2 7629.3 7812.3 8607.3 8615.4 8676.7 8677.4 8702.0 7715.8 7904.3 7905.6 7993.4 8113.8 7725.2 7840.7 7915.8 7927.2 7992.3 7042.9 7141.3 7257.5 7257.7 7261.1 5191.9 5228.3 5298.8 5318.2 5375.2 5245.9 5273.2 5394.5 5503.0 5531.5 06:07:16 INFO - PROCESS | 7731 | 06:07:16 INFO - PROCESS | 7731 | [#4] prototype.html Cycles:180 Average:4611.30 Median:5292.63 stddev:1349.43 (25.5%) stddev-sans-first:1314.62 06:07:16 INFO - PROCESS | 7731 | Values: 342.3 344.1 347.4 349.8 353.5 5256.4 5259.6 5303.8 5305.7 5408.6 5187.2 5248.5 5308.6 5329.5 5329.6 3829.9 3934.3 4072.9 4094.4 4102.8 4017.5 4053.0 4091.5 4095.1 4105.7 3879.8 4042.5 4064.7 4075.3 4103.1 3860.6 4047.4 4059.2 4071.6 4078.2 3610.3 3624.5 3626.2 3628.3 3635.9 5098.6 5120.3 5126.4 5148.9 5153.8 4552.8 4722.0 4756.5 4757.6 4759.7 5449.2 5458.3 5463.0 5470.9 5478.4 4041.7 4049.1 4050.6 4051.9 4058.1 5577.6 5656.7 5692.8 5698.9 5724.7 4109.5 4126.8 4128.2 4130.1 4132.2 4175.0 4184.8 4187.4 4187.4 4200.9 4428.0 4625.9 4653.1 4678.1 4701.1 5519.2 5528.7 5535.6 5557.8 5569.7 1350.9 1367.4 1367.8 1372.2 1383.6 916.3 930.6 948.6 951.7 957.7 5086.9 5100.5 5123.2 5128.6 5177.2 5377.3 5394.2 5408.6 5420.9 5468.6 5047.2 5063.8 5116.2 5135.9 5211.3 2857.0 2858.6 2861.8 2884.8 2917.8 5524.1 5659.8 5663.6 5687.5 5690.9 5390.9 5455.6 5505.7 5506.6 5526.4 5561.4 5570.0 5571.2 5585.8 5635.6 5299.0 5361.2 5425.6 5502.3 5750.3 5628.7 5629.9 5646.0 5647.9 5686.7 5877.1 5886.4 5894.6 5896.9 5899.6 3964.7 4009.3 4040.3 4058.2 4066.4 5630.3 5640.7 5659.7 5670.0 5677.4 5544.8 5549.7 5568.9 5598.9 5599.2 5286.3 5524.9 5533.9 5572.8 5589.4 5190.5 5312.8 5461.7 5501.3 5506.9 5542.8 5585.4 5612.3 5636.0 5669.5 5447.7 5451.5 5522.8 5546.0 5547.8 06:07:16 INFO - PROCESS | 7731 | 06:07:16 INFO - PROCESS | 7731 | [#5] yui.html Cycles:180 Average:15041.93 Median:25591.43 stddev:17361.08 (67.8%) stddev-sans-first:17376.82 06:07:16 INFO - PROCESS | 7731 | Values: 796.1 816.5 837.8 841.0 866.4 14692.7 15144.8 15322.5 15332.8 15353.0 13547.0 13564.3 13767.4 13785.2 13791.4 688.2 805.8 825.2 831.4 841.7 829.2 835.8 838.3 838.4 838.9 884.7 886.1 889.6 890.8 891.4 722.7 748.7 751.5 855.7 885.2 644.3 646.3 646.4 647.0 647.7 14800.2 14829.0 14834.8 14862.6 14871.1 14190.1 14379.6 14525.8 14655.7 14759.3 12628.5 12628.5 12667.2 12707.7 13129.5 4528.3 4556.1 4567.5 4760.8 4762.5 57232.0 57277.0 57388.0 57544.7 59629.7 10414.3 10635.0 11539.7 11635.5 11958.9 18877.3 18906.4 18966.4 19024.3 19095.5 8169.2 8311.8 8403.8 8609.5 8682.7 4975.0 5004.8 5019.2 5046.8 5097.4 3315.0 3398.2 3403.4 3407.1 3408.0 709.3 711.3 711.6 712.4 720.0 646.4 656.3 820.8 829.5 849.3 9207.8 9539.3 9643.0 9718.0 9865.3 768.1 785.6 792.4 798.8 799.5 4398.5 4596.5 4599.6 4638.1 4725.8 61094.0 62417.0 62487.7 62872.7 63320.7 53861.5 55356.0 55481.0 55837.2 58289.0 50737.5 51163.7 51240.5 51966.0 52168.7 8715.9 8848.7 8956.0 8957.3 8983.4 32500.0 33215.7 33227.3 33467.7 33797.3 41587.4 44724.0 44845.6 45916.3 46544.8 10982.7 11202.6 11221.6 11435.9 11732.5 12564.2 12983.8 13299.7 13355.9 13618.3 12535.4 12850.0 13098.7 13205.3 13341.0 12470.7 12606.7 12640.7 12739.4 13365.5 12038.3 12039.0 12436.0 12444.0 12801.9 10048.5 10189.8 10382.4 10607.4 10774.5 10048.2 10256.0 10303.9 10327.1 10483.8 06:07:16 INFO - PROCESS | 7731 | -------- Summary: end -------- 06:07:16 INFO - PROCESS | 7731 | 06:07:17 INFO - TEST-INFO | 7731: exit 0 06:07:17 INFO - TEST-OK | dromaeo_css | took 1114914ms 06:07:17 INFO - TEST-START | kraken 06:07:17 INFO - operating with platform_type : linux_ 06:07:17 INFO - Initialising browser for kraken test... 06:07:17 INFO - TEST-INFO | started process 7909 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGUFObg/profile http://localhost:33003/getInfo.html) 06:07:22 INFO - PROCESS | 7909 | __metrics Screen width/height:1600/1200 06:07:22 INFO - PROCESS | 7909 | colorDepth:24 06:07:22 INFO - PROCESS | 7909 | Browser inner width/height: 1024/697 06:07:22 INFO - PROCESS | 7909 | __metrics 06:07:23 ERROR - PROCESS | 7909 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:07:24 INFO - TEST-INFO | 7909: exit 0 06:07:24 INFO - Browser initialized. 06:07:24 INFO - Running cycle 1/1 for kraken test... 06:07:24 INFO - TEST-INFO | started process 7990 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGUFObg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:07:36 INFO - PROCESS | 7990 | RSS: Main: 152391680 06:07:36 INFO - PROCESS | 7990 | 06:07:39 INFO - PROCESS | 7990 | Cycle 1(1): loaded http://localhost:33003/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33003/tests/kraken/driver.html?testName=audio-beat-detection) 06:07:39 INFO - PROCESS | 7990 | RSS: Main: 208875520 06:07:39 INFO - PROCESS | 7990 | 06:07:42 INFO - PROCESS | 7990 | Cycle 1(1): loaded http://localhost:33003/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33003/tests/kraken/driver.html?testName=audio-dft) 06:07:43 INFO - PROCESS | 7990 | RSS: Main: 198254592 06:07:43 INFO - PROCESS | 7990 | 06:07:46 INFO - PROCESS | 7990 | Cycle 1(1): loaded http://localhost:33003/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33003/tests/kraken/driver.html?testName=audio-fft) 06:07:46 INFO - PROCESS | 7990 | RSS: Main: 265428992 06:07:46 INFO - PROCESS | 7990 | 06:07:48 INFO - PROCESS | 7990 | Cycle 1(1): loaded http://localhost:33003/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33003/tests/kraken/driver.html?testName=audio-oscillator) 06:07:49 INFO - PROCESS | 7990 | RSS: Main: 174841856 06:07:49 INFO - PROCESS | 7990 | 06:07:51 INFO - PROCESS | 7990 | Cycle 1(1): loaded http://localhost:33003/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33003/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:07:52 INFO - PROCESS | 7990 | RSS: Main: 179027968 06:07:52 INFO - PROCESS | 7990 | 06:07:55 INFO - PROCESS | 7990 | Cycle 1(1): loaded http://localhost:33003/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33003/tests/kraken/driver.html?testName=imaging-darkroom) 06:07:56 INFO - PROCESS | 7990 | RSS: Main: 214765568 06:07:56 INFO - PROCESS | 7990 | 06:07:59 INFO - PROCESS | 7990 | Cycle 1(1): loaded http://localhost:33003/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33003/tests/kraken/driver.html?testName=imaging-desaturate) 06:08:00 INFO - PROCESS | 7990 | RSS: Main: 215728128 06:08:00 INFO - PROCESS | 7990 | 06:08:02 INFO - PROCESS | 7990 | Cycle 1(1): loaded http://localhost:33003/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33003/tests/kraken/driver.html?testName=json-parse-financial) 06:08:03 INFO - PROCESS | 7990 | RSS: Main: 216002560 06:08:03 INFO - PROCESS | 7990 | 06:08:04 INFO - PROCESS | 7990 | Cycle 1(1): loaded http://localhost:33003/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33003/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:08:05 INFO - PROCESS | 7990 | RSS: Main: 201924608 06:08:05 INFO - PROCESS | 7990 | 06:08:07 INFO - PROCESS | 7990 | Cycle 1(1): loaded http://localhost:33003/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33003/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:08:07 INFO - PROCESS | 7990 | RSS: Main: 205295616 06:08:07 INFO - PROCESS | 7990 | 06:08:09 INFO - PROCESS | 7990 | Cycle 1(1): loaded http://localhost:33003/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33003/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:08:10 INFO - PROCESS | 7990 | RSS: Main: 215355392 06:08:10 INFO - PROCESS | 7990 | 06:08:13 INFO - PROCESS | 7990 | Cycle 1(1): loaded http://localhost:33003/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33003/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:08:13 INFO - PROCESS | 7990 | RSS: Main: 221151232 06:08:13 INFO - PROCESS | 7990 | 06:08:16 INFO - PROCESS | 7990 | Cycle 1(1): loaded http://localhost:33003/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33003/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:08:17 INFO - PROCESS | 7990 | RSS: Main: 218869760 06:08:17 INFO - PROCESS | 7990 | 06:08:18 INFO - PROCESS | 7990 | Cycle 1(1): loaded http://localhost:33003/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33003/tests/kraken/driver.html?testName=ai-astar) 06:08:19 INFO - PROCESS | 7990 | RSS: Main: 264814592 06:08:19 INFO - PROCESS | 7990 | 06:08:19 INFO - PROCESS | 7990 | __start_tp_report 06:08:19 INFO - PROCESS | 7990 | _x_x_mozilla_page_load 06:08:19 INFO - PROCESS | 7990 | _x_x_mozilla_page_load_details 06:08:19 INFO - PROCESS | 7990 | |i|pagename|runs| 06:08:19 INFO - PROCESS | 7990 | |0;ai-astar;111;107;111;110;111;111;109;109;111;111 06:08:19 INFO - PROCESS | 7990 | |1;audio-beat-detection;157;125;155;175;126;158;156;132;177;125 06:08:19 INFO - PROCESS | 7990 | |2;audio-dft;161;160;161;158;161;160;158;160;159;161 06:08:19 INFO - PROCESS | 7990 | |3;audio-fft;75;76;74;123;75;74;75;74;133;75 06:08:19 INFO - PROCESS | 7990 | |4;audio-oscillator;92;93;126;93;92;93;127;92;91;128 06:08:19 INFO - PROCESS | 7990 | |5;imaging-gaussian-blur;117;116;117;116;117;117;116;117;116;116 06:08:19 INFO - PROCESS | 7990 | |6;imaging-darkroom;149;145;145;146;145;146;146;146;145;146 06:08:19 INFO - PROCESS | 7990 | |7;imaging-desaturate;95;94;95;95;95;95;95;94;96;95 06:08:19 INFO - PROCESS | 7990 | |8;json-parse-financial;58;58;58;57;58;58;58;73;57;55 06:08:19 INFO - PROCESS | 7990 | |9;json-stringify-tinderbox;59;59;59;60;60;59;59;59;59;59 06:08:19 INFO - PROCESS | 7990 | |10;stanford-crypto-aes;85;77;80;78;78;84;79;78;79;80 06:08:19 INFO - PROCESS | 7990 | |11;stanford-crypto-ccm;140;126;124;121;123;122;122;121;213;125 06:08:19 INFO - PROCESS | 7990 | |12;stanford-crypto-pbkdf2;166;172;167;171;168;170;167;172;167;171 06:08:19 INFO - PROCESS | 7990 | |13;stanford-crypto-sha256-iterative;67;65;66;64;64;66;66;63;67;64 06:08:19 INFO - PROCESS | 7990 | __end_tp_report 06:08:19 INFO - PROCESS | 7990 | __start_cc_report 06:08:19 INFO - PROCESS | 7990 | _x_x_mozilla_cycle_collect,1582 06:08:19 INFO - PROCESS | 7990 | __end_cc_report 06:08:19 INFO - PROCESS | 7990 | __startTimestamp1462712899101__endTimestamp 06:08:19 INFO - PROCESS | 7990 | 06:08:19 INFO - PROCESS | 7990 | ------- Summary: start ------- 06:08:19 INFO - PROCESS | 7990 | Number of tests: 14 06:08:19 INFO - PROCESS | 7990 | 06:08:19 INFO - PROCESS | 7990 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:1.37 (1.2%) stddev-sans-first:1.41 06:08:19 INFO - PROCESS | 7990 | Values: 111.0 107.0 111.0 110.0 111.0 111.0 109.0 109.0 111.0 111.0 06:08:19 INFO - PROCESS | 7990 | 06:08:19 INFO - PROCESS | 7990 | [#1] audio-beat-detection Cycles:10 Average:148.60 Median:156.50 stddev:20.16 (12.9%) stddev-sans-first:21.15 06:08:19 INFO - PROCESS | 7990 | Values: 157.0 125.0 155.0 175.0 126.0 158.0 156.0 132.0 177.0 125.0 06:08:19 INFO - PROCESS | 7990 | 06:08:19 INFO - PROCESS | 7990 | [#2] audio-dft Cycles:10 Average:159.90 Median:160.50 stddev:1.20 (0.7%) stddev-sans-first:1.20 06:08:19 INFO - PROCESS | 7990 | Values: 161.0 160.0 161.0 158.0 161.0 160.0 158.0 160.0 159.0 161.0 06:08:19 INFO - PROCESS | 7990 | 06:08:19 INFO - PROCESS | 7990 | [#3] audio-fft Cycles:10 Average:85.40 Median:75.00 stddev:22.58 (30.1%) stddev-sans-first:23.64 06:08:19 INFO - PROCESS | 7990 | Values: 75.0 76.0 74.0 123.0 75.0 74.0 75.0 74.0 133.0 75.0 06:08:19 INFO - PROCESS | 7990 | 06:08:19 INFO - PROCESS | 7990 | [#4] audio-oscillator Cycles:10 Average:102.70 Median:92.00 stddev:16.79 (18.2%) stddev-sans-first:17.35 06:08:19 INFO - PROCESS | 7990 | Values: 92.0 93.0 126.0 93.0 92.0 93.0 127.0 92.0 91.0 128.0 06:08:19 INFO - PROCESS | 7990 | 06:08:19 INFO - PROCESS | 7990 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 06:08:19 INFO - PROCESS | 7990 | Values: 117.0 116.0 117.0 116.0 117.0 117.0 116.0 117.0 116.0 116.0 06:08:19 INFO - PROCESS | 7990 | 06:08:19 INFO - PROCESS | 7990 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:1.20 (0.8%) stddev-sans-first:0.53 06:08:19 INFO - PROCESS | 7990 | Values: 149.0 145.0 145.0 146.0 145.0 146.0 146.0 146.0 145.0 146.0 06:08:19 INFO - PROCESS | 7990 | 06:08:19 INFO - PROCESS | 7990 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 06:08:19 INFO - PROCESS | 7990 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 95.0 94.0 96.0 95.0 06:08:19 INFO - PROCESS | 7990 | 06:08:19 INFO - PROCESS | 7990 | [#8] json-parse-financial Cycles:10 Average:59.00 Median:58.00 stddev:5.01 (8.6%) stddev-sans-first:5.30 06:08:19 INFO - PROCESS | 7990 | Values: 58.0 58.0 58.0 57.0 58.0 58.0 58.0 73.0 57.0 55.0 06:08:19 INFO - PROCESS | 7990 | 06:08:19 INFO - PROCESS | 7990 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:59.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 06:08:19 INFO - PROCESS | 7990 | Values: 59.0 59.0 59.0 60.0 60.0 59.0 59.0 59.0 59.0 59.0 06:08:19 INFO - PROCESS | 7990 | 06:08:19 INFO - PROCESS | 7990 | [#10] stanford-crypto-aes Cycles:10 Average:79.80 Median:79.50 stddev:2.66 (3.3%) stddev-sans-first:2.05 06:08:19 INFO - PROCESS | 7990 | Values: 85.0 77.0 80.0 78.0 78.0 84.0 79.0 78.0 79.0 80.0 06:08:19 INFO - PROCESS | 7990 | 06:08:19 INFO - PROCESS | 7990 | [#11] stanford-crypto-ccm Cycles:10 Average:133.70 Median:124.50 stddev:28.42 (22.8%) stddev-sans-first:30.05 06:08:19 INFO - PROCESS | 7990 | Values: 140.0 126.0 124.0 121.0 123.0 122.0 122.0 121.0 213.0 125.0 06:08:19 INFO - PROCESS | 7990 | 06:08:19 INFO - PROCESS | 7990 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.10 Median:170.50 stddev:2.33 (1.4%) stddev-sans-first:2.19 06:08:19 INFO - PROCESS | 7990 | Values: 166.0 172.0 167.0 171.0 168.0 170.0 167.0 172.0 167.0 171.0 06:08:19 INFO - PROCESS | 7990 | 06:08:19 INFO - PROCESS | 7990 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:66.00 stddev:1.40 (2.1%) stddev-sans-first:1.32 06:08:19 INFO - PROCESS | 7990 | Values: 67.0 65.0 66.0 64.0 64.0 66.0 66.0 63.0 67.0 64.0 06:08:19 INFO - PROCESS | 7990 | -------- Summary: end -------- 06:08:19 INFO - PROCESS | 7990 | 06:08:20 INFO - TEST-INFO | 7990: exit 0 06:08:20 INFO - TEST-OK | kraken | took 62580ms 06:08:20 INFO - SUITE-END | took 1177s 06:08:20 INFO - Completed test suite (00:19:37) 06:08:20 INFO - javascript benchmark 06:08:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3135.0438116374503, 3171.7621178411623, 3185.7769956103066, 3210.2134976930656, 3232.0627018164732, 5254.395744489385, 5331.866703332418, 5370.650907690997, 5456.945430545693, 5499.725013749312, 5389.434109418514, 5406.08096623574, 5440.156775699763, 5505.889882202364, 5518.33779946406, 4800.8319708810195, 4841.61267098633, 4859.73271470069, 4874.122657921573, 4978.377702787152, 4876.734742744272, 4885.828995985141, 4923.0, 4931.556159945604, 4946.060248552763, 4702.506236845134, 4795.280707893844, 4801.639877009238, 4839.758012099381, 4927.162382394984, 4787.066522028206, 4799.544043315879, 4861.513848615145, 4866.245731911559, 4900.730459824708, 4720.103180395714, 4822.035592881438, 4832.226843705025, 4840.201366774478, 4871.805127794884, 5274.26160337553, 5352.223927530486, 5356.303680521546, 5400.162974738922, 5432.891342173174, 5788.160716696098, 5830.7959221427045, 5835.824925252249, 5861.4724674779045, 5872.0, 5649.915251271234, 5812.244408226946, 5852.092925596497, 5881.411858814127, 5929.258842644669, 5416.377116631559, 5539.113741801292, 5542.057850165482, 5544.695041772701, 5551.500364967173, 6082.817515474543, 6091.086337049478, 6095.359987201368, 6096.02463605821, 6099.4815440688035, 5481.013417584793, 5639.295088113986, 5679.5172410345585, 5771.538276937835, 5829.562782791308, 5798.275215598051, 5805.796797112165, 5810.970945145247, 5813.302403711582, 5842.444967728059, 5717.485426311652, 5760.769569217185, 5764.308283005982, 5767.682777447197, 5775.913361299584, 5567.832965010975, 5679.318481782213, 5727.570432217601, 5736.569757268222, 5775.27809023872, 4381.496127945327, 4386.1008493258805, 4387.517373088957, 4388.802503887333, 4425.6238219751685, 3908.1402091539817, 3914.5693973662874, 3916.9020774480864, 3929.862454814068, 3951.565327813938, 5280.577553795764, 5427.511523962783, 5441.428649991773, 5473.562115030788, 5498.560115190775, 5795.1017592273265, 5797.304323481209, 5797.88404231913, 5813.941860581424, 5821.039528477754, 5290.994711004897, 5442.945570544323, 5471.644343117685, 5482.972585137049, 5491.890162196733, 5001.124803159432, 5022.84931452057, 5040.243963405518, 5051.545360917535, 5083.364579427572, 6104.298005729309, 6110.969445152746, 6118.938810611837, 6122.326544080059, 6132.110843927606, 5608.327000759935, 5746.511546518593, 5776.480116789509, 5887.4406931341455, 5890.52875769946, 5979.970100149471, 5981.760729570942, 5998.970005149947, 6010.308814486215, 6054.636721796706, 5703.771849126155, 5710.172025056427, 5713.371529131709, 5722.513586345207, 5724.0, 5589.972050139886, 5754.884902302014, 5771.653700777967, 5813.738381772915, 5813.883722325614, 5686.857828554319, 5687.914681279867, 5691.3170419549915, 5697.743601537858, 5701.486866182064, 5626.831195064155, 5628.60599758013, 5682.9147562785765, 5683.06229472149, 5691.089425691869, 5427.945720542902, 5554.555635549065, 5557.833265002057, 5587.636803607753, 5609.4390560943575, 5717.656940583578, 5725.227094342377, 5778.219940308005, 5784.971075144597, 5787.8553036174435, 5384.596155288291, 5617.662940223599, 5623.8594035149445, 5629.521490673339, 5669.631473954345], "value": 5336.1870469481755, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.0606856338395, 634.4131678197666, 648.3095503288997, 651.3128649275019, 658.93740094691, 44338.556614433845, 45580.77209613947, 45633.0, 49237.26144107832, 49344.0, 44619.553804461946, 45012.09975800482, 45192.0, 45199.548004519944, 45214.32178517325, 8935.374523783337, 9058.77353066172, 9067.455952642862, 9072.047435019327, 9083.636654533844, 8942.748015277866, 9060.592273347715, 9064.093590640949, 9064.730937668732, 9071.501067441288, 9049.411788233776, 9114.908850911472, 9116.589753461078, 9125.0, 9125.543722813865, 9080.500572468512, 9106.362554621179, 9114.726558203198, 9121.635134594608, 9123.452592844451, 8937.285017198608, 9012.369134160612, 9013.36906416551, 9014.774630634221, 9014.86477702835, 42158.367624485654, 42621.36067958983, 42640.78679606582, 42697.78651106724, 42778.35832462516, 3642.7796688109515, 3668.963310366889, 3804.144067584799, 3923.4311024901517, 4200.306949353353, 32036.359272814414, 33054.17364565881, 33104.6689533104, 33555.83222083874, 34270.14324641879, 4343.6959412841115, 4422.292433210703, 4456.821727130943, 4460.955390446086, 4502.2571275739465, 223478.0, 223825.0, 224596.0, 225023.0, 293035.0, 58844.0, 59439.40560594425, 59473.40526594765, 59483.0, 59501.70249148727, 37319.440208396896, 38207.0, 38278.23443531114, 40044.79977600093, 61613.38386616166, 17253.741193882102, 17350.392736254424, 17423.303067877143, 17439.302427902996, 17448.912755436395, 12991.15557488779, 13004.739905201843, 13073.607791766071, 13086.149400289141, 13105.737885242243, 20212.595748084957, 20271.797282027284, 20407.795922040885, 20430.284940027028, 20435.693464598044, 7455.589942553212, 7537.133229678548, 7563.659635316314, 7605.163432022473, 7621.0, 1005.5826831864695, 1034.8240799064176, 1075.9677209683566, 1180.1915687753917, 1182.9885447942058, 31674.366512669618, 32221.838890805397, 32760.672393275763, 33183.502247466306, 33295.83352083224, 1134.2513940799033, 1167.5563285951455, 1169.6783384569312, 1198.646399312205, 1244.8630650628425, 17666.381676641256, 17729.911350443166, 17745.0, 17785.644287114443, 17787.73318400225, 430689.0, 435085.0, 437223.0, 437839.1620628466, 439442.0, 58230.4176958225, 58639.120413193836, 58985.70507147437, 58996.70501647464, 59240.0, 1360.9183448993092, 1430.9499167529295, 1446.5371081253898, 1465.6775509387705, 1468.7943687883705, 31173.376532469676, 32038.19904502406, 32549.34901302008, 32565.674343256265, 32909.50635740418, 52129.0, 52301.215481767045, 52491.737541312046, 52697.20954185614, 52716.20925686041, 365596.0, 365637.0, 365669.0, 366128.0, 366641.0, 25739.613905791055, 26878.193654190407, 28569.571456428584, 28998.13005609835, 29228.853855730584, 46879.59361219169, 47648.28527572159, 47798.76100619614, 48110.5188948106, 48440.75779621079, 40434.39348409835, 41168.79415602903, 41216.38175427431, 41372.793136034124, 42225.0, 40176.7991160054, 40327.0, 40538.59461405466, 40860.0, 41601.58398415977, 37250.8137459311, 41879.37180942227, 42434.15131697411, 42781.35827962521, 43338.13323733571, 35749.46375804313, 37280.813595931846, 37531.43702844514, 37890.43164352592, 38164.236715266095, 28763.712362876104, 28874.0, 29248.41503169967, 29422.411551769274, 30060.24849378783], "value": 20038.079432513496, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.9290927633026, 395.23127516979486, 399.89402808255835, 404.2965240481562, 413.7331421233305, 14775.261236938137, 17492.650146997068, 18914.905425472854, 18970.62058758826, 19005.04974751262, 15395.461158859442, 18427.447176584723, 19130.617387652237, 19332.903335483337, 19946.301879434224, 5819.912701309473, 5951.107333899928, 5961.254843144607, 5963.105534169866, 5965.940340596582, 4235.7246778959425, 5830.621009634381, 5934.495567876736, 6187.969060154715, 6532.934670653304, 6569.474442044625, 6599.47204223661, 6604.834879128036, 6626.73493060277, 6632.6020438773585, 6392.712327945207, 6474.643894585796, 6534.738610455576, 6539.117219175422, 6557.4754019678785, 5516.503514683698, 5752.769889204426, 5765.596408251424, 5769.88460230793, 5772.769089236425, 22318.442038948993, 22971.08115675371, 23064.769352306597, 23189.652155217686, 23244.65133023006, 2470.0243403855557, 2525.8484490930605, 2539.1113110411393, 2549.8087643426634, 2952.424277265934, 7216.603086830222, 14371.425142994267, 14435.35040923161, 14512.686981163228, 14691.706165876729, 1942.65032294187, 2005.298145649011, 2042.7650820155575, 2050.2516581447812, 2122.8620139691025, 79084.60457697732, 81858.0, 82084.0, 82526.17473825245, 82882.17117828866, 10465.68602941913, 10848.0, 10982.670519884416, 10998.945005275082, 11051.0, 15118.697626047417, 15186.164760938254, 15231.16228607415, 15234.314455849513, 15269.083854968516, 8383.16168383169, 8451.239388454946, 8467.068622451525, 8572.228499434956, 8577.356698247657, 7312.0, 8215.917840821634, 8234.382421318425, 8252.21603947624, 8401.663933442594, 6365.96817015912, 6674.631700501385, 6826.897596536056, 6842.657867106725, 6890.517663763589, 1878.2674756844842, 1901.3440363074717, 1913.1104036623037, 1938.6995015772577, 1965.9115339809744, 970.8108862387024, 988.6687959533637, 1032.1123833503182, 1094.2668412163869, 1121.1535290855516, 19341.323053693053, 19988.400347989584, 20017.499562511053, 20266.493337666678, 20297.0, 1068.8770791359093, 1111.8832522585174, 1122.747381839096, 1132.7224829916559, 1138.8633363996373, 11020.50407731654, 11510.827337589943, 11574.305541667527, 11695.707607309885, 11700.473478693479, 482847.0, 486475.0, 486988.0, 502911.0, 507137.0, 79736.6013169942, 81094.59452702699, 81885.59057204676, 81962.0, 82140.0, 1077.9029887310337, 1085.1698450685233, 1096.2435919215875, 1098.7803538072733, 1117.3184357541893, 17105.828941710923, 17217.13914304305, 17574.64850702953, 17720.113994299976, 17969.460916172535, 35271.294574108884, 36573.26853462862, 36953.63046369609, 36970.26059478742, 38090.238195236496, 49666.255006174215, 49758.50241497539, 51744.741276293375, 52255.477445226585, 52323.47676523186, 6483.384078512534, 8622.78443038929, 8733.432326898732, 8777.385583009129, 8952.731418057469, 12925.28910909909, 13238.338083096, 13306.600801975956, 13388.0, 13551.932240338736, 11432.314061156358, 11592.710182245512, 11716.589919352782, 11721.941390292994, 11738.354390508604, 11398.373089480157, 11463.0, 11617.709557261136, 11635.418229088342, 11774.411279435823, 11820.881791182323, 11924.224925379822, 11996.40017999114, 12319.499744006407, 12372.505099796268, 8774.947006359022, 8838.204561589488, 8888.33337499703, 8900.643974241217, 9049.140331668481, 11893.881061189277, 11927.582534611594, 12025.098117641386, 12143.14997950135, 12227.75544489123], "value": 9498.324819736305, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1370.1778932640411, 1500.3098574655658, 1543.9886874097467, 1703.735920932256, 1840.429466865271, 8175.672973081077, 8598.140185981407, 8626.137386261378, 8842.204201621853, 8904.287656987442, 8658.307335413168, 8811.427257228275, 8846.955765221164, 8852.159044890725, 8871.645134194641, 2023.9392818215404, 2290.3815969688176, 2369.7748713872156, 2377.4413012941945, 2418.0811291709124, 2416.492536567323, 2425.0, 2425.126954296452, 2427.320350301918, 2428.1501474483966, 2249.089118906845, 2281.7490076091617, 2297.6668383084443, 2299.8505097168713, 2302.26327575176, 1986.145957238387, 2280.600894843396, 2359.8112151027876, 2365.1249037856105, 2377.869217193054, 2305.2853615379286, 2315.780000899912, 2330.067972810872, 2333.801626861719, 2334.0780391745334, 8716.215540601377, 8747.475151490931, 8771.16673915977, 8780.780480487974, 8790.86813697795, 5277.762500687479, 5421.0, 5449.536789372908, 5464.3442786865435, 5468.835934921959, 3287.819169945652, 3363.3273345330786, 3423.640517745626, 3436.381451338758, 3446.965530344715, 1096.5230124895616, 1120.7758448310371, 1128.9435528223637, 1173.8004539228266, 1199.7840388730026, 12134.514619415213, 12212.145149839514, 12231.143819932608, 12273.140880138393, 12290.385480725929, 4539.909201815945, 4626.074785042938, 4675.064987002545, 4697.154512187839, 4736.123817093849, 9696.127348538665, 9713.854292185622, 9735.70792876215, 9748.853767193497, 9765.072318129767, 4572.0627271409285, 5245.186996015624, 5261.973690131525, 5350.5184533392185, 5354.4645535446925, 4763.04739052191, 4892.608591312686, 4893.4617192108835, 4906.067847109038, 4918.483559226302, 3802.7338086334244, 3863.8840834775, 3896.7077469189358, 3899.8440062397754, 3951.7036222283446, 1118.3457677258732, 1152.7867344541287, 1165.44641295384, 1170.5025364220173, 1188.3582865252667, 1040.947952602382, 1045.2213101239624, 1052.2318707343682, 1053.783974285285, 1055.403696911258, 6098.268207815002, 6140.329006746704, 6180.381961803783, 6255.24937007562, 6362.809115726535, 459.5725974843361, 463.83302011275913, 468.6274411842525, 1009.535613617744, 1078.44460103047, 4357.455318085239, 4449.888752781207, 4459.9331010034875, 4477.753723545171, 4490.865274041784, 10671.092957098579, 10816.080633146114, 11047.392393418439, 11087.944560277147, 11129.220954533266, 10057.145142662956, 10725.731856703489, 11002.559897604006, 11016.614418495474, 11059.391733454737, 8267.338612911073, 8298.294644955125, 8379.62291696875, 8425.536595487307, 8469.915300847037, 6172.259328880563, 6395.616263024233, 6411.4229719325485, 6417.807465776034, 6495.805125846043, 9958.402495850272, 9984.301098923297, 10123.0, 10125.0, 10163.339382940085, 9779.266555008546, 10183.236257280585, 10223.948880255552, 10309.432981186106, 10470.947645261725, 6697.531172817856, 7481.812954676177, 7628.160902300631, 7629.2752188542, 7812.3359514439635, 8607.311415086653, 8615.396922215385, 8676.652933882575, 8677.435966662148, 8702.042775294585, 7715.8071048222, 7904.288614024766, 7905.604719763874, 7993.400494962785, 8113.837723245384, 7725.22747725223, 7840.686372545262, 7915.84168316642, 7927.246911543394, 7992.280694737501, 7042.859142817012, 7141.321574450419, 7257.455690823103, 7257.709691612487, 7261.092363454568, 5191.870203244949, 5228.294180285613, 5298.788048478018, 5318.228856815663, 5375.16684913839, 5245.895082098413, 5273.235380869829, 5394.487523685244, 5503.036968530571, 5531.502164805026], "value": 4643.156966582151, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.3102448566138, 344.1362180925876, 347.4267458693156, 349.8408224257962, 353.46450128055983, 5256.448072952342, 5259.55293800027, 5303.787848486061, 5305.734713264335, 5408.594355423349, 5187.221916712495, 5248.53041148478, 5308.601854860891, 5329.546988505982, 5329.600279978998, 3829.9234015319676, 3934.3311637021634, 4072.9389059164137, 4094.4472496213075, 4102.79486025699, 4017.457643218172, 4052.9797351013203, 4091.509018917734, 4095.1195492969005, 4105.733127346728, 3879.8254078566533, 4042.4744783178294, 4064.715469917107, 4075.286824805662, 4103.138340948404, 3860.613938606145, 4047.392891066334, 4059.188162367509, 4071.6131967463043, 4078.2047500737367, 3610.295992281506, 3624.5106910567265, 3626.184108575576, 3628.310620982031, 3635.8545658173643, 5098.643094983353, 5120.308758317617, 5126.384833819928, 5148.897022059537, 5153.793848246066, 4552.795124219418, 4721.976390118062, 4756.549252477993, 4757.619390448755, 4759.666823322369, 5449.155380915964, 5458.2904222450825, 5462.9726851365485, 5470.9452905471235, 5478.397376288605, 4041.6564592009713, 4049.1496785675045, 4050.6177341919533, 4051.9189616207805, 4058.127502586958, 5577.637453565546, 5656.698959239398, 5692.829215123553, 5698.943010569883, 5724.685142317129, 4109.506859176918, 4126.834926602963, 4128.236276288896, 4130.091379896418, 4132.173565286895, 4174.958250417518, 4184.811683474251, 4187.350960601112, 4187.413762073312, 4200.94976255936, 4427.977860110679, 4625.884352891205, 4653.115488227273, 4678.134545109166, 4701.096056097286, 5519.172124181405, 5528.7235638218735, 5535.612507124462, 5557.777688892399, 5569.693666848362, 1350.898682598809, 1367.3505085084705, 1367.8221831161886, 1372.2041216094642, 1383.605672383386, 916.3356566489375, 930.5626355612851, 948.6489998700387, 951.6574033347989, 957.7461972577272, 5086.92369614456, 5100.515451032146, 5123.231515272664, 5128.5640020794235, 5177.249298851645, 5377.327834020747, 5394.244805727201, 5408.567314614821, 5420.942916131316, 5468.64453810509, 5047.242913562922, 5063.797448102035, 5116.232565115262, 5135.8957824068, 5211.270422140903, 2856.9572106181095, 2858.6278586278704, 2861.7567506762157, 2884.79806413549, 2917.8249305041763, 5524.059596984354, 5659.783146623496, 5663.631863928831, 5687.488126068673, 5690.9146362804595, 5390.9191362129595, 5455.645383050089, 5505.651115476734, 5506.559475242051, 5526.447355264522, 5561.443855614406, 5569.994801871323, 5571.220029195916, 5585.776568937278, 5635.605507614428, 5298.966701493172, 5361.249425080414, 5425.593080518898, 5502.339719233718, 5750.281214848144, 5628.690422026828, 5629.887402252014, 5646.0, 5647.887042259214, 5686.715664216856, 5877.089051197071, 5886.41135886425, 5894.616849904743, 5896.911546326723, 5899.616524925866, 3964.6630036447227, 4009.258287216874, 4040.252553277653, 4058.2403965302697, 4066.430699702103, 5630.296212973379, 5640.661560306395, 5659.688717120598, 5669.987154560236, 5677.375488696158, 5544.805931792368, 5549.6680796609335, 5568.916466252928, 5598.944010559842, 5599.188117722989, 5286.286351342674, 5524.944750552604, 5533.944660553504, 5572.832815015556, 5589.441055894541, 5190.506901844319, 5312.787488500417, 5461.726913654381, 5501.312335958005, 5506.944930550803, 5542.806001789918, 5585.357683866245, 5612.270404847343, 5636.0, 5669.5180909621495, 5447.727613619224, 5451.48210919962, 5522.790883646573, 5545.972270138624, 5547.778088876561], "value": 4185.28735145168, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [796.0805269913245, 816.5019338203695, 837.8324335132975, 840.9621567029484, 866.354565848443, 14692.70614587709, 15144.77282840757, 15322.463713769992, 15332.846671533282, 15353.0, 13547.0, 13564.32178391079, 13767.449302027931, 13785.241811700353, 13791.448342066331, 688.2223087910654, 805.7703554486973, 825.22428916818, 831.3723139030024, 841.7390608911227, 829.2039641943711, 835.8119423129777, 838.3083955736512, 838.3544670603632, 838.9077201507829, 884.7390019944099, 886.0652012127204, 889.6485888074207, 890.8262888736699, 891.3893982621893, 722.7434260837406, 748.7042618165848, 751.4964973467789, 855.7090589199639, 885.1590988560861, 644.3234603666132, 646.2761706888315, 646.3988490703643, 647.0068444936999, 647.6988200486749, 14800.185989770558, 14829.0, 14834.777478337834, 14862.554123376316, 14871.107733535915, 14190.148591084568, 14379.640508987255, 14525.78211326831, 14655.70688586233, 14759.262036898112, 12628.494860205581, 12628.494860205581, 12667.239965602, 12707.745845083047, 13129.474821007148, 4528.275475923836, 4556.134334476472, 4567.497575266718, 4760.7619619018915, 4762.452317983441, 57232.0, 57277.0, 57388.0, 57544.71227643877, 59629.701851491336, 10414.271001030007, 10635.042846143884, 11539.711507212387, 11635.476403561861, 11958.940205298917, 18877.339293124674, 18906.43280701581, 18966.43100706981, 19024.33414830502, 19095.52261193481, 8169.183081691784, 8311.792205194797, 8403.831923361498, 8609.526476043753, 8682.6526938923, 4974.950250497449, 5004.774785134678, 5019.222020586815, 5046.798128074836, 5097.439281679012, 3315.0, 3398.167448975017, 3403.3873902697255, 3407.148212946763, 3408.0287118171204, 709.3403135084421, 711.3384552366349, 711.5979471598633, 712.383788023356, 719.9604021778748, 646.405307117453, 656.2518728649344, 820.7742870710603, 829.4857188543142, 849.3375167369338, 9207.769805754775, 9539.3322467428, 9642.951785241028, 9718.028197180367, 9865.309428339948, 768.0936494935918, 785.6189747972229, 792.4492477728039, 798.8122791144076, 799.5322736199389, 4398.450193725785, 4596.517365676623, 4599.563041511118, 4638.095571363552, 4725.810967561259, 61094.0, 62417.0, 62487.6875615619, 62872.68563657152, 63320.683396582725, 53861.46138538643, 55356.0, 55481.0, 55837.16244256339, 58289.0, 50737.49262507402, 51163.74418127885, 51240.48759512357, 51966.0, 52168.739156304735, 8715.91284087151, 8848.690295839871, 8956.0, 8957.28341732673, 8983.414014760589, 32500.0, 33215.66784332126, 33227.33545329032, 33467.66532334645, 33797.32405351928, 41587.376189356575, 44724.0, 44845.55154448414, 45916.311255330525, 46544.767276164755, 10982.725431864268, 11202.607908723156, 11221.60724374643, 11435.942820285845, 11732.472038758106, 12564.183328083645, 12983.805242921553, 13299.66750831237, 13355.933220333836, 13618.250996195304, 12535.435905384098, 12850.0, 13098.73802523925, 13205.273709946045, 13340.999425042966, 12470.68823279389, 12606.684832879251, 12640.6839829005, 12739.426725797546, 13365.53220637273, 12038.277703337828, 12039.0, 12436.0, 12444.0, 12801.93599031999, 10048.49757512136, 10189.796204076025, 10382.377057376581, 10607.41659208751, 10774.515146818569, 10048.196144308291, 10256.0, 10303.896961030294, 10327.122194613241, 10483.842742358718], "value": 6918.443461306812, "unit": "score"}], "name": "dromaeo_css", "value": 7176.089077591445, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 107.0, 111.0, 110.0, 111.0, 111.0, 109.0, 109.0, 111.0, 111.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 125.0, 155.0, 175.0, 126.0, 158.0, 156.0, 132.0, 177.0, 125.0], "value": 148.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 158.0, 161.0, 160.0, 158.0, 160.0, 159.0, 161.0], "value": 159.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 123.0, 75.0, 74.0, 75.0, 74.0, 133.0, 75.0], "value": 85.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 126.0, 93.0, 92.0, 93.0, 127.0, 92.0, 91.0, 128.0], "value": 102.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 96.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 57.0, 58.0, 58.0, 58.0, 73.0, 57.0, 55.0], "value": 59.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 60.0, 60.0, 59.0, 59.0, 59.0, 59.0, 59.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 77.0, 80.0, 78.0, 78.0, 84.0, 79.0, 78.0, 79.0, 80.0], "value": 79.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 126.0, 124.0, 121.0, 123.0, 122.0, 122.0, 121.0, 213.0, 125.0], "value": 133.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 172.0, 167.0, 171.0, 168.0, 170.0, 167.0, 172.0, 167.0, 171.0], "value": 169.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 66.0, 64.0, 64.0, 66.0, 66.0, 63.0, 67.0, 64.0], "value": 65.2, "unit": "score"}], "name": "kraken", "value": 1530.0, "alertThreshold": 2.0}]} 06:08:20 INFO - Return code: 0 06:08:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:08:20 ERROR - # TBPL SUCCESS # 06:08:20 INFO - Running post-action listener: _resource_record_post_action 06:08:20 INFO - ##### 06:08:20 INFO - ##### Finished run-tests step (success) 06:08:20 INFO - ##### 06:08:20 INFO - Running post-run listener: _resource_record_post_run 06:08:21 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 196608; Write bytes: 535433216; Read time: 52; Write time: 1094348 06:08:21 INFO - install - Wall time: 17s; CPU: 16.0%; Read bytes: 0; Write bytes: 244277248; Read time: 0; Write time: 488668 06:08:21 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 196608; Write bytes: 290414592; Read time: 52; Write time: 605564 06:08:21 INFO - Running post-run listener: _upload_blobber_files 06:08:21 INFO - Blob upload gear active. 06:08:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:08:21 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:08:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:08:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:08:21 INFO - (blobuploader) - INFO - Open directory for files ... 06:08:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:08:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:08:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:08:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:08:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:08:22 INFO - (blobuploader) - INFO - Done attempting. 06:08:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:08:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:08:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:08:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:08:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:08:23 INFO - (blobuploader) - INFO - Done attempting. 06:08:23 INFO - (blobuploader) - INFO - Iteration through files over. 06:08:23 INFO - Return code: 0 06:08:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:08:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:08:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8bc1ca46e31ae2af2bb67a0265007551bdc80d99400b15706f012e4dd687e2335068f19e54311f9aece9c0fce4057ed63caa9dac94e971e279a33c1471e45f1b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be9b438a7eead661ceb776440122667140a0ca7350358cd24ccb364dd87c3db52f22d98a4862d5817a5ecde8a3dfac5d32fbed44f22994ad87fa35bb4989f777"} 06:08:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:08:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:08:23 INFO - Contents: 06:08:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8bc1ca46e31ae2af2bb67a0265007551bdc80d99400b15706f012e4dd687e2335068f19e54311f9aece9c0fce4057ed63caa9dac94e971e279a33c1471e45f1b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be9b438a7eead661ceb776440122667140a0ca7350358cd24ccb364dd87c3db52f22d98a4862d5817a5ecde8a3dfac5d32fbed44f22994ad87fa35bb4989f777"} 06:08:23 INFO - Running post-run listener: copy_logs_to_upload_dir 06:08:23 INFO - Copying logs to upload dir... 06:08:23 INFO - mkdir: /builds/slave/test/build/upload/logs 06:08:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.544902 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-05-08 06:08:23.444274) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-08 06:08:23.448885) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1462710340.399280-1014463292 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/8bc1ca46e31ae2af2bb67a0265007551bdc80d99400b15706f012e4dd687e2335068f19e54311f9aece9c0fce4057ed63caa9dac94e971e279a33c1471e45f1b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be9b438a7eead661ceb776440122667140a0ca7350358cd24ccb364dd87c3db52f22d98a4862d5817a5ecde8a3dfac5d32fbed44f22994ad87fa35bb4989f777"} build_url:https://queue.taskcluster.net/v1/task/a9hi30nWQ0abDN1Kue7smQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011340 build_url: 'https://queue.taskcluster.net/v1/task/a9hi30nWQ0abDN1Kue7smQ/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/8bc1ca46e31ae2af2bb67a0265007551bdc80d99400b15706f012e4dd687e2335068f19e54311f9aece9c0fce4057ed63caa9dac94e971e279a33c1471e45f1b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be9b438a7eead661ceb776440122667140a0ca7350358cd24ccb364dd87c3db52f22d98a4862d5817a5ecde8a3dfac5d32fbed44f22994ad87fa35bb4989f777"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-08 06:08:23.475912) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-08 06:08:23.476234) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1462710340.399280-1014463292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004514 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-08 06:08:23.559421) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-08 06:08:23.559740) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-08 06:08:23.560038) ========= ========= Total master_lag: 0.21 =========