builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-012 starttime: 1461373813.4 results: success (0) buildid: 20160422155151 builduid: 92a58d889d074e099675a38285f93169 revision: 1385868f8904b7e5f0cc338d2b79225f35e406cd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 18:10:13.400667) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 18:10:13.401359) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 18:10:13.401706) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 18:10:13.419530) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 18:10:13.419900) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1461371485.864179-1069483538 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-22 18:10:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 77.6M=0s 2016-04-22 18:10:13 (77.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.208243 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 18:10:13.644385) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 18:10:13.644717) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1461371485.864179-1069483538 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016842 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 18:10:13.698962) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-22 18:10:13.699443) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1385868f8904b7e5f0cc338d2b79225f35e406cd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1385868f8904b7e5f0cc338d2b79225f35e406cd --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=2c5dd2b0a310ecf02fd87158000001b4-1461371485.864179-1069483538 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-22 18:10:13,990 truncating revision to first 12 chars 2016-04-22 18:10:13,990 Setting DEBUG logging. 2016-04-22 18:10:13,990 attempt 1/10 2016-04-22 18:10:13,990 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1385868f8904?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 18:10:15,066 unpacking tar archive at: mozilla-aurora-1385868f8904/testing/mozharness/ program finished with exit code 0 elapsedTime=1.383655 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-22 18:10:15.096806) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 18:10:15.097177) ========= script_repo_revision: 1385868f8904b7e5f0cc338d2b79225f35e406cd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 18:10:15.097642) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 18:10:15.098150) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 18:10:15.107771) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-04-22 18:10:15.108221) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1461371485.864179-1069483538 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:10:15 INFO - MultiFileLogger online at 20160422 18:10:15 in /builds/slave/test 18:10:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 18:10:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:10:15 INFO - {'append_to_log': False, 18:10:15 INFO - 'base_work_dir': '/builds/slave/test', 18:10:15 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 18:10:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:10:15 INFO - 'branch': 'Mozilla-Aurora', 18:10:15 INFO - 'buildbot_json_path': 'buildprops.json', 18:10:15 INFO - 'config_files': ('talos/linux_config.py',), 18:10:15 INFO - 'default_actions': ('clobber', 18:10:15 INFO - 'read-buildbot-config', 18:10:15 INFO - 'download-and-extract', 18:10:15 INFO - 'populate-webroot', 18:10:15 INFO - 'create-virtualenv', 18:10:15 INFO - 'install', 18:10:15 INFO - 'run-tests'), 18:10:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:10:15 INFO - 'download_minidump_stackwalk': True, 18:10:15 INFO - 'download_symbols': 'ondemand', 18:10:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:10:15 INFO - 'tooltool.py': '/tools/tooltool.py', 18:10:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:10:15 INFO - '/tools/misc-python/virtualenv.py')}, 18:10:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:10:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:10:15 INFO - 'installer_path': 'installer.exe', 18:10:15 INFO - 'log_level': 'info', 18:10:15 INFO - 'log_name': 'talos', 18:10:15 INFO - 'log_to_console': True, 18:10:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:10:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:10:15 INFO - 'opt_config_files': (), 18:10:15 INFO - 'pip_index': False, 18:10:15 INFO - 'sps_profile': False, 18:10:15 INFO - 'sps_profile_interval': 0, 18:10:15 INFO - 'suite': 'dromaeojs-e10s', 18:10:15 INFO - 'system_bits': '32', 18:10:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:10:15 INFO - 'title': 'talos-linux64-ix-012', 18:10:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:10:15 INFO - 'use_talos_json': True, 18:10:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:10:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:10:15 INFO - 'work_dir': 'build'} 18:10:15 INFO - ##### 18:10:15 INFO - ##### Running clobber step. 18:10:15 INFO - ##### 18:10:15 INFO - Running pre-action listener: _resource_record_pre_action 18:10:15 INFO - Running main action method: clobber 18:10:15 INFO - rmtree: /builds/slave/test/build 18:10:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:10:15 INFO - Running post-action listener: _resource_record_post_action 18:10:15 INFO - ##### 18:10:15 INFO - ##### Running read-buildbot-config step. 18:10:15 INFO - ##### 18:10:15 INFO - Running pre-action listener: _resource_record_pre_action 18:10:15 INFO - Running main action method: read_buildbot_config 18:10:15 INFO - Using buildbot properties: 18:10:15 INFO - { 18:10:15 INFO - "project": "", 18:10:15 INFO - "product": "firefox", 18:10:15 INFO - "script_repo_revision": "production", 18:10:15 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 18:10:15 INFO - "repository": "", 18:10:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 18:10:15 INFO - "buildid": "20160422155151", 18:10:15 INFO - "pgo_build": "True", 18:10:15 INFO - "basedir": "/builds/slave/test", 18:10:15 INFO - "buildnumber": 234, 18:10:15 INFO - "slavename": "talos-linux64-ix-012", 18:10:15 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:10:15 INFO - "platform": "ubuntu64_hw", 18:10:15 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 18:10:15 INFO - "branch": "mozilla-aurora", 18:10:15 INFO - "repo_path": "releases/mozilla-aurora", 18:10:15 INFO - "revision": "1385868f8904b7e5f0cc338d2b79225f35e406cd", 18:10:15 INFO - "stage_platform": "linux64-pgo", 18:10:15 INFO - "builduid": "92a58d889d074e099675a38285f93169", 18:10:15 INFO - "slavebuilddir": "test" 18:10:15 INFO - } 18:10:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/R2U95CWtR4mlyWgzq70NuQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 18:10:15 INFO - Running post-action listener: _resource_record_post_action 18:10:15 INFO - ##### 18:10:15 INFO - ##### Running download-and-extract step. 18:10:15 INFO - ##### 18:10:15 INFO - Running pre-action listener: _resource_record_pre_action 18:10:15 INFO - Running main action method: download_and_extract 18:10:15 INFO - mkdir: /builds/slave/test/build/tests 18:10:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:10:15 INFO - https://queue.taskcluster.net/v1/task/R2U95CWtR4mlyWgzq70NuQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:10:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2U95CWtR4mlyWgzq70NuQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 18:10:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2U95CWtR4mlyWgzq70NuQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 18:10:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2U95CWtR4mlyWgzq70NuQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 18:10:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2U95CWtR4mlyWgzq70NuQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:10:19 INFO - Downloaded 1448 bytes. 18:10:19 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 18:10:19 INFO - Using the following test package requirements: 18:10:19 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 18:10:19 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 18:10:19 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 18:10:19 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 18:10:19 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 18:10:19 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 18:10:19 INFO - u'jsshell-linux-x86_64.zip'], 18:10:19 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 18:10:19 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 18:10:19 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 18:10:19 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 18:10:19 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 18:10:19 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 18:10:19 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 18:10:19 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 18:10:19 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 18:10:19 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 18:10:19 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 18:10:19 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 18:10:19 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:10:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:10:19 INFO - https://queue.taskcluster.net/v1/task/R2U95CWtR4mlyWgzq70NuQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:10:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2U95CWtR4mlyWgzq70NuQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 18:10:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2U95CWtR4mlyWgzq70NuQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 18:10:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2U95CWtR4mlyWgzq70NuQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 18:10:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2U95CWtR4mlyWgzq70NuQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:10:20 INFO - Downloaded 23358508 bytes. 18:10:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:10:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:10:22 INFO - Return code: 0 18:10:22 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:10:22 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')]} 18:10:22 INFO - https://queue.taskcluster.net/v1/task/R2U95CWtR4mlyWgzq70NuQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:10:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2U95CWtR4mlyWgzq70NuQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 18:10:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2U95CWtR4mlyWgzq70NuQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 18:10:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2U95CWtR4mlyWgzq70NuQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 18:10:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2U95CWtR4mlyWgzq70NuQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:10:39 INFO - Downloaded 23358508 bytes. 18:10:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:10:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:10:40 INFO - Return code: 0 18:10:40 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')]} 18:10:40 INFO - https://queue.taskcluster.net/v1/task/R2U95CWtR4mlyWgzq70NuQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:10:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2U95CWtR4mlyWgzq70NuQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 18:10:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2U95CWtR4mlyWgzq70NuQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 18:10:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2U95CWtR4mlyWgzq70NuQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 18:10:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2U95CWtR4mlyWgzq70NuQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:10:42 INFO - Downloaded 10845198 bytes. 18:10:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:10:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 18:10:42 INFO - Return code: 0 18:10:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:10:42 INFO - https://queue.taskcluster.net/v1/task/R2U95CWtR4mlyWgzq70NuQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:10:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2U95CWtR4mlyWgzq70NuQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 18:10:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2U95CWtR4mlyWgzq70NuQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 18:10:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2U95CWtR4mlyWgzq70NuQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 18:10:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2U95CWtR4mlyWgzq70NuQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:10:44 INFO - Downloaded 60840363 bytes. 18:10:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R2U95CWtR4mlyWgzq70NuQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 18:10:44 INFO - mkdir: /builds/slave/test/properties 18:10:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:10:44 INFO - Writing to file /builds/slave/test/properties/build_url 18:10:44 INFO - Contents: 18:10:44 INFO - build_url:https://queue.taskcluster.net/v1/task/R2U95CWtR4mlyWgzq70NuQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 18:10:45 INFO - Running post-action listener: _resource_record_post_action 18:10:45 INFO - Running post-action listener: set_extra_try_arguments 18:10:45 INFO - ##### 18:10:45 INFO - ##### Running populate-webroot step. 18:10:45 INFO - ##### 18:10:45 INFO - Running pre-action listener: _resource_record_pre_action 18:10:45 INFO - Running main action method: populate_webroot 18:10:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:10:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:10:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:10:45 INFO - '--tppagecycles', 18:10:45 INFO - '7'], 18:10:45 INFO - 'tests': ['tsvgm']}}, 18:10:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:10:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:10:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:10:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:10:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:10:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:10:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:10:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:10:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:10:45 INFO - 'talos_options': ['--e10s'], 18:10:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:10:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:10:45 INFO - 'tests': ['damp', 'tps']}, 18:10:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:10:45 INFO - 'talos_options': ['--e10s'], 18:10:45 INFO - 'tests': ['damp', 'tps']}, 18:10:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:10:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:10:45 INFO - 'other': {'tests': ['a11yr', 18:10:45 INFO - 'ts_paint', 18:10:45 INFO - 'tpaint', 18:10:45 INFO - 'sessionrestore', 18:10:45 INFO - 'sessionrestore_no_auto_restore', 18:10:45 INFO - 'tabpaint']}, 18:10:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:10:45 INFO - 'tests': ['a11yr', 18:10:45 INFO - 'ts_paint', 18:10:45 INFO - 'tpaint', 18:10:45 INFO - 'sessionrestore', 18:10:45 INFO - 'sessionrestore_no_auto_restore', 18:10:45 INFO - 'tabpaint']}, 18:10:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:10:45 INFO - 'tests': ['a11yr', 18:10:45 INFO - 'ts_paint', 18:10:45 INFO - 'tpaint', 18:10:45 INFO - 'sessionrestore', 18:10:45 INFO - 'sessionrestore_no_auto_restore', 18:10:45 INFO - 'tabpaint']}, 18:10:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:10:45 INFO - 'tests': ['a11yr', 18:10:45 INFO - 'ts_paint', 18:10:45 INFO - 'tpaint', 18:10:45 INFO - 'sessionrestore', 18:10:45 INFO - 'sessionrestore_no_auto_restore', 18:10:45 INFO - 'tabpaint']}, 18:10:45 INFO - 'other_l64': {'tests': ['a11yr', 18:10:45 INFO - 'ts_paint', 18:10:45 INFO - 'tpaint', 18:10:45 INFO - 'sessionrestore', 18:10:45 INFO - 'sessionrestore_no_auto_restore', 18:10:45 INFO - 'tabpaint']}, 18:10:45 INFO - 'other_nol64': {'tests': ['a11yr', 18:10:45 INFO - 'ts_paint', 18:10:45 INFO - 'tpaint', 18:10:45 INFO - 'sessionrestore', 18:10:45 INFO - 'sessionrestore_no_auto_restore', 18:10:45 INFO - 'tabpaint']}, 18:10:45 INFO - 'svgr': {'tests': ['tsvgx', 18:10:45 INFO - 'tsvgr_opacity', 18:10:45 INFO - 'tart', 18:10:45 INFO - 'tscrollx', 18:10:45 INFO - 'cart']}, 18:10:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:10:45 INFO - 'tests': ['tsvgx', 18:10:45 INFO - 'tsvgr_opacity', 18:10:45 INFO - 'tart', 18:10:45 INFO - 'tscrollx', 18:10:45 INFO - 'cart']}, 18:10:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:10:45 INFO - 'tests': ['tp5o']}, 18:10:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:10:45 INFO - 'talos_options': ['--e10s'], 18:10:45 INFO - 'tests': ['tp5o']}, 18:10:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:10:45 INFO - 'talos_options': ['--xperf_path', 18:10:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:10:45 INFO - 'tests': ['tp5n']}, 18:10:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:10:45 INFO - 'talos_options': ['--e10s', 18:10:45 INFO - '--xperf_path', 18:10:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:10:45 INFO - 'tests': ['tp5n']}}, 18:10:45 INFO - 'talos.zip': {'path': '', 18:10:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:10:45 INFO - Running post-action listener: _resource_record_post_action 18:10:45 INFO - ##### 18:10:45 INFO - ##### Running create-virtualenv step. 18:10:45 INFO - ##### 18:10:45 INFO - Running pre-action listener: _resource_record_pre_action 18:10:45 INFO - Running main action method: create_virtualenv 18:10:45 INFO - Creating virtualenv /builds/slave/test/build/venv 18:10:45 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 18:10:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:10:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:10:45 INFO - Using real prefix '/usr' 18:10:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:10:45 INFO - Installing distribute.............................................................................................................................................................................................done. 18:10:47 INFO - Installing pip.................done. 18:10:47 INFO - Return code: 0 18:10:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:10:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:10:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:47 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 0x7fbb5d128f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe80410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0f160>, '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 0xf10060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf104f0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461371485.864179-1069483538', '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 18:10:47 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 18:10:47 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 18:10:47 INFO - Using env: {'DISPLAY': ':0', 18:10:47 INFO - 'HOME': '/home/cltbld', 18:10:47 INFO - 'LANG': 'en_US.UTF-8', 18:10:47 INFO - 'LANGUAGE': 'en_US:en', 18:10:47 INFO - 'LOGNAME': 'cltbld', 18:10:47 INFO - 'MAIL': '/var/mail/cltbld', 18:10:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:47 INFO - 'MOZ_NO_REMOTE': '1', 18:10:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:10:47 INFO - 'NO_EM_RESTART': '1', 18:10:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:10:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:47 INFO - 'PWD': '/builds/slave/test', 18:10:47 INFO - 'SHELL': '/bin/bash', 18:10:47 INFO - 'SHLVL': '1', 18:10:47 INFO - 'TERM': 'linux', 18:10:47 INFO - 'TMOUT': '86400', 18:10:47 INFO - 'USER': 'cltbld', 18:10:47 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461371485.864179-1069483538', 18:10:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:47 INFO - '_': '/tools/buildbot/bin/python'} 18:10:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:48 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 18:10:48 INFO - Cleaning up... 18:10:48 INFO - Return code: 0 18:10:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:10:48 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')]} 18:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:48 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')]} 18:10:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:48 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 0x7fbb5d128f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe80410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0f160>, '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 0xf10060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf104f0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461371485.864179-1069483538', '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 18:10:48 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 18:10:48 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 18:10:48 INFO - Using env: {'DISPLAY': ':0', 18:10:48 INFO - 'HOME': '/home/cltbld', 18:10:48 INFO - 'LANG': 'en_US.UTF-8', 18:10:48 INFO - 'LANGUAGE': 'en_US:en', 18:10:48 INFO - 'LOGNAME': 'cltbld', 18:10:48 INFO - 'MAIL': '/var/mail/cltbld', 18:10:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:48 INFO - 'MOZ_NO_REMOTE': '1', 18:10:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:10:48 INFO - 'NO_EM_RESTART': '1', 18:10:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:10:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:48 INFO - 'PWD': '/builds/slave/test', 18:10:48 INFO - 'SHELL': '/bin/bash', 18:10:48 INFO - 'SHLVL': '1', 18:10:48 INFO - 'TERM': 'linux', 18:10:48 INFO - 'TMOUT': '86400', 18:10:48 INFO - 'USER': 'cltbld', 18:10:48 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461371485.864179-1069483538', 18:10:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:48 INFO - '_': '/tools/buildbot/bin/python'} 18:10:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:48 INFO - Downloading/unpacking psutil>=0.7.1 18:10:48 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 18:10:48 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 18:10:48 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 18:10:48 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 18:10:48 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 18:10:48 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 18:10:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:10:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:10:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:10:50 INFO - Installing collected packages: psutil 18:10:50 INFO - Running setup.py install for psutil 18:10:50 INFO - building 'psutil._psutil_linux' extension 18:10:50 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 18:10:50 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 18:10:50 INFO - building 'psutil._psutil_posix' extension 18:10:50 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 18:10:50 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 18:10:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:10:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:10:50 INFO - Successfully installed psutil 18:10:50 INFO - Cleaning up... 18:10:50 INFO - Return code: 0 18:10:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:10:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:10:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:10:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbb5d128f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe80410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0f160>, '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 0xf10060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf104f0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461371485.864179-1069483538', '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 18:10:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 18:10:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:10:50 INFO - Using env: {'DISPLAY': ':0', 18:10:50 INFO - 'HOME': '/home/cltbld', 18:10:50 INFO - 'LANG': 'en_US.UTF-8', 18:10:50 INFO - 'LANGUAGE': 'en_US:en', 18:10:50 INFO - 'LOGNAME': 'cltbld', 18:10:50 INFO - 'MAIL': '/var/mail/cltbld', 18:10:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:50 INFO - 'MOZ_NO_REMOTE': '1', 18:10:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:10:50 INFO - 'NO_EM_RESTART': '1', 18:10:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:10:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:50 INFO - 'PWD': '/builds/slave/test', 18:10:50 INFO - 'SHELL': '/bin/bash', 18:10:50 INFO - 'SHLVL': '1', 18:10:50 INFO - 'TERM': 'linux', 18:10:50 INFO - 'TMOUT': '86400', 18:10:50 INFO - 'USER': 'cltbld', 18:10:50 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461371485.864179-1069483538', 18:10:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:50 INFO - '_': '/tools/buildbot/bin/python'} 18:10:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:10:51 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 18:10:51 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 18:10:51 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 18:10:51 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 18:10:51 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 18:10:51 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 18:10:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:10:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:10:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:10:53 INFO - Installing collected packages: mozsystemmonitor 18:10:53 INFO - Running setup.py install for mozsystemmonitor 18:10:53 INFO - Successfully installed mozsystemmonitor 18:10:53 INFO - Cleaning up... 18:10:53 INFO - Return code: 0 18:10:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:10:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:10:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:53 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 0x7fbb5d128f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe80410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0f160>, '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 0xf10060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf104f0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461371485.864179-1069483538', '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 18:10:53 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 18:10:53 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 18:10:53 INFO - Using env: {'DISPLAY': ':0', 18:10:53 INFO - 'HOME': '/home/cltbld', 18:10:53 INFO - 'LANG': 'en_US.UTF-8', 18:10:53 INFO - 'LANGUAGE': 'en_US:en', 18:10:53 INFO - 'LOGNAME': 'cltbld', 18:10:53 INFO - 'MAIL': '/var/mail/cltbld', 18:10:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:53 INFO - 'MOZ_NO_REMOTE': '1', 18:10:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:10:53 INFO - 'NO_EM_RESTART': '1', 18:10:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:10:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:53 INFO - 'PWD': '/builds/slave/test', 18:10:53 INFO - 'SHELL': '/bin/bash', 18:10:53 INFO - 'SHLVL': '1', 18:10:53 INFO - 'TERM': 'linux', 18:10:53 INFO - 'TMOUT': '86400', 18:10:53 INFO - 'USER': 'cltbld', 18:10:53 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461371485.864179-1069483538', 18:10:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:53 INFO - '_': '/tools/buildbot/bin/python'} 18:10:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:53 INFO - Downloading/unpacking blobuploader==1.2.4 18:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:55 INFO - Downloading blobuploader-1.2.4.tar.gz 18:10:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:10:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:10:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:55 INFO - Downloading docopt-0.6.1.tar.gz 18:10:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:10:56 INFO - Installing collected packages: blobuploader, requests, docopt 18:10:56 INFO - Running setup.py install for blobuploader 18:10:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:10:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:10:56 INFO - Running setup.py install for requests 18:10:56 INFO - Running setup.py install for docopt 18:10:56 INFO - Successfully installed blobuploader requests docopt 18:10:56 INFO - Cleaning up... 18:10:56 INFO - Return code: 0 18:10:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:10:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:10:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:56 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 0x7fbb5d128f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe80410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0f160>, '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 0xf10060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf104f0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461371485.864179-1069483538', '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 18:10:56 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 18:10:56 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 18:10:56 INFO - Using env: {'DISPLAY': ':0', 18:10:56 INFO - 'HOME': '/home/cltbld', 18:10:56 INFO - 'LANG': 'en_US.UTF-8', 18:10:56 INFO - 'LANGUAGE': 'en_US:en', 18:10:56 INFO - 'LOGNAME': 'cltbld', 18:10:56 INFO - 'MAIL': '/var/mail/cltbld', 18:10:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:56 INFO - 'MOZ_NO_REMOTE': '1', 18:10:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:10:56 INFO - 'NO_EM_RESTART': '1', 18:10:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:10:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:56 INFO - 'PWD': '/builds/slave/test', 18:10:56 INFO - 'SHELL': '/bin/bash', 18:10:56 INFO - 'SHLVL': '1', 18:10:56 INFO - 'TERM': 'linux', 18:10:56 INFO - 'TMOUT': '86400', 18:10:56 INFO - 'USER': 'cltbld', 18:10:56 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461371485.864179-1069483538', 18:10:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:56 INFO - '_': '/tools/buildbot/bin/python'} 18:10:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:10:56 INFO - Running setup.py (path:/tmp/pip-Q7H4z3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:10:56 INFO - Running setup.py (path:/tmp/pip-2j2405-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:10:56 INFO - Running setup.py (path:/tmp/pip-62rMf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:10:57 INFO - Running setup.py (path:/tmp/pip-TB6NuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:10:57 INFO - Running setup.py (path:/tmp/pip-SlpArk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:10:57 INFO - Running setup.py (path:/tmp/pip-iCzWXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:10:57 INFO - Running setup.py (path:/tmp/pip-rerUzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:10:57 INFO - Running setup.py (path:/tmp/pip-Wm7LZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:10:57 INFO - Running setup.py (path:/tmp/pip-EdHB15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:10:57 INFO - Running setup.py (path:/tmp/pip-Rs48DL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:10:57 INFO - Running setup.py (path:/tmp/pip-MUWZtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:10:57 INFO - Running setup.py (path:/tmp/pip-9_UdN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:10:57 INFO - Running setup.py (path:/tmp/pip-Pl7oK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:10:57 INFO - Running setup.py (path:/tmp/pip-XJIgYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:10:57 INFO - Running setup.py (path:/tmp/pip-2HOSN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:10:57 INFO - Running setup.py (path:/tmp/pip-kbHd8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:10:57 INFO - Running setup.py (path:/tmp/pip-MGdaHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:10:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:10:58 INFO - Running setup.py install for manifestparser 18:10:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:10:58 INFO - Running setup.py install for mozcrash 18:10:58 INFO - Running setup.py install for mozdebug 18:10:58 INFO - Running setup.py install for mozdevice 18:10:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:10:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:10:58 INFO - Running setup.py install for mozfile 18:10:58 INFO - Running setup.py install for mozhttpd 18:10:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:10:58 INFO - Running setup.py install for mozinfo 18:10:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:10:58 INFO - Running setup.py install for mozInstall 18:10:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:10:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:10:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:10:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:10:58 INFO - Running setup.py install for mozleak 18:10:58 INFO - Running setup.py install for mozlog 18:10:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:10:59 INFO - Running setup.py install for moznetwork 18:10:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:10:59 INFO - Running setup.py install for mozprocess 18:10:59 INFO - Running setup.py install for mozprofile 18:10:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:10:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:10:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:10:59 INFO - Running setup.py install for mozrunner 18:10:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:10:59 INFO - Running setup.py install for mozscreenshot 18:10:59 INFO - Running setup.py install for moztest 18:10:59 INFO - Running setup.py install for mozversion 18:10:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:10:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:10:59 INFO - Cleaning up... 18:10:59 INFO - Return code: 0 18:10:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:10:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:10:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:59 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 0x7fbb5d128f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe80410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0f160>, '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 0xf10060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf104f0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461371485.864179-1069483538', '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 18:10:59 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 18:10:59 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 18:10:59 INFO - Using env: {'DISPLAY': ':0', 18:10:59 INFO - 'HOME': '/home/cltbld', 18:10:59 INFO - 'LANG': 'en_US.UTF-8', 18:10:59 INFO - 'LANGUAGE': 'en_US:en', 18:10:59 INFO - 'LOGNAME': 'cltbld', 18:10:59 INFO - 'MAIL': '/var/mail/cltbld', 18:10:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:59 INFO - 'MOZ_NO_REMOTE': '1', 18:10:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:10:59 INFO - 'NO_EM_RESTART': '1', 18:10:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:10:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:59 INFO - 'PWD': '/builds/slave/test', 18:10:59 INFO - 'SHELL': '/bin/bash', 18:10:59 INFO - 'SHLVL': '1', 18:10:59 INFO - 'TERM': 'linux', 18:10:59 INFO - 'TMOUT': '86400', 18:10:59 INFO - 'USER': 'cltbld', 18:10:59 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461371485.864179-1069483538', 18:10:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:59 INFO - '_': '/tools/buildbot/bin/python'} 18:11:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:11:00 INFO - Running setup.py (path:/tmp/pip-54uagZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:11:00 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)) 18:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:11:00 INFO - Running setup.py (path:/tmp/pip-p1bCWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:11:00 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)) 18:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:11:00 INFO - Running setup.py (path:/tmp/pip-aol4tX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:11:00 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)) 18:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:11:00 INFO - Running setup.py (path:/tmp/pip-cUwIOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:11:00 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)) 18:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:11:00 INFO - Running setup.py (path:/tmp/pip-Pev1s3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:11:00 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)) 18:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:11:00 INFO - Running setup.py (path:/tmp/pip-lOmEat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:11:00 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)) 18:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:11:00 INFO - Running setup.py (path:/tmp/pip-l7KBda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:11:00 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)) 18:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:11:00 INFO - Running setup.py (path:/tmp/pip-DKWqX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:11:00 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)) 18:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:11:00 INFO - Running setup.py (path:/tmp/pip-xx1RN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:11:00 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)) 18:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:11:00 INFO - Running setup.py (path:/tmp/pip-2yMfrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:11:00 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)) 18:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:11:00 INFO - Running setup.py (path:/tmp/pip-QlyVUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:11:00 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)) 18:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:11:00 INFO - Running setup.py (path:/tmp/pip-1kXWVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:11:00 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)) 18:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:11:00 INFO - Running setup.py (path:/tmp/pip-dydk6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:11:01 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)) 18:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:11:01 INFO - Running setup.py (path:/tmp/pip-92lsQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:11:01 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)) 18:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:11:01 INFO - Running setup.py (path:/tmp/pip-eKb3nq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:11:01 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)) 18:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:11:01 INFO - Running setup.py (path:/tmp/pip-TKet6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:11:01 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)) 18:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:11:01 INFO - Running setup.py (path:/tmp/pip-Cx99jL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:11:01 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)) 18:11:01 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)) 18:11:01 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)) 18:11:01 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)) 18:11:01 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)) 18:11:01 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)) 18:11:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:11:01 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 18:11:01 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 18:11:01 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 18:11:01 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 18:11:01 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 18:11:01 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 18:11:03 INFO - Downloading blessings-1.6.tar.gz 18:11:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:11:03 INFO - Installing collected packages: blessings 18:11:03 INFO - Running setup.py install for blessings 18:11:03 INFO - Successfully installed blessings 18:11:03 INFO - Cleaning up... 18:11:03 INFO - Return code: 0 18:11:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:11:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:11:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:11:03 INFO - Reading from file tmpfile_stdout 18:11:03 INFO - Current package versions: 18:11:03 INFO - argparse == 1.2.1 18:11:03 INFO - blessings == 1.6 18:11:03 INFO - blobuploader == 1.2.4 18:11:03 INFO - docopt == 0.6.1 18:11:03 INFO - manifestparser == 1.1 18:11:03 INFO - mozInstall == 1.12 18:11:03 INFO - mozcrash == 0.17 18:11:03 INFO - mozdebug == 0.1 18:11:03 INFO - mozdevice == 0.48 18:11:03 INFO - mozfile == 1.2 18:11:03 INFO - mozhttpd == 0.7 18:11:03 INFO - mozinfo == 0.9 18:11:03 INFO - mozleak == 0.1 18:11:03 INFO - mozlog == 3.1 18:11:03 INFO - moznetwork == 0.27 18:11:03 INFO - mozprocess == 0.22 18:11:03 INFO - mozprofile == 0.28 18:11:03 INFO - mozrunner == 6.11 18:11:03 INFO - mozscreenshot == 0.1 18:11:03 INFO - mozsystemmonitor == 0.0 18:11:03 INFO - moztest == 0.7 18:11:03 INFO - mozversion == 1.4 18:11:03 INFO - psutil == 3.1.1 18:11:03 INFO - requests == 1.2.3 18:11:03 INFO - wsgiref == 0.1.2 18:11:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:11: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')]} 18:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11: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')]} 18:11:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:03 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 0x7fbb5d128f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe80410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0f160>, '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 0xf10060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf104f0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461371485.864179-1069483538', '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 18:11:03 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 18:11:03 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 18:11:03 INFO - Using env: {'DISPLAY': ':0', 18:11:03 INFO - 'HOME': '/home/cltbld', 18:11:03 INFO - 'LANG': 'en_US.UTF-8', 18:11:03 INFO - 'LANGUAGE': 'en_US:en', 18:11:03 INFO - 'LOGNAME': 'cltbld', 18:11:03 INFO - 'MAIL': '/var/mail/cltbld', 18:11:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:03 INFO - 'MOZ_NO_REMOTE': '1', 18:11:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:11:03 INFO - 'NO_EM_RESTART': '1', 18:11:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:11:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:03 INFO - 'PWD': '/builds/slave/test', 18:11:03 INFO - 'SHELL': '/bin/bash', 18:11:03 INFO - 'SHLVL': '1', 18:11:03 INFO - 'TERM': 'linux', 18:11:03 INFO - 'TMOUT': '86400', 18:11:03 INFO - 'USER': 'cltbld', 18:11:03 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461371485.864179-1069483538', 18:11:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:03 INFO - '_': '/tools/buildbot/bin/python'} 18:11:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:03 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)) 18:11:03 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)) 18:11:03 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)) 18:11:03 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)) 18:11:03 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)) 18:11:03 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)) 18:11:03 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)) 18:11:03 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)) 18:11:03 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)) 18:11:03 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)) 18:11:03 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)) 18:11:03 INFO - Cleaning up... 18:11:03 INFO - Return code: 0 18:11:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:11: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')]} 18:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11: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')]} 18:11:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb5d128f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe80410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0f160>, '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 0xf10060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf104f0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461371485.864179-1069483538', '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 18:11: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', 'jsonschema'] in /builds/slave/test/build 18:11: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 jsonschema 18:11:03 INFO - Using env: {'DISPLAY': ':0', 18:11:03 INFO - 'HOME': '/home/cltbld', 18:11:03 INFO - 'LANG': 'en_US.UTF-8', 18:11:03 INFO - 'LANGUAGE': 'en_US:en', 18:11:03 INFO - 'LOGNAME': 'cltbld', 18:11:03 INFO - 'MAIL': '/var/mail/cltbld', 18:11:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:03 INFO - 'MOZ_NO_REMOTE': '1', 18:11:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:11:03 INFO - 'NO_EM_RESTART': '1', 18:11:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:11:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:03 INFO - 'PWD': '/builds/slave/test', 18:11:03 INFO - 'SHELL': '/bin/bash', 18:11:03 INFO - 'SHLVL': '1', 18:11:03 INFO - 'TERM': 'linux', 18:11:03 INFO - 'TMOUT': '86400', 18:11:03 INFO - 'USER': 'cltbld', 18:11:03 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461371485.864179-1069483538', 18:11:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:03 INFO - '_': '/tools/buildbot/bin/python'} 18:11:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:04 INFO - Downloading/unpacking jsonschema 18:11:04 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 18:11:04 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 18:11:04 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 18:11:04 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 18:11:04 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 18:11:04 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 18:11:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:11:05 INFO - Downloading/unpacking functools32 (from jsonschema) 18:11:05 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 18:11:05 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 18:11:05 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 18:11:05 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 18:11:05 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 18:11:05 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 18:11:06 INFO - Downloading functools32-3.2.3-2.tar.gz 18:11:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:11:06 INFO - warning: no files found matching '*.txt' 18:11:06 INFO - no previously-included directories found matching 'build' 18:11:06 INFO - no previously-included directories found matching 'dist' 18:11:06 INFO - no previously-included directories found matching '.git*' 18:11:06 INFO - Installing collected packages: jsonschema, functools32 18:11:06 INFO - Running setup.py install for functools32 18:11:06 INFO - warning: no files found matching '*.txt' 18:11:06 INFO - no previously-included directories found matching 'build' 18:11:06 INFO - no previously-included directories found matching 'dist' 18:11:06 INFO - no previously-included directories found matching '.git*' 18:11:06 INFO - Successfully installed jsonschema functools32 18:11:06 INFO - Cleaning up... 18:11:06 INFO - Return code: 0 18:11:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:11:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:06 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 0x7fbb5d128f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe80410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0f160>, '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 0xf10060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf104f0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461371485.864179-1069483538', '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 18:11:06 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 18:11:06 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 18:11:06 INFO - Using env: {'DISPLAY': ':0', 18:11:06 INFO - 'HOME': '/home/cltbld', 18:11:06 INFO - 'LANG': 'en_US.UTF-8', 18:11:06 INFO - 'LANGUAGE': 'en_US:en', 18:11:06 INFO - 'LOGNAME': 'cltbld', 18:11:06 INFO - 'MAIL': '/var/mail/cltbld', 18:11:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:06 INFO - 'MOZ_NO_REMOTE': '1', 18:11:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:11:06 INFO - 'NO_EM_RESTART': '1', 18:11:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:11:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:06 INFO - 'PWD': '/builds/slave/test', 18:11:06 INFO - 'SHELL': '/bin/bash', 18:11:06 INFO - 'SHLVL': '1', 18:11:06 INFO - 'TERM': 'linux', 18:11:06 INFO - 'TMOUT': '86400', 18:11:06 INFO - 'USER': 'cltbld', 18:11:06 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461371485.864179-1069483538', 18:11:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:06 INFO - '_': '/tools/buildbot/bin/python'} 18:11:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:06 INFO - Downloading/unpacking flake8 18:11: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 18:11: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 18:11: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 18:11: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 18:11: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 18:11: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 18:11:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:11:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:11: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 18:11: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 18:11: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 18:11: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 18:11: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 18:11: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 18:11:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:11:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:11: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 18:11: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 18:11: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 18:11: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 18:11: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 18:11: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 18:11:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:11: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 18:11: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 18:11: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 18:11: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 18:11: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 18:11: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 18:11:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:11:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:11:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:11:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:11:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:11:09 INFO - no previously-included directories found matching 'docs/_build' 18:11:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:11:09 INFO - Running setup.py install for pep8 18:11:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:11:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:11:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:11:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:11:09 INFO - no previously-included directories found matching 'docs/_build' 18:11:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:11:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:11:09 INFO - Cleaning up... 18:11:09 INFO - Return code: 0 18:11:09 INFO - Running post-action listener: _resource_record_post_action 18:11:09 INFO - Running post-action listener: _start_resource_monitoring 18:11:09 INFO - Starting resource monitoring. 18:11:09 INFO - ##### 18:11:09 INFO - ##### Running install step. 18:11:09 INFO - ##### 18:11:09 INFO - Running pre-action listener: _resource_record_pre_action 18:11:09 INFO - Running main action method: install 18:11:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:11:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:11:09 INFO - Reading from file tmpfile_stdout 18:11:09 INFO - Detecting whether we're running mozinstall >=1.0... 18:11:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:11:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:11:09 INFO - Reading from file tmpfile_stdout 18:11:09 INFO - Output received: 18:11:09 INFO - Usage: mozinstall [options] installer 18:11:09 INFO - Options: 18:11:09 INFO - -h, --help show this help message and exit 18:11:09 INFO - -d DEST, --destination=DEST 18:11:09 INFO - Directory to install application into. [default: 18:11:09 INFO - "/builds/slave/test"] 18:11:09 INFO - --app=APP Application being installed. [default: firefox] 18:11:09 INFO - mkdir: /builds/slave/test/build/application 18:11:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:11:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:11:24 INFO - Reading from file tmpfile_stdout 18:11:25 INFO - Output received: 18:11:25 INFO - /builds/slave/test/build/application/firefox/firefox 18:11:25 INFO - Running post-action listener: _resource_record_post_action 18:11:25 INFO - ##### 18:11:25 INFO - ##### Running run-tests step. 18:11:25 INFO - ##### 18:11:25 INFO - Running pre-action listener: _resource_record_pre_action 18:11:25 INFO - Running main action method: run_tests 18:11:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:11:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:11:25 INFO - Python 2.7.3 18:11:25 INFO - Return code: 0 18:11:25 INFO - grabbing minidump binary from tooltool 18:11:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:11:25 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 0xf0f160>, '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 0xf10060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf104f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:11:25 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 18:11:25 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 18:11:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:11:25 INFO - Return code: 0 18:11:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:11:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:11:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:11:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:11:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:11:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:11:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:11:26 INFO - Return code: 0 18:11:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R2U95CWtR4mlyWgzq70NuQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:11:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/R2U95CWtR4mlyWgzq70NuQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:11:26 INFO - Using env: {'DISPLAY': ':0', 18:11:26 INFO - 'HOME': '/home/cltbld', 18:11:26 INFO - 'LANG': 'en_US.UTF-8', 18:11:26 INFO - 'LANGUAGE': 'en_US:en', 18:11:26 INFO - 'LOGNAME': 'cltbld', 18:11:26 INFO - 'MAIL': '/var/mail/cltbld', 18:11:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:11:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:26 INFO - 'MOZ_NO_REMOTE': '1', 18:11:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:11:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:11:26 INFO - 'NO_EM_RESTART': '1', 18:11:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:26 INFO - 'PWD': '/builds/slave/test', 18:11:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:11:26 INFO - 'SHELL': '/bin/bash', 18:11:26 INFO - 'SHLVL': '1', 18:11:26 INFO - 'TERM': 'linux', 18:11:26 INFO - 'TMOUT': '86400', 18:11:26 INFO - 'USER': 'cltbld', 18:11:26 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461371485.864179-1069483538', 18:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:26 INFO - '_': '/tools/buildbot/bin/python'} 18:11:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R2U95CWtR4mlyWgzq70NuQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:11:26 INFO - mozversion application_buildid: 20160422155151 18:11:26 INFO - mozversion application_changeset: 1385868f8904b7e5f0cc338d2b79225f35e406cd 18:11:26 INFO - mozversion application_display_name: FirefoxDeveloperEdition 18:11:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:11:26 INFO - mozversion application_name: Firefox 18:11:26 INFO - mozversion application_remotingname: firefox-dev 18:11:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:11:26 INFO - mozversion application_vendor: Mozilla 18:11:26 INFO - mozversion application_version: 47.0a2 18:11:26 INFO - mozversion platform_buildid: 20160422155151 18:11:26 INFO - mozversion platform_changeset: 1385868f8904b7e5f0cc338d2b79225f35e406cd 18:11:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:11:26 INFO - mozversion platform_version: 47.0a2 18:11:26 INFO - using testdate: 1461373886 18:11:26 INFO - actual date: 1461373886 18:11:26 INFO - starting webserver on 'localhost:48570' 18:11:26 INFO - SUITE-START | Running 2 tests 18:11:26 INFO - TEST-START | dromaeo_css 18:11:26 INFO - operating with platform_type : linux_ 18:11:26 INFO - Initialising browser for dromaeo_css test... 18:11:26 INFO - TEST-INFO | started process 29357 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAYP0XW/profile http://localhost:48570/getInfo.html) 18:11:29 INFO - PROCESS | 29357 | 18:11:29 INFO - PROCESS | 29357 | (process:29435): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:11:30 INFO - PROCESS | 29357 | __metrics Screen width/height:1600/1200 18:11:30 INFO - PROCESS | 29357 | colorDepth:24 18:11:30 INFO - PROCESS | 29357 | Browser inner width/height: 1024/697 18:11:30 INFO - PROCESS | 29357 | __metrics 18:11:31 ERROR - PROCESS | 29357 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 18:11:32 INFO - TEST-INFO | 29357: exit 0 18:11:32 INFO - Browser initialized. 18:11:32 INFO - Running cycle 1/1 for dromaeo_css test... 18:11:32 INFO - TEST-INFO | started process 29486 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAYP0XW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:11:33 INFO - PROCESS | 29486 | 18:11:33 INFO - PROCESS | 29486 | (process:29556): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:11:43 INFO - PROCESS | 29486 | RSS: Main: 151117824 18:11:43 INFO - PROCESS | 29486 | 18:12:33 INFO - PROCESS | 29486 | 1461373953516 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] 18:14:41 INFO - PROCESS | 29486 | Cycle 1(1): loaded http://localhost:48570/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48570/tests/dromaeo/cssquery-ext.html) 18:14:42 INFO - PROCESS | 29486 | RSS: Main: 155430912 18:14:42 INFO - PROCESS | 29486 | 18:17:44 INFO - PROCESS | 29486 | Cycle 1(1): loaded http://localhost:48570/tests/dromaeo/cssquery-ext.html (next: http://localhost:48570/tests/dromaeo/cssquery-jquery.html) 18:17:45 INFO - PROCESS | 29486 | RSS: Main: 153698304 18:17:45 INFO - PROCESS | 29486 | 18:20:46 INFO - PROCESS | 29486 | Cycle 1(1): loaded http://localhost:48570/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48570/tests/dromaeo/cssquery-mootools.html) 18:20:47 INFO - PROCESS | 29486 | RSS: Main: 153186304 18:20:47 INFO - PROCESS | 29486 | 18:23:49 INFO - PROCESS | 29486 | Cycle 1(1): loaded http://localhost:48570/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48570/tests/dromaeo/cssquery-prototype.html) 18:23:49 INFO - PROCESS | 29486 | RSS: Main: 152539136 18:23:49 INFO - PROCESS | 29486 | 18:26:52 INFO - PROCESS | 29486 | Cycle 1(1): loaded http://localhost:48570/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48570/tests/dromaeo/cssquery-yui.html) 18:26:52 INFO - PROCESS | 29486 | RSS: Main: 153485312 18:26:52 INFO - PROCESS | 29486 | 18:29:54 INFO - PROCESS | 29486 | Cycle 1(1): loaded http://localhost:48570/tests/dromaeo/cssquery-yui.html (next: http://localhost:48570/tests/dromaeo/cssquery-dojo.html) 18:29:55 INFO - PROCESS | 29486 | RSS: Main: 155676672 18:29:55 INFO - PROCESS | 29486 | 18:29:55 INFO - PROCESS | 29486 | __start_tp_report 18:29:55 INFO - PROCESS | 29486 | _x_x_mozilla_page_load 18:29:55 INFO - PROCESS | 29486 | _x_x_mozilla_page_load_details 18:29:55 INFO - PROCESS | 29486 | |i|pagename|runs| 18:29:55 INFO - PROCESS | 29486 | |0;dojo.html;3340.6993370596647;3412.812295323757;3432.2277487565316;3461.723062155028;3478.947815782764;5549.445055494449;5566.4990150886415;5569.805056823012;5572;5591.2731344925205;5535.861603459915;5572.4148964358665;5599.580031497633;5602.467765562265;5650.51970582501;5066.062778386001;5097.541221290083;5129.948700513003;5170.844874653748;5191.117510023286;5057.898842023157;5154.974225128869;5173.249878767577;5175.534201921826;5194.35070616173;5117.46266642001;5188.04021256067;5222.086134926391;5231.764570594313;5232.189010703347;5178.559822415099;5184.455632158607;5198.27224188612;5220.269162317279;5253.737313134328;4968.925466118011;4988.451270360258;5045.520675535819;5093.236014597803;5109.284700141983;5398.406175320712;5428.45715428458;5443.265159203496;5450.209719590677;5493.313335833021;6036.0945858121195;6069.180660610805;6071.605345652519;6088.391160883876;6092.329843717188;5967.49276311514;6036.8188954331445;6101.420365065312;6103.23709536308;6115.785947491817;5671.886562268732;5681.943180568224;5687.488126068673;5693.5445164387165;5714.914276285859;6147.415995480422;6195.070739389128;6207.689615519206;6216.720247588869;6219.626822390671;5772.134179873053;5956.821295361146;6048.485878700271;6057.182280392179;6095.725692343766;6054.66699331541;6069.848253793691;6079.817605471843;6087.817365479043;6103.05402662588;5877.5591830612875;6025.096235564701;6025.67435164272;6040.546958978094;6047.969760151171;5962.046072628359;6013.579049466495;6060.393960603992;6069.696515174312;6073.665948372882;4564.794584243717;4566.74882881438;4568.703034302826;4578.313253012075;4592.678512504092;4038.6163314485075;4080.3063479208604;4114.7119701621195;4114.979425102855;4143.212789569972;5664.490195882308;5726.284214473191;5792.739326730307;5824.213731146326;5851.795187168514;6015.608985415934;6033.698315084228;6035.486983606443;6046.062860256668;6064.787732429344;5509.090999984957;5713.085906255063;5720.084786434234;5729.455701708414;5742.483176514133;5151.6908985461;5196.194589838581;5215.165573508297;5217.713025783542;5246.895062098737;6295.622262664163;6313.210848643919;6313.652749098752;6318.052292156121;6324.71538780756;5993.640381577119;6140.17107690456;6146.0473626587955;6172.876542469216;6205.720742566505;6138.447539721446;6186.350433204449;6187.783427580013;6194.225721784777;6206.875862482635;5904.350521442552;5908.940910590839;5923.940760592339;5928.140419639042;5937;5908.231929849092;5991.580589358703;5998.9100163496705;6089.2997305310455;6133.478654314434;5829.53363730892;5918.082697181943;5919.112133180058;5934.762609495572;5955.464008239106;5878.911816322673;5920.703964801829;5925.318588362394;5929.140274660064;5942.10868369748;5667.518260947865;5790.334111577223;5869.266341707286;5886.381929897299;5915.290165180206;5894.6757928314355;5899.67551784656;5914.083317085859;5944.910826337522;5957.3744756799915;5645.745941432728;5826.73779679907;5835.183074369506;5840.94159058404;5850.64896106235 18:29:55 INFO - PROCESS | 29486 | |1;ext.html;508.57788035930184;554.9500544950954;562.485325926777;573.2175580332846;592.2360155399534;39418;39472.210555788864;39619;39745;39885.40171897424;42552.361714574305;42897.14205715884;42992.35511467331;43056.569434305726;43145.35281970773;8881.86677199841;9025.864612030824;9087.091290870927;9090.409123406991;9114.817703645924;8685.044645089036;8718.389712720113;8742.256908162813;8908.242799362062;8919.77700557488;9144.314176436761;9216.30877684173;9218.907810921906;9227.261819054493;9283.07169283073;9169;9237.953810230973;9245.861312080324;9250.398724082914;9254.444733316022;9174.908250917471;9317.11487408695;9328;9331.953340233254;9336.439813611205;35603.82198088993;35756.28487430237;35762.28475430503;35762.64237357619;35833.10417239564;3695.815209239554;3898.298306304864;4003.5195776506716;4090.7750073745933;4321;28503.714962850314;28510.857445712845;28741.712582874112;28803.85598072017;29199.270018249714;3319.974815362627;3339.7328213742844;3382.002309318757;3397.8810741623925;3406.8807591734417;283745;284844;285281;285289;286280.5685971578;46171.76914115408;46735.766321168856;62741;62897;63158.15788289538;36392;36483.635163648556;36509.817450912575;36605.267894641955;36642.81678591643;14677.48628797987;14985.625359366102;14997.70004599902;15008.774868376982;15030.248487575796;11661.941690291495;11734.765304694029;11747.060235181165;11792;11830.940845295718;13188.340582970814;13661.248631325174;13669.589912302647;13735.313234338244;13839.930800345934;6048.4858787003595;6092.817215483543;6224;6244.094606282064;6282.560220784592;1081.6700906223678;1082.815921293382;1098.7143342730947;1115.1859142825783;1184.2473139753213;27014;27474.5878811814;27478;27481.45037099247;27501.587476187873;1058.7829494953517;1085.625459216569;1127.1095834290982;1140.4126874659557;1252.9913419697232;13860.646677487888;13939.442422303197;13967.650808729863;14055.43778248879;14178.71642567143;342573;573712;574567;576020;577366;45222.77388613036;45232.3215151773;45487.772561137645;45529.08941821145;45676.08647827025;1443.7401267771902;1458.795768592398;1459.1974414072217;1472.7717203833422;1473.5652982370227;25565.105221317164;25930.092446764273;26057.869710651325;26401.471970560866;26688;41899.7905010473;41908.161836763706;41955.58044419517;42004.15991680088;42361.15277694367;322924;323117;324123;324460;324860;30794.38411231718;30911;30983.69016309808;31263;31309.686903131587;39916.201675965734;40189.59810401859;40362;40379.798101009306;40753.59246407498;33935;34120.48819267763;34130.82934585411;34286.65713342834;34462.310753785285;33197.17007074843;33610.49584256189;33617.32765344728;34138.31723365568;34296;33688.831555842065;33803.4929476063;33945.49081763825;33972.15069623279;34175.31649366949;29566.408671826874;29715.405691886474;29739.553906690984;29992.85003574968;30094.548581771727;23978;24023.75976240215;24473.265802025966;24517.264482065566;24725 18:29:55 INFO - PROCESS | 29486 | |2;jquery.html;376.58387481832574;377.59220042354275;382.3175631497777;389.48587864019487;403.119184581689;17708.645827083452;19007.809921900778;19064.618707625857;19399.515012124702;19619.901900490495;16657.416990405338;17016;17053.48839534816;17110.31558737649;17138.14309284537;5461.644993075457;5683.829485115432;5710.229119068935;5716.314042314928;5718.59969802114;5416.241726158321;5633.8309850704545;5633.943660563383;5647.040003199466;5654.5193658538865;5564.86087847805;5611.607187496877;5631.493165615094;5938.792142275;5955.34491205967;5897.085951677475;5918.319393269764;5978.671173085479;6001.279846418458;6017.187679663233;5674.899483055731;5738.42615738427;5785.045467497858;5787.855303617401;5830.591858569902;13929.512467063705;14264.429422823074;14322.355494002692;14507.637309067251;14594.34325455357;2239.8096161826265;2292.6790249365104;2312.4681323295567;2368.194813763329;2375.1449478187837;10620.734481637943;10749.140068794477;13035.413406396736;13088.869111308955;13470.663233419145;1830.2861883865303;1898.1078892920304;1924.191839427444;1980.2178139634764;2077.3975547091327;71458;71954.64022679905;72942.63528682322;73531.63234183849;73858;10504.789904201873;10678.839817402744;10991;11041.33751974884;11053.392063436588;15367.154806485527;15384.769228461582;15495.535133945774;15598.142102184262;15642.061476311457;7326.3406293433845;7531.8117047073165;7595;7802.375809935305;7928.563928983961;7295.927040729631;7352;7433.182349941502;7433.776986690408;7456.813579660552;4642.257238841769;4779.378680771547;4789.425268967746;4857.0528746894015;4889.535494128052;1968.8424926005885;2074.9377518674464;2076.325194311855;2077.9376618701463;2081.875087494755;898.874157617934;965.232640051161;985.788055568042;1004.2618675273668;1028.88682244953;16250.918745406434;17296.108375615386;17722.291108355523;17823.554411139827;18340.449786506426;927.221134247222;935.7461002257008;941.2187884056217;963.8939716631165;990.2573070197352;9588.280878934107;10174.745631359276;10207.132393746466;10237.59049638021;10340.017698318648;447436;454395;463187;465503;466631;76266;78056.21943780489;78233.60883195547;80854;81379.59310203411;1025.0723095598346;1041.6406339812752;1046.8586740789897;1052.8736551613702;1057.8942105789513;15752.06908960054;15879.444219452263;15896.682066358839;15971.520854374387;16178.595535111717;33590.83204583961;33986.83006584951;34880.12799679927;34896.30207395888;35252.118697032776;51404;51553.22670160026;51630;51738.223926641884;51918.48081519137;7934.523928564305;8040.155783642634;8094.3929205311015;8126.512409255463;8215.671373145007;11529.192956492965;12360.56738014201;12444.253344799341;12681.30252836103;13013.674658133623;10818.783624327627;11278.154138439813;11397.544098236309;11410.94294528522;11489.310641361544;10669.946650266698;11134.777304454028;11209.43952802373;11268.718282043015;11429.485673144562;11122.944385278022;11421.600243991421;11670;11688.532458701557;11866.228695134789;8692.391532592657;8820.294376449998;8865.24645405122;8898.243649289883;8986.640534378552;8978.775530611787;11115.610953616584;11598;11642.126840486828;11710.355930423908 18:29:55 INFO - PROCESS | 29486 | |3;mootools.html;1470.1913947328967;1534.97697534537;1783.0104292117878;1908.1890196666432;1973.7828838827736;7609.124950630679;8118.309943654796;8411.453255538394;8583.141685831422;8584.184502472272;8258.587070646474;8363.498190108598;8388.706395276167;8461.069282378934;8461.323094152469;2327.8719670418122;2345.1674655497222;2347.6595893595418;2348.6007378745567;2373.881305934705;2340.742518322983;2343.2267351773876;2370.679958205646;2400.051979468109;2404.3989002749313;2298.1496846166942;2350.2009316832273;2366.7396586375485;2379.095943541452;2390.115657206827;2334.684817549643;2369.9526009479714;2369.988150059256;2377.940551486218;2405.1101092595677;2359.3393849722106;2372.0630351011428;2378.8096952243777;2380.5595964746576;2383.2611890313883;8623.180797824196;8653.350998675125;8682.565871706389;8690.304775617935;8691.08743581921;5187.247849061865;5299.788008479656;5316.441773613792;5321.840344789663;5347.6256662033675;3158.368326334742;3159.3997140543224;3184.856681449317;3188.776785625007;3236.5954255718034;968.9563969621383;970.427447805798;990.5889056041734;1021;1024.2011231239644;11758.529658813723;11805.586804461802;11832.585859494877;11864.88135118655;11873.821892671616;4505.526919673387;4623.352730617717;4628.907421851544;4640.814367425265;4705.7411842349;10200.0819926207;10210.285280030326;10218.795624087477;10248.846267305997;10286.691399258034;5371.946280537145;5385.084535628953;5393.5954803389905;5408.675479471244;5439.456054394529;4224.281872081753;4743.241081426955;4794.089123066607;4836.443808961944;4847.151748444078;3895.7078219133678;3922.1175235572337;3948.802559871995;3975.264576053439;3999.080211551301;1214.813335995205;1215.726461546145;1221.8778122187887;1228.668259569911;1243.3348158735034;1075.4837677914645;1077.2082519348273;1088.8203446431407;1206.1918514595243;1281.3208999230424;7624.695012199561;7651.043619547557;7705.961470192725;7730.420218483636;7738.767836964787;523.9973800130975;524.2372348233312;525.2803658987212;527.067091248488;530.2735252703743;5987.6108052976415;6019.849503762353;6040.426159514839;6119.663418511936;6126.203593532812;10260.281780275309;10512.474376281156;10580.36517808934;10639.734006649896;10658.946705266579;10303.330283531546;10378.532966016548;10383.480825958672;10387.890255439985;10396.688099357032;8114.350851931831;8226.629801658939;8233.300169485661;8294.83410331802;8306.169383061646;7466.887996679946;7611.200823913631;7658.2724641159;7686.500377475446;7686.615669216629;8882.289416846766;8937.821243575223;9098.59056342453;9109.726708198765;9208.677696280865;9105.499197544199;9614.278929080487;9651.227901767701;9701.757456063655;9715.465649389069;7504.324610784837;7613.5431874087735;7694.4229182810395;7741.148473668005;7786.649600767866;7877.448578599443;7893.723719669784;7916.050073991158;7916.84166316682;7917.129115797143;6987.545809522365;7275.527090739085;7348.52234604749;7407.962960185165;7499.437542184249;6990.2660220678135;7025.613591252531;7195.02867112954;7289.4168466523615;7327.780166595011;7527.397808175442;7559.697612095454;7589.506682065648;7611.771646850603;7616.162222155669;6814.4548436124;6869.519133660596;6907.240203577502;6915.723371065101;6975.79072627822;7006.229314775269;7028.437724982092;7087.149542054986;7099.929000709927;7101.041359416619 18:29:55 INFO - PROCESS | 29486 | |4;prototype.html;357.545916685809;366.28391494628005;367.98344074516643;369.2062066556904;369.7541135145129;6379.298277189511;6472.967635161817;6485.610863348203;6494.51291153163;6530.444912182458;6409.711562979665;6414.871702565946;6416.550841441101;6417.743290268395;6434.195725534309;4696.107739529495;4753.595944344735;4780.713157210578;4782.641301902354;4962.42932062812;4731.337612734203;4741.976290118562;4743.288506723985;4818.638602104857;4819.638527110464;4782.450018247894;4785.832495862645;4794.42466903972;4796.784144713479;4801.519848015206;4773.522647735216;4796.160671882424;4804.399450068741;4814.470408255089;4821.734804585746;4199.286121359376;4206.053637931472;4208.305629571148;4216.683748718859;4217.704760666755;5994.700264986777;6000.96999515004;6005.549583781234;6016.669083200422;6018.458338749533;5549.306336707911;5586.329640443132;5610.859728506779;5617.831465056055;5627.493525582676;6644.800655980328;6647.60114393138;6666.466682665424;6688.531802773808;6706.698198581075;4603.10239503297;4607.262837945946;4616.1229366420275;4623.375844261015;4642.210824159901;7047.400970917478;7112.075430194093;7123.964380178118;7139.464540159509;7179.605121718303;4576.359309696645;4879.365682461257;4897.681650692693;4898.461169271377;4905.3132561441425;4756.595689366373;4790.329353890458;4810.037992401533;4816.229403295456;4827.541383568555;5636.830895073154;5655.462731040545;5663.745131469093;5671.291088613923;5686.2323586315315;6846.178458584902;6882.793516194522;6884.242733299333;6888.311168883071;6904.4821638377325;1716.7339062445092;1743.4943866278636;1743.5031016160333;1743.5379624399545;1745.2757105801204;1087.1628845788857;1122.5341483284346;1140.5722853929776;1150.976980460403;1152.4871432212585;6585;6586.27550969393;6609.768658096944;6616.536842421081;6629.9337006630285;7044.647767611599;7088.539244949062;7090.432765378758;7090.468214883905;7092.4326053915565;6367.299597044322;6583.30875258091;6617.04052912325;6634.933650663528;6662.6668666566475;3818.3127037133027;3826.9617303826603;3834.118152824866;3844.75009124406;3849.9807500962315;7349.595772232578;7350.228226036296;7353.852922941511;7365.705371785176;7370.336669699753;7214.2785721427435;7273.527220730635;7315.707371705073;7334;7357.484976051625;7083.787486375417;7262.709491620276;7279.927200727925;7282;7294.416446684252;6968.581885086911;7000.614966176706;7002.509824312249;7002.964985175042;7025.718971241093;6999.790006299819;7007.159140903124;7016.438684905297;7034.577925324497;7040;7315.158756743042;7353.264673532604;7356.963215184104;7373.889391659237;7393.630318483947;4848.200046992207;4958.355413796184;4972.950270497394;4984.127777638972;5007.349044624176;6979.5114341997605;7013.403860671696;7044.894326585208;7068.081149450539;7087;6833.487488438288;6840.589564626139;6847.623380714109;6851.657417129024;6869.381755642016;6750.5274630775375;6769.458443324621;6769.492288078315;6773.085633439423;6775.254721980479;6482.546221764431;6499.707513161825;6775.932240677727;6789.558678685869;6804.251532331538;6893.586384816927;6905.240423553305;6945.2707465715375;6945.826354341182;6961.6171110587375;6695.598264104169;6724.7646332378135;6772.864542709217;6777.356151165632;6793.864122717617 18:29:55 INFO - PROCESS | 29486 | |5;yui.html;727.9490435669502;760.5702777930472;801.9398545109118;817.8078151634367;834.3575446905883;14204.502842400518;14326.713465730692;14368.928155359235;14422.85577144227;14447.349869255882;13846.653833654163;13900.513482028131;13913.582592522214;13918;13926.58220253394;762.2453770766929;914.8444764390069;918.4030380252823;931.9021502742216;933.1554942776797;935.9157675809175;943;943.7640589852537;943.8961714211431;945.4610871803075;984.0061537846791;985.9309848310621;986.9358491698052;989;991.3258983890951;981.268954628799;983.026803464572;983.8327484327682;986.1223511075149;987.6000219910948;729.9781006569812;730.7113690092436;732.5897497401472;732.6556518436327;735.782944031512;14445.566633001026;14462.05996610217;14507.274636268145;14512.1292722437;14558.490452834207;13469.326533673375;13754.862451375559;13757.587272381845;13902.652433689138;13956.371963261576;11204.383758893258;11232.3260604364;11449.713757156054;11526.135539834546;11715.882841171564;3611.819409029538;3682.558093028854;3698.593154752975;3713.8700145494777;3753.11801726594;50008.49991500075;50569.49430505685;51903;52117;52269.73865130726;10311.381317120997;10469.84295235572;10496.107830834464;10556.577736890593;10657.946710266398;19322.420327390202;19647;19769;19791.20835166606;19832.50418739543;7701.884471732928;7764.767056988299;7814;7856.410769192334;7955.880661790078;4608.423947006624;4624.190766615896;4688.742119183409;4754.096721622881;4805.663603547788;3395.2360718838063;3422.5037369581273;3431.227973705896;3436.3642726095754;3437.673421024999;615.0528186592597;616.8026231605933;622.0389498225253;623.8752249550017;624.3631495874183;504.2209785880823;583.2592607388593;610.2432983101012;612.874360756044;626.5301024231826;7578.924210757932;8209.917900821034;8329.625166867505;8545.444546104483;8745.825083498421;525.4115390762371;529.264322591598;556.1241045353504;599.3377318063564;620.3610281410155;3618.9638103619154;3662.230931504414;3753.512043434336;3791.75353602015;3901.297766402075;59803;60669.69665151734;60704;60802;61282.69358653178;52958;54047.18929216065;54665.726671367185;54955.175672364945;55613.72193139089;47857.76071119622;47878.28182577264;48550.999999999294;48978;48991.75504122457;7384.704611815468;7485.139208991036;7500.399968002655;7632.045994250719;7770.339521140766;36793.448098278015;37253.81373093117;37441.81279093696;38050.2389952205;38487.807560962014;43417.34873976956;47235.291470628654;48223.5177648219;49211.261831071846;49302.26046609376;9223.308251881002;10018.3488073275;10137.695869123938;10159;10648.254622176682;10399.272050956662;10433.686989390331;10808.513616887416;10975.176861735561;11001.284916480403;9944.403335799876;10051.296409251283;10144.188464922936;10219.642312519027;10274.691759247235;10773.29973551748;10941.343519388862;10943;11055.72360690989;11361.829572556584;9911.256655750703;10044.949775251076;10166.8474972874;10467.790644187226;10489.632862849763;8548.401611887108;8795.648174072965;8836.91163088361;9075.863862041942;9280.72157835266;9061.728148155566;9094.499802510925;9186.862197067183;9298.116678915492;9379.015203403544 18:29:55 INFO - PROCESS | 29486 | __end_tp_report 18:29:55 INFO - PROCESS | 29486 | __start_cc_report 18:29:55 INFO - PROCESS | 29486 | _x_x_mozilla_cycle_collect,326 18:29:55 INFO - PROCESS | 29486 | __end_cc_report 18:29:55 INFO - PROCESS | 29486 | __startTimestamp1461374995139__endTimestamp 18:29:55 INFO - PROCESS | 29486 | 18:29:55 INFO - PROCESS | 29486 | ------- Summary: start ------- 18:29:55 INFO - PROCESS | 29486 | Number of tests: 6 18:29:55 INFO - PROCESS | 29486 | 18:29:55 INFO - PROCESS | 29486 | [#0] dojo.html Cycles:165 Average:5612.41 Median:5850.65 stddev:627.53 (10.7%) stddev-sans-first:603.62 18:29:55 INFO - PROCESS | 29486 | Values: 3340.7 3412.8 3432.2 3461.7 3478.9 5549.4 5566.5 5569.8 5572.0 5591.3 5535.9 5572.4 5599.6 5602.5 5650.5 5066.1 5097.5 5129.9 5170.8 5191.1 5057.9 5155.0 5173.2 5175.5 5194.4 5117.5 5188.0 5222.1 5231.8 5232.2 5178.6 5184.5 5198.3 5220.3 5253.7 4968.9 4988.5 5045.5 5093.2 5109.3 5398.4 5428.5 5443.3 5450.2 5493.3 6036.1 6069.2 6071.6 6088.4 6092.3 5967.5 6036.8 6101.4 6103.2 6115.8 5671.9 5681.9 5687.5 5693.5 5714.9 6147.4 6195.1 6207.7 6216.7 6219.6 5772.1 5956.8 6048.5 6057.2 6095.7 6054.7 6069.8 6079.8 6087.8 6103.1 5877.6 6025.1 6025.7 6040.5 6048.0 5962.0 6013.6 6060.4 6069.7 6073.7 4564.8 4566.7 4568.7 4578.3 4592.7 4038.6 4080.3 4114.7 4115.0 4143.2 5664.5 5726.3 5792.7 5824.2 5851.8 6015.6 6033.7 6035.5 6046.1 6064.8 5509.1 5713.1 5720.1 5729.5 5742.5 5151.7 5196.2 5215.2 5217.7 5246.9 6295.6 6313.2 6313.7 6318.1 6324.7 5993.6 6140.2 6146.0 6172.9 6205.7 6138.4 6186.4 6187.8 6194.2 6206.9 5904.4 5908.9 5923.9 5928.1 5937.0 5908.2 5991.6 5998.9 6089.3 6133.5 5829.5 5918.1 5919.1 5934.8 5955.5 5878.9 5920.7 5925.3 5929.1 5942.1 5667.5 5790.3 5869.3 5886.4 5915.3 5894.7 5899.7 5914.1 5944.9 5957.4 5645.7 5826.7 5835.2 5840.9 5850.6 18:29:55 INFO - PROCESS | 29486 | 18:29:55 INFO - PROCESS | 29486 | [#1] ext.html Cycles:180 Average:51773.58 Median:34156.82 stddev:105988.17 (310.3%) stddev-sans-first:106215.61 18:29:55 INFO - PROCESS | 29486 | Values: 508.6 555.0 562.5 573.2 592.2 39418.0 39472.2 39619.0 39745.0 39885.4 42552.4 42897.1 42992.4 43056.6 43145.4 8881.9 9025.9 9087.1 9090.4 9114.8 8685.0 8718.4 8742.3 8908.2 8919.8 9144.3 9216.3 9218.9 9227.3 9283.1 9169.0 9238.0 9245.9 9250.4 9254.4 9174.9 9317.1 9328.0 9332.0 9336.4 35603.8 35756.3 35762.3 35762.6 35833.1 3695.8 3898.3 4003.5 4090.8 4321.0 28503.7 28510.9 28741.7 28803.9 29199.3 3320.0 3339.7 3382.0 3397.9 3406.9 283745.0 284844.0 285281.0 285289.0 286280.6 46171.8 46735.8 62741.0 62897.0 63158.2 36392.0 36483.6 36509.8 36605.3 36642.8 14677.5 14985.6 14997.7 15008.8 15030.2 11661.9 11734.8 11747.1 11792.0 11830.9 13188.3 13661.2 13669.6 13735.3 13839.9 6048.5 6092.8 6224.0 6244.1 6282.6 1081.7 1082.8 1098.7 1115.2 1184.2 27014.0 27474.6 27478.0 27481.5 27501.6 1058.8 1085.6 1127.1 1140.4 1253.0 13860.6 13939.4 13967.7 14055.4 14178.7 342573.0 573712.0 574567.0 576020.0 577366.0 45222.8 45232.3 45487.8 45529.1 45676.1 1443.7 1458.8 1459.2 1472.8 1473.6 25565.1 25930.1 26057.9 26401.5 26688.0 41899.8 41908.2 41955.6 42004.2 42361.2 322924.0 323117.0 324123.0 324460.0 324860.0 30794.4 30911.0 30983.7 31263.0 31309.7 39916.2 40189.6 40362.0 40379.8 40753.6 33935.0 34120.5 34130.8 34286.7 34462.3 33197.2 33610.5 33617.3 34138.3 34296.0 33688.8 33803.5 33945.5 33972.2 34175.3 29566.4 29715.4 29739.6 29992.9 30094.5 23978.0 24023.8 24473.3 24517.3 24725.0 18:29:55 INFO - PROCESS | 29486 | 18:29:55 INFO - PROCESS | 29486 | [#2] jquery.html Cycles:180 Average:26727.95 Median:33788.83 stddev:75478.25 (223.4%) stddev-sans-first:75664.06 18:29:55 INFO - PROCESS | 29486 | Values: 376.6 377.6 382.3 389.5 403.1 17708.6 19007.8 19064.6 19399.5 19619.9 16657.4 17016.0 17053.5 17110.3 17138.1 5461.6 5683.8 5710.2 5716.3 5718.6 5416.2 5633.8 5633.9 5647.0 5654.5 5564.9 5611.6 5631.5 5938.8 5955.3 5897.1 5918.3 5978.7 6001.3 6017.2 5674.9 5738.4 5785.0 5787.9 5830.6 13929.5 14264.4 14322.4 14507.6 14594.3 2239.8 2292.7 2312.5 2368.2 2375.1 10620.7 10749.1 13035.4 13088.9 13470.7 1830.3 1898.1 1924.2 1980.2 2077.4 71458.0 71954.6 72942.6 73531.6 73858.0 10504.8 10678.8 10991.0 11041.3 11053.4 15367.2 15384.8 15495.5 15598.1 15642.1 7326.3 7531.8 7595.0 7802.4 7928.6 7295.9 7352.0 7433.2 7433.8 7456.8 4642.3 4779.4 4789.4 4857.1 4889.5 1968.8 2074.9 2076.3 2077.9 2081.9 898.9 965.2 985.8 1004.3 1028.9 16250.9 17296.1 17722.3 17823.6 18340.4 927.2 935.7 941.2 963.9 990.3 9588.3 10174.7 10207.1 10237.6 10340.0 447436.0 454395.0 463187.0 465503.0 466631.0 76266.0 78056.2 78233.6 80854.0 81379.6 1025.1 1041.6 1046.9 1052.9 1057.9 15752.1 15879.4 15896.7 15971.5 16178.6 33590.8 33986.8 34880.1 34896.3 35252.1 51404.0 51553.2 51630.0 51738.2 51918.5 7934.5 8040.2 8094.4 8126.5 8215.7 11529.2 12360.6 12444.3 12681.3 13013.7 10818.8 11278.2 11397.5 11410.9 11489.3 10669.9 11134.8 11209.4 11268.7 11429.5 11122.9 11421.6 11670.0 11688.5 11866.2 8692.4 8820.3 8865.2 8898.2 8986.6 8978.8 11115.6 11598.0 11642.1 11710.4 18:29:55 INFO - PROCESS | 29486 | 18:29:55 INFO - PROCESS | 29486 | [#3] mootools.html Cycles:180 Average:5907.18 Median:5334.73 stddev:3162.88 (59.3%) stddev-sans-first:3154.17 18:29:55 INFO - PROCESS | 29486 | Values: 1470.2 1535.0 1783.0 1908.2 1973.8 7609.1 8118.3 8411.5 8583.1 8584.2 8258.6 8363.5 8388.7 8461.1 8461.3 2327.9 2345.2 2347.7 2348.6 2373.9 2340.7 2343.2 2370.7 2400.1 2404.4 2298.1 2350.2 2366.7 2379.1 2390.1 2334.7 2370.0 2370.0 2377.9 2405.1 2359.3 2372.1 2378.8 2380.6 2383.3 8623.2 8653.4 8682.6 8690.3 8691.1 5187.2 5299.8 5316.4 5321.8 5347.6 3158.4 3159.4 3184.9 3188.8 3236.6 969.0 970.4 990.6 1021.0 1024.2 11758.5 11805.6 11832.6 11864.9 11873.8 4505.5 4623.4 4628.9 4640.8 4705.7 10200.1 10210.3 10218.8 10248.8 10286.7 5371.9 5385.1 5393.6 5408.7 5439.5 4224.3 4743.2 4794.1 4836.4 4847.2 3895.7 3922.1 3948.8 3975.3 3999.1 1214.8 1215.7 1221.9 1228.7 1243.3 1075.5 1077.2 1088.8 1206.2 1281.3 7624.7 7651.0 7706.0 7730.4 7738.8 524.0 524.2 525.3 527.1 530.3 5987.6 6019.8 6040.4 6119.7 6126.2 10260.3 10512.5 10580.4 10639.7 10658.9 10303.3 10378.5 10383.5 10387.9 10396.7 8114.4 8226.6 8233.3 8294.8 8306.2 7466.9 7611.2 7658.3 7686.5 7686.6 8882.3 8937.8 9098.6 9109.7 9208.7 9105.5 9614.3 9651.2 9701.8 9715.5 7504.3 7613.5 7694.4 7741.1 7786.6 7877.4 7893.7 7916.1 7916.8 7917.1 6987.5 7275.5 7348.5 7408.0 7499.4 6990.3 7025.6 7195.0 7289.4 7327.8 7527.4 7559.7 7589.5 7611.8 7616.2 6814.5 6869.5 6907.2 6915.7 6975.8 7006.2 7028.4 7087.1 7099.9 7101.0 18:29:55 INFO - PROCESS | 29486 | 18:29:55 INFO - PROCESS | 29486 | [#4] prototype.html Cycles:180 Average:5695.01 Median:6497.11 stddev:1738.08 (26.8%) stddev-sans-first:1696.16 18:29:55 INFO - PROCESS | 29486 | Values: 357.5 366.3 368.0 369.2 369.8 6379.3 6473.0 6485.6 6494.5 6530.4 6409.7 6414.9 6416.6 6417.7 6434.2 4696.1 4753.6 4780.7 4782.6 4962.4 4731.3 4742.0 4743.3 4818.6 4819.6 4782.5 4785.8 4794.4 4796.8 4801.5 4773.5 4796.2 4804.4 4814.5 4821.7 4199.3 4206.1 4208.3 4216.7 4217.7 5994.7 6001.0 6005.5 6016.7 6018.5 5549.3 5586.3 5610.9 5617.8 5627.5 6644.8 6647.6 6666.5 6688.5 6706.7 4603.1 4607.3 4616.1 4623.4 4642.2 7047.4 7112.1 7124.0 7139.5 7179.6 4576.4 4879.4 4897.7 4898.5 4905.3 4756.6 4790.3 4810.0 4816.2 4827.5 5636.8 5655.5 5663.7 5671.3 5686.2 6846.2 6882.8 6884.2 6888.3 6904.5 1716.7 1743.5 1743.5 1743.5 1745.3 1087.2 1122.5 1140.6 1151.0 1152.5 6585.0 6586.3 6609.8 6616.5 6629.9 7044.6 7088.5 7090.4 7090.5 7092.4 6367.3 6583.3 6617.0 6634.9 6662.7 3818.3 3827.0 3834.1 3844.8 3850.0 7349.6 7350.2 7353.9 7365.7 7370.3 7214.3 7273.5 7315.7 7334.0 7357.5 7083.8 7262.7 7279.9 7282.0 7294.4 6968.6 7000.6 7002.5 7003.0 7025.7 6999.8 7007.2 7016.4 7034.6 7040.0 7315.2 7353.3 7357.0 7373.9 7393.6 4848.2 4958.4 4973.0 4984.1 5007.3 6979.5 7013.4 7044.9 7068.1 7087.0 6833.5 6840.6 6847.6 6851.7 6869.4 6750.5 6769.5 6769.5 6773.1 6775.3 6482.5 6499.7 6775.9 6789.6 6804.3 6893.6 6905.2 6945.3 6945.8 6961.6 6695.6 6724.8 6772.9 6777.4 6793.9 18:29:55 INFO - PROCESS | 29486 | 18:29:55 INFO - PROCESS | 29486 | [#5] yui.html Cycles:180 Average:14296.40 Median:49256.76 stddev:16992.68 (34.5%) stddev-sans-first:17009.81 18:29:55 INFO - PROCESS | 29486 | Values: 727.9 760.6 801.9 817.8 834.4 14204.5 14326.7 14368.9 14422.9 14447.3 13846.7 13900.5 13913.6 13918.0 13926.6 762.2 914.8 918.4 931.9 933.2 935.9 943.0 943.8 943.9 945.5 984.0 985.9 986.9 989.0 991.3 981.3 983.0 983.8 986.1 987.6 730.0 730.7 732.6 732.7 735.8 14445.6 14462.1 14507.3 14512.1 14558.5 13469.3 13754.9 13757.6 13902.7 13956.4 11204.4 11232.3 11449.7 11526.1 11715.9 3611.8 3682.6 3698.6 3713.9 3753.1 50008.5 50569.5 51903.0 52117.0 52269.7 10311.4 10469.8 10496.1 10556.6 10657.9 19322.4 19647.0 19769.0 19791.2 19832.5 7701.9 7764.8 7814.0 7856.4 7955.9 4608.4 4624.2 4688.7 4754.1 4805.7 3395.2 3422.5 3431.2 3436.4 3437.7 615.1 616.8 622.0 623.9 624.4 504.2 583.3 610.2 612.9 626.5 7578.9 8209.9 8329.6 8545.4 8745.8 525.4 529.3 556.1 599.3 620.4 3619.0 3662.2 3753.5 3791.8 3901.3 59803.0 60669.7 60704.0 60802.0 61282.7 52958.0 54047.2 54665.7 54955.2 55613.7 47857.8 47878.3 48551.0 48978.0 48991.8 7384.7 7485.1 7500.4 7632.0 7770.3 36793.4 37253.8 37441.8 38050.2 38487.8 43417.3 47235.3 48223.5 49211.3 49302.3 9223.3 10018.3 10137.7 10159.0 10648.3 10399.3 10433.7 10808.5 10975.2 11001.3 9944.4 10051.3 10144.2 10219.6 10274.7 10773.3 10941.3 10943.0 11055.7 11361.8 9911.3 10044.9 10166.8 10467.8 10489.6 8548.4 8795.6 8836.9 9075.9 9280.7 9061.7 9094.5 9186.9 9298.1 9379.0 18:29:55 INFO - PROCESS | 29486 | -------- Summary: end -------- 18:29:55 INFO - PROCESS | 29486 | 18:29:55 INFO - TEST-INFO | 29486: exit 0 18:29:55 INFO - TEST-OK | dromaeo_css | took 1109524ms 18:29:55 INFO - TEST-START | kraken 18:29:55 INFO - operating with platform_type : linux_ 18:29:55 INFO - Initialising browser for kraken test... 18:29:55 INFO - TEST-INFO | started process 29731 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLIZT8N/profile http://localhost:48570/getInfo.html) 18:29:59 INFO - PROCESS | 29731 | 18:29:59 INFO - PROCESS | 29731 | (process:29807): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:29:59 INFO - PROCESS | 29731 | __metrics Screen width/height:1600/1200 18:29:59 INFO - PROCESS | 29731 | colorDepth:24 18:29:59 INFO - PROCESS | 29731 | Browser inner width/height: 1024/697 18:29:59 INFO - PROCESS | 29731 | __metrics 18:30:00 ERROR - PROCESS | 29731 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 18:30:01 INFO - TEST-INFO | 29731: exit 0 18:30:01 INFO - Browser initialized. 18:30:01 INFO - Running cycle 1/1 for kraken test... 18:30:01 INFO - TEST-INFO | started process 29858 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLIZT8N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:30:03 INFO - PROCESS | 29858 | 18:30:03 INFO - PROCESS | 29858 | (process:29927): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:30:13 INFO - PROCESS | 29858 | RSS: Main: 151449600 18:30:13 INFO - PROCESS | 29858 | 18:30:15 INFO - PROCESS | 29858 | Cycle 1(1): loaded http://localhost:48570/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48570/tests/kraken/driver.html?testName=audio-beat-detection) 18:30:16 INFO - PROCESS | 29858 | RSS: Main: 155713536 18:30:16 INFO - PROCESS | 29858 | 18:30:18 INFO - PROCESS | 29858 | Cycle 1(1): loaded http://localhost:48570/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48570/tests/kraken/driver.html?testName=audio-dft) 18:30:19 INFO - PROCESS | 29858 | RSS: Main: 155926528 18:30:19 INFO - PROCESS | 29858 | 18:30:22 INFO - PROCESS | 29858 | Cycle 1(1): loaded http://localhost:48570/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48570/tests/kraken/driver.html?testName=audio-fft) 18:30:22 INFO - PROCESS | 29858 | RSS: Main: 155942912 18:30:22 INFO - PROCESS | 29858 | 18:30:24 INFO - PROCESS | 29858 | Cycle 1(1): loaded http://localhost:48570/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48570/tests/kraken/driver.html?testName=audio-oscillator) 18:30:25 INFO - PROCESS | 29858 | RSS: Main: 156958720 18:30:25 INFO - PROCESS | 29858 | 18:30:27 INFO - PROCESS | 29858 | Cycle 1(1): loaded http://localhost:48570/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48570/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:30:28 INFO - PROCESS | 29858 | RSS: Main: 156426240 18:30:28 INFO - PROCESS | 29858 | 18:30:31 INFO - PROCESS | 29858 | Cycle 1(1): loaded http://localhost:48570/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48570/tests/kraken/driver.html?testName=imaging-darkroom) 18:30:31 INFO - PROCESS | 29858 | RSS: Main: 156860416 18:30:31 INFO - PROCESS | 29858 | 18:30:35 INFO - PROCESS | 29858 | Cycle 1(1): loaded http://localhost:48570/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48570/tests/kraken/driver.html?testName=imaging-desaturate) 18:30:35 INFO - PROCESS | 29858 | RSS: Main: 156696576 18:30:35 INFO - PROCESS | 29858 | 18:30:38 INFO - PROCESS | 29858 | Cycle 1(1): loaded http://localhost:48570/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48570/tests/kraken/driver.html?testName=json-parse-financial) 18:30:39 INFO - PROCESS | 29858 | RSS: Main: 156487680 18:30:39 INFO - PROCESS | 29858 | 18:30:40 INFO - PROCESS | 29858 | Cycle 1(1): loaded http://localhost:48570/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48570/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:30:41 INFO - PROCESS | 29858 | RSS: Main: 156643328 18:30:41 INFO - PROCESS | 29858 | 18:30:43 INFO - PROCESS | 29858 | Cycle 1(1): loaded http://localhost:48570/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48570/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:30:43 INFO - PROCESS | 29858 | RSS: Main: 156344320 18:30:43 INFO - PROCESS | 29858 | 18:30:45 INFO - PROCESS | 29858 | Cycle 1(1): loaded http://localhost:48570/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48570/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:30:46 INFO - PROCESS | 29858 | RSS: Main: 156966912 18:30:46 INFO - PROCESS | 29858 | 18:30:48 INFO - PROCESS | 29858 | Cycle 1(1): loaded http://localhost:48570/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48570/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:30:49 INFO - PROCESS | 29858 | RSS: Main: 156815360 18:30:49 INFO - PROCESS | 29858 | 18:30:52 INFO - PROCESS | 29858 | Cycle 1(1): loaded http://localhost:48570/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48570/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:30:52 INFO - PROCESS | 29858 | RSS: Main: 157032448 18:30:52 INFO - PROCESS | 29858 | 18:30:54 INFO - PROCESS | 29858 | Cycle 1(1): loaded http://localhost:48570/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48570/tests/kraken/driver.html?testName=ai-astar) 18:30:54 INFO - PROCESS | 29858 | RSS: Main: 159395840 18:30:54 INFO - PROCESS | 29858 | 18:30:54 INFO - PROCESS | 29858 | __start_tp_report 18:30:54 INFO - PROCESS | 29858 | _x_x_mozilla_page_load 18:30:54 INFO - PROCESS | 29858 | _x_x_mozilla_page_load_details 18:30:54 INFO - PROCESS | 29858 | |i|pagename|runs| 18:30:54 INFO - PROCESS | 29858 | |0;ai-astar;112;103;111;109;111;122;111;111;110;111 18:30:54 INFO - PROCESS | 29858 | |1;audio-beat-detection;154;129;160;175;128;153;151;132;174;128 18:30:54 INFO - PROCESS | 29858 | |2;audio-dft;163;162;160;162;161;163;162;162;164;163 18:30:54 INFO - PROCESS | 29858 | |3;audio-fft;76;76;76;175;76;75;74;74;161;73 18:30:54 INFO - PROCESS | 29858 | |4;audio-oscillator;96;94;140;94;94;94;139;93;94;145 18:30:54 INFO - PROCESS | 29858 | |5;imaging-gaussian-blur;117;118;117;118;118;118;118;118;117;117 18:30:54 INFO - PROCESS | 29858 | |6;imaging-darkroom;146;147;148;149;147;148;146;147;147;146 18:30:54 INFO - PROCESS | 29858 | |7;imaging-desaturate;96;97;96;96;98;97;97;96;96;96 18:30:54 INFO - PROCESS | 29858 | |8;json-parse-financial;56;58;57;58;57;57;58;64;55;54 18:30:54 INFO - PROCESS | 29858 | |9;json-stringify-tinderbox;66;66;66;64;65;66;65;65;66;65 18:30:54 INFO - PROCESS | 29858 | |10;stanford-crypto-aes;81;80;82;80;78;80;80;79;81;79 18:30:54 INFO - PROCESS | 29858 | |11;stanford-crypto-ccm;124;114;117;118;119;115;129;116;120;122 18:30:54 INFO - PROCESS | 29858 | |12;stanford-crypto-pbkdf2;138;149;149;157;149;136;146;146;148;140 18:30:54 INFO - PROCESS | 29858 | |13;stanford-crypto-sha256-iterative;72;69;69;68;66;69;66;69;68;68 18:30:54 INFO - PROCESS | 29858 | __end_tp_report 18:30:54 INFO - PROCESS | 29858 | __start_cc_report 18:30:54 INFO - PROCESS | 29858 | _x_x_mozilla_cycle_collect,809 18:30:54 INFO - PROCESS | 29858 | __end_cc_report 18:30:54 INFO - PROCESS | 29858 | __startTimestamp1461375054600__endTimestamp 18:30:54 INFO - PROCESS | 29858 | 18:30:54 INFO - PROCESS | 29858 | ------- Summary: start ------- 18:30:54 INFO - PROCESS | 29858 | Number of tests: 14 18:30:54 INFO - PROCESS | 29858 | 18:30:54 INFO - PROCESS | 29858 | [#0] ai-astar Cycles:10 Average:111.10 Median:111.00 stddev:4.61 (4.1%) stddev-sans-first:4.87 18:30:54 INFO - PROCESS | 29858 | Values: 112.0 103.0 111.0 109.0 111.0 122.0 111.0 111.0 110.0 111.0 18:30:54 INFO - PROCESS | 29858 | 18:30:54 INFO - PROCESS | 29858 | [#1] audio-beat-detection Cycles:10 Average:148.40 Median:153.50 stddev:18.36 (12.0%) stddev-sans-first:19.36 18:30:54 INFO - PROCESS | 29858 | Values: 154.0 129.0 160.0 175.0 128.0 153.0 151.0 132.0 174.0 128.0 18:30:54 INFO - PROCESS | 29858 | 18:30:54 INFO - PROCESS | 29858 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.50 stddev:1.14 (0.7%) stddev-sans-first:1.17 18:30:54 INFO - PROCESS | 29858 | Values: 163.0 162.0 160.0 162.0 161.0 163.0 162.0 162.0 164.0 163.0 18:30:54 INFO - PROCESS | 29858 | 18:30:54 INFO - PROCESS | 29858 | [#3] audio-fft Cycles:10 Average:93.60 Median:75.50 stddev:39.36 (52.1%) stddev-sans-first:41.23 18:30:54 INFO - PROCESS | 29858 | Values: 76.0 76.0 76.0 175.0 76.0 75.0 74.0 74.0 161.0 73.0 18:30:54 INFO - PROCESS | 29858 | 18:30:54 INFO - PROCESS | 29858 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:94.00 stddev:22.86 (24.3%) stddev-sans-first:23.81 18:30:54 INFO - PROCESS | 29858 | Values: 96.0 94.0 140.0 94.0 94.0 94.0 139.0 93.0 94.0 145.0 18:30:54 INFO - PROCESS | 29858 | 18:30:54 INFO - PROCESS | 29858 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 18:30:54 INFO - PROCESS | 29858 | Values: 117.0 118.0 117.0 118.0 118.0 118.0 118.0 118.0 117.0 117.0 18:30:54 INFO - PROCESS | 29858 | 18:30:54 INFO - PROCESS | 29858 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.99 (0.7%) stddev-sans-first:0.97 18:30:54 INFO - PROCESS | 29858 | Values: 146.0 147.0 148.0 149.0 147.0 148.0 146.0 147.0 147.0 146.0 18:30:54 INFO - PROCESS | 29858 | 18:30:54 INFO - PROCESS | 29858 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 18:30:54 INFO - PROCESS | 29858 | Values: 96.0 97.0 96.0 96.0 98.0 97.0 97.0 96.0 96.0 96.0 18:30:54 INFO - PROCESS | 29858 | 18:30:54 INFO - PROCESS | 29858 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:57.50 stddev:2.67 (4.7%) stddev-sans-first:2.79 18:30:54 INFO - PROCESS | 29858 | Values: 56.0 58.0 57.0 58.0 57.0 57.0 58.0 64.0 55.0 54.0 18:30:54 INFO - PROCESS | 29858 | 18:30:54 INFO - PROCESS | 29858 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 18:30:54 INFO - PROCESS | 29858 | Values: 66.0 66.0 66.0 64.0 65.0 66.0 65.0 65.0 66.0 65.0 18:30:54 INFO - PROCESS | 29858 | 18:30:54 INFO - PROCESS | 29858 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:80.00 stddev:1.15 (1.4%) stddev-sans-first:1.17 18:30:54 INFO - PROCESS | 29858 | Values: 81.0 80.0 82.0 80.0 78.0 80.0 80.0 79.0 81.0 79.0 18:30:54 INFO - PROCESS | 29858 | 18:30:54 INFO - PROCESS | 29858 | [#11] stanford-crypto-ccm Cycles:10 Average:119.40 Median:119.50 stddev:4.58 (3.8%) stddev-sans-first:4.54 18:30:54 INFO - PROCESS | 29858 | Values: 124.0 114.0 117.0 118.0 119.0 115.0 129.0 116.0 120.0 122.0 18:30:54 INFO - PROCESS | 29858 | 18:30:54 INFO - PROCESS | 29858 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.80 Median:148.50 stddev:6.25 (4.2%) stddev-sans-first:5.96 18:30:54 INFO - PROCESS | 29858 | Values: 138.0 149.0 149.0 157.0 149.0 136.0 146.0 146.0 148.0 140.0 18:30:54 INFO - PROCESS | 29858 | 18:30:54 INFO - PROCESS | 29858 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:69.00 stddev:1.71 (2.5%) stddev-sans-first:1.22 18:30:54 INFO - PROCESS | 29858 | Values: 72.0 69.0 69.0 68.0 66.0 69.0 66.0 69.0 68.0 68.0 18:30:54 INFO - PROCESS | 29858 | -------- Summary: end -------- 18:30:54 INFO - PROCESS | 29858 | 18:30:55 INFO - TEST-INFO | 29858: exit 0 18:30:55 INFO - TEST-OK | kraken | took 59865ms 18:30:55 INFO - SUITE-END | took 1169s 18:30:55 INFO - Completed test suite (00:19:29) 18:30:55 INFO - javascript benchmark 18:30:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3340.6993370596647, 3412.812295323757, 3432.2277487565316, 3461.723062155028, 3478.947815782764, 5549.445055494449, 5566.4990150886415, 5569.805056823012, 5572.0, 5591.2731344925205, 5535.861603459915, 5572.4148964358665, 5599.580031497633, 5602.467765562265, 5650.51970582501, 5066.062778386001, 5097.541221290083, 5129.948700513003, 5170.844874653748, 5191.117510023286, 5057.898842023157, 5154.974225128869, 5173.249878767577, 5175.534201921826, 5194.35070616173, 5117.46266642001, 5188.04021256067, 5222.086134926391, 5231.764570594313, 5232.189010703347, 5178.559822415099, 5184.455632158607, 5198.27224188612, 5220.269162317279, 5253.737313134328, 4968.925466118011, 4988.451270360258, 5045.520675535819, 5093.236014597803, 5109.284700141983, 5398.406175320712, 5428.45715428458, 5443.265159203496, 5450.209719590677, 5493.313335833021, 6036.0945858121195, 6069.180660610805, 6071.605345652519, 6088.391160883876, 6092.329843717188, 5967.49276311514, 6036.8188954331445, 6101.420365065312, 6103.23709536308, 6115.785947491817, 5671.886562268732, 5681.943180568224, 5687.488126068673, 5693.5445164387165, 5714.914276285859, 6147.415995480422, 6195.070739389128, 6207.689615519206, 6216.720247588869, 6219.626822390671, 5772.134179873053, 5956.821295361146, 6048.485878700271, 6057.182280392179, 6095.725692343766, 6054.66699331541, 6069.848253793691, 6079.817605471843, 6087.817365479043, 6103.05402662588, 5877.5591830612875, 6025.096235564701, 6025.67435164272, 6040.546958978094, 6047.969760151171, 5962.046072628359, 6013.579049466495, 6060.393960603992, 6069.696515174312, 6073.665948372882, 4564.794584243717, 4566.74882881438, 4568.703034302826, 4578.313253012075, 4592.678512504092, 4038.6163314485075, 4080.3063479208604, 4114.7119701621195, 4114.979425102855, 4143.212789569972, 5664.490195882308, 5726.284214473191, 5792.739326730307, 5824.213731146326, 5851.795187168514, 6015.608985415934, 6033.698315084228, 6035.486983606443, 6046.062860256668, 6064.787732429344, 5509.090999984957, 5713.085906255063, 5720.084786434234, 5729.455701708414, 5742.483176514133, 5151.6908985461, 5196.194589838581, 5215.165573508297, 5217.713025783542, 5246.895062098737, 6295.622262664163, 6313.210848643919, 6313.652749098752, 6318.052292156121, 6324.71538780756, 5993.640381577119, 6140.17107690456, 6146.0473626587955, 6172.876542469216, 6205.720742566505, 6138.447539721446, 6186.350433204449, 6187.783427580013, 6194.225721784777, 6206.875862482635, 5904.350521442552, 5908.940910590839, 5923.940760592339, 5928.140419639042, 5937.0, 5908.231929849092, 5991.580589358703, 5998.9100163496705, 6089.2997305310455, 6133.478654314434, 5829.53363730892, 5918.082697181943, 5919.112133180058, 5934.762609495572, 5955.464008239106, 5878.911816322673, 5920.703964801829, 5925.318588362394, 5929.140274660064, 5942.10868369748, 5667.518260947865, 5790.334111577223, 5869.266341707286, 5886.381929897299, 5915.290165180206, 5894.6757928314355, 5899.67551784656, 5914.083317085859, 5944.910826337522, 5957.3744756799915, 5645.745941432728, 5826.73779679907, 5835.183074369506, 5840.94159058404, 5850.64896106235], "unit": "score", "name": "dojo.html", "value": 5571.594620966742}, {"lowerIsBetter": false, "replicates": [508.57788035930184, 554.9500544950954, 562.485325926777, 573.2175580332846, 592.2360155399534, 39418.0, 39472.210555788864, 39619.0, 39745.0, 39885.40171897424, 42552.361714574305, 42897.14205715884, 42992.35511467331, 43056.569434305726, 43145.35281970773, 8881.86677199841, 9025.864612030824, 9087.091290870927, 9090.409123406991, 9114.817703645924, 8685.044645089036, 8718.389712720113, 8742.256908162813, 8908.242799362062, 8919.77700557488, 9144.314176436761, 9216.30877684173, 9218.907810921906, 9227.261819054493, 9283.07169283073, 9169.0, 9237.953810230973, 9245.861312080324, 9250.398724082914, 9254.444733316022, 9174.908250917471, 9317.11487408695, 9328.0, 9331.953340233254, 9336.439813611205, 35603.82198088993, 35756.28487430237, 35762.28475430503, 35762.64237357619, 35833.10417239564, 3695.815209239554, 3898.298306304864, 4003.5195776506716, 4090.7750073745933, 4321.0, 28503.714962850314, 28510.857445712845, 28741.712582874112, 28803.85598072017, 29199.270018249714, 3319.974815362627, 3339.7328213742844, 3382.002309318757, 3397.8810741623925, 3406.8807591734417, 283745.0, 284844.0, 285281.0, 285289.0, 286280.5685971578, 46171.76914115408, 46735.766321168856, 62741.0, 62897.0, 63158.15788289538, 36392.0, 36483.635163648556, 36509.817450912575, 36605.267894641955, 36642.81678591643, 14677.48628797987, 14985.625359366102, 14997.70004599902, 15008.774868376982, 15030.248487575796, 11661.941690291495, 11734.765304694029, 11747.060235181165, 11792.0, 11830.940845295718, 13188.340582970814, 13661.248631325174, 13669.589912302647, 13735.313234338244, 13839.930800345934, 6048.4858787003595, 6092.817215483543, 6224.0, 6244.094606282064, 6282.560220784592, 1081.6700906223678, 1082.815921293382, 1098.7143342730947, 1115.1859142825783, 1184.2473139753213, 27014.0, 27474.5878811814, 27478.0, 27481.45037099247, 27501.587476187873, 1058.7829494953517, 1085.625459216569, 1127.1095834290982, 1140.4126874659557, 1252.9913419697232, 13860.646677487888, 13939.442422303197, 13967.650808729863, 14055.43778248879, 14178.71642567143, 342573.0, 573712.0, 574567.0, 576020.0, 577366.0, 45222.77388613036, 45232.3215151773, 45487.772561137645, 45529.08941821145, 45676.08647827025, 1443.7401267771902, 1458.795768592398, 1459.1974414072217, 1472.7717203833422, 1473.5652982370227, 25565.105221317164, 25930.092446764273, 26057.869710651325, 26401.471970560866, 26688.0, 41899.7905010473, 41908.161836763706, 41955.58044419517, 42004.15991680088, 42361.15277694367, 322924.0, 323117.0, 324123.0, 324460.0, 324860.0, 30794.38411231718, 30911.0, 30983.69016309808, 31263.0, 31309.686903131587, 39916.201675965734, 40189.59810401859, 40362.0, 40379.798101009306, 40753.59246407498, 33935.0, 34120.48819267763, 34130.82934585411, 34286.65713342834, 34462.310753785285, 33197.17007074843, 33610.49584256189, 33617.32765344728, 34138.31723365568, 34296.0, 33688.831555842065, 33803.4929476063, 33945.49081763825, 33972.15069623279, 34175.31649366949, 29566.408671826874, 29715.405691886474, 29739.553906690984, 29992.85003574968, 30094.548581771727, 23978.0, 24023.75976240215, 24473.265802025966, 24517.264482065566, 24725.0], "unit": "score", "name": "ext.html", "value": 18000.151177050007}, {"lowerIsBetter": false, "replicates": [376.58387481832574, 377.59220042354275, 382.3175631497777, 389.48587864019487, 403.119184581689, 17708.645827083452, 19007.809921900778, 19064.618707625857, 19399.515012124702, 19619.901900490495, 16657.416990405338, 17016.0, 17053.48839534816, 17110.31558737649, 17138.14309284537, 5461.644993075457, 5683.829485115432, 5710.229119068935, 5716.314042314928, 5718.59969802114, 5416.241726158321, 5633.8309850704545, 5633.943660563383, 5647.040003199466, 5654.5193658538865, 5564.86087847805, 5611.607187496877, 5631.493165615094, 5938.792142275, 5955.34491205967, 5897.085951677475, 5918.319393269764, 5978.671173085479, 6001.279846418458, 6017.187679663233, 5674.899483055731, 5738.42615738427, 5785.045467497858, 5787.855303617401, 5830.591858569902, 13929.512467063705, 14264.429422823074, 14322.355494002692, 14507.637309067251, 14594.34325455357, 2239.8096161826265, 2292.6790249365104, 2312.4681323295567, 2368.194813763329, 2375.1449478187837, 10620.734481637943, 10749.140068794477, 13035.413406396736, 13088.869111308955, 13470.663233419145, 1830.2861883865303, 1898.1078892920304, 1924.191839427444, 1980.2178139634764, 2077.3975547091327, 71458.0, 71954.64022679905, 72942.63528682322, 73531.63234183849, 73858.0, 10504.789904201873, 10678.839817402744, 10991.0, 11041.33751974884, 11053.392063436588, 15367.154806485527, 15384.769228461582, 15495.535133945774, 15598.142102184262, 15642.061476311457, 7326.3406293433845, 7531.8117047073165, 7595.0, 7802.375809935305, 7928.563928983961, 7295.927040729631, 7352.0, 7433.182349941502, 7433.776986690408, 7456.813579660552, 4642.257238841769, 4779.378680771547, 4789.425268967746, 4857.0528746894015, 4889.535494128052, 1968.8424926005885, 2074.9377518674464, 2076.325194311855, 2077.9376618701463, 2081.875087494755, 898.874157617934, 965.232640051161, 985.788055568042, 1004.2618675273668, 1028.88682244953, 16250.918745406434, 17296.108375615386, 17722.291108355523, 17823.554411139827, 18340.449786506426, 927.221134247222, 935.7461002257008, 941.2187884056217, 963.8939716631165, 990.2573070197352, 9588.280878934107, 10174.745631359276, 10207.132393746466, 10237.59049638021, 10340.017698318648, 447436.0, 454395.0, 463187.0, 465503.0, 466631.0, 76266.0, 78056.21943780489, 78233.60883195547, 80854.0, 81379.59310203411, 1025.0723095598346, 1041.6406339812752, 1046.8586740789897, 1052.8736551613702, 1057.8942105789513, 15752.06908960054, 15879.444219452263, 15896.682066358839, 15971.520854374387, 16178.595535111717, 33590.83204583961, 33986.83006584951, 34880.12799679927, 34896.30207395888, 35252.118697032776, 51404.0, 51553.22670160026, 51630.0, 51738.223926641884, 51918.48081519137, 7934.523928564305, 8040.155783642634, 8094.3929205311015, 8126.512409255463, 8215.671373145007, 11529.192956492965, 12360.56738014201, 12444.253344799341, 12681.30252836103, 13013.674658133623, 10818.783624327627, 11278.154138439813, 11397.544098236309, 11410.94294528522, 11489.310641361544, 10669.946650266698, 11134.777304454028, 11209.43952802373, 11268.718282043015, 11429.485673144562, 11122.944385278022, 11421.600243991421, 11670.0, 11688.532458701557, 11866.228695134789, 8692.391532592657, 8820.294376449998, 8865.24645405122, 8898.243649289883, 8986.640534378552, 8978.775530611787, 11115.610953616584, 11598.0, 11642.126840486828, 11710.355930423908], "unit": "score", "name": "jquery.html", "value": 8811.023045760288}, {"lowerIsBetter": false, "replicates": [1470.1913947328967, 1534.97697534537, 1783.0104292117878, 1908.1890196666432, 1973.7828838827736, 7609.124950630679, 8118.309943654796, 8411.453255538394, 8583.141685831422, 8584.184502472272, 8258.587070646474, 8363.498190108598, 8388.706395276167, 8461.069282378934, 8461.323094152469, 2327.8719670418122, 2345.1674655497222, 2347.6595893595418, 2348.6007378745567, 2373.881305934705, 2340.742518322983, 2343.2267351773876, 2370.679958205646, 2400.051979468109, 2404.3989002749313, 2298.1496846166942, 2350.2009316832273, 2366.7396586375485, 2379.095943541452, 2390.115657206827, 2334.684817549643, 2369.9526009479714, 2369.988150059256, 2377.940551486218, 2405.1101092595677, 2359.3393849722106, 2372.0630351011428, 2378.8096952243777, 2380.5595964746576, 2383.2611890313883, 8623.180797824196, 8653.350998675125, 8682.565871706389, 8690.304775617935, 8691.08743581921, 5187.247849061865, 5299.788008479656, 5316.441773613792, 5321.840344789663, 5347.6256662033675, 3158.368326334742, 3159.3997140543224, 3184.856681449317, 3188.776785625007, 3236.5954255718034, 968.9563969621383, 970.427447805798, 990.5889056041734, 1021.0, 1024.2011231239644, 11758.529658813723, 11805.586804461802, 11832.585859494877, 11864.88135118655, 11873.821892671616, 4505.526919673387, 4623.352730617717, 4628.907421851544, 4640.814367425265, 4705.7411842349, 10200.0819926207, 10210.285280030326, 10218.795624087477, 10248.846267305997, 10286.691399258034, 5371.946280537145, 5385.084535628953, 5393.5954803389905, 5408.675479471244, 5439.456054394529, 4224.281872081753, 4743.241081426955, 4794.089123066607, 4836.443808961944, 4847.151748444078, 3895.7078219133678, 3922.1175235572337, 3948.802559871995, 3975.264576053439, 3999.080211551301, 1214.813335995205, 1215.726461546145, 1221.8778122187887, 1228.668259569911, 1243.3348158735034, 1075.4837677914645, 1077.2082519348273, 1088.8203446431407, 1206.1918514595243, 1281.3208999230424, 7624.695012199561, 7651.043619547557, 7705.961470192725, 7730.420218483636, 7738.767836964787, 523.9973800130975, 524.2372348233312, 525.2803658987212, 527.067091248488, 530.2735252703743, 5987.6108052976415, 6019.849503762353, 6040.426159514839, 6119.663418511936, 6126.203593532812, 10260.281780275309, 10512.474376281156, 10580.36517808934, 10639.734006649896, 10658.946705266579, 10303.330283531546, 10378.532966016548, 10383.480825958672, 10387.890255439985, 10396.688099357032, 8114.350851931831, 8226.629801658939, 8233.300169485661, 8294.83410331802, 8306.169383061646, 7466.887996679946, 7611.200823913631, 7658.2724641159, 7686.500377475446, 7686.615669216629, 8882.289416846766, 8937.821243575223, 9098.59056342453, 9109.726708198765, 9208.677696280865, 9105.499197544199, 9614.278929080487, 9651.227901767701, 9701.757456063655, 9715.465649389069, 7504.324610784837, 7613.5431874087735, 7694.4229182810395, 7741.148473668005, 7786.649600767866, 7877.448578599443, 7893.723719669784, 7916.050073991158, 7916.84166316682, 7917.129115797143, 6987.545809522365, 7275.527090739085, 7348.52234604749, 7407.962960185165, 7499.437542184249, 6990.2660220678135, 7025.613591252531, 7195.02867112954, 7289.4168466523615, 7327.780166595011, 7527.397808175442, 7559.697612095454, 7589.506682065648, 7611.771646850603, 7616.162222155669, 6814.4548436124, 6869.519133660596, 6907.240203577502, 6915.723371065101, 6975.79072627822, 7006.229314775269, 7028.437724982092, 7087.149542054986, 7099.929000709927, 7101.041359416619], "unit": "score", "name": "mootools.html", "value": 4712.963645373583}, {"lowerIsBetter": false, "replicates": [357.545916685809, 366.28391494628005, 367.98344074516643, 369.2062066556904, 369.7541135145129, 6379.298277189511, 6472.967635161817, 6485.610863348203, 6494.51291153163, 6530.444912182458, 6409.711562979665, 6414.871702565946, 6416.550841441101, 6417.743290268395, 6434.195725534309, 4696.107739529495, 4753.595944344735, 4780.713157210578, 4782.641301902354, 4962.42932062812, 4731.337612734203, 4741.976290118562, 4743.288506723985, 4818.638602104857, 4819.638527110464, 4782.450018247894, 4785.832495862645, 4794.42466903972, 4796.784144713479, 4801.519848015206, 4773.522647735216, 4796.160671882424, 4804.399450068741, 4814.470408255089, 4821.734804585746, 4199.286121359376, 4206.053637931472, 4208.305629571148, 4216.683748718859, 4217.704760666755, 5994.700264986777, 6000.96999515004, 6005.549583781234, 6016.669083200422, 6018.458338749533, 5549.306336707911, 5586.329640443132, 5610.859728506779, 5617.831465056055, 5627.493525582676, 6644.800655980328, 6647.60114393138, 6666.466682665424, 6688.531802773808, 6706.698198581075, 4603.10239503297, 4607.262837945946, 4616.1229366420275, 4623.375844261015, 4642.210824159901, 7047.400970917478, 7112.075430194093, 7123.964380178118, 7139.464540159509, 7179.605121718303, 4576.359309696645, 4879.365682461257, 4897.681650692693, 4898.461169271377, 4905.3132561441425, 4756.595689366373, 4790.329353890458, 4810.037992401533, 4816.229403295456, 4827.541383568555, 5636.830895073154, 5655.462731040545, 5663.745131469093, 5671.291088613923, 5686.2323586315315, 6846.178458584902, 6882.793516194522, 6884.242733299333, 6888.311168883071, 6904.4821638377325, 1716.7339062445092, 1743.4943866278636, 1743.5031016160333, 1743.5379624399545, 1745.2757105801204, 1087.1628845788857, 1122.5341483284346, 1140.5722853929776, 1150.976980460403, 1152.4871432212585, 6585.0, 6586.27550969393, 6609.768658096944, 6616.536842421081, 6629.9337006630285, 7044.647767611599, 7088.539244949062, 7090.432765378758, 7090.468214883905, 7092.4326053915565, 6367.299597044322, 6583.30875258091, 6617.04052912325, 6634.933650663528, 6662.6668666566475, 3818.3127037133027, 3826.9617303826603, 3834.118152824866, 3844.75009124406, 3849.9807500962315, 7349.595772232578, 7350.228226036296, 7353.852922941511, 7365.705371785176, 7370.336669699753, 7214.2785721427435, 7273.527220730635, 7315.707371705073, 7334.0, 7357.484976051625, 7083.787486375417, 7262.709491620276, 7279.927200727925, 7282.0, 7294.416446684252, 6968.581885086911, 7000.614966176706, 7002.509824312249, 7002.964985175042, 7025.718971241093, 6999.790006299819, 7007.159140903124, 7016.438684905297, 7034.577925324497, 7040.0, 7315.158756743042, 7353.264673532604, 7356.963215184104, 7373.889391659237, 7393.630318483947, 4848.200046992207, 4958.355413796184, 4972.950270497394, 4984.127777638972, 5007.349044624176, 6979.5114341997605, 7013.403860671696, 7044.894326585208, 7068.081149450539, 7087.0, 6833.487488438288, 6840.589564626139, 6847.623380714109, 6851.657417129024, 6869.381755642016, 6750.5274630775375, 6769.458443324621, 6769.492288078315, 6773.085633439423, 6775.254721980479, 6482.546221764431, 6499.707513161825, 6775.932240677727, 6789.558678685869, 6804.251532331538, 6893.586384816927, 6905.240423553305, 6945.2707465715375, 6945.826354341182, 6961.6171110587375, 6695.598264104169, 6724.7646332378135, 6772.864542709217, 6777.356151165632, 6793.864122717617], "unit": "score", "name": "prototype.html", "value": 5131.530557602208}, {"lowerIsBetter": false, "replicates": [727.9490435669502, 760.5702777930472, 801.9398545109118, 817.8078151634367, 834.3575446905883, 14204.502842400518, 14326.713465730692, 14368.928155359235, 14422.85577144227, 14447.349869255882, 13846.653833654163, 13900.513482028131, 13913.582592522214, 13918.0, 13926.58220253394, 762.2453770766929, 914.8444764390069, 918.4030380252823, 931.9021502742216, 933.1554942776797, 935.9157675809175, 943.0, 943.7640589852537, 943.8961714211431, 945.4610871803075, 984.0061537846791, 985.9309848310621, 986.9358491698052, 989.0, 991.3258983890951, 981.268954628799, 983.026803464572, 983.8327484327682, 986.1223511075149, 987.6000219910948, 729.9781006569812, 730.7113690092436, 732.5897497401472, 732.6556518436327, 735.782944031512, 14445.566633001026, 14462.05996610217, 14507.274636268145, 14512.1292722437, 14558.490452834207, 13469.326533673375, 13754.862451375559, 13757.587272381845, 13902.652433689138, 13956.371963261576, 11204.383758893258, 11232.3260604364, 11449.713757156054, 11526.135539834546, 11715.882841171564, 3611.819409029538, 3682.558093028854, 3698.593154752975, 3713.8700145494777, 3753.11801726594, 50008.49991500075, 50569.49430505685, 51903.0, 52117.0, 52269.73865130726, 10311.381317120997, 10469.84295235572, 10496.107830834464, 10556.577736890593, 10657.946710266398, 19322.420327390202, 19647.0, 19769.0, 19791.20835166606, 19832.50418739543, 7701.884471732928, 7764.767056988299, 7814.0, 7856.410769192334, 7955.880661790078, 4608.423947006624, 4624.190766615896, 4688.742119183409, 4754.096721622881, 4805.663603547788, 3395.2360718838063, 3422.5037369581273, 3431.227973705896, 3436.3642726095754, 3437.673421024999, 615.0528186592597, 616.8026231605933, 622.0389498225253, 623.8752249550017, 624.3631495874183, 504.2209785880823, 583.2592607388593, 610.2432983101012, 612.874360756044, 626.5301024231826, 7578.924210757932, 8209.917900821034, 8329.625166867505, 8545.444546104483, 8745.825083498421, 525.4115390762371, 529.264322591598, 556.1241045353504, 599.3377318063564, 620.3610281410155, 3618.9638103619154, 3662.230931504414, 3753.512043434336, 3791.75353602015, 3901.297766402075, 59803.0, 60669.69665151734, 60704.0, 60802.0, 61282.69358653178, 52958.0, 54047.18929216065, 54665.726671367185, 54955.175672364945, 55613.72193139089, 47857.76071119622, 47878.28182577264, 48550.999999999294, 48978.0, 48991.75504122457, 7384.704611815468, 7485.139208991036, 7500.399968002655, 7632.045994250719, 7770.339521140766, 36793.448098278015, 37253.81373093117, 37441.81279093696, 38050.2389952205, 38487.807560962014, 43417.34873976956, 47235.291470628654, 48223.5177648219, 49211.261831071846, 49302.26046609376, 9223.308251881002, 10018.3488073275, 10137.695869123938, 10159.0, 10648.254622176682, 10399.272050956662, 10433.686989390331, 10808.513616887416, 10975.176861735561, 11001.284916480403, 9944.403335799876, 10051.296409251283, 10144.188464922936, 10219.642312519027, 10274.691759247235, 10773.29973551748, 10941.343519388862, 10943.0, 11055.72360690989, 11361.829572556584, 9911.256655750703, 10044.949775251076, 10166.8474972874, 10467.790644187226, 10489.632862849763, 8548.401611887108, 8795.648174072965, 8836.91163088361, 9075.863862041942, 9280.72157835266, 9061.728148155566, 9094.499802510925, 9186.862197067183, 9298.116678915492, 9379.015203403544], "unit": "score", "name": "yui.html", "value": 6461.106930703637}], "name": "dromaeo_css", "value": 7189.4192143990995}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 103.0, 111.0, 109.0, 111.0, 122.0, 111.0, 111.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [154.0, 129.0, 160.0, 175.0, 128.0, 153.0, 151.0, 132.0, 174.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 148.4}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 160.0, 162.0, 161.0, 163.0, 162.0, 162.0, 164.0, 163.0], "unit": "score", "name": "audio-dft", "value": 162.2}, {"lowerIsBetter": true, "replicates": [76.0, 76.0, 76.0, 175.0, 76.0, 75.0, 74.0, 74.0, 161.0, 73.0], "unit": "score", "name": "audio-fft", "value": 93.6}, {"lowerIsBetter": true, "replicates": [96.0, 94.0, 140.0, 94.0, 94.0, 94.0, 139.0, 93.0, 94.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 108.3}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.6}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 148.0, 149.0, 147.0, 148.0, 146.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 98.0, 97.0, 97.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [56.0, 58.0, 57.0, 58.0, 57.0, 57.0, 58.0, 64.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.4}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 66.0, 64.0, 65.0, 66.0, 65.0, 65.0, 66.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.4}, {"lowerIsBetter": true, "replicates": [81.0, 80.0, 82.0, 80.0, 78.0, 80.0, 80.0, 79.0, 81.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.0}, {"lowerIsBetter": true, "replicates": [124.0, 114.0, 117.0, 118.0, 119.0, 115.0, 129.0, 116.0, 120.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.4}, {"lowerIsBetter": true, "replicates": [138.0, 149.0, 149.0, 157.0, 149.0, 136.0, 146.0, 146.0, 148.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.8}, {"lowerIsBetter": true, "replicates": [72.0, 69.0, 69.0, 68.0, 66.0, 69.0, 66.0, 69.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.4}], "name": "kraken", "value": 1521.2000000000003}]} 18:30:55 INFO - Return code: 0 18:30:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:30:55 ERROR - # TBPL SUCCESS # 18:30:55 INFO - Running post-action listener: _resource_record_post_action 18:30:55 INFO - Running post-run listener: _resource_record_post_run 18:30:56 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 8192; Write bytes: 501022720; Read time: 36; Write time: 333576 18:30:56 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 244666368; Read time: 0; Write time: 217424 18:30:56 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 8192; Write bytes: 255598592; Read time: 36; Write time: 116132 18:30:56 INFO - Running post-run listener: _upload_blobber_files 18:30:56 INFO - Blob upload gear active. 18:30:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:30:56 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 18:30:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:30:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:30:57 INFO - (blobuploader) - INFO - Open directory for files ... 18:30:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:30:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:30:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:30:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:30:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:30:58 INFO - (blobuploader) - INFO - Done attempting. 18:30:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:30:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:30:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:30:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:30:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:30:59 INFO - (blobuploader) - INFO - Done attempting. 18:30:59 INFO - (blobuploader) - INFO - Iteration through files over. 18:30:59 INFO - Return code: 0 18:30:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:30:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:30:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1eb966c7fb91ef807292deeff851a3388de701f03c784dbfbc39985581f6bdefebe0ff19f45c2468b3776b483ef5ae941ce18d8a2d28ac5f47765fe03ddf811a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3381147ee6e5b6cd6369a2a243d67538831d6f00c0430da2701d1369c63f2a50a0f56c178b640a89bc178c4726478e025a0e9ce6b9a34bd1c1dde95e39194c39"} 18:30:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:30:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:30:59 INFO - Contents: 18:30:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1eb966c7fb91ef807292deeff851a3388de701f03c784dbfbc39985581f6bdefebe0ff19f45c2468b3776b483ef5ae941ce18d8a2d28ac5f47765fe03ddf811a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3381147ee6e5b6cd6369a2a243d67538831d6f00c0430da2701d1369c63f2a50a0f56c178b640a89bc178c4726478e025a0e9ce6b9a34bd1c1dde95e39194c39"} 18:30:59 INFO - Running post-run listener: copy_logs_to_upload_dir 18:30:59 INFO - Copying logs to upload dir... 18:30:59 INFO - mkdir: /builds/slave/test/build/upload/logs 18:30:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.733684 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-04-22 18:30:58.863247) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 18:30:58.868323) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1461371485.864179-1069483538 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1eb966c7fb91ef807292deeff851a3388de701f03c784dbfbc39985581f6bdefebe0ff19f45c2468b3776b483ef5ae941ce18d8a2d28ac5f47765fe03ddf811a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3381147ee6e5b6cd6369a2a243d67538831d6f00c0430da2701d1369c63f2a50a0f56c178b640a89bc178c4726478e025a0e9ce6b9a34bd1c1dde95e39194c39"} build_url:https://queue.taskcluster.net/v1/task/R2U95CWtR4mlyWgzq70NuQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011320 build_url: 'https://queue.taskcluster.net/v1/task/R2U95CWtR4mlyWgzq70NuQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1eb966c7fb91ef807292deeff851a3388de701f03c784dbfbc39985581f6bdefebe0ff19f45c2468b3776b483ef5ae941ce18d8a2d28ac5f47765fe03ddf811a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3381147ee6e5b6cd6369a2a243d67538831d6f00c0430da2701d1369c63f2a50a0f56c178b640a89bc178c4726478e025a0e9ce6b9a34bd1c1dde95e39194c39"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 18:30:58.895022) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 18:30:58.895432) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1461371485.864179-1069483538 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004442 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 18:30:58.978198) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 18:30:58.978518) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 18:30:58.978852) ========= ========= Total master_lag: 0.18 =========